printk.c 73.1 KB
Newer Older
L
Linus Torvalds 已提交
1 2 3 4 5 6 7 8 9 10 11 12
/*
 *  linux/kernel/printk.c
 *
 *  Copyright (C) 1991, 1992  Linus Torvalds
 *
 * Modified to make sys_syslog() more flexible: added commands to
 * return the last 4k of kernel messages, regardless of whether
 * they've been read or not.  Added option to suppress kernel printk's
 * to the console.  Added hook for sending the console messages
 * elsewhere, in preparation for a serial line console (someday).
 * Ted Ts'o, 2/11/93.
 * Modified for sysctl support, 1/8/97, Chris Horn.
J
Jesper Juhl 已提交
13
 * Fixed SMP synchronization, 08/08/99, Manfred Spraul
14
 *     manfred@colorfullife.com
L
Linus Torvalds 已提交
15
 * Rewrote bits to get rid of console_lock
16
 *	01Mar01 Andrew Morton
L
Linus Torvalds 已提交
17 18 19 20 21 22 23 24
 */

#include <linux/kernel.h>
#include <linux/mm.h>
#include <linux/tty.h>
#include <linux/tty_driver.h>
#include <linux/console.h>
#include <linux/init.h>
R
Randy Dunlap 已提交
25 26
#include <linux/jiffies.h>
#include <linux/nmi.h>
L
Linus Torvalds 已提交
27
#include <linux/module.h>
J
Jan Engelhardt 已提交
28
#include <linux/moduleparam.h>
L
Linus Torvalds 已提交
29 30 31 32 33
#include <linux/interrupt.h>			/* For in_interrupt() */
#include <linux/delay.h>
#include <linux/smp.h>
#include <linux/security.h>
#include <linux/bootmem.h>
34
#include <linux/memblock.h>
35
#include <linux/aio.h>
L
Linus Torvalds 已提交
36
#include <linux/syscalls.h>
37
#include <linux/kexec.h>
38
#include <linux/kdb.h>
39
#include <linux/ratelimit.h>
40
#include <linux/kmsg_dump.h>
41
#include <linux/syslog.h>
42 43
#include <linux/cpu.h>
#include <linux/notifier.h>
44
#include <linux/rculist.h>
45
#include <linux/poll.h>
46
#include <linux/irq_work.h>
47
#include <linux/utsname.h>
L
Linus Torvalds 已提交
48 49 50

#include <asm/uaccess.h>

51 52 53
#define CREATE_TRACE_POINTS
#include <trace/events/printk.h>

J
Joe Perches 已提交
54
#include "console_cmdline.h"
55
#include "braille.h"
J
Joe Perches 已提交
56

L
Linus Torvalds 已提交
57
/* printk's without a loglevel use this.. */
58
#define DEFAULT_MESSAGE_LOGLEVEL CONFIG_DEFAULT_MESSAGE_LOGLEVEL
L
Linus Torvalds 已提交
59 60 61 62 63 64 65 66 67 68 69 70 71

/* We show everything that is MORE important than this.. */
#define MINIMUM_CONSOLE_LOGLEVEL 1 /* Minimum loglevel we let people use */
#define DEFAULT_CONSOLE_LOGLEVEL 7 /* anything MORE serious than KERN_DEBUG */

int console_printk[4] = {
	DEFAULT_CONSOLE_LOGLEVEL,	/* console_loglevel */
	DEFAULT_MESSAGE_LOGLEVEL,	/* default_message_loglevel */
	MINIMUM_CONSOLE_LOGLEVEL,	/* minimum_console_loglevel */
	DEFAULT_CONSOLE_LOGLEVEL,	/* default_console_loglevel */
};

/*
P
Patrick Pletscher 已提交
72
 * Low level drivers may need that to know if they can schedule in
L
Linus Torvalds 已提交
73 74 75 76 77 78 79 80 81 82
 * their unblank() callback or not. So let's export it.
 */
int oops_in_progress;
EXPORT_SYMBOL(oops_in_progress);

/*
 * console_sem protects the console_drivers list, and also
 * provides serialisation for access to the entire console
 * driver system.
 */
83
static DEFINE_SEMAPHORE(console_sem);
L
Linus Torvalds 已提交
84
struct console *console_drivers;
I
Ingo Molnar 已提交
85 86
EXPORT_SYMBOL_GPL(console_drivers);

87 88 89 90 91 92
#ifdef CONFIG_LOCKDEP
static struct lockdep_map console_lock_dep_map = {
	.name = "console_lock"
};
#endif

L
Linus Torvalds 已提交
93 94 95 96 97 98 99 100
/*
 * This is used for debugging the mess that is the VT code by
 * keeping track if we have the console semaphore held. It's
 * definitely not the perfect debug tool (we don't know if _WE_
 * hold it are racing, but it helps tracking those weird code
 * path in the console code where we end up in places I want
 * locked without the console sempahore held
 */
101
static int console_locked, console_suspended;
L
Linus Torvalds 已提交
102

103 104 105 106 107
/*
 * If exclusive_console is non-NULL then only this console is to be printed to.
 */
static struct console *exclusive_console;

L
Linus Torvalds 已提交
108 109 110 111 112 113 114
/*
 *	Array of consoles built from command line options (console=)
 */

#define MAX_CMDLINECONSOLES 8

static struct console_cmdline console_cmdline[MAX_CMDLINECONSOLES];
J
Joe Perches 已提交
115

L
Linus Torvalds 已提交
116 117
static int selected_console = -1;
static int preferred_console = -1;
118 119
int console_set_on_cmdline;
EXPORT_SYMBOL(console_set_on_cmdline);
L
Linus Torvalds 已提交
120 121 122 123

/* Flag: console code may call schedule() */
static int console_may_schedule;

124 125 126 127 128 129 130 131 132 133 134 135 136 137 138 139 140 141 142 143 144 145 146
/*
 * The printk log buffer consists of a chain of concatenated variable
 * length records. Every record starts with a record header, containing
 * the overall length of the record.
 *
 * The heads to the first and last entry in the buffer, as well as the
 * sequence numbers of these both entries are maintained when messages
 * are stored..
 *
 * If the heads indicate available messages, the length in the header
 * tells the start next message. A length == 0 for the next message
 * indicates a wrap-around to the beginning of the buffer.
 *
 * Every record carries the monotonic timestamp in microseconds, as well as
 * the standard userspace syslog level and syslog facility. The usual
 * kernel messages use LOG_KERN; userspace-injected messages always carry
 * a matching syslog facility, by default LOG_USER. The origin of every
 * message can be reliably determined that way.
 *
 * The human readable log message directly follows the message header. The
 * length of the message text is stored in the header, the stored message
 * is not terminated.
 *
147 148 149 150 151 152 153 154 155 156 157 158 159 160 161 162 163 164 165 166 167 168 169 170 171 172 173 174 175
 * Optionally, a message can carry a dictionary of properties (key/value pairs),
 * to provide userspace with a machine-readable message context.
 *
 * Examples for well-defined, commonly used property names are:
 *   DEVICE=b12:8               device identifier
 *                                b12:8         block dev_t
 *                                c127:3        char dev_t
 *                                n8            netdev ifindex
 *                                +sound:card0  subsystem:devname
 *   SUBSYSTEM=pci              driver-core subsystem name
 *
 * Valid characters in property names are [a-zA-Z0-9.-_]. The plain text value
 * follows directly after a '=' character. Every property is terminated by
 * a '\0' character. The last property is not terminated.
 *
 * Example of a message structure:
 *   0000  ff 8f 00 00 00 00 00 00      monotonic time in nsec
 *   0008  34 00                        record is 52 bytes long
 *   000a        0b 00                  text is 11 bytes long
 *   000c              1f 00            dictionary is 23 bytes long
 *   000e                    03 00      LOG_KERN (facility) LOG_ERR (level)
 *   0010  69 74 27 73 20 61 20 6c      "it's a l"
 *         69 6e 65                     "ine"
 *   001b           44 45 56 49 43      "DEVIC"
 *         45 3d 62 38 3a 32 00 44      "E=b8:2\0D"
 *         52 49 56 45 52 3d 62 75      "RIVER=bu"
 *         67                           "g"
 *   0032     00 00 00                  padding to next message header
 *
176
 * The 'struct printk_log' buffer header must never be directly exported to
177 178 179 180 181 182 183 184 185 186 187 188
 * userspace, it is a kernel-private implementation detail that might
 * need to be changed in the future, when the requirements change.
 *
 * /dev/kmsg exports the structured data in the following line format:
 *   "level,sequnum,timestamp;<message text>\n"
 *
 * The optional key/value pairs are attached as continuation lines starting
 * with a space character and terminated by a newline. All possible
 * non-prinatable characters are escaped in the "\xff" notation.
 *
 * Users of the export format should ignore possible additional values
 * separated by ',', and find the message after the ';' character.
189 190
 */

191
enum log_flags {
192 193 194 195
	LOG_NOCONS	= 1,	/* already flushed, do not print to console */
	LOG_NEWLINE	= 2,	/* text ended with a newline */
	LOG_PREFIX	= 4,	/* text started with a prefix */
	LOG_CONT	= 8,	/* text is a fragment of a continuation line */
196 197
};

198
struct printk_log {
199 200 201 202
	u64 ts_nsec;		/* timestamp in nanoseconds */
	u16 len;		/* length of entire record */
	u16 text_len;		/* length of text buffer */
	u16 dict_len;		/* length of dictionary buffer */
203 204 205
	u8 facility;		/* syslog facility */
	u8 flags:5;		/* internal record flags */
	u8 level:3;		/* syslog level */
206 207 208 209 210 211 212
};

/*
 * The logbuf_lock protects kmsg buffer, indices, counters. It is also
 * used in interesting ways to provide interlocking in console_unlock();
 */
static DEFINE_RAW_SPINLOCK(logbuf_lock);
M
Matt Mackall 已提交
213

214
#ifdef CONFIG_PRINTK
215
DECLARE_WAIT_QUEUE_HEAD(log_wait);
216 217 218
/* the next printk record to read by syslog(READ) or /proc/kmsg */
static u64 syslog_seq;
static u32 syslog_idx;
219
static enum log_flags syslog_prev;
220
static size_t syslog_partial;
221 222 223 224 225 226 227 228 229

/* index and sequence number of the first record stored in the buffer */
static u64 log_first_seq;
static u32 log_first_idx;

/* index and sequence number of the next record to store in the buffer */
static u64 log_next_seq;
static u32 log_next_idx;

230 231 232 233 234
/* the next printk record to write to the console */
static u64 console_seq;
static u32 console_idx;
static enum log_flags console_prev;

235 236 237 238
/* the next printk record to read after the last 'clear' command */
static u64 clear_seq;
static u32 clear_idx;

239 240
#define PREFIX_MAX		32
#define LOG_LINE_MAX		1024 - PREFIX_MAX
241 242

/* record buffer */
243
#if defined(CONFIG_HAVE_EFFICIENT_UNALIGNED_ACCESS)
244 245
#define LOG_ALIGN 4
#else
246
#define LOG_ALIGN __alignof__(struct printk_log)
247
#endif
248
#define __LOG_BUF_LEN (1 << CONFIG_LOG_BUF_SHIFT)
249
static char __log_buf[__LOG_BUF_LEN] __aligned(LOG_ALIGN);
250 251 252 253 254
static char *log_buf = __log_buf;
static u32 log_buf_len = __LOG_BUF_LEN;

/* cpu currently holding logbuf_lock */
static volatile unsigned int logbuf_cpu = UINT_MAX;
255 256

/* human readable text of the record */
257
static char *log_text(const struct printk_log *msg)
258
{
259
	return (char *)msg + sizeof(struct printk_log);
260 261 262
}

/* optional key/value pair dictionary attached to the record */
263
static char *log_dict(const struct printk_log *msg)
264
{
265
	return (char *)msg + sizeof(struct printk_log) + msg->text_len;
266 267 268
}

/* get record by index; idx must point to valid msg */
269
static struct printk_log *log_from_idx(u32 idx)
270
{
271
	struct printk_log *msg = (struct printk_log *)(log_buf + idx);
272 273 274 275 276 277

	/*
	 * A length == 0 record is the end of buffer marker. Wrap around and
	 * read the message at the start of the buffer.
	 */
	if (!msg->len)
278
		return (struct printk_log *)log_buf;
279 280 281 282 283 284
	return msg;
}

/* get next record; idx must point to valid msg */
static u32 log_next(u32 idx)
{
285
	struct printk_log *msg = (struct printk_log *)(log_buf + idx);
286 287 288 289 290 291 292 293

	/* length == 0 indicates the end of the buffer; wrap */
	/*
	 * A length == 0 record is the end of buffer marker. Wrap around and
	 * read the message at the start of the buffer as *this* one, and
	 * return the one after that.
	 */
	if (!msg->len) {
294
		msg = (struct printk_log *)log_buf;
295 296 297 298 299
		return msg->len;
	}
	return idx + msg->len;
}

P
Petr Mladek 已提交
300 301 302 303 304 305 306 307 308 309
/*
 * Check whether there is enough free space for the given message.
 *
 * The same values of first_idx and next_idx mean that the buffer
 * is either empty or full.
 *
 * If the buffer is empty, we must respect the position of the indexes.
 * They cannot be reset to the beginning of the buffer.
 */
static int logbuf_has_space(u32 msg_size, bool empty)
310 311 312
{
	u32 free;

P
Petr Mladek 已提交
313
	if (log_next_idx > log_first_idx || empty)
314 315 316 317 318 319 320 321 322 323 324
		free = max(log_buf_len - log_next_idx, log_first_idx);
	else
		free = log_first_idx - log_next_idx;

	/*
	 * We need space also for an empty header that signalizes wrapping
	 * of the buffer.
	 */
	return free >= msg_size + sizeof(struct printk_log);
}

P
Petr Mladek 已提交
325
static int log_make_free_space(u32 msg_size)
326 327
{
	while (log_first_seq < log_next_seq) {
P
Petr Mladek 已提交
328 329
		if (logbuf_has_space(msg_size, false))
			return 0;
330 331 332 333
		/* drop old messages until we have enough continuous space */
		log_first_idx = log_next(log_first_idx);
		log_first_seq++;
	}
P
Petr Mladek 已提交
334 335 336 337 338 339

	/* sequence numbers are equal, so the log buffer is empty */
	if (logbuf_has_space(msg_size, true))
		return 0;

	return -ENOMEM;
340 341
}

342 343
/* insert record into the buffer, discard old ones, update heads */
static void log_store(int facility, int level,
344
		      enum log_flags flags, u64 ts_nsec,
345 346 347
		      const char *dict, u16 dict_len,
		      const char *text, u16 text_len)
{
348
	struct printk_log *msg;
349 350 351
	u32 size, pad_len;

	/* number of '\0' padding bytes to next message */
352
	size = sizeof(struct printk_log) + text_len + dict_len;
353 354 355
	pad_len = (-size) & (LOG_ALIGN - 1);
	size += pad_len;

P
Petr Mladek 已提交
356 357 358
	/* if message does not fit empty log buffer, ignore it */
	if (log_make_free_space(size))
		return;
359

360
	if (log_next_idx + size + sizeof(struct printk_log) > log_buf_len) {
361 362 363 364 365
		/*
		 * This message + an additional empty header does not fit
		 * at the end of the buffer. Add an empty header with len == 0
		 * to signify a wrap around.
		 */
366
		memset(log_buf + log_next_idx, 0, sizeof(struct printk_log));
367 368 369 370
		log_next_idx = 0;
	}

	/* fill message */
371
	msg = (struct printk_log *)(log_buf + log_next_idx);
372 373 374 375
	memcpy(log_text(msg), text, text_len);
	msg->text_len = text_len;
	memcpy(log_dict(msg), dict, dict_len);
	msg->dict_len = dict_len;
376 377 378 379 380 381 382
	msg->facility = facility;
	msg->level = level & 7;
	msg->flags = flags & 0x1f;
	if (ts_nsec > 0)
		msg->ts_nsec = ts_nsec;
	else
		msg->ts_nsec = local_clock();
383
	memset(log_dict(msg) + dict_len, 0, pad_len);
384
	msg->len = size;
385 386 387 388 389

	/* insert message */
	log_next_idx += msg->len;
	log_next_seq++;
}
M
Matt Mackall 已提交
390

391 392 393 394 395 396 397 398 399 400 401 402 403 404 405 406 407 408 409 410 411 412 413 414 415 416 417 418 419 420 421 422 423 424 425 426 427 428 429 430 431 432 433 434 435 436 437
#ifdef CONFIG_SECURITY_DMESG_RESTRICT
int dmesg_restrict = 1;
#else
int dmesg_restrict;
#endif

static int syslog_action_restricted(int type)
{
	if (dmesg_restrict)
		return 1;
	/*
	 * Unless restricted, we allow "read all" and "get buffer size"
	 * for everybody.
	 */
	return type != SYSLOG_ACTION_READ_ALL &&
	       type != SYSLOG_ACTION_SIZE_BUFFER;
}

static int check_syslog_permissions(int type, bool from_file)
{
	/*
	 * If this is from /proc/kmsg and we've already opened it, then we've
	 * already done the capabilities checks at open time.
	 */
	if (from_file && type != SYSLOG_ACTION_OPEN)
		return 0;

	if (syslog_action_restricted(type)) {
		if (capable(CAP_SYSLOG))
			return 0;
		/*
		 * For historical reasons, accept CAP_SYS_ADMIN too, with
		 * a warning.
		 */
		if (capable(CAP_SYS_ADMIN)) {
			pr_warn_once("%s (%d): Attempt to access syslog with "
				     "CAP_SYS_ADMIN but no CAP_SYSLOG "
				     "(deprecated).\n",
				 current->comm, task_pid_nr(current));
			return 0;
		}
		return -EPERM;
	}
	return security_syslog(type);
}


438 439 440 441
/* /dev/kmsg - userspace message inject/listen interface */
struct devkmsg_user {
	u64 seq;
	u32 idx;
442
	enum log_flags prev;
443 444 445 446 447 448 449 450 451 452 453 454 455 456 457 458 459 460 461 462 463 464
	struct mutex lock;
	char buf[8192];
};

static ssize_t devkmsg_writev(struct kiocb *iocb, const struct iovec *iv,
			      unsigned long count, loff_t pos)
{
	char *buf, *line;
	int i;
	int level = default_message_loglevel;
	int facility = 1;	/* LOG_USER */
	size_t len = iov_length(iv, count);
	ssize_t ret = len;

	if (len > LOG_LINE_MAX)
		return -EINVAL;
	buf = kmalloc(len+1, GFP_KERNEL);
	if (buf == NULL)
		return -ENOMEM;

	line = buf;
	for (i = 0; i < count; i++) {
465 466
		if (copy_from_user(line, iv[i].iov_base, iv[i].iov_len)) {
			ret = -EFAULT;
467
			goto out;
468
		}
469 470 471 472 473 474 475 476 477 478 479 480 481 482 483 484 485 486 487 488 489 490 491 492 493 494 495 496 497 498 499 500 501 502 503 504 505 506
		line += iv[i].iov_len;
	}

	/*
	 * Extract and skip the syslog prefix <[0-9]*>. Coming from userspace
	 * the decimal value represents 32bit, the lower 3 bit are the log
	 * level, the rest are the log facility.
	 *
	 * If no prefix or no userspace facility is specified, we
	 * enforce LOG_USER, to be able to reliably distinguish
	 * kernel-generated messages from userspace-injected ones.
	 */
	line = buf;
	if (line[0] == '<') {
		char *endp = NULL;

		i = simple_strtoul(line+1, &endp, 10);
		if (endp && endp[0] == '>') {
			level = i & 7;
			if (i >> 3)
				facility = i >> 3;
			endp++;
			len -= endp - line;
			line = endp;
		}
	}
	line[len] = '\0';

	printk_emit(facility, level, NULL, 0, "%s", line);
out:
	kfree(buf);
	return ret;
}

static ssize_t devkmsg_read(struct file *file, char __user *buf,
			    size_t count, loff_t *ppos)
{
	struct devkmsg_user *user = file->private_data;
507
	struct printk_log *msg;
508
	u64 ts_usec;
509
	size_t i;
510
	char cont = '-';
511 512 513 514 515 516
	size_t len;
	ssize_t ret;

	if (!user)
		return -EBADF;

517 518 519
	ret = mutex_lock_interruptible(&user->lock);
	if (ret)
		return ret;
520
	raw_spin_lock_irq(&logbuf_lock);
521 522 523
	while (user->seq == log_next_seq) {
		if (file->f_flags & O_NONBLOCK) {
			ret = -EAGAIN;
524
			raw_spin_unlock_irq(&logbuf_lock);
525 526 527
			goto out;
		}

528
		raw_spin_unlock_irq(&logbuf_lock);
529 530 531 532
		ret = wait_event_interruptible(log_wait,
					       user->seq != log_next_seq);
		if (ret)
			goto out;
533
		raw_spin_lock_irq(&logbuf_lock);
534 535 536 537 538 539 540
	}

	if (user->seq < log_first_seq) {
		/* our last seen message is gone, return error and reset */
		user->idx = log_first_idx;
		user->seq = log_first_seq;
		ret = -EPIPE;
541
		raw_spin_unlock_irq(&logbuf_lock);
542 543 544 545
		goto out;
	}

	msg = log_from_idx(user->idx);
546 547
	ts_usec = msg->ts_nsec;
	do_div(ts_usec, 1000);
548 549 550 551 552 553 554 555 556 557 558 559 560 561 562 563 564 565 566

	/*
	 * If we couldn't merge continuation line fragments during the print,
	 * export the stored flags to allow an optional external merge of the
	 * records. Merging the records isn't always neccessarily correct, like
	 * when we hit a race during printing. In most cases though, it produces
	 * better readable output. 'c' in the record flags mark the first
	 * fragment of a line, '+' the following.
	 */
	if (msg->flags & LOG_CONT && !(user->prev & LOG_CONT))
		cont = 'c';
	else if ((msg->flags & LOG_CONT) ||
		 ((user->prev & LOG_CONT) && !(msg->flags & LOG_PREFIX)))
		cont = '+';

	len = sprintf(user->buf, "%u,%llu,%llu,%c;",
		      (msg->facility << 3) | msg->level,
		      user->seq, ts_usec, cont);
	user->prev = msg->flags;
567 568 569

	/* escape non-printable characters */
	for (i = 0; i < msg->text_len; i++) {
570
		unsigned char c = log_text(msg)[i];
571

572
		if (c < ' ' || c >= 127 || c == '\\')
573 574 575 576 577 578 579 580 581 582
			len += sprintf(user->buf + len, "\\x%02x", c);
		else
			user->buf[len++] = c;
	}
	user->buf[len++] = '\n';

	if (msg->dict_len) {
		bool line = true;

		for (i = 0; i < msg->dict_len; i++) {
583
			unsigned char c = log_dict(msg)[i];
584 585 586 587 588 589 590 591 592 593 594 595

			if (line) {
				user->buf[len++] = ' ';
				line = false;
			}

			if (c == '\0') {
				user->buf[len++] = '\n';
				line = true;
				continue;
			}

596
			if (c < ' ' || c >= 127 || c == '\\') {
597 598 599 600 601 602 603 604 605 606 607
				len += sprintf(user->buf + len, "\\x%02x", c);
				continue;
			}

			user->buf[len++] = c;
		}
		user->buf[len++] = '\n';
	}

	user->idx = log_next(user->idx);
	user->seq++;
608
	raw_spin_unlock_irq(&logbuf_lock);
609 610 611 612 613 614 615 616 617 618 619 620 621 622 623 624 625 626 627 628 629 630 631 632 633 634

	if (len > count) {
		ret = -EINVAL;
		goto out;
	}

	if (copy_to_user(buf, user->buf, len)) {
		ret = -EFAULT;
		goto out;
	}
	ret = len;
out:
	mutex_unlock(&user->lock);
	return ret;
}

static loff_t devkmsg_llseek(struct file *file, loff_t offset, int whence)
{
	struct devkmsg_user *user = file->private_data;
	loff_t ret = 0;

	if (!user)
		return -EBADF;
	if (offset)
		return -ESPIPE;

635
	raw_spin_lock_irq(&logbuf_lock);
636 637 638 639 640 641 642 643 644 645 646 647 648 649 650 651 652 653 654 655 656 657 658
	switch (whence) {
	case SEEK_SET:
		/* the first record */
		user->idx = log_first_idx;
		user->seq = log_first_seq;
		break;
	case SEEK_DATA:
		/*
		 * The first record after the last SYSLOG_ACTION_CLEAR,
		 * like issued by 'dmesg -c'. Reading /dev/kmsg itself
		 * changes no global state, and does not clear anything.
		 */
		user->idx = clear_idx;
		user->seq = clear_seq;
		break;
	case SEEK_END:
		/* after the last record */
		user->idx = log_next_idx;
		user->seq = log_next_seq;
		break;
	default:
		ret = -EINVAL;
	}
659
	raw_spin_unlock_irq(&logbuf_lock);
660 661 662 663 664 665 666 667 668 669 670 671 672
	return ret;
}

static unsigned int devkmsg_poll(struct file *file, poll_table *wait)
{
	struct devkmsg_user *user = file->private_data;
	int ret = 0;

	if (!user)
		return POLLERR|POLLNVAL;

	poll_wait(file, &log_wait, wait);

673
	raw_spin_lock_irq(&logbuf_lock);
674 675 676 677
	if (user->seq < log_next_seq) {
		/* return error when data has vanished underneath us */
		if (user->seq < log_first_seq)
			ret = POLLIN|POLLRDNORM|POLLERR|POLLPRI;
678 679
		else
			ret = POLLIN|POLLRDNORM;
680
	}
681
	raw_spin_unlock_irq(&logbuf_lock);
682 683 684 685 686 687 688 689 690 691 692 693 694

	return ret;
}

static int devkmsg_open(struct inode *inode, struct file *file)
{
	struct devkmsg_user *user;
	int err;

	/* write-only does not need any file context */
	if ((file->f_flags & O_ACCMODE) == O_WRONLY)
		return 0;

695 696
	err = check_syslog_permissions(SYSLOG_ACTION_READ_ALL,
				       SYSLOG_FROM_READER);
697 698 699 700 701 702 703 704 705
	if (err)
		return err;

	user = kmalloc(sizeof(struct devkmsg_user), GFP_KERNEL);
	if (!user)
		return -ENOMEM;

	mutex_init(&user->lock);

706
	raw_spin_lock_irq(&logbuf_lock);
707 708
	user->idx = log_first_idx;
	user->seq = log_first_seq;
709
	raw_spin_unlock_irq(&logbuf_lock);
710 711 712 713 714 715 716 717 718 719 720 721 722 723 724 725 726 727 728 729 730 731 732 733 734 735

	file->private_data = user;
	return 0;
}

static int devkmsg_release(struct inode *inode, struct file *file)
{
	struct devkmsg_user *user = file->private_data;

	if (!user)
		return 0;

	mutex_destroy(&user->lock);
	kfree(user);
	return 0;
}

const struct file_operations kmsg_fops = {
	.open = devkmsg_open,
	.read = devkmsg_read,
	.aio_write = devkmsg_writev,
	.llseek = devkmsg_llseek,
	.poll = devkmsg_poll,
	.release = devkmsg_release,
};

736 737
#ifdef CONFIG_KEXEC
/*
738
 * This appends the listed symbols to /proc/vmcore
739
 *
740
 * /proc/vmcore is used by various utilities, like crash and makedumpfile to
741 742 743 744 745 746 747 748
 * obtain access to symbols that are otherwise very difficult to locate.  These
 * symbols are specifically used so that utilities can access and extract the
 * dmesg log from a vmcore file after a crash.
 */
void log_buf_kexec_setup(void)
{
	VMCOREINFO_SYMBOL(log_buf);
	VMCOREINFO_SYMBOL(log_buf_len);
749 750
	VMCOREINFO_SYMBOL(log_first_idx);
	VMCOREINFO_SYMBOL(log_next_idx);
751
	/*
752
	 * Export struct printk_log size and field offsets. User space tools can
753 754
	 * parse it and detect any changes to structure down the line.
	 */
755 756 757 758 759
	VMCOREINFO_STRUCT_SIZE(printk_log);
	VMCOREINFO_OFFSET(printk_log, ts_nsec);
	VMCOREINFO_OFFSET(printk_log, len);
	VMCOREINFO_OFFSET(printk_log, text_len);
	VMCOREINFO_OFFSET(printk_log, dict_len);
760 761 762
}
#endif

763 764 765 766
/* requested log_buf_len from kernel cmdline */
static unsigned long __initdata new_log_buf_len;

/* save requested log_buf_len since it's too early to process it */
L
Linus Torvalds 已提交
767 768
static int __init log_buf_len_setup(char *str)
{
769
	unsigned size = memparse(str, &str);
L
Linus Torvalds 已提交
770 771 772

	if (size)
		size = roundup_pow_of_two(size);
773 774 775 776
	if (size > log_buf_len)
		new_log_buf_len = size;

	return 0;
L
Linus Torvalds 已提交
777
}
778 779 780 781 782 783 784 785 786 787
early_param("log_buf_len", log_buf_len_setup);

void __init setup_log_buf(int early)
{
	unsigned long flags;
	char *new_log_buf;
	int free;

	if (!new_log_buf_len)
		return;
L
Linus Torvalds 已提交
788

789
	if (early) {
790 791
		new_log_buf =
			memblock_virt_alloc(new_log_buf_len, PAGE_SIZE);
792
	} else {
793
		new_log_buf = memblock_virt_alloc_nopanic(new_log_buf_len, 0);
794 795 796 797 798 799 800 801
	}

	if (unlikely(!new_log_buf)) {
		pr_err("log_buf_len: %ld bytes not available\n",
			new_log_buf_len);
		return;
	}

802
	raw_spin_lock_irqsave(&logbuf_lock, flags);
803 804 805
	log_buf_len = new_log_buf_len;
	log_buf = new_log_buf;
	new_log_buf_len = 0;
806 807
	free = __LOG_BUF_LEN - log_next_idx;
	memcpy(log_buf, __log_buf, __LOG_BUF_LEN);
808
	raw_spin_unlock_irqrestore(&logbuf_lock, flags);
809 810 811 812 813

	pr_info("log_buf_len: %d\n", log_buf_len);
	pr_info("early log buf free: %d(%d%%)\n",
		free, (free * 100) / __LOG_BUF_LEN);
}
L
Linus Torvalds 已提交
814

815 816 817 818 819
static bool __read_mostly ignore_loglevel;

static int __init ignore_loglevel_setup(char *str)
{
	ignore_loglevel = 1;
820
	pr_info("debug: ignoring loglevel setting.\n");
821 822 823 824 825 826 827 828 829

	return 0;
}

early_param("ignore_loglevel", ignore_loglevel_setup);
module_param(ignore_loglevel, bool, S_IRUGO | S_IWUSR);
MODULE_PARM_DESC(ignore_loglevel, "ignore loglevel setting, to"
	"print all kernel messages to the console.");

R
Randy Dunlap 已提交
830 831
#ifdef CONFIG_BOOT_PRINTK_DELAY

832
static int boot_delay; /* msecs delay after each printk during bootup */
833
static unsigned long long loops_per_msec;	/* based on boot_delay */
R
Randy Dunlap 已提交
834 835 836 837 838 839 840 841 842 843 844 845

static int __init boot_delay_setup(char *str)
{
	unsigned long lpj;

	lpj = preset_lpj ? preset_lpj : 1000000;	/* some guess */
	loops_per_msec = (unsigned long long)lpj / 1000 * HZ;

	get_option(&str, &boot_delay);
	if (boot_delay > 10 * 1000)
		boot_delay = 0;

846 847 848
	pr_debug("boot_delay: %u, preset_lpj: %ld, lpj: %lu, "
		"HZ: %d, loops_per_msec: %llu\n",
		boot_delay, preset_lpj, lpj, HZ, loops_per_msec);
849
	return 0;
R
Randy Dunlap 已提交
850
}
851
early_param("boot_delay", boot_delay_setup);
R
Randy Dunlap 已提交
852

853
static void boot_delay_msec(int level)
R
Randy Dunlap 已提交
854 855 856 857
{
	unsigned long long k;
	unsigned long timeout;

858 859
	if ((boot_delay == 0 || system_state != SYSTEM_BOOTING)
		|| (level >= console_loglevel && !ignore_loglevel)) {
R
Randy Dunlap 已提交
860
		return;
861
	}
R
Randy Dunlap 已提交
862

863
	k = (unsigned long long)loops_per_msec * boot_delay;
R
Randy Dunlap 已提交
864 865 866 867 868 869 870 871 872 873 874 875 876 877 878 879

	timeout = jiffies + msecs_to_jiffies(boot_delay);
	while (k) {
		k--;
		cpu_relax();
		/*
		 * use (volatile) jiffies to prevent
		 * compiler reduction; loop termination via jiffies
		 * is secondary and may or may not happen.
		 */
		if (time_after(jiffies, timeout))
			break;
		touch_nmi_watchdog();
	}
}
#else
880
static inline void boot_delay_msec(int level)
R
Randy Dunlap 已提交
881 882 883 884
{
}
#endif

885 886 887 888 889 890 891
#if defined(CONFIG_PRINTK_TIME)
static bool printk_time = 1;
#else
static bool printk_time;
#endif
module_param_named(time, printk_time, bool, S_IRUGO | S_IWUSR);

892 893 894 895 896 897 898
static size_t print_time(u64 ts, char *buf)
{
	unsigned long rem_nsec;

	if (!printk_time)
		return 0;

899 900
	rem_nsec = do_div(ts, 1000000000);

901
	if (!buf)
902
		return snprintf(NULL, 0, "[%5lu.000000] ", (unsigned long)ts);
903 904 905 906 907

	return sprintf(buf, "[%5lu.%06lu] ",
		       (unsigned long)ts, rem_nsec / 1000);
}

908
static size_t print_prefix(const struct printk_log *msg, bool syslog, char *buf)
909
{
910
	size_t len = 0;
911
	unsigned int prefix = (msg->facility << 3) | msg->level;
912

913 914
	if (syslog) {
		if (buf) {
915
			len += sprintf(buf, "<%u>", prefix);
916 917
		} else {
			len += 3;
918 919 920 921 922
			if (prefix > 999)
				len += 3;
			else if (prefix > 99)
				len += 2;
			else if (prefix > 9)
923 924 925
				len++;
		}
	}
926

927
	len += print_time(msg->ts_nsec, buf ? buf + len : NULL);
928
	return len;
929 930
}

931
static size_t msg_print_text(const struct printk_log *msg, enum log_flags prev,
932
			     bool syslog, char *buf, size_t size)
933
{
934 935
	const char *text = log_text(msg);
	size_t text_size = msg->text_len;
936 937
	bool prefix = true;
	bool newline = true;
938 939
	size_t len = 0;

940 941 942 943 944 945 946 947 948 949 950
	if ((prev & LOG_CONT) && !(msg->flags & LOG_PREFIX))
		prefix = false;

	if (msg->flags & LOG_CONT) {
		if ((prev & LOG_CONT) && !(prev & LOG_NEWLINE))
			prefix = false;

		if (!(msg->flags & LOG_NEWLINE))
			newline = false;
	}

951 952 953 954 955 956 957 958 959 960 961
	do {
		const char *next = memchr(text, '\n', text_size);
		size_t text_len;

		if (next) {
			text_len = next - text;
			next++;
			text_size -= next - text;
		} else {
			text_len = text_size;
		}
962

963 964
		if (buf) {
			if (print_prefix(msg, syslog, NULL) +
965
			    text_len + 1 >= size - len)
966
				break;
967

968 969
			if (prefix)
				len += print_prefix(msg, syslog, buf + len);
970 971
			memcpy(buf + len, text, text_len);
			len += text_len;
972 973
			if (next || newline)
				buf[len++] = '\n';
974 975
		} else {
			/* SYSLOG_ACTION_* buffer size only calculation */
976 977 978 979 980
			if (prefix)
				len += print_prefix(msg, syslog, NULL);
			len += text_len;
			if (next || newline)
				len++;
981
		}
982

983
		prefix = true;
984 985
		text = next;
	} while (text);
986 987 988 989 990 991 992

	return len;
}

static int syslog_print(char __user *buf, int size)
{
	char *text;
993
	struct printk_log *msg;
994
	int len = 0;
995

996
	text = kmalloc(LOG_LINE_MAX + PREFIX_MAX, GFP_KERNEL);
997 998 999
	if (!text)
		return -ENOMEM;

1000 1001
	while (size > 0) {
		size_t n;
1002
		size_t skip;
1003 1004 1005 1006 1007 1008

		raw_spin_lock_irq(&logbuf_lock);
		if (syslog_seq < log_first_seq) {
			/* messages are gone, move to first one */
			syslog_seq = log_first_seq;
			syslog_idx = log_first_idx;
1009
			syslog_prev = 0;
1010
			syslog_partial = 0;
1011 1012 1013 1014 1015
		}
		if (syslog_seq == log_next_seq) {
			raw_spin_unlock_irq(&logbuf_lock);
			break;
		}
1016 1017

		skip = syslog_partial;
1018
		msg = log_from_idx(syslog_idx);
1019 1020
		n = msg_print_text(msg, syslog_prev, true, text,
				   LOG_LINE_MAX + PREFIX_MAX);
1021 1022
		if (n - syslog_partial <= size) {
			/* message fits into buffer, move forward */
1023 1024
			syslog_idx = log_next(syslog_idx);
			syslog_seq++;
1025
			syslog_prev = msg->flags;
1026 1027 1028 1029 1030 1031
			n -= syslog_partial;
			syslog_partial = 0;
		} else if (!len){
			/* partial read(), remember position */
			n = size;
			syslog_partial += n;
1032 1033 1034 1035 1036 1037 1038
		} else
			n = 0;
		raw_spin_unlock_irq(&logbuf_lock);

		if (!n)
			break;

1039
		if (copy_to_user(buf, text + skip, n)) {
1040 1041 1042 1043
			if (!len)
				len = -EFAULT;
			break;
		}
1044 1045 1046 1047

		len += n;
		size -= n;
		buf += n;
1048 1049 1050 1051 1052 1053 1054 1055 1056 1057 1058
	}

	kfree(text);
	return len;
}

static int syslog_print_all(char __user *buf, int size, bool clear)
{
	char *text;
	int len = 0;

1059
	text = kmalloc(LOG_LINE_MAX + PREFIX_MAX, GFP_KERNEL);
1060 1061 1062 1063 1064 1065 1066 1067
	if (!text)
		return -ENOMEM;

	raw_spin_lock_irq(&logbuf_lock);
	if (buf) {
		u64 next_seq;
		u64 seq;
		u32 idx;
1068
		enum log_flags prev;
1069 1070 1071 1072 1073 1074 1075 1076 1077 1078

		if (clear_seq < log_first_seq) {
			/* messages are gone, move to first available one */
			clear_seq = log_first_seq;
			clear_idx = log_first_idx;
		}

		/*
		 * Find first record that fits, including all following records,
		 * into the user-provided buffer for this dump.
1079
		 */
1080 1081
		seq = clear_seq;
		idx = clear_idx;
1082
		prev = 0;
1083
		while (seq < log_next_seq) {
1084
			struct printk_log *msg = log_from_idx(idx);
1085

1086
			len += msg_print_text(msg, prev, true, NULL, 0);
1087
			prev = msg->flags;
1088 1089 1090
			idx = log_next(idx);
			seq++;
		}
1091 1092

		/* move first record forward until length fits into the buffer */
1093 1094
		seq = clear_seq;
		idx = clear_idx;
1095
		prev = 0;
1096
		while (len > size && seq < log_next_seq) {
1097
			struct printk_log *msg = log_from_idx(idx);
1098

1099
			len -= msg_print_text(msg, prev, true, NULL, 0);
1100
			prev = msg->flags;
1101 1102 1103 1104
			idx = log_next(idx);
			seq++;
		}

1105
		/* last message fitting into this dump */
1106 1107 1108 1109
		next_seq = log_next_seq;

		len = 0;
		while (len >= 0 && seq < next_seq) {
1110
			struct printk_log *msg = log_from_idx(idx);
1111 1112
			int textlen;

1113 1114
			textlen = msg_print_text(msg, prev, true, text,
						 LOG_LINE_MAX + PREFIX_MAX);
1115 1116 1117 1118 1119 1120
			if (textlen < 0) {
				len = textlen;
				break;
			}
			idx = log_next(idx);
			seq++;
1121
			prev = msg->flags;
1122 1123 1124 1125 1126 1127 1128 1129 1130 1131 1132 1133

			raw_spin_unlock_irq(&logbuf_lock);
			if (copy_to_user(buf + len, text, textlen))
				len = -EFAULT;
			else
				len += textlen;
			raw_spin_lock_irq(&logbuf_lock);

			if (seq < log_first_seq) {
				/* messages are gone, move to next one */
				seq = log_first_seq;
				idx = log_first_idx;
1134
				prev = 0;
1135 1136 1137 1138 1139 1140 1141 1142 1143 1144 1145 1146 1147 1148
			}
		}
	}

	if (clear) {
		clear_seq = log_next_seq;
		clear_idx = log_next_idx;
	}
	raw_spin_unlock_irq(&logbuf_lock);

	kfree(text);
	return len;
}

1149
int do_syslog(int type, char __user *buf, int len, bool from_file)
L
Linus Torvalds 已提交
1150
{
1151 1152
	bool clear = false;
	static int saved_console_loglevel = -1;
1153
	int error;
L
Linus Torvalds 已提交
1154

1155 1156 1157
	error = check_syslog_permissions(type, from_file);
	if (error)
		goto out;
1158 1159

	error = security_syslog(type);
L
Linus Torvalds 已提交
1160 1161 1162 1163
	if (error)
		return error;

	switch (type) {
1164
	case SYSLOG_ACTION_CLOSE:	/* Close log */
L
Linus Torvalds 已提交
1165
		break;
1166
	case SYSLOG_ACTION_OPEN:	/* Open log */
L
Linus Torvalds 已提交
1167
		break;
1168
	case SYSLOG_ACTION_READ:	/* Read from log */
L
Linus Torvalds 已提交
1169 1170 1171 1172 1173 1174 1175 1176 1177 1178
		error = -EINVAL;
		if (!buf || len < 0)
			goto out;
		error = 0;
		if (!len)
			goto out;
		if (!access_ok(VERIFY_WRITE, buf, len)) {
			error = -EFAULT;
			goto out;
		}
J
Jesper Juhl 已提交
1179
		error = wait_event_interruptible(log_wait,
1180
						 syslog_seq != log_next_seq);
1181
		if (error)
L
Linus Torvalds 已提交
1182
			goto out;
1183
		error = syslog_print(buf, len);
L
Linus Torvalds 已提交
1184
		break;
1185 1186
	/* Read/clear last kernel messages */
	case SYSLOG_ACTION_READ_CLEAR:
1187
		clear = true;
L
Linus Torvalds 已提交
1188
		/* FALL THRU */
1189 1190
	/* Read last kernel messages */
	case SYSLOG_ACTION_READ_ALL:
L
Linus Torvalds 已提交
1191 1192 1193 1194 1195 1196 1197 1198 1199 1200
		error = -EINVAL;
		if (!buf || len < 0)
			goto out;
		error = 0;
		if (!len)
			goto out;
		if (!access_ok(VERIFY_WRITE, buf, len)) {
			error = -EFAULT;
			goto out;
		}
1201
		error = syslog_print_all(buf, len, clear);
L
Linus Torvalds 已提交
1202
		break;
1203 1204
	/* Clear ring buffer */
	case SYSLOG_ACTION_CLEAR:
1205
		syslog_print_all(NULL, 0, true);
1206
		break;
1207 1208
	/* Disable logging to console */
	case SYSLOG_ACTION_CONSOLE_OFF:
1209 1210
		if (saved_console_loglevel == -1)
			saved_console_loglevel = console_loglevel;
L
Linus Torvalds 已提交
1211 1212
		console_loglevel = minimum_console_loglevel;
		break;
1213 1214
	/* Enable logging to console */
	case SYSLOG_ACTION_CONSOLE_ON:
1215 1216 1217 1218
		if (saved_console_loglevel != -1) {
			console_loglevel = saved_console_loglevel;
			saved_console_loglevel = -1;
		}
L
Linus Torvalds 已提交
1219
		break;
1220 1221
	/* Set level of messages printed to console */
	case SYSLOG_ACTION_CONSOLE_LEVEL:
L
Linus Torvalds 已提交
1222 1223 1224 1225 1226 1227
		error = -EINVAL;
		if (len < 1 || len > 8)
			goto out;
		if (len < minimum_console_loglevel)
			len = minimum_console_loglevel;
		console_loglevel = len;
1228 1229
		/* Implicitly re-enable logging to console */
		saved_console_loglevel = -1;
L
Linus Torvalds 已提交
1230 1231
		error = 0;
		break;
1232 1233
	/* Number of chars in the log buffer */
	case SYSLOG_ACTION_SIZE_UNREAD:
1234 1235 1236 1237 1238
		raw_spin_lock_irq(&logbuf_lock);
		if (syslog_seq < log_first_seq) {
			/* messages are gone, move to first one */
			syslog_seq = log_first_seq;
			syslog_idx = log_first_idx;
1239
			syslog_prev = 0;
1240
			syslog_partial = 0;
1241 1242 1243 1244 1245 1246 1247 1248 1249
		}
		if (from_file) {
			/*
			 * Short-cut for poll(/"proc/kmsg") which simply checks
			 * for pending data, not the size; return the count of
			 * records, not the length.
			 */
			error = log_next_idx - syslog_idx;
		} else {
1250 1251 1252
			u64 seq = syslog_seq;
			u32 idx = syslog_idx;
			enum log_flags prev = syslog_prev;
1253 1254 1255

			error = 0;
			while (seq < log_next_seq) {
1256
				struct printk_log *msg = log_from_idx(idx);
1257

1258
				error += msg_print_text(msg, prev, true, NULL, 0);
1259 1260
				idx = log_next(idx);
				seq++;
1261
				prev = msg->flags;
1262
			}
1263
			error -= syslog_partial;
1264 1265
		}
		raw_spin_unlock_irq(&logbuf_lock);
L
Linus Torvalds 已提交
1266
		break;
1267 1268
	/* Size of the log buffer */
	case SYSLOG_ACTION_SIZE_BUFFER:
L
Linus Torvalds 已提交
1269 1270 1271 1272 1273 1274 1275 1276 1277 1278
		error = log_buf_len;
		break;
	default:
		error = -EINVAL;
		break;
	}
out:
	return error;
}

1279
SYSCALL_DEFINE3(syslog, int, type, char __user *, buf, int, len)
L
Linus Torvalds 已提交
1280
{
1281
	return do_syslog(type, buf, len, SYSLOG_FROM_READER);
L
Linus Torvalds 已提交
1282 1283 1284 1285 1286
}

/*
 * Call the console drivers, asking them to write out
 * log_buf[start] to log_buf[end - 1].
1287
 * The console_lock must be held.
L
Linus Torvalds 已提交
1288
 */
1289
static void call_console_drivers(int level, const char *text, size_t len)
L
Linus Torvalds 已提交
1290
{
1291
	struct console *con;
L
Linus Torvalds 已提交
1292

1293
	trace_console(text, len);
1294 1295 1296 1297 1298 1299 1300 1301 1302 1303 1304 1305 1306 1307 1308 1309 1310 1311

	if (level >= console_loglevel && !ignore_loglevel)
		return;
	if (!console_drivers)
		return;

	for_each_console(con) {
		if (exclusive_console && con != exclusive_console)
			continue;
		if (!(con->flags & CON_ENABLED))
			continue;
		if (!con->write)
			continue;
		if (!cpu_online(smp_processor_id()) &&
		    !(con->flags & CON_ANYTIME))
			continue;
		con->write(con, text, len);
	}
L
Linus Torvalds 已提交
1312 1313 1314 1315 1316 1317 1318 1319 1320 1321 1322 1323
}

/*
 * Zap console related locks when oopsing. Only zap at most once
 * every 10 seconds, to leave time for slow consoles to print a
 * full oops.
 */
static void zap_locks(void)
{
	static unsigned long oops_timestamp;

	if (time_after_eq(jiffies, oops_timestamp) &&
J
Jesper Juhl 已提交
1324
			!time_after(jiffies, oops_timestamp + 30 * HZ))
L
Linus Torvalds 已提交
1325 1326 1327 1328
		return;

	oops_timestamp = jiffies;

1329
	debug_locks_off();
L
Linus Torvalds 已提交
1330
	/* If a crash is occurring, make sure we can't deadlock */
1331
	raw_spin_lock_init(&logbuf_lock);
L
Linus Torvalds 已提交
1332
	/* And make sure that we print immediately */
1333
	sema_init(&console_sem, 1);
L
Linus Torvalds 已提交
1334 1335
}

1336 1337 1338 1339 1340
/* Check if we have any console registered that can be called early in boot. */
static int have_callable_console(void)
{
	struct console *con;

1341
	for_each_console(con)
1342 1343 1344 1345 1346 1347
		if (con->flags & CON_ANYTIME)
			return 1;

	return 0;
}

1348 1349 1350 1351 1352 1353 1354 1355 1356 1357 1358 1359 1360 1361 1362 1363
/*
 * Can we actually use the console at this time on this cpu?
 *
 * Console drivers may assume that per-cpu resources have
 * been allocated. So unless they're explicitly marked as
 * being able to cope (CON_ANYTIME) don't call them until
 * this CPU is officially up.
 */
static inline int can_use_console(unsigned int cpu)
{
	return cpu_online(cpu) || have_callable_console();
}

/*
 * Try to get console ownership to actually show the kernel
 * messages from a 'printk'. Return true (and with the
1364
 * console_lock held, and 'console_locked' set) if it
1365 1366 1367 1368 1369 1370
 * is successful, false otherwise.
 *
 * This gets called with the 'logbuf_lock' spinlock held and
 * interrupts disabled. It should return with 'lockbuf_lock'
 * released but interrupts still disabled.
 */
1371
static int console_trylock_for_printk(unsigned int cpu)
N
Namhyung Kim 已提交
1372
	__releases(&logbuf_lock)
1373
{
1374
	int retval = 0, wake = 0;
1375

1376
	if (console_trylock()) {
1377 1378 1379 1380 1381 1382 1383 1384 1385 1386
		retval = 1;

		/*
		 * If we can't use the console, we need to release
		 * the console semaphore by hand to avoid flushing
		 * the buffer. We need to hold the console semaphore
		 * in order to do this test safely.
		 */
		if (!can_use_console(cpu)) {
			console_locked = 0;
1387
			wake = 1;
1388 1389 1390
			retval = 0;
		}
	}
1391
	logbuf_cpu = UINT_MAX;
1392
	raw_spin_unlock(&logbuf_lock);
1393 1394
	if (wake)
		up(&console_sem);
1395 1396
	return retval;
}
1397

1398 1399 1400 1401 1402 1403 1404 1405 1406 1407 1408 1409 1410 1411
int printk_delay_msec __read_mostly;

static inline void printk_delay(void)
{
	if (unlikely(printk_delay_msec)) {
		int m = printk_delay_msec;

		while (m--) {
			mdelay(1);
			touch_nmi_watchdog();
		}
	}
}

1412 1413 1414 1415 1416 1417 1418 1419 1420 1421 1422 1423 1424 1425
/*
 * Continuation lines are buffered, and not committed to the record buffer
 * until the line is complete, or a race forces it. The line fragments
 * though, are printed immediately to the consoles to ensure everything has
 * reached the console in case of a kernel crash.
 */
static struct cont {
	char buf[LOG_LINE_MAX];
	size_t len;			/* length == 0 means unused buffer */
	size_t cons;			/* bytes written to console */
	struct task_struct *owner;	/* task of first print*/
	u64 ts_nsec;			/* time of first print */
	u8 level;			/* log level of first message */
	u8 facility;			/* log level of first message */
1426
	enum log_flags flags;		/* prefix, newline flags */
1427 1428 1429
	bool flushed:1;			/* buffer sealed and committed */
} cont;

1430
static void cont_flush(enum log_flags flags)
1431 1432 1433 1434 1435 1436
{
	if (cont.flushed)
		return;
	if (cont.len == 0)
		return;

1437 1438 1439 1440 1441 1442 1443 1444 1445 1446 1447 1448 1449 1450 1451 1452 1453 1454 1455
	if (cont.cons) {
		/*
		 * If a fragment of this line was directly flushed to the
		 * console; wait for the console to pick up the rest of the
		 * line. LOG_NOCONS suppresses a duplicated output.
		 */
		log_store(cont.facility, cont.level, flags | LOG_NOCONS,
			  cont.ts_nsec, NULL, 0, cont.buf, cont.len);
		cont.flags = flags;
		cont.flushed = true;
	} else {
		/*
		 * If no fragment of this line ever reached the console,
		 * just submit it to the store and free the buffer.
		 */
		log_store(cont.facility, cont.level, flags, 0,
			  NULL, 0, cont.buf, cont.len);
		cont.len = 0;
	}
1456 1457 1458 1459 1460 1461 1462 1463
}

static bool cont_add(int facility, int level, const char *text, size_t len)
{
	if (cont.len && cont.flushed)
		return false;

	if (cont.len + len > sizeof(cont.buf)) {
1464 1465
		/* the line gets too long, split it up in separate records */
		cont_flush(LOG_CONT);
1466 1467 1468 1469 1470 1471 1472 1473
		return false;
	}

	if (!cont.len) {
		cont.facility = facility;
		cont.level = level;
		cont.owner = current;
		cont.ts_nsec = local_clock();
1474
		cont.flags = 0;
1475 1476 1477 1478 1479 1480
		cont.cons = 0;
		cont.flushed = false;
	}

	memcpy(cont.buf + cont.len, text, len);
	cont.len += len;
1481 1482 1483 1484

	if (cont.len > (sizeof(cont.buf) * 80) / 100)
		cont_flush(LOG_CONT);

1485 1486 1487 1488 1489 1490 1491 1492
	return true;
}

static size_t cont_print_text(char *text, size_t size)
{
	size_t textlen = 0;
	size_t len;

1493
	if (cont.cons == 0 && (console_prev & LOG_NEWLINE)) {
1494 1495 1496 1497 1498 1499 1500 1501 1502 1503 1504 1505 1506 1507
		textlen += print_time(cont.ts_nsec, text);
		size -= textlen;
	}

	len = cont.len - cont.cons;
	if (len > 0) {
		if (len+1 > size)
			len = size-1;
		memcpy(text + textlen, cont.buf + cont.cons, len);
		textlen += len;
		cont.cons = cont.len;
	}

	if (cont.flushed) {
1508 1509
		if (cont.flags & LOG_NEWLINE)
			text[textlen++] = '\n';
1510 1511 1512 1513 1514 1515
		/* got everything, release buffer */
		cont.len = 0;
	}
	return textlen;
}

1516 1517 1518
asmlinkage int vprintk_emit(int facility, int level,
			    const char *dict, size_t dictlen,
			    const char *fmt, va_list args)
L
Linus Torvalds 已提交
1519
{
1520 1521 1522
	static int recursion_bug;
	static char textbuf[LOG_LINE_MAX];
	char *text = textbuf;
1523
	size_t text_len;
1524
	enum log_flags lflags = 0;
1525
	unsigned long flags;
1526
	int this_cpu;
1527
	int printed_len = 0;
L
Linus Torvalds 已提交
1528

1529
	boot_delay_msec(level);
1530
	printk_delay();
R
Randy Dunlap 已提交
1531

L
Linus Torvalds 已提交
1532
	/* This stops the holder of console_sem just where we want him */
1533
	local_irq_save(flags);
1534 1535 1536 1537 1538
	this_cpu = smp_processor_id();

	/*
	 * Ouch, printk recursed into itself!
	 */
1539
	if (unlikely(logbuf_cpu == this_cpu)) {
1540 1541 1542 1543 1544 1545 1546
		/*
		 * If a crash is occurring during printk() on this CPU,
		 * then try to get the crash message out but make sure
		 * we can't deadlock. Otherwise just return to avoid the
		 * recursion and return - but flag the recursion so that
		 * it can be printed at the next appropriate moment:
		 */
1547
		if (!oops_in_progress && !lockdep_recursing(current)) {
1548
			recursion_bug = 1;
1549 1550 1551 1552 1553
			goto out_restore_irqs;
		}
		zap_locks();
	}

1554
	lockdep_off();
1555
	raw_spin_lock(&logbuf_lock);
1556
	logbuf_cpu = this_cpu;
L
Linus Torvalds 已提交
1557

1558
	if (recursion_bug) {
1559 1560 1561
		static const char recursion_msg[] =
			"BUG: recent printk recursion!";

1562
		recursion_bug = 0;
1563 1564
		printed_len += strlen(recursion_msg);
		/* emit KERN_CRIT message */
1565
		log_store(0, 2, LOG_PREFIX|LOG_NEWLINE, 0,
1566
			  NULL, 0, recursion_msg, printed_len);
1567
	}
L
Linus Torvalds 已提交
1568

1569 1570 1571 1572
	/*
	 * The printf needs to come first; we need the syslog
	 * prefix which might be passed-in as a parameter.
	 */
1573
	text_len = vscnprintf(text, sizeof(textbuf), fmt, args);
1574

1575
	/* mark and strip a trailing newline */
1576 1577
	if (text_len && text[text_len-1] == '\n') {
		text_len--;
1578
		lflags |= LOG_NEWLINE;
1579
	}
1580

1581 1582 1583 1584 1585 1586 1587 1588 1589 1590 1591 1592 1593
	/* strip kernel syslog prefix and extract log level or control flags */
	if (facility == 0) {
		int kern_level = printk_get_level(text);

		if (kern_level) {
			const char *end_of_header = printk_skip_level(text);
			switch (kern_level) {
			case '0' ... '7':
				if (level == -1)
					level = kern_level - '0';
			case 'd':	/* KERN_DEFAULT */
				lflags |= LOG_PREFIX;
			}
1594 1595 1596 1597 1598
			/*
			 * No need to check length here because vscnprintf
			 * put '\0' at the end of the string. Only valid and
			 * newly printed level is detected.
			 */
1599 1600
			text_len -= end_of_header - text;
			text = (char *)end_of_header;
1601 1602 1603
		}
	}

1604 1605
	if (level == -1)
		level = default_message_loglevel;
1606

1607 1608
	if (dict)
		lflags |= LOG_PREFIX|LOG_NEWLINE;
1609

1610
	if (!(lflags & LOG_NEWLINE)) {
1611 1612 1613 1614
		/*
		 * Flush the conflicting buffer. An earlier newline was missing,
		 * or another task also prints continuation lines.
		 */
1615
		if (cont.len && (lflags & LOG_PREFIX || cont.owner != current))
1616
			cont_flush(LOG_NEWLINE);
1617

1618 1619
		/* buffer line if possible, otherwise store it right away */
		if (!cont_add(facility, level, text, text_len))
1620
			log_store(facility, level, lflags | LOG_CONT, 0,
1621
				  dict, dictlen, text, text_len);
1622
	} else {
1623
		bool stored = false;
1624

1625
		/*
1626 1627 1628 1629
		 * If an earlier newline was missing and it was the same task,
		 * either merge it with the current buffer and flush, or if
		 * there was a race with interrupts (prefix == true) then just
		 * flush it out and store this line separately.
1630 1631
		 * If the preceding printk was from a different task and missed
		 * a newline, flush and append the newline.
1632
		 */
1633 1634 1635 1636
		if (cont.len) {
			if (cont.owner == current && !(lflags & LOG_PREFIX))
				stored = cont_add(facility, level, text,
						  text_len);
1637
			cont_flush(LOG_NEWLINE);
1638
		}
1639 1640

		if (!stored)
1641
			log_store(facility, level, lflags, 0,
1642
				  dict, dictlen, text, text_len);
L
Linus Torvalds 已提交
1643
	}
1644
	printed_len += text_len;
L
Linus Torvalds 已提交
1645

1646
	/*
1647 1648 1649
	 * Try to acquire and then immediately release the console semaphore.
	 * The release will print out buffers and wake up /dev/kmsg and syslog()
	 * users.
1650
	 *
1651 1652
	 * The console_trylock_for_printk() function will release 'logbuf_lock'
	 * regardless of whether it actually gets the console semaphore or not.
1653
	 */
1654 1655
	if (console_trylock_for_printk(this_cpu))
		console_unlock();
1656

1657
	lockdep_on();
1658
out_restore_irqs:
1659
	local_irq_restore(flags);
1660

L
Linus Torvalds 已提交
1661 1662
	return printed_len;
}
1663 1664 1665 1666 1667 1668
EXPORT_SYMBOL(vprintk_emit);

asmlinkage int vprintk(const char *fmt, va_list args)
{
	return vprintk_emit(0, -1, NULL, 0, fmt, args);
}
L
Linus Torvalds 已提交
1669 1670
EXPORT_SYMBOL(vprintk);

1671 1672 1673 1674 1675 1676 1677 1678 1679 1680 1681 1682 1683 1684 1685 1686 1687 1688 1689 1690 1691 1692 1693 1694 1695 1696 1697 1698 1699 1700 1701 1702 1703 1704 1705 1706
asmlinkage int printk_emit(int facility, int level,
			   const char *dict, size_t dictlen,
			   const char *fmt, ...)
{
	va_list args;
	int r;

	va_start(args, fmt);
	r = vprintk_emit(facility, level, dict, dictlen, fmt, args);
	va_end(args);

	return r;
}
EXPORT_SYMBOL(printk_emit);

/**
 * printk - print a kernel message
 * @fmt: format string
 *
 * This is printk(). It can be called from any context. We want it to work.
 *
 * We try to grab the console_lock. If we succeed, it's easy - we log the
 * output and call the console drivers.  If we fail to get the semaphore, we
 * place the output into the log buffer and return. The current holder of
 * the console_sem will notice the new output in console_unlock(); and will
 * send it to the consoles before releasing the lock.
 *
 * One effect of this deferred printing is that code which calls printk() and
 * then changes console_loglevel may break. This is because console_loglevel
 * is inspected when the actual printing occurs.
 *
 * See also:
 * printf(3)
 *
 * See the vsnprintf() documentation for format string extensions over C99.
 */
1707
asmlinkage __visible int printk(const char *fmt, ...)
1708 1709 1710 1711 1712 1713 1714 1715 1716 1717 1718 1719 1720 1721 1722 1723 1724 1725 1726
{
	va_list args;
	int r;

#ifdef CONFIG_KGDB_KDB
	if (unlikely(kdb_trap_printk)) {
		va_start(args, fmt);
		r = vkdb_printf(fmt, args);
		va_end(args);
		return r;
	}
#endif
	va_start(args, fmt);
	r = vprintk_emit(0, -1, NULL, 0, fmt, args);
	va_end(args);

	return r;
}
EXPORT_SYMBOL(printk);
1727

1728
#else /* CONFIG_PRINTK */
M
Matt Mackall 已提交
1729

1730 1731
#define LOG_LINE_MAX		0
#define PREFIX_MAX		0
1732
#define LOG_LINE_MAX 0
1733 1734
static u64 syslog_seq;
static u32 syslog_idx;
1735 1736
static u64 console_seq;
static u32 console_idx;
1737 1738 1739 1740
static enum log_flags syslog_prev;
static u64 log_first_seq;
static u32 log_first_idx;
static u64 log_next_seq;
1741
static enum log_flags console_prev;
1742 1743 1744 1745 1746 1747
static struct cont {
	size_t len;
	size_t cons;
	u8 level;
	bool flushed:1;
} cont;
1748
static struct printk_log *log_from_idx(u32 idx) { return NULL; }
1749 1750
static u32 log_next(u32 idx) { return 0; }
static void call_console_drivers(int level, const char *text, size_t len) {}
1751
static size_t msg_print_text(const struct printk_log *msg, enum log_flags prev,
1752
			     bool syslog, char *buf, size_t size) { return 0; }
1753
static size_t cont_print_text(char *text, size_t size) { return 0; }
M
Matt Mackall 已提交
1754

1755
#endif /* CONFIG_PRINTK */
M
Matt Mackall 已提交
1756

1757 1758 1759 1760 1761 1762 1763 1764 1765 1766 1767 1768 1769
#ifdef CONFIG_EARLY_PRINTK
struct console *early_console;

void early_vprintk(const char *fmt, va_list ap)
{
	if (early_console) {
		char buf[512];
		int n = vscnprintf(buf, sizeof(buf), fmt, ap);

		early_console->write(early_console, buf, n);
	}
}

1770
asmlinkage __visible void early_printk(const char *fmt, ...)
1771 1772 1773 1774 1775 1776 1777 1778 1779
{
	va_list ap;

	va_start(ap, fmt);
	early_vprintk(fmt, ap);
	va_end(ap);
}
#endif

1780 1781 1782 1783 1784 1785 1786 1787 1788 1789
static int __add_preferred_console(char *name, int idx, char *options,
				   char *brl_options)
{
	struct console_cmdline *c;
	int i;

	/*
	 *	See if this tty is not yet registered, and
	 *	if we have a slot free.
	 */
1790 1791 1792 1793 1794 1795 1796
	for (i = 0, c = console_cmdline;
	     i < MAX_CMDLINECONSOLES && c->name[0];
	     i++, c++) {
		if (strcmp(c->name, name) == 0 && c->index == idx) {
			if (!brl_options)
				selected_console = i;
			return 0;
1797
		}
1798
	}
1799 1800 1801 1802 1803 1804
	if (i == MAX_CMDLINECONSOLES)
		return -E2BIG;
	if (!brl_options)
		selected_console = i;
	strlcpy(c->name, name, sizeof(c->name));
	c->options = options;
1805 1806
	braille_set_options(c, brl_options);

1807 1808 1809
	c->index = idx;
	return 0;
}
1810 1811 1812 1813 1814
/*
 * Set up a list of consoles.  Called from init/main.c
 */
static int __init console_setup(char *str)
{
Y
Yinghai Lu 已提交
1815
	char buf[sizeof(console_cmdline[0].name) + 4]; /* 4 for index */
1816
	char *s, *options, *brl_options = NULL;
1817 1818
	int idx;

1819 1820
	if (_braille_console_setup(&str, &brl_options))
		return 1;
1821

1822 1823 1824 1825
	/*
	 * Decode str into name, index, options.
	 */
	if (str[0] >= '0' && str[0] <= '9') {
Y
Yinghai Lu 已提交
1826 1827
		strcpy(buf, "ttyS");
		strncpy(buf + 4, str, sizeof(buf) - 5);
1828
	} else {
Y
Yinghai Lu 已提交
1829
		strncpy(buf, str, sizeof(buf) - 1);
1830
	}
Y
Yinghai Lu 已提交
1831
	buf[sizeof(buf) - 1] = 0;
1832 1833 1834 1835
	if ((options = strchr(str, ',')) != NULL)
		*(options++) = 0;
#ifdef __sparc__
	if (!strcmp(str, "ttya"))
Y
Yinghai Lu 已提交
1836
		strcpy(buf, "ttyS0");
1837
	if (!strcmp(str, "ttyb"))
Y
Yinghai Lu 已提交
1838
		strcpy(buf, "ttyS1");
1839
#endif
Y
Yinghai Lu 已提交
1840
	for (s = buf; *s; s++)
1841 1842 1843 1844 1845
		if ((*s >= '0' && *s <= '9') || *s == ',')
			break;
	idx = simple_strtoul(s, NULL, 10);
	*s = 0;

1846
	__add_preferred_console(buf, idx, options, brl_options);
1847
	console_set_on_cmdline = 1;
1848 1849 1850 1851
	return 1;
}
__setup("console=", console_setup);

1852 1853
/**
 * add_preferred_console - add a device to the list of preferred consoles.
1854 1855 1856
 * @name: device name
 * @idx: device index
 * @options: options for this console
1857 1858 1859 1860 1861 1862 1863 1864
 *
 * The last preferred console added will be used for kernel messages
 * and stdin/out/err for init.  Normally this is used by console_setup
 * above to handle user-supplied console arguments; however it can also
 * be used by arch-specific code either to override the user or more
 * commonly to provide a default console (ie from PROM variables) when
 * the user has not supplied one.
 */
1865
int add_preferred_console(char *name, int idx, char *options)
1866
{
1867
	return __add_preferred_console(name, idx, options, NULL);
1868 1869
}

1870
int update_console_cmdline(char *name, int idx, char *name_new, int idx_new, char *options)
1871 1872 1873 1874
{
	struct console_cmdline *c;
	int i;

1875 1876 1877 1878 1879 1880 1881 1882 1883
	for (i = 0, c = console_cmdline;
	     i < MAX_CMDLINECONSOLES && c->name[0];
	     i++, c++)
		if (strcmp(c->name, name) == 0 && c->index == idx) {
			strlcpy(c->name, name_new, sizeof(c->name));
			c->name[sizeof(c->name) - 1] = 0;
			c->options = options;
			c->index = idx_new;
			return i;
1884 1885 1886 1887 1888
		}
	/* not found */
	return -1;
}

1889
bool console_suspend_enabled = 1;
1890 1891 1892 1893 1894 1895 1896 1897
EXPORT_SYMBOL(console_suspend_enabled);

static int __init console_suspend_disable(char *str)
{
	console_suspend_enabled = 0;
	return 1;
}
__setup("no_console_suspend", console_suspend_disable);
1898 1899 1900 1901
module_param_named(console_suspend, console_suspend_enabled,
		bool, S_IRUGO | S_IWUSR);
MODULE_PARM_DESC(console_suspend, "suspend console during suspend"
	" and hibernate operations");
1902

1903 1904 1905 1906 1907 1908 1909
/**
 * suspend_console - suspend the console subsystem
 *
 * This disables printk() while we go into suspend states
 */
void suspend_console(void)
{
1910 1911
	if (!console_suspend_enabled)
		return;
1912
	printk("Suspending console(s) (use no_console_suspend to debug)\n");
1913
	console_lock();
1914
	console_suspended = 1;
1915
	up(&console_sem);
1916
	mutex_release(&console_lock_dep_map, 1, _RET_IP_);
1917 1918 1919 1920
}

void resume_console(void)
{
1921 1922
	if (!console_suspend_enabled)
		return;
1923
	down(&console_sem);
1924
	mutex_acquire(&console_lock_dep_map, 0, 0, _RET_IP_);
1925
	console_suspended = 0;
1926
	console_unlock();
1927 1928
}

1929 1930 1931 1932 1933 1934 1935 1936 1937 1938 1939
/**
 * console_cpu_notify - print deferred console messages after CPU hotplug
 * @self: notifier struct
 * @action: CPU hotplug event
 * @hcpu: unused
 *
 * If printk() is called from a CPU that is not online yet, the messages
 * will be spooled but will not show up on the console.  This function is
 * called when a new CPU comes online (or fails to come up), and ensures
 * that any such output gets printed.
 */
1940
static int console_cpu_notify(struct notifier_block *self,
1941 1942 1943 1944 1945 1946 1947
	unsigned long action, void *hcpu)
{
	switch (action) {
	case CPU_ONLINE:
	case CPU_DEAD:
	case CPU_DOWN_FAILED:
	case CPU_UP_CANCELED:
1948 1949
		console_lock();
		console_unlock();
1950 1951 1952 1953
	}
	return NOTIFY_OK;
}

L
Linus Torvalds 已提交
1954
/**
1955
 * console_lock - lock the console system for exclusive use.
L
Linus Torvalds 已提交
1956
 *
1957
 * Acquires a lock which guarantees that the caller has
L
Linus Torvalds 已提交
1958 1959 1960 1961
 * exclusive access to the console system and the console_drivers list.
 *
 * Can sleep, returns nothing.
 */
1962
void console_lock(void)
L
Linus Torvalds 已提交
1963
{
1964 1965
	might_sleep();

L
Linus Torvalds 已提交
1966
	down(&console_sem);
1967 1968
	if (console_suspended)
		return;
L
Linus Torvalds 已提交
1969 1970
	console_locked = 1;
	console_may_schedule = 1;
1971
	mutex_acquire(&console_lock_dep_map, 0, 0, _RET_IP_);
L
Linus Torvalds 已提交
1972
}
1973
EXPORT_SYMBOL(console_lock);
L
Linus Torvalds 已提交
1974

1975 1976 1977 1978 1979 1980 1981 1982 1983
/**
 * console_trylock - try to lock the console system for exclusive use.
 *
 * Tried to acquire a lock which guarantees that the caller has
 * exclusive access to the console system and the console_drivers list.
 *
 * returns 1 on success, and 0 on failure to acquire the lock.
 */
int console_trylock(void)
L
Linus Torvalds 已提交
1984 1985
{
	if (down_trylock(&console_sem))
1986
		return 0;
1987 1988
	if (console_suspended) {
		up(&console_sem);
1989
		return 0;
1990
	}
L
Linus Torvalds 已提交
1991 1992
	console_locked = 1;
	console_may_schedule = 0;
1993
	mutex_acquire(&console_lock_dep_map, 0, 1, _RET_IP_);
1994
	return 1;
L
Linus Torvalds 已提交
1995
}
1996
EXPORT_SYMBOL(console_trylock);
L
Linus Torvalds 已提交
1997 1998 1999 2000 2001 2002

int is_console_locked(void)
{
	return console_locked;
}

2003 2004 2005 2006 2007 2008 2009 2010 2011 2012 2013 2014 2015 2016 2017 2018 2019 2020 2021 2022 2023 2024 2025 2026 2027 2028 2029 2030
static void console_cont_flush(char *text, size_t size)
{
	unsigned long flags;
	size_t len;

	raw_spin_lock_irqsave(&logbuf_lock, flags);

	if (!cont.len)
		goto out;

	/*
	 * We still queue earlier records, likely because the console was
	 * busy. The earlier ones need to be printed before this one, we
	 * did not flush any fragment so far, so just let it queue up.
	 */
	if (console_seq < log_next_seq && !cont.cons)
		goto out;

	len = cont_print_text(text, size);
	raw_spin_unlock(&logbuf_lock);
	stop_critical_timings();
	call_console_drivers(cont.level, text, len);
	start_critical_timings();
	local_irq_restore(flags);
	return;
out:
	raw_spin_unlock_irqrestore(&logbuf_lock, flags);
}
2031

L
Linus Torvalds 已提交
2032
/**
2033
 * console_unlock - unlock the console system
L
Linus Torvalds 已提交
2034
 *
2035
 * Releases the console_lock which the caller holds on the console system
L
Linus Torvalds 已提交
2036 2037
 * and the console driver list.
 *
2038 2039 2040
 * While the console_lock was held, console output may have been buffered
 * by printk().  If this is the case, console_unlock(); emits
 * the output prior to releasing the lock.
L
Linus Torvalds 已提交
2041
 *
2042
 * If there is output waiting, we wake /dev/kmsg and syslog() users.
L
Linus Torvalds 已提交
2043
 *
2044
 * console_unlock(); may be called from any context.
L
Linus Torvalds 已提交
2045
 */
2046
void console_unlock(void)
L
Linus Torvalds 已提交
2047
{
2048
	static char text[LOG_LINE_MAX + PREFIX_MAX];
2049
	static u64 seen_seq;
L
Linus Torvalds 已提交
2050
	unsigned long flags;
2051 2052
	bool wake_klogd = false;
	bool retry;
L
Linus Torvalds 已提交
2053

2054
	if (console_suspended) {
2055
		up(&console_sem);
2056 2057
		return;
	}
2058 2059 2060

	console_may_schedule = 0;

2061
	/* flush buffered message fragment immediately to console */
2062
	console_cont_flush(text, sizeof(text));
2063
again:
2064
	for (;;) {
2065
		struct printk_log *msg;
2066
		size_t len;
2067 2068
		int level;

2069
		raw_spin_lock_irqsave(&logbuf_lock, flags);
2070 2071 2072 2073 2074 2075 2076 2077 2078
		if (seen_seq != log_next_seq) {
			wake_klogd = true;
			seen_seq = log_next_seq;
		}

		if (console_seq < log_first_seq) {
			/* messages are gone, move to first one */
			console_seq = log_first_seq;
			console_idx = log_first_idx;
2079
			console_prev = 0;
2080
		}
2081
skip:
2082 2083 2084 2085
		if (console_seq == log_next_seq)
			break;

		msg = log_from_idx(console_idx);
2086 2087 2088 2089 2090 2091 2092
		if (msg->flags & LOG_NOCONS) {
			/*
			 * Skip record we have buffered and already printed
			 * directly to the console when we received it.
			 */
			console_idx = log_next(console_idx);
			console_seq++;
2093 2094 2095 2096 2097 2098
			/*
			 * We will get here again when we register a new
			 * CON_PRINTBUFFER console. Clear the flag so we
			 * will properly dump everything later.
			 */
			msg->flags &= ~LOG_NOCONS;
2099
			console_prev = msg->flags;
2100 2101
			goto skip;
		}
2102

2103
		level = msg->level;
2104 2105
		len = msg_print_text(msg, console_prev, false,
				     text, sizeof(text));
2106 2107
		console_idx = log_next(console_idx);
		console_seq++;
2108
		console_prev = msg->flags;
2109
		raw_spin_unlock(&logbuf_lock);
2110

2111
		stop_critical_timings();	/* don't trace print latency */
2112
		call_console_drivers(level, text, len);
2113
		start_critical_timings();
L
Linus Torvalds 已提交
2114 2115 2116
		local_irq_restore(flags);
	}
	console_locked = 0;
2117
	mutex_release(&console_lock_dep_map, 1, _RET_IP_);
2118 2119 2120 2121 2122

	/* Release the exclusive_console once it is used */
	if (unlikely(exclusive_console))
		exclusive_console = NULL;

2123
	raw_spin_unlock(&logbuf_lock);
2124

2125
	up(&console_sem);
2126 2127 2128 2129 2130 2131 2132

	/*
	 * Someone could have filled up the buffer again, so re-check if there's
	 * something to flush. In case we cannot trylock the console_sem again,
	 * there's a new owner and the console_unlock() from them will do the
	 * flush, no worries.
	 */
2133
	raw_spin_lock(&logbuf_lock);
2134
	retry = console_seq != log_next_seq;
P
Peter Zijlstra 已提交
2135 2136
	raw_spin_unlock_irqrestore(&logbuf_lock, flags);

2137 2138 2139
	if (retry && console_trylock())
		goto again;

2140 2141
	if (wake_klogd)
		wake_up_klogd();
L
Linus Torvalds 已提交
2142
}
2143
EXPORT_SYMBOL(console_unlock);
L
Linus Torvalds 已提交
2144

2145 2146
/**
 * console_conditional_schedule - yield the CPU if required
L
Linus Torvalds 已提交
2147 2148 2149 2150 2151
 *
 * If the console code is currently allowed to sleep, and
 * if this CPU should yield the CPU to another task, do
 * so here.
 *
2152
 * Must be called within console_lock();.
L
Linus Torvalds 已提交
2153 2154 2155 2156 2157 2158 2159 2160 2161 2162 2163 2164 2165 2166 2167 2168 2169 2170 2171 2172
 */
void __sched console_conditional_schedule(void)
{
	if (console_may_schedule)
		cond_resched();
}
EXPORT_SYMBOL(console_conditional_schedule);

void console_unblank(void)
{
	struct console *c;

	/*
	 * console_unblank can no longer be called in interrupt context unless
	 * oops_in_progress is set to 1..
	 */
	if (oops_in_progress) {
		if (down_trylock(&console_sem) != 0)
			return;
	} else
2173
		console_lock();
L
Linus Torvalds 已提交
2174 2175 2176

	console_locked = 1;
	console_may_schedule = 0;
2177
	for_each_console(c)
L
Linus Torvalds 已提交
2178 2179
		if ((c->flags & CON_ENABLED) && c->unblank)
			c->unblank();
2180
	console_unlock();
L
Linus Torvalds 已提交
2181 2182 2183 2184 2185 2186 2187 2188 2189 2190
}

/*
 * Return the console tty driver structure and its associated index
 */
struct tty_driver *console_device(int *index)
{
	struct console *c;
	struct tty_driver *driver = NULL;

2191
	console_lock();
2192
	for_each_console(c) {
L
Linus Torvalds 已提交
2193 2194 2195 2196 2197 2198
		if (!c->device)
			continue;
		driver = c->device(c, index);
		if (driver)
			break;
	}
2199
	console_unlock();
L
Linus Torvalds 已提交
2200 2201 2202 2203 2204 2205 2206 2207 2208 2209
	return driver;
}

/*
 * Prevent further output on the passed console device so that (for example)
 * serial drivers can disable console output before suspending a port, and can
 * re-enable output afterwards.
 */
void console_stop(struct console *console)
{
2210
	console_lock();
L
Linus Torvalds 已提交
2211
	console->flags &= ~CON_ENABLED;
2212
	console_unlock();
L
Linus Torvalds 已提交
2213 2214 2215 2216 2217
}
EXPORT_SYMBOL(console_stop);

void console_start(struct console *console)
{
2218
	console_lock();
L
Linus Torvalds 已提交
2219
	console->flags |= CON_ENABLED;
2220
	console_unlock();
L
Linus Torvalds 已提交
2221 2222 2223
}
EXPORT_SYMBOL(console_start);

2224 2225 2226 2227 2228
static int __read_mostly keep_bootcon;

static int __init keep_bootcon_setup(char *str)
{
	keep_bootcon = 1;
2229
	pr_info("debug: skip boot console de-registration.\n");
2230 2231 2232 2233 2234 2235

	return 0;
}

early_param("keep_bootcon", keep_bootcon_setup);

L
Linus Torvalds 已提交
2236 2237 2238 2239 2240
/*
 * The console driver calls this routine during kernel initialization
 * to register the console printing procedure with printk() and to
 * print any messages that were printed by the kernel before the
 * console driver was initialized.
2241 2242 2243 2244 2245 2246 2247 2248 2249 2250 2251 2252 2253
 *
 * This can happen pretty early during the boot process (because of
 * early_printk) - sometimes before setup_arch() completes - be careful
 * of what kernel features are used - they may not be initialised yet.
 *
 * There are two types of consoles - bootconsoles (early_printk) and
 * "real" consoles (everything which is not a bootconsole) which are
 * handled differently.
 *  - Any number of bootconsoles can be registered at any time.
 *  - As soon as a "real" console is registered, all bootconsoles
 *    will be unregistered automatically.
 *  - Once a "real" console is registered, any attempt to register a
 *    bootconsoles will be rejected
L
Linus Torvalds 已提交
2254
 */
2255
void register_console(struct console *newcon)
L
Linus Torvalds 已提交
2256
{
J
Jesper Juhl 已提交
2257
	int i;
L
Linus Torvalds 已提交
2258
	unsigned long flags;
2259
	struct console *bcon = NULL;
2260
	struct console_cmdline *c;
L
Linus Torvalds 已提交
2261

2262 2263 2264 2265 2266 2267 2268
	if (console_drivers)
		for_each_console(bcon)
			if (WARN(bcon == newcon,
					"console '%s%d' already registered\n",
					bcon->name, bcon->index))
				return;

2269 2270 2271 2272 2273 2274 2275 2276
	/*
	 * before we register a new CON_BOOT console, make sure we don't
	 * already have a valid console
	 */
	if (console_drivers && newcon->flags & CON_BOOT) {
		/* find the last or real console */
		for_each_console(bcon) {
			if (!(bcon->flags & CON_BOOT)) {
2277
				pr_info("Too late to register bootconsole %s%d\n",
2278 2279 2280 2281
					newcon->name, newcon->index);
				return;
			}
		}
2282 2283
	}

2284 2285 2286 2287
	if (console_drivers && console_drivers->flags & CON_BOOT)
		bcon = console_drivers;

	if (preferred_console < 0 || bcon || !console_drivers)
L
Linus Torvalds 已提交
2288 2289
		preferred_console = selected_console;

2290 2291
	if (newcon->early_setup)
		newcon->early_setup();
2292

L
Linus Torvalds 已提交
2293 2294 2295 2296 2297 2298
	/*
	 *	See if we want to use this console driver. If we
	 *	didn't select a console we take the first one
	 *	that registers here.
	 */
	if (preferred_console < 0) {
2299 2300 2301 2302 2303 2304 2305
		if (newcon->index < 0)
			newcon->index = 0;
		if (newcon->setup == NULL ||
		    newcon->setup(newcon, NULL) == 0) {
			newcon->flags |= CON_ENABLED;
			if (newcon->device) {
				newcon->flags |= CON_CONSDEV;
2306 2307
				preferred_console = 0;
			}
L
Linus Torvalds 已提交
2308 2309 2310 2311 2312 2313 2314
		}
	}

	/*
	 *	See if this console matches one we selected on
	 *	the command line.
	 */
2315 2316 2317 2318
	for (i = 0, c = console_cmdline;
	     i < MAX_CMDLINECONSOLES && c->name[0];
	     i++, c++) {
		if (strcmp(c->name, newcon->name) != 0)
L
Linus Torvalds 已提交
2319
			continue;
2320
		if (newcon->index >= 0 &&
2321
		    newcon->index != c->index)
L
Linus Torvalds 已提交
2322
			continue;
2323
		if (newcon->index < 0)
2324
			newcon->index = c->index;
2325

2326
		if (_braille_register_console(newcon, c))
2327
			return;
2328

2329 2330
		if (newcon->setup &&
		    newcon->setup(newcon, console_cmdline[i].options) != 0)
L
Linus Torvalds 已提交
2331
			break;
2332
		newcon->flags |= CON_ENABLED;
2333
		newcon->index = c->index;
2334
		if (i == selected_console) {
2335
			newcon->flags |= CON_CONSDEV;
2336 2337
			preferred_console = selected_console;
		}
L
Linus Torvalds 已提交
2338 2339 2340
		break;
	}

2341
	if (!(newcon->flags & CON_ENABLED))
L
Linus Torvalds 已提交
2342 2343
		return;

2344 2345 2346 2347 2348 2349 2350
	/*
	 * If we have a bootconsole, and are switching to a real console,
	 * don't print everything out again, since when the boot console, and
	 * the real console are the same physical device, it's annoying to
	 * see the beginning boot messages twice
	 */
	if (bcon && ((newcon->flags & (CON_CONSDEV | CON_BOOT)) == CON_CONSDEV))
2351
		newcon->flags &= ~CON_PRINTBUFFER;
L
Linus Torvalds 已提交
2352 2353 2354 2355 2356

	/*
	 *	Put this console in the list - keep the
	 *	preferred driver at the head of the list.
	 */
2357
	console_lock();
2358 2359 2360 2361 2362
	if ((newcon->flags & CON_CONSDEV) || console_drivers == NULL) {
		newcon->next = console_drivers;
		console_drivers = newcon;
		if (newcon->next)
			newcon->next->flags &= ~CON_CONSDEV;
L
Linus Torvalds 已提交
2363
	} else {
2364 2365
		newcon->next = console_drivers->next;
		console_drivers->next = newcon;
L
Linus Torvalds 已提交
2366
	}
2367
	if (newcon->flags & CON_PRINTBUFFER) {
L
Linus Torvalds 已提交
2368
		/*
2369
		 * console_unlock(); will print out the buffered messages
L
Linus Torvalds 已提交
2370 2371
		 * for us.
		 */
2372
		raw_spin_lock_irqsave(&logbuf_lock, flags);
2373 2374
		console_seq = syslog_seq;
		console_idx = syslog_idx;
2375
		console_prev = syslog_prev;
2376
		raw_spin_unlock_irqrestore(&logbuf_lock, flags);
2377 2378 2379 2380 2381 2382
		/*
		 * We're about to replay the log buffer.  Only do this to the
		 * just-registered console to avoid excessive message spam to
		 * the already-registered consoles.
		 */
		exclusive_console = newcon;
L
Linus Torvalds 已提交
2383
	}
2384
	console_unlock();
2385
	console_sysfs_notify();
2386 2387 2388 2389 2390 2391 2392 2393

	/*
	 * By unregistering the bootconsoles after we enable the real console
	 * we get the "console xxx enabled" message on all the consoles -
	 * boot consoles, real consoles, etc - this is to ensure that end
	 * users know there might be something in the kernel's log buffer that
	 * went to the bootconsole (that they do not see on the real console)
	 */
2394
	pr_info("%sconsole [%s%d] enabled\n",
2395 2396
		(newcon->flags & CON_BOOT) ? "boot" : "" ,
		newcon->name, newcon->index);
2397 2398 2399
	if (bcon &&
	    ((newcon->flags & (CON_CONSDEV | CON_BOOT)) == CON_CONSDEV) &&
	    !keep_bootcon) {
2400 2401
		/* We need to iterate through all boot consoles, to make
		 * sure we print everything out, before we unregister them.
2402 2403 2404 2405 2406
		 */
		for_each_console(bcon)
			if (bcon->flags & CON_BOOT)
				unregister_console(bcon);
	}
L
Linus Torvalds 已提交
2407 2408 2409
}
EXPORT_SYMBOL(register_console);

J
Jesper Juhl 已提交
2410
int unregister_console(struct console *console)
L
Linus Torvalds 已提交
2411
{
J
Jesper Juhl 已提交
2412
        struct console *a, *b;
2413
	int res;
L
Linus Torvalds 已提交
2414

2415
	pr_info("%sconsole [%s%d] disabled\n",
2416 2417 2418
		(console->flags & CON_BOOT) ? "boot" : "" ,
		console->name, console->index);

2419 2420 2421
	res = _braille_unregister_console(console);
	if (res)
		return res;
2422

2423
	res = 1;
2424
	console_lock();
L
Linus Torvalds 已提交
2425 2426 2427
	if (console_drivers == console) {
		console_drivers=console->next;
		res = 0;
2428
	} else if (console_drivers) {
L
Linus Torvalds 已提交
2429 2430 2431 2432 2433 2434
		for (a=console_drivers->next, b=console_drivers ;
		     a; b=a, a=b->next) {
			if (a == console) {
				b->next = a->next;
				res = 0;
				break;
J
Jesper Juhl 已提交
2435
			}
L
Linus Torvalds 已提交
2436 2437
		}
	}
J
Jesper Juhl 已提交
2438

2439
	/*
2440 2441
	 * If this isn't the last console and it has CON_CONSDEV set, we
	 * need to set it on the next preferred console.
L
Linus Torvalds 已提交
2442
	 */
2443
	if (console_drivers != NULL && console->flags & CON_CONSDEV)
2444
		console_drivers->flags |= CON_CONSDEV;
L
Linus Torvalds 已提交
2445

2446
	console->flags &= ~CON_ENABLED;
2447
	console_unlock();
2448
	console_sysfs_notify();
L
Linus Torvalds 已提交
2449 2450 2451
	return res;
}
EXPORT_SYMBOL(unregister_console);
M
Matt Mackall 已提交
2452

2453
static int __init printk_late_init(void)
2454
{
2455 2456 2457
	struct console *con;

	for_each_console(con) {
2458
		if (!keep_bootcon && con->flags & CON_BOOT) {
2459
			unregister_console(con);
2460
		}
2461
	}
2462
	hotcpu_notifier(console_cpu_notify, 0);
2463 2464
	return 0;
}
2465
late_initcall(printk_late_init);
2466

2467
#if defined CONFIG_PRINTK
2468 2469 2470 2471 2472 2473 2474 2475 2476 2477 2478 2479 2480 2481 2482 2483 2484
/*
 * Delayed printk version, for scheduler-internal messages:
 */
#define PRINTK_BUF_SIZE		512

#define PRINTK_PENDING_WAKEUP	0x01
#define PRINTK_PENDING_SCHED	0x02

static DEFINE_PER_CPU(int, printk_pending);
static DEFINE_PER_CPU(char [PRINTK_BUF_SIZE], printk_sched_buf);

static void wake_up_klogd_work_func(struct irq_work *irq_work)
{
	int pending = __this_cpu_xchg(printk_pending, 0);

	if (pending & PRINTK_PENDING_SCHED) {
		char *buf = __get_cpu_var(printk_sched_buf);
2485
		pr_warn("[sched_delayed] %s", buf);
2486 2487 2488 2489 2490 2491 2492 2493 2494 2495 2496 2497 2498 2499 2500 2501 2502 2503 2504 2505
	}

	if (pending & PRINTK_PENDING_WAKEUP)
		wake_up_interruptible(&log_wait);
}

static DEFINE_PER_CPU(struct irq_work, wake_up_klogd_work) = {
	.func = wake_up_klogd_work_func,
	.flags = IRQ_WORK_LAZY,
};

void wake_up_klogd(void)
{
	preempt_disable();
	if (waitqueue_active(&log_wait)) {
		this_cpu_or(printk_pending, PRINTK_PENDING_WAKEUP);
		irq_work_queue(&__get_cpu_var(wake_up_klogd_work));
	}
	preempt_enable();
}
D
Dave Young 已提交
2506

2507 2508 2509 2510 2511 2512 2513 2514 2515 2516 2517 2518 2519 2520 2521
int printk_sched(const char *fmt, ...)
{
	unsigned long flags;
	va_list args;
	char *buf;
	int r;

	local_irq_save(flags);
	buf = __get_cpu_var(printk_sched_buf);

	va_start(args, fmt);
	r = vsnprintf(buf, PRINTK_BUF_SIZE, fmt, args);
	va_end(args);

	__this_cpu_or(printk_pending, PRINTK_PENDING_SCHED);
2522
	irq_work_queue(&__get_cpu_var(wake_up_klogd_work));
2523 2524 2525 2526 2527
	local_irq_restore(flags);

	return r;
}

L
Linus Torvalds 已提交
2528 2529 2530
/*
 * printk rate limiting, lifted from the networking subsystem.
 *
2531 2532
 * This enforces a rate limit: not more than 10 kernel messages
 * every 5s to make a denial-of-service attack impossible.
L
Linus Torvalds 已提交
2533
 */
2534 2535
DEFINE_RATELIMIT_STATE(printk_ratelimit_state, 5 * HZ, 10);

2536
int __printk_ratelimit(const char *func)
L
Linus Torvalds 已提交
2537
{
2538
	return ___ratelimit(&printk_ratelimit_state, func);
L
Linus Torvalds 已提交
2539
}
2540
EXPORT_SYMBOL(__printk_ratelimit);
2541 2542 2543 2544 2545 2546 2547 2548 2549 2550 2551 2552 2553

/**
 * printk_timed_ratelimit - caller-controlled printk ratelimiting
 * @caller_jiffies: pointer to caller's state
 * @interval_msecs: minimum interval between prints
 *
 * printk_timed_ratelimit() returns true if more than @interval_msecs
 * milliseconds have elapsed since the last time printk_timed_ratelimit()
 * returned true.
 */
bool printk_timed_ratelimit(unsigned long *caller_jiffies,
			unsigned int interval_msecs)
{
2554 2555 2556 2557 2558
	if (*caller_jiffies == 0
			|| !time_in_range(jiffies, *caller_jiffies,
					*caller_jiffies
					+ msecs_to_jiffies(interval_msecs))) {
		*caller_jiffies = jiffies;
2559 2560 2561 2562 2563
		return true;
	}
	return false;
}
EXPORT_SYMBOL(printk_timed_ratelimit);
2564 2565 2566 2567 2568 2569

static DEFINE_SPINLOCK(dump_list_lock);
static LIST_HEAD(dump_list);

/**
 * kmsg_dump_register - register a kernel log dumper.
R
Randy Dunlap 已提交
2570
 * @dumper: pointer to the kmsg_dumper structure
2571 2572 2573 2574 2575 2576 2577 2578 2579 2580 2581 2582 2583 2584 2585 2586 2587 2588
 *
 * Adds a kernel log dumper to the system. The dump callback in the
 * structure will be called when the kernel oopses or panics and must be
 * set. Returns zero on success and %-EINVAL or %-EBUSY otherwise.
 */
int kmsg_dump_register(struct kmsg_dumper *dumper)
{
	unsigned long flags;
	int err = -EBUSY;

	/* The dump callback needs to be set */
	if (!dumper->dump)
		return -EINVAL;

	spin_lock_irqsave(&dump_list_lock, flags);
	/* Don't allow registering multiple times */
	if (!dumper->registered) {
		dumper->registered = 1;
2589
		list_add_tail_rcu(&dumper->list, &dump_list);
2590 2591 2592 2593 2594 2595 2596 2597 2598 2599
		err = 0;
	}
	spin_unlock_irqrestore(&dump_list_lock, flags);

	return err;
}
EXPORT_SYMBOL_GPL(kmsg_dump_register);

/**
 * kmsg_dump_unregister - unregister a kmsg dumper.
R
Randy Dunlap 已提交
2600
 * @dumper: pointer to the kmsg_dumper structure
2601 2602 2603 2604 2605 2606 2607 2608 2609 2610 2611 2612
 *
 * Removes a dump device from the system. Returns zero on success and
 * %-EINVAL otherwise.
 */
int kmsg_dump_unregister(struct kmsg_dumper *dumper)
{
	unsigned long flags;
	int err = -EINVAL;

	spin_lock_irqsave(&dump_list_lock, flags);
	if (dumper->registered) {
		dumper->registered = 0;
2613
		list_del_rcu(&dumper->list);
2614 2615 2616
		err = 0;
	}
	spin_unlock_irqrestore(&dump_list_lock, flags);
2617
	synchronize_rcu();
2618 2619 2620 2621 2622

	return err;
}
EXPORT_SYMBOL_GPL(kmsg_dump_unregister);

2623 2624 2625
static bool always_kmsg_dump;
module_param_named(always_kmsg_dump, always_kmsg_dump, bool, S_IRUGO | S_IWUSR);

2626 2627 2628 2629
/**
 * kmsg_dump - dump kernel log to kernel message dumpers.
 * @reason: the reason (oops, panic etc) for dumping
 *
2630 2631 2632
 * Call each of the registered dumper's dump() callback, which can
 * retrieve the kmsg records with kmsg_dump_get_line() or
 * kmsg_dump_get_buffer().
2633 2634 2635 2636 2637 2638
 */
void kmsg_dump(enum kmsg_dump_reason reason)
{
	struct kmsg_dumper *dumper;
	unsigned long flags;

2639 2640 2641
	if ((reason > KMSG_DUMP_OOPS) && !always_kmsg_dump)
		return;

2642 2643 2644 2645 2646 2647 2648 2649 2650 2651 2652 2653 2654 2655 2656 2657 2658 2659 2660 2661 2662 2663 2664 2665 2666
	rcu_read_lock();
	list_for_each_entry_rcu(dumper, &dump_list, list) {
		if (dumper->max_reason && reason > dumper->max_reason)
			continue;

		/* initialize iterator with data about the stored records */
		dumper->active = true;

		raw_spin_lock_irqsave(&logbuf_lock, flags);
		dumper->cur_seq = clear_seq;
		dumper->cur_idx = clear_idx;
		dumper->next_seq = log_next_seq;
		dumper->next_idx = log_next_idx;
		raw_spin_unlock_irqrestore(&logbuf_lock, flags);

		/* invoke dumper which will iterate over records */
		dumper->dump(dumper, reason);

		/* reset iterator */
		dumper->active = false;
	}
	rcu_read_unlock();
}

/**
2667
 * kmsg_dump_get_line_nolock - retrieve one kmsg log line (unlocked version)
2668 2669 2670 2671 2672 2673 2674 2675 2676 2677 2678 2679 2680 2681
 * @dumper: registered kmsg dumper
 * @syslog: include the "<4>" prefixes
 * @line: buffer to copy the line to
 * @size: maximum size of the buffer
 * @len: length of line placed into buffer
 *
 * Start at the beginning of the kmsg buffer, with the oldest kmsg
 * record, and copy one record into the provided buffer.
 *
 * Consecutive calls will return the next available record moving
 * towards the end of the buffer with the youngest messages.
 *
 * A return value of FALSE indicates that there are no more records to
 * read.
2682 2683
 *
 * The function is similar to kmsg_dump_get_line(), but grabs no locks.
2684
 */
2685 2686
bool kmsg_dump_get_line_nolock(struct kmsg_dumper *dumper, bool syslog,
			       char *line, size_t size, size_t *len)
2687
{
2688
	struct printk_log *msg;
2689 2690 2691 2692 2693
	size_t l = 0;
	bool ret = false;

	if (!dumper->active)
		goto out;
2694

2695 2696 2697 2698 2699
	if (dumper->cur_seq < log_first_seq) {
		/* messages are gone, move to first available one */
		dumper->cur_seq = log_first_seq;
		dumper->cur_idx = log_first_idx;
	}
2700

2701
	/* last entry */
2702
	if (dumper->cur_seq >= log_next_seq)
2703
		goto out;
2704

2705
	msg = log_from_idx(dumper->cur_idx);
2706
	l = msg_print_text(msg, 0, syslog, line, size);
2707 2708 2709 2710 2711 2712 2713 2714 2715

	dumper->cur_idx = log_next(dumper->cur_idx);
	dumper->cur_seq++;
	ret = true;
out:
	if (len)
		*len = l;
	return ret;
}
2716 2717 2718 2719 2720 2721 2722 2723 2724 2725 2726 2727 2728 2729 2730 2731 2732 2733 2734 2735 2736 2737 2738 2739 2740 2741 2742 2743 2744 2745

/**
 * kmsg_dump_get_line - retrieve one kmsg log line
 * @dumper: registered kmsg dumper
 * @syslog: include the "<4>" prefixes
 * @line: buffer to copy the line to
 * @size: maximum size of the buffer
 * @len: length of line placed into buffer
 *
 * Start at the beginning of the kmsg buffer, with the oldest kmsg
 * record, and copy one record into the provided buffer.
 *
 * Consecutive calls will return the next available record moving
 * towards the end of the buffer with the youngest messages.
 *
 * A return value of FALSE indicates that there are no more records to
 * read.
 */
bool kmsg_dump_get_line(struct kmsg_dumper *dumper, bool syslog,
			char *line, size_t size, size_t *len)
{
	unsigned long flags;
	bool ret;

	raw_spin_lock_irqsave(&logbuf_lock, flags);
	ret = kmsg_dump_get_line_nolock(dumper, syslog, line, size, len);
	raw_spin_unlock_irqrestore(&logbuf_lock, flags);

	return ret;
}
2746 2747 2748 2749 2750 2751
EXPORT_SYMBOL_GPL(kmsg_dump_get_line);

/**
 * kmsg_dump_get_buffer - copy kmsg log lines
 * @dumper: registered kmsg dumper
 * @syslog: include the "<4>" prefixes
R
Randy Dunlap 已提交
2752
 * @buf: buffer to copy the line to
2753 2754 2755 2756 2757 2758 2759 2760 2761 2762 2763 2764 2765 2766 2767 2768 2769 2770 2771 2772 2773 2774
 * @size: maximum size of the buffer
 * @len: length of line placed into buffer
 *
 * Start at the end of the kmsg buffer and fill the provided buffer
 * with as many of the the *youngest* kmsg records that fit into it.
 * If the buffer is large enough, all available kmsg records will be
 * copied with a single call.
 *
 * Consecutive calls will fill the buffer with the next block of
 * available older records, not including the earlier retrieved ones.
 *
 * A return value of FALSE indicates that there are no more records to
 * read.
 */
bool kmsg_dump_get_buffer(struct kmsg_dumper *dumper, bool syslog,
			  char *buf, size_t size, size_t *len)
{
	unsigned long flags;
	u64 seq;
	u32 idx;
	u64 next_seq;
	u32 next_idx;
2775
	enum log_flags prev;
2776 2777 2778 2779 2780 2781 2782 2783 2784 2785 2786 2787 2788 2789 2790 2791 2792 2793 2794 2795 2796 2797
	size_t l = 0;
	bool ret = false;

	if (!dumper->active)
		goto out;

	raw_spin_lock_irqsave(&logbuf_lock, flags);
	if (dumper->cur_seq < log_first_seq) {
		/* messages are gone, move to first available one */
		dumper->cur_seq = log_first_seq;
		dumper->cur_idx = log_first_idx;
	}

	/* last entry */
	if (dumper->cur_seq >= dumper->next_seq) {
		raw_spin_unlock_irqrestore(&logbuf_lock, flags);
		goto out;
	}

	/* calculate length of entire buffer */
	seq = dumper->cur_seq;
	idx = dumper->cur_idx;
2798
	prev = 0;
2799
	while (seq < dumper->next_seq) {
2800
		struct printk_log *msg = log_from_idx(idx);
2801

2802
		l += msg_print_text(msg, prev, true, NULL, 0);
2803 2804
		idx = log_next(idx);
		seq++;
2805
		prev = msg->flags;
2806 2807 2808 2809 2810
	}

	/* move first record forward until length fits into the buffer */
	seq = dumper->cur_seq;
	idx = dumper->cur_idx;
2811
	prev = 0;
2812
	while (l > size && seq < dumper->next_seq) {
2813
		struct printk_log *msg = log_from_idx(idx);
2814

2815
		l -= msg_print_text(msg, prev, true, NULL, 0);
2816 2817
		idx = log_next(idx);
		seq++;
2818
		prev = msg->flags;
2819
	}
2820 2821 2822 2823 2824 2825 2826

	/* last message in next interation */
	next_seq = seq;
	next_idx = idx;

	l = 0;
	while (seq < dumper->next_seq) {
2827
		struct printk_log *msg = log_from_idx(idx);
2828

2829
		l += msg_print_text(msg, prev, syslog, buf + l, size - l);
2830 2831
		idx = log_next(idx);
		seq++;
2832
		prev = msg->flags;
2833 2834 2835 2836 2837
	}

	dumper->next_seq = next_seq;
	dumper->next_idx = next_idx;
	ret = true;
2838
	raw_spin_unlock_irqrestore(&logbuf_lock, flags);
2839 2840 2841 2842 2843 2844
out:
	if (len)
		*len = l;
	return ret;
}
EXPORT_SYMBOL_GPL(kmsg_dump_get_buffer);
2845

2846 2847 2848 2849 2850 2851 2852 2853 2854 2855 2856 2857 2858 2859 2860 2861 2862 2863
/**
 * kmsg_dump_rewind_nolock - reset the interator (unlocked version)
 * @dumper: registered kmsg dumper
 *
 * Reset the dumper's iterator so that kmsg_dump_get_line() and
 * kmsg_dump_get_buffer() can be called again and used multiple
 * times within the same dumper.dump() callback.
 *
 * The function is similar to kmsg_dump_rewind(), but grabs no locks.
 */
void kmsg_dump_rewind_nolock(struct kmsg_dumper *dumper)
{
	dumper->cur_seq = clear_seq;
	dumper->cur_idx = clear_idx;
	dumper->next_seq = log_next_seq;
	dumper->next_idx = log_next_idx;
}

2864 2865 2866 2867 2868 2869 2870 2871 2872 2873 2874 2875 2876
/**
 * kmsg_dump_rewind - reset the interator
 * @dumper: registered kmsg dumper
 *
 * Reset the dumper's iterator so that kmsg_dump_get_line() and
 * kmsg_dump_get_buffer() can be called again and used multiple
 * times within the same dumper.dump() callback.
 */
void kmsg_dump_rewind(struct kmsg_dumper *dumper)
{
	unsigned long flags;

	raw_spin_lock_irqsave(&logbuf_lock, flags);
2877
	kmsg_dump_rewind_nolock(dumper);
2878
	raw_spin_unlock_irqrestore(&logbuf_lock, flags);
2879
}
2880
EXPORT_SYMBOL_GPL(kmsg_dump_rewind);
2881

2882 2883 2884 2885 2886 2887 2888 2889 2890 2891 2892 2893 2894 2895 2896 2897 2898 2899 2900 2901 2902 2903
static char dump_stack_arch_desc_str[128];

/**
 * dump_stack_set_arch_desc - set arch-specific str to show with task dumps
 * @fmt: printf-style format string
 * @...: arguments for the format string
 *
 * The configured string will be printed right after utsname during task
 * dumps.  Usually used to add arch-specific system identifiers.  If an
 * arch wants to make use of such an ID string, it should initialize this
 * as soon as possible during boot.
 */
void __init dump_stack_set_arch_desc(const char *fmt, ...)
{
	va_list args;

	va_start(args, fmt);
	vsnprintf(dump_stack_arch_desc_str, sizeof(dump_stack_arch_desc_str),
		  fmt, args);
	va_end(args);
}

2904 2905 2906 2907 2908 2909 2910 2911 2912 2913 2914 2915 2916 2917
/**
 * dump_stack_print_info - print generic debug info for dump_stack()
 * @log_lvl: log level
 *
 * Arch-specific dump_stack() implementations can use this function to
 * print out the same debug information as the generic dump_stack().
 */
void dump_stack_print_info(const char *log_lvl)
{
	printk("%sCPU: %d PID: %d Comm: %.20s %s %s %.*s\n",
	       log_lvl, raw_smp_processor_id(), current->pid, current->comm,
	       print_tainted(), init_utsname()->release,
	       (int)strcspn(init_utsname()->version, " "),
	       init_utsname()->version);
2918 2919 2920 2921

	if (dump_stack_arch_desc_str[0] != '\0')
		printk("%sHardware name: %s\n",
		       log_lvl, dump_stack_arch_desc_str);
2922 2923

	print_worker_info(log_lvl, current);
2924 2925
}

2926 2927 2928 2929 2930 2931 2932 2933 2934 2935 2936 2937 2938 2939 2940 2941
/**
 * show_regs_print_info - print generic debug info for show_regs()
 * @log_lvl: log level
 *
 * show_regs() implementations can use this function to print out generic
 * debug information.
 */
void show_regs_print_info(const char *log_lvl)
{
	dump_stack_print_info(log_lvl);

	printk("%stask: %p ti: %p task.ti: %p\n",
	       log_lvl, current, current_thread_info(),
	       task_thread_info(current));
}

2942
#endif