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