blob: 449364f07a1e22e848ceec0d404c35604771d2ad [file] [log] [blame]
Linus Torvalds1da177e2005-04-16 15:20:36 -07001/*
2 * linux/kernel/printk.c
3 *
4 * Copyright (C) 1991, 1992 Linus Torvalds
5 *
6 * Modified to make sys_syslog() more flexible: added commands to
7 * return the last 4k of kernel messages, regardless of whether
8 * they've been read or not. Added option to suppress kernel printk's
9 * to the console. Added hook for sending the console messages
10 * elsewhere, in preparation for a serial line console (someday).
11 * Ted Ts'o, 2/11/93.
12 * Modified for sysctl support, 1/8/97, Chris Horn.
Jesper Juhl40dc5652005-10-30 15:02:46 -080013 * Fixed SMP synchronization, 08/08/99, Manfred Spraul
Christian Kujau624dffc2006-01-15 02:43:54 +010014 * manfred@colorfullife.com
Linus Torvalds1da177e2005-04-16 15:20:36 -070015 * Rewrote bits to get rid of console_lock
Francois Camie1f8e872008-10-15 22:01:59 -070016 * 01Mar01 Andrew Morton
Linus Torvalds1da177e2005-04-16 15:20:36 -070017 */
18
19#include <linux/kernel.h>
20#include <linux/mm.h>
21#include <linux/tty.h>
22#include <linux/tty_driver.h>
Linus Torvalds1da177e2005-04-16 15:20:36 -070023#include <linux/console.h>
24#include <linux/init.h>
Randy Dunlapbfe8df32007-10-16 01:23:46 -070025#include <linux/jiffies.h>
26#include <linux/nmi.h>
Linus Torvalds1da177e2005-04-16 15:20:36 -070027#include <linux/module.h>
Jan Engelhardt3b9c0412006-06-25 05:48:15 -070028#include <linux/moduleparam.h>
Linus Torvalds1da177e2005-04-16 15:20:36 -070029#include <linux/interrupt.h> /* For in_interrupt() */
Linus Torvalds1da177e2005-04-16 15:20:36 -070030#include <linux/delay.h>
31#include <linux/smp.h>
32#include <linux/security.h>
33#include <linux/bootmem.h>
Mike Travis162a7e72011-05-24 17:13:20 -070034#include <linux/memblock.h>
Linus Torvalds1da177e2005-04-16 15:20:36 -070035#include <linux/syscalls.h>
Neil Horman04d491a2009-04-02 16:58:57 -070036#include <linux/kexec.h>
Jason Wesseld37d39a2010-05-20 21:04:27 -050037#include <linux/kdb.h>
Ingo Molnar3fff4c42009-09-22 16:18:09 +020038#include <linux/ratelimit.h>
Simon Kagstrom456b5652009-10-16 14:09:18 +020039#include <linux/kmsg_dump.h>
Kees Cook00234592010-02-03 15:36:43 -080040#include <linux/syslog.h>
Kevin Cernekee034260d2010-06-03 22:11:25 -070041#include <linux/cpu.h>
42#include <linux/notifier.h>
Huang Yingfb842b02011-01-12 16:59:43 -080043#include <linux/rculist.h>
Kay Sieverse11fea92012-05-03 02:29:41 +020044#include <linux/poll.h>
Linus Torvalds1da177e2005-04-16 15:20:36 -070045
46#include <asm/uaccess.h>
47
Johannes Berg95100352011-11-24 20:03:08 +010048#define CREATE_TRACE_POINTS
49#include <trace/events/printk.h>
50
Ingo Molnar076f9772008-01-30 13:33:06 +010051/*
52 * Architectures can override it:
53 */
Jiri Slabye17ba732008-05-12 15:44:40 +020054void asmlinkage __attribute__((weak)) early_printk(const char *fmt, ...)
Ingo Molnar076f9772008-01-30 13:33:06 +010055{
56}
57
Linus Torvalds1da177e2005-04-16 15:20:36 -070058/* printk's without a loglevel use this.. */
Mandeep Singh Baines5af5bcb2011-03-22 16:34:23 -070059#define DEFAULT_MESSAGE_LOGLEVEL CONFIG_DEFAULT_MESSAGE_LOGLEVEL
Linus Torvalds1da177e2005-04-16 15:20:36 -070060
61/* We show everything that is MORE important than this.. */
62#define MINIMUM_CONSOLE_LOGLEVEL 1 /* Minimum loglevel we let people use */
63#define DEFAULT_CONSOLE_LOGLEVEL 7 /* anything MORE serious than KERN_DEBUG */
64
65DECLARE_WAIT_QUEUE_HEAD(log_wait);
66
67int console_printk[4] = {
68 DEFAULT_CONSOLE_LOGLEVEL, /* console_loglevel */
69 DEFAULT_MESSAGE_LOGLEVEL, /* default_message_loglevel */
70 MINIMUM_CONSOLE_LOGLEVEL, /* minimum_console_loglevel */
71 DEFAULT_CONSOLE_LOGLEVEL, /* default_console_loglevel */
72};
73
Linus Torvalds1da177e2005-04-16 15:20:36 -070074/*
Patrick Pletscher0bbfb7c2007-02-17 20:10:16 +010075 * Low level drivers may need that to know if they can schedule in
Linus Torvalds1da177e2005-04-16 15:20:36 -070076 * their unblank() callback or not. So let's export it.
77 */
78int oops_in_progress;
79EXPORT_SYMBOL(oops_in_progress);
80
81/*
82 * console_sem protects the console_drivers list, and also
83 * provides serialisation for access to the entire console
84 * driver system.
85 */
Thomas Gleixner5b8c4f22010-09-07 14:33:43 +000086static DEFINE_SEMAPHORE(console_sem);
Linus Torvalds1da177e2005-04-16 15:20:36 -070087struct console *console_drivers;
Ingo Molnara29d1cf2008-06-02 13:19:08 +020088EXPORT_SYMBOL_GPL(console_drivers);
89
Linus Torvalds1da177e2005-04-16 15:20:36 -070090/*
91 * This is used for debugging the mess that is the VT code by
92 * keeping track if we have the console semaphore held. It's
93 * definitely not the perfect debug tool (we don't know if _WE_
94 * hold it are racing, but it helps tracking those weird code
95 * path in the console code where we end up in places I want
96 * locked without the console sempahore held
97 */
Linus Torvalds557240b2006-06-19 18:16:01 -070098static int console_locked, console_suspended;
Linus Torvalds1da177e2005-04-16 15:20:36 -070099
100/*
Feng Tangfe3d8ad2011-03-22 16:34:21 -0700101 * If exclusive_console is non-NULL then only this console is to be printed to.
102 */
103static struct console *exclusive_console;
104
105/*
Linus Torvalds1da177e2005-04-16 15:20:36 -0700106 * Array of consoles built from command line options (console=)
107 */
108struct console_cmdline
109{
110 char name[8]; /* Name of the driver */
111 int index; /* Minor dev. to use */
112 char *options; /* Options for the driver */
Samuel Thibaultf7511d52008-04-30 00:54:51 -0700113#ifdef CONFIG_A11Y_BRAILLE_CONSOLE
114 char *brl_options; /* Options for braille driver */
115#endif
Linus Torvalds1da177e2005-04-16 15:20:36 -0700116};
117
118#define MAX_CMDLINECONSOLES 8
119
120static struct console_cmdline console_cmdline[MAX_CMDLINECONSOLES];
121static int selected_console = -1;
122static int preferred_console = -1;
Markus Armbruster9e124fe2008-05-26 23:31:07 +0100123int console_set_on_cmdline;
124EXPORT_SYMBOL(console_set_on_cmdline);
Linus Torvalds1da177e2005-04-16 15:20:36 -0700125
126/* Flag: console code may call schedule() */
127static int console_may_schedule;
128
Kay Sievers7ff95542012-05-03 02:29:13 +0200129/*
130 * The printk log buffer consists of a chain of concatenated variable
131 * length records. Every record starts with a record header, containing
132 * the overall length of the record.
133 *
134 * The heads to the first and last entry in the buffer, as well as the
135 * sequence numbers of these both entries are maintained when messages
136 * are stored..
137 *
138 * If the heads indicate available messages, the length in the header
139 * tells the start next message. A length == 0 for the next message
140 * indicates a wrap-around to the beginning of the buffer.
141 *
142 * Every record carries the monotonic timestamp in microseconds, as well as
143 * the standard userspace syslog level and syslog facility. The usual
144 * kernel messages use LOG_KERN; userspace-injected messages always carry
145 * a matching syslog facility, by default LOG_USER. The origin of every
146 * message can be reliably determined that way.
147 *
148 * The human readable log message directly follows the message header. The
149 * length of the message text is stored in the header, the stored message
150 * is not terminated.
151 *
Kay Sieverse11fea92012-05-03 02:29:41 +0200152 * Optionally, a message can carry a dictionary of properties (key/value pairs),
153 * to provide userspace with a machine-readable message context.
154 *
155 * Examples for well-defined, commonly used property names are:
156 * DEVICE=b12:8 device identifier
157 * b12:8 block dev_t
158 * c127:3 char dev_t
159 * n8 netdev ifindex
160 * +sound:card0 subsystem:devname
161 * SUBSYSTEM=pci driver-core subsystem name
162 *
163 * Valid characters in property names are [a-zA-Z0-9.-_]. The plain text value
164 * follows directly after a '=' character. Every property is terminated by
165 * a '\0' character. The last property is not terminated.
166 *
167 * Example of a message structure:
168 * 0000 ff 8f 00 00 00 00 00 00 monotonic time in nsec
169 * 0008 34 00 record is 52 bytes long
170 * 000a 0b 00 text is 11 bytes long
171 * 000c 1f 00 dictionary is 23 bytes long
172 * 000e 03 00 LOG_KERN (facility) LOG_ERR (level)
173 * 0010 69 74 27 73 20 61 20 6c "it's a l"
174 * 69 6e 65 "ine"
175 * 001b 44 45 56 49 43 "DEVIC"
176 * 45 3d 62 38 3a 32 00 44 "E=b8:2\0D"
177 * 52 49 56 45 52 3d 62 75 "RIVER=bu"
178 * 67 "g"
179 * 0032 00 00 00 padding to next message header
180 *
181 * The 'struct log' buffer header must never be directly exported to
182 * userspace, it is a kernel-private implementation detail that might
183 * need to be changed in the future, when the requirements change.
184 *
185 * /dev/kmsg exports the structured data in the following line format:
186 * "level,sequnum,timestamp;<message text>\n"
187 *
188 * The optional key/value pairs are attached as continuation lines starting
189 * with a space character and terminated by a newline. All possible
190 * non-prinatable characters are escaped in the "\xff" notation.
191 *
192 * Users of the export format should ignore possible additional values
193 * separated by ',', and find the message after the ';' character.
Kay Sievers7ff95542012-05-03 02:29:13 +0200194 */
Matt Mackalld59745c2005-05-01 08:59:02 -0700195
Kay Sievers084681d2012-06-28 09:38:53 +0200196enum log_flags {
Kay Sievers5becfb12012-07-09 12:15:42 -0700197 LOG_NOCONS = 1, /* already flushed, do not print to console */
198 LOG_NEWLINE = 2, /* text ended with a newline */
199 LOG_PREFIX = 4, /* text started with a prefix */
200 LOG_CONT = 8, /* text is a fragment of a continuation line */
Kay Sievers084681d2012-06-28 09:38:53 +0200201};
202
Kay Sievers7ff95542012-05-03 02:29:13 +0200203struct log {
204 u64 ts_nsec; /* timestamp in nanoseconds */
205 u16 len; /* length of entire record */
206 u16 text_len; /* length of text buffer */
207 u16 dict_len; /* length of dictionary buffer */
Kay Sievers084681d2012-06-28 09:38:53 +0200208 u8 facility; /* syslog facility */
209 u8 flags:5; /* internal record flags */
210 u8 level:3; /* syslog level */
Kay Sievers7ff95542012-05-03 02:29:13 +0200211};
212
213/*
214 * The logbuf_lock protects kmsg buffer, indices, counters. It is also
215 * used in interesting ways to provide interlocking in console_unlock();
216 */
217static DEFINE_RAW_SPINLOCK(logbuf_lock);
218
Kay Sievers96efedf2012-07-16 18:35:29 -0700219#ifdef CONFIG_PRINTK
Kay Sievers7f3a7812012-05-09 01:37:51 +0200220/* the next printk record to read by syslog(READ) or /proc/kmsg */
221static u64 syslog_seq;
222static u32 syslog_idx;
Kay Sievers5becfb12012-07-09 12:15:42 -0700223static enum log_flags syslog_prev;
Kay Sieverseb02dac2012-07-09 10:05:10 -0700224static size_t syslog_partial;
Kay Sievers7f3a7812012-05-09 01:37:51 +0200225
226/* index and sequence number of the first record stored in the buffer */
227static u64 log_first_seq;
228static u32 log_first_idx;
229
230/* index and sequence number of the next record to store in the buffer */
231static u64 log_next_seq;
Kay Sievers7f3a7812012-05-09 01:37:51 +0200232static u32 log_next_idx;
233
Kay Sieverseab07262012-07-16 18:35:30 -0700234/* the next printk record to write to the console */
235static u64 console_seq;
236static u32 console_idx;
237static enum log_flags console_prev;
238
Kay Sievers7f3a7812012-05-09 01:37:51 +0200239/* the next printk record to read after the last 'clear' command */
240static u64 clear_seq;
241static u32 clear_idx;
Kay Sievers7ff95542012-05-03 02:29:13 +0200242
Kay Sievers70498252012-07-16 18:35:29 -0700243#define PREFIX_MAX 32
244#define LOG_LINE_MAX 1024 - PREFIX_MAX
Kay Sievers7ff95542012-05-03 02:29:13 +0200245
246/* record buffer */
Andrew Lunn6ebb0172012-06-05 08:52:34 +0200247#if defined(CONFIG_HAVE_EFFICIENT_UNALIGNED_ACCESS)
Stephen Warrenf8450fc2012-05-10 16:14:33 -0600248#define LOG_ALIGN 4
249#else
Andrew Lunn6ebb0172012-06-05 08:52:34 +0200250#define LOG_ALIGN __alignof__(struct log)
Stephen Warrenf8450fc2012-05-10 16:14:33 -0600251#endif
Kay Sievers7ff95542012-05-03 02:29:13 +0200252#define __LOG_BUF_LEN (1 << CONFIG_LOG_BUF_SHIFT)
Stephen Warrenf8450fc2012-05-10 16:14:33 -0600253static char __log_buf[__LOG_BUF_LEN] __aligned(LOG_ALIGN);
Matt Mackalld59745c2005-05-01 08:59:02 -0700254static char *log_buf = __log_buf;
Kay Sievers7ff95542012-05-03 02:29:13 +0200255static u32 log_buf_len = __LOG_BUF_LEN;
256
Kay Sievers7f3a7812012-05-09 01:37:51 +0200257/* cpu currently holding logbuf_lock */
258static volatile unsigned int logbuf_cpu = UINT_MAX;
Kay Sievers7ff95542012-05-03 02:29:13 +0200259
260/* human readable text of the record */
261static char *log_text(const struct log *msg)
262{
263 return (char *)msg + sizeof(struct log);
264}
265
266/* optional key/value pair dictionary attached to the record */
267static char *log_dict(const struct log *msg)
268{
269 return (char *)msg + sizeof(struct log) + msg->text_len;
270}
271
272/* get record by index; idx must point to valid msg */
273static struct log *log_from_idx(u32 idx)
274{
275 struct log *msg = (struct log *)(log_buf + idx);
276
277 /*
278 * A length == 0 record is the end of buffer marker. Wrap around and
279 * read the message at the start of the buffer.
280 */
281 if (!msg->len)
282 return (struct log *)log_buf;
283 return msg;
284}
285
286/* get next record; idx must point to valid msg */
287static u32 log_next(u32 idx)
288{
289 struct log *msg = (struct log *)(log_buf + idx);
290
291 /* length == 0 indicates the end of the buffer; wrap */
292 /*
293 * A length == 0 record is the end of buffer marker. Wrap around and
294 * read the message at the start of the buffer as *this* one, and
295 * return the one after that.
296 */
297 if (!msg->len) {
298 msg = (struct log *)log_buf;
299 return msg->len;
300 }
301 return idx + msg->len;
302}
303
Kay Sievers7ff95542012-05-03 02:29:13 +0200304/* insert record into the buffer, discard old ones, update heads */
305static void log_store(int facility, int level,
Kay Sievers084681d2012-06-28 09:38:53 +0200306 enum log_flags flags, u64 ts_nsec,
Kay Sievers7ff95542012-05-03 02:29:13 +0200307 const char *dict, u16 dict_len,
308 const char *text, u16 text_len)
309{
310 struct log *msg;
311 u32 size, pad_len;
312
313 /* number of '\0' padding bytes to next message */
314 size = sizeof(struct log) + text_len + dict_len;
315 pad_len = (-size) & (LOG_ALIGN - 1);
316 size += pad_len;
317
318 while (log_first_seq < log_next_seq) {
319 u32 free;
320
321 if (log_next_idx > log_first_idx)
322 free = max(log_buf_len - log_next_idx, log_first_idx);
323 else
324 free = log_first_idx - log_next_idx;
325
326 if (free > size + sizeof(struct log))
327 break;
328
329 /* drop old messages until we have enough contiuous space */
330 log_first_idx = log_next(log_first_idx);
331 log_first_seq++;
332 }
333
334 if (log_next_idx + size + sizeof(struct log) >= log_buf_len) {
335 /*
336 * This message + an additional empty header does not fit
337 * at the end of the buffer. Add an empty header with len == 0
338 * to signify a wrap around.
339 */
340 memset(log_buf + log_next_idx, 0, sizeof(struct log));
341 log_next_idx = 0;
342 }
343
344 /* fill message */
345 msg = (struct log *)(log_buf + log_next_idx);
346 memcpy(log_text(msg), text, text_len);
347 msg->text_len = text_len;
348 memcpy(log_dict(msg), dict, dict_len);
349 msg->dict_len = dict_len;
Kay Sievers084681d2012-06-28 09:38:53 +0200350 msg->facility = facility;
351 msg->level = level & 7;
352 msg->flags = flags & 0x1f;
353 if (ts_nsec > 0)
354 msg->ts_nsec = ts_nsec;
355 else
356 msg->ts_nsec = local_clock();
Kay Sievers7ff95542012-05-03 02:29:13 +0200357 memset(log_dict(msg) + dict_len, 0, pad_len);
358 msg->len = sizeof(struct log) + text_len + dict_len + pad_len;
359
360 /* insert message */
361 log_next_idx += msg->len;
362 log_next_seq++;
363}
Matt Mackalld59745c2005-05-01 08:59:02 -0700364
Kay Sieverse11fea92012-05-03 02:29:41 +0200365/* /dev/kmsg - userspace message inject/listen interface */
366struct devkmsg_user {
367 u64 seq;
368 u32 idx;
Kay Sieversd39f3d72012-07-16 18:35:30 -0700369 enum log_flags prev;
Kay Sieverse11fea92012-05-03 02:29:41 +0200370 struct mutex lock;
371 char buf[8192];
372};
373
374static ssize_t devkmsg_writev(struct kiocb *iocb, const struct iovec *iv,
375 unsigned long count, loff_t pos)
376{
377 char *buf, *line;
378 int i;
379 int level = default_message_loglevel;
380 int facility = 1; /* LOG_USER */
381 size_t len = iov_length(iv, count);
382 ssize_t ret = len;
383
384 if (len > LOG_LINE_MAX)
385 return -EINVAL;
386 buf = kmalloc(len+1, GFP_KERNEL);
387 if (buf == NULL)
388 return -ENOMEM;
389
390 line = buf;
391 for (i = 0; i < count; i++) {
392 if (copy_from_user(line, iv[i].iov_base, iv[i].iov_len))
393 goto out;
394 line += iv[i].iov_len;
395 }
396
397 /*
398 * Extract and skip the syslog prefix <[0-9]*>. Coming from userspace
399 * the decimal value represents 32bit, the lower 3 bit are the log
400 * level, the rest are the log facility.
401 *
402 * If no prefix or no userspace facility is specified, we
403 * enforce LOG_USER, to be able to reliably distinguish
404 * kernel-generated messages from userspace-injected ones.
405 */
406 line = buf;
407 if (line[0] == '<') {
408 char *endp = NULL;
409
410 i = simple_strtoul(line+1, &endp, 10);
411 if (endp && endp[0] == '>') {
412 level = i & 7;
413 if (i >> 3)
414 facility = i >> 3;
415 endp++;
416 len -= endp - line;
417 line = endp;
418 }
419 }
420 line[len] = '\0';
421
422 printk_emit(facility, level, NULL, 0, "%s", line);
423out:
424 kfree(buf);
425 return ret;
426}
427
428static ssize_t devkmsg_read(struct file *file, char __user *buf,
429 size_t count, loff_t *ppos)
430{
431 struct devkmsg_user *user = file->private_data;
432 struct log *msg;
Kay Sievers5fc324902012-05-08 13:04:17 +0200433 u64 ts_usec;
Kay Sieverse11fea92012-05-03 02:29:41 +0200434 size_t i;
Kay Sieversd39f3d72012-07-16 18:35:30 -0700435 char cont = '-';
Kay Sieverse11fea92012-05-03 02:29:41 +0200436 size_t len;
437 ssize_t ret;
438
439 if (!user)
440 return -EBADF;
441
Yuanhan Liu4a77a5a2012-06-16 21:21:51 +0800442 ret = mutex_lock_interruptible(&user->lock);
443 if (ret)
444 return ret;
liu chuansheng5c53d812012-07-06 09:50:08 -0700445 raw_spin_lock_irq(&logbuf_lock);
Kay Sieverse11fea92012-05-03 02:29:41 +0200446 while (user->seq == log_next_seq) {
447 if (file->f_flags & O_NONBLOCK) {
448 ret = -EAGAIN;
liu chuansheng5c53d812012-07-06 09:50:08 -0700449 raw_spin_unlock_irq(&logbuf_lock);
Kay Sieverse11fea92012-05-03 02:29:41 +0200450 goto out;
451 }
452
liu chuansheng5c53d812012-07-06 09:50:08 -0700453 raw_spin_unlock_irq(&logbuf_lock);
Kay Sieverse11fea92012-05-03 02:29:41 +0200454 ret = wait_event_interruptible(log_wait,
455 user->seq != log_next_seq);
456 if (ret)
457 goto out;
liu chuansheng5c53d812012-07-06 09:50:08 -0700458 raw_spin_lock_irq(&logbuf_lock);
Kay Sieverse11fea92012-05-03 02:29:41 +0200459 }
460
461 if (user->seq < log_first_seq) {
462 /* our last seen message is gone, return error and reset */
463 user->idx = log_first_idx;
464 user->seq = log_first_seq;
465 ret = -EPIPE;
liu chuansheng5c53d812012-07-06 09:50:08 -0700466 raw_spin_unlock_irq(&logbuf_lock);
Kay Sieverse11fea92012-05-03 02:29:41 +0200467 goto out;
468 }
469
470 msg = log_from_idx(user->idx);
Kay Sievers5fc324902012-05-08 13:04:17 +0200471 ts_usec = msg->ts_nsec;
472 do_div(ts_usec, 1000);
Kay Sieversd39f3d72012-07-16 18:35:30 -0700473
474 /*
475 * If we couldn't merge continuation line fragments during the print,
476 * export the stored flags to allow an optional external merge of the
477 * records. Merging the records isn't always neccessarily correct, like
478 * when we hit a race during printing. In most cases though, it produces
479 * better readable output. 'c' in the record flags mark the first
480 * fragment of a line, '+' the following.
481 */
482 if (msg->flags & LOG_CONT && !(user->prev & LOG_CONT))
483 cont = 'c';
484 else if ((msg->flags & LOG_CONT) ||
485 ((user->prev & LOG_CONT) && !(msg->flags & LOG_PREFIX)))
486 cont = '+';
487
488 len = sprintf(user->buf, "%u,%llu,%llu,%c;",
489 (msg->facility << 3) | msg->level,
490 user->seq, ts_usec, cont);
491 user->prev = msg->flags;
Kay Sieverse11fea92012-05-03 02:29:41 +0200492
493 /* escape non-printable characters */
494 for (i = 0; i < msg->text_len; i++) {
Kay Sievers3ce9a7c2012-05-13 23:30:46 +0200495 unsigned char c = log_text(msg)[i];
Kay Sieverse11fea92012-05-03 02:29:41 +0200496
Kay Sieverse3f5a5f2012-07-06 09:50:09 -0700497 if (c < ' ' || c >= 127 || c == '\\')
Kay Sieverse11fea92012-05-03 02:29:41 +0200498 len += sprintf(user->buf + len, "\\x%02x", c);
499 else
500 user->buf[len++] = c;
501 }
502 user->buf[len++] = '\n';
503
504 if (msg->dict_len) {
505 bool line = true;
506
507 for (i = 0; i < msg->dict_len; i++) {
Kay Sievers3ce9a7c2012-05-13 23:30:46 +0200508 unsigned char c = log_dict(msg)[i];
Kay Sieverse11fea92012-05-03 02:29:41 +0200509
510 if (line) {
511 user->buf[len++] = ' ';
512 line = false;
513 }
514
515 if (c == '\0') {
516 user->buf[len++] = '\n';
517 line = true;
518 continue;
519 }
520
Kay Sieverse3f5a5f2012-07-06 09:50:09 -0700521 if (c < ' ' || c >= 127 || c == '\\') {
Kay Sieverse11fea92012-05-03 02:29:41 +0200522 len += sprintf(user->buf + len, "\\x%02x", c);
523 continue;
524 }
525
526 user->buf[len++] = c;
527 }
528 user->buf[len++] = '\n';
529 }
530
531 user->idx = log_next(user->idx);
532 user->seq++;
liu chuansheng5c53d812012-07-06 09:50:08 -0700533 raw_spin_unlock_irq(&logbuf_lock);
Kay Sieverse11fea92012-05-03 02:29:41 +0200534
535 if (len > count) {
536 ret = -EINVAL;
537 goto out;
538 }
539
540 if (copy_to_user(buf, user->buf, len)) {
541 ret = -EFAULT;
542 goto out;
543 }
544 ret = len;
545out:
546 mutex_unlock(&user->lock);
547 return ret;
548}
549
550static loff_t devkmsg_llseek(struct file *file, loff_t offset, int whence)
551{
552 struct devkmsg_user *user = file->private_data;
553 loff_t ret = 0;
554
555 if (!user)
556 return -EBADF;
557 if (offset)
558 return -ESPIPE;
559
liu chuansheng5c53d812012-07-06 09:50:08 -0700560 raw_spin_lock_irq(&logbuf_lock);
Kay Sieverse11fea92012-05-03 02:29:41 +0200561 switch (whence) {
562 case SEEK_SET:
563 /* the first record */
564 user->idx = log_first_idx;
565 user->seq = log_first_seq;
566 break;
567 case SEEK_DATA:
568 /*
569 * The first record after the last SYSLOG_ACTION_CLEAR,
570 * like issued by 'dmesg -c'. Reading /dev/kmsg itself
571 * changes no global state, and does not clear anything.
572 */
573 user->idx = clear_idx;
574 user->seq = clear_seq;
575 break;
576 case SEEK_END:
577 /* after the last record */
578 user->idx = log_next_idx;
579 user->seq = log_next_seq;
580 break;
581 default:
582 ret = -EINVAL;
583 }
liu chuansheng5c53d812012-07-06 09:50:08 -0700584 raw_spin_unlock_irq(&logbuf_lock);
Kay Sieverse11fea92012-05-03 02:29:41 +0200585 return ret;
586}
587
588static unsigned int devkmsg_poll(struct file *file, poll_table *wait)
589{
590 struct devkmsg_user *user = file->private_data;
591 int ret = 0;
592
593 if (!user)
594 return POLLERR|POLLNVAL;
595
596 poll_wait(file, &log_wait, wait);
597
liu chuansheng5c53d812012-07-06 09:50:08 -0700598 raw_spin_lock_irq(&logbuf_lock);
Kay Sieverse11fea92012-05-03 02:29:41 +0200599 if (user->seq < log_next_seq) {
600 /* return error when data has vanished underneath us */
601 if (user->seq < log_first_seq)
602 ret = POLLIN|POLLRDNORM|POLLERR|POLLPRI;
603 ret = POLLIN|POLLRDNORM;
604 }
liu chuansheng5c53d812012-07-06 09:50:08 -0700605 raw_spin_unlock_irq(&logbuf_lock);
Kay Sieverse11fea92012-05-03 02:29:41 +0200606
607 return ret;
608}
609
610static int devkmsg_open(struct inode *inode, struct file *file)
611{
612 struct devkmsg_user *user;
613 int err;
614
615 /* write-only does not need any file context */
616 if ((file->f_flags & O_ACCMODE) == O_WRONLY)
617 return 0;
618
619 err = security_syslog(SYSLOG_ACTION_READ_ALL);
620 if (err)
621 return err;
622
623 user = kmalloc(sizeof(struct devkmsg_user), GFP_KERNEL);
624 if (!user)
625 return -ENOMEM;
626
627 mutex_init(&user->lock);
628
liu chuansheng5c53d812012-07-06 09:50:08 -0700629 raw_spin_lock_irq(&logbuf_lock);
Kay Sieverse11fea92012-05-03 02:29:41 +0200630 user->idx = log_first_idx;
631 user->seq = log_first_seq;
liu chuansheng5c53d812012-07-06 09:50:08 -0700632 raw_spin_unlock_irq(&logbuf_lock);
Kay Sieverse11fea92012-05-03 02:29:41 +0200633
634 file->private_data = user;
635 return 0;
636}
637
638static int devkmsg_release(struct inode *inode, struct file *file)
639{
640 struct devkmsg_user *user = file->private_data;
641
642 if (!user)
643 return 0;
644
645 mutex_destroy(&user->lock);
646 kfree(user);
647 return 0;
648}
649
650const struct file_operations kmsg_fops = {
651 .open = devkmsg_open,
652 .read = devkmsg_read,
653 .aio_write = devkmsg_writev,
654 .llseek = devkmsg_llseek,
655 .poll = devkmsg_poll,
656 .release = devkmsg_release,
657};
658
Neil Horman04d491a2009-04-02 16:58:57 -0700659#ifdef CONFIG_KEXEC
660/*
661 * This appends the listed symbols to /proc/vmcoreinfo
662 *
663 * /proc/vmcoreinfo is used by various utiilties, like crash and makedumpfile to
664 * obtain access to symbols that are otherwise very difficult to locate. These
665 * symbols are specifically used so that utilities can access and extract the
666 * dmesg log from a vmcore file after a crash.
667 */
668void log_buf_kexec_setup(void)
669{
670 VMCOREINFO_SYMBOL(log_buf);
Neil Horman04d491a2009-04-02 16:58:57 -0700671 VMCOREINFO_SYMBOL(log_buf_len);
Kay Sievers7ff95542012-05-03 02:29:13 +0200672 VMCOREINFO_SYMBOL(log_first_idx);
673 VMCOREINFO_SYMBOL(log_next_idx);
Vivek Goyal67914572012-07-18 13:18:12 -0400674 /*
675 * Export struct log size and field offsets. User space tools can
676 * parse it and detect any changes to structure down the line.
677 */
678 VMCOREINFO_STRUCT_SIZE(log);
679 VMCOREINFO_OFFSET(log, ts_nsec);
680 VMCOREINFO_OFFSET(log, len);
681 VMCOREINFO_OFFSET(log, text_len);
682 VMCOREINFO_OFFSET(log, dict_len);
Neil Horman04d491a2009-04-02 16:58:57 -0700683}
684#endif
685
Mike Travis162a7e72011-05-24 17:13:20 -0700686/* requested log_buf_len from kernel cmdline */
687static unsigned long __initdata new_log_buf_len;
688
689/* save requested log_buf_len since it's too early to process it */
Linus Torvalds1da177e2005-04-16 15:20:36 -0700690static int __init log_buf_len_setup(char *str)
691{
Denys Vlasenkoeed4a2a2008-02-06 01:37:02 -0800692 unsigned size = memparse(str, &str);
Linus Torvalds1da177e2005-04-16 15:20:36 -0700693
694 if (size)
695 size = roundup_pow_of_two(size);
Mike Travis162a7e72011-05-24 17:13:20 -0700696 if (size > log_buf_len)
697 new_log_buf_len = size;
Linus Torvalds1da177e2005-04-16 15:20:36 -0700698
Mike Travis162a7e72011-05-24 17:13:20 -0700699 return 0;
Linus Torvalds1da177e2005-04-16 15:20:36 -0700700}
Mike Travis162a7e72011-05-24 17:13:20 -0700701early_param("log_buf_len", log_buf_len_setup);
Linus Torvalds1da177e2005-04-16 15:20:36 -0700702
Mike Travis162a7e72011-05-24 17:13:20 -0700703void __init setup_log_buf(int early)
704{
705 unsigned long flags;
Mike Travis162a7e72011-05-24 17:13:20 -0700706 char *new_log_buf;
707 int free;
708
709 if (!new_log_buf_len)
710 return;
711
712 if (early) {
713 unsigned long mem;
714
715 mem = memblock_alloc(new_log_buf_len, PAGE_SIZE);
Tejun Heo1f5026a2011-07-12 09:58:09 +0200716 if (!mem)
Mike Travis162a7e72011-05-24 17:13:20 -0700717 return;
718 new_log_buf = __va(mem);
719 } else {
720 new_log_buf = alloc_bootmem_nopanic(new_log_buf_len);
721 }
722
723 if (unlikely(!new_log_buf)) {
724 pr_err("log_buf_len: %ld bytes not available\n",
725 new_log_buf_len);
726 return;
727 }
728
Thomas Gleixner07354eb2009-07-25 17:50:36 +0200729 raw_spin_lock_irqsave(&logbuf_lock, flags);
Mike Travis162a7e72011-05-24 17:13:20 -0700730 log_buf_len = new_log_buf_len;
731 log_buf = new_log_buf;
732 new_log_buf_len = 0;
Kay Sievers7ff95542012-05-03 02:29:13 +0200733 free = __LOG_BUF_LEN - log_next_idx;
734 memcpy(log_buf, __log_buf, __LOG_BUF_LEN);
Thomas Gleixner07354eb2009-07-25 17:50:36 +0200735 raw_spin_unlock_irqrestore(&logbuf_lock, flags);
Mike Travis162a7e72011-05-24 17:13:20 -0700736
737 pr_info("log_buf_len: %d\n", log_buf_len);
738 pr_info("early log buf free: %d(%d%%)\n",
739 free, (free * 100) / __LOG_BUF_LEN);
740}
Linus Torvalds1da177e2005-04-16 15:20:36 -0700741
Randy Dunlapbfe8df32007-10-16 01:23:46 -0700742#ifdef CONFIG_BOOT_PRINTK_DELAY
743
Namhyung Kim674dff62010-10-26 14:22:48 -0700744static int boot_delay; /* msecs delay after each printk during bootup */
Dave Young3a3b6ed2009-09-22 16:43:31 -0700745static unsigned long long loops_per_msec; /* based on boot_delay */
Randy Dunlapbfe8df32007-10-16 01:23:46 -0700746
747static int __init boot_delay_setup(char *str)
748{
749 unsigned long lpj;
Randy Dunlapbfe8df32007-10-16 01:23:46 -0700750
751 lpj = preset_lpj ? preset_lpj : 1000000; /* some guess */
752 loops_per_msec = (unsigned long long)lpj / 1000 * HZ;
753
754 get_option(&str, &boot_delay);
755 if (boot_delay > 10 * 1000)
756 boot_delay = 0;
757
Dave Young3a3b6ed2009-09-22 16:43:31 -0700758 pr_debug("boot_delay: %u, preset_lpj: %ld, lpj: %lu, "
759 "HZ: %d, loops_per_msec: %llu\n",
760 boot_delay, preset_lpj, lpj, HZ, loops_per_msec);
Randy Dunlapbfe8df32007-10-16 01:23:46 -0700761 return 1;
762}
763__setup("boot_delay=", boot_delay_setup);
764
765static void boot_delay_msec(void)
766{
767 unsigned long long k;
768 unsigned long timeout;
769
770 if (boot_delay == 0 || system_state != SYSTEM_BOOTING)
771 return;
772
Dave Young3a3b6ed2009-09-22 16:43:31 -0700773 k = (unsigned long long)loops_per_msec * boot_delay;
Randy Dunlapbfe8df32007-10-16 01:23:46 -0700774
775 timeout = jiffies + msecs_to_jiffies(boot_delay);
776 while (k) {
777 k--;
778 cpu_relax();
779 /*
780 * use (volatile) jiffies to prevent
781 * compiler reduction; loop termination via jiffies
782 * is secondary and may or may not happen.
783 */
784 if (time_after(jiffies, timeout))
785 break;
786 touch_nmi_watchdog();
787 }
788}
789#else
790static inline void boot_delay_msec(void)
791{
792}
793#endif
794
Dan Rosenbergeaf06b22010-11-11 14:05:18 -0800795#ifdef CONFIG_SECURITY_DMESG_RESTRICT
796int dmesg_restrict = 1;
797#else
798int dmesg_restrict;
799#endif
800
Linus Torvaldsee24aeb2011-02-10 17:53:55 -0800801static int syslog_action_restricted(int type)
802{
803 if (dmesg_restrict)
804 return 1;
805 /* Unless restricted, we allow "read all" and "get buffer size" for everybody */
806 return type != SYSLOG_ACTION_READ_ALL && type != SYSLOG_ACTION_SIZE_BUFFER;
807}
808
809static int check_syslog_permissions(int type, bool from_file)
810{
811 /*
812 * If this is from /proc/kmsg and we've already opened it, then we've
813 * already done the capabilities checks at open time.
814 */
815 if (from_file && type != SYSLOG_ACTION_OPEN)
816 return 0;
817
818 if (syslog_action_restricted(type)) {
819 if (capable(CAP_SYSLOG))
820 return 0;
821 /* For historical reasons, accept CAP_SYS_ADMIN too, with a warning */
822 if (capable(CAP_SYS_ADMIN)) {
Jonathan Niederf2c0d022011-08-08 06:22:43 +0200823 printk_once(KERN_WARNING "%s (%d): "
824 "Attempt to access syslog with CAP_SYS_ADMIN "
825 "but no CAP_SYSLOG (deprecated).\n",
826 current->comm, task_pid_nr(current));
Linus Torvaldsee24aeb2011-02-10 17:53:55 -0800827 return 0;
828 }
829 return -EPERM;
830 }
831 return 0;
832}
833
Kay Sievers7ff95542012-05-03 02:29:13 +0200834#if defined(CONFIG_PRINTK_TIME)
835static bool printk_time = 1;
836#else
837static bool printk_time;
838#endif
839module_param_named(time, printk_time, bool, S_IRUGO | S_IWUSR);
840
Kay Sievers084681d2012-06-28 09:38:53 +0200841static size_t print_time(u64 ts, char *buf)
842{
843 unsigned long rem_nsec;
844
845 if (!printk_time)
846 return 0;
847
848 if (!buf)
849 return 15;
850
851 rem_nsec = do_div(ts, 1000000000);
852 return sprintf(buf, "[%5lu.%06lu] ",
853 (unsigned long)ts, rem_nsec / 1000);
854}
855
Kay Sievers3ce9a7c2012-05-13 23:30:46 +0200856static size_t print_prefix(const struct log *msg, bool syslog, char *buf)
Kay Sievers649e6ee2012-05-10 04:30:45 +0200857{
Kay Sievers3ce9a7c2012-05-13 23:30:46 +0200858 size_t len = 0;
Kay Sievers43a73a52012-07-06 09:50:09 -0700859 unsigned int prefix = (msg->facility << 3) | msg->level;
Kay Sievers649e6ee2012-05-10 04:30:45 +0200860
Kay Sievers3ce9a7c2012-05-13 23:30:46 +0200861 if (syslog) {
862 if (buf) {
Kay Sievers43a73a52012-07-06 09:50:09 -0700863 len += sprintf(buf, "<%u>", prefix);
Kay Sievers3ce9a7c2012-05-13 23:30:46 +0200864 } else {
865 len += 3;
Kay Sievers43a73a52012-07-06 09:50:09 -0700866 if (prefix > 999)
867 len += 3;
868 else if (prefix > 99)
869 len += 2;
870 else if (prefix > 9)
Kay Sievers3ce9a7c2012-05-13 23:30:46 +0200871 len++;
872 }
Kay Sievers7ff95542012-05-03 02:29:13 +0200873 }
874
Kay Sievers084681d2012-06-28 09:38:53 +0200875 len += print_time(msg->ts_nsec, buf ? buf + len : NULL);
Kay Sievers3ce9a7c2012-05-13 23:30:46 +0200876 return len;
877}
878
Kay Sievers5becfb12012-07-09 12:15:42 -0700879static size_t msg_print_text(const struct log *msg, enum log_flags prev,
880 bool syslog, char *buf, size_t size)
Kay Sievers3ce9a7c2012-05-13 23:30:46 +0200881{
882 const char *text = log_text(msg);
883 size_t text_size = msg->text_len;
Kay Sievers5becfb12012-07-09 12:15:42 -0700884 bool prefix = true;
885 bool newline = true;
Kay Sievers3ce9a7c2012-05-13 23:30:46 +0200886 size_t len = 0;
887
Kay Sievers5becfb12012-07-09 12:15:42 -0700888 if ((prev & LOG_CONT) && !(msg->flags & LOG_PREFIX))
889 prefix = false;
890
891 if (msg->flags & LOG_CONT) {
892 if ((prev & LOG_CONT) && !(prev & LOG_NEWLINE))
893 prefix = false;
894
895 if (!(msg->flags & LOG_NEWLINE))
896 newline = false;
897 }
898
Kay Sievers3ce9a7c2012-05-13 23:30:46 +0200899 do {
900 const char *next = memchr(text, '\n', text_size);
901 size_t text_len;
902
903 if (next) {
904 text_len = next - text;
905 next++;
906 text_size -= next - text;
907 } else {
908 text_len = text_size;
909 }
910
911 if (buf) {
912 if (print_prefix(msg, syslog, NULL) +
Kay Sievers70498252012-07-16 18:35:29 -0700913 text_len + 1 >= size - len)
Kay Sievers3ce9a7c2012-05-13 23:30:46 +0200914 break;
915
Kay Sievers5becfb12012-07-09 12:15:42 -0700916 if (prefix)
917 len += print_prefix(msg, syslog, buf + len);
Kay Sievers3ce9a7c2012-05-13 23:30:46 +0200918 memcpy(buf + len, text, text_len);
919 len += text_len;
Kay Sievers5becfb12012-07-09 12:15:42 -0700920 if (next || newline)
921 buf[len++] = '\n';
Kay Sievers3ce9a7c2012-05-13 23:30:46 +0200922 } else {
923 /* SYSLOG_ACTION_* buffer size only calculation */
Kay Sievers5becfb12012-07-09 12:15:42 -0700924 if (prefix)
925 len += print_prefix(msg, syslog, NULL);
926 len += text_len;
927 if (next || newline)
928 len++;
Kay Sievers3ce9a7c2012-05-13 23:30:46 +0200929 }
930
Kay Sievers5becfb12012-07-09 12:15:42 -0700931 prefix = true;
Kay Sievers3ce9a7c2012-05-13 23:30:46 +0200932 text = next;
933 } while (text);
934
Kay Sievers7ff95542012-05-03 02:29:13 +0200935 return len;
936}
937
938static int syslog_print(char __user *buf, int size)
939{
940 char *text;
Kay Sievers3ce9a7c2012-05-13 23:30:46 +0200941 struct log *msg;
Jan Beulich116e90b2012-06-22 16:36:09 +0100942 int len = 0;
Kay Sievers7ff95542012-05-03 02:29:13 +0200943
Kay Sievers70498252012-07-16 18:35:29 -0700944 text = kmalloc(LOG_LINE_MAX + PREFIX_MAX, GFP_KERNEL);
Kay Sievers7ff95542012-05-03 02:29:13 +0200945 if (!text)
946 return -ENOMEM;
947
Jan Beulich116e90b2012-06-22 16:36:09 +0100948 while (size > 0) {
949 size_t n;
Kay Sieverseb02dac2012-07-09 10:05:10 -0700950 size_t skip;
Kay Sievers7ff95542012-05-03 02:29:13 +0200951
Jan Beulich116e90b2012-06-22 16:36:09 +0100952 raw_spin_lock_irq(&logbuf_lock);
953 if (syslog_seq < log_first_seq) {
954 /* messages are gone, move to first one */
955 syslog_seq = log_first_seq;
956 syslog_idx = log_first_idx;
Kay Sievers5becfb12012-07-09 12:15:42 -0700957 syslog_prev = 0;
Kay Sieverseb02dac2012-07-09 10:05:10 -0700958 syslog_partial = 0;
Jan Beulich116e90b2012-06-22 16:36:09 +0100959 }
960 if (syslog_seq == log_next_seq) {
961 raw_spin_unlock_irq(&logbuf_lock);
962 break;
963 }
Kay Sieverseb02dac2012-07-09 10:05:10 -0700964
965 skip = syslog_partial;
Jan Beulich116e90b2012-06-22 16:36:09 +0100966 msg = log_from_idx(syslog_idx);
Kay Sievers70498252012-07-16 18:35:29 -0700967 n = msg_print_text(msg, syslog_prev, true, text,
968 LOG_LINE_MAX + PREFIX_MAX);
Kay Sieverseb02dac2012-07-09 10:05:10 -0700969 if (n - syslog_partial <= size) {
970 /* message fits into buffer, move forward */
Jan Beulich116e90b2012-06-22 16:36:09 +0100971 syslog_idx = log_next(syslog_idx);
972 syslog_seq++;
Kay Sievers5becfb12012-07-09 12:15:42 -0700973 syslog_prev = msg->flags;
Kay Sieverseb02dac2012-07-09 10:05:10 -0700974 n -= syslog_partial;
975 syslog_partial = 0;
976 } else if (!len){
977 /* partial read(), remember position */
978 n = size;
979 syslog_partial += n;
Jan Beulich116e90b2012-06-22 16:36:09 +0100980 } else
981 n = 0;
982 raw_spin_unlock_irq(&logbuf_lock);
983
984 if (!n)
985 break;
986
Kay Sieverseb02dac2012-07-09 10:05:10 -0700987 if (copy_to_user(buf, text + skip, n)) {
Jan Beulich116e90b2012-06-22 16:36:09 +0100988 if (!len)
989 len = -EFAULT;
990 break;
991 }
Kay Sieverseb02dac2012-07-09 10:05:10 -0700992
993 len += n;
994 size -= n;
995 buf += n;
Jan Beulich116e90b2012-06-22 16:36:09 +0100996 }
Kay Sievers7ff95542012-05-03 02:29:13 +0200997
998 kfree(text);
999 return len;
1000}
1001
1002static int syslog_print_all(char __user *buf, int size, bool clear)
1003{
1004 char *text;
1005 int len = 0;
1006
Kay Sievers70498252012-07-16 18:35:29 -07001007 text = kmalloc(LOG_LINE_MAX + PREFIX_MAX, GFP_KERNEL);
Kay Sievers7ff95542012-05-03 02:29:13 +02001008 if (!text)
1009 return -ENOMEM;
1010
1011 raw_spin_lock_irq(&logbuf_lock);
1012 if (buf) {
1013 u64 next_seq;
1014 u64 seq;
1015 u32 idx;
Kay Sievers5becfb12012-07-09 12:15:42 -07001016 enum log_flags prev;
Kay Sievers7ff95542012-05-03 02:29:13 +02001017
1018 if (clear_seq < log_first_seq) {
1019 /* messages are gone, move to first available one */
1020 clear_seq = log_first_seq;
1021 clear_idx = log_first_idx;
1022 }
1023
1024 /*
1025 * Find first record that fits, including all following records,
1026 * into the user-provided buffer for this dump.
Kay Sieverse2ae7152012-06-15 14:07:51 +02001027 */
Kay Sievers7ff95542012-05-03 02:29:13 +02001028 seq = clear_seq;
1029 idx = clear_idx;
Kay Sievers5becfb12012-07-09 12:15:42 -07001030 prev = 0;
Kay Sievers7ff95542012-05-03 02:29:13 +02001031 while (seq < log_next_seq) {
Kay Sievers3ce9a7c2012-05-13 23:30:46 +02001032 struct log *msg = log_from_idx(idx);
1033
Kay Sievers5becfb12012-07-09 12:15:42 -07001034 len += msg_print_text(msg, prev, true, NULL, 0);
Kay Sievers7ff95542012-05-03 02:29:13 +02001035 idx = log_next(idx);
1036 seq++;
1037 }
Kay Sieverse2ae7152012-06-15 14:07:51 +02001038
1039 /* move first record forward until length fits into the buffer */
Kay Sievers7ff95542012-05-03 02:29:13 +02001040 seq = clear_seq;
1041 idx = clear_idx;
Kay Sievers5becfb12012-07-09 12:15:42 -07001042 prev = 0;
Kay Sievers7ff95542012-05-03 02:29:13 +02001043 while (len > size && seq < log_next_seq) {
Kay Sievers3ce9a7c2012-05-13 23:30:46 +02001044 struct log *msg = log_from_idx(idx);
1045
Kay Sievers5becfb12012-07-09 12:15:42 -07001046 len -= msg_print_text(msg, prev, true, NULL, 0);
Kay Sievers7ff95542012-05-03 02:29:13 +02001047 idx = log_next(idx);
1048 seq++;
1049 }
1050
Kay Sieverse2ae7152012-06-15 14:07:51 +02001051 /* last message fitting into this dump */
Kay Sievers7ff95542012-05-03 02:29:13 +02001052 next_seq = log_next_seq;
1053
1054 len = 0;
Kay Sievers5becfb12012-07-09 12:15:42 -07001055 prev = 0;
Kay Sievers7ff95542012-05-03 02:29:13 +02001056 while (len >= 0 && seq < next_seq) {
Kay Sievers3ce9a7c2012-05-13 23:30:46 +02001057 struct log *msg = log_from_idx(idx);
Kay Sievers7ff95542012-05-03 02:29:13 +02001058 int textlen;
1059
Kay Sievers70498252012-07-16 18:35:29 -07001060 textlen = msg_print_text(msg, prev, true, text,
1061 LOG_LINE_MAX + PREFIX_MAX);
Kay Sievers7ff95542012-05-03 02:29:13 +02001062 if (textlen < 0) {
1063 len = textlen;
1064 break;
1065 }
1066 idx = log_next(idx);
1067 seq++;
Kay Sievers5becfb12012-07-09 12:15:42 -07001068 prev = msg->flags;
Kay Sievers7ff95542012-05-03 02:29:13 +02001069
1070 raw_spin_unlock_irq(&logbuf_lock);
1071 if (copy_to_user(buf + len, text, textlen))
1072 len = -EFAULT;
1073 else
1074 len += textlen;
1075 raw_spin_lock_irq(&logbuf_lock);
1076
1077 if (seq < log_first_seq) {
1078 /* messages are gone, move to next one */
1079 seq = log_first_seq;
1080 idx = log_first_idx;
Kay Sievers5becfb12012-07-09 12:15:42 -07001081 prev = 0;
Kay Sievers7ff95542012-05-03 02:29:13 +02001082 }
1083 }
1084 }
1085
1086 if (clear) {
1087 clear_seq = log_next_seq;
1088 clear_idx = log_next_idx;
1089 }
1090 raw_spin_unlock_irq(&logbuf_lock);
1091
1092 kfree(text);
1093 return len;
1094}
1095
Kees Cook00234592010-02-03 15:36:43 -08001096int do_syslog(int type, char __user *buf, int len, bool from_file)
Linus Torvalds1da177e2005-04-16 15:20:36 -07001097{
Kay Sievers7ff95542012-05-03 02:29:13 +02001098 bool clear = false;
1099 static int saved_console_loglevel = -1;
Linus Torvaldsee24aeb2011-02-10 17:53:55 -08001100 int error;
Linus Torvalds1da177e2005-04-16 15:20:36 -07001101
Linus Torvaldsee24aeb2011-02-10 17:53:55 -08001102 error = check_syslog_permissions(type, from_file);
1103 if (error)
1104 goto out;
Eric Paris12b30522010-11-15 18:36:29 -05001105
1106 error = security_syslog(type);
Linus Torvalds1da177e2005-04-16 15:20:36 -07001107 if (error)
1108 return error;
1109
1110 switch (type) {
Kees Cookd78ca3c2010-02-03 15:37:13 -08001111 case SYSLOG_ACTION_CLOSE: /* Close log */
Linus Torvalds1da177e2005-04-16 15:20:36 -07001112 break;
Kees Cookd78ca3c2010-02-03 15:37:13 -08001113 case SYSLOG_ACTION_OPEN: /* Open log */
Linus Torvalds1da177e2005-04-16 15:20:36 -07001114 break;
Kees Cookd78ca3c2010-02-03 15:37:13 -08001115 case SYSLOG_ACTION_READ: /* Read from log */
Linus Torvalds1da177e2005-04-16 15:20:36 -07001116 error = -EINVAL;
1117 if (!buf || len < 0)
1118 goto out;
1119 error = 0;
1120 if (!len)
1121 goto out;
1122 if (!access_ok(VERIFY_WRITE, buf, len)) {
1123 error = -EFAULT;
1124 goto out;
1125 }
Yuanhan Liu4a77a5a2012-06-16 21:21:51 +08001126 error = wait_event_interruptible(log_wait,
1127 syslog_seq != log_next_seq);
Kay Sieverscb424ff2012-07-06 09:50:09 -07001128 if (error)
Yuanhan Liu4a77a5a2012-06-16 21:21:51 +08001129 goto out;
Kay Sievers7ff95542012-05-03 02:29:13 +02001130 error = syslog_print(buf, len);
Linus Torvalds1da177e2005-04-16 15:20:36 -07001131 break;
Kees Cookd78ca3c2010-02-03 15:37:13 -08001132 /* Read/clear last kernel messages */
1133 case SYSLOG_ACTION_READ_CLEAR:
Kay Sievers7ff95542012-05-03 02:29:13 +02001134 clear = true;
Linus Torvalds1da177e2005-04-16 15:20:36 -07001135 /* FALL THRU */
Kees Cookd78ca3c2010-02-03 15:37:13 -08001136 /* Read last kernel messages */
1137 case SYSLOG_ACTION_READ_ALL:
Linus Torvalds1da177e2005-04-16 15:20:36 -07001138 error = -EINVAL;
1139 if (!buf || len < 0)
1140 goto out;
1141 error = 0;
1142 if (!len)
1143 goto out;
1144 if (!access_ok(VERIFY_WRITE, buf, len)) {
1145 error = -EFAULT;
1146 goto out;
1147 }
Kay Sievers7ff95542012-05-03 02:29:13 +02001148 error = syslog_print_all(buf, len, clear);
Linus Torvalds1da177e2005-04-16 15:20:36 -07001149 break;
Kees Cookd78ca3c2010-02-03 15:37:13 -08001150 /* Clear ring buffer */
1151 case SYSLOG_ACTION_CLEAR:
Kay Sievers7ff95542012-05-03 02:29:13 +02001152 syslog_print_all(NULL, 0, true);
Alan Stern4661e352012-06-22 17:12:19 -04001153 break;
Kees Cookd78ca3c2010-02-03 15:37:13 -08001154 /* Disable logging to console */
1155 case SYSLOG_ACTION_CONSOLE_OFF:
Frans Pop1aaad492009-07-06 13:31:48 +02001156 if (saved_console_loglevel == -1)
1157 saved_console_loglevel = console_loglevel;
Linus Torvalds1da177e2005-04-16 15:20:36 -07001158 console_loglevel = minimum_console_loglevel;
1159 break;
Kees Cookd78ca3c2010-02-03 15:37:13 -08001160 /* Enable logging to console */
1161 case SYSLOG_ACTION_CONSOLE_ON:
Frans Pop1aaad492009-07-06 13:31:48 +02001162 if (saved_console_loglevel != -1) {
1163 console_loglevel = saved_console_loglevel;
1164 saved_console_loglevel = -1;
1165 }
Linus Torvalds1da177e2005-04-16 15:20:36 -07001166 break;
Kees Cookd78ca3c2010-02-03 15:37:13 -08001167 /* Set level of messages printed to console */
1168 case SYSLOG_ACTION_CONSOLE_LEVEL:
Linus Torvalds1da177e2005-04-16 15:20:36 -07001169 error = -EINVAL;
1170 if (len < 1 || len > 8)
1171 goto out;
1172 if (len < minimum_console_loglevel)
1173 len = minimum_console_loglevel;
1174 console_loglevel = len;
Frans Pop1aaad492009-07-06 13:31:48 +02001175 /* Implicitly re-enable logging to console */
1176 saved_console_loglevel = -1;
Linus Torvalds1da177e2005-04-16 15:20:36 -07001177 error = 0;
1178 break;
Kees Cookd78ca3c2010-02-03 15:37:13 -08001179 /* Number of chars in the log buffer */
1180 case SYSLOG_ACTION_SIZE_UNREAD:
Kay Sievers7ff95542012-05-03 02:29:13 +02001181 raw_spin_lock_irq(&logbuf_lock);
1182 if (syslog_seq < log_first_seq) {
1183 /* messages are gone, move to first one */
1184 syslog_seq = log_first_seq;
1185 syslog_idx = log_first_idx;
Kay Sievers5becfb12012-07-09 12:15:42 -07001186 syslog_prev = 0;
Kay Sieverseb02dac2012-07-09 10:05:10 -07001187 syslog_partial = 0;
Kay Sievers7ff95542012-05-03 02:29:13 +02001188 }
1189 if (from_file) {
1190 /*
1191 * Short-cut for poll(/"proc/kmsg") which simply checks
1192 * for pending data, not the size; return the count of
1193 * records, not the length.
1194 */
1195 error = log_next_idx - syslog_idx;
1196 } else {
Kay Sievers5becfb12012-07-09 12:15:42 -07001197 u64 seq = syslog_seq;
1198 u32 idx = syslog_idx;
1199 enum log_flags prev = syslog_prev;
Kay Sievers7ff95542012-05-03 02:29:13 +02001200
1201 error = 0;
Kay Sievers7ff95542012-05-03 02:29:13 +02001202 while (seq < log_next_seq) {
Kay Sievers3ce9a7c2012-05-13 23:30:46 +02001203 struct log *msg = log_from_idx(idx);
1204
Kay Sievers5becfb12012-07-09 12:15:42 -07001205 error += msg_print_text(msg, prev, true, NULL, 0);
Kay Sievers7ff95542012-05-03 02:29:13 +02001206 idx = log_next(idx);
1207 seq++;
Kay Sievers5becfb12012-07-09 12:15:42 -07001208 prev = msg->flags;
Kay Sievers7ff95542012-05-03 02:29:13 +02001209 }
Kay Sieverseb02dac2012-07-09 10:05:10 -07001210 error -= syslog_partial;
Kay Sievers7ff95542012-05-03 02:29:13 +02001211 }
1212 raw_spin_unlock_irq(&logbuf_lock);
Linus Torvalds1da177e2005-04-16 15:20:36 -07001213 break;
Kees Cookd78ca3c2010-02-03 15:37:13 -08001214 /* Size of the log buffer */
1215 case SYSLOG_ACTION_SIZE_BUFFER:
Linus Torvalds1da177e2005-04-16 15:20:36 -07001216 error = log_buf_len;
1217 break;
1218 default:
1219 error = -EINVAL;
1220 break;
1221 }
1222out:
1223 return error;
1224}
1225
Heiko Carstens1e7bfb22009-01-14 14:14:29 +01001226SYSCALL_DEFINE3(syslog, int, type, char __user *, buf, int, len)
Linus Torvalds1da177e2005-04-16 15:20:36 -07001227{
Kees Cook00234592010-02-03 15:36:43 -08001228 return do_syslog(type, buf, len, SYSLOG_FROM_CALL);
Linus Torvalds1da177e2005-04-16 15:20:36 -07001229}
1230
Jason Wessel67fc4e02010-05-20 21:04:21 -05001231#ifdef CONFIG_KGDB_KDB
1232/* kdb dmesg command needs access to the syslog buffer. do_syslog()
1233 * uses locks so it cannot be used during debugging. Just tell kdb
1234 * where the start and end of the physical and logical logs are. This
1235 * is equivalent to do_syslog(3).
1236 */
1237void kdb_syslog_data(char *syslog_data[4])
1238{
1239 syslog_data[0] = log_buf;
1240 syslog_data[1] = log_buf + log_buf_len;
Kay Sievers7ff95542012-05-03 02:29:13 +02001241 syslog_data[2] = log_buf + log_first_idx;
1242 syslog_data[3] = log_buf + log_next_idx;
Jason Wessel67fc4e02010-05-20 21:04:21 -05001243}
1244#endif /* CONFIG_KGDB_KDB */
1245
Rusty Russell2329abf2012-01-13 09:32:18 +10301246static bool __read_mostly ignore_loglevel;
Ingo Molnar792908222006-12-06 20:40:51 -08001247
Adrian Bunk99eea6a2006-12-22 01:07:00 -08001248static int __init ignore_loglevel_setup(char *str)
Ingo Molnar792908222006-12-06 20:40:51 -08001249{
1250 ignore_loglevel = 1;
1251 printk(KERN_INFO "debug: ignoring loglevel setting.\n");
1252
Ingo Molnarc4772d92008-01-31 22:45:23 +01001253 return 0;
Ingo Molnar792908222006-12-06 20:40:51 -08001254}
1255
Ingo Molnarc4772d92008-01-31 22:45:23 +01001256early_param("ignore_loglevel", ignore_loglevel_setup);
Rusty Russell29d4d6d2012-01-13 09:32:17 +10301257module_param(ignore_loglevel, bool, S_IRUGO | S_IWUSR);
Yanmin Zhang0eca6b72011-10-31 17:11:25 -07001258MODULE_PARM_DESC(ignore_loglevel, "ignore loglevel setting, to"
1259 "print all kernel messages to the console.");
Ingo Molnar792908222006-12-06 20:40:51 -08001260
Linus Torvalds1da177e2005-04-16 15:20:36 -07001261/*
Linus Torvalds1da177e2005-04-16 15:20:36 -07001262 * Call the console drivers, asking them to write out
1263 * log_buf[start] to log_buf[end - 1].
Torben Hohnac751ef2011-01-25 15:07:35 -08001264 * The console_lock must be held.
Linus Torvalds1da177e2005-04-16 15:20:36 -07001265 */
Kay Sievers7ff95542012-05-03 02:29:13 +02001266static void call_console_drivers(int level, const char *text, size_t len)
Linus Torvalds1da177e2005-04-16 15:20:36 -07001267{
Kay Sievers7ff95542012-05-03 02:29:13 +02001268 struct console *con;
Linus Torvalds1da177e2005-04-16 15:20:36 -07001269
Kay Sievers7ff95542012-05-03 02:29:13 +02001270 trace_console(text, 0, len, len);
Linus Torvalds1da177e2005-04-16 15:20:36 -07001271
Kay Sievers7ff95542012-05-03 02:29:13 +02001272 if (level >= console_loglevel && !ignore_loglevel)
1273 return;
1274 if (!console_drivers)
1275 return;
Linus Torvalds1da177e2005-04-16 15:20:36 -07001276
Kay Sievers7ff95542012-05-03 02:29:13 +02001277 for_each_console(con) {
1278 if (exclusive_console && con != exclusive_console)
1279 continue;
1280 if (!(con->flags & CON_ENABLED))
1281 continue;
1282 if (!con->write)
1283 continue;
1284 if (!cpu_online(smp_processor_id()) &&
1285 !(con->flags & CON_ANYTIME))
1286 continue;
1287 con->write(con, text, len);
Linus Torvalds1da177e2005-04-16 15:20:36 -07001288 }
Linus Torvalds1da177e2005-04-16 15:20:36 -07001289}
1290
1291/*
1292 * Zap console related locks when oopsing. Only zap at most once
1293 * every 10 seconds, to leave time for slow consoles to print a
1294 * full oops.
1295 */
1296static void zap_locks(void)
1297{
1298 static unsigned long oops_timestamp;
1299
1300 if (time_after_eq(jiffies, oops_timestamp) &&
Jesper Juhl40dc5652005-10-30 15:02:46 -08001301 !time_after(jiffies, oops_timestamp + 30 * HZ))
Linus Torvalds1da177e2005-04-16 15:20:36 -07001302 return;
1303
1304 oops_timestamp = jiffies;
1305
Peter Zijlstra94d24fc2011-06-07 11:17:30 +02001306 debug_locks_off();
Linus Torvalds1da177e2005-04-16 15:20:36 -07001307 /* If a crash is occurring, make sure we can't deadlock */
Thomas Gleixner07354eb2009-07-25 17:50:36 +02001308 raw_spin_lock_init(&logbuf_lock);
Linus Torvalds1da177e2005-04-16 15:20:36 -07001309 /* And make sure that we print immediately */
Thomas Gleixner5b8c4f22010-09-07 14:33:43 +00001310 sema_init(&console_sem, 1);
Linus Torvalds1da177e2005-04-16 15:20:36 -07001311}
1312
Michael Ellerman76a8ad22006-06-25 05:47:40 -07001313/* Check if we have any console registered that can be called early in boot. */
1314static int have_callable_console(void)
1315{
1316 struct console *con;
1317
Robin Getz4d091612009-07-01 21:08:37 -04001318 for_each_console(con)
Michael Ellerman76a8ad22006-06-25 05:47:40 -07001319 if (con->flags & CON_ANYTIME)
1320 return 1;
1321
1322 return 0;
1323}
1324
Linus Torvalds266c2e02008-03-24 19:25:08 -07001325/*
1326 * Can we actually use the console at this time on this cpu?
1327 *
1328 * Console drivers may assume that per-cpu resources have
1329 * been allocated. So unless they're explicitly marked as
1330 * being able to cope (CON_ANYTIME) don't call them until
1331 * this CPU is officially up.
1332 */
1333static inline int can_use_console(unsigned int cpu)
1334{
1335 return cpu_online(cpu) || have_callable_console();
1336}
1337
1338/*
1339 * Try to get console ownership to actually show the kernel
1340 * messages from a 'printk'. Return true (and with the
Torben Hohnac751ef2011-01-25 15:07:35 -08001341 * console_lock held, and 'console_locked' set) if it
Linus Torvalds266c2e02008-03-24 19:25:08 -07001342 * is successful, false otherwise.
1343 *
1344 * This gets called with the 'logbuf_lock' spinlock held and
1345 * interrupts disabled. It should return with 'lockbuf_lock'
1346 * released but interrupts still disabled.
1347 */
Torben Hohnac751ef2011-01-25 15:07:35 -08001348static int console_trylock_for_printk(unsigned int cpu)
Namhyung Kim8155c022010-10-26 14:22:47 -07001349 __releases(&logbuf_lock)
Linus Torvalds266c2e02008-03-24 19:25:08 -07001350{
Peter Zijlstra0b5e1c52011-06-07 11:15:33 +02001351 int retval = 0, wake = 0;
Linus Torvalds266c2e02008-03-24 19:25:08 -07001352
Torben Hohnac751ef2011-01-25 15:07:35 -08001353 if (console_trylock()) {
Linus Torvalds093a07e2008-04-15 13:09:54 -07001354 retval = 1;
1355
1356 /*
1357 * If we can't use the console, we need to release
1358 * the console semaphore by hand to avoid flushing
1359 * the buffer. We need to hold the console semaphore
1360 * in order to do this test safely.
1361 */
1362 if (!can_use_console(cpu)) {
1363 console_locked = 0;
Peter Zijlstra0b5e1c52011-06-07 11:15:33 +02001364 wake = 1;
Linus Torvalds093a07e2008-04-15 13:09:54 -07001365 retval = 0;
1366 }
1367 }
Kay Sievers7ff95542012-05-03 02:29:13 +02001368 logbuf_cpu = UINT_MAX;
Peter Zijlstra0b5e1c52011-06-07 11:15:33 +02001369 if (wake)
1370 up(&console_sem);
Thomas Gleixner07354eb2009-07-25 17:50:36 +02001371 raw_spin_unlock(&logbuf_lock);
Linus Torvalds266c2e02008-03-24 19:25:08 -07001372 return retval;
1373}
Ingo Molnar32a76002008-01-25 21:07:58 +01001374
Dave Youngaf913222009-09-22 16:43:33 -07001375int printk_delay_msec __read_mostly;
1376
1377static inline void printk_delay(void)
1378{
1379 if (unlikely(printk_delay_msec)) {
1380 int m = printk_delay_msec;
1381
1382 while (m--) {
1383 mdelay(1);
1384 touch_nmi_watchdog();
1385 }
1386 }
1387}
1388
Kay Sievers084681d2012-06-28 09:38:53 +02001389/*
1390 * Continuation lines are buffered, and not committed to the record buffer
1391 * until the line is complete, or a race forces it. The line fragments
1392 * though, are printed immediately to the consoles to ensure everything has
1393 * reached the console in case of a kernel crash.
1394 */
1395static struct cont {
1396 char buf[LOG_LINE_MAX];
1397 size_t len; /* length == 0 means unused buffer */
1398 size_t cons; /* bytes written to console */
1399 struct task_struct *owner; /* task of first print*/
1400 u64 ts_nsec; /* time of first print */
1401 u8 level; /* log level of first message */
1402 u8 facility; /* log level of first message */
Kay Sieverseab07262012-07-16 18:35:30 -07001403 enum log_flags flags; /* prefix, newline flags */
Kay Sievers084681d2012-06-28 09:38:53 +02001404 bool flushed:1; /* buffer sealed and committed */
1405} cont;
1406
Kay Sievers70498252012-07-16 18:35:29 -07001407static void cont_flush(enum log_flags flags)
Kay Sievers084681d2012-06-28 09:38:53 +02001408{
1409 if (cont.flushed)
1410 return;
1411 if (cont.len == 0)
1412 return;
1413
Kay Sieverseab07262012-07-16 18:35:30 -07001414 if (cont.cons) {
1415 /*
1416 * If a fragment of this line was directly flushed to the
1417 * console; wait for the console to pick up the rest of the
1418 * line. LOG_NOCONS suppresses a duplicated output.
1419 */
1420 log_store(cont.facility, cont.level, flags | LOG_NOCONS,
1421 cont.ts_nsec, NULL, 0, cont.buf, cont.len);
1422 cont.flags = flags;
1423 cont.flushed = true;
1424 } else {
1425 /*
1426 * If no fragment of this line ever reached the console,
1427 * just submit it to the store and free the buffer.
1428 */
1429 log_store(cont.facility, cont.level, flags, 0,
1430 NULL, 0, cont.buf, cont.len);
1431 cont.len = 0;
1432 }
Kay Sievers084681d2012-06-28 09:38:53 +02001433}
1434
1435static bool cont_add(int facility, int level, const char *text, size_t len)
1436{
1437 if (cont.len && cont.flushed)
1438 return false;
1439
1440 if (cont.len + len > sizeof(cont.buf)) {
Kay Sievers70498252012-07-16 18:35:29 -07001441 /* the line gets too long, split it up in separate records */
1442 cont_flush(LOG_CONT);
Kay Sievers084681d2012-06-28 09:38:53 +02001443 return false;
1444 }
1445
1446 if (!cont.len) {
1447 cont.facility = facility;
1448 cont.level = level;
1449 cont.owner = current;
1450 cont.ts_nsec = local_clock();
Kay Sieverseab07262012-07-16 18:35:30 -07001451 cont.flags = 0;
Kay Sievers084681d2012-06-28 09:38:53 +02001452 cont.cons = 0;
1453 cont.flushed = false;
1454 }
1455
1456 memcpy(cont.buf + cont.len, text, len);
1457 cont.len += len;
Kay Sieverseab07262012-07-16 18:35:30 -07001458
1459 if (cont.len > (sizeof(cont.buf) * 80) / 100)
1460 cont_flush(LOG_CONT);
1461
Kay Sievers084681d2012-06-28 09:38:53 +02001462 return true;
1463}
1464
1465static size_t cont_print_text(char *text, size_t size)
1466{
1467 size_t textlen = 0;
1468 size_t len;
1469
Kay Sieverseab07262012-07-16 18:35:30 -07001470 if (cont.cons == 0 && (console_prev & LOG_NEWLINE)) {
Kay Sievers084681d2012-06-28 09:38:53 +02001471 textlen += print_time(cont.ts_nsec, text);
1472 size -= textlen;
1473 }
1474
1475 len = cont.len - cont.cons;
1476 if (len > 0) {
1477 if (len+1 > size)
1478 len = size-1;
1479 memcpy(text + textlen, cont.buf + cont.cons, len);
1480 textlen += len;
1481 cont.cons = cont.len;
1482 }
1483
1484 if (cont.flushed) {
Kay Sieverseab07262012-07-16 18:35:30 -07001485 if (cont.flags & LOG_NEWLINE)
1486 text[textlen++] = '\n';
Kay Sievers084681d2012-06-28 09:38:53 +02001487 /* got everything, release buffer */
1488 cont.len = 0;
1489 }
1490 return textlen;
1491}
1492
Kay Sievers7ff95542012-05-03 02:29:13 +02001493asmlinkage int vprintk_emit(int facility, int level,
1494 const char *dict, size_t dictlen,
1495 const char *fmt, va_list args)
Linus Torvalds1da177e2005-04-16 15:20:36 -07001496{
Kay Sievers7ff95542012-05-03 02:29:13 +02001497 static int recursion_bug;
Kay Sievers7ff95542012-05-03 02:29:13 +02001498 static char textbuf[LOG_LINE_MAX];
1499 char *text = textbuf;
Kay Sieversc313af12012-05-14 20:46:27 +02001500 size_t text_len;
Kay Sievers5becfb12012-07-09 12:15:42 -07001501 enum log_flags lflags = 0;
Nick Andrewac60ad72008-05-12 21:21:04 +02001502 unsigned long flags;
Ingo Molnar32a76002008-01-25 21:07:58 +01001503 int this_cpu;
Kay Sievers7ff95542012-05-03 02:29:13 +02001504 int printed_len = 0;
Linus Torvalds1da177e2005-04-16 15:20:36 -07001505
Randy Dunlapbfe8df32007-10-16 01:23:46 -07001506 boot_delay_msec();
Dave Youngaf913222009-09-22 16:43:33 -07001507 printk_delay();
Randy Dunlapbfe8df32007-10-16 01:23:46 -07001508
Linus Torvalds1da177e2005-04-16 15:20:36 -07001509 /* This stops the holder of console_sem just where we want him */
Peter Zijlstra1a9a8ae2011-06-07 11:17:30 +02001510 local_irq_save(flags);
Ingo Molnar32a76002008-01-25 21:07:58 +01001511 this_cpu = smp_processor_id();
1512
1513 /*
1514 * Ouch, printk recursed into itself!
1515 */
Kay Sievers7ff95542012-05-03 02:29:13 +02001516 if (unlikely(logbuf_cpu == this_cpu)) {
Ingo Molnar32a76002008-01-25 21:07:58 +01001517 /*
1518 * If a crash is occurring during printk() on this CPU,
1519 * then try to get the crash message out but make sure
1520 * we can't deadlock. Otherwise just return to avoid the
1521 * recursion and return - but flag the recursion so that
1522 * it can be printed at the next appropriate moment:
1523 */
Peter Zijlstra94d24fc2011-06-07 11:17:30 +02001524 if (!oops_in_progress && !lockdep_recursing(current)) {
Tejun Heo3b8945e2008-05-12 21:21:04 +02001525 recursion_bug = 1;
Ingo Molnar32a76002008-01-25 21:07:58 +01001526 goto out_restore_irqs;
1527 }
1528 zap_locks();
1529 }
1530
Ingo Molnara0f1ccf2006-07-03 00:24:58 -07001531 lockdep_off();
Thomas Gleixner07354eb2009-07-25 17:50:36 +02001532 raw_spin_lock(&logbuf_lock);
Kay Sievers7ff95542012-05-03 02:29:13 +02001533 logbuf_cpu = this_cpu;
Linus Torvalds1da177e2005-04-16 15:20:36 -07001534
Tejun Heo3b8945e2008-05-12 21:21:04 +02001535 if (recursion_bug) {
Kay Sievers7ff95542012-05-03 02:29:13 +02001536 static const char recursion_msg[] =
1537 "BUG: recent printk recursion!";
1538
Tejun Heo3b8945e2008-05-12 21:21:04 +02001539 recursion_bug = 0;
Kay Sievers7ff95542012-05-03 02:29:13 +02001540 printed_len += strlen(recursion_msg);
1541 /* emit KERN_CRIT message */
Kay Sievers5becfb12012-07-09 12:15:42 -07001542 log_store(0, 2, LOG_PREFIX|LOG_NEWLINE, 0,
Kay Sievers084681d2012-06-28 09:38:53 +02001543 NULL, 0, recursion_msg, printed_len);
Linus Torvalds5fd29d62009-06-16 10:57:02 -07001544 }
1545
Linus Torvalds1da177e2005-04-16 15:20:36 -07001546 /*
Kay Sievers7ff95542012-05-03 02:29:13 +02001547 * The printf needs to come first; we need the syslog
1548 * prefix which might be passed-in as a parameter.
Linus Torvalds1da177e2005-04-16 15:20:36 -07001549 */
Kay Sieversc313af12012-05-14 20:46:27 +02001550 text_len = vscnprintf(text, sizeof(textbuf), fmt, args);
Nick Andrewac60ad72008-05-12 21:21:04 +02001551
Kay Sievers7ff95542012-05-03 02:29:13 +02001552 /* mark and strip a trailing newline */
Kay Sieversc313af12012-05-14 20:46:27 +02001553 if (text_len && text[text_len-1] == '\n') {
1554 text_len--;
Kay Sievers5becfb12012-07-09 12:15:42 -07001555 lflags |= LOG_NEWLINE;
Kay Sievers7ff95542012-05-03 02:29:13 +02001556 }
Kay Sievers9d90c8d2011-03-13 03:19:51 +01001557
Kay Sieversc313af12012-05-14 20:46:27 +02001558 /* strip syslog prefix and extract log level or control flags */
Kay Sievers7ff95542012-05-03 02:29:13 +02001559 if (text[0] == '<' && text[1] && text[2] == '>') {
1560 switch (text[1]) {
1561 case '0' ... '7':
1562 if (level == -1)
1563 level = text[1] - '0';
Kay Sievers7ff95542012-05-03 02:29:13 +02001564 case 'd': /* KERN_DEFAULT */
Kay Sievers5becfb12012-07-09 12:15:42 -07001565 lflags |= LOG_PREFIX;
Kay Sievers5c5d5ca2012-05-10 04:32:53 +02001566 case 'c': /* KERN_CONT */
Kay Sievers7ff95542012-05-03 02:29:13 +02001567 text += 3;
Kay Sieversc313af12012-05-14 20:46:27 +02001568 text_len -= 3;
Linus Torvalds1da177e2005-04-16 15:20:36 -07001569 }
Kay Sievers7ff95542012-05-03 02:29:13 +02001570 }
Nick Andrewac60ad72008-05-12 21:21:04 +02001571
Kay Sieversc313af12012-05-14 20:46:27 +02001572 if (level == -1)
1573 level = default_message_loglevel;
1574
Kay Sievers5becfb12012-07-09 12:15:42 -07001575 if (dict)
1576 lflags |= LOG_PREFIX|LOG_NEWLINE;
Kay Sievers7ff95542012-05-03 02:29:13 +02001577
Kay Sievers5becfb12012-07-09 12:15:42 -07001578 if (!(lflags & LOG_NEWLINE)) {
Kay Sievers084681d2012-06-28 09:38:53 +02001579 /*
1580 * Flush the conflicting buffer. An earlier newline was missing,
1581 * or another task also prints continuation lines.
1582 */
Kay Sievers5becfb12012-07-09 12:15:42 -07001583 if (cont.len && (lflags & LOG_PREFIX || cont.owner != current))
Kay Sieverseab07262012-07-16 18:35:30 -07001584 cont_flush(LOG_NEWLINE);
Kay Sieversc313af12012-05-14 20:46:27 +02001585
Kay Sievers084681d2012-06-28 09:38:53 +02001586 /* buffer line if possible, otherwise store it right away */
1587 if (!cont_add(facility, level, text, text_len))
Kay Sievers5becfb12012-07-09 12:15:42 -07001588 log_store(facility, level, lflags | LOG_CONT, 0,
Kay Sieversc313af12012-05-14 20:46:27 +02001589 dict, dictlen, text, text_len);
Kay Sievers084681d2012-06-28 09:38:53 +02001590 } else {
1591 bool stored = false;
1592
1593 /*
Steven Rostedtd3620822012-06-29 11:40:11 -04001594 * If an earlier newline was missing and it was the same task,
1595 * either merge it with the current buffer and flush, or if
1596 * there was a race with interrupts (prefix == true) then just
1597 * flush it out and store this line separately.
Kay Sievers084681d2012-06-28 09:38:53 +02001598 */
Kay Sievers084681d2012-06-28 09:38:53 +02001599 if (cont.len && cont.owner == current) {
Kay Sievers5becfb12012-07-09 12:15:42 -07001600 if (!(lflags & LOG_PREFIX))
Steven Rostedtd3620822012-06-29 11:40:11 -04001601 stored = cont_add(facility, level, text, text_len);
Kay Sieverseab07262012-07-16 18:35:30 -07001602 cont_flush(LOG_NEWLINE);
Kay Sieversc313af12012-05-14 20:46:27 +02001603 }
Kay Sievers084681d2012-06-28 09:38:53 +02001604
1605 if (!stored)
Kay Sievers5becfb12012-07-09 12:15:42 -07001606 log_store(facility, level, lflags, 0,
Kay Sievers084681d2012-06-28 09:38:53 +02001607 dict, dictlen, text, text_len);
Linus Torvalds1da177e2005-04-16 15:20:36 -07001608 }
Kay Sievers084681d2012-06-28 09:38:53 +02001609 printed_len += text_len;
Linus Torvalds1da177e2005-04-16 15:20:36 -07001610
Linus Torvalds266c2e02008-03-24 19:25:08 -07001611 /*
Kay Sievers7ff95542012-05-03 02:29:13 +02001612 * Try to acquire and then immediately release the console semaphore.
1613 * The release will print out buffers and wake up /dev/kmsg and syslog()
1614 * users.
Linus Torvalds266c2e02008-03-24 19:25:08 -07001615 *
Kay Sievers7ff95542012-05-03 02:29:13 +02001616 * The console_trylock_for_printk() function will release 'logbuf_lock'
1617 * regardless of whether it actually gets the console semaphore or not.
Linus Torvalds266c2e02008-03-24 19:25:08 -07001618 */
Torben Hohnac751ef2011-01-25 15:07:35 -08001619 if (console_trylock_for_printk(this_cpu))
1620 console_unlock();
Michael Ellerman76a8ad22006-06-25 05:47:40 -07001621
Linus Torvalds266c2e02008-03-24 19:25:08 -07001622 lockdep_on();
Ingo Molnar32a76002008-01-25 21:07:58 +01001623out_restore_irqs:
Peter Zijlstra1a9a8ae2011-06-07 11:17:30 +02001624 local_irq_restore(flags);
Michael Ellerman76a8ad22006-06-25 05:47:40 -07001625
Linus Torvalds1da177e2005-04-16 15:20:36 -07001626 return printed_len;
1627}
Kay Sievers7ff95542012-05-03 02:29:13 +02001628EXPORT_SYMBOL(vprintk_emit);
1629
1630asmlinkage int vprintk(const char *fmt, va_list args)
1631{
1632 return vprintk_emit(0, -1, NULL, 0, fmt, args);
1633}
Linus Torvalds1da177e2005-04-16 15:20:36 -07001634EXPORT_SYMBOL(vprintk);
1635
Kay Sievers7ff95542012-05-03 02:29:13 +02001636asmlinkage int printk_emit(int facility, int level,
1637 const char *dict, size_t dictlen,
1638 const char *fmt, ...)
1639{
1640 va_list args;
1641 int r;
1642
1643 va_start(args, fmt);
1644 r = vprintk_emit(facility, level, dict, dictlen, fmt, args);
1645 va_end(args);
1646
1647 return r;
1648}
1649EXPORT_SYMBOL(printk_emit);
1650
1651/**
1652 * printk - print a kernel message
1653 * @fmt: format string
1654 *
1655 * This is printk(). It can be called from any context. We want it to work.
1656 *
1657 * We try to grab the console_lock. If we succeed, it's easy - we log the
1658 * output and call the console drivers. If we fail to get the semaphore, we
1659 * place the output into the log buffer and return. The current holder of
1660 * the console_sem will notice the new output in console_unlock(); and will
1661 * send it to the consoles before releasing the lock.
1662 *
1663 * One effect of this deferred printing is that code which calls printk() and
1664 * then changes console_loglevel may break. This is because console_loglevel
1665 * is inspected when the actual printing occurs.
1666 *
1667 * See also:
1668 * printf(3)
1669 *
1670 * See the vsnprintf() documentation for format string extensions over C99.
1671 */
1672asmlinkage int printk(const char *fmt, ...)
1673{
1674 va_list args;
1675 int r;
1676
1677#ifdef CONFIG_KGDB_KDB
1678 if (unlikely(kdb_trap_printk)) {
1679 va_start(args, fmt);
1680 r = vkdb_printf(fmt, args);
1681 va_end(args);
1682 return r;
1683 }
1684#endif
1685 va_start(args, fmt);
1686 r = vprintk_emit(0, -1, NULL, 0, fmt, args);
1687 va_end(args);
1688
1689 return r;
1690}
1691EXPORT_SYMBOL(printk);
Kay Sievers7f3a7812012-05-09 01:37:51 +02001692
Kay Sievers96efedf2012-07-16 18:35:29 -07001693#else /* CONFIG_PRINTK */
Matt Mackalld59745c2005-05-01 08:59:02 -07001694
Kay Sievers70498252012-07-16 18:35:29 -07001695#define LOG_LINE_MAX 0
1696#define PREFIX_MAX 0
Kay Sievers96efedf2012-07-16 18:35:29 -07001697#define LOG_LINE_MAX 0
1698static u64 syslog_seq;
1699static u32 syslog_idx;
Kay Sieverseab07262012-07-16 18:35:30 -07001700static u64 console_seq;
1701static u32 console_idx;
Kay Sievers96efedf2012-07-16 18:35:29 -07001702static enum log_flags syslog_prev;
1703static u64 log_first_seq;
1704static u32 log_first_idx;
1705static u64 log_next_seq;
Kay Sieverseab07262012-07-16 18:35:30 -07001706static enum log_flags console_prev;
Kay Sievers084681d2012-06-28 09:38:53 +02001707static struct cont {
1708 size_t len;
1709 size_t cons;
1710 u8 level;
1711 bool flushed:1;
1712} cont;
Kay Sievers7f3a7812012-05-09 01:37:51 +02001713static struct log *log_from_idx(u32 idx) { return NULL; }
1714static u32 log_next(u32 idx) { return 0; }
Kay Sievers7f3a7812012-05-09 01:37:51 +02001715static void call_console_drivers(int level, const char *text, size_t len) {}
Kay Sievers5becfb12012-07-09 12:15:42 -07001716static size_t msg_print_text(const struct log *msg, enum log_flags prev,
1717 bool syslog, char *buf, size_t size) { return 0; }
Kay Sievers084681d2012-06-28 09:38:53 +02001718static size_t cont_print_text(char *text, size_t size) { return 0; }
Matt Mackalld59745c2005-05-01 08:59:02 -07001719
Kay Sievers7f3a7812012-05-09 01:37:51 +02001720#endif /* CONFIG_PRINTK */
Matt Mackalld59745c2005-05-01 08:59:02 -07001721
Samuel Thibaultf7511d52008-04-30 00:54:51 -07001722static int __add_preferred_console(char *name, int idx, char *options,
1723 char *brl_options)
1724{
1725 struct console_cmdline *c;
1726 int i;
1727
1728 /*
1729 * See if this tty is not yet registered, and
1730 * if we have a slot free.
1731 */
1732 for (i = 0; i < MAX_CMDLINECONSOLES && console_cmdline[i].name[0]; i++)
1733 if (strcmp(console_cmdline[i].name, name) == 0 &&
1734 console_cmdline[i].index == idx) {
1735 if (!brl_options)
1736 selected_console = i;
1737 return 0;
1738 }
1739 if (i == MAX_CMDLINECONSOLES)
1740 return -E2BIG;
1741 if (!brl_options)
1742 selected_console = i;
1743 c = &console_cmdline[i];
1744 strlcpy(c->name, name, sizeof(c->name));
1745 c->options = options;
1746#ifdef CONFIG_A11Y_BRAILLE_CONSOLE
1747 c->brl_options = brl_options;
1748#endif
1749 c->index = idx;
1750 return 0;
1751}
John Z. Bohach2ea1c532006-03-24 03:18:19 -08001752/*
1753 * Set up a list of consoles. Called from init/main.c
1754 */
1755static int __init console_setup(char *str)
1756{
Yinghai Lueaa944a2007-07-15 23:37:27 -07001757 char buf[sizeof(console_cmdline[0].name) + 4]; /* 4 for index */
Samuel Thibaultf7511d52008-04-30 00:54:51 -07001758 char *s, *options, *brl_options = NULL;
John Z. Bohach2ea1c532006-03-24 03:18:19 -08001759 int idx;
1760
Samuel Thibaultf7511d52008-04-30 00:54:51 -07001761#ifdef CONFIG_A11Y_BRAILLE_CONSOLE
1762 if (!memcmp(str, "brl,", 4)) {
1763 brl_options = "";
1764 str += 4;
1765 } else if (!memcmp(str, "brl=", 4)) {
1766 brl_options = str + 4;
1767 str = strchr(brl_options, ',');
1768 if (!str) {
1769 printk(KERN_ERR "need port name after brl=\n");
1770 return 1;
1771 }
1772 *(str++) = 0;
1773 }
1774#endif
1775
John Z. Bohach2ea1c532006-03-24 03:18:19 -08001776 /*
1777 * Decode str into name, index, options.
1778 */
1779 if (str[0] >= '0' && str[0] <= '9') {
Yinghai Lueaa944a2007-07-15 23:37:27 -07001780 strcpy(buf, "ttyS");
1781 strncpy(buf + 4, str, sizeof(buf) - 5);
John Z. Bohach2ea1c532006-03-24 03:18:19 -08001782 } else {
Yinghai Lueaa944a2007-07-15 23:37:27 -07001783 strncpy(buf, str, sizeof(buf) - 1);
John Z. Bohach2ea1c532006-03-24 03:18:19 -08001784 }
Yinghai Lueaa944a2007-07-15 23:37:27 -07001785 buf[sizeof(buf) - 1] = 0;
John Z. Bohach2ea1c532006-03-24 03:18:19 -08001786 if ((options = strchr(str, ',')) != NULL)
1787 *(options++) = 0;
1788#ifdef __sparc__
1789 if (!strcmp(str, "ttya"))
Yinghai Lueaa944a2007-07-15 23:37:27 -07001790 strcpy(buf, "ttyS0");
John Z. Bohach2ea1c532006-03-24 03:18:19 -08001791 if (!strcmp(str, "ttyb"))
Yinghai Lueaa944a2007-07-15 23:37:27 -07001792 strcpy(buf, "ttyS1");
John Z. Bohach2ea1c532006-03-24 03:18:19 -08001793#endif
Yinghai Lueaa944a2007-07-15 23:37:27 -07001794 for (s = buf; *s; s++)
John Z. Bohach2ea1c532006-03-24 03:18:19 -08001795 if ((*s >= '0' && *s <= '9') || *s == ',')
1796 break;
1797 idx = simple_strtoul(s, NULL, 10);
1798 *s = 0;
1799
Samuel Thibaultf7511d52008-04-30 00:54:51 -07001800 __add_preferred_console(buf, idx, options, brl_options);
Markus Armbruster9e124fe2008-05-26 23:31:07 +01001801 console_set_on_cmdline = 1;
John Z. Bohach2ea1c532006-03-24 03:18:19 -08001802 return 1;
1803}
1804__setup("console=", console_setup);
1805
Linus Torvalds1da177e2005-04-16 15:20:36 -07001806/**
Matt Mackall3c0547b2005-05-16 21:53:47 -07001807 * add_preferred_console - add a device to the list of preferred consoles.
Martin Waitzddad86c2005-11-13 16:08:14 -08001808 * @name: device name
1809 * @idx: device index
1810 * @options: options for this console
Matt Mackall3c0547b2005-05-16 21:53:47 -07001811 *
1812 * The last preferred console added will be used for kernel messages
1813 * and stdin/out/err for init. Normally this is used by console_setup
1814 * above to handle user-supplied console arguments; however it can also
1815 * be used by arch-specific code either to override the user or more
1816 * commonly to provide a default console (ie from PROM variables) when
1817 * the user has not supplied one.
1818 */
David S. Millerfb445ee2007-12-29 01:19:49 -08001819int add_preferred_console(char *name, int idx, char *options)
Matt Mackall3c0547b2005-05-16 21:53:47 -07001820{
Samuel Thibaultf7511d52008-04-30 00:54:51 -07001821 return __add_preferred_console(name, idx, options, NULL);
Matt Mackall3c0547b2005-05-16 21:53:47 -07001822}
1823
Daniel Ritzb6b1d872007-08-03 16:07:43 +02001824int update_console_cmdline(char *name, int idx, char *name_new, int idx_new, char *options)
Yinghai Lu18a8bd92007-07-15 23:37:59 -07001825{
1826 struct console_cmdline *c;
1827 int i;
1828
1829 for (i = 0; i < MAX_CMDLINECONSOLES && console_cmdline[i].name[0]; i++)
1830 if (strcmp(console_cmdline[i].name, name) == 0 &&
1831 console_cmdline[i].index == idx) {
1832 c = &console_cmdline[i];
Markus Armbrusterf7352952008-04-30 00:54:52 -07001833 strlcpy(c->name, name_new, sizeof(c->name));
Yinghai Lu18a8bd92007-07-15 23:37:59 -07001834 c->name[sizeof(c->name) - 1] = 0;
1835 c->options = options;
1836 c->index = idx_new;
1837 return i;
1838 }
1839 /* not found */
1840 return -1;
1841}
1842
Rusty Russell2329abf2012-01-13 09:32:18 +10301843bool console_suspend_enabled = 1;
Andres Salomon8f4ce8c2007-10-18 03:04:50 -07001844EXPORT_SYMBOL(console_suspend_enabled);
1845
1846static int __init console_suspend_disable(char *str)
1847{
1848 console_suspend_enabled = 0;
1849 return 1;
1850}
1851__setup("no_console_suspend", console_suspend_disable);
Yanmin Zhang134620f2011-10-31 17:11:27 -07001852module_param_named(console_suspend, console_suspend_enabled,
1853 bool, S_IRUGO | S_IWUSR);
1854MODULE_PARM_DESC(console_suspend, "suspend console during suspend"
1855 " and hibernate operations");
Andres Salomon8f4ce8c2007-10-18 03:04:50 -07001856
Matt Mackall3c0547b2005-05-16 21:53:47 -07001857/**
Linus Torvalds557240b2006-06-19 18:16:01 -07001858 * suspend_console - suspend the console subsystem
1859 *
1860 * This disables printk() while we go into suspend states
1861 */
1862void suspend_console(void)
1863{
Andres Salomon8f4ce8c2007-10-18 03:04:50 -07001864 if (!console_suspend_enabled)
1865 return;
Pavel Machek0d630812008-07-23 21:28:32 -07001866 printk("Suspending console(s) (use no_console_suspend to debug)\n");
Torben Hohnac751ef2011-01-25 15:07:35 -08001867 console_lock();
Linus Torvalds557240b2006-06-19 18:16:01 -07001868 console_suspended = 1;
Arve Hjønnevåg403f3072009-02-14 02:07:24 +01001869 up(&console_sem);
Linus Torvalds557240b2006-06-19 18:16:01 -07001870}
1871
1872void resume_console(void)
1873{
Andres Salomon8f4ce8c2007-10-18 03:04:50 -07001874 if (!console_suspend_enabled)
1875 return;
Arve Hjønnevåg403f3072009-02-14 02:07:24 +01001876 down(&console_sem);
Linus Torvalds557240b2006-06-19 18:16:01 -07001877 console_suspended = 0;
Torben Hohnac751ef2011-01-25 15:07:35 -08001878 console_unlock();
Linus Torvalds557240b2006-06-19 18:16:01 -07001879}
1880
1881/**
Kevin Cernekee034260d2010-06-03 22:11:25 -07001882 * console_cpu_notify - print deferred console messages after CPU hotplug
1883 * @self: notifier struct
1884 * @action: CPU hotplug event
1885 * @hcpu: unused
1886 *
1887 * If printk() is called from a CPU that is not online yet, the messages
1888 * will be spooled but will not show up on the console. This function is
1889 * called when a new CPU comes online (or fails to come up), and ensures
1890 * that any such output gets printed.
1891 */
1892static int __cpuinit console_cpu_notify(struct notifier_block *self,
1893 unsigned long action, void *hcpu)
1894{
1895 switch (action) {
1896 case CPU_ONLINE:
1897 case CPU_DEAD:
1898 case CPU_DYING:
1899 case CPU_DOWN_FAILED:
1900 case CPU_UP_CANCELED:
Torben Hohnac751ef2011-01-25 15:07:35 -08001901 console_lock();
1902 console_unlock();
Kevin Cernekee034260d2010-06-03 22:11:25 -07001903 }
1904 return NOTIFY_OK;
1905}
1906
1907/**
Torben Hohnac751ef2011-01-25 15:07:35 -08001908 * console_lock - lock the console system for exclusive use.
Linus Torvalds1da177e2005-04-16 15:20:36 -07001909 *
Torben Hohnac751ef2011-01-25 15:07:35 -08001910 * Acquires a lock which guarantees that the caller has
Linus Torvalds1da177e2005-04-16 15:20:36 -07001911 * exclusive access to the console system and the console_drivers list.
1912 *
1913 * Can sleep, returns nothing.
1914 */
Torben Hohnac751ef2011-01-25 15:07:35 -08001915void console_lock(void)
Linus Torvalds1da177e2005-04-16 15:20:36 -07001916{
Eric Sesterhenn8abd8e22006-04-01 01:21:17 +02001917 BUG_ON(in_interrupt());
Linus Torvalds1da177e2005-04-16 15:20:36 -07001918 down(&console_sem);
Arve Hjønnevåg403f3072009-02-14 02:07:24 +01001919 if (console_suspended)
1920 return;
Linus Torvalds1da177e2005-04-16 15:20:36 -07001921 console_locked = 1;
1922 console_may_schedule = 1;
1923}
Torben Hohnac751ef2011-01-25 15:07:35 -08001924EXPORT_SYMBOL(console_lock);
Linus Torvalds1da177e2005-04-16 15:20:36 -07001925
Torben Hohnac751ef2011-01-25 15:07:35 -08001926/**
1927 * console_trylock - try to lock the console system for exclusive use.
1928 *
1929 * Tried to acquire a lock which guarantees that the caller has
1930 * exclusive access to the console system and the console_drivers list.
1931 *
1932 * returns 1 on success, and 0 on failure to acquire the lock.
1933 */
1934int console_trylock(void)
Linus Torvalds1da177e2005-04-16 15:20:36 -07001935{
1936 if (down_trylock(&console_sem))
Torben Hohnac751ef2011-01-25 15:07:35 -08001937 return 0;
Arve Hjønnevåg403f3072009-02-14 02:07:24 +01001938 if (console_suspended) {
1939 up(&console_sem);
Torben Hohnac751ef2011-01-25 15:07:35 -08001940 return 0;
Arve Hjønnevåg403f3072009-02-14 02:07:24 +01001941 }
Linus Torvalds1da177e2005-04-16 15:20:36 -07001942 console_locked = 1;
1943 console_may_schedule = 0;
Torben Hohnac751ef2011-01-25 15:07:35 -08001944 return 1;
Linus Torvalds1da177e2005-04-16 15:20:36 -07001945}
Torben Hohnac751ef2011-01-25 15:07:35 -08001946EXPORT_SYMBOL(console_trylock);
Linus Torvalds1da177e2005-04-16 15:20:36 -07001947
1948int is_console_locked(void)
1949{
1950 return console_locked;
1951}
Linus Torvalds1da177e2005-04-16 15:20:36 -07001952
Peter Zijlstra3ccf3e82012-02-27 10:47:00 +01001953/*
Kay Sievers7ff95542012-05-03 02:29:13 +02001954 * Delayed printk version, for scheduler-internal messages:
Peter Zijlstra3ccf3e82012-02-27 10:47:00 +01001955 */
1956#define PRINTK_BUF_SIZE 512
1957
1958#define PRINTK_PENDING_WAKEUP 0x01
1959#define PRINTK_PENDING_SCHED 0x02
1960
Peter Zijlstrab845b512008-08-08 21:47:09 +02001961static DEFINE_PER_CPU(int, printk_pending);
Peter Zijlstra3ccf3e82012-02-27 10:47:00 +01001962static DEFINE_PER_CPU(char [PRINTK_BUF_SIZE], printk_sched_buf);
Peter Zijlstrab845b512008-08-08 21:47:09 +02001963
1964void printk_tick(void)
1965{
Eric Dumazet40dc11f2010-11-26 17:22:16 +01001966 if (__this_cpu_read(printk_pending)) {
Peter Zijlstra3ccf3e82012-02-27 10:47:00 +01001967 int pending = __this_cpu_xchg(printk_pending, 0);
1968 if (pending & PRINTK_PENDING_SCHED) {
1969 char *buf = __get_cpu_var(printk_sched_buf);
1970 printk(KERN_WARNING "[sched_delayed] %s", buf);
1971 }
1972 if (pending & PRINTK_PENDING_WAKEUP)
1973 wake_up_interruptible(&log_wait);
Peter Zijlstrab845b512008-08-08 21:47:09 +02001974 }
1975}
1976
1977int printk_needs_cpu(int cpu)
1978{
Eric Dumazet40dc11f2010-11-26 17:22:16 +01001979 if (cpu_is_offline(cpu))
Heiko Carstens61ab25442010-11-26 13:00:59 +01001980 printk_tick();
Eric Dumazet40dc11f2010-11-26 17:22:16 +01001981 return __this_cpu_read(printk_pending);
Peter Zijlstrab845b512008-08-08 21:47:09 +02001982}
1983
Kirill Korotaeve3e8a752007-02-10 01:46:19 -08001984void wake_up_klogd(void)
1985{
Peter Zijlstrab845b512008-08-08 21:47:09 +02001986 if (waitqueue_active(&log_wait))
Peter Zijlstra3ccf3e82012-02-27 10:47:00 +01001987 this_cpu_or(printk_pending, PRINTK_PENDING_WAKEUP);
Kirill Korotaeve3e8a752007-02-10 01:46:19 -08001988}
1989
Kay Sieverseab07262012-07-16 18:35:30 -07001990static void console_cont_flush(char *text, size_t size)
1991{
1992 unsigned long flags;
1993 size_t len;
1994
1995 raw_spin_lock_irqsave(&logbuf_lock, flags);
1996
1997 if (!cont.len)
1998 goto out;
1999
2000 /*
2001 * We still queue earlier records, likely because the console was
2002 * busy. The earlier ones need to be printed before this one, we
2003 * did not flush any fragment so far, so just let it queue up.
2004 */
2005 if (console_seq < log_next_seq && !cont.cons)
2006 goto out;
2007
2008 len = cont_print_text(text, size);
2009 raw_spin_unlock(&logbuf_lock);
2010 stop_critical_timings();
2011 call_console_drivers(cont.level, text, len);
2012 start_critical_timings();
2013 local_irq_restore(flags);
2014 return;
2015out:
2016 raw_spin_unlock_irqrestore(&logbuf_lock, flags);
2017}
Kay Sievers7ff95542012-05-03 02:29:13 +02002018
Linus Torvalds1da177e2005-04-16 15:20:36 -07002019/**
Torben Hohnac751ef2011-01-25 15:07:35 -08002020 * console_unlock - unlock the console system
Linus Torvalds1da177e2005-04-16 15:20:36 -07002021 *
Torben Hohnac751ef2011-01-25 15:07:35 -08002022 * Releases the console_lock which the caller holds on the console system
Linus Torvalds1da177e2005-04-16 15:20:36 -07002023 * and the console driver list.
2024 *
Torben Hohnac751ef2011-01-25 15:07:35 -08002025 * While the console_lock was held, console output may have been buffered
2026 * by printk(). If this is the case, console_unlock(); emits
2027 * the output prior to releasing the lock.
Linus Torvalds1da177e2005-04-16 15:20:36 -07002028 *
Kay Sievers7f3a7812012-05-09 01:37:51 +02002029 * If there is output waiting, we wake /dev/kmsg and syslog() users.
Linus Torvalds1da177e2005-04-16 15:20:36 -07002030 *
Torben Hohnac751ef2011-01-25 15:07:35 -08002031 * console_unlock(); may be called from any context.
Linus Torvalds1da177e2005-04-16 15:20:36 -07002032 */
Torben Hohnac751ef2011-01-25 15:07:35 -08002033void console_unlock(void)
Linus Torvalds1da177e2005-04-16 15:20:36 -07002034{
Kay Sievers70498252012-07-16 18:35:29 -07002035 static char text[LOG_LINE_MAX + PREFIX_MAX];
Kay Sievers7ff95542012-05-03 02:29:13 +02002036 static u64 seen_seq;
Linus Torvalds1da177e2005-04-16 15:20:36 -07002037 unsigned long flags;
Kay Sievers7ff95542012-05-03 02:29:13 +02002038 bool wake_klogd = false;
2039 bool retry;
Linus Torvalds1da177e2005-04-16 15:20:36 -07002040
Linus Torvalds557240b2006-06-19 18:16:01 -07002041 if (console_suspended) {
Arve Hjønnevåg403f3072009-02-14 02:07:24 +01002042 up(&console_sem);
Linus Torvalds557240b2006-06-19 18:16:01 -07002043 return;
2044 }
Antonino A. Daplas78944e52006-08-05 12:14:16 -07002045
2046 console_may_schedule = 0;
2047
Kay Sievers084681d2012-06-28 09:38:53 +02002048 /* flush buffered message fragment immediately to console */
Kay Sieverseab07262012-07-16 18:35:30 -07002049 console_cont_flush(text, sizeof(text));
Peter Zijlstra4f2a8d32011-06-22 11:20:09 +02002050again:
Kay Sievers7ff95542012-05-03 02:29:13 +02002051 for (;;) {
2052 struct log *msg;
Kay Sievers3ce9a7c2012-05-13 23:30:46 +02002053 size_t len;
Kay Sievers7ff95542012-05-03 02:29:13 +02002054 int level;
2055
Thomas Gleixner07354eb2009-07-25 17:50:36 +02002056 raw_spin_lock_irqsave(&logbuf_lock, flags);
Kay Sievers7ff95542012-05-03 02:29:13 +02002057 if (seen_seq != log_next_seq) {
2058 wake_klogd = true;
2059 seen_seq = log_next_seq;
2060 }
2061
2062 if (console_seq < log_first_seq) {
2063 /* messages are gone, move to first one */
2064 console_seq = log_first_seq;
2065 console_idx = log_first_idx;
Kay Sievers5becfb12012-07-09 12:15:42 -07002066 console_prev = 0;
Kay Sievers7ff95542012-05-03 02:29:13 +02002067 }
Kay Sievers084681d2012-06-28 09:38:53 +02002068skip:
Kay Sievers7ff95542012-05-03 02:29:13 +02002069 if (console_seq == log_next_seq)
2070 break;
2071
2072 msg = log_from_idx(console_idx);
Kay Sievers084681d2012-06-28 09:38:53 +02002073 if (msg->flags & LOG_NOCONS) {
2074 /*
2075 * Skip record we have buffered and already printed
2076 * directly to the console when we received it.
2077 */
2078 console_idx = log_next(console_idx);
2079 console_seq++;
Kay Sievers68b65072012-07-06 09:50:09 -07002080 /*
2081 * We will get here again when we register a new
2082 * CON_PRINTBUFFER console. Clear the flag so we
2083 * will properly dump everything later.
2084 */
2085 msg->flags &= ~LOG_NOCONS;
Kay Sieverseab07262012-07-16 18:35:30 -07002086 console_prev = msg->flags;
Kay Sievers084681d2012-06-28 09:38:53 +02002087 goto skip;
2088 }
Kay Sievers649e6ee2012-05-10 04:30:45 +02002089
Kay Sievers084681d2012-06-28 09:38:53 +02002090 level = msg->level;
Kay Sievers5becfb12012-07-09 12:15:42 -07002091 len = msg_print_text(msg, console_prev, false,
2092 text, sizeof(text));
Kay Sievers7ff95542012-05-03 02:29:13 +02002093 console_idx = log_next(console_idx);
2094 console_seq++;
Kay Sievers5becfb12012-07-09 12:15:42 -07002095 console_prev = msg->flags;
Thomas Gleixner07354eb2009-07-25 17:50:36 +02002096 raw_spin_unlock(&logbuf_lock);
Kay Sievers7ff95542012-05-03 02:29:13 +02002097
Steven Rostedt81d68a92008-05-12 21:20:42 +02002098 stop_critical_timings(); /* don't trace print latency */
Kay Sievers7ff95542012-05-03 02:29:13 +02002099 call_console_drivers(level, text, len);
Steven Rostedt81d68a92008-05-12 21:20:42 +02002100 start_critical_timings();
Linus Torvalds1da177e2005-04-16 15:20:36 -07002101 local_irq_restore(flags);
2102 }
2103 console_locked = 0;
Feng Tangfe3d8ad2011-03-22 16:34:21 -07002104
2105 /* Release the exclusive_console once it is used */
2106 if (unlikely(exclusive_console))
2107 exclusive_console = NULL;
2108
Thomas Gleixner07354eb2009-07-25 17:50:36 +02002109 raw_spin_unlock(&logbuf_lock);
Peter Zijlstra4f2a8d32011-06-22 11:20:09 +02002110
Peter Zijlstra0b5e1c52011-06-07 11:15:33 +02002111 up(&console_sem);
Peter Zijlstra4f2a8d32011-06-22 11:20:09 +02002112
2113 /*
2114 * Someone could have filled up the buffer again, so re-check if there's
2115 * something to flush. In case we cannot trylock the console_sem again,
2116 * there's a new owner and the console_unlock() from them will do the
2117 * flush, no worries.
2118 */
Thomas Gleixner07354eb2009-07-25 17:50:36 +02002119 raw_spin_lock(&logbuf_lock);
Kay Sievers7ff95542012-05-03 02:29:13 +02002120 retry = console_seq != log_next_seq;
Peter Zijlstra09dc3cf2011-12-08 14:34:13 -08002121 raw_spin_unlock_irqrestore(&logbuf_lock, flags);
2122
Peter Zijlstra4f2a8d32011-06-22 11:20:09 +02002123 if (retry && console_trylock())
2124 goto again;
2125
Kirill Korotaeve3e8a752007-02-10 01:46:19 -08002126 if (wake_klogd)
2127 wake_up_klogd();
Linus Torvalds1da177e2005-04-16 15:20:36 -07002128}
Torben Hohnac751ef2011-01-25 15:07:35 -08002129EXPORT_SYMBOL(console_unlock);
Linus Torvalds1da177e2005-04-16 15:20:36 -07002130
Martin Waitzddad86c2005-11-13 16:08:14 -08002131/**
2132 * console_conditional_schedule - yield the CPU if required
Linus Torvalds1da177e2005-04-16 15:20:36 -07002133 *
2134 * If the console code is currently allowed to sleep, and
2135 * if this CPU should yield the CPU to another task, do
2136 * so here.
2137 *
Torben Hohnac751ef2011-01-25 15:07:35 -08002138 * Must be called within console_lock();.
Linus Torvalds1da177e2005-04-16 15:20:36 -07002139 */
2140void __sched console_conditional_schedule(void)
2141{
2142 if (console_may_schedule)
2143 cond_resched();
2144}
2145EXPORT_SYMBOL(console_conditional_schedule);
2146
Linus Torvalds1da177e2005-04-16 15:20:36 -07002147void console_unblank(void)
2148{
2149 struct console *c;
2150
2151 /*
2152 * console_unblank can no longer be called in interrupt context unless
2153 * oops_in_progress is set to 1..
2154 */
2155 if (oops_in_progress) {
2156 if (down_trylock(&console_sem) != 0)
2157 return;
2158 } else
Torben Hohnac751ef2011-01-25 15:07:35 -08002159 console_lock();
Linus Torvalds1da177e2005-04-16 15:20:36 -07002160
2161 console_locked = 1;
2162 console_may_schedule = 0;
Robin Getz4d091612009-07-01 21:08:37 -04002163 for_each_console(c)
Linus Torvalds1da177e2005-04-16 15:20:36 -07002164 if ((c->flags & CON_ENABLED) && c->unblank)
2165 c->unblank();
Torben Hohnac751ef2011-01-25 15:07:35 -08002166 console_unlock();
Linus Torvalds1da177e2005-04-16 15:20:36 -07002167}
Linus Torvalds1da177e2005-04-16 15:20:36 -07002168
2169/*
2170 * Return the console tty driver structure and its associated index
2171 */
2172struct tty_driver *console_device(int *index)
2173{
2174 struct console *c;
2175 struct tty_driver *driver = NULL;
2176
Torben Hohnac751ef2011-01-25 15:07:35 -08002177 console_lock();
Robin Getz4d091612009-07-01 21:08:37 -04002178 for_each_console(c) {
Linus Torvalds1da177e2005-04-16 15:20:36 -07002179 if (!c->device)
2180 continue;
2181 driver = c->device(c, index);
2182 if (driver)
2183 break;
2184 }
Torben Hohnac751ef2011-01-25 15:07:35 -08002185 console_unlock();
Linus Torvalds1da177e2005-04-16 15:20:36 -07002186 return driver;
2187}
2188
2189/*
2190 * Prevent further output on the passed console device so that (for example)
2191 * serial drivers can disable console output before suspending a port, and can
2192 * re-enable output afterwards.
2193 */
2194void console_stop(struct console *console)
2195{
Torben Hohnac751ef2011-01-25 15:07:35 -08002196 console_lock();
Linus Torvalds1da177e2005-04-16 15:20:36 -07002197 console->flags &= ~CON_ENABLED;
Torben Hohnac751ef2011-01-25 15:07:35 -08002198 console_unlock();
Linus Torvalds1da177e2005-04-16 15:20:36 -07002199}
2200EXPORT_SYMBOL(console_stop);
2201
2202void console_start(struct console *console)
2203{
Torben Hohnac751ef2011-01-25 15:07:35 -08002204 console_lock();
Linus Torvalds1da177e2005-04-16 15:20:36 -07002205 console->flags |= CON_ENABLED;
Torben Hohnac751ef2011-01-25 15:07:35 -08002206 console_unlock();
Linus Torvalds1da177e2005-04-16 15:20:36 -07002207}
2208EXPORT_SYMBOL(console_start);
2209
Fabio M. Di Nitto7bf69392011-03-22 16:34:20 -07002210static int __read_mostly keep_bootcon;
2211
2212static int __init keep_bootcon_setup(char *str)
2213{
2214 keep_bootcon = 1;
2215 printk(KERN_INFO "debug: skip boot console de-registration.\n");
2216
2217 return 0;
2218}
2219
2220early_param("keep_bootcon", keep_bootcon_setup);
2221
Linus Torvalds1da177e2005-04-16 15:20:36 -07002222/*
2223 * The console driver calls this routine during kernel initialization
2224 * to register the console printing procedure with printk() and to
2225 * print any messages that were printed by the kernel before the
2226 * console driver was initialized.
Robin Getz4d091612009-07-01 21:08:37 -04002227 *
2228 * This can happen pretty early during the boot process (because of
2229 * early_printk) - sometimes before setup_arch() completes - be careful
2230 * of what kernel features are used - they may not be initialised yet.
2231 *
2232 * There are two types of consoles - bootconsoles (early_printk) and
2233 * "real" consoles (everything which is not a bootconsole) which are
2234 * handled differently.
2235 * - Any number of bootconsoles can be registered at any time.
2236 * - As soon as a "real" console is registered, all bootconsoles
2237 * will be unregistered automatically.
2238 * - Once a "real" console is registered, any attempt to register a
2239 * bootconsoles will be rejected
Linus Torvalds1da177e2005-04-16 15:20:36 -07002240 */
Robin Getz4d091612009-07-01 21:08:37 -04002241void register_console(struct console *newcon)
Linus Torvalds1da177e2005-04-16 15:20:36 -07002242{
Jesper Juhl40dc5652005-10-30 15:02:46 -08002243 int i;
Linus Torvalds1da177e2005-04-16 15:20:36 -07002244 unsigned long flags;
Robin Getz4d091612009-07-01 21:08:37 -04002245 struct console *bcon = NULL;
Linus Torvalds1da177e2005-04-16 15:20:36 -07002246
Robin Getz4d091612009-07-01 21:08:37 -04002247 /*
2248 * before we register a new CON_BOOT console, make sure we don't
2249 * already have a valid console
2250 */
2251 if (console_drivers && newcon->flags & CON_BOOT) {
2252 /* find the last or real console */
2253 for_each_console(bcon) {
2254 if (!(bcon->flags & CON_BOOT)) {
2255 printk(KERN_INFO "Too late to register bootconsole %s%d\n",
2256 newcon->name, newcon->index);
2257 return;
2258 }
2259 }
Gerd Hoffmann69331af2007-05-08 00:26:49 -07002260 }
2261
Robin Getz4d091612009-07-01 21:08:37 -04002262 if (console_drivers && console_drivers->flags & CON_BOOT)
2263 bcon = console_drivers;
2264
2265 if (preferred_console < 0 || bcon || !console_drivers)
Linus Torvalds1da177e2005-04-16 15:20:36 -07002266 preferred_console = selected_console;
2267
Robin Getz4d091612009-07-01 21:08:37 -04002268 if (newcon->early_setup)
2269 newcon->early_setup();
Yinghai Lu18a8bd92007-07-15 23:37:59 -07002270
Linus Torvalds1da177e2005-04-16 15:20:36 -07002271 /*
2272 * See if we want to use this console driver. If we
2273 * didn't select a console we take the first one
2274 * that registers here.
2275 */
2276 if (preferred_console < 0) {
Robin Getz4d091612009-07-01 21:08:37 -04002277 if (newcon->index < 0)
2278 newcon->index = 0;
2279 if (newcon->setup == NULL ||
2280 newcon->setup(newcon, NULL) == 0) {
2281 newcon->flags |= CON_ENABLED;
2282 if (newcon->device) {
2283 newcon->flags |= CON_CONSDEV;
Jan Kiszkacd3a1b82008-05-12 21:21:04 +02002284 preferred_console = 0;
2285 }
Linus Torvalds1da177e2005-04-16 15:20:36 -07002286 }
2287 }
2288
2289 /*
2290 * See if this console matches one we selected on
2291 * the command line.
2292 */
Jesper Juhl40dc5652005-10-30 15:02:46 -08002293 for (i = 0; i < MAX_CMDLINECONSOLES && console_cmdline[i].name[0];
2294 i++) {
Robin Getz4d091612009-07-01 21:08:37 -04002295 if (strcmp(console_cmdline[i].name, newcon->name) != 0)
Linus Torvalds1da177e2005-04-16 15:20:36 -07002296 continue;
Robin Getz4d091612009-07-01 21:08:37 -04002297 if (newcon->index >= 0 &&
2298 newcon->index != console_cmdline[i].index)
Linus Torvalds1da177e2005-04-16 15:20:36 -07002299 continue;
Robin Getz4d091612009-07-01 21:08:37 -04002300 if (newcon->index < 0)
2301 newcon->index = console_cmdline[i].index;
Samuel Thibaultf7511d52008-04-30 00:54:51 -07002302#ifdef CONFIG_A11Y_BRAILLE_CONSOLE
2303 if (console_cmdline[i].brl_options) {
Robin Getz4d091612009-07-01 21:08:37 -04002304 newcon->flags |= CON_BRL;
2305 braille_register_console(newcon,
Samuel Thibaultf7511d52008-04-30 00:54:51 -07002306 console_cmdline[i].index,
2307 console_cmdline[i].options,
2308 console_cmdline[i].brl_options);
2309 return;
2310 }
2311#endif
Robin Getz4d091612009-07-01 21:08:37 -04002312 if (newcon->setup &&
2313 newcon->setup(newcon, console_cmdline[i].options) != 0)
Linus Torvalds1da177e2005-04-16 15:20:36 -07002314 break;
Robin Getz4d091612009-07-01 21:08:37 -04002315 newcon->flags |= CON_ENABLED;
2316 newcon->index = console_cmdline[i].index;
Greg Edwardsab4af032005-06-23 00:09:05 -07002317 if (i == selected_console) {
Robin Getz4d091612009-07-01 21:08:37 -04002318 newcon->flags |= CON_CONSDEV;
Greg Edwardsab4af032005-06-23 00:09:05 -07002319 preferred_console = selected_console;
2320 }
Linus Torvalds1da177e2005-04-16 15:20:36 -07002321 break;
2322 }
2323
Robin Getz4d091612009-07-01 21:08:37 -04002324 if (!(newcon->flags & CON_ENABLED))
Linus Torvalds1da177e2005-04-16 15:20:36 -07002325 return;
2326
Robin Getz8259cf42009-07-09 13:08:37 -04002327 /*
2328 * If we have a bootconsole, and are switching to a real console,
2329 * don't print everything out again, since when the boot console, and
2330 * the real console are the same physical device, it's annoying to
2331 * see the beginning boot messages twice
2332 */
2333 if (bcon && ((newcon->flags & (CON_CONSDEV | CON_BOOT)) == CON_CONSDEV))
Robin Getz4d091612009-07-01 21:08:37 -04002334 newcon->flags &= ~CON_PRINTBUFFER;
Linus Torvalds1da177e2005-04-16 15:20:36 -07002335
2336 /*
2337 * Put this console in the list - keep the
2338 * preferred driver at the head of the list.
2339 */
Torben Hohnac751ef2011-01-25 15:07:35 -08002340 console_lock();
Robin Getz4d091612009-07-01 21:08:37 -04002341 if ((newcon->flags & CON_CONSDEV) || console_drivers == NULL) {
2342 newcon->next = console_drivers;
2343 console_drivers = newcon;
2344 if (newcon->next)
2345 newcon->next->flags &= ~CON_CONSDEV;
Linus Torvalds1da177e2005-04-16 15:20:36 -07002346 } else {
Robin Getz4d091612009-07-01 21:08:37 -04002347 newcon->next = console_drivers->next;
2348 console_drivers->next = newcon;
Linus Torvalds1da177e2005-04-16 15:20:36 -07002349 }
Robin Getz4d091612009-07-01 21:08:37 -04002350 if (newcon->flags & CON_PRINTBUFFER) {
Linus Torvalds1da177e2005-04-16 15:20:36 -07002351 /*
Torben Hohnac751ef2011-01-25 15:07:35 -08002352 * console_unlock(); will print out the buffered messages
Linus Torvalds1da177e2005-04-16 15:20:36 -07002353 * for us.
2354 */
Thomas Gleixner07354eb2009-07-25 17:50:36 +02002355 raw_spin_lock_irqsave(&logbuf_lock, flags);
Kay Sievers7ff95542012-05-03 02:29:13 +02002356 console_seq = syslog_seq;
2357 console_idx = syslog_idx;
Kay Sievers5becfb12012-07-09 12:15:42 -07002358 console_prev = syslog_prev;
Thomas Gleixner07354eb2009-07-25 17:50:36 +02002359 raw_spin_unlock_irqrestore(&logbuf_lock, flags);
Feng Tangfe3d8ad2011-03-22 16:34:21 -07002360 /*
2361 * We're about to replay the log buffer. Only do this to the
2362 * just-registered console to avoid excessive message spam to
2363 * the already-registered consoles.
2364 */
2365 exclusive_console = newcon;
Linus Torvalds1da177e2005-04-16 15:20:36 -07002366 }
Torben Hohnac751ef2011-01-25 15:07:35 -08002367 console_unlock();
Kay Sieversfbc92a32010-12-01 18:51:05 +01002368 console_sysfs_notify();
Robin Getz8259cf42009-07-09 13:08:37 -04002369
2370 /*
2371 * By unregistering the bootconsoles after we enable the real console
2372 * we get the "console xxx enabled" message on all the consoles -
2373 * boot consoles, real consoles, etc - this is to ensure that end
2374 * users know there might be something in the kernel's log buffer that
2375 * went to the bootconsole (that they do not see on the real console)
2376 */
Fabio M. Di Nitto7bf69392011-03-22 16:34:20 -07002377 if (bcon &&
2378 ((newcon->flags & (CON_CONSDEV | CON_BOOT)) == CON_CONSDEV) &&
2379 !keep_bootcon) {
Robin Getz8259cf42009-07-09 13:08:37 -04002380 /* we need to iterate through twice, to make sure we print
2381 * everything out, before we unregister the console(s)
2382 */
2383 printk(KERN_INFO "console [%s%d] enabled, bootconsole disabled\n",
2384 newcon->name, newcon->index);
2385 for_each_console(bcon)
2386 if (bcon->flags & CON_BOOT)
2387 unregister_console(bcon);
2388 } else {
2389 printk(KERN_INFO "%sconsole [%s%d] enabled\n",
2390 (newcon->flags & CON_BOOT) ? "boot" : "" ,
2391 newcon->name, newcon->index);
2392 }
Linus Torvalds1da177e2005-04-16 15:20:36 -07002393}
2394EXPORT_SYMBOL(register_console);
2395
Jesper Juhl40dc5652005-10-30 15:02:46 -08002396int unregister_console(struct console *console)
Linus Torvalds1da177e2005-04-16 15:20:36 -07002397{
Jesper Juhl40dc5652005-10-30 15:02:46 -08002398 struct console *a, *b;
Linus Torvalds1da177e2005-04-16 15:20:36 -07002399 int res = 1;
2400
Samuel Thibaultf7511d52008-04-30 00:54:51 -07002401#ifdef CONFIG_A11Y_BRAILLE_CONSOLE
2402 if (console->flags & CON_BRL)
2403 return braille_unregister_console(console);
2404#endif
2405
Torben Hohnac751ef2011-01-25 15:07:35 -08002406 console_lock();
Linus Torvalds1da177e2005-04-16 15:20:36 -07002407 if (console_drivers == console) {
2408 console_drivers=console->next;
2409 res = 0;
Benjamin Herrenschmidte9b15b52005-11-23 13:37:44 -08002410 } else if (console_drivers) {
Linus Torvalds1da177e2005-04-16 15:20:36 -07002411 for (a=console_drivers->next, b=console_drivers ;
2412 a; b=a, a=b->next) {
2413 if (a == console) {
2414 b->next = a->next;
2415 res = 0;
2416 break;
Jesper Juhl40dc5652005-10-30 15:02:46 -08002417 }
Linus Torvalds1da177e2005-04-16 15:20:36 -07002418 }
2419 }
Jesper Juhl40dc5652005-10-30 15:02:46 -08002420
Gerd Hoffmann69331af2007-05-08 00:26:49 -07002421 /*
Greg Edwardsab4af032005-06-23 00:09:05 -07002422 * If this isn't the last console and it has CON_CONSDEV set, we
2423 * need to set it on the next preferred console.
Linus Torvalds1da177e2005-04-16 15:20:36 -07002424 */
Gerd Hoffmann69331af2007-05-08 00:26:49 -07002425 if (console_drivers != NULL && console->flags & CON_CONSDEV)
Greg Edwardsab4af032005-06-23 00:09:05 -07002426 console_drivers->flags |= CON_CONSDEV;
Linus Torvalds1da177e2005-04-16 15:20:36 -07002427
Torben Hohnac751ef2011-01-25 15:07:35 -08002428 console_unlock();
Kay Sieversfbc92a32010-12-01 18:51:05 +01002429 console_sysfs_notify();
Linus Torvalds1da177e2005-04-16 15:20:36 -07002430 return res;
2431}
2432EXPORT_SYMBOL(unregister_console);
Matt Mackalld59745c2005-05-01 08:59:02 -07002433
Kevin Cernekee034260d2010-06-03 22:11:25 -07002434static int __init printk_late_init(void)
Robin Getz0c5564b2007-08-20 15:22:47 -04002435{
Robin Getz4d091612009-07-01 21:08:37 -04002436 struct console *con;
2437
2438 for_each_console(con) {
Nishanth Aravamudan4c30c6f2011-08-25 15:59:11 -07002439 if (!keep_bootcon && con->flags & CON_BOOT) {
Robin Getzcb00e992007-08-21 23:14:58 -04002440 printk(KERN_INFO "turn off boot console %s%d\n",
Robin Getz4d091612009-07-01 21:08:37 -04002441 con->name, con->index);
Sonic Zhang42c2c8c2009-08-06 15:58:11 -07002442 unregister_console(con);
Robin Getzcb00e992007-08-21 23:14:58 -04002443 }
Robin Getz0c5564b2007-08-20 15:22:47 -04002444 }
Kevin Cernekee034260d2010-06-03 22:11:25 -07002445 hotcpu_notifier(console_cpu_notify, 0);
Robin Getz0c5564b2007-08-20 15:22:47 -04002446 return 0;
2447}
Kevin Cernekee034260d2010-06-03 22:11:25 -07002448late_initcall(printk_late_init);
Robin Getz0c5564b2007-08-20 15:22:47 -04002449
Joe Perches7ef3d2f2008-02-08 04:21:25 -08002450#if defined CONFIG_PRINTK
Dave Young717115e2008-07-25 01:45:58 -07002451
Peter Zijlstra600e1452012-03-15 12:35:37 +01002452int printk_sched(const char *fmt, ...)
2453{
2454 unsigned long flags;
2455 va_list args;
2456 char *buf;
2457 int r;
2458
2459 local_irq_save(flags);
2460 buf = __get_cpu_var(printk_sched_buf);
2461
2462 va_start(args, fmt);
2463 r = vsnprintf(buf, PRINTK_BUF_SIZE, fmt, args);
2464 va_end(args);
2465
2466 __this_cpu_or(printk_pending, PRINTK_PENDING_SCHED);
2467 local_irq_restore(flags);
2468
2469 return r;
2470}
2471
Linus Torvalds1da177e2005-04-16 15:20:36 -07002472/*
2473 * printk rate limiting, lifted from the networking subsystem.
2474 *
Uwe Kleine-König641de9d2008-07-29 22:33:38 -07002475 * This enforces a rate limit: not more than 10 kernel messages
2476 * every 5s to make a denial-of-service attack impossible.
Linus Torvalds1da177e2005-04-16 15:20:36 -07002477 */
Uwe Kleine-König641de9d2008-07-29 22:33:38 -07002478DEFINE_RATELIMIT_STATE(printk_ratelimit_state, 5 * HZ, 10);
2479
Christian Borntraeger5c828712009-10-23 14:58:11 +02002480int __printk_ratelimit(const char *func)
Linus Torvalds1da177e2005-04-16 15:20:36 -07002481{
Christian Borntraeger5c828712009-10-23 14:58:11 +02002482 return ___ratelimit(&printk_ratelimit_state, func);
Linus Torvalds1da177e2005-04-16 15:20:36 -07002483}
Christian Borntraeger5c828712009-10-23 14:58:11 +02002484EXPORT_SYMBOL(__printk_ratelimit);
Andrew Mortonf46c4832006-11-02 22:07:16 -08002485
2486/**
2487 * printk_timed_ratelimit - caller-controlled printk ratelimiting
2488 * @caller_jiffies: pointer to caller's state
2489 * @interval_msecs: minimum interval between prints
2490 *
2491 * printk_timed_ratelimit() returns true if more than @interval_msecs
2492 * milliseconds have elapsed since the last time printk_timed_ratelimit()
2493 * returned true.
2494 */
2495bool printk_timed_ratelimit(unsigned long *caller_jiffies,
2496 unsigned int interval_msecs)
2497{
Guillaume Knispelf2d28a22009-03-17 16:18:42 +01002498 if (*caller_jiffies == 0
2499 || !time_in_range(jiffies, *caller_jiffies,
2500 *caller_jiffies
2501 + msecs_to_jiffies(interval_msecs))) {
2502 *caller_jiffies = jiffies;
Andrew Mortonf46c4832006-11-02 22:07:16 -08002503 return true;
2504 }
2505 return false;
2506}
2507EXPORT_SYMBOL(printk_timed_ratelimit);
Simon Kagstrom456b5652009-10-16 14:09:18 +02002508
2509static DEFINE_SPINLOCK(dump_list_lock);
2510static LIST_HEAD(dump_list);
2511
2512/**
2513 * kmsg_dump_register - register a kernel log dumper.
Randy Dunlap64855362009-12-17 15:27:27 -08002514 * @dumper: pointer to the kmsg_dumper structure
Simon Kagstrom456b5652009-10-16 14:09:18 +02002515 *
2516 * Adds a kernel log dumper to the system. The dump callback in the
2517 * structure will be called when the kernel oopses or panics and must be
2518 * set. Returns zero on success and %-EINVAL or %-EBUSY otherwise.
2519 */
2520int kmsg_dump_register(struct kmsg_dumper *dumper)
2521{
2522 unsigned long flags;
2523 int err = -EBUSY;
2524
2525 /* The dump callback needs to be set */
2526 if (!dumper->dump)
2527 return -EINVAL;
2528
2529 spin_lock_irqsave(&dump_list_lock, flags);
2530 /* Don't allow registering multiple times */
2531 if (!dumper->registered) {
2532 dumper->registered = 1;
Huang Yingfb842b02011-01-12 16:59:43 -08002533 list_add_tail_rcu(&dumper->list, &dump_list);
Simon Kagstrom456b5652009-10-16 14:09:18 +02002534 err = 0;
2535 }
2536 spin_unlock_irqrestore(&dump_list_lock, flags);
2537
2538 return err;
2539}
2540EXPORT_SYMBOL_GPL(kmsg_dump_register);
2541
2542/**
2543 * kmsg_dump_unregister - unregister a kmsg dumper.
Randy Dunlap64855362009-12-17 15:27:27 -08002544 * @dumper: pointer to the kmsg_dumper structure
Simon Kagstrom456b5652009-10-16 14:09:18 +02002545 *
2546 * Removes a dump device from the system. Returns zero on success and
2547 * %-EINVAL otherwise.
2548 */
2549int kmsg_dump_unregister(struct kmsg_dumper *dumper)
2550{
2551 unsigned long flags;
2552 int err = -EINVAL;
2553
2554 spin_lock_irqsave(&dump_list_lock, flags);
2555 if (dumper->registered) {
2556 dumper->registered = 0;
Huang Yingfb842b02011-01-12 16:59:43 -08002557 list_del_rcu(&dumper->list);
Simon Kagstrom456b5652009-10-16 14:09:18 +02002558 err = 0;
2559 }
2560 spin_unlock_irqrestore(&dump_list_lock, flags);
Huang Yingfb842b02011-01-12 16:59:43 -08002561 synchronize_rcu();
Simon Kagstrom456b5652009-10-16 14:09:18 +02002562
2563 return err;
2564}
2565EXPORT_SYMBOL_GPL(kmsg_dump_unregister);
2566
Kay Sievers7ff95542012-05-03 02:29:13 +02002567static bool always_kmsg_dump;
2568module_param_named(always_kmsg_dump, always_kmsg_dump, bool, S_IRUGO | S_IWUSR);
2569
Simon Kagstrom456b5652009-10-16 14:09:18 +02002570/**
2571 * kmsg_dump - dump kernel log to kernel message dumpers.
2572 * @reason: the reason (oops, panic etc) for dumping
2573 *
Kay Sieverse2ae7152012-06-15 14:07:51 +02002574 * Call each of the registered dumper's dump() callback, which can
2575 * retrieve the kmsg records with kmsg_dump_get_line() or
2576 * kmsg_dump_get_buffer().
Simon Kagstrom456b5652009-10-16 14:09:18 +02002577 */
2578void kmsg_dump(enum kmsg_dump_reason reason)
2579{
Simon Kagstrom456b5652009-10-16 14:09:18 +02002580 struct kmsg_dumper *dumper;
Simon Kagstrom456b5652009-10-16 14:09:18 +02002581 unsigned long flags;
2582
Matthew Garrettc22ab332012-03-05 14:59:10 -08002583 if ((reason > KMSG_DUMP_OOPS) && !always_kmsg_dump)
2584 return;
2585
Huang Yingfb842b02011-01-12 16:59:43 -08002586 rcu_read_lock();
Kay Sieverse2ae7152012-06-15 14:07:51 +02002587 list_for_each_entry_rcu(dumper, &dump_list, list) {
2588 if (dumper->max_reason && reason > dumper->max_reason)
2589 continue;
2590
2591 /* initialize iterator with data about the stored records */
2592 dumper->active = true;
2593
2594 raw_spin_lock_irqsave(&logbuf_lock, flags);
2595 dumper->cur_seq = clear_seq;
2596 dumper->cur_idx = clear_idx;
2597 dumper->next_seq = log_next_seq;
2598 dumper->next_idx = log_next_idx;
2599 raw_spin_unlock_irqrestore(&logbuf_lock, flags);
2600
2601 /* invoke dumper which will iterate over records */
2602 dumper->dump(dumper, reason);
2603
2604 /* reset iterator */
2605 dumper->active = false;
2606 }
Huang Yingfb842b02011-01-12 16:59:43 -08002607 rcu_read_unlock();
Simon Kagstrom456b5652009-10-16 14:09:18 +02002608}
Kay Sieverse2ae7152012-06-15 14:07:51 +02002609
2610/**
2611 * kmsg_dump_get_line - retrieve one kmsg log line
2612 * @dumper: registered kmsg dumper
2613 * @syslog: include the "<4>" prefixes
2614 * @line: buffer to copy the line to
2615 * @size: maximum size of the buffer
2616 * @len: length of line placed into buffer
2617 *
2618 * Start at the beginning of the kmsg buffer, with the oldest kmsg
2619 * record, and copy one record into the provided buffer.
2620 *
2621 * Consecutive calls will return the next available record moving
2622 * towards the end of the buffer with the youngest messages.
2623 *
2624 * A return value of FALSE indicates that there are no more records to
2625 * read.
2626 */
2627bool kmsg_dump_get_line(struct kmsg_dumper *dumper, bool syslog,
2628 char *line, size_t size, size_t *len)
2629{
2630 unsigned long flags;
2631 struct log *msg;
2632 size_t l = 0;
2633 bool ret = false;
2634
2635 if (!dumper->active)
2636 goto out;
2637
2638 raw_spin_lock_irqsave(&logbuf_lock, flags);
2639 if (dumper->cur_seq < log_first_seq) {
2640 /* messages are gone, move to first available one */
2641 dumper->cur_seq = log_first_seq;
2642 dumper->cur_idx = log_first_idx;
2643 }
2644
2645 /* last entry */
2646 if (dumper->cur_seq >= log_next_seq) {
2647 raw_spin_unlock_irqrestore(&logbuf_lock, flags);
2648 goto out;
2649 }
2650
2651 msg = log_from_idx(dumper->cur_idx);
Kay Sievers5becfb12012-07-09 12:15:42 -07002652 l = msg_print_text(msg, 0, syslog, line, size);
Kay Sieverse2ae7152012-06-15 14:07:51 +02002653
2654 dumper->cur_idx = log_next(dumper->cur_idx);
2655 dumper->cur_seq++;
2656 ret = true;
2657 raw_spin_unlock_irqrestore(&logbuf_lock, flags);
2658out:
2659 if (len)
2660 *len = l;
2661 return ret;
2662}
2663EXPORT_SYMBOL_GPL(kmsg_dump_get_line);
2664
2665/**
2666 * kmsg_dump_get_buffer - copy kmsg log lines
2667 * @dumper: registered kmsg dumper
2668 * @syslog: include the "<4>" prefixes
Randy Dunlap4f0f4af2012-06-30 15:37:24 -07002669 * @buf: buffer to copy the line to
Kay Sieverse2ae7152012-06-15 14:07:51 +02002670 * @size: maximum size of the buffer
2671 * @len: length of line placed into buffer
2672 *
2673 * Start at the end of the kmsg buffer and fill the provided buffer
2674 * with as many of the the *youngest* kmsg records that fit into it.
2675 * If the buffer is large enough, all available kmsg records will be
2676 * copied with a single call.
2677 *
2678 * Consecutive calls will fill the buffer with the next block of
2679 * available older records, not including the earlier retrieved ones.
2680 *
2681 * A return value of FALSE indicates that there are no more records to
2682 * read.
2683 */
2684bool kmsg_dump_get_buffer(struct kmsg_dumper *dumper, bool syslog,
2685 char *buf, size_t size, size_t *len)
2686{
2687 unsigned long flags;
2688 u64 seq;
2689 u32 idx;
2690 u64 next_seq;
2691 u32 next_idx;
Kay Sievers5becfb12012-07-09 12:15:42 -07002692 enum log_flags prev;
Kay Sieverse2ae7152012-06-15 14:07:51 +02002693 size_t l = 0;
2694 bool ret = false;
2695
2696 if (!dumper->active)
2697 goto out;
2698
2699 raw_spin_lock_irqsave(&logbuf_lock, flags);
2700 if (dumper->cur_seq < log_first_seq) {
2701 /* messages are gone, move to first available one */
2702 dumper->cur_seq = log_first_seq;
2703 dumper->cur_idx = log_first_idx;
2704 }
2705
2706 /* last entry */
2707 if (dumper->cur_seq >= dumper->next_seq) {
2708 raw_spin_unlock_irqrestore(&logbuf_lock, flags);
2709 goto out;
2710 }
2711
2712 /* calculate length of entire buffer */
2713 seq = dumper->cur_seq;
2714 idx = dumper->cur_idx;
Kay Sievers5becfb12012-07-09 12:15:42 -07002715 prev = 0;
Kay Sieverse2ae7152012-06-15 14:07:51 +02002716 while (seq < dumper->next_seq) {
2717 struct log *msg = log_from_idx(idx);
2718
Kay Sievers5becfb12012-07-09 12:15:42 -07002719 l += msg_print_text(msg, prev, true, NULL, 0);
Kay Sieverse2ae7152012-06-15 14:07:51 +02002720 idx = log_next(idx);
2721 seq++;
Kay Sievers5becfb12012-07-09 12:15:42 -07002722 prev = msg->flags;
Kay Sieverse2ae7152012-06-15 14:07:51 +02002723 }
2724
2725 /* move first record forward until length fits into the buffer */
2726 seq = dumper->cur_seq;
2727 idx = dumper->cur_idx;
Kay Sievers5becfb12012-07-09 12:15:42 -07002728 prev = 0;
Kay Sieverse2ae7152012-06-15 14:07:51 +02002729 while (l > size && seq < dumper->next_seq) {
2730 struct log *msg = log_from_idx(idx);
2731
Kay Sievers5becfb12012-07-09 12:15:42 -07002732 l -= msg_print_text(msg, prev, true, NULL, 0);
Kay Sieverse2ae7152012-06-15 14:07:51 +02002733 idx = log_next(idx);
2734 seq++;
Kay Sievers5becfb12012-07-09 12:15:42 -07002735 prev = msg->flags;
Kay Sieverse2ae7152012-06-15 14:07:51 +02002736 }
2737
2738 /* last message in next interation */
2739 next_seq = seq;
2740 next_idx = idx;
2741
2742 l = 0;
Kay Sievers5becfb12012-07-09 12:15:42 -07002743 prev = 0;
Kay Sieverse2ae7152012-06-15 14:07:51 +02002744 while (seq < dumper->next_seq) {
2745 struct log *msg = log_from_idx(idx);
2746
Kay Sievers5becfb12012-07-09 12:15:42 -07002747 l += msg_print_text(msg, prev, syslog, buf + l, size - l);
Kay Sieverse2ae7152012-06-15 14:07:51 +02002748 idx = log_next(idx);
2749 seq++;
Kay Sievers5becfb12012-07-09 12:15:42 -07002750 prev = msg->flags;
Kay Sieverse2ae7152012-06-15 14:07:51 +02002751 }
2752
2753 dumper->next_seq = next_seq;
2754 dumper->next_idx = next_idx;
2755 ret = true;
2756 raw_spin_unlock_irqrestore(&logbuf_lock, flags);
2757out:
2758 if (len)
2759 *len = l;
2760 return ret;
2761}
2762EXPORT_SYMBOL_GPL(kmsg_dump_get_buffer);
2763
2764/**
2765 * kmsg_dump_rewind - reset the interator
2766 * @dumper: registered kmsg dumper
2767 *
2768 * Reset the dumper's iterator so that kmsg_dump_get_line() and
2769 * kmsg_dump_get_buffer() can be called again and used multiple
2770 * times within the same dumper.dump() callback.
2771 */
2772void kmsg_dump_rewind(struct kmsg_dumper *dumper)
2773{
2774 unsigned long flags;
2775
2776 raw_spin_lock_irqsave(&logbuf_lock, flags);
2777 dumper->cur_seq = clear_seq;
2778 dumper->cur_idx = clear_idx;
2779 dumper->next_seq = log_next_seq;
2780 dumper->next_idx = log_next_idx;
2781 raw_spin_unlock_irqrestore(&logbuf_lock, flags);
2782}
2783EXPORT_SYMBOL_GPL(kmsg_dump_rewind);
Joe Perches7ef3d2f2008-02-08 04:21:25 -08002784#endif