blob: 8f71915e8bb4d9c63b67735cfacb62fca9ca9834 [file] [log] [blame]
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +01001/*
2 * ring buffer based initcalls tracer
3 *
4 * Copyright (C) 2008 Frederic Weisbecker <fweisbec@gmail.com>
5 *
6 */
7
8#include <linux/init.h>
9#include <linux/debugfs.h>
10#include <linux/ftrace.h>
Frederic Weisbecker56010202008-10-02 13:26:05 +020011#include <linux/kallsyms.h>
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +010012
13#include "trace.h"
14
15static struct trace_array *boot_trace;
Frederic Weisbecker71566a02008-10-31 12:57:20 +010016static bool pre_initcalls_finished;
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +010017
Frederic Weisbecker71566a02008-10-31 12:57:20 +010018/* Tells the boot tracer that the pre_smp_initcalls are finished.
19 * So we are ready .
20 * It doesn't enable sched events tracing however.
21 * You have to call enable_boot_trace to do so.
22 */
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +010023void start_boot_trace(void)
24{
Frederic Weisbecker71566a02008-10-31 12:57:20 +010025 pre_initcalls_finished = true;
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +010026}
27
Frederic Weisbecker71566a02008-10-31 12:57:20 +010028void enable_boot_trace(void)
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +010029{
Frederic Weisbeckerd7ad44b2008-10-31 13:20:08 +010030 if (pre_initcalls_finished)
Steven Rostedte168e052008-11-07 22:36:02 -050031 tracing_start_sched_switch_record();
Frederic Weisbecker71566a02008-10-31 12:57:20 +010032}
33
34void disable_boot_trace(void)
35{
Frederic Weisbeckerd7ad44b2008-10-31 13:20:08 +010036 if (pre_initcalls_finished)
Steven Rostedte168e052008-11-07 22:36:02 -050037 tracing_stop_sched_switch_record();
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +010038}
39
Frederic Weisbecker79a9d462008-10-31 13:34:45 +010040static void reset_boot_trace(struct trace_array *tr)
Frederic Weisbecker097d0362008-10-03 15:39:21 +020041{
Steven Rostedt75f5c472008-11-07 22:36:02 -050042 int cpu;
43
44 tr->time_start = ftrace_now(tr->cpu);
45
46 for_each_online_cpu(cpu)
47 tracing_reset(tr, cpu);
Frederic Weisbecker097d0362008-10-03 15:39:21 +020048}
49
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +010050static void boot_trace_init(struct trace_array *tr)
51{
52 int cpu;
53 boot_trace = tr;
54
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +010055 for_each_cpu_mask(cpu, cpu_possible_map)
Steven Rostedt3928a8a2008-09-29 23:02:41 -040056 tracing_reset(tr, cpu);
Frederic Weisbeckerd7ad44b2008-10-31 13:20:08 +010057
Steven Rostedte168e052008-11-07 22:36:02 -050058 tracing_sched_switch_assign_trace(tr);
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +010059}
60
Frederic Weisbecker9e9efff2008-09-29 20:31:58 +020061static enum print_line_t initcall_print_line(struct trace_iterator *iter)
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +010062{
Frederic Weisbecker9e9efff2008-09-29 20:31:58 +020063 int ret;
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +010064 struct trace_entry *entry = iter->ent;
Steven Rostedt777e2082008-09-29 23:02:42 -040065 struct trace_boot *field = (struct trace_boot *)entry;
66 struct boot_trace *it = &field->initcall;
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +010067 struct trace_seq *s = &iter->seq;
Frederic Weisbeckercb5ab742008-10-02 12:59:20 +020068 struct timespec calltime = ktime_to_timespec(it->calltime);
69 struct timespec rettime = ktime_to_timespec(it->rettime);
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +010070
Frederic Weisbecker9e9efff2008-09-29 20:31:58 +020071 if (entry->type == TRACE_BOOT) {
Arjan van de Ven8a5d9002008-10-04 13:42:27 -070072 ret = trace_seq_printf(s, "[%5ld.%09ld] calling %s @ %i\n",
Frederic Weisbeckercb5ab742008-10-02 12:59:20 +020073 calltime.tv_sec,
74 calltime.tv_nsec,
75 it->func, it->caller);
76 if (!ret)
Frederic Weisbecker9e9efff2008-09-29 20:31:58 +020077 return TRACE_TYPE_PARTIAL_LINE;
Frederic Weisbecker56010202008-10-02 13:26:05 +020078
Arjan van de Ven8a5d9002008-10-04 13:42:27 -070079 ret = trace_seq_printf(s, "[%5ld.%09ld] initcall %s "
Frederic Weisbeckercb5ab742008-10-02 12:59:20 +020080 "returned %d after %lld msecs\n",
81 rettime.tv_sec,
82 rettime.tv_nsec,
83 it->func, it->result, it->duration);
Frederic Weisbecker56010202008-10-02 13:26:05 +020084
Frederic Weisbeckercb5ab742008-10-02 12:59:20 +020085 if (!ret)
86 return TRACE_TYPE_PARTIAL_LINE;
87 return TRACE_TYPE_HANDLED;
Frederic Weisbecker9e9efff2008-09-29 20:31:58 +020088 }
89 return TRACE_TYPE_UNHANDLED;
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +010090}
91
92struct tracer boot_tracer __read_mostly =
93{
94 .name = "initcall",
95 .init = boot_trace_init,
Frederic Weisbecker097d0362008-10-03 15:39:21 +020096 .reset = reset_boot_trace,
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +010097 .print_line = initcall_print_line,
98};
99
Frederic Weisbecker56010202008-10-02 13:26:05 +0200100void trace_boot(struct boot_trace *it, initcall_t fn)
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +0100101{
Steven Rostedt3928a8a2008-09-29 23:02:41 -0400102 struct ring_buffer_event *event;
Steven Rostedt777e2082008-09-29 23:02:42 -0400103 struct trace_boot *entry;
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +0100104 struct trace_array_cpu *data;
105 unsigned long irq_flags;
106 struct trace_array *tr = boot_trace;
107
Frederic Weisbecker71566a02008-10-31 12:57:20 +0100108 if (!pre_initcalls_finished)
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +0100109 return;
110
Frederic Weisbecker56010202008-10-02 13:26:05 +0200111 /* Get its name now since this function could
112 * disappear because it is in the .init section.
113 */
114 sprint_symbol(it->func, (unsigned long)fn);
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +0100115 preempt_disable();
116 data = tr->data[smp_processor_id()];
117
Steven Rostedt3928a8a2008-09-29 23:02:41 -0400118 event = ring_buffer_lock_reserve(tr->buffer, sizeof(*entry),
119 &irq_flags);
120 if (!event)
121 goto out;
122 entry = ring_buffer_event_data(event);
Steven Rostedt38697052008-10-01 13:14:09 -0400123 tracing_generic_entry_update(&entry->ent, 0, 0);
Steven Rostedt777e2082008-09-29 23:02:42 -0400124 entry->ent.type = TRACE_BOOT;
125 entry->initcall = *it;
Steven Rostedt3928a8a2008-09-29 23:02:41 -0400126 ring_buffer_unlock_commit(tr->buffer, event, irq_flags);
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +0100127
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +0100128 trace_wake_up();
129
Steven Rostedt3928a8a2008-09-29 23:02:41 -0400130 out:
Frédéric Weisbeckerd13744c2008-09-23 11:32:08 +0100131 preempt_enable();
132}