blob: a272d78185eb5901449b0e8765f33a3f5723df28 [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
Jason Wessel9c106c12008-05-27 12:23:29 -050052static void __touch_softlockup_watchdog(void)
Ingo Molnar8446f1d2005-09-06 15:16:27 -070053{
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}
Jason Wessel9c106c12008-05-27 12:23:29 -050058
59void touch_softlockup_watchdog(void)
60{
61 __raw_get_cpu_var(touch_timestamp) = 0;
62}
Ingo Molnar8446f1d2005-09-06 15:16:27 -070063EXPORT_SYMBOL(touch_softlockup_watchdog);
64
Jeremy Fitzhardinge04c91672007-05-08 00:28:05 -070065void touch_all_softlockup_watchdogs(void)
66{
67 int cpu;
68
69 /* Cause each CPU to re-update its timestamp rather than complain */
70 for_each_online_cpu(cpu)
71 per_cpu(touch_timestamp, cpu) = 0;
72}
73EXPORT_SYMBOL(touch_all_softlockup_watchdogs);
74
Ingo Molnar8446f1d2005-09-06 15:16:27 -070075/*
76 * This callback runs from the timer interrupt, and checks
77 * whether the watchdog thread has hung or not:
78 */
Ingo Molnar6687a972006-03-24 03:18:41 -080079void softlockup_tick(void)
Ingo Molnar8446f1d2005-09-06 15:16:27 -070080{
81 int this_cpu = smp_processor_id();
Ingo Molnar6687a972006-03-24 03:18:41 -080082 unsigned long touch_timestamp = per_cpu(touch_timestamp, this_cpu);
Jeremy Fitzhardinge966812d2007-05-08 00:28:02 -070083 unsigned long print_timestamp;
Ingo Molnar43581a12007-10-16 23:26:08 -070084 struct pt_regs *regs = get_irq_regs();
Jeremy Fitzhardinge966812d2007-05-08 00:28:02 -070085 unsigned long now;
Ingo Molnar8446f1d2005-09-06 15:16:27 -070086
Jeremy Fitzhardinge04c91672007-05-08 00:28:05 -070087 if (touch_timestamp == 0) {
Jason Wessel9c106c12008-05-27 12:23:29 -050088 __touch_softlockup_watchdog();
Jeremy Fitzhardinge966812d2007-05-08 00:28:02 -070089 return;
Jeremy Fitzhardinge04c91672007-05-08 00:28:05 -070090 }
Jeremy Fitzhardinge966812d2007-05-08 00:28:02 -070091
92 print_timestamp = per_cpu(print_timestamp, this_cpu);
93
94 /* report at most once a second */
Ingo Molnara115d5c2007-10-16 23:26:06 -070095 if ((print_timestamp >= touch_timestamp &&
96 print_timestamp < (touch_timestamp + 1)) ||
97 did_panic || !per_cpu(watchdog_task, this_cpu)) {
Ingo Molnar8446f1d2005-09-06 15:16:27 -070098 return;
Ingo Molnara115d5c2007-10-16 23:26:06 -070099 }
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700100
Ingo Molnar6687a972006-03-24 03:18:41 -0800101 /* do not print during early bootup: */
102 if (unlikely(system_state != SYSTEM_RUNNING)) {
Jason Wessel9c106c12008-05-27 12:23:29 -0500103 __touch_softlockup_watchdog();
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700104 return;
Ingo Molnar6687a972006-03-24 03:18:41 -0800105 }
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700106
Ingo Molnara3b13c22007-10-16 23:26:06 -0700107 now = get_timestamp(this_cpu);
Jeremy Fitzhardinge966812d2007-05-08 00:28:02 -0700108
Peter Zijlstraed50d6c2008-02-02 00:23:08 +0100109 /* Wake up the high-prio watchdog task every second: */
110 if (now > (touch_timestamp + 1))
111 wake_up_process(per_cpu(watchdog_task, this_cpu));
112
Ingo Molnar82a1fcb2008-01-25 21:08:02 +0100113 /* Warn about unreasonable delays: */
Ravikiran G Thirumalaic4f3b632007-10-16 23:26:09 -0700114 if (now <= (touch_timestamp + softlockup_thresh))
Ingo Molnar43581a12007-10-16 23:26:08 -0700115 return;
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700116
Ingo Molnar43581a12007-10-16 23:26:08 -0700117 per_cpu(print_timestamp, this_cpu) = touch_timestamp;
118
119 spin_lock(&print_lock);
Ravikiran G Thirumalaic4f3b632007-10-16 23:26:09 -0700120 printk(KERN_ERR "BUG: soft lockup - CPU#%d stuck for %lus! [%s:%d]\n",
121 this_cpu, now - touch_timestamp,
Pavel Emelyanovba25f9d2007-10-18 23:40:40 -0700122 current->comm, task_pid_nr(current));
Arjan van de Ven3b725322008-06-16 15:51:08 -0700123 print_modules();
Ingo Molnar43581a12007-10-16 23:26:08 -0700124 if (regs)
125 show_regs(regs);
126 else
Ingo Molnar6687a972006-03-24 03:18:41 -0800127 dump_stack();
Ingo Molnar43581a12007-10-16 23:26:08 -0700128 spin_unlock(&print_lock);
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700129}
130
131/*
Ingo Molnar82a1fcb2008-01-25 21:08:02 +0100132 * Have a reasonable limit on the number of tasks checked:
133 */
Ingo Molnar90739082008-01-25 21:08:34 +0100134unsigned long __read_mostly sysctl_hung_task_check_count = 1024;
Ingo Molnar82a1fcb2008-01-25 21:08:02 +0100135
136/*
137 * Zero means infinite timeout - no checking done:
138 */
Ingo Molnar90739082008-01-25 21:08:34 +0100139unsigned long __read_mostly sysctl_hung_task_timeout_secs = 120;
Ingo Molnar82a1fcb2008-01-25 21:08:02 +0100140
Ingo Molnar90739082008-01-25 21:08:34 +0100141unsigned long __read_mostly sysctl_hung_task_warnings = 10;
Ingo Molnar82a1fcb2008-01-25 21:08:02 +0100142
143/*
144 * Only do the hung-tasks check on one CPU:
145 */
146static int check_cpu __read_mostly = -1;
147
148static void check_hung_task(struct task_struct *t, unsigned long now)
149{
150 unsigned long switch_count = t->nvcsw + t->nivcsw;
151
152 if (t->flags & PF_FROZEN)
153 return;
154
155 if (switch_count != t->last_switch_count || !t->last_switch_timestamp) {
156 t->last_switch_count = switch_count;
157 t->last_switch_timestamp = now;
158 return;
159 }
160 if ((long)(now - t->last_switch_timestamp) <
161 sysctl_hung_task_timeout_secs)
162 return;
163 if (sysctl_hung_task_warnings < 0)
164 return;
165 sysctl_hung_task_warnings--;
166
167 /*
168 * Ok, the task did not get scheduled for more than 2 minutes,
169 * complain:
170 */
171 printk(KERN_ERR "INFO: task %s:%d blocked for more than "
172 "%ld seconds.\n", t->comm, t->pid,
173 sysctl_hung_task_timeout_secs);
174 printk(KERN_ERR "\"echo 0 > /proc/sys/kernel/hung_task_timeout_secs\""
175 " disables this message.\n");
176 sched_show_task(t);
177 __debug_show_held_locks(t);
178
179 t->last_switch_timestamp = now;
180 touch_nmi_watchdog();
181}
182
183/*
184 * Check whether a TASK_UNINTERRUPTIBLE does not get woken up for
185 * a really long time (120 seconds). If that happens, print out
186 * a warning.
187 */
188static void check_hung_uninterruptible_tasks(int this_cpu)
189{
190 int max_count = sysctl_hung_task_check_count;
191 unsigned long now = get_timestamp(this_cpu);
192 struct task_struct *g, *t;
193
194 /*
195 * If the system crashed already then all bets are off,
196 * do not report extra hung tasks:
197 */
198 if ((tainted & TAINT_DIE) || did_panic)
199 return;
200
201 read_lock(&tasklist_lock);
202 do_each_thread(g, t) {
203 if (!--max_count)
Peter Zijlstraed50d6c2008-02-02 00:23:08 +0100204 goto unlock;
Ingo Molnar82a1fcb2008-01-25 21:08:02 +0100205 if (t->state & TASK_UNINTERRUPTIBLE)
206 check_hung_task(t, now);
207 } while_each_thread(g, t);
Peter Zijlstraed50d6c2008-02-02 00:23:08 +0100208 unlock:
Ingo Molnar82a1fcb2008-01-25 21:08:02 +0100209 read_unlock(&tasklist_lock);
210}
211
212/*
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700213 * The watchdog thread - runs every second and touches the timestamp.
214 */
Ingo Molnara5f2ce32007-10-16 23:26:08 -0700215static int watchdog(void *__bind_cpu)
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700216{
Oleg Nesterov02fb6142007-05-08 00:24:03 -0700217 struct sched_param param = { .sched_priority = MAX_RT_PRIO-1 };
Ingo Molnar82a1fcb2008-01-25 21:08:02 +0100218 int this_cpu = (long)__bind_cpu;
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700219
220 sched_setscheduler(current, SCHED_FIFO, &param);
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700221
Jeremy Fitzhardinge966812d2007-05-08 00:28:02 -0700222 /* initialize timestamp */
Jason Wessel9c106c12008-05-27 12:23:29 -0500223 __touch_softlockup_watchdog();
Jeremy Fitzhardinge966812d2007-05-08 00:28:02 -0700224
Dmitry Adamushko7be2a032008-02-08 15:41:13 +0100225 set_current_state(TASK_INTERRUPTIBLE);
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700226 /*
Ingo Molnar6687a972006-03-24 03:18:41 -0800227 * Run briefly once per second to reset the softlockup timestamp.
Ingo Molnar82a1fcb2008-01-25 21:08:02 +0100228 * If this gets delayed for more than 60 seconds then the
Ingo Molnar6687a972006-03-24 03:18:41 -0800229 * debug-printout triggers in softlockup_tick().
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700230 */
231 while (!kthread_should_stop()) {
Jason Wessel9c106c12008-05-27 12:23:29 -0500232 __touch_softlockup_watchdog();
Peter Zijlstraed50d6c2008-02-02 00:23:08 +0100233 schedule();
234
235 if (kthread_should_stop())
236 break;
Ingo Molnar82a1fcb2008-01-25 21:08:02 +0100237
Dmitry Adamushko7be2a032008-02-08 15:41:13 +0100238 if (this_cpu == check_cpu) {
239 if (sysctl_hung_task_timeout_secs)
240 check_hung_uninterruptible_tasks(this_cpu);
241 }
Ingo Molnar82a1fcb2008-01-25 21:08:02 +0100242
Dmitry Adamushko7be2a032008-02-08 15:41:13 +0100243 set_current_state(TASK_INTERRUPTIBLE);
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700244 }
Dmitry Adamushko7be2a032008-02-08 15:41:13 +0100245 __set_current_state(TASK_RUNNING);
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700246
247 return 0;
248}
249
250/*
251 * Create/destroy watchdog threads as CPUs come and go:
252 */
Chandra Seetharaman8c78f302006-07-30 03:03:35 -0700253static int __cpuinit
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700254cpu_callback(struct notifier_block *nfb, unsigned long action, void *hcpu)
255{
256 int hotcpu = (unsigned long)hcpu;
257 struct task_struct *p;
258
259 switch (action) {
260 case CPU_UP_PREPARE:
Rafael J. Wysocki8bb78442007-05-09 02:35:10 -0700261 case CPU_UP_PREPARE_FROZEN:
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700262 BUG_ON(per_cpu(watchdog_task, hotcpu));
263 p = kthread_create(watchdog, hcpu, "watchdog/%d", hotcpu);
264 if (IS_ERR(p)) {
Ingo Molnara5f2ce32007-10-16 23:26:08 -0700265 printk(KERN_ERR "watchdog for %i failed\n", hotcpu);
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700266 return NOTIFY_BAD;
267 }
Ingo Molnara5f2ce32007-10-16 23:26:08 -0700268 per_cpu(touch_timestamp, hotcpu) = 0;
269 per_cpu(watchdog_task, hotcpu) = p;
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700270 kthread_bind(p, hotcpu);
Ingo Molnara5f2ce32007-10-16 23:26:08 -0700271 break;
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700272 case CPU_ONLINE:
Rafael J. Wysocki8bb78442007-05-09 02:35:10 -0700273 case CPU_ONLINE_FROZEN:
Ingo Molnar82a1fcb2008-01-25 21:08:02 +0100274 check_cpu = any_online_cpu(cpu_online_map);
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700275 wake_up_process(per_cpu(watchdog_task, hotcpu));
276 break;
277#ifdef CONFIG_HOTPLUG_CPU
Ingo Molnar82a1fcb2008-01-25 21:08:02 +0100278 case CPU_DOWN_PREPARE:
279 case CPU_DOWN_PREPARE_FROZEN:
280 if (hotcpu == check_cpu) {
281 cpumask_t temp_cpu_online_map = cpu_online_map;
282
283 cpu_clear(hotcpu, temp_cpu_online_map);
284 check_cpu = any_online_cpu(temp_cpu_online_map);
285 }
286 break;
Peter Zijlstraed50d6c2008-02-02 00:23:08 +0100287
288 case CPU_UP_CANCELED:
289 case CPU_UP_CANCELED_FROZEN:
290 if (!per_cpu(watchdog_task, hotcpu))
291 break;
292 /* Unbind so it can run. Fall thru. */
293 kthread_bind(per_cpu(watchdog_task, hotcpu),
294 any_online_cpu(cpu_online_map));
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700295 case CPU_DEAD:
Rafael J. Wysocki8bb78442007-05-09 02:35:10 -0700296 case CPU_DEAD_FROZEN:
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700297 p = per_cpu(watchdog_task, hotcpu);
298 per_cpu(watchdog_task, hotcpu) = NULL;
299 kthread_stop(p);
300 break;
301#endif /* CONFIG_HOTPLUG_CPU */
Ingo Molnara5f2ce32007-10-16 23:26:08 -0700302 }
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700303 return NOTIFY_OK;
304}
305
Chandra Seetharaman8c78f302006-07-30 03:03:35 -0700306static struct notifier_block __cpuinitdata cpu_nfb = {
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700307 .notifier_call = cpu_callback
308};
309
310__init void spawn_softlockup_task(void)
311{
312 void *cpu = (void *)(long)smp_processor_id();
Akinobu Mita07dccf32006-09-29 02:00:22 -0700313 int err = cpu_callback(&cpu_nfb, CPU_UP_PREPARE, cpu);
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700314
Akinobu Mita07dccf32006-09-29 02:00:22 -0700315 BUG_ON(err == NOTIFY_BAD);
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700316 cpu_callback(&cpu_nfb, CPU_ONLINE, cpu);
317 register_cpu_notifier(&cpu_nfb);
318
Alan Sterne041c682006-03-27 01:16:30 -0800319 atomic_notifier_chain_register(&panic_notifier_list, &panic_block);
Ingo Molnar8446f1d2005-09-06 15:16:27 -0700320}