2010-08-05 22:22:23 +08:00
|
|
|
/*
|
|
|
|
* kdb helper for dumping the ftrace buffer
|
|
|
|
*
|
|
|
|
* Copyright (C) 2010 Jason Wessel <jason.wessel@windriver.com>
|
|
|
|
*
|
|
|
|
* ftrace_dump_buf based on ftrace_dump:
|
|
|
|
* Copyright (C) 2007-2008 Steven Rostedt <srostedt@redhat.com>
|
|
|
|
* Copyright (C) 2008 Ingo Molnar <mingo@redhat.com>
|
|
|
|
*
|
|
|
|
*/
|
|
|
|
#include <linux/init.h>
|
|
|
|
#include <linux/kgdb.h>
|
|
|
|
#include <linux/kdb.h>
|
|
|
|
#include <linux/ftrace.h>
|
|
|
|
|
|
|
|
#include "trace.h"
|
|
|
|
#include "trace_output.h"
|
|
|
|
|
2010-08-05 22:22:23 +08:00
|
|
|
static void ftrace_dump_buf(int skip_lines, long cpu_file)
|
2010-08-05 22:22:23 +08:00
|
|
|
{
|
|
|
|
/* use static because iter can be a bit big for the stack */
|
|
|
|
static struct trace_iterator iter;
|
2014-11-06 20:41:55 +08:00
|
|
|
static struct ring_buffer_iter *buffer_iter[CONFIG_NR_CPUS];
|
2015-09-30 21:42:05 +08:00
|
|
|
struct trace_array *tr;
|
2010-08-05 22:22:23 +08:00
|
|
|
unsigned int old_userobj;
|
|
|
|
int cnt = 0, cpu;
|
|
|
|
|
|
|
|
trace_init_global_iter(&iter);
|
2014-11-06 20:41:55 +08:00
|
|
|
iter.buffer_iter = buffer_iter;
|
2015-09-30 21:42:05 +08:00
|
|
|
tr = iter.tr;
|
2010-08-05 22:22:23 +08:00
|
|
|
|
|
|
|
for_each_tracing_cpu(cpu) {
|
tracing: Consolidate max_tr into main trace_array structure
Currently, the way the latency tracers and snapshot feature works
is to have a separate trace_array called "max_tr" that holds the
snapshot buffer. For latency tracers, this snapshot buffer is used
to swap the running buffer with this buffer to save the current max
latency.
The only items needed for the max_tr is really just a copy of the buffer
itself, the per_cpu data pointers, the time_start timestamp that states
when the max latency was triggered, and the cpu that the max latency
was triggered on. All other fields in trace_array are unused by the
max_tr, making the max_tr mostly bloat.
This change removes the max_tr completely, and adds a new structure
called trace_buffer, that holds the buffer pointer, the per_cpu data
pointers, the time_start timestamp, and the cpu where the latency occurred.
The trace_array, now has two trace_buffers, one for the normal trace and
one for the max trace or snapshot. By doing this, not only do we remove
the bloat from the max_trace but the instances of traces can now use
their own snapshot feature and not have just the top level global_trace have
the snapshot feature and latency tracers for itself.
Signed-off-by: Steven Rostedt <rostedt@goodmis.org>
2013-03-05 22:24:35 +08:00
|
|
|
atomic_inc(&per_cpu_ptr(iter.trace_buffer->data, cpu)->disabled);
|
2010-08-05 22:22:23 +08:00
|
|
|
}
|
|
|
|
|
2015-09-30 21:42:05 +08:00
|
|
|
old_userobj = tr->trace_flags;
|
2010-08-05 22:22:23 +08:00
|
|
|
|
|
|
|
/* don't look at user memory in panic mode */
|
2015-09-30 21:42:05 +08:00
|
|
|
tr->trace_flags &= ~TRACE_ITER_SYM_USEROBJ;
|
2010-08-05 22:22:23 +08:00
|
|
|
|
|
|
|
kdb_printf("Dumping ftrace buffer:\n");
|
|
|
|
|
|
|
|
/* reset all but tr, trace, and overruns */
|
|
|
|
memset(&iter.seq, 0,
|
|
|
|
sizeof(struct trace_iterator) -
|
|
|
|
offsetof(struct trace_iterator, seq));
|
|
|
|
iter.iter_flags |= TRACE_FILE_LAT_FMT;
|
|
|
|
iter.pos = -1;
|
|
|
|
|
2013-01-24 04:22:59 +08:00
|
|
|
if (cpu_file == RING_BUFFER_ALL_CPUS) {
|
2010-08-05 22:22:23 +08:00
|
|
|
for_each_tracing_cpu(cpu) {
|
|
|
|
iter.buffer_iter[cpu] =
|
tracing: Consolidate max_tr into main trace_array structure
Currently, the way the latency tracers and snapshot feature works
is to have a separate trace_array called "max_tr" that holds the
snapshot buffer. For latency tracers, this snapshot buffer is used
to swap the running buffer with this buffer to save the current max
latency.
The only items needed for the max_tr is really just a copy of the buffer
itself, the per_cpu data pointers, the time_start timestamp that states
when the max latency was triggered, and the cpu that the max latency
was triggered on. All other fields in trace_array are unused by the
max_tr, making the max_tr mostly bloat.
This change removes the max_tr completely, and adds a new structure
called trace_buffer, that holds the buffer pointer, the per_cpu data
pointers, the time_start timestamp, and the cpu where the latency occurred.
The trace_array, now has two trace_buffers, one for the normal trace and
one for the max trace or snapshot. By doing this, not only do we remove
the bloat from the max_trace but the instances of traces can now use
their own snapshot feature and not have just the top level global_trace have
the snapshot feature and latency tracers for itself.
Signed-off-by: Steven Rostedt <rostedt@goodmis.org>
2013-03-05 22:24:35 +08:00
|
|
|
ring_buffer_read_prepare(iter.trace_buffer->buffer, cpu);
|
2010-08-05 22:22:23 +08:00
|
|
|
ring_buffer_read_start(iter.buffer_iter[cpu]);
|
|
|
|
tracing_iter_reset(&iter, cpu);
|
|
|
|
}
|
|
|
|
} else {
|
|
|
|
iter.cpu_file = cpu_file;
|
|
|
|
iter.buffer_iter[cpu_file] =
|
tracing: Consolidate max_tr into main trace_array structure
Currently, the way the latency tracers and snapshot feature works
is to have a separate trace_array called "max_tr" that holds the
snapshot buffer. For latency tracers, this snapshot buffer is used
to swap the running buffer with this buffer to save the current max
latency.
The only items needed for the max_tr is really just a copy of the buffer
itself, the per_cpu data pointers, the time_start timestamp that states
when the max latency was triggered, and the cpu that the max latency
was triggered on. All other fields in trace_array are unused by the
max_tr, making the max_tr mostly bloat.
This change removes the max_tr completely, and adds a new structure
called trace_buffer, that holds the buffer pointer, the per_cpu data
pointers, the time_start timestamp, and the cpu where the latency occurred.
The trace_array, now has two trace_buffers, one for the normal trace and
one for the max trace or snapshot. By doing this, not only do we remove
the bloat from the max_trace but the instances of traces can now use
their own snapshot feature and not have just the top level global_trace have
the snapshot feature and latency tracers for itself.
Signed-off-by: Steven Rostedt <rostedt@goodmis.org>
2013-03-05 22:24:35 +08:00
|
|
|
ring_buffer_read_prepare(iter.trace_buffer->buffer, cpu_file);
|
2010-08-05 22:22:23 +08:00
|
|
|
ring_buffer_read_start(iter.buffer_iter[cpu_file]);
|
|
|
|
tracing_iter_reset(&iter, cpu_file);
|
2010-08-05 22:22:23 +08:00
|
|
|
}
|
2014-11-06 20:41:56 +08:00
|
|
|
|
|
|
|
while (trace_find_next_entry_inc(&iter)) {
|
2010-08-05 22:22:23 +08:00
|
|
|
if (!cnt)
|
|
|
|
kdb_printf("---------------------------------\n");
|
|
|
|
cnt++;
|
|
|
|
|
2014-11-06 20:41:56 +08:00
|
|
|
if (!skip_lines) {
|
2010-08-05 22:22:23 +08:00
|
|
|
print_trace_line(&iter);
|
|
|
|
trace_printk_seq(&iter.seq);
|
2014-11-06 20:41:56 +08:00
|
|
|
} else {
|
2010-08-05 22:22:23 +08:00
|
|
|
skip_lines--;
|
2014-11-06 20:41:56 +08:00
|
|
|
}
|
|
|
|
|
2010-08-05 22:22:23 +08:00
|
|
|
if (KDB_FLAG(CMD_INTERRUPT))
|
|
|
|
goto out;
|
|
|
|
}
|
|
|
|
|
|
|
|
if (!cnt)
|
|
|
|
kdb_printf(" (ftrace buffer empty)\n");
|
|
|
|
else
|
|
|
|
kdb_printf("---------------------------------\n");
|
|
|
|
|
|
|
|
out:
|
2015-09-30 21:42:05 +08:00
|
|
|
tr->trace_flags = old_userobj;
|
2010-08-05 22:22:23 +08:00
|
|
|
|
|
|
|
for_each_tracing_cpu(cpu) {
|
tracing: Consolidate max_tr into main trace_array structure
Currently, the way the latency tracers and snapshot feature works
is to have a separate trace_array called "max_tr" that holds the
snapshot buffer. For latency tracers, this snapshot buffer is used
to swap the running buffer with this buffer to save the current max
latency.
The only items needed for the max_tr is really just a copy of the buffer
itself, the per_cpu data pointers, the time_start timestamp that states
when the max latency was triggered, and the cpu that the max latency
was triggered on. All other fields in trace_array are unused by the
max_tr, making the max_tr mostly bloat.
This change removes the max_tr completely, and adds a new structure
called trace_buffer, that holds the buffer pointer, the per_cpu data
pointers, the time_start timestamp, and the cpu where the latency occurred.
The trace_array, now has two trace_buffers, one for the normal trace and
one for the max trace or snapshot. By doing this, not only do we remove
the bloat from the max_trace but the instances of traces can now use
their own snapshot feature and not have just the top level global_trace have
the snapshot feature and latency tracers for itself.
Signed-off-by: Steven Rostedt <rostedt@goodmis.org>
2013-03-05 22:24:35 +08:00
|
|
|
atomic_dec(&per_cpu_ptr(iter.trace_buffer->data, cpu)->disabled);
|
2010-08-05 22:22:23 +08:00
|
|
|
}
|
|
|
|
|
2014-11-06 20:41:55 +08:00
|
|
|
for_each_tracing_cpu(cpu) {
|
|
|
|
if (iter.buffer_iter[cpu]) {
|
2010-08-05 22:22:23 +08:00
|
|
|
ring_buffer_read_finish(iter.buffer_iter[cpu]);
|
2014-11-06 20:41:55 +08:00
|
|
|
iter.buffer_iter[cpu] = NULL;
|
|
|
|
}
|
|
|
|
}
|
2010-08-05 22:22:23 +08:00
|
|
|
}
|
|
|
|
|
|
|
|
/*
|
|
|
|
* kdb_ftdump - Dump the ftrace log buffer
|
|
|
|
*/
|
|
|
|
static int kdb_ftdump(int argc, const char **argv)
|
|
|
|
{
|
|
|
|
int skip_lines = 0;
|
2010-08-05 22:22:23 +08:00
|
|
|
long cpu_file;
|
2010-08-05 22:22:23 +08:00
|
|
|
char *cp;
|
|
|
|
|
2010-08-05 22:22:23 +08:00
|
|
|
if (argc > 2)
|
2010-08-05 22:22:23 +08:00
|
|
|
return KDB_ARGCOUNT;
|
|
|
|
|
|
|
|
if (argc) {
|
|
|
|
skip_lines = simple_strtol(argv[1], &cp, 0);
|
|
|
|
if (*cp)
|
|
|
|
skip_lines = 0;
|
|
|
|
}
|
|
|
|
|
2010-08-05 22:22:23 +08:00
|
|
|
if (argc == 2) {
|
|
|
|
cpu_file = simple_strtol(argv[2], &cp, 0);
|
|
|
|
if (*cp || cpu_file >= NR_CPUS || cpu_file < 0 ||
|
|
|
|
!cpu_online(cpu_file))
|
|
|
|
return KDB_BADINT;
|
|
|
|
} else {
|
2013-01-24 04:22:59 +08:00
|
|
|
cpu_file = RING_BUFFER_ALL_CPUS;
|
2010-08-05 22:22:23 +08:00
|
|
|
}
|
|
|
|
|
2010-08-05 22:22:23 +08:00
|
|
|
kdb_trap_printk++;
|
2010-08-05 22:22:23 +08:00
|
|
|
ftrace_dump_buf(skip_lines, cpu_file);
|
2010-08-05 22:22:23 +08:00
|
|
|
kdb_trap_printk--;
|
|
|
|
|
|
|
|
return 0;
|
|
|
|
}
|
|
|
|
|
|
|
|
static __init int kdb_ftrace_register(void)
|
|
|
|
{
|
2014-11-06 22:36:42 +08:00
|
|
|
kdb_register_flags("ftdump", kdb_ftdump, "[skip_#lines] [cpu]",
|
kdb: Categorize kdb commands (similar to SysRq categorization)
This patch introduces several new flags to collect kdb commands into
groups (later allowing them to be optionally disabled).
This follows similar prior art to enable/disable magic sysrq
commands.
The commands have been categorized as follows:
Always on: go (w/o args), env, set, help, ?, cpu (w/o args), sr,
dmesg, disable_nmi, defcmd, summary, grephelp
Mem read: md, mdr, mdp, mds, ef, bt (with args), per_cpu
Mem write: mm
Reg read: rd
Reg write: go (with args), rm
Inspect: bt (w/o args), btp, bta, btc, btt, ps, pid, lsmod
Flow ctrl: bp, bl, bph, bc, be, bd, ss
Signal: kill
Reboot: reboot
All: cpu, kgdb, (and all of the above), nmi_console
Signed-off-by: Daniel Thompson <daniel.thompson@linaro.org>
Cc: Jason Wessel <jason.wessel@windriver.com>
Signed-off-by: Jason Wessel <jason.wessel@windriver.com>
2014-11-06 22:36:45 +08:00
|
|
|
"Dump ftrace log", 0, KDB_ENABLE_ALWAYS_SAFE);
|
2010-08-05 22:22:23 +08:00
|
|
|
return 0;
|
|
|
|
}
|
|
|
|
|
|
|
|
late_initcall(kdb_ftrace_register);
|