trace: branch profiling should not print percent without data
[linux-2.6] / kernel / trace / trace.c
1 /*
2  * ring buffer based function tracer
3  *
4  * Copyright (C) 2007-2008 Steven Rostedt <srostedt@redhat.com>
5  * Copyright (C) 2008 Ingo Molnar <mingo@redhat.com>
6  *
7  * Originally taken from the RT patch by:
8  *    Arnaldo Carvalho de Melo <acme@redhat.com>
9  *
10  * Based on code from the latency_tracer, that is:
11  *  Copyright (C) 2004-2006 Ingo Molnar
12  *  Copyright (C) 2004 William Lee Irwin III
13  */
14 #include <linux/utsrelease.h>
15 #include <linux/kallsyms.h>
16 #include <linux/seq_file.h>
17 #include <linux/notifier.h>
18 #include <linux/debugfs.h>
19 #include <linux/pagemap.h>
20 #include <linux/hardirq.h>
21 #include <linux/linkage.h>
22 #include <linux/uaccess.h>
23 #include <linux/ftrace.h>
24 #include <linux/module.h>
25 #include <linux/percpu.h>
26 #include <linux/kdebug.h>
27 #include <linux/ctype.h>
28 #include <linux/init.h>
29 #include <linux/poll.h>
30 #include <linux/gfp.h>
31 #include <linux/fs.h>
32 #include <linux/kprobes.h>
33 #include <linux/writeback.h>
34
35 #include <linux/stacktrace.h>
36 #include <linux/ring_buffer.h>
37 #include <linux/irqflags.h>
38
39 #include "trace.h"
40
41 #define TRACE_BUFFER_FLAGS      (RB_FL_OVERWRITE)
42
43 unsigned long __read_mostly     tracing_max_latency = (cycle_t)ULONG_MAX;
44 unsigned long __read_mostly     tracing_thresh;
45
46 /* For tracers that don't implement custom flags */
47 static struct tracer_opt dummy_tracer_opt[] = {
48         { }
49 };
50
51 static struct tracer_flags dummy_tracer_flags = {
52         .val = 0,
53         .opts = dummy_tracer_opt
54 };
55
56 static int dummy_set_flag(u32 old_flags, u32 bit, int set)
57 {
58         return 0;
59 }
60
61 /*
62  * Kill all tracing for good (never come back).
63  * It is initialized to 1 but will turn to zero if the initialization
64  * of the tracer is successful. But that is the only place that sets
65  * this back to zero.
66  */
67 int tracing_disabled = 1;
68
69 static DEFINE_PER_CPU(local_t, ftrace_cpu_disabled);
70
71 static inline void ftrace_disable_cpu(void)
72 {
73         preempt_disable();
74         local_inc(&__get_cpu_var(ftrace_cpu_disabled));
75 }
76
77 static inline void ftrace_enable_cpu(void)
78 {
79         local_dec(&__get_cpu_var(ftrace_cpu_disabled));
80         preempt_enable();
81 }
82
83 static cpumask_t __read_mostly          tracing_buffer_mask;
84
85 #define for_each_tracing_cpu(cpu)       \
86         for_each_cpu_mask(cpu, tracing_buffer_mask)
87
88 /*
89  * ftrace_dump_on_oops - variable to dump ftrace buffer on oops
90  *
91  * If there is an oops (or kernel panic) and the ftrace_dump_on_oops
92  * is set, then ftrace_dump is called. This will output the contents
93  * of the ftrace buffers to the console.  This is very useful for
94  * capturing traces that lead to crashes and outputing it to a
95  * serial console.
96  *
97  * It is default off, but you can enable it with either specifying
98  * "ftrace_dump_on_oops" in the kernel command line, or setting
99  * /proc/sys/kernel/ftrace_dump_on_oops to true.
100  */
101 int ftrace_dump_on_oops;
102
103 static int tracing_set_tracer(char *buf);
104
105 static int __init set_ftrace(char *str)
106 {
107         tracing_set_tracer(str);
108         return 1;
109 }
110 __setup("ftrace", set_ftrace);
111
112 static int __init set_ftrace_dump_on_oops(char *str)
113 {
114         ftrace_dump_on_oops = 1;
115         return 1;
116 }
117 __setup("ftrace_dump_on_oops", set_ftrace_dump_on_oops);
118
119 long
120 ns2usecs(cycle_t nsec)
121 {
122         nsec += 500;
123         do_div(nsec, 1000);
124         return nsec;
125 }
126
127 cycle_t ftrace_now(int cpu)
128 {
129         u64 ts = ring_buffer_time_stamp(cpu);
130         ring_buffer_normalize_time_stamp(cpu, &ts);
131         return ts;
132 }
133
134 /*
135  * The global_trace is the descriptor that holds the tracing
136  * buffers for the live tracing. For each CPU, it contains
137  * a link list of pages that will store trace entries. The
138  * page descriptor of the pages in the memory is used to hold
139  * the link list by linking the lru item in the page descriptor
140  * to each of the pages in the buffer per CPU.
141  *
142  * For each active CPU there is a data field that holds the
143  * pages for the buffer for that CPU. Each CPU has the same number
144  * of pages allocated for its buffer.
145  */
146 static struct trace_array       global_trace;
147
148 static DEFINE_PER_CPU(struct trace_array_cpu, global_trace_cpu);
149
150 /*
151  * The max_tr is used to snapshot the global_trace when a maximum
152  * latency is reached. Some tracers will use this to store a maximum
153  * trace while it continues examining live traces.
154  *
155  * The buffers for the max_tr are set up the same as the global_trace.
156  * When a snapshot is taken, the link list of the max_tr is swapped
157  * with the link list of the global_trace and the buffers are reset for
158  * the global_trace so the tracing can continue.
159  */
160 static struct trace_array       max_tr;
161
162 static DEFINE_PER_CPU(struct trace_array_cpu, max_data);
163
164 /* tracer_enabled is used to toggle activation of a tracer */
165 static int                      tracer_enabled = 1;
166
167 /**
168  * tracing_is_enabled - return tracer_enabled status
169  *
170  * This function is used by other tracers to know the status
171  * of the tracer_enabled flag.  Tracers may use this function
172  * to know if it should enable their features when starting
173  * up. See irqsoff tracer for an example (start_irqsoff_tracer).
174  */
175 int tracing_is_enabled(void)
176 {
177         return tracer_enabled;
178 }
179
180 /* function tracing enabled */
181 int                             ftrace_function_enabled;
182
183 /*
184  * trace_buf_size is the size in bytes that is allocated
185  * for a buffer. Note, the number of bytes is always rounded
186  * to page size.
187  *
188  * This number is purposely set to a low number of 16384.
189  * If the dump on oops happens, it will be much appreciated
190  * to not have to wait for all that output. Anyway this can be
191  * boot time and run time configurable.
192  */
193 #define TRACE_BUF_SIZE_DEFAULT  1441792UL /* 16384 * 88 (sizeof(entry)) */
194
195 static unsigned long            trace_buf_size = TRACE_BUF_SIZE_DEFAULT;
196
197 /* trace_types holds a link list of available tracers. */
198 static struct tracer            *trace_types __read_mostly;
199
200 /* current_trace points to the tracer that is currently active */
201 static struct tracer            *current_trace __read_mostly;
202
203 /*
204  * max_tracer_type_len is used to simplify the allocating of
205  * buffers to read userspace tracer names. We keep track of
206  * the longest tracer name registered.
207  */
208 static int                      max_tracer_type_len;
209
210 /*
211  * trace_types_lock is used to protect the trace_types list.
212  * This lock is also used to keep user access serialized.
213  * Accesses from userspace will grab this lock while userspace
214  * activities happen inside the kernel.
215  */
216 static DEFINE_MUTEX(trace_types_lock);
217
218 /* trace_wait is a waitqueue for tasks blocked on trace_poll */
219 static DECLARE_WAIT_QUEUE_HEAD(trace_wait);
220
221 /* trace_flags holds trace_options default values */
222 unsigned long trace_flags = TRACE_ITER_PRINT_PARENT | TRACE_ITER_PRINTK |
223         TRACE_ITER_ANNOTATE;
224
225 /**
226  * trace_wake_up - wake up tasks waiting for trace input
227  *
228  * Simply wakes up any task that is blocked on the trace_wait
229  * queue. These is used with trace_poll for tasks polling the trace.
230  */
231 void trace_wake_up(void)
232 {
233         /*
234          * The runqueue_is_locked() can fail, but this is the best we
235          * have for now:
236          */
237         if (!(trace_flags & TRACE_ITER_BLOCK) && !runqueue_is_locked())
238                 wake_up(&trace_wait);
239 }
240
241 static int __init set_buf_size(char *str)
242 {
243         unsigned long buf_size;
244         int ret;
245
246         if (!str)
247                 return 0;
248         ret = strict_strtoul(str, 0, &buf_size);
249         /* nr_entries can not be zero */
250         if (ret < 0 || buf_size == 0)
251                 return 0;
252         trace_buf_size = buf_size;
253         return 1;
254 }
255 __setup("trace_buf_size=", set_buf_size);
256
257 unsigned long nsecs_to_usecs(unsigned long nsecs)
258 {
259         return nsecs / 1000;
260 }
261
262 /* These must match the bit postions in trace_iterator_flags */
263 static const char *trace_options[] = {
264         "print-parent",
265         "sym-offset",
266         "sym-addr",
267         "verbose",
268         "raw",
269         "hex",
270         "bin",
271         "block",
272         "stacktrace",
273         "sched-tree",
274         "ftrace_printk",
275         "ftrace_preempt",
276         "branch",
277         "annotate",
278         NULL
279 };
280
281 /*
282  * ftrace_max_lock is used to protect the swapping of buffers
283  * when taking a max snapshot. The buffers themselves are
284  * protected by per_cpu spinlocks. But the action of the swap
285  * needs its own lock.
286  *
287  * This is defined as a raw_spinlock_t in order to help
288  * with performance when lockdep debugging is enabled.
289  */
290 static raw_spinlock_t ftrace_max_lock =
291         (raw_spinlock_t)__RAW_SPIN_LOCK_UNLOCKED;
292
293 /*
294  * Copy the new maximum trace into the separate maximum-trace
295  * structure. (this way the maximum trace is permanently saved,
296  * for later retrieval via /debugfs/tracing/latency_trace)
297  */
298 static void
299 __update_max_tr(struct trace_array *tr, struct task_struct *tsk, int cpu)
300 {
301         struct trace_array_cpu *data = tr->data[cpu];
302
303         max_tr.cpu = cpu;
304         max_tr.time_start = data->preempt_timestamp;
305
306         data = max_tr.data[cpu];
307         data->saved_latency = tracing_max_latency;
308
309         memcpy(data->comm, tsk->comm, TASK_COMM_LEN);
310         data->pid = tsk->pid;
311         data->uid = tsk->uid;
312         data->nice = tsk->static_prio - 20 - MAX_RT_PRIO;
313         data->policy = tsk->policy;
314         data->rt_priority = tsk->rt_priority;
315
316         /* record this tasks comm */
317         tracing_record_cmdline(current);
318 }
319
320 /**
321  * trace_seq_printf - sequence printing of trace information
322  * @s: trace sequence descriptor
323  * @fmt: printf format string
324  *
325  * The tracer may use either sequence operations or its own
326  * copy to user routines. To simplify formating of a trace
327  * trace_seq_printf is used to store strings into a special
328  * buffer (@s). Then the output may be either used by
329  * the sequencer or pulled into another buffer.
330  */
331 int
332 trace_seq_printf(struct trace_seq *s, const char *fmt, ...)
333 {
334         int len = (PAGE_SIZE - 1) - s->len;
335         va_list ap;
336         int ret;
337
338         if (!len)
339                 return 0;
340
341         va_start(ap, fmt);
342         ret = vsnprintf(s->buffer + s->len, len, fmt, ap);
343         va_end(ap);
344
345         /* If we can't write it all, don't bother writing anything */
346         if (ret >= len)
347                 return 0;
348
349         s->len += ret;
350
351         return len;
352 }
353
354 /**
355  * trace_seq_puts - trace sequence printing of simple string
356  * @s: trace sequence descriptor
357  * @str: simple string to record
358  *
359  * The tracer may use either the sequence operations or its own
360  * copy to user routines. This function records a simple string
361  * into a special buffer (@s) for later retrieval by a sequencer
362  * or other mechanism.
363  */
364 static int
365 trace_seq_puts(struct trace_seq *s, const char *str)
366 {
367         int len = strlen(str);
368
369         if (len > ((PAGE_SIZE - 1) - s->len))
370                 return 0;
371
372         memcpy(s->buffer + s->len, str, len);
373         s->len += len;
374
375         return len;
376 }
377
378 static int
379 trace_seq_putc(struct trace_seq *s, unsigned char c)
380 {
381         if (s->len >= (PAGE_SIZE - 1))
382                 return 0;
383
384         s->buffer[s->len++] = c;
385
386         return 1;
387 }
388
389 static int
390 trace_seq_putmem(struct trace_seq *s, void *mem, size_t len)
391 {
392         if (len > ((PAGE_SIZE - 1) - s->len))
393                 return 0;
394
395         memcpy(s->buffer + s->len, mem, len);
396         s->len += len;
397
398         return len;
399 }
400
401 #define MAX_MEMHEX_BYTES        8
402 #define HEX_CHARS               (MAX_MEMHEX_BYTES*2 + 1)
403
404 static int
405 trace_seq_putmem_hex(struct trace_seq *s, void *mem, size_t len)
406 {
407         unsigned char hex[HEX_CHARS];
408         unsigned char *data = mem;
409         int i, j;
410
411 #ifdef __BIG_ENDIAN
412         for (i = 0, j = 0; i < len; i++) {
413 #else
414         for (i = len-1, j = 0; i >= 0; i--) {
415 #endif
416                 hex[j++] = hex_asc_hi(data[i]);
417                 hex[j++] = hex_asc_lo(data[i]);
418         }
419         hex[j++] = ' ';
420
421         return trace_seq_putmem(s, hex, j);
422 }
423
424 static void
425 trace_seq_reset(struct trace_seq *s)
426 {
427         s->len = 0;
428         s->readpos = 0;
429 }
430
431 ssize_t trace_seq_to_user(struct trace_seq *s, char __user *ubuf, size_t cnt)
432 {
433         int len;
434         int ret;
435
436         if (s->len <= s->readpos)
437                 return -EBUSY;
438
439         len = s->len - s->readpos;
440         if (cnt > len)
441                 cnt = len;
442         ret = copy_to_user(ubuf, s->buffer + s->readpos, cnt);
443         if (ret)
444                 return -EFAULT;
445
446         s->readpos += len;
447         return cnt;
448 }
449
450 static void
451 trace_print_seq(struct seq_file *m, struct trace_seq *s)
452 {
453         int len = s->len >= PAGE_SIZE ? PAGE_SIZE - 1 : s->len;
454
455         s->buffer[len] = 0;
456         seq_puts(m, s->buffer);
457
458         trace_seq_reset(s);
459 }
460
461 /**
462  * update_max_tr - snapshot all trace buffers from global_trace to max_tr
463  * @tr: tracer
464  * @tsk: the task with the latency
465  * @cpu: The cpu that initiated the trace.
466  *
467  * Flip the buffers between the @tr and the max_tr and record information
468  * about which task was the cause of this latency.
469  */
470 void
471 update_max_tr(struct trace_array *tr, struct task_struct *tsk, int cpu)
472 {
473         struct ring_buffer *buf = tr->buffer;
474
475         WARN_ON_ONCE(!irqs_disabled());
476         __raw_spin_lock(&ftrace_max_lock);
477
478         tr->buffer = max_tr.buffer;
479         max_tr.buffer = buf;
480
481         ftrace_disable_cpu();
482         ring_buffer_reset(tr->buffer);
483         ftrace_enable_cpu();
484
485         __update_max_tr(tr, tsk, cpu);
486         __raw_spin_unlock(&ftrace_max_lock);
487 }
488
489 /**
490  * update_max_tr_single - only copy one trace over, and reset the rest
491  * @tr - tracer
492  * @tsk - task with the latency
493  * @cpu - the cpu of the buffer to copy.
494  *
495  * Flip the trace of a single CPU buffer between the @tr and the max_tr.
496  */
497 void
498 update_max_tr_single(struct trace_array *tr, struct task_struct *tsk, int cpu)
499 {
500         int ret;
501
502         WARN_ON_ONCE(!irqs_disabled());
503         __raw_spin_lock(&ftrace_max_lock);
504
505         ftrace_disable_cpu();
506
507         ring_buffer_reset(max_tr.buffer);
508         ret = ring_buffer_swap_cpu(max_tr.buffer, tr->buffer, cpu);
509
510         ftrace_enable_cpu();
511
512         WARN_ON_ONCE(ret);
513
514         __update_max_tr(tr, tsk, cpu);
515         __raw_spin_unlock(&ftrace_max_lock);
516 }
517
518 /**
519  * register_tracer - register a tracer with the ftrace system.
520  * @type - the plugin for the tracer
521  *
522  * Register a new plugin tracer.
523  */
524 int register_tracer(struct tracer *type)
525 {
526         struct tracer *t;
527         int len;
528         int ret = 0;
529
530         if (!type->name) {
531                 pr_info("Tracer must have a name\n");
532                 return -1;
533         }
534
535         /*
536          * When this gets called we hold the BKL which means that
537          * preemption is disabled. Various trace selftests however
538          * need to disable and enable preemption for successful tests.
539          * So we drop the BKL here and grab it after the tests again.
540          */
541         unlock_kernel();
542         mutex_lock(&trace_types_lock);
543
544         for (t = trace_types; t; t = t->next) {
545                 if (strcmp(type->name, t->name) == 0) {
546                         /* already found */
547                         pr_info("Trace %s already registered\n",
548                                 type->name);
549                         ret = -1;
550                         goto out;
551                 }
552         }
553
554         if (!type->set_flag)
555                 type->set_flag = &dummy_set_flag;
556         if (!type->flags)
557                 type->flags = &dummy_tracer_flags;
558         else
559                 if (!type->flags->opts)
560                         type->flags->opts = dummy_tracer_opt;
561
562 #ifdef CONFIG_FTRACE_STARTUP_TEST
563         if (type->selftest) {
564                 struct tracer *saved_tracer = current_trace;
565                 struct trace_array *tr = &global_trace;
566                 int i;
567                 /*
568                  * Run a selftest on this tracer.
569                  * Here we reset the trace buffer, and set the current
570                  * tracer to be this tracer. The tracer can then run some
571                  * internal tracing to verify that everything is in order.
572                  * If we fail, we do not register this tracer.
573                  */
574                 for_each_tracing_cpu(i)
575                         tracing_reset(tr, i);
576
577                 current_trace = type;
578                 /* the test is responsible for initializing and enabling */
579                 pr_info("Testing tracer %s: ", type->name);
580                 ret = type->selftest(type, tr);
581                 /* the test is responsible for resetting too */
582                 current_trace = saved_tracer;
583                 if (ret) {
584                         printk(KERN_CONT "FAILED!\n");
585                         goto out;
586                 }
587                 /* Only reset on passing, to avoid touching corrupted buffers */
588                 for_each_tracing_cpu(i)
589                         tracing_reset(tr, i);
590
591                 printk(KERN_CONT "PASSED\n");
592         }
593 #endif
594
595         type->next = trace_types;
596         trace_types = type;
597         len = strlen(type->name);
598         if (len > max_tracer_type_len)
599                 max_tracer_type_len = len;
600
601  out:
602         mutex_unlock(&trace_types_lock);
603         lock_kernel();
604
605         return ret;
606 }
607
608 void unregister_tracer(struct tracer *type)
609 {
610         struct tracer **t;
611         int len;
612
613         mutex_lock(&trace_types_lock);
614         for (t = &trace_types; *t; t = &(*t)->next) {
615                 if (*t == type)
616                         goto found;
617         }
618         pr_info("Trace %s not registered\n", type->name);
619         goto out;
620
621  found:
622         *t = (*t)->next;
623         if (strlen(type->name) != max_tracer_type_len)
624                 goto out;
625
626         max_tracer_type_len = 0;
627         for (t = &trace_types; *t; t = &(*t)->next) {
628                 len = strlen((*t)->name);
629                 if (len > max_tracer_type_len)
630                         max_tracer_type_len = len;
631         }
632  out:
633         mutex_unlock(&trace_types_lock);
634 }
635
636 void tracing_reset(struct trace_array *tr, int cpu)
637 {
638         ftrace_disable_cpu();
639         ring_buffer_reset_cpu(tr->buffer, cpu);
640         ftrace_enable_cpu();
641 }
642
643 #define SAVED_CMDLINES 128
644 static unsigned map_pid_to_cmdline[PID_MAX_DEFAULT+1];
645 static unsigned map_cmdline_to_pid[SAVED_CMDLINES];
646 static char saved_cmdlines[SAVED_CMDLINES][TASK_COMM_LEN];
647 static int cmdline_idx;
648 static DEFINE_SPINLOCK(trace_cmdline_lock);
649
650 /* temporary disable recording */
651 atomic_t trace_record_cmdline_disabled __read_mostly;
652
653 static void trace_init_cmdlines(void)
654 {
655         memset(&map_pid_to_cmdline, -1, sizeof(map_pid_to_cmdline));
656         memset(&map_cmdline_to_pid, -1, sizeof(map_cmdline_to_pid));
657         cmdline_idx = 0;
658 }
659
660 static int trace_stop_count;
661 static DEFINE_SPINLOCK(tracing_start_lock);
662
663 /**
664  * tracing_start - quick start of the tracer
665  *
666  * If tracing is enabled but was stopped by tracing_stop,
667  * this will start the tracer back up.
668  */
669 void tracing_start(void)
670 {
671         struct ring_buffer *buffer;
672         unsigned long flags;
673
674         if (tracing_disabled)
675                 return;
676
677         spin_lock_irqsave(&tracing_start_lock, flags);
678         if (--trace_stop_count)
679                 goto out;
680
681         if (trace_stop_count < 0) {
682                 /* Someone screwed up their debugging */
683                 WARN_ON_ONCE(1);
684                 trace_stop_count = 0;
685                 goto out;
686         }
687
688
689         buffer = global_trace.buffer;
690         if (buffer)
691                 ring_buffer_record_enable(buffer);
692
693         buffer = max_tr.buffer;
694         if (buffer)
695                 ring_buffer_record_enable(buffer);
696
697         ftrace_start();
698  out:
699         spin_unlock_irqrestore(&tracing_start_lock, flags);
700 }
701
702 /**
703  * tracing_stop - quick stop of the tracer
704  *
705  * Light weight way to stop tracing. Use in conjunction with
706  * tracing_start.
707  */
708 void tracing_stop(void)
709 {
710         struct ring_buffer *buffer;
711         unsigned long flags;
712
713         ftrace_stop();
714         spin_lock_irqsave(&tracing_start_lock, flags);
715         if (trace_stop_count++)
716                 goto out;
717
718         buffer = global_trace.buffer;
719         if (buffer)
720                 ring_buffer_record_disable(buffer);
721
722         buffer = max_tr.buffer;
723         if (buffer)
724                 ring_buffer_record_disable(buffer);
725
726  out:
727         spin_unlock_irqrestore(&tracing_start_lock, flags);
728 }
729
730 void trace_stop_cmdline_recording(void);
731
732 static void trace_save_cmdline(struct task_struct *tsk)
733 {
734         unsigned map;
735         unsigned idx;
736
737         if (!tsk->pid || unlikely(tsk->pid > PID_MAX_DEFAULT))
738                 return;
739
740         /*
741          * It's not the end of the world if we don't get
742          * the lock, but we also don't want to spin
743          * nor do we want to disable interrupts,
744          * so if we miss here, then better luck next time.
745          */
746         if (!spin_trylock(&trace_cmdline_lock))
747                 return;
748
749         idx = map_pid_to_cmdline[tsk->pid];
750         if (idx >= SAVED_CMDLINES) {
751                 idx = (cmdline_idx + 1) % SAVED_CMDLINES;
752
753                 map = map_cmdline_to_pid[idx];
754                 if (map <= PID_MAX_DEFAULT)
755                         map_pid_to_cmdline[map] = (unsigned)-1;
756
757                 map_pid_to_cmdline[tsk->pid] = idx;
758
759                 cmdline_idx = idx;
760         }
761
762         memcpy(&saved_cmdlines[idx], tsk->comm, TASK_COMM_LEN);
763
764         spin_unlock(&trace_cmdline_lock);
765 }
766
767 static char *trace_find_cmdline(int pid)
768 {
769         char *cmdline = "<...>";
770         unsigned map;
771
772         if (!pid)
773                 return "<idle>";
774
775         if (pid > PID_MAX_DEFAULT)
776                 goto out;
777
778         map = map_pid_to_cmdline[pid];
779         if (map >= SAVED_CMDLINES)
780                 goto out;
781
782         cmdline = saved_cmdlines[map];
783
784  out:
785         return cmdline;
786 }
787
788 void tracing_record_cmdline(struct task_struct *tsk)
789 {
790         if (atomic_read(&trace_record_cmdline_disabled))
791                 return;
792
793         trace_save_cmdline(tsk);
794 }
795
796 void
797 tracing_generic_entry_update(struct trace_entry *entry, unsigned long flags,
798                              int pc)
799 {
800         struct task_struct *tsk = current;
801
802         entry->preempt_count            = pc & 0xff;
803         entry->pid                      = (tsk) ? tsk->pid : 0;
804         entry->flags =
805 #ifdef CONFIG_TRACE_IRQFLAGS_SUPPORT
806                 (irqs_disabled_flags(flags) ? TRACE_FLAG_IRQS_OFF : 0) |
807 #else
808                 TRACE_FLAG_IRQS_NOSUPPORT |
809 #endif
810                 ((pc & HARDIRQ_MASK) ? TRACE_FLAG_HARDIRQ : 0) |
811                 ((pc & SOFTIRQ_MASK) ? TRACE_FLAG_SOFTIRQ : 0) |
812                 (need_resched() ? TRACE_FLAG_NEED_RESCHED : 0);
813 }
814
815 void
816 trace_function(struct trace_array *tr, struct trace_array_cpu *data,
817                unsigned long ip, unsigned long parent_ip, unsigned long flags,
818                int pc)
819 {
820         struct ring_buffer_event *event;
821         struct ftrace_entry *entry;
822         unsigned long irq_flags;
823
824         /* If we are reading the ring buffer, don't trace */
825         if (unlikely(local_read(&__get_cpu_var(ftrace_cpu_disabled))))
826                 return;
827
828         event = ring_buffer_lock_reserve(tr->buffer, sizeof(*entry),
829                                          &irq_flags);
830         if (!event)
831                 return;
832         entry   = ring_buffer_event_data(event);
833         tracing_generic_entry_update(&entry->ent, flags, pc);
834         entry->ent.type                 = TRACE_FN;
835         entry->ip                       = ip;
836         entry->parent_ip                = parent_ip;
837         ring_buffer_unlock_commit(tr->buffer, event, irq_flags);
838 }
839
840 #ifdef CONFIG_FUNCTION_RET_TRACER
841 static void __trace_function_return(struct trace_array *tr,
842                                 struct trace_array_cpu *data,
843                                 struct ftrace_retfunc *trace,
844                                 unsigned long flags,
845                                 int pc)
846 {
847         struct ring_buffer_event *event;
848         struct ftrace_ret_entry *entry;
849         unsigned long irq_flags;
850
851         if (unlikely(local_read(&__get_cpu_var(ftrace_cpu_disabled))))
852                 return;
853
854         event = ring_buffer_lock_reserve(global_trace.buffer, sizeof(*entry),
855                                          &irq_flags);
856         if (!event)
857                 return;
858         entry   = ring_buffer_event_data(event);
859         tracing_generic_entry_update(&entry->ent, flags, pc);
860         entry->ent.type                 = TRACE_FN_RET;
861         entry->ip                       = trace->func;
862         entry->parent_ip        = trace->ret;
863         entry->rettime          = trace->rettime;
864         entry->calltime         = trace->calltime;
865         entry->overrun          = trace->overrun;
866         ring_buffer_unlock_commit(global_trace.buffer, event, irq_flags);
867 }
868 #endif
869
870 void
871 ftrace(struct trace_array *tr, struct trace_array_cpu *data,
872        unsigned long ip, unsigned long parent_ip, unsigned long flags,
873        int pc)
874 {
875         if (likely(!atomic_read(&data->disabled)))
876                 trace_function(tr, data, ip, parent_ip, flags, pc);
877 }
878
879 static void ftrace_trace_stack(struct trace_array *tr,
880                                struct trace_array_cpu *data,
881                                unsigned long flags,
882                                int skip, int pc)
883 {
884 #ifdef CONFIG_STACKTRACE
885         struct ring_buffer_event *event;
886         struct stack_entry *entry;
887         struct stack_trace trace;
888         unsigned long irq_flags;
889
890         if (!(trace_flags & TRACE_ITER_STACKTRACE))
891                 return;
892
893         event = ring_buffer_lock_reserve(tr->buffer, sizeof(*entry),
894                                          &irq_flags);
895         if (!event)
896                 return;
897         entry   = ring_buffer_event_data(event);
898         tracing_generic_entry_update(&entry->ent, flags, pc);
899         entry->ent.type         = TRACE_STACK;
900
901         memset(&entry->caller, 0, sizeof(entry->caller));
902
903         trace.nr_entries        = 0;
904         trace.max_entries       = FTRACE_STACK_ENTRIES;
905         trace.skip              = skip;
906         trace.entries           = entry->caller;
907
908         save_stack_trace(&trace);
909         ring_buffer_unlock_commit(tr->buffer, event, irq_flags);
910 #endif
911 }
912
913 void __trace_stack(struct trace_array *tr,
914                    struct trace_array_cpu *data,
915                    unsigned long flags,
916                    int skip)
917 {
918         ftrace_trace_stack(tr, data, flags, skip, preempt_count());
919 }
920
921 static void
922 ftrace_trace_special(void *__tr, void *__data,
923                      unsigned long arg1, unsigned long arg2, unsigned long arg3,
924                      int pc)
925 {
926         struct ring_buffer_event *event;
927         struct trace_array_cpu *data = __data;
928         struct trace_array *tr = __tr;
929         struct special_entry *entry;
930         unsigned long irq_flags;
931
932         event = ring_buffer_lock_reserve(tr->buffer, sizeof(*entry),
933                                          &irq_flags);
934         if (!event)
935                 return;
936         entry   = ring_buffer_event_data(event);
937         tracing_generic_entry_update(&entry->ent, 0, pc);
938         entry->ent.type                 = TRACE_SPECIAL;
939         entry->arg1                     = arg1;
940         entry->arg2                     = arg2;
941         entry->arg3                     = arg3;
942         ring_buffer_unlock_commit(tr->buffer, event, irq_flags);
943         ftrace_trace_stack(tr, data, irq_flags, 4, pc);
944
945         trace_wake_up();
946 }
947
948 void
949 __trace_special(void *__tr, void *__data,
950                 unsigned long arg1, unsigned long arg2, unsigned long arg3)
951 {
952         ftrace_trace_special(__tr, __data, arg1, arg2, arg3, preempt_count());
953 }
954
955 void
956 tracing_sched_switch_trace(struct trace_array *tr,
957                            struct trace_array_cpu *data,
958                            struct task_struct *prev,
959                            struct task_struct *next,
960                            unsigned long flags, int pc)
961 {
962         struct ring_buffer_event *event;
963         struct ctx_switch_entry *entry;
964         unsigned long irq_flags;
965
966         event = ring_buffer_lock_reserve(tr->buffer, sizeof(*entry),
967                                            &irq_flags);
968         if (!event)
969                 return;
970         entry   = ring_buffer_event_data(event);
971         tracing_generic_entry_update(&entry->ent, flags, pc);
972         entry->ent.type                 = TRACE_CTX;
973         entry->prev_pid                 = prev->pid;
974         entry->prev_prio                = prev->prio;
975         entry->prev_state               = prev->state;
976         entry->next_pid                 = next->pid;
977         entry->next_prio                = next->prio;
978         entry->next_state               = next->state;
979         entry->next_cpu = task_cpu(next);
980         ring_buffer_unlock_commit(tr->buffer, event, irq_flags);
981         ftrace_trace_stack(tr, data, flags, 5, pc);
982 }
983
984 void
985 tracing_sched_wakeup_trace(struct trace_array *tr,
986                            struct trace_array_cpu *data,
987                            struct task_struct *wakee,
988                            struct task_struct *curr,
989                            unsigned long flags, int pc)
990 {
991         struct ring_buffer_event *event;
992         struct ctx_switch_entry *entry;
993         unsigned long irq_flags;
994
995         event = ring_buffer_lock_reserve(tr->buffer, sizeof(*entry),
996                                            &irq_flags);
997         if (!event)
998                 return;
999         entry   = ring_buffer_event_data(event);
1000         tracing_generic_entry_update(&entry->ent, flags, pc);
1001         entry->ent.type                 = TRACE_WAKE;
1002         entry->prev_pid                 = curr->pid;
1003         entry->prev_prio                = curr->prio;
1004         entry->prev_state               = curr->state;
1005         entry->next_pid                 = wakee->pid;
1006         entry->next_prio                = wakee->prio;
1007         entry->next_state               = wakee->state;
1008         entry->next_cpu                 = task_cpu(wakee);
1009         ring_buffer_unlock_commit(tr->buffer, event, irq_flags);
1010         ftrace_trace_stack(tr, data, flags, 6, pc);
1011
1012         trace_wake_up();
1013 }
1014
1015 void
1016 ftrace_special(unsigned long arg1, unsigned long arg2, unsigned long arg3)
1017 {
1018         struct trace_array *tr = &global_trace;
1019         struct trace_array_cpu *data;
1020         unsigned long flags;
1021         int cpu;
1022         int pc;
1023
1024         if (tracing_disabled)
1025                 return;
1026
1027         pc = preempt_count();
1028         local_irq_save(flags);
1029         cpu = raw_smp_processor_id();
1030         data = tr->data[cpu];
1031
1032         if (likely(atomic_inc_return(&data->disabled) == 1))
1033                 ftrace_trace_special(tr, data, arg1, arg2, arg3, pc);
1034
1035         atomic_dec(&data->disabled);
1036         local_irq_restore(flags);
1037 }
1038
1039 #ifdef CONFIG_FUNCTION_TRACER
1040 static void
1041 function_trace_call_preempt_only(unsigned long ip, unsigned long parent_ip)
1042 {
1043         struct trace_array *tr = &global_trace;
1044         struct trace_array_cpu *data;
1045         unsigned long flags;
1046         long disabled;
1047         int cpu, resched;
1048         int pc;
1049
1050         if (unlikely(!ftrace_function_enabled))
1051                 return;
1052
1053         pc = preempt_count();
1054         resched = ftrace_preempt_disable();
1055         local_save_flags(flags);
1056         cpu = raw_smp_processor_id();
1057         data = tr->data[cpu];
1058         disabled = atomic_inc_return(&data->disabled);
1059
1060         if (likely(disabled == 1))
1061                 trace_function(tr, data, ip, parent_ip, flags, pc);
1062
1063         atomic_dec(&data->disabled);
1064         ftrace_preempt_enable(resched);
1065 }
1066
1067 static void
1068 function_trace_call(unsigned long ip, unsigned long parent_ip)
1069 {
1070         struct trace_array *tr = &global_trace;
1071         struct trace_array_cpu *data;
1072         unsigned long flags;
1073         long disabled;
1074         int cpu;
1075         int pc;
1076
1077         if (unlikely(!ftrace_function_enabled))
1078                 return;
1079
1080         /*
1081          * Need to use raw, since this must be called before the
1082          * recursive protection is performed.
1083          */
1084         local_irq_save(flags);
1085         cpu = raw_smp_processor_id();
1086         data = tr->data[cpu];
1087         disabled = atomic_inc_return(&data->disabled);
1088
1089         if (likely(disabled == 1)) {
1090                 pc = preempt_count();
1091                 trace_function(tr, data, ip, parent_ip, flags, pc);
1092         }
1093
1094         atomic_dec(&data->disabled);
1095         local_irq_restore(flags);
1096 }
1097
1098 #ifdef CONFIG_FUNCTION_RET_TRACER
1099 void trace_function_return(struct ftrace_retfunc *trace)
1100 {
1101         struct trace_array *tr = &global_trace;
1102         struct trace_array_cpu *data;
1103         unsigned long flags;
1104         long disabled;
1105         int cpu;
1106         int pc;
1107
1108         raw_local_irq_save(flags);
1109         cpu = raw_smp_processor_id();
1110         data = tr->data[cpu];
1111         disabled = atomic_inc_return(&data->disabled);
1112         if (likely(disabled == 1)) {
1113                 pc = preempt_count();
1114                 __trace_function_return(tr, data, trace, flags, pc);
1115         }
1116         atomic_dec(&data->disabled);
1117         raw_local_irq_restore(flags);
1118 }
1119 #endif /* CONFIG_FUNCTION_RET_TRACER */
1120
1121 static struct ftrace_ops trace_ops __read_mostly =
1122 {
1123         .func = function_trace_call,
1124 };
1125
1126 void tracing_start_function_trace(void)
1127 {
1128         ftrace_function_enabled = 0;
1129
1130         if (trace_flags & TRACE_ITER_PREEMPTONLY)
1131                 trace_ops.func = function_trace_call_preempt_only;
1132         else
1133                 trace_ops.func = function_trace_call;
1134
1135         register_ftrace_function(&trace_ops);
1136         ftrace_function_enabled = 1;
1137 }
1138
1139 void tracing_stop_function_trace(void)
1140 {
1141         ftrace_function_enabled = 0;
1142         unregister_ftrace_function(&trace_ops);
1143 }
1144 #endif
1145
1146 enum trace_file_type {
1147         TRACE_FILE_LAT_FMT      = 1,
1148         TRACE_FILE_ANNOTATE     = 2,
1149 };
1150
1151 static void trace_iterator_increment(struct trace_iterator *iter, int cpu)
1152 {
1153         /* Don't allow ftrace to trace into the ring buffers */
1154         ftrace_disable_cpu();
1155
1156         iter->idx++;
1157         if (iter->buffer_iter[iter->cpu])
1158                 ring_buffer_read(iter->buffer_iter[iter->cpu], NULL);
1159
1160         ftrace_enable_cpu();
1161 }
1162
1163 static struct trace_entry *
1164 peek_next_entry(struct trace_iterator *iter, int cpu, u64 *ts)
1165 {
1166         struct ring_buffer_event *event;
1167         struct ring_buffer_iter *buf_iter = iter->buffer_iter[cpu];
1168
1169         /* Don't allow ftrace to trace into the ring buffers */
1170         ftrace_disable_cpu();
1171
1172         if (buf_iter)
1173                 event = ring_buffer_iter_peek(buf_iter, ts);
1174         else
1175                 event = ring_buffer_peek(iter->tr->buffer, cpu, ts);
1176
1177         ftrace_enable_cpu();
1178
1179         return event ? ring_buffer_event_data(event) : NULL;
1180 }
1181
1182 static struct trace_entry *
1183 __find_next_entry(struct trace_iterator *iter, int *ent_cpu, u64 *ent_ts)
1184 {
1185         struct ring_buffer *buffer = iter->tr->buffer;
1186         struct trace_entry *ent, *next = NULL;
1187         u64 next_ts = 0, ts;
1188         int next_cpu = -1;
1189         int cpu;
1190
1191         for_each_tracing_cpu(cpu) {
1192
1193                 if (ring_buffer_empty_cpu(buffer, cpu))
1194                         continue;
1195
1196                 ent = peek_next_entry(iter, cpu, &ts);
1197
1198                 /*
1199                  * Pick the entry with the smallest timestamp:
1200                  */
1201                 if (ent && (!next || ts < next_ts)) {
1202                         next = ent;
1203                         next_cpu = cpu;
1204                         next_ts = ts;
1205                 }
1206         }
1207
1208         if (ent_cpu)
1209                 *ent_cpu = next_cpu;
1210
1211         if (ent_ts)
1212                 *ent_ts = next_ts;
1213
1214         return next;
1215 }
1216
1217 /* Find the next real entry, without updating the iterator itself */
1218 static struct trace_entry *
1219 find_next_entry(struct trace_iterator *iter, int *ent_cpu, u64 *ent_ts)
1220 {
1221         return __find_next_entry(iter, ent_cpu, ent_ts);
1222 }
1223
1224 /* Find the next real entry, and increment the iterator to the next entry */
1225 static void *find_next_entry_inc(struct trace_iterator *iter)
1226 {
1227         iter->ent = __find_next_entry(iter, &iter->cpu, &iter->ts);
1228
1229         if (iter->ent)
1230                 trace_iterator_increment(iter, iter->cpu);
1231
1232         return iter->ent ? iter : NULL;
1233 }
1234
1235 static void trace_consume(struct trace_iterator *iter)
1236 {
1237         /* Don't allow ftrace to trace into the ring buffers */
1238         ftrace_disable_cpu();
1239         ring_buffer_consume(iter->tr->buffer, iter->cpu, &iter->ts);
1240         ftrace_enable_cpu();
1241 }
1242
1243 static void *s_next(struct seq_file *m, void *v, loff_t *pos)
1244 {
1245         struct trace_iterator *iter = m->private;
1246         int i = (int)*pos;
1247         void *ent;
1248
1249         (*pos)++;
1250
1251         /* can't go backwards */
1252         if (iter->idx > i)
1253                 return NULL;
1254
1255         if (iter->idx < 0)
1256                 ent = find_next_entry_inc(iter);
1257         else
1258                 ent = iter;
1259
1260         while (ent && iter->idx < i)
1261                 ent = find_next_entry_inc(iter);
1262
1263         iter->pos = *pos;
1264
1265         return ent;
1266 }
1267
1268 static void *s_start(struct seq_file *m, loff_t *pos)
1269 {
1270         struct trace_iterator *iter = m->private;
1271         void *p = NULL;
1272         loff_t l = 0;
1273         int cpu;
1274
1275         mutex_lock(&trace_types_lock);
1276
1277         if (!current_trace || current_trace != iter->trace) {
1278                 mutex_unlock(&trace_types_lock);
1279                 return NULL;
1280         }
1281
1282         atomic_inc(&trace_record_cmdline_disabled);
1283
1284         if (*pos != iter->pos) {
1285                 iter->ent = NULL;
1286                 iter->cpu = 0;
1287                 iter->idx = -1;
1288
1289                 ftrace_disable_cpu();
1290
1291                 for_each_tracing_cpu(cpu) {
1292                         ring_buffer_iter_reset(iter->buffer_iter[cpu]);
1293                 }
1294
1295                 ftrace_enable_cpu();
1296
1297                 for (p = iter; p && l < *pos; p = s_next(m, p, &l))
1298                         ;
1299
1300         } else {
1301                 l = *pos - 1;
1302                 p = s_next(m, p, &l);
1303         }
1304
1305         return p;
1306 }
1307
1308 static void s_stop(struct seq_file *m, void *p)
1309 {
1310         atomic_dec(&trace_record_cmdline_disabled);
1311         mutex_unlock(&trace_types_lock);
1312 }
1313
1314 #ifdef CONFIG_KRETPROBES
1315 static inline const char *kretprobed(const char *name)
1316 {
1317         static const char tramp_name[] = "kretprobe_trampoline";
1318         int size = sizeof(tramp_name);
1319
1320         if (strncmp(tramp_name, name, size) == 0)
1321                 return "[unknown/kretprobe'd]";
1322         return name;
1323 }
1324 #else
1325 static inline const char *kretprobed(const char *name)
1326 {
1327         return name;
1328 }
1329 #endif /* CONFIG_KRETPROBES */
1330
1331 static int
1332 seq_print_sym_short(struct trace_seq *s, const char *fmt, unsigned long address)
1333 {
1334 #ifdef CONFIG_KALLSYMS
1335         char str[KSYM_SYMBOL_LEN];
1336         const char *name;
1337
1338         kallsyms_lookup(address, NULL, NULL, NULL, str);
1339
1340         name = kretprobed(str);
1341
1342         return trace_seq_printf(s, fmt, name);
1343 #endif
1344         return 1;
1345 }
1346
1347 static int
1348 seq_print_sym_offset(struct trace_seq *s, const char *fmt,
1349                      unsigned long address)
1350 {
1351 #ifdef CONFIG_KALLSYMS
1352         char str[KSYM_SYMBOL_LEN];
1353         const char *name;
1354
1355         sprint_symbol(str, address);
1356         name = kretprobed(str);
1357
1358         return trace_seq_printf(s, fmt, name);
1359 #endif
1360         return 1;
1361 }
1362
1363 #ifndef CONFIG_64BIT
1364 # define IP_FMT "%08lx"
1365 #else
1366 # define IP_FMT "%016lx"
1367 #endif
1368
1369 int
1370 seq_print_ip_sym(struct trace_seq *s, unsigned long ip, unsigned long sym_flags)
1371 {
1372         int ret;
1373
1374         if (!ip)
1375                 return trace_seq_printf(s, "0");
1376
1377         if (sym_flags & TRACE_ITER_SYM_OFFSET)
1378                 ret = seq_print_sym_offset(s, "%s", ip);
1379         else
1380                 ret = seq_print_sym_short(s, "%s", ip);
1381
1382         if (!ret)
1383                 return 0;
1384
1385         if (sym_flags & TRACE_ITER_SYM_ADDR)
1386                 ret = trace_seq_printf(s, " <" IP_FMT ">", ip);
1387         return ret;
1388 }
1389
1390 static void print_lat_help_header(struct seq_file *m)
1391 {
1392         seq_puts(m, "#                  _------=> CPU#            \n");
1393         seq_puts(m, "#                 / _-----=> irqs-off        \n");
1394         seq_puts(m, "#                | / _----=> need-resched    \n");
1395         seq_puts(m, "#                || / _---=> hardirq/softirq \n");
1396         seq_puts(m, "#                ||| / _--=> preempt-depth   \n");
1397         seq_puts(m, "#                |||| /                      \n");
1398         seq_puts(m, "#                |||||     delay             \n");
1399         seq_puts(m, "#  cmd     pid   ||||| time  |   caller      \n");
1400         seq_puts(m, "#     \\   /      |||||   \\   |   /           \n");
1401 }
1402
1403 static void print_func_help_header(struct seq_file *m)
1404 {
1405         seq_puts(m, "#           TASK-PID    CPU#    TIMESTAMP  FUNCTION\n");
1406         seq_puts(m, "#              | |       |          |         |\n");
1407 }
1408
1409
1410 static void
1411 print_trace_header(struct seq_file *m, struct trace_iterator *iter)
1412 {
1413         unsigned long sym_flags = (trace_flags & TRACE_ITER_SYM_MASK);
1414         struct trace_array *tr = iter->tr;
1415         struct trace_array_cpu *data = tr->data[tr->cpu];
1416         struct tracer *type = current_trace;
1417         unsigned long total;
1418         unsigned long entries;
1419         const char *name = "preemption";
1420
1421         if (type)
1422                 name = type->name;
1423
1424         entries = ring_buffer_entries(iter->tr->buffer);
1425         total = entries +
1426                 ring_buffer_overruns(iter->tr->buffer);
1427
1428         seq_printf(m, "%s latency trace v1.1.5 on %s\n",
1429                    name, UTS_RELEASE);
1430         seq_puts(m, "-----------------------------------"
1431                  "---------------------------------\n");
1432         seq_printf(m, " latency: %lu us, #%lu/%lu, CPU#%d |"
1433                    " (M:%s VP:%d, KP:%d, SP:%d HP:%d",
1434                    nsecs_to_usecs(data->saved_latency),
1435                    entries,
1436                    total,
1437                    tr->cpu,
1438 #if defined(CONFIG_PREEMPT_NONE)
1439                    "server",
1440 #elif defined(CONFIG_PREEMPT_VOLUNTARY)
1441                    "desktop",
1442 #elif defined(CONFIG_PREEMPT)
1443                    "preempt",
1444 #else
1445                    "unknown",
1446 #endif
1447                    /* These are reserved for later use */
1448                    0, 0, 0, 0);
1449 #ifdef CONFIG_SMP
1450         seq_printf(m, " #P:%d)\n", num_online_cpus());
1451 #else
1452         seq_puts(m, ")\n");
1453 #endif
1454         seq_puts(m, "    -----------------\n");
1455         seq_printf(m, "    | task: %.16s-%d "
1456                    "(uid:%d nice:%ld policy:%ld rt_prio:%ld)\n",
1457                    data->comm, data->pid, data->uid, data->nice,
1458                    data->policy, data->rt_priority);
1459         seq_puts(m, "    -----------------\n");
1460
1461         if (data->critical_start) {
1462                 seq_puts(m, " => started at: ");
1463                 seq_print_ip_sym(&iter->seq, data->critical_start, sym_flags);
1464                 trace_print_seq(m, &iter->seq);
1465                 seq_puts(m, "\n => ended at:   ");
1466                 seq_print_ip_sym(&iter->seq, data->critical_end, sym_flags);
1467                 trace_print_seq(m, &iter->seq);
1468                 seq_puts(m, "\n");
1469         }
1470
1471         seq_puts(m, "\n");
1472 }
1473
1474 static void
1475 lat_print_generic(struct trace_seq *s, struct trace_entry *entry, int cpu)
1476 {
1477         int hardirq, softirq;
1478         char *comm;
1479
1480         comm = trace_find_cmdline(entry->pid);
1481
1482         trace_seq_printf(s, "%8.8s-%-5d ", comm, entry->pid);
1483         trace_seq_printf(s, "%3d", cpu);
1484         trace_seq_printf(s, "%c%c",
1485                         (entry->flags & TRACE_FLAG_IRQS_OFF) ? 'd' :
1486                          (entry->flags & TRACE_FLAG_IRQS_NOSUPPORT) ? 'X' : '.',
1487                         ((entry->flags & TRACE_FLAG_NEED_RESCHED) ? 'N' : '.'));
1488
1489         hardirq = entry->flags & TRACE_FLAG_HARDIRQ;
1490         softirq = entry->flags & TRACE_FLAG_SOFTIRQ;
1491         if (hardirq && softirq) {
1492                 trace_seq_putc(s, 'H');
1493         } else {
1494                 if (hardirq) {
1495                         trace_seq_putc(s, 'h');
1496                 } else {
1497                         if (softirq)
1498                                 trace_seq_putc(s, 's');
1499                         else
1500                                 trace_seq_putc(s, '.');
1501                 }
1502         }
1503
1504         if (entry->preempt_count)
1505                 trace_seq_printf(s, "%x", entry->preempt_count);
1506         else
1507                 trace_seq_puts(s, ".");
1508 }
1509
1510 unsigned long preempt_mark_thresh = 100;
1511
1512 static void
1513 lat_print_timestamp(struct trace_seq *s, u64 abs_usecs,
1514                     unsigned long rel_usecs)
1515 {
1516         trace_seq_printf(s, " %4lldus", abs_usecs);
1517         if (rel_usecs > preempt_mark_thresh)
1518                 trace_seq_puts(s, "!: ");
1519         else if (rel_usecs > 1)
1520                 trace_seq_puts(s, "+: ");
1521         else
1522                 trace_seq_puts(s, " : ");
1523 }
1524
1525 static const char state_to_char[] = TASK_STATE_TO_CHAR_STR;
1526
1527 /*
1528  * The message is supposed to contain an ending newline.
1529  * If the printing stops prematurely, try to add a newline of our own.
1530  */
1531 void trace_seq_print_cont(struct trace_seq *s, struct trace_iterator *iter)
1532 {
1533         struct trace_entry *ent;
1534         struct trace_field_cont *cont;
1535         bool ok = true;
1536
1537         ent = peek_next_entry(iter, iter->cpu, NULL);
1538         if (!ent || ent->type != TRACE_CONT) {
1539                 trace_seq_putc(s, '\n');
1540                 return;
1541         }
1542
1543         do {
1544                 cont = (struct trace_field_cont *)ent;
1545                 if (ok)
1546                         ok = (trace_seq_printf(s, "%s", cont->buf) > 0);
1547
1548                 ftrace_disable_cpu();
1549
1550                 if (iter->buffer_iter[iter->cpu])
1551                         ring_buffer_read(iter->buffer_iter[iter->cpu], NULL);
1552                 else
1553                         ring_buffer_consume(iter->tr->buffer, iter->cpu, NULL);
1554
1555                 ftrace_enable_cpu();
1556
1557                 ent = peek_next_entry(iter, iter->cpu, NULL);
1558         } while (ent && ent->type == TRACE_CONT);
1559
1560         if (!ok)
1561                 trace_seq_putc(s, '\n');
1562 }
1563
1564 static void test_cpu_buff_start(struct trace_iterator *iter)
1565 {
1566         struct trace_seq *s = &iter->seq;
1567
1568         if (!(trace_flags & TRACE_ITER_ANNOTATE))
1569                 return;
1570
1571         if (!(iter->iter_flags & TRACE_FILE_ANNOTATE))
1572                 return;
1573
1574         if (cpu_isset(iter->cpu, iter->started))
1575                 return;
1576
1577         cpu_set(iter->cpu, iter->started);
1578         trace_seq_printf(s, "##### CPU %u buffer started ####\n", iter->cpu);
1579 }
1580
1581 static enum print_line_t
1582 print_lat_fmt(struct trace_iterator *iter, unsigned int trace_idx, int cpu)
1583 {
1584         struct trace_seq *s = &iter->seq;
1585         unsigned long sym_flags = (trace_flags & TRACE_ITER_SYM_MASK);
1586         struct trace_entry *next_entry;
1587         unsigned long verbose = (trace_flags & TRACE_ITER_VERBOSE);
1588         struct trace_entry *entry = iter->ent;
1589         unsigned long abs_usecs;
1590         unsigned long rel_usecs;
1591         u64 next_ts;
1592         char *comm;
1593         int S, T;
1594         int i;
1595         unsigned state;
1596
1597         if (entry->type == TRACE_CONT)
1598                 return TRACE_TYPE_HANDLED;
1599
1600         test_cpu_buff_start(iter);
1601
1602         next_entry = find_next_entry(iter, NULL, &next_ts);
1603         if (!next_entry)
1604                 next_ts = iter->ts;
1605         rel_usecs = ns2usecs(next_ts - iter->ts);
1606         abs_usecs = ns2usecs(iter->ts - iter->tr->time_start);
1607
1608         if (verbose) {
1609                 comm = trace_find_cmdline(entry->pid);
1610                 trace_seq_printf(s, "%16s %5d %3d %d %08x %08x [%08lx]"
1611                                  " %ld.%03ldms (+%ld.%03ldms): ",
1612                                  comm,
1613                                  entry->pid, cpu, entry->flags,
1614                                  entry->preempt_count, trace_idx,
1615                                  ns2usecs(iter->ts),
1616                                  abs_usecs/1000,
1617                                  abs_usecs % 1000, rel_usecs/1000,
1618                                  rel_usecs % 1000);
1619         } else {
1620                 lat_print_generic(s, entry, cpu);
1621                 lat_print_timestamp(s, abs_usecs, rel_usecs);
1622         }
1623         switch (entry->type) {
1624         case TRACE_FN: {
1625                 struct ftrace_entry *field;
1626
1627                 trace_assign_type(field, entry);
1628
1629                 seq_print_ip_sym(s, field->ip, sym_flags);
1630                 trace_seq_puts(s, " (");
1631                 seq_print_ip_sym(s, field->parent_ip, sym_flags);
1632                 trace_seq_puts(s, ")\n");
1633                 break;
1634         }
1635         case TRACE_CTX:
1636         case TRACE_WAKE: {
1637                 struct ctx_switch_entry *field;
1638
1639                 trace_assign_type(field, entry);
1640
1641                 T = field->next_state < sizeof(state_to_char) ?
1642                         state_to_char[field->next_state] : 'X';
1643
1644                 state = field->prev_state ?
1645                         __ffs(field->prev_state) + 1 : 0;
1646                 S = state < sizeof(state_to_char) - 1 ? state_to_char[state] : 'X';
1647                 comm = trace_find_cmdline(field->next_pid);
1648                 trace_seq_printf(s, " %5d:%3d:%c %s [%03d] %5d:%3d:%c %s\n",
1649                                  field->prev_pid,
1650                                  field->prev_prio,
1651                                  S, entry->type == TRACE_CTX ? "==>" : "  +",
1652                                  field->next_cpu,
1653                                  field->next_pid,
1654                                  field->next_prio,
1655                                  T, comm);
1656                 break;
1657         }
1658         case TRACE_SPECIAL: {
1659                 struct special_entry *field;
1660
1661                 trace_assign_type(field, entry);
1662
1663                 trace_seq_printf(s, "# %ld %ld %ld\n",
1664                                  field->arg1,
1665                                  field->arg2,
1666                                  field->arg3);
1667                 break;
1668         }
1669         case TRACE_STACK: {
1670                 struct stack_entry *field;
1671
1672                 trace_assign_type(field, entry);
1673
1674                 for (i = 0; i < FTRACE_STACK_ENTRIES; i++) {
1675                         if (i)
1676                                 trace_seq_puts(s, " <= ");
1677                         seq_print_ip_sym(s, field->caller[i], sym_flags);
1678                 }
1679                 trace_seq_puts(s, "\n");
1680                 break;
1681         }
1682         case TRACE_PRINT: {
1683                 struct print_entry *field;
1684
1685                 trace_assign_type(field, entry);
1686
1687                 seq_print_ip_sym(s, field->ip, sym_flags);
1688                 trace_seq_printf(s, ": %s", field->buf);
1689                 if (entry->flags & TRACE_FLAG_CONT)
1690                         trace_seq_print_cont(s, iter);
1691                 break;
1692         }
1693         case TRACE_BRANCH: {
1694                 struct trace_branch *field;
1695
1696                 trace_assign_type(field, entry);
1697
1698                 trace_seq_printf(s, "[%s] %s:%s:%d\n",
1699                                  field->correct ? "  ok  " : " MISS ",
1700                                  field->func,
1701                                  field->file,
1702                                  field->line);
1703                 break;
1704         }
1705         default:
1706                 trace_seq_printf(s, "Unknown type %d\n", entry->type);
1707         }
1708         return TRACE_TYPE_HANDLED;
1709 }
1710
1711 static enum print_line_t print_trace_fmt(struct trace_iterator *iter)
1712 {
1713         struct trace_seq *s = &iter->seq;
1714         unsigned long sym_flags = (trace_flags & TRACE_ITER_SYM_MASK);
1715         struct trace_entry *entry;
1716         unsigned long usec_rem;
1717         unsigned long long t;
1718         unsigned long secs;
1719         char *comm;
1720         int ret;
1721         int S, T;
1722         int i;
1723
1724         entry = iter->ent;
1725
1726         if (entry->type == TRACE_CONT)
1727                 return TRACE_TYPE_HANDLED;
1728
1729         test_cpu_buff_start(iter);
1730
1731         comm = trace_find_cmdline(iter->ent->pid);
1732
1733         t = ns2usecs(iter->ts);
1734         usec_rem = do_div(t, 1000000ULL);
1735         secs = (unsigned long)t;
1736
1737         ret = trace_seq_printf(s, "%16s-%-5d ", comm, entry->pid);
1738         if (!ret)
1739                 return TRACE_TYPE_PARTIAL_LINE;
1740         ret = trace_seq_printf(s, "[%03d] ", iter->cpu);
1741         if (!ret)
1742                 return TRACE_TYPE_PARTIAL_LINE;
1743         ret = trace_seq_printf(s, "%5lu.%06lu: ", secs, usec_rem);
1744         if (!ret)
1745                 return TRACE_TYPE_PARTIAL_LINE;
1746
1747         switch (entry->type) {
1748         case TRACE_FN: {
1749                 struct ftrace_entry *field;
1750
1751                 trace_assign_type(field, entry);
1752
1753                 ret = seq_print_ip_sym(s, field->ip, sym_flags);
1754                 if (!ret)
1755                         return TRACE_TYPE_PARTIAL_LINE;
1756                 if ((sym_flags & TRACE_ITER_PRINT_PARENT) &&
1757                                                 field->parent_ip) {
1758                         ret = trace_seq_printf(s, " <-");
1759                         if (!ret)
1760                                 return TRACE_TYPE_PARTIAL_LINE;
1761                         ret = seq_print_ip_sym(s,
1762                                                field->parent_ip,
1763                                                sym_flags);
1764                         if (!ret)
1765                                 return TRACE_TYPE_PARTIAL_LINE;
1766                 }
1767                 ret = trace_seq_printf(s, "\n");
1768                 if (!ret)
1769                         return TRACE_TYPE_PARTIAL_LINE;
1770                 break;
1771         }
1772         case TRACE_CTX:
1773         case TRACE_WAKE: {
1774                 struct ctx_switch_entry *field;
1775
1776                 trace_assign_type(field, entry);
1777
1778                 S = field->prev_state < sizeof(state_to_char) ?
1779                         state_to_char[field->prev_state] : 'X';
1780                 T = field->next_state < sizeof(state_to_char) ?
1781                         state_to_char[field->next_state] : 'X';
1782                 ret = trace_seq_printf(s, " %5d:%3d:%c %s [%03d] %5d:%3d:%c\n",
1783                                        field->prev_pid,
1784                                        field->prev_prio,
1785                                        S,
1786                                        entry->type == TRACE_CTX ? "==>" : "  +",
1787                                        field->next_cpu,
1788                                        field->next_pid,
1789                                        field->next_prio,
1790                                        T);
1791                 if (!ret)
1792                         return TRACE_TYPE_PARTIAL_LINE;
1793                 break;
1794         }
1795         case TRACE_SPECIAL: {
1796                 struct special_entry *field;
1797
1798                 trace_assign_type(field, entry);
1799
1800                 ret = trace_seq_printf(s, "# %ld %ld %ld\n",
1801                                  field->arg1,
1802                                  field->arg2,
1803                                  field->arg3);
1804                 if (!ret)
1805                         return TRACE_TYPE_PARTIAL_LINE;
1806                 break;
1807         }
1808         case TRACE_STACK: {
1809                 struct stack_entry *field;
1810
1811                 trace_assign_type(field, entry);
1812
1813                 for (i = 0; i < FTRACE_STACK_ENTRIES; i++) {
1814                         if (i) {
1815                                 ret = trace_seq_puts(s, " <= ");
1816                                 if (!ret)
1817                                         return TRACE_TYPE_PARTIAL_LINE;
1818                         }
1819                         ret = seq_print_ip_sym(s, field->caller[i],
1820                                                sym_flags);
1821                         if (!ret)
1822                                 return TRACE_TYPE_PARTIAL_LINE;
1823                 }
1824                 ret = trace_seq_puts(s, "\n");
1825                 if (!ret)
1826                         return TRACE_TYPE_PARTIAL_LINE;
1827                 break;
1828         }
1829         case TRACE_PRINT: {
1830                 struct print_entry *field;
1831
1832                 trace_assign_type(field, entry);
1833
1834                 seq_print_ip_sym(s, field->ip, sym_flags);
1835                 trace_seq_printf(s, ": %s", field->buf);
1836                 if (entry->flags & TRACE_FLAG_CONT)
1837                         trace_seq_print_cont(s, iter);
1838                 break;
1839         }
1840         case TRACE_FN_RET: {
1841                 return print_return_function(iter);
1842                 break;
1843         }
1844         case TRACE_BRANCH: {
1845                 struct trace_branch *field;
1846
1847                 trace_assign_type(field, entry);
1848
1849                 trace_seq_printf(s, "[%s] %s:%s:%d\n",
1850                                  field->correct ? "  ok  " : " MISS ",
1851                                  field->func,
1852                                  field->file,
1853                                  field->line);
1854                 break;
1855         }
1856         }
1857         return TRACE_TYPE_HANDLED;
1858 }
1859
1860 static enum print_line_t print_raw_fmt(struct trace_iterator *iter)
1861 {
1862         struct trace_seq *s = &iter->seq;
1863         struct trace_entry *entry;
1864         int ret;
1865         int S, T;
1866
1867         entry = iter->ent;
1868
1869         if (entry->type == TRACE_CONT)
1870                 return TRACE_TYPE_HANDLED;
1871
1872         ret = trace_seq_printf(s, "%d %d %llu ",
1873                 entry->pid, iter->cpu, iter->ts);
1874         if (!ret)
1875                 return TRACE_TYPE_PARTIAL_LINE;
1876
1877         switch (entry->type) {
1878         case TRACE_FN: {
1879                 struct ftrace_entry *field;
1880
1881                 trace_assign_type(field, entry);
1882
1883                 ret = trace_seq_printf(s, "%x %x\n",
1884                                         field->ip,
1885                                         field->parent_ip);
1886                 if (!ret)
1887                         return TRACE_TYPE_PARTIAL_LINE;
1888                 break;
1889         }
1890         case TRACE_CTX:
1891         case TRACE_WAKE: {
1892                 struct ctx_switch_entry *field;
1893
1894                 trace_assign_type(field, entry);
1895
1896                 S = field->prev_state < sizeof(state_to_char) ?
1897                         state_to_char[field->prev_state] : 'X';
1898                 T = field->next_state < sizeof(state_to_char) ?
1899                         state_to_char[field->next_state] : 'X';
1900                 if (entry->type == TRACE_WAKE)
1901                         S = '+';
1902                 ret = trace_seq_printf(s, "%d %d %c %d %d %d %c\n",
1903                                        field->prev_pid,
1904                                        field->prev_prio,
1905                                        S,
1906                                        field->next_cpu,
1907                                        field->next_pid,
1908                                        field->next_prio,
1909                                        T);
1910                 if (!ret)
1911                         return TRACE_TYPE_PARTIAL_LINE;
1912                 break;
1913         }
1914         case TRACE_SPECIAL:
1915         case TRACE_STACK: {
1916                 struct special_entry *field;
1917
1918                 trace_assign_type(field, entry);
1919
1920                 ret = trace_seq_printf(s, "# %ld %ld %ld\n",
1921                                  field->arg1,
1922                                  field->arg2,
1923                                  field->arg3);
1924                 if (!ret)
1925                         return TRACE_TYPE_PARTIAL_LINE;
1926                 break;
1927         }
1928         case TRACE_PRINT: {
1929                 struct print_entry *field;
1930
1931                 trace_assign_type(field, entry);
1932
1933                 trace_seq_printf(s, "# %lx %s", field->ip, field->buf);
1934                 if (entry->flags & TRACE_FLAG_CONT)
1935                         trace_seq_print_cont(s, iter);
1936                 break;
1937         }
1938         }
1939         return TRACE_TYPE_HANDLED;
1940 }
1941
1942 #define SEQ_PUT_FIELD_RET(s, x)                         \
1943 do {                                                    \
1944         if (!trace_seq_putmem(s, &(x), sizeof(x)))      \
1945                 return 0;                               \
1946 } while (0)
1947
1948 #define SEQ_PUT_HEX_FIELD_RET(s, x)                     \
1949 do {                                                    \
1950         BUILD_BUG_ON(sizeof(x) > MAX_MEMHEX_BYTES);     \
1951         if (!trace_seq_putmem_hex(s, &(x), sizeof(x)))  \
1952                 return 0;                               \
1953 } while (0)
1954
1955 static enum print_line_t print_hex_fmt(struct trace_iterator *iter)
1956 {
1957         struct trace_seq *s = &iter->seq;
1958         unsigned char newline = '\n';
1959         struct trace_entry *entry;
1960         int S, T;
1961
1962         entry = iter->ent;
1963
1964         if (entry->type == TRACE_CONT)
1965                 return TRACE_TYPE_HANDLED;
1966
1967         SEQ_PUT_HEX_FIELD_RET(s, entry->pid);
1968         SEQ_PUT_HEX_FIELD_RET(s, iter->cpu);
1969         SEQ_PUT_HEX_FIELD_RET(s, iter->ts);
1970
1971         switch (entry->type) {
1972         case TRACE_FN: {
1973                 struct ftrace_entry *field;
1974
1975                 trace_assign_type(field, entry);
1976
1977                 SEQ_PUT_HEX_FIELD_RET(s, field->ip);
1978                 SEQ_PUT_HEX_FIELD_RET(s, field->parent_ip);
1979                 break;
1980         }
1981         case TRACE_CTX:
1982         case TRACE_WAKE: {
1983                 struct ctx_switch_entry *field;
1984
1985                 trace_assign_type(field, entry);
1986
1987                 S = field->prev_state < sizeof(state_to_char) ?
1988                         state_to_char[field->prev_state] : 'X';
1989                 T = field->next_state < sizeof(state_to_char) ?
1990                         state_to_char[field->next_state] : 'X';
1991                 if (entry->type == TRACE_WAKE)
1992                         S = '+';
1993                 SEQ_PUT_HEX_FIELD_RET(s, field->prev_pid);
1994                 SEQ_PUT_HEX_FIELD_RET(s, field->prev_prio);
1995                 SEQ_PUT_HEX_FIELD_RET(s, S);
1996                 SEQ_PUT_HEX_FIELD_RET(s, field->next_cpu);
1997                 SEQ_PUT_HEX_FIELD_RET(s, field->next_pid);
1998                 SEQ_PUT_HEX_FIELD_RET(s, field->next_prio);
1999                 SEQ_PUT_HEX_FIELD_RET(s, T);
2000                 break;
2001         }
2002         case TRACE_SPECIAL:
2003         case TRACE_STACK: {
2004                 struct special_entry *field;
2005
2006                 trace_assign_type(field, entry);
2007
2008                 SEQ_PUT_HEX_FIELD_RET(s, field->arg1);
2009                 SEQ_PUT_HEX_FIELD_RET(s, field->arg2);
2010                 SEQ_PUT_HEX_FIELD_RET(s, field->arg3);
2011                 break;
2012         }
2013         }
2014         SEQ_PUT_FIELD_RET(s, newline);
2015
2016         return TRACE_TYPE_HANDLED;
2017 }
2018
2019 static enum print_line_t print_bin_fmt(struct trace_iterator *iter)
2020 {
2021         struct trace_seq *s = &iter->seq;
2022         struct trace_entry *entry;
2023
2024         entry = iter->ent;
2025
2026         if (entry->type == TRACE_CONT)
2027                 return TRACE_TYPE_HANDLED;
2028
2029         SEQ_PUT_FIELD_RET(s, entry->pid);
2030         SEQ_PUT_FIELD_RET(s, entry->cpu);
2031         SEQ_PUT_FIELD_RET(s, iter->ts);
2032
2033         switch (entry->type) {
2034         case TRACE_FN: {
2035                 struct ftrace_entry *field;
2036
2037                 trace_assign_type(field, entry);
2038
2039                 SEQ_PUT_FIELD_RET(s, field->ip);
2040                 SEQ_PUT_FIELD_RET(s, field->parent_ip);
2041                 break;
2042         }
2043         case TRACE_CTX: {
2044                 struct ctx_switch_entry *field;
2045
2046                 trace_assign_type(field, entry);
2047
2048                 SEQ_PUT_FIELD_RET(s, field->prev_pid);
2049                 SEQ_PUT_FIELD_RET(s, field->prev_prio);
2050                 SEQ_PUT_FIELD_RET(s, field->prev_state);
2051                 SEQ_PUT_FIELD_RET(s, field->next_pid);
2052                 SEQ_PUT_FIELD_RET(s, field->next_prio);
2053                 SEQ_PUT_FIELD_RET(s, field->next_state);
2054                 break;
2055         }
2056         case TRACE_SPECIAL:
2057         case TRACE_STACK: {
2058                 struct special_entry *field;
2059
2060                 trace_assign_type(field, entry);
2061
2062                 SEQ_PUT_FIELD_RET(s, field->arg1);
2063                 SEQ_PUT_FIELD_RET(s, field->arg2);
2064                 SEQ_PUT_FIELD_RET(s, field->arg3);
2065                 break;
2066         }
2067         }
2068         return 1;
2069 }
2070
2071 static int trace_empty(struct trace_iterator *iter)
2072 {
2073         int cpu;
2074
2075         for_each_tracing_cpu(cpu) {
2076                 if (iter->buffer_iter[cpu]) {
2077                         if (!ring_buffer_iter_empty(iter->buffer_iter[cpu]))
2078                                 return 0;
2079                 } else {
2080                         if (!ring_buffer_empty_cpu(iter->tr->buffer, cpu))
2081                                 return 0;
2082                 }
2083         }
2084
2085         return 1;
2086 }
2087
2088 static enum print_line_t print_trace_line(struct trace_iterator *iter)
2089 {
2090         enum print_line_t ret;
2091
2092         if (iter->trace && iter->trace->print_line) {
2093                 ret = iter->trace->print_line(iter);
2094                 if (ret != TRACE_TYPE_UNHANDLED)
2095                         return ret;
2096         }
2097
2098         if (trace_flags & TRACE_ITER_BIN)
2099                 return print_bin_fmt(iter);
2100
2101         if (trace_flags & TRACE_ITER_HEX)
2102                 return print_hex_fmt(iter);
2103
2104         if (trace_flags & TRACE_ITER_RAW)
2105                 return print_raw_fmt(iter);
2106
2107         if (iter->iter_flags & TRACE_FILE_LAT_FMT)
2108                 return print_lat_fmt(iter, iter->idx, iter->cpu);
2109
2110         return print_trace_fmt(iter);
2111 }
2112
2113 static int s_show(struct seq_file *m, void *v)
2114 {
2115         struct trace_iterator *iter = v;
2116
2117         if (iter->ent == NULL) {
2118                 if (iter->tr) {
2119                         seq_printf(m, "# tracer: %s\n", iter->trace->name);
2120                         seq_puts(m, "#\n");
2121                 }
2122                 if (iter->iter_flags & TRACE_FILE_LAT_FMT) {
2123                         /* print nothing if the buffers are empty */
2124                         if (trace_empty(iter))
2125                                 return 0;
2126                         print_trace_header(m, iter);
2127                         if (!(trace_flags & TRACE_ITER_VERBOSE))
2128                                 print_lat_help_header(m);
2129                 } else {
2130                         if (!(trace_flags & TRACE_ITER_VERBOSE))
2131                                 print_func_help_header(m);
2132                 }
2133         } else {
2134                 print_trace_line(iter);
2135                 trace_print_seq(m, &iter->seq);
2136         }
2137
2138         return 0;
2139 }
2140
2141 static struct seq_operations tracer_seq_ops = {
2142         .start          = s_start,
2143         .next           = s_next,
2144         .stop           = s_stop,
2145         .show           = s_show,
2146 };
2147
2148 static struct trace_iterator *
2149 __tracing_open(struct inode *inode, struct file *file, int *ret)
2150 {
2151         struct trace_iterator *iter;
2152         struct seq_file *m;
2153         int cpu;
2154
2155         if (tracing_disabled) {
2156                 *ret = -ENODEV;
2157                 return NULL;
2158         }
2159
2160         iter = kzalloc(sizeof(*iter), GFP_KERNEL);
2161         if (!iter) {
2162                 *ret = -ENOMEM;
2163                 goto out;
2164         }
2165
2166         mutex_lock(&trace_types_lock);
2167         if (current_trace && current_trace->print_max)
2168                 iter->tr = &max_tr;
2169         else
2170                 iter->tr = inode->i_private;
2171         iter->trace = current_trace;
2172         iter->pos = -1;
2173
2174         /* Annotate start of buffers if we had overruns */
2175         if (ring_buffer_overruns(iter->tr->buffer))
2176                 iter->iter_flags |= TRACE_FILE_ANNOTATE;
2177
2178
2179         for_each_tracing_cpu(cpu) {
2180
2181                 iter->buffer_iter[cpu] =
2182                         ring_buffer_read_start(iter->tr->buffer, cpu);
2183
2184                 if (!iter->buffer_iter[cpu])
2185                         goto fail_buffer;
2186         }
2187
2188         /* TODO stop tracer */
2189         *ret = seq_open(file, &tracer_seq_ops);
2190         if (*ret)
2191                 goto fail_buffer;
2192
2193         m = file->private_data;
2194         m->private = iter;
2195
2196         /* stop the trace while dumping */
2197         tracing_stop();
2198
2199         if (iter->trace && iter->trace->open)
2200                         iter->trace->open(iter);
2201
2202         mutex_unlock(&trace_types_lock);
2203
2204  out:
2205         return iter;
2206
2207  fail_buffer:
2208         for_each_tracing_cpu(cpu) {
2209                 if (iter->buffer_iter[cpu])
2210                         ring_buffer_read_finish(iter->buffer_iter[cpu]);
2211         }
2212         mutex_unlock(&trace_types_lock);
2213         kfree(iter);
2214
2215         return ERR_PTR(-ENOMEM);
2216 }
2217
2218 int tracing_open_generic(struct inode *inode, struct file *filp)
2219 {
2220         if (tracing_disabled)
2221                 return -ENODEV;
2222
2223         filp->private_data = inode->i_private;
2224         return 0;
2225 }
2226
2227 int tracing_release(struct inode *inode, struct file *file)
2228 {
2229         struct seq_file *m = (struct seq_file *)file->private_data;
2230         struct trace_iterator *iter = m->private;
2231         int cpu;
2232
2233         mutex_lock(&trace_types_lock);
2234         for_each_tracing_cpu(cpu) {
2235                 if (iter->buffer_iter[cpu])
2236                         ring_buffer_read_finish(iter->buffer_iter[cpu]);
2237         }
2238
2239         if (iter->trace && iter->trace->close)
2240                 iter->trace->close(iter);
2241
2242         /* reenable tracing if it was previously enabled */
2243         tracing_start();
2244         mutex_unlock(&trace_types_lock);
2245
2246         seq_release(inode, file);
2247         kfree(iter);
2248         return 0;
2249 }
2250
2251 static int tracing_open(struct inode *inode, struct file *file)
2252 {
2253         int ret;
2254
2255         __tracing_open(inode, file, &ret);
2256
2257         return ret;
2258 }
2259
2260 static int tracing_lt_open(struct inode *inode, struct file *file)
2261 {
2262         struct trace_iterator *iter;
2263         int ret;
2264
2265         iter = __tracing_open(inode, file, &ret);
2266
2267         if (!ret)
2268                 iter->iter_flags |= TRACE_FILE_LAT_FMT;
2269
2270         return ret;
2271 }
2272
2273
2274 static void *
2275 t_next(struct seq_file *m, void *v, loff_t *pos)
2276 {
2277         struct tracer *t = m->private;
2278
2279         (*pos)++;
2280
2281         if (t)
2282                 t = t->next;
2283
2284         m->private = t;
2285
2286         return t;
2287 }
2288
2289 static void *t_start(struct seq_file *m, loff_t *pos)
2290 {
2291         struct tracer *t = m->private;
2292         loff_t l = 0;
2293
2294         mutex_lock(&trace_types_lock);
2295         for (; t && l < *pos; t = t_next(m, t, &l))
2296                 ;
2297
2298         return t;
2299 }
2300
2301 static void t_stop(struct seq_file *m, void *p)
2302 {
2303         mutex_unlock(&trace_types_lock);
2304 }
2305
2306 static int t_show(struct seq_file *m, void *v)
2307 {
2308         struct tracer *t = v;
2309
2310         if (!t)
2311                 return 0;
2312
2313         seq_printf(m, "%s", t->name);
2314         if (t->next)
2315                 seq_putc(m, ' ');
2316         else
2317                 seq_putc(m, '\n');
2318
2319         return 0;
2320 }
2321
2322 static struct seq_operations show_traces_seq_ops = {
2323         .start          = t_start,
2324         .next           = t_next,
2325         .stop           = t_stop,
2326         .show           = t_show,
2327 };
2328
2329 static int show_traces_open(struct inode *inode, struct file *file)
2330 {
2331         int ret;
2332
2333         if (tracing_disabled)
2334                 return -ENODEV;
2335
2336         ret = seq_open(file, &show_traces_seq_ops);
2337         if (!ret) {
2338                 struct seq_file *m = file->private_data;
2339                 m->private = trace_types;
2340         }
2341
2342         return ret;
2343 }
2344
2345 static struct file_operations tracing_fops = {
2346         .open           = tracing_open,
2347         .read           = seq_read,
2348         .llseek         = seq_lseek,
2349         .release        = tracing_release,
2350 };
2351
2352 static struct file_operations tracing_lt_fops = {
2353         .open           = tracing_lt_open,
2354         .read           = seq_read,
2355         .llseek         = seq_lseek,
2356         .release        = tracing_release,
2357 };
2358
2359 static struct file_operations show_traces_fops = {
2360         .open           = show_traces_open,
2361         .read           = seq_read,
2362         .release        = seq_release,
2363 };
2364
2365 /*
2366  * Only trace on a CPU if the bitmask is set:
2367  */
2368 static cpumask_t tracing_cpumask = CPU_MASK_ALL;
2369
2370 /*
2371  * When tracing/tracing_cpu_mask is modified then this holds
2372  * the new bitmask we are about to install:
2373  */
2374 static cpumask_t tracing_cpumask_new;
2375
2376 /*
2377  * The tracer itself will not take this lock, but still we want
2378  * to provide a consistent cpumask to user-space:
2379  */
2380 static DEFINE_MUTEX(tracing_cpumask_update_lock);
2381
2382 /*
2383  * Temporary storage for the character representation of the
2384  * CPU bitmask (and one more byte for the newline):
2385  */
2386 static char mask_str[NR_CPUS + 1];
2387
2388 static ssize_t
2389 tracing_cpumask_read(struct file *filp, char __user *ubuf,
2390                      size_t count, loff_t *ppos)
2391 {
2392         int len;
2393
2394         mutex_lock(&tracing_cpumask_update_lock);
2395
2396         len = cpumask_scnprintf(mask_str, count, tracing_cpumask);
2397         if (count - len < 2) {
2398                 count = -EINVAL;
2399                 goto out_err;
2400         }
2401         len += sprintf(mask_str + len, "\n");
2402         count = simple_read_from_buffer(ubuf, count, ppos, mask_str, NR_CPUS+1);
2403
2404 out_err:
2405         mutex_unlock(&tracing_cpumask_update_lock);
2406
2407         return count;
2408 }
2409
2410 static ssize_t
2411 tracing_cpumask_write(struct file *filp, const char __user *ubuf,
2412                       size_t count, loff_t *ppos)
2413 {
2414         int err, cpu;
2415
2416         mutex_lock(&tracing_cpumask_update_lock);
2417         err = cpumask_parse_user(ubuf, count, tracing_cpumask_new);
2418         if (err)
2419                 goto err_unlock;
2420
2421         raw_local_irq_disable();
2422         __raw_spin_lock(&ftrace_max_lock);
2423         for_each_tracing_cpu(cpu) {
2424                 /*
2425                  * Increase/decrease the disabled counter if we are
2426                  * about to flip a bit in the cpumask:
2427                  */
2428                 if (cpu_isset(cpu, tracing_cpumask) &&
2429                                 !cpu_isset(cpu, tracing_cpumask_new)) {
2430                         atomic_inc(&global_trace.data[cpu]->disabled);
2431                 }
2432                 if (!cpu_isset(cpu, tracing_cpumask) &&
2433                                 cpu_isset(cpu, tracing_cpumask_new)) {
2434                         atomic_dec(&global_trace.data[cpu]->disabled);
2435                 }
2436         }
2437         __raw_spin_unlock(&ftrace_max_lock);
2438         raw_local_irq_enable();
2439
2440         tracing_cpumask = tracing_cpumask_new;
2441
2442         mutex_unlock(&tracing_cpumask_update_lock);
2443
2444         return count;
2445
2446 err_unlock:
2447         mutex_unlock(&tracing_cpumask_update_lock);
2448
2449         return err;
2450 }
2451
2452 static struct file_operations tracing_cpumask_fops = {
2453         .open           = tracing_open_generic,
2454         .read           = tracing_cpumask_read,
2455         .write          = tracing_cpumask_write,
2456 };
2457
2458 static ssize_t
2459 tracing_trace_options_read(struct file *filp, char __user *ubuf,
2460                        size_t cnt, loff_t *ppos)
2461 {
2462         int i;
2463         char *buf;
2464         int r = 0;
2465         int len = 0;
2466         u32 tracer_flags = current_trace->flags->val;
2467         struct tracer_opt *trace_opts = current_trace->flags->opts;
2468
2469
2470         /* calulate max size */
2471         for (i = 0; trace_options[i]; i++) {
2472                 len += strlen(trace_options[i]);
2473                 len += 3; /* "no" and space */
2474         }
2475
2476         /*
2477          * Increase the size with names of options specific
2478          * of the current tracer.
2479          */
2480         for (i = 0; trace_opts[i].name; i++) {
2481                 len += strlen(trace_opts[i].name);
2482                 len += 3; /* "no" and space */
2483         }
2484
2485         /* +2 for \n and \0 */
2486         buf = kmalloc(len + 2, GFP_KERNEL);
2487         if (!buf)
2488                 return -ENOMEM;
2489
2490         for (i = 0; trace_options[i]; i++) {
2491                 if (trace_flags & (1 << i))
2492                         r += sprintf(buf + r, "%s ", trace_options[i]);
2493                 else
2494                         r += sprintf(buf + r, "no%s ", trace_options[i]);
2495         }
2496
2497         for (i = 0; trace_opts[i].name; i++) {
2498                 if (tracer_flags & trace_opts[i].bit)
2499                         r += sprintf(buf + r, "%s ",
2500                                 trace_opts[i].name);
2501                 else
2502                         r += sprintf(buf + r, "no%s ",
2503                                 trace_opts[i].name);
2504         }
2505
2506         r += sprintf(buf + r, "\n");
2507         WARN_ON(r >= len + 2);
2508
2509         r = simple_read_from_buffer(ubuf, cnt, ppos, buf, r);
2510
2511         kfree(buf);
2512
2513         return r;
2514 }
2515
2516 /* Try to assign a tracer specific option */
2517 static int set_tracer_option(struct tracer *trace, char *cmp, int neg)
2518 {
2519         struct tracer_flags *trace_flags = trace->flags;
2520         struct tracer_opt *opts = NULL;
2521         int ret = 0, i = 0;
2522         int len;
2523
2524         for (i = 0; trace_flags->opts[i].name; i++) {
2525                 opts = &trace_flags->opts[i];
2526                 len = strlen(opts->name);
2527
2528                 if (strncmp(cmp, opts->name, len) == 0) {
2529                         ret = trace->set_flag(trace_flags->val,
2530                                 opts->bit, !neg);
2531                         break;
2532                 }
2533         }
2534         /* Not found */
2535         if (!trace_flags->opts[i].name)
2536                 return -EINVAL;
2537
2538         /* Refused to handle */
2539         if (ret)
2540                 return ret;
2541
2542         if (neg)
2543                 trace_flags->val &= ~opts->bit;
2544         else
2545                 trace_flags->val |= opts->bit;
2546
2547         return 0;
2548 }
2549
2550 static ssize_t
2551 tracing_trace_options_write(struct file *filp, const char __user *ubuf,
2552                         size_t cnt, loff_t *ppos)
2553 {
2554         char buf[64];
2555         char *cmp = buf;
2556         int neg = 0;
2557         int ret;
2558         int i;
2559
2560         if (cnt >= sizeof(buf))
2561                 return -EINVAL;
2562
2563         if (copy_from_user(&buf, ubuf, cnt))
2564                 return -EFAULT;
2565
2566         buf[cnt] = 0;
2567
2568         if (strncmp(buf, "no", 2) == 0) {
2569                 neg = 1;
2570                 cmp += 2;
2571         }
2572
2573         for (i = 0; trace_options[i]; i++) {
2574                 int len = strlen(trace_options[i]);
2575
2576                 if (strncmp(cmp, trace_options[i], len) == 0) {
2577                         if (neg)
2578                                 trace_flags &= ~(1 << i);
2579                         else
2580                                 trace_flags |= (1 << i);
2581                         break;
2582                 }
2583         }
2584
2585         /* If no option could be set, test the specific tracer options */
2586         if (!trace_options[i]) {
2587                 ret = set_tracer_option(current_trace, cmp, neg);
2588                 if (ret)
2589                         return ret;
2590         }
2591
2592         filp->f_pos += cnt;
2593
2594         return cnt;
2595 }
2596
2597 static struct file_operations tracing_iter_fops = {
2598         .open           = tracing_open_generic,
2599         .read           = tracing_trace_options_read,
2600         .write          = tracing_trace_options_write,
2601 };
2602
2603 static const char readme_msg[] =
2604         "tracing mini-HOWTO:\n\n"
2605         "# mkdir /debug\n"
2606         "# mount -t debugfs nodev /debug\n\n"
2607         "# cat /debug/tracing/available_tracers\n"
2608         "wakeup preemptirqsoff preemptoff irqsoff ftrace sched_switch none\n\n"
2609         "# cat /debug/tracing/current_tracer\n"
2610         "none\n"
2611         "# echo sched_switch > /debug/tracing/current_tracer\n"
2612         "# cat /debug/tracing/current_tracer\n"
2613         "sched_switch\n"
2614         "# cat /debug/tracing/trace_options\n"
2615         "noprint-parent nosym-offset nosym-addr noverbose\n"
2616         "# echo print-parent > /debug/tracing/trace_options\n"
2617         "# echo 1 > /debug/tracing/tracing_enabled\n"
2618         "# cat /debug/tracing/trace > /tmp/trace.txt\n"
2619         "echo 0 > /debug/tracing/tracing_enabled\n"
2620 ;
2621
2622 static ssize_t
2623 tracing_readme_read(struct file *filp, char __user *ubuf,
2624                        size_t cnt, loff_t *ppos)
2625 {
2626         return simple_read_from_buffer(ubuf, cnt, ppos,
2627                                         readme_msg, strlen(readme_msg));
2628 }
2629
2630 static struct file_operations tracing_readme_fops = {
2631         .open           = tracing_open_generic,
2632         .read           = tracing_readme_read,
2633 };
2634
2635 static ssize_t
2636 tracing_ctrl_read(struct file *filp, char __user *ubuf,
2637                   size_t cnt, loff_t *ppos)
2638 {
2639         char buf[64];
2640         int r;
2641
2642         r = sprintf(buf, "%u\n", tracer_enabled);
2643         return simple_read_from_buffer(ubuf, cnt, ppos, buf, r);
2644 }
2645
2646 static ssize_t
2647 tracing_ctrl_write(struct file *filp, const char __user *ubuf,
2648                    size_t cnt, loff_t *ppos)
2649 {
2650         struct trace_array *tr = filp->private_data;
2651         char buf[64];
2652         long val;
2653         int ret;
2654
2655         if (cnt >= sizeof(buf))
2656                 return -EINVAL;
2657
2658         if (copy_from_user(&buf, ubuf, cnt))
2659                 return -EFAULT;
2660
2661         buf[cnt] = 0;
2662
2663         ret = strict_strtoul(buf, 10, &val);
2664         if (ret < 0)
2665                 return ret;
2666
2667         val = !!val;
2668
2669         mutex_lock(&trace_types_lock);
2670         if (tracer_enabled ^ val) {
2671                 if (val) {
2672                         tracer_enabled = 1;
2673                         if (current_trace->start)
2674                                 current_trace->start(tr);
2675                         tracing_start();
2676                 } else {
2677                         tracer_enabled = 0;
2678                         tracing_stop();
2679                         if (current_trace->stop)
2680                                 current_trace->stop(tr);
2681                 }
2682         }
2683         mutex_unlock(&trace_types_lock);
2684
2685         filp->f_pos += cnt;
2686
2687         return cnt;
2688 }
2689
2690 static ssize_t
2691 tracing_set_trace_read(struct file *filp, char __user *ubuf,
2692                        size_t cnt, loff_t *ppos)
2693 {
2694         char buf[max_tracer_type_len+2];
2695         int r;
2696
2697         mutex_lock(&trace_types_lock);
2698         if (current_trace)
2699                 r = sprintf(buf, "%s\n", current_trace->name);
2700         else
2701                 r = sprintf(buf, "\n");
2702         mutex_unlock(&trace_types_lock);
2703
2704         return simple_read_from_buffer(ubuf, cnt, ppos, buf, r);
2705 }
2706
2707 static int tracing_set_tracer(char *buf)
2708 {
2709         struct trace_array *tr = &global_trace;
2710         struct tracer *t;
2711         int ret = 0;
2712
2713         mutex_lock(&trace_types_lock);
2714         for (t = trace_types; t; t = t->next) {
2715                 if (strcmp(t->name, buf) == 0)
2716                         break;
2717         }
2718         if (!t) {
2719                 ret = -EINVAL;
2720                 goto out;
2721         }
2722         if (t == current_trace)
2723                 goto out;
2724
2725         trace_branch_disable();
2726         if (current_trace && current_trace->reset)
2727                 current_trace->reset(tr);
2728
2729         current_trace = t;
2730         if (t->init) {
2731                 ret = t->init(tr);
2732                 if (ret)
2733                         goto out;
2734         }
2735
2736         trace_branch_enable(tr);
2737  out:
2738         mutex_unlock(&trace_types_lock);
2739
2740         return ret;
2741 }
2742
2743 static ssize_t
2744 tracing_set_trace_write(struct file *filp, const char __user *ubuf,
2745                         size_t cnt, loff_t *ppos)
2746 {
2747         char buf[max_tracer_type_len+1];
2748         int i;
2749         size_t ret;
2750         int err;
2751
2752         ret = cnt;
2753
2754         if (cnt > max_tracer_type_len)
2755                 cnt = max_tracer_type_len;
2756
2757         if (copy_from_user(&buf, ubuf, cnt))
2758                 return -EFAULT;
2759
2760         buf[cnt] = 0;
2761
2762         /* strip ending whitespace. */
2763         for (i = cnt - 1; i > 0 && isspace(buf[i]); i--)
2764                 buf[i] = 0;
2765
2766         err = tracing_set_tracer(buf);
2767         if (err)
2768                 return err;
2769
2770         filp->f_pos += ret;
2771
2772         return ret;
2773 }
2774
2775 static ssize_t
2776 tracing_max_lat_read(struct file *filp, char __user *ubuf,
2777                      size_t cnt, loff_t *ppos)
2778 {
2779         unsigned long *ptr = filp->private_data;
2780         char buf[64];
2781         int r;
2782
2783         r = snprintf(buf, sizeof(buf), "%ld\n",
2784                      *ptr == (unsigned long)-1 ? -1 : nsecs_to_usecs(*ptr));
2785         if (r > sizeof(buf))
2786                 r = sizeof(buf);
2787         return simple_read_from_buffer(ubuf, cnt, ppos, buf, r);
2788 }
2789
2790 static ssize_t
2791 tracing_max_lat_write(struct file *filp, const char __user *ubuf,
2792                       size_t cnt, loff_t *ppos)
2793 {
2794         long *ptr = filp->private_data;
2795         char buf[64];
2796         long val;
2797         int ret;
2798
2799         if (cnt >= sizeof(buf))
2800                 return -EINVAL;
2801
2802         if (copy_from_user(&buf, ubuf, cnt))
2803                 return -EFAULT;
2804
2805         buf[cnt] = 0;
2806
2807         ret = strict_strtoul(buf, 10, &val);
2808         if (ret < 0)
2809                 return ret;
2810
2811         *ptr = val * 1000;
2812
2813         return cnt;
2814 }
2815
2816 static atomic_t tracing_reader;
2817
2818 static int tracing_open_pipe(struct inode *inode, struct file *filp)
2819 {
2820         struct trace_iterator *iter;
2821
2822         if (tracing_disabled)
2823                 return -ENODEV;
2824
2825         /* We only allow for reader of the pipe */
2826         if (atomic_inc_return(&tracing_reader) != 1) {
2827                 atomic_dec(&tracing_reader);
2828                 return -EBUSY;
2829         }
2830
2831         /* create a buffer to store the information to pass to userspace */
2832         iter = kzalloc(sizeof(*iter), GFP_KERNEL);
2833         if (!iter)
2834                 return -ENOMEM;
2835
2836         mutex_lock(&trace_types_lock);
2837
2838         /* trace pipe does not show start of buffer */
2839         cpus_setall(iter->started);
2840
2841         iter->tr = &global_trace;
2842         iter->trace = current_trace;
2843         filp->private_data = iter;
2844
2845         if (iter->trace->pipe_open)
2846                 iter->trace->pipe_open(iter);
2847         mutex_unlock(&trace_types_lock);
2848
2849         return 0;
2850 }
2851
2852 static int tracing_release_pipe(struct inode *inode, struct file *file)
2853 {
2854         struct trace_iterator *iter = file->private_data;
2855
2856         kfree(iter);
2857         atomic_dec(&tracing_reader);
2858
2859         return 0;
2860 }
2861
2862 static unsigned int
2863 tracing_poll_pipe(struct file *filp, poll_table *poll_table)
2864 {
2865         struct trace_iterator *iter = filp->private_data;
2866
2867         if (trace_flags & TRACE_ITER_BLOCK) {
2868                 /*
2869                  * Always select as readable when in blocking mode
2870                  */
2871                 return POLLIN | POLLRDNORM;
2872         } else {
2873                 if (!trace_empty(iter))
2874                         return POLLIN | POLLRDNORM;
2875                 poll_wait(filp, &trace_wait, poll_table);
2876                 if (!trace_empty(iter))
2877                         return POLLIN | POLLRDNORM;
2878
2879                 return 0;
2880         }
2881 }
2882
2883 /*
2884  * Consumer reader.
2885  */
2886 static ssize_t
2887 tracing_read_pipe(struct file *filp, char __user *ubuf,
2888                   size_t cnt, loff_t *ppos)
2889 {
2890         struct trace_iterator *iter = filp->private_data;
2891         ssize_t sret;
2892
2893         /* return any leftover data */
2894         sret = trace_seq_to_user(&iter->seq, ubuf, cnt);
2895         if (sret != -EBUSY)
2896                 return sret;
2897
2898         trace_seq_reset(&iter->seq);
2899
2900         mutex_lock(&trace_types_lock);
2901         if (iter->trace->read) {
2902                 sret = iter->trace->read(iter, filp, ubuf, cnt, ppos);
2903                 if (sret)
2904                         goto out;
2905         }
2906
2907 waitagain:
2908         sret = 0;
2909         while (trace_empty(iter)) {
2910
2911                 if ((filp->f_flags & O_NONBLOCK)) {
2912                         sret = -EAGAIN;
2913                         goto out;
2914                 }
2915
2916                 /*
2917                  * This is a make-shift waitqueue. The reason we don't use
2918                  * an actual wait queue is because:
2919                  *  1) we only ever have one waiter
2920                  *  2) the tracing, traces all functions, we don't want
2921                  *     the overhead of calling wake_up and friends
2922                  *     (and tracing them too)
2923                  *     Anyway, this is really very primitive wakeup.
2924                  */
2925                 set_current_state(TASK_INTERRUPTIBLE);
2926                 iter->tr->waiter = current;
2927
2928                 mutex_unlock(&trace_types_lock);
2929
2930                 /* sleep for 100 msecs, and try again. */
2931                 schedule_timeout(HZ/10);
2932
2933                 mutex_lock(&trace_types_lock);
2934
2935                 iter->tr->waiter = NULL;
2936
2937                 if (signal_pending(current)) {
2938                         sret = -EINTR;
2939                         goto out;
2940                 }
2941
2942                 if (iter->trace != current_trace)
2943                         goto out;
2944
2945                 /*
2946                  * We block until we read something and tracing is disabled.
2947                  * We still block if tracing is disabled, but we have never
2948                  * read anything. This allows a user to cat this file, and
2949                  * then enable tracing. But after we have read something,
2950                  * we give an EOF when tracing is again disabled.
2951                  *
2952                  * iter->pos will be 0 if we haven't read anything.
2953                  */
2954                 if (!tracer_enabled && iter->pos)
2955                         break;
2956
2957                 continue;
2958         }
2959
2960         /* stop when tracing is finished */
2961         if (trace_empty(iter))
2962                 goto out;
2963
2964         if (cnt >= PAGE_SIZE)
2965                 cnt = PAGE_SIZE - 1;
2966
2967         /* reset all but tr, trace, and overruns */
2968         memset(&iter->seq, 0,
2969                sizeof(struct trace_iterator) -
2970                offsetof(struct trace_iterator, seq));
2971         iter->pos = -1;
2972
2973         while (find_next_entry_inc(iter) != NULL) {
2974                 enum print_line_t ret;
2975                 int len = iter->seq.len;
2976
2977                 ret = print_trace_line(iter);
2978                 if (ret == TRACE_TYPE_PARTIAL_LINE) {
2979                         /* don't print partial lines */
2980                         iter->seq.len = len;
2981                         break;
2982                 }
2983
2984                 trace_consume(iter);
2985
2986                 if (iter->seq.len >= cnt)
2987                         break;
2988         }
2989
2990         /* Now copy what we have to the user */
2991         sret = trace_seq_to_user(&iter->seq, ubuf, cnt);
2992         if (iter->seq.readpos >= iter->seq.len)
2993                 trace_seq_reset(&iter->seq);
2994
2995         /*
2996          * If there was nothing to send to user, inspite of consuming trace
2997          * entries, go back to wait for more entries.
2998          */
2999         if (sret == -EBUSY)
3000                 goto waitagain;
3001
3002 out:
3003         mutex_unlock(&trace_types_lock);
3004
3005         return sret;
3006 }
3007
3008 static ssize_t
3009 tracing_entries_read(struct file *filp, char __user *ubuf,
3010                      size_t cnt, loff_t *ppos)
3011 {
3012         struct trace_array *tr = filp->private_data;
3013         char buf[64];
3014         int r;
3015
3016         r = sprintf(buf, "%lu\n", tr->entries >> 10);
3017         return simple_read_from_buffer(ubuf, cnt, ppos, buf, r);
3018 }
3019
3020 static ssize_t
3021 tracing_entries_write(struct file *filp, const char __user *ubuf,
3022                       size_t cnt, loff_t *ppos)
3023 {
3024         unsigned long val;
3025         char buf[64];
3026         int ret, cpu;
3027
3028         if (cnt >= sizeof(buf))
3029                 return -EINVAL;
3030
3031         if (copy_from_user(&buf, ubuf, cnt))
3032                 return -EFAULT;
3033
3034         buf[cnt] = 0;
3035
3036         ret = strict_strtoul(buf, 10, &val);
3037         if (ret < 0)
3038                 return ret;
3039
3040         /* must have at least 1 entry */
3041         if (!val)
3042                 return -EINVAL;
3043
3044         mutex_lock(&trace_types_lock);
3045
3046         tracing_stop();
3047
3048         /* disable all cpu buffers */
3049         for_each_tracing_cpu(cpu) {
3050                 if (global_trace.data[cpu])
3051                         atomic_inc(&global_trace.data[cpu]->disabled);
3052                 if (max_tr.data[cpu])
3053                         atomic_inc(&max_tr.data[cpu]->disabled);
3054         }
3055
3056         /* value is in KB */
3057         val <<= 10;
3058
3059         if (val != global_trace.entries) {
3060                 ret = ring_buffer_resize(global_trace.buffer, val);
3061                 if (ret < 0) {
3062                         cnt = ret;
3063                         goto out;
3064                 }
3065
3066                 ret = ring_buffer_resize(max_tr.buffer, val);
3067                 if (ret < 0) {
3068                         int r;
3069                         cnt = ret;
3070                         r = ring_buffer_resize(global_trace.buffer,
3071                                                global_trace.entries);
3072                         if (r < 0) {
3073                                 /* AARGH! We are left with different
3074                                  * size max buffer!!!! */
3075                                 WARN_ON(1);
3076                                 tracing_disabled = 1;
3077                         }
3078                         goto out;
3079                 }
3080
3081                 global_trace.entries = val;
3082         }
3083
3084         filp->f_pos += cnt;
3085
3086         /* If check pages failed, return ENOMEM */
3087         if (tracing_disabled)
3088                 cnt = -ENOMEM;
3089  out:
3090         for_each_tracing_cpu(cpu) {
3091                 if (global_trace.data[cpu])
3092                         atomic_dec(&global_trace.data[cpu]->disabled);
3093                 if (max_tr.data[cpu])
3094                         atomic_dec(&max_tr.data[cpu]->disabled);
3095         }
3096
3097         tracing_start();
3098         max_tr.entries = global_trace.entries;
3099         mutex_unlock(&trace_types_lock);
3100
3101         return cnt;
3102 }
3103
3104 static int mark_printk(const char *fmt, ...)
3105 {
3106         int ret;
3107         va_list args;
3108         va_start(args, fmt);
3109         ret = trace_vprintk(0, fmt, args);
3110         va_end(args);
3111         return ret;
3112 }
3113
3114 static ssize_t
3115 tracing_mark_write(struct file *filp, const char __user *ubuf,
3116                                         size_t cnt, loff_t *fpos)
3117 {
3118         char *buf;
3119         char *end;
3120
3121         if (tracing_disabled)
3122                 return -EINVAL;
3123
3124         if (cnt > TRACE_BUF_SIZE)
3125                 cnt = TRACE_BUF_SIZE;
3126
3127         buf = kmalloc(cnt + 1, GFP_KERNEL);
3128         if (buf == NULL)
3129                 return -ENOMEM;
3130
3131         if (copy_from_user(buf, ubuf, cnt)) {
3132                 kfree(buf);
3133                 return -EFAULT;
3134         }
3135
3136         /* Cut from the first nil or newline. */
3137         buf[cnt] = '\0';
3138         end = strchr(buf, '\n');
3139         if (end)
3140                 *end = '\0';
3141
3142         cnt = mark_printk("%s\n", buf);
3143         kfree(buf);
3144         *fpos += cnt;
3145
3146         return cnt;
3147 }
3148
3149 static struct file_operations tracing_max_lat_fops = {
3150         .open           = tracing_open_generic,
3151         .read           = tracing_max_lat_read,
3152         .write          = tracing_max_lat_write,
3153 };
3154
3155 static struct file_operations tracing_ctrl_fops = {
3156         .open           = tracing_open_generic,
3157         .read           = tracing_ctrl_read,
3158         .write          = tracing_ctrl_write,
3159 };
3160
3161 static struct file_operations set_tracer_fops = {
3162         .open           = tracing_open_generic,
3163         .read           = tracing_set_trace_read,
3164         .write          = tracing_set_trace_write,
3165 };
3166
3167 static struct file_operations tracing_pipe_fops = {
3168         .open           = tracing_open_pipe,
3169         .poll           = tracing_poll_pipe,
3170         .read           = tracing_read_pipe,
3171         .release        = tracing_release_pipe,
3172 };
3173
3174 static struct file_operations tracing_entries_fops = {
3175         .open           = tracing_open_generic,
3176         .read           = tracing_entries_read,
3177         .write          = tracing_entries_write,
3178 };
3179
3180 static struct file_operations tracing_mark_fops = {
3181         .open           = tracing_open_generic,
3182         .write          = tracing_mark_write,
3183 };
3184
3185 #ifdef CONFIG_DYNAMIC_FTRACE
3186
3187 int __weak ftrace_arch_read_dyn_info(char *buf, int size)
3188 {
3189         return 0;
3190 }
3191
3192 static ssize_t
3193 tracing_read_dyn_info(struct file *filp, char __user *ubuf,
3194                   size_t cnt, loff_t *ppos)
3195 {
3196         static char ftrace_dyn_info_buffer[1024];
3197         static DEFINE_MUTEX(dyn_info_mutex);
3198         unsigned long *p = filp->private_data;
3199         char *buf = ftrace_dyn_info_buffer;
3200         int size = ARRAY_SIZE(ftrace_dyn_info_buffer);
3201         int r;
3202
3203         mutex_lock(&dyn_info_mutex);
3204         r = sprintf(buf, "%ld ", *p);
3205
3206         r += ftrace_arch_read_dyn_info(buf+r, (size-1)-r);
3207         buf[r++] = '\n';
3208
3209         r = simple_read_from_buffer(ubuf, cnt, ppos, buf, r);
3210
3211         mutex_unlock(&dyn_info_mutex);
3212
3213         return r;
3214 }
3215
3216 static struct file_operations tracing_dyn_info_fops = {
3217         .open           = tracing_open_generic,
3218         .read           = tracing_read_dyn_info,
3219 };
3220 #endif
3221
3222 static struct dentry *d_tracer;
3223
3224 struct dentry *tracing_init_dentry(void)
3225 {
3226         static int once;
3227
3228         if (d_tracer)
3229                 return d_tracer;
3230
3231         d_tracer = debugfs_create_dir("tracing", NULL);
3232
3233         if (!d_tracer && !once) {
3234                 once = 1;
3235                 pr_warning("Could not create debugfs directory 'tracing'\n");
3236                 return NULL;
3237         }
3238
3239         return d_tracer;
3240 }
3241
3242 #ifdef CONFIG_FTRACE_SELFTEST
3243 /* Let selftest have access to static functions in this file */
3244 #include "trace_selftest.c"
3245 #endif
3246
3247 static __init int tracer_init_debugfs(void)
3248 {
3249         struct dentry *d_tracer;
3250         struct dentry *entry;
3251
3252         d_tracer = tracing_init_dentry();
3253
3254         entry = debugfs_create_file("tracing_enabled", 0644, d_tracer,
3255                                     &global_trace, &tracing_ctrl_fops);
3256         if (!entry)
3257                 pr_warning("Could not create debugfs 'tracing_enabled' entry\n");
3258
3259         entry = debugfs_create_file("trace_options", 0644, d_tracer,
3260                                     NULL, &tracing_iter_fops);
3261         if (!entry)
3262                 pr_warning("Could not create debugfs 'trace_options' entry\n");
3263
3264         entry = debugfs_create_file("tracing_cpumask", 0644, d_tracer,
3265                                     NULL, &tracing_cpumask_fops);
3266         if (!entry)
3267                 pr_warning("Could not create debugfs 'tracing_cpumask' entry\n");
3268
3269         entry = debugfs_create_file("latency_trace", 0444, d_tracer,
3270                                     &global_trace, &tracing_lt_fops);
3271         if (!entry)
3272                 pr_warning("Could not create debugfs 'latency_trace' entry\n");
3273
3274         entry = debugfs_create_file("trace", 0444, d_tracer,
3275                                     &global_trace, &tracing_fops);
3276         if (!entry)
3277                 pr_warning("Could not create debugfs 'trace' entry\n");
3278
3279         entry = debugfs_create_file("available_tracers", 0444, d_tracer,
3280                                     &global_trace, &show_traces_fops);
3281         if (!entry)
3282                 pr_warning("Could not create debugfs 'available_tracers' entry\n");
3283
3284         entry = debugfs_create_file("current_tracer", 0444, d_tracer,
3285                                     &global_trace, &set_tracer_fops);
3286         if (!entry)
3287                 pr_warning("Could not create debugfs 'current_tracer' entry\n");
3288
3289         entry = debugfs_create_file("tracing_max_latency", 0644, d_tracer,
3290                                     &tracing_max_latency,
3291                                     &tracing_max_lat_fops);
3292         if (!entry)
3293                 pr_warning("Could not create debugfs "
3294                            "'tracing_max_latency' entry\n");
3295
3296         entry = debugfs_create_file("tracing_thresh", 0644, d_tracer,
3297                                     &tracing_thresh, &tracing_max_lat_fops);
3298         if (!entry)
3299                 pr_warning("Could not create debugfs "
3300                            "'tracing_thresh' entry\n");
3301         entry = debugfs_create_file("README", 0644, d_tracer,
3302                                     NULL, &tracing_readme_fops);
3303         if (!entry)
3304                 pr_warning("Could not create debugfs 'README' entry\n");
3305
3306         entry = debugfs_create_file("trace_pipe", 0644, d_tracer,
3307                                     NULL, &tracing_pipe_fops);
3308         if (!entry)
3309                 pr_warning("Could not create debugfs "
3310                            "'trace_pipe' entry\n");
3311
3312         entry = debugfs_create_file("buffer_size_kb", 0644, d_tracer,
3313                                     &global_trace, &tracing_entries_fops);
3314         if (!entry)
3315                 pr_warning("Could not create debugfs "
3316                            "'buffer_size_kb' entry\n");
3317
3318         entry = debugfs_create_file("trace_marker", 0220, d_tracer,
3319                                     NULL, &tracing_mark_fops);
3320         if (!entry)
3321                 pr_warning("Could not create debugfs "
3322                            "'trace_marker' entry\n");
3323
3324 #ifdef CONFIG_DYNAMIC_FTRACE
3325         entry = debugfs_create_file("dyn_ftrace_total_info", 0444, d_tracer,
3326                                     &ftrace_update_tot_cnt,
3327                                     &tracing_dyn_info_fops);
3328         if (!entry)
3329                 pr_warning("Could not create debugfs "
3330                            "'dyn_ftrace_total_info' entry\n");
3331 #endif
3332 #ifdef CONFIG_SYSPROF_TRACER
3333         init_tracer_sysprof_debugfs(d_tracer);
3334 #endif
3335         return 0;
3336 }
3337
3338 int trace_vprintk(unsigned long ip, const char *fmt, va_list args)
3339 {
3340         static DEFINE_SPINLOCK(trace_buf_lock);
3341         static char trace_buf[TRACE_BUF_SIZE];
3342
3343         struct ring_buffer_event *event;
3344         struct trace_array *tr = &global_trace;
3345         struct trace_array_cpu *data;
3346         struct print_entry *entry;
3347         unsigned long flags, irq_flags;
3348         int cpu, len = 0, size, pc;
3349
3350         if (tracing_disabled)
3351                 return 0;
3352
3353         pc = preempt_count();
3354         preempt_disable_notrace();
3355         cpu = raw_smp_processor_id();
3356         data = tr->data[cpu];
3357
3358         if (unlikely(atomic_read(&data->disabled)))
3359                 goto out;
3360
3361         spin_lock_irqsave(&trace_buf_lock, flags);
3362         len = vsnprintf(trace_buf, TRACE_BUF_SIZE, fmt, args);
3363
3364         len = min(len, TRACE_BUF_SIZE-1);
3365         trace_buf[len] = 0;
3366
3367         size = sizeof(*entry) + len + 1;
3368         event = ring_buffer_lock_reserve(tr->buffer, size, &irq_flags);
3369         if (!event)
3370                 goto out_unlock;
3371         entry = ring_buffer_event_data(event);
3372         tracing_generic_entry_update(&entry->ent, flags, pc);
3373         entry->ent.type                 = TRACE_PRINT;
3374         entry->ip                       = ip;
3375
3376         memcpy(&entry->buf, trace_buf, len);
3377         entry->buf[len] = 0;
3378         ring_buffer_unlock_commit(tr->buffer, event, irq_flags);
3379
3380  out_unlock:
3381         spin_unlock_irqrestore(&trace_buf_lock, flags);
3382
3383  out:
3384         preempt_enable_notrace();
3385
3386         return len;
3387 }
3388 EXPORT_SYMBOL_GPL(trace_vprintk);
3389
3390 int __ftrace_printk(unsigned long ip, const char *fmt, ...)
3391 {
3392         int ret;
3393         va_list ap;
3394
3395         if (!(trace_flags & TRACE_ITER_PRINTK))
3396                 return 0;
3397
3398         va_start(ap, fmt);
3399         ret = trace_vprintk(ip, fmt, ap);
3400         va_end(ap);
3401         return ret;
3402 }
3403 EXPORT_SYMBOL_GPL(__ftrace_printk);
3404
3405 static int trace_panic_handler(struct notifier_block *this,
3406                                unsigned long event, void *unused)
3407 {
3408         if (ftrace_dump_on_oops)
3409                 ftrace_dump();
3410         return NOTIFY_OK;
3411 }
3412
3413 static struct notifier_block trace_panic_notifier = {
3414         .notifier_call  = trace_panic_handler,
3415         .next           = NULL,
3416         .priority       = 150   /* priority: INT_MAX >= x >= 0 */
3417 };
3418
3419 static int trace_die_handler(struct notifier_block *self,
3420                              unsigned long val,
3421                              void *data)
3422 {
3423         switch (val) {
3424         case DIE_OOPS:
3425                 if (ftrace_dump_on_oops)
3426                         ftrace_dump();
3427                 break;
3428         default:
3429                 break;
3430         }
3431         return NOTIFY_OK;
3432 }
3433
3434 static struct notifier_block trace_die_notifier = {
3435         .notifier_call = trace_die_handler,
3436         .priority = 200
3437 };
3438
3439 /*
3440  * printk is set to max of 1024, we really don't need it that big.
3441  * Nothing should be printing 1000 characters anyway.
3442  */
3443 #define TRACE_MAX_PRINT         1000
3444
3445 /*
3446  * Define here KERN_TRACE so that we have one place to modify
3447  * it if we decide to change what log level the ftrace dump
3448  * should be at.
3449  */
3450 #define KERN_TRACE              KERN_INFO
3451
3452 static void
3453 trace_printk_seq(struct trace_seq *s)
3454 {
3455         /* Probably should print a warning here. */
3456         if (s->len >= 1000)
3457                 s->len = 1000;
3458
3459         /* should be zero ended, but we are paranoid. */
3460         s->buffer[s->len] = 0;
3461
3462         printk(KERN_TRACE "%s", s->buffer);
3463
3464         trace_seq_reset(s);
3465 }
3466
3467 void ftrace_dump(void)
3468 {
3469         static DEFINE_SPINLOCK(ftrace_dump_lock);
3470         /* use static because iter can be a bit big for the stack */
3471         static struct trace_iterator iter;
3472         static cpumask_t mask;
3473         static int dump_ran;
3474         unsigned long flags;
3475         int cnt = 0, cpu;
3476
3477         /* only one dump */
3478         spin_lock_irqsave(&ftrace_dump_lock, flags);
3479         if (dump_ran)
3480                 goto out;
3481
3482         dump_ran = 1;
3483
3484         /* No turning back! */
3485         ftrace_kill();
3486
3487         for_each_tracing_cpu(cpu) {
3488                 atomic_inc(&global_trace.data[cpu]->disabled);
3489         }
3490
3491         printk(KERN_TRACE "Dumping ftrace buffer:\n");
3492
3493         iter.tr = &global_trace;
3494         iter.trace = current_trace;
3495
3496         /*
3497          * We need to stop all tracing on all CPUS to read the
3498          * the next buffer. This is a bit expensive, but is
3499          * not done often. We fill all what we can read,
3500          * and then release the locks again.
3501          */
3502
3503         cpus_clear(mask);
3504
3505         while (!trace_empty(&iter)) {
3506
3507                 if (!cnt)
3508                         printk(KERN_TRACE "---------------------------------\n");
3509
3510                 cnt++;
3511
3512                 /* reset all but tr, trace, and overruns */
3513                 memset(&iter.seq, 0,
3514                        sizeof(struct trace_iterator) -
3515                        offsetof(struct trace_iterator, seq));
3516                 iter.iter_flags |= TRACE_FILE_LAT_FMT;
3517                 iter.pos = -1;
3518
3519                 if (find_next_entry_inc(&iter) != NULL) {
3520                         print_trace_line(&iter);
3521                         trace_consume(&iter);
3522                 }
3523
3524                 trace_printk_seq(&iter.seq);
3525         }
3526
3527         if (!cnt)
3528                 printk(KERN_TRACE "   (ftrace buffer empty)\n");
3529         else
3530                 printk(KERN_TRACE "---------------------------------\n");
3531
3532  out:
3533         spin_unlock_irqrestore(&ftrace_dump_lock, flags);
3534 }
3535
3536 __init static int tracer_alloc_buffers(void)
3537 {
3538         struct trace_array_cpu *data;
3539         int i;
3540
3541         /* TODO: make the number of buffers hot pluggable with CPUS */
3542         tracing_buffer_mask = cpu_possible_map;
3543
3544         global_trace.buffer = ring_buffer_alloc(trace_buf_size,
3545                                                    TRACE_BUFFER_FLAGS);
3546         if (!global_trace.buffer) {
3547                 printk(KERN_ERR "tracer: failed to allocate ring buffer!\n");
3548                 WARN_ON(1);
3549                 return 0;
3550         }
3551         global_trace.entries = ring_buffer_size(global_trace.buffer);
3552
3553 #ifdef CONFIG_TRACER_MAX_TRACE
3554         max_tr.buffer = ring_buffer_alloc(trace_buf_size,
3555                                              TRACE_BUFFER_FLAGS);
3556         if (!max_tr.buffer) {
3557                 printk(KERN_ERR "tracer: failed to allocate max ring buffer!\n");
3558                 WARN_ON(1);
3559                 ring_buffer_free(global_trace.buffer);
3560                 return 0;
3561         }
3562         max_tr.entries = ring_buffer_size(max_tr.buffer);
3563         WARN_ON(max_tr.entries != global_trace.entries);
3564 #endif
3565
3566         /* Allocate the first page for all buffers */
3567         for_each_tracing_cpu(i) {
3568                 data = global_trace.data[i] = &per_cpu(global_trace_cpu, i);
3569                 max_tr.data[i] = &per_cpu(max_data, i);
3570         }
3571
3572         trace_init_cmdlines();
3573
3574         register_tracer(&nop_trace);
3575 #ifdef CONFIG_BOOT_TRACER
3576         register_tracer(&boot_tracer);
3577         current_trace = &boot_tracer;
3578         current_trace->init(&global_trace);
3579 #else
3580         current_trace = &nop_trace;
3581 #endif
3582
3583         /* All seems OK, enable tracing */
3584         tracing_disabled = 0;
3585
3586         atomic_notifier_chain_register(&panic_notifier_list,
3587                                        &trace_panic_notifier);
3588
3589         register_die_notifier(&trace_die_notifier);
3590
3591         return 0;
3592 }
3593 early_initcall(tracer_alloc_buffers);
3594 fs_initcall(tracer_init_debugfs);