blob: 7c2da88db4eddf6539673357b01d94b543aac52c [file] [log] [blame]
Ingo Molnar8446f1d2005-09-06 15:16:27 -07001/*
2 * Detect Soft Lockups
3 *
Ingo Molnar6687a972006-03-24 03:18:41 -08004 * started by Ingo Molnar, Copyright (C) 2005, 2006 Red Hat, Inc.
Ingo Molnar8446f1d2005-09-06 15:16:27 -07005 *
6 * this code detects soft lockups: incidents in where on a CPU
7 * the kernel does not reschedule for 10 seconds or more.
8 */
Ingo Molnar8446f1d2005-09-06 15:16:27 -07009#include <linux/mm.h>
10#include <linux/cpu.h>
Ingo Molnar82a1fcb2008-01-25 21:08:02 +010011#include <linux/nmi.h>
Ingo Molnar8446f1d2005-09-06 15:16:27 -070012#include <linux/init.h>
13#include <linux/delay.h>
Rafael J. Wysocki83144182007-07-17 04:03:35 -070014#include <linux/freezer.h>
Ingo Molnar8446f1d2005-09-06 15:16:27 -070015#include <linux/kthread.h>
16#include <linux/notifier.h>
17#include <linux/module.h>
18
Ingo Molnar43581a12007-10-16 23:26:08 -070019#include <asm/irq_regs.h>
20
Ingo Molnar8446f1d2005-09-06 15:16:27 -070021static DEFINE_SPINLOCK(print_lock);
22
Ingo Molnar6687a972006-03-24 03:18:41 -080023static DEFINE_PER_CPU(unsigned long, touch_timestamp);
24static DEFINE_PER_CPU(unsigned long, print_timestamp);
Ingo Molnar8446f1d2005-09-06 15:16:27 -070025static DEFINE_PER_CPU(struct task_struct *, watchdog_task);
26
Ingo Molnar90739082008-01-25 21:08:34 +010027static int __read_mostly did_panic;
28unsigned long __read_mostly softlockup_thresh = 60;
Ingo Molnar6687a972006-03-24 03:18:41 -080029
30static int
31softlock_panic(struct notifier_block *this, unsigned long event, void *ptr)
Ingo Molnar8446f1d2005-09-06 15:16:27 -070032{
33 did_panic = 1;
34
35 return NOTIFY_DONE;
36}
37
38static struct notifier_block panic_block = {
39 .notifier_call = softlock_panic,
40};
41
Jeremy Fitzhardinge966812d2007-05-08 00:28:02 -070042/*
43 * Returns seconds, approximately. We don't need nanosecond
44 * resolution, and we don't need to waste time with a big divide when
45 * 2^30ns == 1.074s.
46 */
Ingo Molnara3b13c22007-10-16 23:26:06 -070047static unsigned long get_timestamp(int this_cpu)
Jeremy Fitzhardinge966812d2007-05-08 00:28:02 -070048{
Ingo Molnar82a1fcb2008-01-25 21:08:02 +010049 return cpu_clock(this_cpu) >> 30LL; /* 2^30 ~= 10^9 */
Jeremy Fitzhardinge966812d2007-05-08 00:28:02 -070050}
51
Ingo Molnar8446f1d2005-09-06 15:16:27 -070052void touch_softlockup_watchdog(void)
53{
Ingo Molnara3b13c22007-10-16 23:26:06 -070054 int this_cpu = raw_smp_processor_id();
55
56 __raw_get_cpu_var(touch_timestamp) = get_timestamp(this_cpu);
Ingo Molnar8446f1d2005-09-06 15:16:27 -070057}
58EXPORT_SYMBOL(touch_softlockup_watchdog);
59
Jeremy Fitzhardinge04c91672007-05-08 00:28:05 -070060void touch_all_softlockup_watchdogs(void)
61{
62 int cpu;
63
64 /* Cause each CPU to re-update its timestamp rather than complain */
65 for_each_online_cpu(cpu)
66 per_cpu(touch_timestamp, cpu) = 0;
67}
68EXPORT_SYMBOL(touch_all_softlockup_watchdogs);
69
Ingo Molnar8446f1d2005-09-06 15:16:27 -070070/*
71 * This callback runs from the timer interrupt, and checks
72 * whether the watchdog thread has hung or not:
73 */
Ingo Molnar6687a972006-03-24 03:18:41 -080074void softlockup_tick(void)
Ingo Molnar8446f1d2005-09-06 15:16:27 -070075{
76 int this_cpu = smp_processor_id();
Ingo Molnar6687a972006-03-24 03:18:41 -080077 unsigned long touch_timestamp = per_cpu(touch_timestamp, this_cpu);
Jeremy Fitzhardinge966812d2007-05-08 00:28:02 -070078 unsigned long print_timestamp;
Ingo Molnar43581a12007-10-16 23:26:08 -070079 struct pt_regs *regs = get_irq_regs();
Jeremy Fitzhardinge966812d2007-05-08 00:28:02 -070080 unsigned long now;
Ingo Molnar8446f1d2005-09-06 15:16:27 -070081
Jeremy Fitzhardinge04c91672007-05-08 00:28:05 -070082 if (touch_timestamp == 0) {
83 touch_softlockup_watchdog();
Jeremy Fitzhardinge966812d2007-05-08 00:28:02 -070084 return;
Jeremy Fitzhardinge04c91672007-05-08 00:28:05 -070085 }
Jeremy Fitzhardinge966812d2007-05-08 00:28:02 -070086
87 print_timestamp = per_cpu(print_timestamp, this_cpu);
88
89 /* report at most once a second */
Ingo Molnara115d5c2007-10-16 23:26:06 -070090 if ((print_timestamp >= touch_timestamp &&
91 print_timestamp < (touch_timestamp + 1)) ||
92 did_panic || !per_cpu(watchdog_task, this_cpu)) {
Ingo Molnar8446f1d2005-09-06 15:16:27 -070093 return;
Ingo Molnara115d5c2007-10-16 23:26:06 -070094 }
Ingo Molnar8446f1d2005-09-06 15:16:27 -070095
Ingo Molnar6687a972006-03-24 03:18:41 -080096 /* do not print during early bootup: */
97 if (unlikely(system_state != SYSTEM_RUNNING)) {
98 touch_softlockup_watchdog();
Ingo Molnar8446f1d2005-09-06 15:16:27 -070099 return;
Ingo Molnar6687a972006-03-24 03:18:41 -0800100 }
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700101
Ingo Molnara3b13c22007-10-16 23:26:06 -0700102 now = get_timestamp(this_cpu);
Jeremy Fitzhardinge966812d2007-05-08 00:28:02 -0700103
Peter Zijlstraed50d6c2008-02-02 00:23:08 +0100104 /* Wake up the high-prio watchdog task every second: */
105 if (now > (touch_timestamp + 1))
106 wake_up_process(per_cpu(watchdog_task, this_cpu));
107
Ingo Molnar82a1fcb2008-01-25 21:08:02 +0100108 /* Warn about unreasonable delays: */
Ravikiran G Thirumalaic4f3b632007-10-16 23:26:09 -0700109 if (now <= (touch_timestamp + softlockup_thresh))
Ingo Molnar43581a12007-10-16 23:26:08 -0700110 return;
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700111
Ingo Molnar43581a12007-10-16 23:26:08 -0700112 per_cpu(print_timestamp, this_cpu) = touch_timestamp;
113
114 spin_lock(&print_lock);
Ravikiran G Thirumalaic4f3b632007-10-16 23:26:09 -0700115 printk(KERN_ERR "BUG: soft lockup - CPU#%d stuck for %lus! [%s:%d]\n",
116 this_cpu, now - touch_timestamp,
Pavel Emelyanovba25f9d2007-10-18 23:40:40 -0700117 current->comm, task_pid_nr(current));
Ingo Molnar43581a12007-10-16 23:26:08 -0700118 if (regs)
119 show_regs(regs);
120 else
Ingo Molnar6687a972006-03-24 03:18:41 -0800121 dump_stack();
Ingo Molnar43581a12007-10-16 23:26:08 -0700122 spin_unlock(&print_lock);
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700123}
124
125/*
Ingo Molnar82a1fcb2008-01-25 21:08:02 +0100126 * Have a reasonable limit on the number of tasks checked:
127 */
Ingo Molnar90739082008-01-25 21:08:34 +0100128unsigned long __read_mostly sysctl_hung_task_check_count = 1024;
Ingo Molnar82a1fcb2008-01-25 21:08:02 +0100129
130/*
131 * Zero means infinite timeout - no checking done:
132 */
Ingo Molnar90739082008-01-25 21:08:34 +0100133unsigned long __read_mostly sysctl_hung_task_timeout_secs = 120;
Ingo Molnar82a1fcb2008-01-25 21:08:02 +0100134
Ingo Molnar90739082008-01-25 21:08:34 +0100135unsigned long __read_mostly sysctl_hung_task_warnings = 10;
Ingo Molnar82a1fcb2008-01-25 21:08:02 +0100136
137/*
138 * Only do the hung-tasks check on one CPU:
139 */
140static int check_cpu __read_mostly = -1;
141
142static void check_hung_task(struct task_struct *t, unsigned long now)
143{
144 unsigned long switch_count = t->nvcsw + t->nivcsw;
145
146 if (t->flags & PF_FROZEN)
147 return;
148
149 if (switch_count != t->last_switch_count || !t->last_switch_timestamp) {
150 t->last_switch_count = switch_count;
151 t->last_switch_timestamp = now;
152 return;
153 }
154 if ((long)(now - t->last_switch_timestamp) <
155 sysctl_hung_task_timeout_secs)
156 return;
157 if (sysctl_hung_task_warnings < 0)
158 return;
159 sysctl_hung_task_warnings--;
160
161 /*
162 * Ok, the task did not get scheduled for more than 2 minutes,
163 * complain:
164 */
165 printk(KERN_ERR "INFO: task %s:%d blocked for more than "
166 "%ld seconds.\n", t->comm, t->pid,
167 sysctl_hung_task_timeout_secs);
168 printk(KERN_ERR "\"echo 0 > /proc/sys/kernel/hung_task_timeout_secs\""
169 " disables this message.\n");
170 sched_show_task(t);
171 __debug_show_held_locks(t);
172
173 t->last_switch_timestamp = now;
174 touch_nmi_watchdog();
175}
176
177/*
178 * Check whether a TASK_UNINTERRUPTIBLE does not get woken up for
179 * a really long time (120 seconds). If that happens, print out
180 * a warning.
181 */
182static void check_hung_uninterruptible_tasks(int this_cpu)
183{
184 int max_count = sysctl_hung_task_check_count;
185 unsigned long now = get_timestamp(this_cpu);
186 struct task_struct *g, *t;
187
188 /*
189 * If the system crashed already then all bets are off,
190 * do not report extra hung tasks:
191 */
192 if ((tainted & TAINT_DIE) || did_panic)
193 return;
194
195 read_lock(&tasklist_lock);
196 do_each_thread(g, t) {
197 if (!--max_count)
Peter Zijlstraed50d6c2008-02-02 00:23:08 +0100198 goto unlock;
Ingo Molnar82a1fcb2008-01-25 21:08:02 +0100199 if (t->state & TASK_UNINTERRUPTIBLE)
200 check_hung_task(t, now);
201 } while_each_thread(g, t);
Peter Zijlstraed50d6c2008-02-02 00:23:08 +0100202 unlock:
Ingo Molnar82a1fcb2008-01-25 21:08:02 +0100203 read_unlock(&tasklist_lock);
204}
205
206/*
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700207 * The watchdog thread - runs every second and touches the timestamp.
208 */
Ingo Molnara5f2ce32007-10-16 23:26:08 -0700209static int watchdog(void *__bind_cpu)
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700210{
Oleg Nesterov02fb6142007-05-08 00:24:03 -0700211 struct sched_param param = { .sched_priority = MAX_RT_PRIO-1 };
Ingo Molnar82a1fcb2008-01-25 21:08:02 +0100212 int this_cpu = (long)__bind_cpu;
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700213
214 sched_setscheduler(current, SCHED_FIFO, &param);
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700215
Jeremy Fitzhardinge966812d2007-05-08 00:28:02 -0700216 /* initialize timestamp */
217 touch_softlockup_watchdog();
218
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700219 /*
Ingo Molnar6687a972006-03-24 03:18:41 -0800220 * Run briefly once per second to reset the softlockup timestamp.
Ingo Molnar82a1fcb2008-01-25 21:08:02 +0100221 * If this gets delayed for more than 60 seconds then the
Ingo Molnar6687a972006-03-24 03:18:41 -0800222 * debug-printout triggers in softlockup_tick().
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700223 */
224 while (!kthread_should_stop()) {
Peter Zijlstraed50d6c2008-02-02 00:23:08 +0100225 set_current_state(TASK_INTERRUPTIBLE);
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700226 touch_softlockup_watchdog();
Peter Zijlstraed50d6c2008-02-02 00:23:08 +0100227 schedule();
228
229 if (kthread_should_stop())
230 break;
Ingo Molnar82a1fcb2008-01-25 21:08:02 +0100231
232 if (this_cpu != check_cpu)
233 continue;
234
235 if (sysctl_hung_task_timeout_secs)
236 check_hung_uninterruptible_tasks(this_cpu);
Peter Zijlstraed50d6c2008-02-02 00:23:08 +0100237
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700238 }
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700239
240 return 0;
241}
242
243/*
244 * Create/destroy watchdog threads as CPUs come and go:
245 */
Chandra Seetharaman8c78f302006-07-30 03:03:35 -0700246static int __cpuinit
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700247cpu_callback(struct notifier_block *nfb, unsigned long action, void *hcpu)
248{
249 int hotcpu = (unsigned long)hcpu;
250 struct task_struct *p;
251
252 switch (action) {
253 case CPU_UP_PREPARE:
Rafael J. Wysocki8bb78442007-05-09 02:35:10 -0700254 case CPU_UP_PREPARE_FROZEN:
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700255 BUG_ON(per_cpu(watchdog_task, hotcpu));
256 p = kthread_create(watchdog, hcpu, "watchdog/%d", hotcpu);
257 if (IS_ERR(p)) {
Ingo Molnara5f2ce32007-10-16 23:26:08 -0700258 printk(KERN_ERR "watchdog for %i failed\n", hotcpu);
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700259 return NOTIFY_BAD;
260 }
Ingo Molnara5f2ce32007-10-16 23:26:08 -0700261 per_cpu(touch_timestamp, hotcpu) = 0;
262 per_cpu(watchdog_task, hotcpu) = p;
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700263 kthread_bind(p, hotcpu);
Ingo Molnara5f2ce32007-10-16 23:26:08 -0700264 break;
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700265 case CPU_ONLINE:
Rafael J. Wysocki8bb78442007-05-09 02:35:10 -0700266 case CPU_ONLINE_FROZEN:
Ingo Molnar82a1fcb2008-01-25 21:08:02 +0100267 check_cpu = any_online_cpu(cpu_online_map);
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700268 wake_up_process(per_cpu(watchdog_task, hotcpu));
269 break;
270#ifdef CONFIG_HOTPLUG_CPU
Ingo Molnar82a1fcb2008-01-25 21:08:02 +0100271 case CPU_DOWN_PREPARE:
272 case CPU_DOWN_PREPARE_FROZEN:
273 if (hotcpu == check_cpu) {
274 cpumask_t temp_cpu_online_map = cpu_online_map;
275
276 cpu_clear(hotcpu, temp_cpu_online_map);
277 check_cpu = any_online_cpu(temp_cpu_online_map);
278 }
279 break;
Peter Zijlstraed50d6c2008-02-02 00:23:08 +0100280
281 case CPU_UP_CANCELED:
282 case CPU_UP_CANCELED_FROZEN:
283 if (!per_cpu(watchdog_task, hotcpu))
284 break;
285 /* Unbind so it can run. Fall thru. */
286 kthread_bind(per_cpu(watchdog_task, hotcpu),
287 any_online_cpu(cpu_online_map));
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700288 case CPU_DEAD:
Rafael J. Wysocki8bb78442007-05-09 02:35:10 -0700289 case CPU_DEAD_FROZEN:
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700290 p = per_cpu(watchdog_task, hotcpu);
291 per_cpu(watchdog_task, hotcpu) = NULL;
292 kthread_stop(p);
293 break;
294#endif /* CONFIG_HOTPLUG_CPU */
Ingo Molnara5f2ce32007-10-16 23:26:08 -0700295 }
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700296 return NOTIFY_OK;
297}
298
Chandra Seetharaman8c78f302006-07-30 03:03:35 -0700299static struct notifier_block __cpuinitdata cpu_nfb = {
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700300 .notifier_call = cpu_callback
301};
302
303__init void spawn_softlockup_task(void)
304{
305 void *cpu = (void *)(long)smp_processor_id();
Akinobu Mita07dccf32006-09-29 02:00:22 -0700306 int err = cpu_callback(&cpu_nfb, CPU_UP_PREPARE, cpu);
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700307
Akinobu Mita07dccf32006-09-29 02:00:22 -0700308 BUG_ON(err == NOTIFY_BAD);
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700309 cpu_callback(&cpu_nfb, CPU_ONLINE, cpu);
310 register_cpu_notifier(&cpu_nfb);
311
Alan Sterne041c682006-03-27 01:16:30 -0800312 atomic_notifier_chain_register(&panic_notifier_list, &panic_block);
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700313}