blob: 363a493bded82981d9345aa34bd16bdc254ae67a [file] [log] [blame]
Thomas Gleixner457c8992019-05-19 13:08:55 +01001// SPDX-License-Identifier: GPL-2.0-only
Linus Torvalds1da177e2005-04-16 15:20:36 -07002/*
3 * linux/kernel/printk.c
4 *
5 * Copyright (C) 1991, 1992 Linus Torvalds
6 *
7 * Modified to make sys_syslog() more flexible: added commands to
8 * return the last 4k of kernel messages, regardless of whether
9 * they've been read or not. Added option to suppress kernel printk's
10 * to the console. Added hook for sending the console messages
11 * elsewhere, in preparation for a serial line console (someday).
12 * Ted Ts'o, 2/11/93.
13 * Modified for sysctl support, 1/8/97, Chris Horn.
Jesper Juhl40dc5652005-10-30 15:02:46 -080014 * Fixed SMP synchronization, 08/08/99, Manfred Spraul
Christian Kujau624dffc2006-01-15 02:43:54 +010015 * manfred@colorfullife.com
Linus Torvalds1da177e2005-04-16 15:20:36 -070016 * Rewrote bits to get rid of console_lock
Francois Camie1f8e872008-10-15 22:01:59 -070017 * 01Mar01 Andrew Morton
Linus Torvalds1da177e2005-04-16 15:20:36 -070018 */
19
He Zhedd5adbf2018-09-30 00:45:52 +080020#define pr_fmt(fmt) KBUILD_MODNAME ": " fmt
21
Linus Torvalds1da177e2005-04-16 15:20:36 -070022#include <linux/kernel.h>
23#include <linux/mm.h>
24#include <linux/tty.h>
25#include <linux/tty_driver.h>
Linus Torvalds1da177e2005-04-16 15:20:36 -070026#include <linux/console.h>
27#include <linux/init.h>
Randy Dunlapbfe8df32007-10-16 01:23:46 -070028#include <linux/jiffies.h>
29#include <linux/nmi.h>
Linus Torvalds1da177e2005-04-16 15:20:36 -070030#include <linux/module.h>
Jan Engelhardt3b9c0412006-06-25 05:48:15 -070031#include <linux/moduleparam.h>
Linus Torvalds1da177e2005-04-16 15:20:36 -070032#include <linux/delay.h>
33#include <linux/smp.h>
34#include <linux/security.h>
Mike Travis162a7e72011-05-24 17:13:20 -070035#include <linux/memblock.h>
Linus Torvalds1da177e2005-04-16 15:20:36 -070036#include <linux/syscalls.h>
Hari Bathini692f66f2017-05-08 15:56:18 -070037#include <linux/crash_core.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>
Huang Yingfb842b002011-01-12 16:59:43 -080042#include <linux/rculist.h>
Kay Sieverse11fea92012-05-03 02:29:41 +020043#include <linux/poll.h>
Frederic Weisbecker74876a92012-10-12 18:00:23 +020044#include <linux/irq_work.h>
Alex Elder249771b2014-08-06 16:09:08 -070045#include <linux/ctype.h>
Christoph Hellwige2e40f22015-02-22 08:58:50 -080046#include <linux/uio.h>
Ingo Molnare6017572017-02-01 16:36:40 +010047#include <linux/sched/clock.h>
Ingo Molnarb17b0152017-02-08 18:51:35 +010048#include <linux/sched/debug.h>
Ingo Molnar68db0cf2017-02-08 18:51:37 +010049#include <linux/sched/task_stack.h>
Linus Torvalds1da177e2005-04-16 15:20:36 -070050
Linus Torvalds7c0f6ba2016-12-24 11:46:01 -080051#include <linux/uaccess.h>
Christoph Hellwig40a7d9f2016-08-02 14:03:59 -070052#include <asm/sections.h>
Linus Torvalds1da177e2005-04-16 15:20:36 -070053
Abderrahmane Benbachir58eacff2018-03-22 20:33:28 -040054#include <trace/events/initcall.h>
Johannes Berg95100352011-11-24 20:03:08 +010055#define CREATE_TRACE_POINTS
56#include <trace/events/printk.h>
57
John Ogness896fbe22020-07-09 15:29:44 +020658#include "printk_ringbuffer.h"
Joe Perchesd197c432013-07-31 13:53:44 -070059#include "console_cmdline.h"
Joe Perchesbbeddf52013-07-31 13:53:45 -070060#include "braille.h"
Petr Mladek42a0bb32016-05-20 17:00:33 -070061#include "internal.h"
Joe Perchesd197c432013-07-31 13:53:44 -070062
Linus Torvalds1da177e2005-04-16 15:20:36 -070063int console_printk[4] = {
Borislav Petkova8fe19e2014-06-04 16:11:46 -070064 CONSOLE_LOGLEVEL_DEFAULT, /* console_loglevel */
Alex Elder42a9dc02014-08-06 16:09:01 -070065 MESSAGE_LOGLEVEL_DEFAULT, /* default_message_loglevel */
Borislav Petkova8fe19e2014-06-04 16:11:46 -070066 CONSOLE_LOGLEVEL_MIN, /* minimum_console_loglevel */
67 CONSOLE_LOGLEVEL_DEFAULT, /* default_console_loglevel */
Linus Torvalds1da177e2005-04-16 15:20:36 -070068};
Prarit Bhargavaa1939182019-02-08 19:24:49 +010069EXPORT_SYMBOL_GPL(console_printk);
Linus Torvalds1da177e2005-04-16 15:20:36 -070070
Thomas Zimmermann56e6c102018-07-31 13:06:57 +020071atomic_t ignore_console_lock_warning __read_mostly = ATOMIC_INIT(0);
72EXPORT_SYMBOL(ignore_console_lock_warning);
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
Feng Tangc39ea0b2019-05-14 15:45:34 -070090/*
91 * System may need to suppress printk message under certain
92 * circumstances, like after kernel panic happens.
93 */
94int __read_mostly suppress_printk;
95
Daniel Vetterdaee7792012-09-22 19:52:11 +020096#ifdef CONFIG_LOCKDEP
97static struct lockdep_map console_lock_dep_map = {
98 .name = "console_lock"
99};
100#endif
101
Borislav Petkov750afe72016-08-02 14:04:07 -0700102enum devkmsg_log_bits {
103 __DEVKMSG_LOG_BIT_ON = 0,
104 __DEVKMSG_LOG_BIT_OFF,
105 __DEVKMSG_LOG_BIT_LOCK,
106};
107
108enum devkmsg_log_masks {
109 DEVKMSG_LOG_MASK_ON = BIT(__DEVKMSG_LOG_BIT_ON),
110 DEVKMSG_LOG_MASK_OFF = BIT(__DEVKMSG_LOG_BIT_OFF),
111 DEVKMSG_LOG_MASK_LOCK = BIT(__DEVKMSG_LOG_BIT_LOCK),
112};
113
114/* Keep both the 'on' and 'off' bits clear, i.e. ratelimit by default: */
115#define DEVKMSG_LOG_MASK_DEFAULT 0
116
117static unsigned int __read_mostly devkmsg_log = DEVKMSG_LOG_MASK_DEFAULT;
118
119static int __control_devkmsg(char *str)
120{
Chuhong Yuan35c35492019-08-09 15:10:34 +0800121 size_t len;
122
Borislav Petkov750afe72016-08-02 14:04:07 -0700123 if (!str)
124 return -EINVAL;
125
Chuhong Yuan35c35492019-08-09 15:10:34 +0800126 len = str_has_prefix(str, "on");
127 if (len) {
Borislav Petkov750afe72016-08-02 14:04:07 -0700128 devkmsg_log = DEVKMSG_LOG_MASK_ON;
Chuhong Yuan35c35492019-08-09 15:10:34 +0800129 return len;
Borislav Petkov750afe72016-08-02 14:04:07 -0700130 }
Chuhong Yuan35c35492019-08-09 15:10:34 +0800131
132 len = str_has_prefix(str, "off");
133 if (len) {
134 devkmsg_log = DEVKMSG_LOG_MASK_OFF;
135 return len;
136 }
137
138 len = str_has_prefix(str, "ratelimit");
139 if (len) {
140 devkmsg_log = DEVKMSG_LOG_MASK_DEFAULT;
141 return len;
142 }
143
Borislav Petkov750afe72016-08-02 14:04:07 -0700144 return -EINVAL;
145}
146
147static int __init control_devkmsg(char *str)
148{
149 if (__control_devkmsg(str) < 0)
150 return 1;
151
152 /*
153 * Set sysctl string accordingly:
154 */
Sergey Senozhatsky6fd78a12018-01-19 13:39:01 +0900155 if (devkmsg_log == DEVKMSG_LOG_MASK_ON)
156 strcpy(devkmsg_log_str, "on");
157 else if (devkmsg_log == DEVKMSG_LOG_MASK_OFF)
158 strcpy(devkmsg_log_str, "off");
Borislav Petkov750afe72016-08-02 14:04:07 -0700159 /* else "ratelimit" which is set by default. */
160
161 /*
162 * Sysctl cannot change it anymore. The kernel command line setting of
163 * this parameter is to force the setting to be permanent throughout the
164 * runtime of the system. This is a precation measure against userspace
165 * trying to be a smarta** and attempting to change it up on us.
166 */
167 devkmsg_log |= DEVKMSG_LOG_MASK_LOCK;
168
169 return 0;
170}
171__setup("printk.devkmsg=", control_devkmsg);
172
173char devkmsg_log_str[DEVKMSG_STR_MAX_SIZE] = "ratelimit";
174
175int devkmsg_sysctl_set_loglvl(struct ctl_table *table, int write,
Christoph Hellwig32927392020-04-24 08:43:38 +0200176 void *buffer, size_t *lenp, loff_t *ppos)
Borislav Petkov750afe72016-08-02 14:04:07 -0700177{
178 char old_str[DEVKMSG_STR_MAX_SIZE];
179 unsigned int old;
180 int err;
181
182 if (write) {
183 if (devkmsg_log & DEVKMSG_LOG_MASK_LOCK)
184 return -EINVAL;
185
186 old = devkmsg_log;
187 strncpy(old_str, devkmsg_log_str, DEVKMSG_STR_MAX_SIZE);
188 }
189
190 err = proc_dostring(table, write, buffer, lenp, ppos);
191 if (err)
192 return err;
193
194 if (write) {
195 err = __control_devkmsg(devkmsg_log_str);
196
197 /*
198 * Do not accept an unknown string OR a known string with
199 * trailing crap...
200 */
201 if (err < 0 || (err + 1 != *lenp)) {
202
203 /* ... and restore old setting. */
204 devkmsg_log = old;
205 strncpy(devkmsg_log_str, old_str, DEVKMSG_STR_MAX_SIZE);
206
207 return -EINVAL;
208 }
209 }
210
211 return 0;
212}
213
Sergey Senozhatsky96278082018-10-02 11:38:34 +0900214/* Number of registered extended console drivers. */
Tejun Heo6fe29352015-06-25 15:01:30 -0700215static int nr_ext_console_drivers;
216
217/*
Jan Karabd8d7cf2014-06-04 16:11:36 -0700218 * Helper macros to handle lockdep when locking/unlocking console_sem. We use
219 * macros instead of functions so that _RET_IP_ contains useful information.
220 */
221#define down_console_sem() do { \
222 down(&console_sem);\
223 mutex_acquire(&console_lock_dep_map, 0, 0, _RET_IP_);\
224} while (0)
225
226static int __down_trylock_console_sem(unsigned long ip)
227{
Sergey Senozhatskyf9752372016-12-27 23:16:09 +0900228 int lock_failed;
229 unsigned long flags;
230
231 /*
232 * Here and in __up_console_sem() we need to be in safe mode,
233 * because spindump/WARN/etc from under console ->lock will
234 * deadlock in printk()->down_trylock_console_sem() otherwise.
235 */
236 printk_safe_enter_irqsave(flags);
237 lock_failed = down_trylock(&console_sem);
238 printk_safe_exit_irqrestore(flags);
239
240 if (lock_failed)
Jan Karabd8d7cf2014-06-04 16:11:36 -0700241 return 1;
242 mutex_acquire(&console_lock_dep_map, 0, 1, ip);
243 return 0;
244}
245#define down_trylock_console_sem() __down_trylock_console_sem(_RET_IP_)
246
Sergey Senozhatskyf9752372016-12-27 23:16:09 +0900247static void __up_console_sem(unsigned long ip)
248{
249 unsigned long flags;
250
Qian Cai5facae42019-09-19 12:09:40 -0400251 mutex_release(&console_lock_dep_map, ip);
Sergey Senozhatskyf9752372016-12-27 23:16:09 +0900252
253 printk_safe_enter_irqsave(flags);
254 up(&console_sem);
255 printk_safe_exit_irqrestore(flags);
256}
257#define up_console_sem() __up_console_sem(_RET_IP_)
Jan Karabd8d7cf2014-06-04 16:11:36 -0700258
259/*
Linus Torvalds1da177e2005-04-16 15:20:36 -0700260 * This is used for debugging the mess that is the VT code by
261 * keeping track if we have the console semaphore held. It's
262 * definitely not the perfect debug tool (we don't know if _WE_
Alex Elder0b90fec2014-08-06 16:09:03 -0700263 * hold it and are racing, but it helps tracking those weird code
264 * paths in the console code where we end up in places I want
Bhaskar Chowdhuryacebb552021-03-28 10:09:32 +0530265 * locked without the console semaphore held).
Linus Torvalds1da177e2005-04-16 15:20:36 -0700266 */
Linus Torvalds557240b2006-06-19 18:16:01 -0700267static int console_locked, console_suspended;
Linus Torvalds1da177e2005-04-16 15:20:36 -0700268
269/*
Feng Tangfe3d8ad2011-03-22 16:34:21 -0700270 * If exclusive_console is non-NULL then only this console is to be printed to.
271 */
272static struct console *exclusive_console;
273
274/*
Linus Torvalds1da177e2005-04-16 15:20:36 -0700275 * Array of consoles built from command line options (console=)
276 */
Linus Torvalds1da177e2005-04-16 15:20:36 -0700277
278#define MAX_CMDLINECONSOLES 8
279
280static struct console_cmdline console_cmdline[MAX_CMDLINECONSOLES];
Joe Perchesd197c432013-07-31 13:53:44 -0700281
Linus Torvalds1da177e2005-04-16 15:20:36 -0700282static int preferred_console = -1;
Markus Armbruster9e124fe2008-05-26 23:31:07 +0100283int console_set_on_cmdline;
284EXPORT_SYMBOL(console_set_on_cmdline);
Linus Torvalds1da177e2005-04-16 15:20:36 -0700285
286/* Flag: console code may call schedule() */
287static int console_may_schedule;
288
Sergey Senozhatskycca10d52017-12-21 14:41:49 +0900289enum con_msg_format_flags {
290 MSG_FORMAT_DEFAULT = 0,
291 MSG_FORMAT_SYSLOG = (1 << 0),
292};
293
294static int console_msg_format = MSG_FORMAT_DEFAULT;
295
Kay Sievers7ff95542012-05-03 02:29:13 +0200296/*
John Ogness896fbe22020-07-09 15:29:44 +0206297 * The printk log buffer consists of a sequenced collection of records, each
John Ogness74caba72020-09-21 13:24:45 +0206298 * containing variable length message text. Every record also contains its
299 * own meta-data (@info).
Kay Sievers7ff95542012-05-03 02:29:13 +0200300 *
John Ogness896fbe22020-07-09 15:29:44 +0206301 * Every record meta-data carries the timestamp in microseconds, as well as
302 * the standard userspace syslog level and syslog facility. The usual kernel
303 * messages use LOG_KERN; userspace-injected messages always carry a matching
304 * syslog facility, by default LOG_USER. The origin of every message can be
305 * reliably determined that way.
Kay Sievers7ff95542012-05-03 02:29:13 +0200306 *
John Ogness896fbe22020-07-09 15:29:44 +0206307 * The human readable log message of a record is available in @text, the
308 * length of the message text in @text_len. The stored message is not
309 * terminated.
Kay Sievers7ff95542012-05-03 02:29:13 +0200310 *
John Ogness896fbe22020-07-09 15:29:44 +0206311 * Optionally, a record can carry a dictionary of properties (key/value
John Ogness74caba72020-09-21 13:24:45 +0206312 * pairs), to provide userspace with a machine-readable message context.
Kay Sieverse11fea92012-05-03 02:29:41 +0200313 *
314 * Examples for well-defined, commonly used property names are:
315 * DEVICE=b12:8 device identifier
316 * b12:8 block dev_t
317 * c127:3 char dev_t
318 * n8 netdev ifindex
319 * +sound:card0 subsystem:devname
320 * SUBSYSTEM=pci driver-core subsystem name
321 *
John Ogness74caba72020-09-21 13:24:45 +0206322 * Valid characters in property names are [a-zA-Z0-9.-_]. Property names
323 * and values are terminated by a '\0' character.
Kay Sieverse11fea92012-05-03 02:29:41 +0200324 *
John Ogness896fbe22020-07-09 15:29:44 +0206325 * Example of record values:
John Ogness74caba72020-09-21 13:24:45 +0206326 * record.text_buf = "it's a line" (unterminated)
327 * record.info.seq = 56
328 * record.info.ts_nsec = 36863
329 * record.info.text_len = 11
330 * record.info.facility = 0 (LOG_KERN)
331 * record.info.flags = 0
332 * record.info.level = 3 (LOG_ERR)
333 * record.info.caller_id = 299 (task 299)
334 * record.info.dev_info.subsystem = "pci" (terminated)
335 * record.info.dev_info.device = "+pci:0000:00:01.0" (terminated)
Kay Sieverse11fea92012-05-03 02:29:41 +0200336 *
John Ogness896fbe22020-07-09 15:29:44 +0206337 * The 'struct printk_info' buffer must never be directly exported to
Kay Sieverse11fea92012-05-03 02:29:41 +0200338 * userspace, it is a kernel-private implementation detail that might
339 * need to be changed in the future, when the requirements change.
340 *
341 * /dev/kmsg exports the structured data in the following line format:
Antonio Ospiteb3896452015-06-30 14:59:03 -0700342 * "<level>,<sequnum>,<timestamp>,<contflag>[,additional_values, ... ];<message text>\n"
343 *
344 * Users of the export format should ignore possible additional values
345 * separated by ',', and find the message after the ';' character.
Kay Sieverse11fea92012-05-03 02:29:41 +0200346 *
347 * The optional key/value pairs are attached as continuation lines starting
348 * with a space character and terminated by a newline. All possible
349 * non-prinatable characters are escaped in the "\xff" notation.
Kay Sievers7ff95542012-05-03 02:29:13 +0200350 */
Matt Mackalld59745c2005-05-01 08:59:02 -0700351
John Ogness636babd2021-03-03 11:15:23 +0100352/* syslog_lock protects syslog_* variables and write access to clear_seq. */
John Ognessb371cbb2021-07-15 21:39:58 +0206353static DEFINE_MUTEX(syslog_lock);
John Ogness636babd2021-03-03 11:15:23 +0100354
Kay Sievers96efedf2012-07-16 18:35:29 -0700355#ifdef CONFIG_PRINTK
Frederic Weisbeckerdc72c322013-03-22 15:04:39 -0700356DECLARE_WAIT_QUEUE_HEAD(log_wait);
John Ogness636babd2021-03-03 11:15:23 +0100357/* All 3 protected by @syslog_lock. */
Kay Sievers7f3a7812012-05-09 01:37:51 +0200358/* the next printk record to read by syslog(READ) or /proc/kmsg */
359static u64 syslog_seq;
Kay Sieverseb02dac2012-07-09 10:05:10 -0700360static size_t syslog_partial;
Tetsuo Handae80c1a92018-12-04 19:00:01 +0900361static bool syslog_time;
Kay Sievers7f3a7812012-05-09 01:37:51 +0200362
John Ogness996e9662021-03-03 11:15:26 +0100363/* All 3 protected by @console_sem. */
Kay Sieverseab07262012-07-16 18:35:30 -0700364/* the next printk record to write to the console */
365static u64 console_seq;
Petr Mladekf92b0702018-09-13 14:34:06 +0200366static u64 exclusive_console_stop_seq;
John Ogness896fbe22020-07-09 15:29:44 +0206367static unsigned long console_dropped;
Kay Sieverseab07262012-07-16 18:35:30 -0700368
John Ogness7d7a23a2021-03-03 11:15:21 +0100369struct latched_seq {
370 seqcount_latch_t latch;
371 u64 val[2];
372};
373
374/*
375 * The next printk record to read after the last 'clear' command. There are
376 * two copies (updated with seqcount_latch) so that reads can locklessly
John Ogness636babd2021-03-03 11:15:23 +0100377 * access a valid value. Writers are synchronized by @syslog_lock.
John Ogness7d7a23a2021-03-03 11:15:21 +0100378 */
379static struct latched_seq clear_seq = {
380 .latch = SEQCNT_LATCH_ZERO(clear_seq.latch),
381 .val[0] = 0,
382 .val[1] = 0,
383};
Kay Sievers7ff95542012-05-03 02:29:13 +0200384
Tetsuo Handa15ff2062018-12-18 06:05:04 +0900385#ifdef CONFIG_PRINTK_CALLER
386#define PREFIX_MAX 48
387#else
Kay Sievers70498252012-07-16 18:35:29 -0700388#define PREFIX_MAX 32
Tetsuo Handa15ff2062018-12-18 06:05:04 +0900389#endif
John Ognesscf5b0202021-03-03 11:15:20 +0100390
391/* the maximum size of a formatted record (i.e. with prefix added per line) */
392#define CONSOLE_LOG_MAX 1024
393
394/* the maximum size allowed to be reserved for a record */
395#define LOG_LINE_MAX (CONSOLE_LOG_MAX - PREFIX_MAX)
Kay Sievers7ff95542012-05-03 02:29:13 +0200396
Mathias Krause38246572015-11-06 16:30:38 -0800397#define LOG_LEVEL(v) ((v) & 0x07)
398#define LOG_FACILITY(v) ((v) >> 3 & 0xff)
399
Kay Sievers7ff95542012-05-03 02:29:13 +0200400/* record buffer */
John Ogness896fbe22020-07-09 15:29:44 +0206401#define LOG_ALIGN __alignof__(unsigned long)
Kay Sievers7ff95542012-05-03 02:29:13 +0200402#define __LOG_BUF_LEN (1 << CONFIG_LOG_BUF_SHIFT)
He Zhee6fe3e52018-09-30 00:45:53 +0800403#define LOG_BUF_LEN_MAX (u32)(1 << 31)
Stephen Warrenf8450fc2012-05-10 16:14:33 -0600404static char __log_buf[__LOG_BUF_LEN] __aligned(LOG_ALIGN);
Matt Mackalld59745c2005-05-01 08:59:02 -0700405static char *log_buf = __log_buf;
Kay Sievers7ff95542012-05-03 02:29:13 +0200406static u32 log_buf_len = __LOG_BUF_LEN;
407
Sergey Senozhatskyab6f7622020-03-03 20:30:02 +0900408/*
John Ogness896fbe22020-07-09 15:29:44 +0206409 * Define the average message size. This only affects the number of
410 * descriptors that will be available. Underestimating is better than
411 * overestimating (too many available descriptors is better than not enough).
John Ogness896fbe22020-07-09 15:29:44 +0206412 */
413#define PRB_AVGBITS 5 /* 32 character average length */
414
415#if CONFIG_LOG_BUF_SHIFT <= PRB_AVGBITS
416#error CONFIG_LOG_BUF_SHIFT value too small.
417#endif
418_DEFINE_PRINTKRB(printk_rb_static, CONFIG_LOG_BUF_SHIFT - PRB_AVGBITS,
John Ognessf35efc72020-09-19 00:40:21 +0206419 PRB_AVGBITS, &__log_buf[0]);
John Ogness896fbe22020-07-09 15:29:44 +0206420
421static struct printk_ringbuffer printk_rb_dynamic;
422
423static struct printk_ringbuffer *prb = &printk_rb_static;
424
425/*
Sergey Senozhatskyab6f7622020-03-03 20:30:02 +0900426 * We cannot access per-CPU data (e.g. per-CPU flush irq_work) before
427 * per_cpu_areas are initialised. This variable is set to true when
428 * it's safe to access per-CPU data.
429 */
430static bool __printk_percpu_data_ready __read_mostly;
431
432bool printk_percpu_data_ready(void)
433{
434 return __printk_percpu_data_ready;
435}
436
John Ogness636babd2021-03-03 11:15:23 +0100437/* Must be called under syslog_lock. */
John Ogness7d7a23a2021-03-03 11:15:21 +0100438static void latched_seq_write(struct latched_seq *ls, u64 val)
439{
440 raw_write_seqcount_latch(&ls->latch);
441 ls->val[0] = val;
442 raw_write_seqcount_latch(&ls->latch);
443 ls->val[1] = val;
444}
445
446/* Can be called from any context. */
447static u64 latched_seq_read_nolock(struct latched_seq *ls)
448{
449 unsigned int seq;
450 unsigned int idx;
451 u64 val;
452
453 do {
454 seq = raw_read_seqcount_latch(&ls->latch);
455 idx = seq & 0x1;
456 val = ls->val[idx];
457 } while (read_seqcount_latch_retry(&ls->latch, seq));
458
459 return val;
460}
461
Vasant Hegde14c40002014-08-09 11:15:30 +0530462/* Return log buffer address */
463char *log_buf_addr_get(void)
464{
465 return log_buf;
466}
467
468/* Return log buffer size */
469u32 log_buf_len_get(void)
470{
471 return log_buf_len;
472}
473
Petr Mladek55bd53a2014-06-04 16:11:32 -0700474/*
475 * Define how much of the log buffer we could take at maximum. The value
476 * must be greater than two. Note that only half of the buffer is available
477 * when the index points to the middle.
478 */
479#define MAX_LOG_TAKE_PART 4
480static const char trunc_msg[] = "<truncated>";
481
John Ogness896fbe22020-07-09 15:29:44 +0206482static void truncate_msg(u16 *text_len, u16 *trunc_msg_len)
Petr Mladek55bd53a2014-06-04 16:11:32 -0700483{
484 /*
485 * The message should not take the whole buffer. Otherwise, it might
486 * get removed too soon.
487 */
488 u32 max_text_len = log_buf_len / MAX_LOG_TAKE_PART;
John Ogness896fbe22020-07-09 15:29:44 +0206489
Petr Mladek55bd53a2014-06-04 16:11:32 -0700490 if (*text_len > max_text_len)
491 *text_len = max_text_len;
John Ogness896fbe22020-07-09 15:29:44 +0206492
493 /* enable the warning message (if there is room) */
Petr Mladek55bd53a2014-06-04 16:11:32 -0700494 *trunc_msg_len = strlen(trunc_msg);
John Ogness896fbe22020-07-09 15:29:44 +0206495 if (*text_len >= *trunc_msg_len)
496 *text_len -= *trunc_msg_len;
497 else
498 *trunc_msg_len = 0;
Petr Mladek55bd53a2014-06-04 16:11:32 -0700499}
500
Alex Eldere99aa462014-08-06 16:09:05 -0700501int dmesg_restrict = IS_ENABLED(CONFIG_SECURITY_DMESG_RESTRICT);
Kees Cook637241a2013-06-12 14:04:39 -0700502
503static int syslog_action_restricted(int type)
504{
505 if (dmesg_restrict)
506 return 1;
507 /*
508 * Unless restricted, we allow "read all" and "get buffer size"
509 * for everybody.
510 */
511 return type != SYSLOG_ACTION_READ_ALL &&
512 type != SYSLOG_ACTION_SIZE_BUFFER;
513}
514
Kees Cookc71b02e2017-08-09 21:11:00 -0700515static int check_syslog_permissions(int type, int source)
Kees Cook637241a2013-06-12 14:04:39 -0700516{
517 /*
518 * If this is from /proc/kmsg and we've already opened it, then we've
519 * already done the capabilities checks at open time.
520 */
Vasily Averin3ea43312015-06-25 15:01:47 -0700521 if (source == SYSLOG_FROM_PROC && type != SYSLOG_ACTION_OPEN)
Vasily Averind194e5d2015-06-25 15:01:44 -0700522 goto ok;
Kees Cook637241a2013-06-12 14:04:39 -0700523
524 if (syslog_action_restricted(type)) {
525 if (capable(CAP_SYSLOG))
Vasily Averind194e5d2015-06-25 15:01:44 -0700526 goto ok;
Kees Cook637241a2013-06-12 14:04:39 -0700527 /*
528 * For historical reasons, accept CAP_SYS_ADMIN too, with
529 * a warning.
530 */
531 if (capable(CAP_SYS_ADMIN)) {
532 pr_warn_once("%s (%d): Attempt to access syslog with "
533 "CAP_SYS_ADMIN but no CAP_SYSLOG "
534 "(deprecated).\n",
535 current->comm, task_pid_nr(current));
Vasily Averind194e5d2015-06-25 15:01:44 -0700536 goto ok;
Kees Cook637241a2013-06-12 14:04:39 -0700537 }
538 return -EPERM;
539 }
Vasily Averind194e5d2015-06-25 15:01:44 -0700540ok:
Kees Cook637241a2013-06-12 14:04:39 -0700541 return security_syslog(type);
542}
543
Tejun Heod43ff432015-06-25 15:01:24 -0700544static void append_char(char **pp, char *e, char c)
545{
546 if (*pp < e)
547 *(*pp)++ = c;
548}
Kees Cook637241a2013-06-12 14:04:39 -0700549
John Ogness896fbe22020-07-09 15:29:44 +0206550static ssize_t info_print_ext_header(char *buf, size_t size,
551 struct printk_info *info)
Tejun Heo0a295e672015-06-25 15:01:27 -0700552{
John Ogness896fbe22020-07-09 15:29:44 +0206553 u64 ts_usec = info->ts_nsec;
Tetsuo Handa15ff2062018-12-18 06:05:04 +0900554 char caller[20];
555#ifdef CONFIG_PRINTK_CALLER
John Ogness896fbe22020-07-09 15:29:44 +0206556 u32 id = info->caller_id;
Tetsuo Handa15ff2062018-12-18 06:05:04 +0900557
558 snprintf(caller, sizeof(caller), ",caller=%c%u",
559 id & 0x80000000 ? 'C' : 'T', id & ~0x80000000);
560#else
561 caller[0] = '\0';
562#endif
Tejun Heo0a295e672015-06-25 15:01:27 -0700563
564 do_div(ts_usec, 1000);
565
Tetsuo Handa15ff2062018-12-18 06:05:04 +0900566 return scnprintf(buf, size, "%u,%llu,%llu,%c%s;",
John Ogness896fbe22020-07-09 15:29:44 +0206567 (info->facility << 3) | info->level, info->seq,
568 ts_usec, info->flags & LOG_CONT ? 'c' : '-', caller);
Tejun Heo0a295e672015-06-25 15:01:27 -0700569}
570
John Ogness74caba72020-09-21 13:24:45 +0206571static ssize_t msg_add_ext_text(char *buf, size_t size,
572 const char *text, size_t text_len,
573 unsigned char endc)
Tejun Heo0a295e672015-06-25 15:01:27 -0700574{
575 char *p = buf, *e = buf + size;
576 size_t i;
577
578 /* escape non-printable characters */
579 for (i = 0; i < text_len; i++) {
580 unsigned char c = text[i];
581
582 if (c < ' ' || c >= 127 || c == '\\')
583 p += scnprintf(p, e - p, "\\x%02x", c);
584 else
585 append_char(&p, e, c);
586 }
John Ogness74caba72020-09-21 13:24:45 +0206587 append_char(&p, e, endc);
Tejun Heo0a295e672015-06-25 15:01:27 -0700588
589 return p - buf;
590}
591
John Ogness74caba72020-09-21 13:24:45 +0206592static ssize_t msg_add_dict_text(char *buf, size_t size,
593 const char *key, const char *val)
594{
595 size_t val_len = strlen(val);
596 ssize_t len;
597
598 if (!val_len)
599 return 0;
600
601 len = msg_add_ext_text(buf, size, "", 0, ' '); /* dict prefix */
602 len += msg_add_ext_text(buf + len, size - len, key, strlen(key), '=');
603 len += msg_add_ext_text(buf + len, size - len, val, val_len, '\n');
604
605 return len;
606}
607
608static ssize_t msg_print_ext_body(char *buf, size_t size,
609 char *text, size_t text_len,
610 struct dev_printk_info *dev_info)
611{
612 ssize_t len;
613
614 len = msg_add_ext_text(buf, size, text, text_len, '\n');
615
616 if (!dev_info)
617 goto out;
618
619 len += msg_add_dict_text(buf + len, size - len, "SUBSYSTEM",
620 dev_info->subsystem);
621 len += msg_add_dict_text(buf + len, size - len, "DEVICE",
622 dev_info->device);
623out:
624 return len;
625}
626
Kay Sieverse11fea92012-05-03 02:29:41 +0200627/* /dev/kmsg - userspace message inject/listen interface */
628struct devkmsg_user {
John Ogness35b2b162021-03-03 11:15:22 +0100629 atomic64_t seq;
Borislav Petkov750afe72016-08-02 14:04:07 -0700630 struct ratelimit_state rs;
Kay Sieverse11fea92012-05-03 02:29:41 +0200631 struct mutex lock;
Tejun Heod43ff432015-06-25 15:01:24 -0700632 char buf[CONSOLE_EXT_LOG_MAX];
John Ogness896fbe22020-07-09 15:29:44 +0206633
634 struct printk_info info;
635 char text_buf[CONSOLE_EXT_LOG_MAX];
John Ogness896fbe22020-07-09 15:29:44 +0206636 struct printk_record record;
Kay Sieverse11fea92012-05-03 02:29:41 +0200637};
638
Tetsuo Handa9adcfaf2018-11-24 13:10:25 +0900639static __printf(3, 4) __cold
640int devkmsg_emit(int facility, int level, const char *fmt, ...)
641{
642 va_list args;
643 int r;
644
645 va_start(args, fmt);
John Ogness74caba72020-09-21 13:24:45 +0206646 r = vprintk_emit(facility, level, NULL, fmt, args);
Tetsuo Handa9adcfaf2018-11-24 13:10:25 +0900647 va_end(args);
648
649 return r;
650}
651
Al Viro849f3122014-08-23 12:23:53 -0400652static ssize_t devkmsg_write(struct kiocb *iocb, struct iov_iter *from)
Kay Sieverse11fea92012-05-03 02:29:41 +0200653{
654 char *buf, *line;
Kay Sieverse11fea92012-05-03 02:29:41 +0200655 int level = default_message_loglevel;
656 int facility = 1; /* LOG_USER */
Borislav Petkov750afe72016-08-02 14:04:07 -0700657 struct file *file = iocb->ki_filp;
658 struct devkmsg_user *user = file->private_data;
Christoph Hellwig66ee59a2015-02-11 19:56:46 +0100659 size_t len = iov_iter_count(from);
Kay Sieverse11fea92012-05-03 02:29:41 +0200660 ssize_t ret = len;
661
Borislav Petkov750afe72016-08-02 14:04:07 -0700662 if (!user || len > LOG_LINE_MAX)
Kay Sieverse11fea92012-05-03 02:29:41 +0200663 return -EINVAL;
Borislav Petkov750afe72016-08-02 14:04:07 -0700664
665 /* Ignore when user logging is disabled. */
666 if (devkmsg_log & DEVKMSG_LOG_MASK_OFF)
667 return len;
668
669 /* Ratelimit when not explicitly enabled. */
670 if (!(devkmsg_log & DEVKMSG_LOG_MASK_ON)) {
671 if (!___ratelimit(&user->rs, current->comm))
672 return ret;
673 }
674
Kay Sieverse11fea92012-05-03 02:29:41 +0200675 buf = kmalloc(len+1, GFP_KERNEL);
676 if (buf == NULL)
677 return -ENOMEM;
678
Al Viro849f3122014-08-23 12:23:53 -0400679 buf[len] = '\0';
Al Virocbbd26b2016-11-01 22:09:04 -0400680 if (!copy_from_iter_full(buf, len, from)) {
Al Viro849f3122014-08-23 12:23:53 -0400681 kfree(buf);
682 return -EFAULT;
Kay Sieverse11fea92012-05-03 02:29:41 +0200683 }
684
685 /*
686 * Extract and skip the syslog prefix <[0-9]*>. Coming from userspace
687 * the decimal value represents 32bit, the lower 3 bit are the log
688 * level, the rest are the log facility.
689 *
690 * If no prefix or no userspace facility is specified, we
691 * enforce LOG_USER, to be able to reliably distinguish
692 * kernel-generated messages from userspace-injected ones.
693 */
694 line = buf;
695 if (line[0] == '<') {
696 char *endp = NULL;
Mathias Krause38246572015-11-06 16:30:38 -0800697 unsigned int u;
Kay Sieverse11fea92012-05-03 02:29:41 +0200698
Mathias Krause38246572015-11-06 16:30:38 -0800699 u = simple_strtoul(line + 1, &endp, 10);
Kay Sieverse11fea92012-05-03 02:29:41 +0200700 if (endp && endp[0] == '>') {
Mathias Krause38246572015-11-06 16:30:38 -0800701 level = LOG_LEVEL(u);
702 if (LOG_FACILITY(u) != 0)
703 facility = LOG_FACILITY(u);
Kay Sieverse11fea92012-05-03 02:29:41 +0200704 endp++;
Kay Sieverse11fea92012-05-03 02:29:41 +0200705 line = endp;
706 }
707 }
Kay Sieverse11fea92012-05-03 02:29:41 +0200708
Tetsuo Handa9adcfaf2018-11-24 13:10:25 +0900709 devkmsg_emit(facility, level, "%s", line);
Kay Sieverse11fea92012-05-03 02:29:41 +0200710 kfree(buf);
711 return ret;
712}
713
714static ssize_t devkmsg_read(struct file *file, char __user *buf,
715 size_t count, loff_t *ppos)
716{
717 struct devkmsg_user *user = file->private_data;
John Ogness896fbe22020-07-09 15:29:44 +0206718 struct printk_record *r = &user->record;
Kay Sieverse11fea92012-05-03 02:29:41 +0200719 size_t len;
720 ssize_t ret;
721
722 if (!user)
723 return -EBADF;
724
Yuanhan Liu4a77a5a2012-06-16 21:21:51 +0800725 ret = mutex_lock_interruptible(&user->lock);
726 if (ret)
727 return ret;
Sergey Senozhatskyde6fcbd2016-12-27 23:16:11 +0900728
John Ogness35b2b162021-03-03 11:15:22 +0100729 if (!prb_read_valid(prb, atomic64_read(&user->seq), r)) {
Kay Sieverse11fea92012-05-03 02:29:41 +0200730 if (file->f_flags & O_NONBLOCK) {
731 ret = -EAGAIN;
Kay Sieverse11fea92012-05-03 02:29:41 +0200732 goto out;
733 }
734
Kay Sieverse11fea92012-05-03 02:29:41 +0200735 ret = wait_event_interruptible(log_wait,
John Ogness35b2b162021-03-03 11:15:22 +0100736 prb_read_valid(prb, atomic64_read(&user->seq), r));
Kay Sieverse11fea92012-05-03 02:29:41 +0200737 if (ret)
738 goto out;
Kay Sieverse11fea92012-05-03 02:29:41 +0200739 }
740
John Ogness35b2b162021-03-03 11:15:22 +0100741 if (r->info->seq != atomic64_read(&user->seq)) {
Kay Sieverse11fea92012-05-03 02:29:41 +0200742 /* our last seen message is gone, return error and reset */
John Ogness35b2b162021-03-03 11:15:22 +0100743 atomic64_set(&user->seq, r->info->seq);
Kay Sieverse11fea92012-05-03 02:29:41 +0200744 ret = -EPIPE;
Kay Sieverse11fea92012-05-03 02:29:41 +0200745 goto out;
746 }
747
John Ogness896fbe22020-07-09 15:29:44 +0206748 len = info_print_ext_header(user->buf, sizeof(user->buf), r->info);
Tejun Heo0a295e672015-06-25 15:01:27 -0700749 len += msg_print_ext_body(user->buf + len, sizeof(user->buf) - len,
John Ogness74caba72020-09-21 13:24:45 +0206750 &r->text_buf[0], r->info->text_len,
751 &r->info->dev_info);
Kay Sieversd39f3d72012-07-16 18:35:30 -0700752
John Ogness35b2b162021-03-03 11:15:22 +0100753 atomic64_set(&user->seq, r->info->seq + 1);
Kay Sieverse11fea92012-05-03 02:29:41 +0200754
755 if (len > count) {
756 ret = -EINVAL;
757 goto out;
758 }
759
760 if (copy_to_user(buf, user->buf, len)) {
761 ret = -EFAULT;
762 goto out;
763 }
764 ret = len;
765out:
766 mutex_unlock(&user->lock);
767 return ret;
768}
769
Bruno Meneguelebc885f12020-07-10 14:44:23 -0300770/*
771 * Be careful when modifying this function!!!
772 *
773 * Only few operations are supported because the device works only with the
774 * entire variable length messages (records). Non-standard values are
775 * returned in the other cases and has been this way for quite some time.
776 * User space applications might depend on this behavior.
777 */
Kay Sieverse11fea92012-05-03 02:29:41 +0200778static loff_t devkmsg_llseek(struct file *file, loff_t offset, int whence)
779{
780 struct devkmsg_user *user = file->private_data;
781 loff_t ret = 0;
782
783 if (!user)
784 return -EBADF;
785 if (offset)
786 return -ESPIPE;
787
Kay Sieverse11fea92012-05-03 02:29:41 +0200788 switch (whence) {
789 case SEEK_SET:
790 /* the first record */
John Ogness35b2b162021-03-03 11:15:22 +0100791 atomic64_set(&user->seq, prb_first_valid_seq(prb));
Kay Sieverse11fea92012-05-03 02:29:41 +0200792 break;
793 case SEEK_DATA:
794 /*
795 * The first record after the last SYSLOG_ACTION_CLEAR,
796 * like issued by 'dmesg -c'. Reading /dev/kmsg itself
797 * changes no global state, and does not clear anything.
798 */
John Ogness35b2b162021-03-03 11:15:22 +0100799 atomic64_set(&user->seq, latched_seq_read_nolock(&clear_seq));
Kay Sieverse11fea92012-05-03 02:29:41 +0200800 break;
801 case SEEK_END:
802 /* after the last record */
John Ogness35b2b162021-03-03 11:15:22 +0100803 atomic64_set(&user->seq, prb_next_seq(prb));
Kay Sieverse11fea92012-05-03 02:29:41 +0200804 break;
805 default:
806 ret = -EINVAL;
807 }
Kay Sieverse11fea92012-05-03 02:29:41 +0200808 return ret;
809}
810
Al Viro9dd95742017-07-03 00:42:43 -0400811static __poll_t devkmsg_poll(struct file *file, poll_table *wait)
Kay Sieverse11fea92012-05-03 02:29:41 +0200812{
813 struct devkmsg_user *user = file->private_data;
John Ogness13791c82021-02-11 18:37:52 +0106814 struct printk_info info;
Al Viro9dd95742017-07-03 00:42:43 -0400815 __poll_t ret = 0;
Kay Sieverse11fea92012-05-03 02:29:41 +0200816
817 if (!user)
Linus Torvaldsa9a08842018-02-11 14:34:03 -0800818 return EPOLLERR|EPOLLNVAL;
Kay Sieverse11fea92012-05-03 02:29:41 +0200819
820 poll_wait(file, &log_wait, wait);
821
John Ogness35b2b162021-03-03 11:15:22 +0100822 if (prb_read_valid_info(prb, atomic64_read(&user->seq), &info, NULL)) {
Kay Sieverse11fea92012-05-03 02:29:41 +0200823 /* return error when data has vanished underneath us */
John Ogness35b2b162021-03-03 11:15:22 +0100824 if (info.seq != atomic64_read(&user->seq))
Linus Torvaldsa9a08842018-02-11 14:34:03 -0800825 ret = EPOLLIN|EPOLLRDNORM|EPOLLERR|EPOLLPRI;
Nicolas Kaiser0a285312013-04-29 16:17:20 -0700826 else
Linus Torvaldsa9a08842018-02-11 14:34:03 -0800827 ret = EPOLLIN|EPOLLRDNORM;
Kay Sieverse11fea92012-05-03 02:29:41 +0200828 }
Kay Sieverse11fea92012-05-03 02:29:41 +0200829
830 return ret;
831}
832
833static int devkmsg_open(struct inode *inode, struct file *file)
834{
835 struct devkmsg_user *user;
836 int err;
837
Borislav Petkov750afe72016-08-02 14:04:07 -0700838 if (devkmsg_log & DEVKMSG_LOG_MASK_OFF)
839 return -EPERM;
Kay Sieverse11fea92012-05-03 02:29:41 +0200840
Borislav Petkov750afe72016-08-02 14:04:07 -0700841 /* write-only does not need any file context */
842 if ((file->f_flags & O_ACCMODE) != O_WRONLY) {
843 err = check_syslog_permissions(SYSLOG_ACTION_READ_ALL,
844 SYSLOG_FROM_READER);
845 if (err)
846 return err;
847 }
Kay Sieverse11fea92012-05-03 02:29:41 +0200848
Yong-Taek Lee9980c422021-08-30 16:17:01 +0900849 user = kvmalloc(sizeof(struct devkmsg_user), GFP_KERNEL);
Kay Sieverse11fea92012-05-03 02:29:41 +0200850 if (!user)
851 return -ENOMEM;
852
Borislav Petkov750afe72016-08-02 14:04:07 -0700853 ratelimit_default_init(&user->rs);
854 ratelimit_set_flags(&user->rs, RATELIMIT_MSG_ON_RELEASE);
855
Kay Sieverse11fea92012-05-03 02:29:41 +0200856 mutex_init(&user->lock);
857
John Ogness896fbe22020-07-09 15:29:44 +0206858 prb_rec_init_rd(&user->record, &user->info,
John Ognessf35efc72020-09-19 00:40:21 +0206859 &user->text_buf[0], sizeof(user->text_buf));
John Ogness896fbe22020-07-09 15:29:44 +0206860
John Ogness35b2b162021-03-03 11:15:22 +0100861 atomic64_set(&user->seq, prb_first_valid_seq(prb));
Kay Sieverse11fea92012-05-03 02:29:41 +0200862
863 file->private_data = user;
864 return 0;
865}
866
867static int devkmsg_release(struct inode *inode, struct file *file)
868{
869 struct devkmsg_user *user = file->private_data;
870
871 if (!user)
872 return 0;
873
Borislav Petkov750afe72016-08-02 14:04:07 -0700874 ratelimit_state_exit(&user->rs);
875
Kay Sieverse11fea92012-05-03 02:29:41 +0200876 mutex_destroy(&user->lock);
Yong-Taek Lee9980c422021-08-30 16:17:01 +0900877 kvfree(user);
Kay Sieverse11fea92012-05-03 02:29:41 +0200878 return 0;
879}
880
881const struct file_operations kmsg_fops = {
882 .open = devkmsg_open,
883 .read = devkmsg_read,
Al Viro849f3122014-08-23 12:23:53 -0400884 .write_iter = devkmsg_write,
Kay Sieverse11fea92012-05-03 02:29:41 +0200885 .llseek = devkmsg_llseek,
886 .poll = devkmsg_poll,
887 .release = devkmsg_release,
888};
889
Hari Bathini692f66f2017-05-08 15:56:18 -0700890#ifdef CONFIG_CRASH_CORE
Neil Horman04d491a2009-04-02 16:58:57 -0700891/*
Dirk Gouders4c1ace62013-11-12 15:08:54 -0800892 * This appends the listed symbols to /proc/vmcore
Neil Horman04d491a2009-04-02 16:58:57 -0700893 *
Dirk Gouders4c1ace62013-11-12 15:08:54 -0800894 * /proc/vmcore is used by various utilities, like crash and makedumpfile to
Neil Horman04d491a2009-04-02 16:58:57 -0700895 * obtain access to symbols that are otherwise very difficult to locate. These
896 * symbols are specifically used so that utilities can access and extract the
897 * dmesg log from a vmcore file after a crash.
898 */
Hari Bathini692f66f2017-05-08 15:56:18 -0700899void log_buf_vmcoreinfo_setup(void)
Neil Horman04d491a2009-04-02 16:58:57 -0700900{
John Ogness74caba72020-09-21 13:24:45 +0206901 struct dev_printk_info *dev_info = NULL;
902
John Ogness896fbe22020-07-09 15:29:44 +0206903 VMCOREINFO_SYMBOL(prb);
904 VMCOREINFO_SYMBOL(printk_rb_static);
905 VMCOREINFO_SYMBOL(clear_seq);
906
Vivek Goyal67914572012-07-18 13:18:12 -0400907 /*
John Ogness896fbe22020-07-09 15:29:44 +0206908 * Export struct size and field offsets. User space tools can
Vivek Goyal67914572012-07-18 13:18:12 -0400909 * parse it and detect any changes to structure down the line.
910 */
John Ogness896fbe22020-07-09 15:29:44 +0206911
912 VMCOREINFO_STRUCT_SIZE(printk_ringbuffer);
913 VMCOREINFO_OFFSET(printk_ringbuffer, desc_ring);
914 VMCOREINFO_OFFSET(printk_ringbuffer, text_data_ring);
John Ogness896fbe22020-07-09 15:29:44 +0206915 VMCOREINFO_OFFSET(printk_ringbuffer, fail);
916
917 VMCOREINFO_STRUCT_SIZE(prb_desc_ring);
918 VMCOREINFO_OFFSET(prb_desc_ring, count_bits);
919 VMCOREINFO_OFFSET(prb_desc_ring, descs);
John Ognesscfe27902020-09-19 00:40:19 +0206920 VMCOREINFO_OFFSET(prb_desc_ring, infos);
John Ogness896fbe22020-07-09 15:29:44 +0206921 VMCOREINFO_OFFSET(prb_desc_ring, head_id);
922 VMCOREINFO_OFFSET(prb_desc_ring, tail_id);
923
924 VMCOREINFO_STRUCT_SIZE(prb_desc);
John Ogness896fbe22020-07-09 15:29:44 +0206925 VMCOREINFO_OFFSET(prb_desc, state_var);
926 VMCOREINFO_OFFSET(prb_desc, text_blk_lpos);
John Ogness896fbe22020-07-09 15:29:44 +0206927
928 VMCOREINFO_STRUCT_SIZE(prb_data_blk_lpos);
929 VMCOREINFO_OFFSET(prb_data_blk_lpos, begin);
930 VMCOREINFO_OFFSET(prb_data_blk_lpos, next);
931
932 VMCOREINFO_STRUCT_SIZE(printk_info);
933 VMCOREINFO_OFFSET(printk_info, seq);
934 VMCOREINFO_OFFSET(printk_info, ts_nsec);
935 VMCOREINFO_OFFSET(printk_info, text_len);
John Ogness896fbe22020-07-09 15:29:44 +0206936 VMCOREINFO_OFFSET(printk_info, caller_id);
John Ogness74caba72020-09-21 13:24:45 +0206937 VMCOREINFO_OFFSET(printk_info, dev_info);
938
939 VMCOREINFO_STRUCT_SIZE(dev_printk_info);
940 VMCOREINFO_OFFSET(dev_printk_info, subsystem);
941 VMCOREINFO_LENGTH(printk_info_subsystem, sizeof(dev_info->subsystem));
942 VMCOREINFO_OFFSET(dev_printk_info, device);
943 VMCOREINFO_LENGTH(printk_info_device, sizeof(dev_info->device));
John Ogness896fbe22020-07-09 15:29:44 +0206944
945 VMCOREINFO_STRUCT_SIZE(prb_data_ring);
946 VMCOREINFO_OFFSET(prb_data_ring, size_bits);
947 VMCOREINFO_OFFSET(prb_data_ring, data);
948 VMCOREINFO_OFFSET(prb_data_ring, head_lpos);
949 VMCOREINFO_OFFSET(prb_data_ring, tail_lpos);
950
951 VMCOREINFO_SIZE(atomic_long_t);
952 VMCOREINFO_TYPE_OFFSET(atomic_long_t, counter);
John Ogness7d7a23a2021-03-03 11:15:21 +0100953
954 VMCOREINFO_STRUCT_SIZE(latched_seq);
955 VMCOREINFO_OFFSET(latched_seq, val);
Neil Horman04d491a2009-04-02 16:58:57 -0700956}
957#endif
958
Mike Travis162a7e72011-05-24 17:13:20 -0700959/* requested log_buf_len from kernel cmdline */
960static unsigned long __initdata new_log_buf_len;
961
Luis R. Rodriguezc0a318a2014-08-06 16:08:52 -0700962/* we practice scaling the ring buffer by powers of 2 */
He Zhee6fe3e52018-09-30 00:45:53 +0800963static void __init log_buf_len_update(u64 size)
Luis R. Rodriguezc0a318a2014-08-06 16:08:52 -0700964{
He Zhee6fe3e52018-09-30 00:45:53 +0800965 if (size > (u64)LOG_BUF_LEN_MAX) {
966 size = (u64)LOG_BUF_LEN_MAX;
967 pr_err("log_buf over 2G is not supported.\n");
968 }
969
Luis R. Rodriguezc0a318a2014-08-06 16:08:52 -0700970 if (size)
971 size = roundup_pow_of_two(size);
972 if (size > log_buf_len)
He Zhee6fe3e52018-09-30 00:45:53 +0800973 new_log_buf_len = (unsigned long)size;
Luis R. Rodriguezc0a318a2014-08-06 16:08:52 -0700974}
975
Mike Travis162a7e72011-05-24 17:13:20 -0700976/* save requested log_buf_len since it's too early to process it */
Linus Torvalds1da177e2005-04-16 15:20:36 -0700977static int __init log_buf_len_setup(char *str)
978{
He Zhee6fe3e52018-09-30 00:45:53 +0800979 u64 size;
He Zhe277fcdb2018-09-30 00:45:50 +0800980
981 if (!str)
982 return -EINVAL;
983
984 size = memparse(str, &str);
Linus Torvalds1da177e2005-04-16 15:20:36 -0700985
Luis R. Rodriguezc0a318a2014-08-06 16:08:52 -0700986 log_buf_len_update(size);
Linus Torvalds1da177e2005-04-16 15:20:36 -0700987
Mike Travis162a7e72011-05-24 17:13:20 -0700988 return 0;
Linus Torvalds1da177e2005-04-16 15:20:36 -0700989}
Mike Travis162a7e72011-05-24 17:13:20 -0700990early_param("log_buf_len", log_buf_len_setup);
Linus Torvalds1da177e2005-04-16 15:20:36 -0700991
Geert Uytterhoeven2240a312014-10-13 15:51:11 -0700992#ifdef CONFIG_SMP
993#define __LOG_CPU_MAX_BUF_LEN (1 << CONFIG_LOG_CPU_MAX_BUF_SHIFT)
994
Luis R. Rodriguez23b28992014-08-06 16:08:56 -0700995static void __init log_buf_add_cpu(void)
996{
997 unsigned int cpu_extra;
998
999 /*
1000 * archs should set up cpu_possible_bits properly with
1001 * set_cpu_possible() after setup_arch() but just in
1002 * case lets ensure this is valid.
1003 */
1004 if (num_possible_cpus() == 1)
1005 return;
1006
1007 cpu_extra = (num_possible_cpus() - 1) * __LOG_CPU_MAX_BUF_LEN;
1008
1009 /* by default this will only continue through for large > 64 CPUs */
1010 if (cpu_extra <= __LOG_BUF_LEN / 2)
1011 return;
1012
1013 pr_info("log_buf_len individual max cpu contribution: %d bytes\n",
1014 __LOG_CPU_MAX_BUF_LEN);
1015 pr_info("log_buf_len total cpu_extra contributions: %d bytes\n",
1016 cpu_extra);
1017 pr_info("log_buf_len min size: %d bytes\n", __LOG_BUF_LEN);
1018
1019 log_buf_len_update(cpu_extra + __LOG_BUF_LEN);
1020}
Geert Uytterhoeven2240a312014-10-13 15:51:11 -07001021#else /* !CONFIG_SMP */
1022static inline void log_buf_add_cpu(void) {}
1023#endif /* CONFIG_SMP */
Luis R. Rodriguez23b28992014-08-06 16:08:56 -07001024
Sergey Senozhatskyab6f7622020-03-03 20:30:02 +09001025static void __init set_percpu_data_ready(void)
1026{
Sergey Senozhatskyab6f7622020-03-03 20:30:02 +09001027 __printk_percpu_data_ready = true;
1028}
1029
John Ogness896fbe22020-07-09 15:29:44 +02061030static unsigned int __init add_to_rb(struct printk_ringbuffer *rb,
1031 struct printk_record *r)
1032{
1033 struct prb_reserved_entry e;
1034 struct printk_record dest_r;
1035
John Ognessf35efc72020-09-19 00:40:21 +02061036 prb_rec_init_wr(&dest_r, r->info->text_len);
John Ogness896fbe22020-07-09 15:29:44 +02061037
1038 if (!prb_reserve(&e, rb, &dest_r))
1039 return 0;
1040
John Ognesscc5c7042020-09-14 14:39:51 +02061041 memcpy(&dest_r.text_buf[0], &r->text_buf[0], r->info->text_len);
1042 dest_r.info->text_len = r->info->text_len;
John Ogness896fbe22020-07-09 15:29:44 +02061043 dest_r.info->facility = r->info->facility;
1044 dest_r.info->level = r->info->level;
1045 dest_r.info->flags = r->info->flags;
1046 dest_r.info->ts_nsec = r->info->ts_nsec;
1047 dest_r.info->caller_id = r->info->caller_id;
John Ogness74caba72020-09-21 13:24:45 +02061048 memcpy(&dest_r.info->dev_info, &r->info->dev_info, sizeof(dest_r.info->dev_info));
John Ogness896fbe22020-07-09 15:29:44 +02061049
John Ognessf5f022e2020-09-14 14:39:54 +02061050 prb_final_commit(&e);
John Ogness896fbe22020-07-09 15:29:44 +02061051
1052 return prb_record_text_space(&e);
1053}
1054
John Ogness0463d042020-09-30 11:07:34 +02061055static char setup_text_buf[LOG_LINE_MAX] __initdata;
John Ogness896fbe22020-07-09 15:29:44 +02061056
Mike Travis162a7e72011-05-24 17:13:20 -07001057void __init setup_log_buf(int early)
1058{
John Ognesscfe27902020-09-19 00:40:19 +02061059 struct printk_info *new_infos;
John Ogness896fbe22020-07-09 15:29:44 +02061060 unsigned int new_descs_count;
1061 struct prb_desc *new_descs;
1062 struct printk_info info;
1063 struct printk_record r;
John Ogness93d102f2021-07-15 21:39:56 +02061064 unsigned int text_size;
John Ogness896fbe22020-07-09 15:29:44 +02061065 size_t new_descs_size;
John Ognesscfe27902020-09-19 00:40:19 +02061066 size_t new_infos_size;
Mike Travis162a7e72011-05-24 17:13:20 -07001067 unsigned long flags;
Mike Travis162a7e72011-05-24 17:13:20 -07001068 char *new_log_buf;
Sergey Senozhatskyd2130e82018-10-10 20:33:08 +09001069 unsigned int free;
John Ogness896fbe22020-07-09 15:29:44 +02061070 u64 seq;
Mike Travis162a7e72011-05-24 17:13:20 -07001071
Sergey Senozhatskyab6f7622020-03-03 20:30:02 +09001072 /*
1073 * Some archs call setup_log_buf() multiple times - first is very
1074 * early, e.g. from setup_arch(), and second - when percpu_areas
1075 * are initialised.
1076 */
1077 if (!early)
1078 set_percpu_data_ready();
1079
Luis R. Rodriguez23b28992014-08-06 16:08:56 -07001080 if (log_buf != __log_buf)
1081 return;
1082
1083 if (!early && !new_log_buf_len)
1084 log_buf_add_cpu();
1085
Mike Travis162a7e72011-05-24 17:13:20 -07001086 if (!new_log_buf_len)
1087 return;
1088
John Ogness896fbe22020-07-09 15:29:44 +02061089 new_descs_count = new_log_buf_len >> PRB_AVGBITS;
1090 if (new_descs_count == 0) {
1091 pr_err("new_log_buf_len: %lu too small\n", new_log_buf_len);
Mike Travis162a7e72011-05-24 17:13:20 -07001092 return;
1093 }
1094
John Ogness896fbe22020-07-09 15:29:44 +02061095 new_log_buf = memblock_alloc(new_log_buf_len, LOG_ALIGN);
1096 if (unlikely(!new_log_buf)) {
1097 pr_err("log_buf_len: %lu text bytes not available\n",
1098 new_log_buf_len);
1099 return;
1100 }
1101
John Ogness896fbe22020-07-09 15:29:44 +02061102 new_descs_size = new_descs_count * sizeof(struct prb_desc);
1103 new_descs = memblock_alloc(new_descs_size, LOG_ALIGN);
1104 if (unlikely(!new_descs)) {
1105 pr_err("log_buf_len: %zu desc bytes not available\n",
1106 new_descs_size);
John Ognessf35efc72020-09-19 00:40:21 +02061107 goto err_free_log_buf;
John Ognesscfe27902020-09-19 00:40:19 +02061108 }
1109
1110 new_infos_size = new_descs_count * sizeof(struct printk_info);
1111 new_infos = memblock_alloc(new_infos_size, LOG_ALIGN);
1112 if (unlikely(!new_infos)) {
1113 pr_err("log_buf_len: %zu info bytes not available\n",
1114 new_infos_size);
1115 goto err_free_descs;
John Ogness896fbe22020-07-09 15:29:44 +02061116 }
1117
John Ognessf35efc72020-09-19 00:40:21 +02061118 prb_rec_init_rd(&r, &info, &setup_text_buf[0], sizeof(setup_text_buf));
John Ogness896fbe22020-07-09 15:29:44 +02061119
1120 prb_init(&printk_rb_dynamic,
1121 new_log_buf, ilog2(new_log_buf_len),
John Ognesscfe27902020-09-19 00:40:19 +02061122 new_descs, ilog2(new_descs_count),
1123 new_infos);
John Ogness896fbe22020-07-09 15:29:44 +02061124
John Ogness93d102f2021-07-15 21:39:56 +02061125 local_irq_save(flags);
John Ogness896fbe22020-07-09 15:29:44 +02061126
Mike Travis162a7e72011-05-24 17:13:20 -07001127 log_buf_len = new_log_buf_len;
1128 log_buf = new_log_buf;
1129 new_log_buf_len = 0;
John Ogness896fbe22020-07-09 15:29:44 +02061130
1131 free = __LOG_BUF_LEN;
John Ogness93d102f2021-07-15 21:39:56 +02061132 prb_for_each_record(0, &printk_rb_static, seq, &r) {
1133 text_size = add_to_rb(&printk_rb_dynamic, &r);
1134 if (text_size > free)
1135 free = 0;
1136 else
1137 free -= text_size;
1138 }
John Ogness896fbe22020-07-09 15:29:44 +02061139
John Ogness896fbe22020-07-09 15:29:44 +02061140 prb = &printk_rb_dynamic;
1141
John Ogness93d102f2021-07-15 21:39:56 +02061142 local_irq_restore(flags);
1143
1144 /*
1145 * Copy any remaining messages that might have appeared from
1146 * NMI context after copying but before switching to the
1147 * dynamic buffer.
1148 */
1149 prb_for_each_record(seq, &printk_rb_static, seq, &r) {
1150 text_size = add_to_rb(&printk_rb_dynamic, &r);
1151 if (text_size > free)
1152 free = 0;
1153 else
1154 free -= text_size;
1155 }
Mike Travis162a7e72011-05-24 17:13:20 -07001156
John Ogness896fbe22020-07-09 15:29:44 +02061157 if (seq != prb_next_seq(&printk_rb_static)) {
1158 pr_err("dropped %llu messages\n",
1159 prb_next_seq(&printk_rb_static) - seq);
1160 }
1161
He Zhee6fe3e52018-09-30 00:45:53 +08001162 pr_info("log_buf_len: %u bytes\n", log_buf_len);
1163 pr_info("early log buf free: %u(%u%%)\n",
Mike Travis162a7e72011-05-24 17:13:20 -07001164 free, (free * 100) / __LOG_BUF_LEN);
John Ognesscfe27902020-09-19 00:40:19 +02061165 return;
1166
1167err_free_descs:
Mike Rapoport4421cca2021-11-05 13:43:22 -07001168 memblock_free(new_descs, new_descs_size);
John Ognesscfe27902020-09-19 00:40:19 +02061169err_free_log_buf:
Mike Rapoport4421cca2021-11-05 13:43:22 -07001170 memblock_free(new_log_buf, new_log_buf_len);
Mike Travis162a7e72011-05-24 17:13:20 -07001171}
Linus Torvalds1da177e2005-04-16 15:20:36 -07001172
Andrew Cooks2fa72c82012-12-17 15:59:56 -08001173static bool __read_mostly ignore_loglevel;
1174
1175static int __init ignore_loglevel_setup(char *str)
1176{
Neil Zhangd25d9fe2014-08-06 16:09:12 -07001177 ignore_loglevel = true;
Andrew Morton27083ba2013-11-12 15:08:50 -08001178 pr_info("debug: ignoring loglevel setting.\n");
Andrew Cooks2fa72c82012-12-17 15:59:56 -08001179
1180 return 0;
1181}
1182
1183early_param("ignore_loglevel", ignore_loglevel_setup);
1184module_param(ignore_loglevel, bool, S_IRUGO | S_IWUSR);
Joe Perches205bd3d2015-02-12 15:01:34 -08001185MODULE_PARM_DESC(ignore_loglevel,
1186 "ignore loglevel setting (prints all kernel messages to the console)");
Andrew Cooks2fa72c82012-12-17 15:59:56 -08001187
Sergey Senozhatskycf775442016-08-02 14:03:56 -07001188static bool suppress_message_printing(int level)
1189{
1190 return (level >= console_loglevel && !ignore_loglevel);
1191}
1192
Randy Dunlapbfe8df32007-10-16 01:23:46 -07001193#ifdef CONFIG_BOOT_PRINTK_DELAY
1194
Namhyung Kim674dff62010-10-26 14:22:48 -07001195static int boot_delay; /* msecs delay after each printk during bootup */
Dave Young3a3b6ed2009-09-22 16:43:31 -07001196static unsigned long long loops_per_msec; /* based on boot_delay */
Randy Dunlapbfe8df32007-10-16 01:23:46 -07001197
1198static int __init boot_delay_setup(char *str)
1199{
1200 unsigned long lpj;
Randy Dunlapbfe8df32007-10-16 01:23:46 -07001201
1202 lpj = preset_lpj ? preset_lpj : 1000000; /* some guess */
1203 loops_per_msec = (unsigned long long)lpj / 1000 * HZ;
1204
1205 get_option(&str, &boot_delay);
1206 if (boot_delay > 10 * 1000)
1207 boot_delay = 0;
1208
Dave Young3a3b6ed2009-09-22 16:43:31 -07001209 pr_debug("boot_delay: %u, preset_lpj: %ld, lpj: %lu, "
1210 "HZ: %d, loops_per_msec: %llu\n",
1211 boot_delay, preset_lpj, lpj, HZ, loops_per_msec);
Dave Young29e9d222013-11-12 15:08:53 -08001212 return 0;
Randy Dunlapbfe8df32007-10-16 01:23:46 -07001213}
Dave Young29e9d222013-11-12 15:08:53 -08001214early_param("boot_delay", boot_delay_setup);
Randy Dunlapbfe8df32007-10-16 01:23:46 -07001215
Andrew Cooks2fa72c82012-12-17 15:59:56 -08001216static void boot_delay_msec(int level)
Randy Dunlapbfe8df32007-10-16 01:23:46 -07001217{
1218 unsigned long long k;
1219 unsigned long timeout;
1220
Thomas Gleixnerff48cd22017-05-16 20:42:45 +02001221 if ((boot_delay == 0 || system_state >= SYSTEM_RUNNING)
Sergey Senozhatskycf775442016-08-02 14:03:56 -07001222 || suppress_message_printing(level)) {
Randy Dunlapbfe8df32007-10-16 01:23:46 -07001223 return;
Andrew Cooks2fa72c82012-12-17 15:59:56 -08001224 }
Randy Dunlapbfe8df32007-10-16 01:23:46 -07001225
Dave Young3a3b6ed2009-09-22 16:43:31 -07001226 k = (unsigned long long)loops_per_msec * boot_delay;
Randy Dunlapbfe8df32007-10-16 01:23:46 -07001227
1228 timeout = jiffies + msecs_to_jiffies(boot_delay);
1229 while (k) {
1230 k--;
1231 cpu_relax();
1232 /*
1233 * use (volatile) jiffies to prevent
1234 * compiler reduction; loop termination via jiffies
1235 * is secondary and may or may not happen.
1236 */
1237 if (time_after(jiffies, timeout))
1238 break;
1239 touch_nmi_watchdog();
1240 }
1241}
1242#else
Andrew Cooks2fa72c82012-12-17 15:59:56 -08001243static inline void boot_delay_msec(int level)
Randy Dunlapbfe8df32007-10-16 01:23:46 -07001244{
1245}
1246#endif
1247
Alex Eldere99aa462014-08-06 16:09:05 -07001248static bool printk_time = IS_ENABLED(CONFIG_PRINTK_TIME);
Kay Sievers7ff95542012-05-03 02:29:13 +02001249module_param_named(time, printk_time, bool, S_IRUGO | S_IWUSR);
1250
Tetsuo Handa07c17732018-12-11 18:49:05 +09001251static size_t print_syslog(unsigned int level, char *buf)
1252{
1253 return sprintf(buf, "<%u>", level);
1254}
1255
Kay Sievers084681d2012-06-28 09:38:53 +02001256static size_t print_time(u64 ts, char *buf)
1257{
Tetsuo Handae80c1a92018-12-04 19:00:01 +09001258 unsigned long rem_nsec = do_div(ts, 1000000000);
Roland Dreier35dac272013-01-04 15:35:50 -08001259
Tetsuo Handa15ff2062018-12-18 06:05:04 +09001260 return sprintf(buf, "[%5lu.%06lu]",
Kay Sievers084681d2012-06-28 09:38:53 +02001261 (unsigned long)ts, rem_nsec / 1000);
1262}
1263
Tetsuo Handa15ff2062018-12-18 06:05:04 +09001264#ifdef CONFIG_PRINTK_CALLER
1265static size_t print_caller(u32 id, char *buf)
1266{
1267 char caller[12];
1268
1269 snprintf(caller, sizeof(caller), "%c%u",
1270 id & 0x80000000 ? 'C' : 'T', id & ~0x80000000);
1271 return sprintf(buf, "[%6s]", caller);
1272}
1273#else
1274#define print_caller(id, buf) 0
1275#endif
1276
John Ogness896fbe22020-07-09 15:29:44 +02061277static size_t info_print_prefix(const struct printk_info *info, bool syslog,
1278 bool time, char *buf)
Kay Sievers649e6ee2012-05-10 04:30:45 +02001279{
Kay Sievers3ce9a7c2012-05-13 23:30:46 +02001280 size_t len = 0;
Kay Sievers649e6ee2012-05-10 04:30:45 +02001281
Tetsuo Handa07c17732018-12-11 18:49:05 +09001282 if (syslog)
John Ogness896fbe22020-07-09 15:29:44 +02061283 len = print_syslog((info->facility << 3) | info->level, buf);
Tetsuo Handa15ff2062018-12-18 06:05:04 +09001284
Tetsuo Handae80c1a92018-12-04 19:00:01 +09001285 if (time)
John Ogness896fbe22020-07-09 15:29:44 +02061286 len += print_time(info->ts_nsec, buf + len);
Tetsuo Handa15ff2062018-12-18 06:05:04 +09001287
John Ogness896fbe22020-07-09 15:29:44 +02061288 len += print_caller(info->caller_id, buf + len);
Tetsuo Handa15ff2062018-12-18 06:05:04 +09001289
1290 if (IS_ENABLED(CONFIG_PRINTK_CALLER) || time) {
1291 buf[len++] = ' ';
1292 buf[len] = '\0';
1293 }
1294
Kay Sievers3ce9a7c2012-05-13 23:30:46 +02001295 return len;
1296}
1297
John Ogness896fbe22020-07-09 15:29:44 +02061298/*
1299 * Prepare the record for printing. The text is shifted within the given
1300 * buffer to avoid a need for another one. The following operations are
1301 * done:
1302 *
1303 * - Add prefix for each line.
John Ognessf0e386e2021-01-14 18:10:12 +01061304 * - Drop truncated lines that no longer fit into the buffer.
John Ogness896fbe22020-07-09 15:29:44 +02061305 * - Add the trailing newline that has been removed in vprintk_store().
John Ognessf0e386e2021-01-14 18:10:12 +01061306 * - Add a string terminator.
1307 *
1308 * Since the produced string is always terminated, the maximum possible
1309 * return value is @r->text_buf_size - 1;
John Ogness896fbe22020-07-09 15:29:44 +02061310 *
1311 * Return: The length of the updated/prepared text, including the added
John Ognessf0e386e2021-01-14 18:10:12 +01061312 * prefixes and the newline. The terminator is not counted. The dropped
1313 * line(s) are not counted.
John Ogness896fbe22020-07-09 15:29:44 +02061314 */
1315static size_t record_print_text(struct printk_record *r, bool syslog,
1316 bool time)
Kay Sievers3ce9a7c2012-05-13 23:30:46 +02001317{
John Ogness896fbe22020-07-09 15:29:44 +02061318 size_t text_len = r->info->text_len;
1319 size_t buf_size = r->text_buf_size;
1320 char *text = r->text_buf;
Tetsuo Handa07c17732018-12-11 18:49:05 +09001321 char prefix[PREFIX_MAX];
John Ogness896fbe22020-07-09 15:29:44 +02061322 bool truncated = false;
1323 size_t prefix_len;
1324 size_t line_len;
1325 size_t len = 0;
1326 char *next;
Kay Sievers3ce9a7c2012-05-13 23:30:46 +02001327
John Ogness59f8bcc2020-09-30 11:07:33 +02061328 /*
1329 * If the message was truncated because the buffer was not large
1330 * enough, treat the available text as if it were the full text.
1331 */
1332 if (text_len > buf_size)
1333 text_len = buf_size;
Kay Sievers3ce9a7c2012-05-13 23:30:46 +02001334
John Ogness896fbe22020-07-09 15:29:44 +02061335 prefix_len = info_print_prefix(r->info, syslog, time, prefix);
Kay Sievers3ce9a7c2012-05-13 23:30:46 +02001336
John Ogness896fbe22020-07-09 15:29:44 +02061337 /*
1338 * @text_len: bytes of unprocessed text
1339 * @line_len: bytes of current line _without_ newline
1340 * @text: pointer to beginning of current line
1341 * @len: number of bytes prepared in r->text_buf
1342 */
1343 for (;;) {
1344 next = memchr(text, '\n', text_len);
Kay Sievers3ce9a7c2012-05-13 23:30:46 +02001345 if (next) {
John Ogness896fbe22020-07-09 15:29:44 +02061346 line_len = next - text;
Kay Sievers3ce9a7c2012-05-13 23:30:46 +02001347 } else {
John Ogness896fbe22020-07-09 15:29:44 +02061348 /* Drop truncated line(s). */
1349 if (truncated)
1350 break;
1351 line_len = text_len;
Kay Sievers3ce9a7c2012-05-13 23:30:46 +02001352 }
1353
John Ogness896fbe22020-07-09 15:29:44 +02061354 /*
1355 * Truncate the text if there is not enough space to add the
John Ognessf0e386e2021-01-14 18:10:12 +01061356 * prefix and a trailing newline and a terminator.
John Ogness896fbe22020-07-09 15:29:44 +02061357 */
John Ognessf0e386e2021-01-14 18:10:12 +01061358 if (len + prefix_len + text_len + 1 + 1 > buf_size) {
John Ogness896fbe22020-07-09 15:29:44 +02061359 /* Drop even the current line if no space. */
John Ognessf0e386e2021-01-14 18:10:12 +01061360 if (len + prefix_len + line_len + 1 + 1 > buf_size)
Kay Sievers3ce9a7c2012-05-13 23:30:46 +02001361 break;
1362
John Ognessf0e386e2021-01-14 18:10:12 +01061363 text_len = buf_size - len - prefix_len - 1 - 1;
John Ogness896fbe22020-07-09 15:29:44 +02061364 truncated = true;
Kay Sievers3ce9a7c2012-05-13 23:30:46 +02001365 }
1366
John Ogness896fbe22020-07-09 15:29:44 +02061367 memmove(text + prefix_len, text, text_len);
1368 memcpy(text, prefix, prefix_len);
1369
John Ognessf0e386e2021-01-14 18:10:12 +01061370 /*
1371 * Increment the prepared length to include the text and
1372 * prefix that were just moved+copied. Also increment for the
1373 * newline at the end of this line. If this is the last line,
1374 * there is no newline, but it will be added immediately below.
1375 */
John Ogness896fbe22020-07-09 15:29:44 +02061376 len += prefix_len + line_len + 1;
John Ogness896fbe22020-07-09 15:29:44 +02061377 if (text_len == line_len) {
1378 /*
John Ognessf0e386e2021-01-14 18:10:12 +01061379 * This is the last line. Add the trailing newline
1380 * removed in vprintk_store().
John Ogness896fbe22020-07-09 15:29:44 +02061381 */
1382 text[prefix_len + line_len] = '\n';
1383 break;
1384 }
1385
1386 /*
1387 * Advance beyond the added prefix and the related line with
1388 * its newline.
1389 */
1390 text += prefix_len + line_len + 1;
1391
1392 /*
1393 * The remaining text has only decreased by the line with its
1394 * newline.
1395 *
1396 * Note that @text_len can become zero. It happens when @text
1397 * ended with a newline (either due to truncation or the
1398 * original string ending with "\n\n"). The loop is correctly
1399 * repeated and (if not truncated) an empty line with a prefix
1400 * will be prepared.
1401 */
1402 text_len -= line_len + 1;
1403 }
Kay Sievers3ce9a7c2012-05-13 23:30:46 +02001404
John Ognessf0e386e2021-01-14 18:10:12 +01061405 /*
1406 * If a buffer was provided, it will be terminated. Space for the
1407 * string terminator is guaranteed to be available. The terminator is
1408 * not counted in the return value.
1409 */
1410 if (buf_size > 0)
John Ogness08d60e52021-01-24 21:33:28 +01061411 r->text_buf[len] = 0;
John Ognessf0e386e2021-01-14 18:10:12 +01061412
Kay Sievers7ff95542012-05-03 02:29:13 +02001413 return len;
1414}
1415
John Ogness896fbe22020-07-09 15:29:44 +02061416static size_t get_record_print_text_size(struct printk_info *info,
1417 unsigned int line_count,
1418 bool syslog, bool time)
1419{
1420 char prefix[PREFIX_MAX];
1421 size_t prefix_len;
1422
1423 prefix_len = info_print_prefix(info, syslog, time, prefix);
1424
1425 /*
1426 * Each line will be preceded with a prefix. The intermediate
1427 * newlines are already within the text, but a final trailing
1428 * newline will be added.
1429 */
1430 return ((prefix_len * line_count) + info->text_len + 1);
1431}
1432
John Ogness4260e0e552021-03-03 11:15:19 +01001433/*
1434 * Beginning with @start_seq, find the first record where it and all following
1435 * records up to (but not including) @max_seq fit into @size.
1436 *
1437 * @max_seq is simply an upper bound and does not need to exist. If the caller
1438 * does not require an upper bound, -1 can be used for @max_seq.
1439 */
1440static u64 find_first_fitting_seq(u64 start_seq, u64 max_seq, size_t size,
1441 bool syslog, bool time)
1442{
1443 struct printk_info info;
1444 unsigned int line_count;
1445 size_t len = 0;
1446 u64 seq;
1447
1448 /* Determine the size of the records up to @max_seq. */
1449 prb_for_each_info(start_seq, prb, seq, &info, &line_count) {
1450 if (info.seq >= max_seq)
1451 break;
1452 len += get_record_print_text_size(&info, line_count, syslog, time);
1453 }
1454
1455 /*
1456 * Adjust the upper bound for the next loop to avoid subtracting
1457 * lengths that were never added.
1458 */
1459 if (seq < max_seq)
1460 max_seq = seq;
1461
1462 /*
1463 * Move first record forward until length fits into the buffer. Ignore
1464 * newest messages that were not counted in the above cycle. Messages
1465 * might appear and get lost in the meantime. This is a best effort
1466 * that prevents an infinite loop that could occur with a retry.
1467 */
1468 prb_for_each_info(start_seq, prb, seq, &info, &line_count) {
1469 if (len <= size || info.seq >= max_seq)
1470 break;
1471 len -= get_record_print_text_size(&info, line_count, syslog, time);
1472 }
1473
1474 return seq;
1475}
1476
John Ogness8d909b22021-07-15 21:39:59 +02061477/* The caller is responsible for making sure @size is greater than 0. */
Kay Sievers7ff95542012-05-03 02:29:13 +02001478static int syslog_print(char __user *buf, int size)
1479{
John Ogness896fbe22020-07-09 15:29:44 +02061480 struct printk_info info;
1481 struct printk_record r;
Kay Sievers7ff95542012-05-03 02:29:13 +02001482 char *text;
Jan Beulich116e90b2012-06-22 16:36:09 +01001483 int len = 0;
John Ogness8d909b22021-07-15 21:39:59 +02061484 u64 seq;
Kay Sievers7ff95542012-05-03 02:29:13 +02001485
John Ognesscf5b0202021-03-03 11:15:20 +01001486 text = kmalloc(CONSOLE_LOG_MAX, GFP_KERNEL);
Kay Sievers7ff95542012-05-03 02:29:13 +02001487 if (!text)
1488 return -ENOMEM;
1489
John Ognesscf5b0202021-03-03 11:15:20 +01001490 prb_rec_init_rd(&r, &info, text, CONSOLE_LOG_MAX);
John Ogness896fbe22020-07-09 15:29:44 +02061491
John Ogness8d909b22021-07-15 21:39:59 +02061492 mutex_lock(&syslog_lock);
1493
1494 /*
1495 * Wait for the @syslog_seq record to be available. @syslog_seq may
1496 * change while waiting.
1497 */
1498 do {
1499 seq = syslog_seq;
1500
1501 mutex_unlock(&syslog_lock);
1502 len = wait_event_interruptible(log_wait, prb_read_valid(prb, seq, NULL));
1503 mutex_lock(&syslog_lock);
1504
1505 if (len)
1506 goto out;
1507 } while (syslog_seq != seq);
1508
1509 /*
1510 * Copy records that fit into the buffer. The above cycle makes sure
1511 * that the first record is always available.
1512 */
1513 do {
Jan Beulich116e90b2012-06-22 16:36:09 +01001514 size_t n;
Kay Sieverseb02dac2012-07-09 10:05:10 -07001515 size_t skip;
John Ogness8d909b22021-07-15 21:39:59 +02061516 int err;
Kay Sievers7ff95542012-05-03 02:29:13 +02001517
John Ogness8d909b22021-07-15 21:39:59 +02061518 if (!prb_read_valid(prb, syslog_seq, &r))
Jan Beulich116e90b2012-06-22 16:36:09 +01001519 break;
John Ogness8d909b22021-07-15 21:39:59 +02061520
John Ogness896fbe22020-07-09 15:29:44 +02061521 if (r.info->seq != syslog_seq) {
1522 /* message is gone, move to next valid one */
1523 syslog_seq = r.info->seq;
1524 syslog_partial = 0;
1525 }
Kay Sieverseb02dac2012-07-09 10:05:10 -07001526
Tetsuo Handae80c1a92018-12-04 19:00:01 +09001527 /*
1528 * To keep reading/counting partial line consistent,
1529 * use printk_time value as of the beginning of a line.
1530 */
1531 if (!syslog_partial)
1532 syslog_time = printk_time;
1533
Kay Sieverseb02dac2012-07-09 10:05:10 -07001534 skip = syslog_partial;
John Ogness896fbe22020-07-09 15:29:44 +02061535 n = record_print_text(&r, true, syslog_time);
Kay Sieverseb02dac2012-07-09 10:05:10 -07001536 if (n - syslog_partial <= size) {
1537 /* message fits into buffer, move forward */
John Ogness896fbe22020-07-09 15:29:44 +02061538 syslog_seq = r.info->seq + 1;
Kay Sieverseb02dac2012-07-09 10:05:10 -07001539 n -= syslog_partial;
1540 syslog_partial = 0;
1541 } else if (!len){
1542 /* partial read(), remember position */
1543 n = size;
1544 syslog_partial += n;
Jan Beulich116e90b2012-06-22 16:36:09 +01001545 } else
1546 n = 0;
Jan Beulich116e90b2012-06-22 16:36:09 +01001547
1548 if (!n)
1549 break;
1550
John Ogness8d909b22021-07-15 21:39:59 +02061551 mutex_unlock(&syslog_lock);
1552 err = copy_to_user(buf, text + skip, n);
1553 mutex_lock(&syslog_lock);
1554
1555 if (err) {
Jan Beulich116e90b2012-06-22 16:36:09 +01001556 if (!len)
1557 len = -EFAULT;
1558 break;
1559 }
Kay Sieverseb02dac2012-07-09 10:05:10 -07001560
1561 len += n;
1562 size -= n;
1563 buf += n;
John Ogness8d909b22021-07-15 21:39:59 +02061564 } while (size);
1565out:
1566 mutex_unlock(&syslog_lock);
Kay Sievers7ff95542012-05-03 02:29:13 +02001567 kfree(text);
1568 return len;
1569}
1570
1571static int syslog_print_all(char __user *buf, int size, bool clear)
1572{
John Ogness896fbe22020-07-09 15:29:44 +02061573 struct printk_info info;
John Ogness896fbe22020-07-09 15:29:44 +02061574 struct printk_record r;
Kay Sievers7ff95542012-05-03 02:29:13 +02001575 char *text;
1576 int len = 0;
Namit Gupta63842c22018-06-20 19:26:19 +05301577 u64 seq;
Tetsuo Handae80c1a92018-12-04 19:00:01 +09001578 bool time;
Namit Gupta63842c22018-06-20 19:26:19 +05301579
John Ognesscf5b0202021-03-03 11:15:20 +01001580 text = kmalloc(CONSOLE_LOG_MAX, GFP_KERNEL);
Kay Sievers7ff95542012-05-03 02:29:13 +02001581 if (!text)
1582 return -ENOMEM;
1583
Tetsuo Handae80c1a92018-12-04 19:00:01 +09001584 time = printk_time;
Namit Gupta63842c22018-06-20 19:26:19 +05301585 /*
1586 * Find first record that fits, including all following records,
1587 * into the user-provided buffer for this dump.
1588 */
John Ogness7d7a23a2021-03-03 11:15:21 +01001589 seq = find_first_fitting_seq(latched_seq_read_nolock(&clear_seq), -1,
1590 size, true, time);
Namit Gupta63842c22018-06-20 19:26:19 +05301591
John Ognesscf5b0202021-03-03 11:15:20 +01001592 prb_rec_init_rd(&r, &info, text, CONSOLE_LOG_MAX);
Namit Gupta63842c22018-06-20 19:26:19 +05301593
1594 len = 0;
John Ogness896fbe22020-07-09 15:29:44 +02061595 prb_for_each_record(seq, prb, seq, &r) {
1596 int textlen;
Namit Gupta63842c22018-06-20 19:26:19 +05301597
John Ogness896fbe22020-07-09 15:29:44 +02061598 textlen = record_print_text(&r, true, time);
1599
1600 if (len + textlen > size) {
1601 seq--;
1602 break;
1603 }
Kay Sieverse2ae7152012-06-15 14:07:51 +02001604
Namit Gupta63842c22018-06-20 19:26:19 +05301605 if (copy_to_user(buf + len, text, textlen))
1606 len = -EFAULT;
1607 else
1608 len += textlen;
Kay Sievers3ce9a7c2012-05-13 23:30:46 +02001609
John Ogness896fbe22020-07-09 15:29:44 +02061610 if (len < 0)
1611 break;
Kay Sievers7ff95542012-05-03 02:29:13 +02001612 }
1613
John Ogness636babd2021-03-03 11:15:23 +01001614 if (clear) {
John Ognessb371cbb2021-07-15 21:39:58 +02061615 mutex_lock(&syslog_lock);
John Ogness7d7a23a2021-03-03 11:15:21 +01001616 latched_seq_write(&clear_seq, seq);
John Ognessb371cbb2021-07-15 21:39:58 +02061617 mutex_unlock(&syslog_lock);
John Ogness636babd2021-03-03 11:15:23 +01001618 }
Kay Sievers7ff95542012-05-03 02:29:13 +02001619
1620 kfree(text);
1621 return len;
1622}
1623
Petr Mladek8599dc72018-06-27 17:06:41 +02001624static void syslog_clear(void)
1625{
John Ognessb371cbb2021-07-15 21:39:58 +02061626 mutex_lock(&syslog_lock);
John Ogness7d7a23a2021-03-03 11:15:21 +01001627 latched_seq_write(&clear_seq, prb_next_seq(prb));
John Ognessb371cbb2021-07-15 21:39:58 +02061628 mutex_unlock(&syslog_lock);
John Ogness636babd2021-03-03 11:15:23 +01001629}
1630
Vasily Averin3ea43312015-06-25 15:01:47 -07001631int do_syslog(int type, char __user *buf, int len, int source)
Linus Torvalds1da177e2005-04-16 15:20:36 -07001632{
John Ogness13791c82021-02-11 18:37:52 +01061633 struct printk_info info;
Kay Sievers7ff95542012-05-03 02:29:13 +02001634 bool clear = false;
Joe Perchesa39d4a82014-12-10 15:50:15 -08001635 static int saved_console_loglevel = LOGLEVEL_DEFAULT;
Linus Torvaldsee24aeb2011-02-10 17:53:55 -08001636 int error;
Linus Torvalds1da177e2005-04-16 15:20:36 -07001637
Vasily Averin3ea43312015-06-25 15:01:47 -07001638 error = check_syslog_permissions(type, source);
Linus Torvaldsee24aeb2011-02-10 17:53:55 -08001639 if (error)
Nikitas Angelinas077a1cc2017-07-29 20:36:36 -07001640 return error;
Eric Paris12b30522010-11-15 18:36:29 -05001641
Linus Torvalds1da177e2005-04-16 15:20:36 -07001642 switch (type) {
Kees Cookd78ca3c2010-02-03 15:37:13 -08001643 case SYSLOG_ACTION_CLOSE: /* Close log */
Linus Torvalds1da177e2005-04-16 15:20:36 -07001644 break;
Kees Cookd78ca3c2010-02-03 15:37:13 -08001645 case SYSLOG_ACTION_OPEN: /* Open log */
Linus Torvalds1da177e2005-04-16 15:20:36 -07001646 break;
Kees Cookd78ca3c2010-02-03 15:37:13 -08001647 case SYSLOG_ACTION_READ: /* Read from log */
Linus Torvalds1da177e2005-04-16 15:20:36 -07001648 if (!buf || len < 0)
Nikitas Angelinas077a1cc2017-07-29 20:36:36 -07001649 return -EINVAL;
Linus Torvalds1da177e2005-04-16 15:20:36 -07001650 if (!len)
Nikitas Angelinas077a1cc2017-07-29 20:36:36 -07001651 return 0;
Linus Torvalds96d4f262019-01-03 18:57:57 -08001652 if (!access_ok(buf, len))
Nikitas Angelinas077a1cc2017-07-29 20:36:36 -07001653 return -EFAULT;
Kay Sievers7ff95542012-05-03 02:29:13 +02001654 error = syslog_print(buf, len);
Linus Torvalds1da177e2005-04-16 15:20:36 -07001655 break;
Kees Cookd78ca3c2010-02-03 15:37:13 -08001656 /* Read/clear last kernel messages */
1657 case SYSLOG_ACTION_READ_CLEAR:
Kay Sievers7ff95542012-05-03 02:29:13 +02001658 clear = true;
Gustavo A. R. Silva4e797e62020-10-02 17:46:27 -05001659 fallthrough;
Kees Cookd78ca3c2010-02-03 15:37:13 -08001660 /* Read last kernel messages */
1661 case SYSLOG_ACTION_READ_ALL:
Linus Torvalds1da177e2005-04-16 15:20:36 -07001662 if (!buf || len < 0)
Nikitas Angelinas077a1cc2017-07-29 20:36:36 -07001663 return -EINVAL;
Linus Torvalds1da177e2005-04-16 15:20:36 -07001664 if (!len)
Nikitas Angelinas077a1cc2017-07-29 20:36:36 -07001665 return 0;
Linus Torvalds96d4f262019-01-03 18:57:57 -08001666 if (!access_ok(buf, len))
Nikitas Angelinas077a1cc2017-07-29 20:36:36 -07001667 return -EFAULT;
Kay Sievers7ff95542012-05-03 02:29:13 +02001668 error = syslog_print_all(buf, len, clear);
Linus Torvalds1da177e2005-04-16 15:20:36 -07001669 break;
Kees Cookd78ca3c2010-02-03 15:37:13 -08001670 /* Clear ring buffer */
1671 case SYSLOG_ACTION_CLEAR:
Petr Mladek8599dc72018-06-27 17:06:41 +02001672 syslog_clear();
Alan Stern4661e352012-06-22 17:12:19 -04001673 break;
Kees Cookd78ca3c2010-02-03 15:37:13 -08001674 /* Disable logging to console */
1675 case SYSLOG_ACTION_CONSOLE_OFF:
Joe Perchesa39d4a82014-12-10 15:50:15 -08001676 if (saved_console_loglevel == LOGLEVEL_DEFAULT)
Frans Pop1aaad492009-07-06 13:31:48 +02001677 saved_console_loglevel = console_loglevel;
Linus Torvalds1da177e2005-04-16 15:20:36 -07001678 console_loglevel = minimum_console_loglevel;
1679 break;
Kees Cookd78ca3c2010-02-03 15:37:13 -08001680 /* Enable logging to console */
1681 case SYSLOG_ACTION_CONSOLE_ON:
Joe Perchesa39d4a82014-12-10 15:50:15 -08001682 if (saved_console_loglevel != LOGLEVEL_DEFAULT) {
Frans Pop1aaad492009-07-06 13:31:48 +02001683 console_loglevel = saved_console_loglevel;
Joe Perchesa39d4a82014-12-10 15:50:15 -08001684 saved_console_loglevel = LOGLEVEL_DEFAULT;
Frans Pop1aaad492009-07-06 13:31:48 +02001685 }
Linus Torvalds1da177e2005-04-16 15:20:36 -07001686 break;
Kees Cookd78ca3c2010-02-03 15:37:13 -08001687 /* Set level of messages printed to console */
1688 case SYSLOG_ACTION_CONSOLE_LEVEL:
Linus Torvalds1da177e2005-04-16 15:20:36 -07001689 if (len < 1 || len > 8)
Nikitas Angelinas077a1cc2017-07-29 20:36:36 -07001690 return -EINVAL;
Linus Torvalds1da177e2005-04-16 15:20:36 -07001691 if (len < minimum_console_loglevel)
1692 len = minimum_console_loglevel;
1693 console_loglevel = len;
Frans Pop1aaad492009-07-06 13:31:48 +02001694 /* Implicitly re-enable logging to console */
Joe Perchesa39d4a82014-12-10 15:50:15 -08001695 saved_console_loglevel = LOGLEVEL_DEFAULT;
Linus Torvalds1da177e2005-04-16 15:20:36 -07001696 break;
Kees Cookd78ca3c2010-02-03 15:37:13 -08001697 /* Number of chars in the log buffer */
1698 case SYSLOG_ACTION_SIZE_UNREAD:
John Ognessb371cbb2021-07-15 21:39:58 +02061699 mutex_lock(&syslog_lock);
John Ogness13791c82021-02-11 18:37:52 +01061700 if (!prb_read_valid_info(prb, syslog_seq, &info, NULL)) {
1701 /* No unread messages. */
John Ognessb371cbb2021-07-15 21:39:58 +02061702 mutex_unlock(&syslog_lock);
John Ogness13791c82021-02-11 18:37:52 +01061703 return 0;
1704 }
1705 if (info.seq != syslog_seq) {
Kay Sievers7ff95542012-05-03 02:29:13 +02001706 /* messages are gone, move to first one */
John Ogness13791c82021-02-11 18:37:52 +01061707 syslog_seq = info.seq;
Kay Sieverseb02dac2012-07-09 10:05:10 -07001708 syslog_partial = 0;
Kay Sievers7ff95542012-05-03 02:29:13 +02001709 }
Vasily Averin3ea43312015-06-25 15:01:47 -07001710 if (source == SYSLOG_FROM_PROC) {
Kay Sievers7ff95542012-05-03 02:29:13 +02001711 /*
1712 * Short-cut for poll(/"proc/kmsg") which simply checks
1713 * for pending data, not the size; return the count of
1714 * records, not the length.
1715 */
John Ogness896fbe22020-07-09 15:29:44 +02061716 error = prb_next_seq(prb) - syslog_seq;
Kay Sievers7ff95542012-05-03 02:29:13 +02001717 } else {
Tetsuo Handae80c1a92018-12-04 19:00:01 +09001718 bool time = syslog_partial ? syslog_time : printk_time;
John Ogness896fbe22020-07-09 15:29:44 +02061719 unsigned int line_count;
1720 u64 seq;
Kay Sievers7ff95542012-05-03 02:29:13 +02001721
John Ogness896fbe22020-07-09 15:29:44 +02061722 prb_for_each_info(syslog_seq, prb, seq, &info,
1723 &line_count) {
1724 error += get_record_print_text_size(&info, line_count,
1725 true, time);
Tetsuo Handae80c1a92018-12-04 19:00:01 +09001726 time = printk_time;
Kay Sievers7ff95542012-05-03 02:29:13 +02001727 }
Kay Sieverseb02dac2012-07-09 10:05:10 -07001728 error -= syslog_partial;
Kay Sievers7ff95542012-05-03 02:29:13 +02001729 }
John Ognessb371cbb2021-07-15 21:39:58 +02061730 mutex_unlock(&syslog_lock);
Linus Torvalds1da177e2005-04-16 15:20:36 -07001731 break;
Kees Cookd78ca3c2010-02-03 15:37:13 -08001732 /* Size of the log buffer */
1733 case SYSLOG_ACTION_SIZE_BUFFER:
Linus Torvalds1da177e2005-04-16 15:20:36 -07001734 error = log_buf_len;
1735 break;
1736 default:
1737 error = -EINVAL;
1738 break;
1739 }
Nikitas Angelinas077a1cc2017-07-29 20:36:36 -07001740
Linus Torvalds1da177e2005-04-16 15:20:36 -07001741 return error;
1742}
1743
Heiko Carstens1e7bfb22009-01-14 14:14:29 +01001744SYSCALL_DEFINE3(syslog, int, type, char __user *, buf, int, len)
Linus Torvalds1da177e2005-04-16 15:20:36 -07001745{
Kees Cook637241a2013-06-12 14:04:39 -07001746 return do_syslog(type, buf, len, SYSLOG_FROM_READER);
Linus Torvalds1da177e2005-04-16 15:20:36 -07001747}
1748
Linus Torvalds1da177e2005-04-16 15:20:36 -07001749/*
Petr Mladekc162d5b2018-01-12 17:08:37 +01001750 * Special console_lock variants that help to reduce the risk of soft-lockups.
1751 * They allow to pass console_lock to another printk() call using a busy wait.
1752 */
1753
1754#ifdef CONFIG_LOCKDEP
1755static struct lockdep_map console_owner_dep_map = {
1756 .name = "console_owner"
1757};
1758#endif
1759
1760static DEFINE_RAW_SPINLOCK(console_owner_lock);
1761static struct task_struct *console_owner;
1762static bool console_waiter;
1763
1764/**
1765 * console_lock_spinning_enable - mark beginning of code where another
1766 * thread might safely busy wait
1767 *
1768 * This basically converts console_lock into a spinlock. This marks
1769 * the section where the console_lock owner can not sleep, because
1770 * there may be a waiter spinning (like a spinlock). Also it must be
1771 * ready to hand over the lock at the end of the section.
1772 */
1773static void console_lock_spinning_enable(void)
1774{
1775 raw_spin_lock(&console_owner_lock);
1776 console_owner = current;
1777 raw_spin_unlock(&console_owner_lock);
1778
1779 /* The waiter may spin on us after setting console_owner */
1780 spin_acquire(&console_owner_dep_map, 0, 0, _THIS_IP_);
1781}
1782
1783/**
1784 * console_lock_spinning_disable_and_check - mark end of code where another
1785 * thread was able to busy wait and check if there is a waiter
1786 *
1787 * This is called at the end of the section where spinning is allowed.
1788 * It has two functions. First, it is a signal that it is no longer
1789 * safe to start busy waiting for the lock. Second, it checks if
1790 * there is a busy waiter and passes the lock rights to her.
1791 *
1792 * Important: Callers lose the lock if there was a busy waiter.
1793 * They must not touch items synchronized by console_lock
1794 * in this case.
1795 *
1796 * Return: 1 if the lock rights were passed, 0 otherwise.
1797 */
1798static int console_lock_spinning_disable_and_check(void)
1799{
1800 int waiter;
1801
1802 raw_spin_lock(&console_owner_lock);
1803 waiter = READ_ONCE(console_waiter);
1804 console_owner = NULL;
1805 raw_spin_unlock(&console_owner_lock);
1806
1807 if (!waiter) {
Qian Cai5facae42019-09-19 12:09:40 -04001808 spin_release(&console_owner_dep_map, _THIS_IP_);
Petr Mladekc162d5b2018-01-12 17:08:37 +01001809 return 0;
1810 }
1811
1812 /* The waiter is now free to continue */
1813 WRITE_ONCE(console_waiter, false);
1814
Qian Cai5facae42019-09-19 12:09:40 -04001815 spin_release(&console_owner_dep_map, _THIS_IP_);
Petr Mladekc162d5b2018-01-12 17:08:37 +01001816
1817 /*
1818 * Hand off console_lock to waiter. The waiter will perform
1819 * the up(). After this, the waiter is the console_lock owner.
1820 */
Qian Cai5facae42019-09-19 12:09:40 -04001821 mutex_release(&console_lock_dep_map, _THIS_IP_);
Petr Mladekc162d5b2018-01-12 17:08:37 +01001822 return 1;
1823}
1824
1825/**
1826 * console_trylock_spinning - try to get console_lock by busy waiting
1827 *
1828 * This allows to busy wait for the console_lock when the current
1829 * owner is running in specially marked sections. It means that
1830 * the current owner is running and cannot reschedule until it
1831 * is ready to lose the lock.
1832 *
1833 * Return: 1 if we got the lock, 0 othrewise
1834 */
1835static int console_trylock_spinning(void)
1836{
1837 struct task_struct *owner = NULL;
1838 bool waiter;
1839 bool spin = false;
1840 unsigned long flags;
1841
1842 if (console_trylock())
1843 return 1;
1844
1845 printk_safe_enter_irqsave(flags);
1846
1847 raw_spin_lock(&console_owner_lock);
1848 owner = READ_ONCE(console_owner);
1849 waiter = READ_ONCE(console_waiter);
1850 if (!waiter && owner && owner != current) {
1851 WRITE_ONCE(console_waiter, true);
1852 spin = true;
1853 }
1854 raw_spin_unlock(&console_owner_lock);
1855
1856 /*
1857 * If there is an active printk() writing to the
1858 * consoles, instead of having it write our data too,
1859 * see if we can offload that load from the active
1860 * printer, and do some printing ourselves.
1861 * Go into a spin only if there isn't already a waiter
1862 * spinning, and there is an active printer, and
1863 * that active printer isn't us (recursive printk?).
1864 */
1865 if (!spin) {
1866 printk_safe_exit_irqrestore(flags);
1867 return 0;
1868 }
1869
1870 /* We spin waiting for the owner to release us */
1871 spin_acquire(&console_owner_dep_map, 0, 0, _THIS_IP_);
1872 /* Owner will clear console_waiter on hand off */
1873 while (READ_ONCE(console_waiter))
1874 cpu_relax();
Qian Cai5facae42019-09-19 12:09:40 -04001875 spin_release(&console_owner_dep_map, _THIS_IP_);
Petr Mladekc162d5b2018-01-12 17:08:37 +01001876
1877 printk_safe_exit_irqrestore(flags);
1878 /*
1879 * The owner passed the console lock to us.
1880 * Since we did not spin on console lock, annotate
1881 * this as a trylock. Otherwise lockdep will
1882 * complain.
1883 */
1884 mutex_acquire(&console_lock_dep_map, 0, 1, _THIS_IP_);
1885
1886 return 1;
1887}
1888
1889/*
Linus Torvalds1da177e2005-04-16 15:20:36 -07001890 * Call the console drivers, asking them to write out
1891 * log_buf[start] to log_buf[end - 1].
Torben Hohnac751ef2011-01-25 15:07:35 -08001892 * The console_lock must be held.
Linus Torvalds1da177e2005-04-16 15:20:36 -07001893 */
Sergey Senozhatskyd9c23522016-12-24 23:09:01 +09001894static void call_console_drivers(const char *ext_text, size_t ext_len,
Tejun Heo6fe29352015-06-25 15:01:30 -07001895 const char *text, size_t len)
Linus Torvalds1da177e2005-04-16 15:20:36 -07001896{
John Ogness896fbe22020-07-09 15:29:44 +02061897 static char dropped_text[64];
1898 size_t dropped_len = 0;
Kay Sievers7ff95542012-05-03 02:29:13 +02001899 struct console *con;
Linus Torvalds1da177e2005-04-16 15:20:36 -07001900
Sergey Senozhatskyfc98c3c2017-02-18 03:42:54 -08001901 trace_console_rcuidle(text, len);
Linus Torvalds1da177e2005-04-16 15:20:36 -07001902
John Ogness896fbe22020-07-09 15:29:44 +02061903 if (!console_drivers)
1904 return;
1905
1906 if (console_dropped) {
1907 dropped_len = snprintf(dropped_text, sizeof(dropped_text),
1908 "** %lu printk messages dropped **\n",
1909 console_dropped);
1910 console_dropped = 0;
1911 }
1912
Kay Sievers7ff95542012-05-03 02:29:13 +02001913 for_each_console(con) {
1914 if (exclusive_console && con != exclusive_console)
1915 continue;
1916 if (!(con->flags & CON_ENABLED))
1917 continue;
1918 if (!con->write)
1919 continue;
1920 if (!cpu_online(smp_processor_id()) &&
1921 !(con->flags & CON_ANYTIME))
1922 continue;
Tejun Heo6fe29352015-06-25 15:01:30 -07001923 if (con->flags & CON_EXTENDED)
1924 con->write(con, ext_text, ext_len);
John Ogness896fbe22020-07-09 15:29:44 +02061925 else {
1926 if (dropped_len)
1927 con->write(con, dropped_text, dropped_len);
Tejun Heo6fe29352015-06-25 15:01:30 -07001928 con->write(con, text, len);
John Ogness896fbe22020-07-09 15:29:44 +02061929 }
Linus Torvalds1da177e2005-04-16 15:20:36 -07001930 }
Linus Torvalds1da177e2005-04-16 15:20:36 -07001931}
1932
John Ogness002eb6a2021-07-15 21:39:55 +02061933/*
1934 * Recursion is tracked separately on each CPU. If NMIs are supported, an
1935 * additional NMI context per CPU is also separately tracked. Until per-CPU
1936 * is available, a separate "early tracking" is performed.
1937 */
1938static DEFINE_PER_CPU(u8, printk_count);
1939static u8 printk_count_early;
1940#ifdef CONFIG_HAVE_NMI
1941static DEFINE_PER_CPU(u8, printk_count_nmi);
1942static u8 printk_count_nmi_early;
1943#endif
1944
1945/*
1946 * Recursion is limited to keep the output sane. printk() should not require
1947 * more than 1 level of recursion (allowing, for example, printk() to trigger
1948 * a WARN), but a higher value is used in case some printk-internal errors
1949 * exist, such as the ringbuffer validation checks failing.
1950 */
1951#define PRINTK_MAX_RECURSION 3
1952
1953/*
1954 * Return a pointer to the dedicated counter for the CPU+context of the
1955 * caller.
1956 */
1957static u8 *__printk_recursion_counter(void)
1958{
1959#ifdef CONFIG_HAVE_NMI
1960 if (in_nmi()) {
1961 if (printk_percpu_data_ready())
1962 return this_cpu_ptr(&printk_count_nmi);
1963 return &printk_count_nmi_early;
1964 }
1965#endif
1966 if (printk_percpu_data_ready())
1967 return this_cpu_ptr(&printk_count);
1968 return &printk_count_early;
1969}
1970
1971/*
1972 * Enter recursion tracking. Interrupts are disabled to simplify tracking.
1973 * The caller must check the boolean return value to see if the recursion is
1974 * allowed. On failure, interrupts are not disabled.
1975 *
1976 * @recursion_ptr must be a variable of type (u8 *) and is the same variable
1977 * that is passed to printk_exit_irqrestore().
1978 */
1979#define printk_enter_irqsave(recursion_ptr, flags) \
1980({ \
1981 bool success = true; \
1982 \
1983 typecheck(u8 *, recursion_ptr); \
1984 local_irq_save(flags); \
1985 (recursion_ptr) = __printk_recursion_counter(); \
1986 if (*(recursion_ptr) > PRINTK_MAX_RECURSION) { \
1987 local_irq_restore(flags); \
1988 success = false; \
1989 } else { \
1990 (*(recursion_ptr))++; \
1991 } \
1992 success; \
1993})
1994
1995/* Exit recursion tracking, restoring interrupts. */
1996#define printk_exit_irqrestore(recursion_ptr, flags) \
1997 do { \
1998 typecheck(u8 *, recursion_ptr); \
1999 (*(recursion_ptr))--; \
2000 local_irq_restore(flags); \
2001 } while (0)
2002
Dave Youngaf913222009-09-22 16:43:33 -07002003int printk_delay_msec __read_mostly;
2004
2005static inline void printk_delay(void)
2006{
2007 if (unlikely(printk_delay_msec)) {
2008 int m = printk_delay_msec;
2009
2010 while (m--) {
2011 mdelay(1);
2012 touch_nmi_watchdog();
2013 }
2014 }
2015}
2016
Tetsuo Handacbae05d2019-02-16 19:59:33 +09002017static inline u32 printk_caller_id(void)
2018{
2019 return in_task() ? task_pid_nr(current) :
2020 0x80000000 + raw_smp_processor_id();
2021}
2022
John Ognessb031a682020-12-09 01:50:53 +01062023/**
Chris Downf3d75cf2021-06-15 17:52:51 +01002024 * printk_parse_prefix - Parse level and control flags.
John Ognessb031a682020-12-09 01:50:53 +01062025 *
2026 * @text: The terminated text message.
2027 * @level: A pointer to the current level value, will be updated.
Chris Downa1ad4b82021-06-15 17:52:48 +01002028 * @flags: A pointer to the current printk_info flags, will be updated.
John Ognessb031a682020-12-09 01:50:53 +01062029 *
2030 * @level may be NULL if the caller is not interested in the parsed value.
2031 * Otherwise the variable pointed to by @level must be set to
2032 * LOGLEVEL_DEFAULT in order to be updated with the parsed value.
2033 *
Chris Downa1ad4b82021-06-15 17:52:48 +01002034 * @flags may be NULL if the caller is not interested in the parsed value.
2035 * Otherwise the variable pointed to by @flags will be OR'd with the parsed
John Ognessb031a682020-12-09 01:50:53 +01062036 * value.
2037 *
2038 * Return: The length of the parsed level and control flags.
2039 */
Chris Downf3d75cf2021-06-15 17:52:51 +01002040u16 printk_parse_prefix(const char *text, int *level,
Chris Downa1ad4b82021-06-15 17:52:48 +01002041 enum printk_info_flags *flags)
Linus Torvaldsc362c7f2016-10-08 22:02:09 -07002042{
John Ognessb031a682020-12-09 01:50:53 +01062043 u16 prefix_len = 0;
2044 int kern_level;
Tetsuo Handacbae05d2019-02-16 19:59:33 +09002045
John Ognessb031a682020-12-09 01:50:53 +01062046 while (*text) {
2047 kern_level = printk_get_level(text);
2048 if (!kern_level)
2049 break;
Linus Torvaldsc362c7f2016-10-08 22:02:09 -07002050
John Ognessb031a682020-12-09 01:50:53 +01062051 switch (kern_level) {
2052 case '0' ... '7':
2053 if (level && *level == LOGLEVEL_DEFAULT)
2054 *level = kern_level - '0';
2055 break;
2056 case 'c': /* KERN_CONT */
Chris Downa1ad4b82021-06-15 17:52:48 +01002057 if (flags)
2058 *flags |= LOG_CONT;
John Ognessb031a682020-12-09 01:50:53 +01062059 }
2060
2061 prefix_len += 2;
2062 text += 2;
2063 }
2064
2065 return prefix_len;
2066}
2067
John Ogness264a7502021-09-27 16:28:03 +02062068__printf(5, 0)
Chris Downa1ad4b82021-06-15 17:52:48 +01002069static u16 printk_sprint(char *text, u16 size, int facility,
2070 enum printk_info_flags *flags, const char *fmt,
2071 va_list args)
John Ognessb031a682020-12-09 01:50:53 +01062072{
2073 u16 text_len;
2074
2075 text_len = vscnprintf(text, size, fmt, args);
2076
2077 /* Mark and strip a trailing newline. */
2078 if (text_len && text[text_len - 1] == '\n') {
2079 text_len--;
Chris Downa1ad4b82021-06-15 17:52:48 +01002080 *flags |= LOG_NEWLINE;
John Ognessb031a682020-12-09 01:50:53 +01062081 }
2082
2083 /* Strip log level and control flags. */
2084 if (facility == 0) {
2085 u16 prefix_len;
2086
Chris Downf3d75cf2021-06-15 17:52:51 +01002087 prefix_len = printk_parse_prefix(text, NULL, NULL);
John Ognessb031a682020-12-09 01:50:53 +01062088 if (prefix_len) {
2089 text_len -= prefix_len;
2090 memmove(text, text + prefix_len, text_len);
John Ognessf5f022e2020-09-14 14:39:54 +02062091 }
Linus Torvaldsc362c7f2016-10-08 22:02:09 -07002092 }
2093
John Ognessb031a682020-12-09 01:50:53 +01062094 return text_len;
Linus Torvaldsc362c7f2016-10-08 22:02:09 -07002095}
2096
John Ognessb031a682020-12-09 01:50:53 +01062097__printf(4, 0)
Petr Mladekba552392018-06-27 16:08:15 +02002098int vprintk_store(int facility, int level,
John Ogness74caba72020-09-21 13:24:45 +02062099 const struct dev_printk_info *dev_info,
Petr Mladekba552392018-06-27 16:08:15 +02002100 const char *fmt, va_list args)
Linus Torvalds1da177e2005-04-16 15:20:36 -07002101{
John Ogness6b916702020-12-09 01:50:52 +01062102 const u32 caller_id = printk_caller_id();
John Ogness6b916702020-12-09 01:50:52 +01062103 struct prb_reserved_entry e;
Chris Downa1ad4b82021-06-15 17:52:48 +01002104 enum printk_info_flags flags = 0;
John Ogness6b916702020-12-09 01:50:52 +01062105 struct printk_record r;
John Ogness002eb6a2021-07-15 21:39:55 +02062106 unsigned long irqflags;
John Ogness6b916702020-12-09 01:50:52 +01062107 u16 trunc_msg_len = 0;
John Ognessb031a682020-12-09 01:50:53 +01062108 char prefix_buf[8];
John Ogness002eb6a2021-07-15 21:39:55 +02062109 u8 *recursion_ptr;
John Ognessb031a682020-12-09 01:50:53 +01062110 u16 reserve_size;
2111 va_list args2;
John Ogness6b916702020-12-09 01:50:52 +01062112 u16 text_len;
John Ogness002eb6a2021-07-15 21:39:55 +02062113 int ret = 0;
John Ogness6b916702020-12-09 01:50:52 +01062114 u64 ts_nsec;
Jan Kara608873c2014-06-04 16:11:35 -07002115
Linus Torvalds1da177e2005-04-16 15:20:36 -07002116 /*
John Ogness6b916702020-12-09 01:50:52 +01062117 * Since the duration of printk() can vary depending on the message
2118 * and state of the ringbuffer, grab the timestamp now so that it is
2119 * close to the call of printk(). This provides a more deterministic
2120 * timestamp with respect to the caller.
Linus Torvalds1da177e2005-04-16 15:20:36 -07002121 */
John Ogness6b916702020-12-09 01:50:52 +01062122 ts_nsec = local_clock();
Nick Andrewac60ad72008-05-12 21:21:04 +02002123
John Ogness002eb6a2021-07-15 21:39:55 +02062124 if (!printk_enter_irqsave(recursion_ptr, irqflags))
2125 return 0;
2126
Linus Torvalds1da177e2005-04-16 15:20:36 -07002127 /*
John Ognessb031a682020-12-09 01:50:53 +01062128 * The sprintf needs to come first since the syslog prefix might be
2129 * passed in as a parameter. An extra byte must be reserved so that
2130 * later the vscnprintf() into the reserved buffer has room for the
2131 * terminating '\0', which is not counted by vsnprintf().
Linus Torvalds1da177e2005-04-16 15:20:36 -07002132 */
John Ognessb031a682020-12-09 01:50:53 +01062133 va_copy(args2, args);
2134 reserve_size = vsnprintf(&prefix_buf[0], sizeof(prefix_buf), fmt, args2) + 1;
2135 va_end(args2);
Kay Sievers9d90c8d2011-03-13 03:19:51 +01002136
John Ognessb031a682020-12-09 01:50:53 +01062137 if (reserve_size > LOG_LINE_MAX)
2138 reserve_size = LOG_LINE_MAX;
Joe Perches088a52a2012-07-30 14:40:19 -07002139
John Ognessb031a682020-12-09 01:50:53 +01062140 /* Extract log level or control flags. */
2141 if (facility == 0)
Chris Downf3d75cf2021-06-15 17:52:51 +01002142 printk_parse_prefix(&prefix_buf[0], &level, &flags);
Nick Andrewac60ad72008-05-12 21:21:04 +02002143
Joe Perchesa39d4a82014-12-10 15:50:15 -08002144 if (level == LOGLEVEL_DEFAULT)
Kay Sieversc313af12012-05-14 20:46:27 +02002145 level = default_message_loglevel;
2146
John Ogness74caba72020-09-21 13:24:45 +02062147 if (dev_info)
Chris Downa1ad4b82021-06-15 17:52:48 +01002148 flags |= LOG_NEWLINE;
Kay Sievers7ff95542012-05-03 02:29:13 +02002149
Chris Downa1ad4b82021-06-15 17:52:48 +01002150 if (flags & LOG_CONT) {
John Ognessb031a682020-12-09 01:50:53 +01062151 prb_rec_init_wr(&r, reserve_size);
John Ogness6b916702020-12-09 01:50:52 +01062152 if (prb_reserve_in_last(&e, prb, &r, caller_id, LOG_LINE_MAX)) {
John Ognessb031a682020-12-09 01:50:53 +01062153 text_len = printk_sprint(&r.text_buf[r.info->text_len], reserve_size,
Chris Downa1ad4b82021-06-15 17:52:48 +01002154 facility, &flags, fmt, args);
John Ogness6b916702020-12-09 01:50:52 +01062155 r.info->text_len += text_len;
2156
Chris Downa1ad4b82021-06-15 17:52:48 +01002157 if (flags & LOG_NEWLINE) {
John Ogness6b916702020-12-09 01:50:52 +01062158 r.info->flags |= LOG_NEWLINE;
2159 prb_final_commit(&e);
2160 } else {
2161 prb_commit(&e);
2162 }
2163
John Ogness002eb6a2021-07-15 21:39:55 +02062164 ret = text_len;
2165 goto out;
John Ogness6b916702020-12-09 01:50:52 +01062166 }
2167 }
2168
2169 /*
2170 * Explicitly initialize the record before every prb_reserve() call.
2171 * prb_reserve_in_last() and prb_reserve() purposely invalidate the
2172 * structure when they fail.
2173 */
John Ognessb031a682020-12-09 01:50:53 +01062174 prb_rec_init_wr(&r, reserve_size);
John Ogness6b916702020-12-09 01:50:52 +01062175 if (!prb_reserve(&e, prb, &r)) {
2176 /* truncate the message if it is too long for empty buffer */
John Ognessb031a682020-12-09 01:50:53 +01062177 truncate_msg(&reserve_size, &trunc_msg_len);
John Ogness6b916702020-12-09 01:50:52 +01062178
John Ognessb031a682020-12-09 01:50:53 +01062179 prb_rec_init_wr(&r, reserve_size + trunc_msg_len);
John Ogness6b916702020-12-09 01:50:52 +01062180 if (!prb_reserve(&e, prb, &r))
John Ogness002eb6a2021-07-15 21:39:55 +02062181 goto out;
John Ogness6b916702020-12-09 01:50:52 +01062182 }
2183
2184 /* fill message */
Chris Downa1ad4b82021-06-15 17:52:48 +01002185 text_len = printk_sprint(&r.text_buf[0], reserve_size, facility, &flags, fmt, args);
John Ogness6b916702020-12-09 01:50:52 +01062186 if (trunc_msg_len)
2187 memcpy(&r.text_buf[text_len], trunc_msg, trunc_msg_len);
2188 r.info->text_len = text_len + trunc_msg_len;
2189 r.info->facility = facility;
2190 r.info->level = level & 7;
Chris Downa1ad4b82021-06-15 17:52:48 +01002191 r.info->flags = flags & 0x1f;
John Ogness6b916702020-12-09 01:50:52 +01062192 r.info->ts_nsec = ts_nsec;
2193 r.info->caller_id = caller_id;
2194 if (dev_info)
2195 memcpy(&r.info->dev_info, dev_info, sizeof(r.info->dev_info));
2196
2197 /* A message without a trailing newline can be continued. */
Chris Downa1ad4b82021-06-15 17:52:48 +01002198 if (!(flags & LOG_NEWLINE))
John Ogness6b916702020-12-09 01:50:52 +01062199 prb_commit(&e);
2200 else
2201 prb_final_commit(&e);
2202
John Ogness002eb6a2021-07-15 21:39:55 +02062203 ret = text_len + trunc_msg_len;
2204out:
2205 printk_exit_irqrestore(recursion_ptr, irqflags);
2206 return ret;
Petr Mladekba552392018-06-27 16:08:15 +02002207}
Linus Torvalds1da177e2005-04-16 15:20:36 -07002208
Petr Mladekba552392018-06-27 16:08:15 +02002209asmlinkage int vprintk_emit(int facility, int level,
John Ogness74caba72020-09-21 13:24:45 +02062210 const struct dev_printk_info *dev_info,
Petr Mladekba552392018-06-27 16:08:15 +02002211 const char *fmt, va_list args)
2212{
2213 int printed_len;
John Ogness8749efc2020-07-09 15:29:43 +02062214 bool in_sched = false;
Petr Mladekba552392018-06-27 16:08:15 +02002215
Feng Tangc39ea0b2019-05-14 15:45:34 -07002216 /* Suppress unimportant messages after panic happens */
2217 if (unlikely(suppress_printk))
2218 return 0;
2219
Petr Mladekba552392018-06-27 16:08:15 +02002220 if (level == LOGLEVEL_SCHED) {
2221 level = LOGLEVEL_DEFAULT;
2222 in_sched = true;
2223 }
2224
2225 boot_delay_msec(level);
2226 printk_delay();
2227
John Ogness74caba72020-09-21 13:24:45 +02062228 printed_len = vprintk_store(facility, level, dev_info, fmt, args);
Jan Kara939f04b2014-06-04 16:11:37 -07002229
Steven Rostedt458df9f2014-06-04 16:11:38 -07002230 /* If called from the scheduler, we can not call up(). */
John Ogness8749efc2020-07-09 15:29:43 +02062231 if (!in_sched) {
Jan Kara5874af22014-08-06 16:09:10 -07002232 /*
Sergey Senozhatskyfd5f7cd2018-01-16 13:47:16 +09002233 * Disable preemption to avoid being preempted while holding
2234 * console_sem which would prevent anyone from printing to
2235 * console
2236 */
2237 preempt_disable();
2238 /*
Andrew Mortond18bbc22014-07-02 15:22:38 -07002239 * Try to acquire and then immediately release the console
2240 * semaphore. The release will print out buffers and wake up
2241 * /dev/kmsg and syslog() users.
2242 */
Petr Mladekc162d5b2018-01-12 17:08:37 +01002243 if (console_trylock_spinning())
Andrew Mortond18bbc22014-07-02 15:22:38 -07002244 console_unlock();
Sergey Senozhatskyfd5f7cd2018-01-16 13:47:16 +09002245 preempt_enable();
Andrew Mortond18bbc22014-07-02 15:22:38 -07002246 }
Steven Rostedt458df9f2014-06-04 16:11:38 -07002247
John Ogness8749efc2020-07-09 15:29:43 +02062248 wake_up_klogd();
Linus Torvalds1da177e2005-04-16 15:20:36 -07002249 return printed_len;
2250}
Kay Sievers7ff95542012-05-03 02:29:13 +02002251EXPORT_SYMBOL(vprintk_emit);
2252
Linus Torvaldsa0cba212016-08-09 10:48:18 -07002253int vprintk_default(const char *fmt, va_list args)
Steven Rostedt (Red Hat)afdc34a2014-06-19 17:33:31 -04002254{
John Ogness74caba72020-09-21 13:24:45 +02062255 return vprintk_emit(0, LOGLEVEL_DEFAULT, NULL, fmt, args);
Steven Rostedt (Red Hat)afdc34a2014-06-19 17:33:31 -04002256}
2257EXPORT_SYMBOL_GPL(vprintk_default);
2258
Chris Down33701552021-06-15 17:52:53 +01002259asmlinkage __visible int _printk(const char *fmt, ...)
Kay Sievers7ff95542012-05-03 02:29:13 +02002260{
2261 va_list args;
2262 int r;
2263
Kay Sievers7ff95542012-05-03 02:29:13 +02002264 va_start(args, fmt);
Rasmus Villemoes28e17452021-03-23 15:42:01 +01002265 r = vprintk(fmt, args);
Kay Sievers7ff95542012-05-03 02:29:13 +02002266 va_end(args);
2267
2268 return r;
2269}
Chris Down33701552021-06-15 17:52:53 +01002270EXPORT_SYMBOL(_printk);
Kay Sievers7f3a7812012-05-09 01:37:51 +02002271
Kay Sievers96efedf2012-07-16 18:35:29 -07002272#else /* CONFIG_PRINTK */
Matt Mackalld59745c2005-05-01 08:59:02 -07002273
John Ognesscf5b0202021-03-03 11:15:20 +01002274#define CONSOLE_LOG_MAX 0
Tetsuo Handae80c1a92018-12-04 19:00:01 +09002275#define printk_time false
Alex Elder249771b2014-08-06 16:09:08 -07002276
John Ogness896fbe22020-07-09 15:29:44 +02062277#define prb_read_valid(rb, seq, r) false
2278#define prb_first_valid_seq(rb) 0
2279
Kay Sievers96efedf2012-07-16 18:35:29 -07002280static u64 syslog_seq;
Kay Sieverseab07262012-07-16 18:35:30 -07002281static u64 console_seq;
Petr Mladekf92b0702018-09-13 14:34:06 +02002282static u64 exclusive_console_stop_seq;
John Ogness896fbe22020-07-09 15:29:44 +02062283static unsigned long console_dropped;
2284
2285static size_t record_print_text(const struct printk_record *r,
2286 bool syslog, bool time)
2287{
2288 return 0;
2289}
2290static ssize_t info_print_ext_header(char *buf, size_t size,
2291 struct printk_info *info)
2292{
2293 return 0;
2294}
Tejun Heo6fe29352015-06-25 15:01:30 -07002295static ssize_t msg_print_ext_body(char *buf, size_t size,
John Ogness74caba72020-09-21 13:24:45 +02062296 char *text, size_t text_len,
2297 struct dev_printk_info *dev_info) { return 0; }
Petr Mladekc162d5b2018-01-12 17:08:37 +01002298static void console_lock_spinning_enable(void) { }
2299static int console_lock_spinning_disable_and_check(void) { return 0; }
Sergey Senozhatskyd9c23522016-12-24 23:09:01 +09002300static void call_console_drivers(const char *ext_text, size_t ext_len,
Tejun Heo6fe29352015-06-25 15:01:30 -07002301 const char *text, size_t len) {}
Petr Mladeka6ae9282018-09-10 15:52:06 +02002302static bool suppress_message_printing(int level) { return false; }
Matt Mackalld59745c2005-05-01 08:59:02 -07002303
Kay Sievers7f3a7812012-05-09 01:37:51 +02002304#endif /* CONFIG_PRINTK */
Matt Mackalld59745c2005-05-01 08:59:02 -07002305
Thomas Gleixnerd0380e62013-04-29 16:17:18 -07002306#ifdef CONFIG_EARLY_PRINTK
2307struct console *early_console;
2308
Andi Kleen722a9f92014-05-02 00:44:38 +02002309asmlinkage __visible void early_printk(const char *fmt, ...)
Thomas Gleixnerd0380e62013-04-29 16:17:18 -07002310{
2311 va_list ap;
Joe Perches1dc62442014-12-10 15:45:53 -08002312 char buf[512];
2313 int n;
2314
2315 if (!early_console)
2316 return;
Thomas Gleixnerd0380e62013-04-29 16:17:18 -07002317
2318 va_start(ap, fmt);
Joe Perches1dc62442014-12-10 15:45:53 -08002319 n = vscnprintf(buf, sizeof(buf), fmt, ap);
Thomas Gleixnerd0380e62013-04-29 16:17:18 -07002320 va_end(ap);
Joe Perches1dc62442014-12-10 15:45:53 -08002321
2322 early_console->write(early_console, buf, n);
Thomas Gleixnerd0380e62013-04-29 16:17:18 -07002323}
2324#endif
2325
Samuel Thibaultf7511d52008-04-30 00:54:51 -07002326static int __add_preferred_console(char *name, int idx, char *options,
Benjamin Herrenschmidte369d822020-02-13 10:51:32 +01002327 char *brl_options, bool user_specified)
Samuel Thibaultf7511d52008-04-30 00:54:51 -07002328{
2329 struct console_cmdline *c;
2330 int i;
2331
2332 /*
2333 * See if this tty is not yet registered, and
2334 * if we have a slot free.
2335 */
Petr Mladekdac8bbb2017-06-08 12:01:30 +02002336 for (i = 0, c = console_cmdline;
2337 i < MAX_CMDLINECONSOLES && c->name[0];
2338 i++, c++) {
Joe Perches23475402013-07-31 13:53:46 -07002339 if (strcmp(c->name, name) == 0 && c->index == idx) {
Petr Mladekdac8bbb2017-06-08 12:01:30 +02002340 if (!brl_options)
2341 preferred_console = i;
Benjamin Herrenschmidte369d822020-02-13 10:51:32 +01002342 if (user_specified)
2343 c->user_specified = true;
Joe Perches23475402013-07-31 13:53:46 -07002344 return 0;
Samuel Thibaultf7511d52008-04-30 00:54:51 -07002345 }
Joe Perches23475402013-07-31 13:53:46 -07002346 }
Samuel Thibaultf7511d52008-04-30 00:54:51 -07002347 if (i == MAX_CMDLINECONSOLES)
2348 return -E2BIG;
2349 if (!brl_options)
Aleksey Makarovad86ee22017-03-15 13:28:51 +03002350 preferred_console = i;
Samuel Thibaultf7511d52008-04-30 00:54:51 -07002351 strlcpy(c->name, name, sizeof(c->name));
2352 c->options = options;
Benjamin Herrenschmidte369d822020-02-13 10:51:32 +01002353 c->user_specified = user_specified;
Joe Perchesbbeddf52013-07-31 13:53:45 -07002354 braille_set_options(c, brl_options);
2355
Samuel Thibaultf7511d52008-04-30 00:54:51 -07002356 c->index = idx;
2357 return 0;
2358}
Sergey Senozhatskycca10d52017-12-21 14:41:49 +09002359
2360static int __init console_msg_format_setup(char *str)
2361{
2362 if (!strcmp(str, "syslog"))
2363 console_msg_format = MSG_FORMAT_SYSLOG;
2364 if (!strcmp(str, "default"))
2365 console_msg_format = MSG_FORMAT_DEFAULT;
2366 return 1;
2367}
2368__setup("console_msg_format=", console_msg_format_setup);
2369
John Z. Bohach2ea1c532006-03-24 03:18:19 -08002370/*
Alex Elder0b90fec2014-08-06 16:09:03 -07002371 * Set up a console. Called via do_early_param() in init/main.c
2372 * for each "console=" parameter in the boot command line.
John Z. Bohach2ea1c532006-03-24 03:18:19 -08002373 */
2374static int __init console_setup(char *str)
2375{
Alex Elder0b90fec2014-08-06 16:09:03 -07002376 char buf[sizeof(console_cmdline[0].name) + 4]; /* 4 for "ttyS" */
Samuel Thibaultf7511d52008-04-30 00:54:51 -07002377 char *s, *options, *brl_options = NULL;
John Z. Bohach2ea1c532006-03-24 03:18:19 -08002378 int idx;
2379
Petr Mladek3cffa062020-11-11 14:54:50 +01002380 /*
2381 * console="" or console=null have been suggested as a way to
2382 * disable console output. Use ttynull that has been created
Bhaskar Chowdhuryacebb552021-03-28 10:09:32 +05302383 * for exactly this purpose.
Petr Mladek3cffa062020-11-11 14:54:50 +01002384 */
2385 if (str[0] == 0 || strcmp(str, "null") == 0) {
2386 __add_preferred_console("ttynull", 0, NULL, NULL, true);
Shreyas Joshi48021f92020-05-22 16:53:06 +10002387 return 1;
Petr Mladek3cffa062020-11-11 14:54:50 +01002388 }
Shreyas Joshi48021f92020-05-22 16:53:06 +10002389
Joe Perchesbbeddf52013-07-31 13:53:45 -07002390 if (_braille_console_setup(&str, &brl_options))
2391 return 1;
Samuel Thibaultf7511d52008-04-30 00:54:51 -07002392
John Z. Bohach2ea1c532006-03-24 03:18:19 -08002393 /*
2394 * Decode str into name, index, options.
2395 */
2396 if (str[0] >= '0' && str[0] <= '9') {
Yinghai Lueaa944a2007-07-15 23:37:27 -07002397 strcpy(buf, "ttyS");
2398 strncpy(buf + 4, str, sizeof(buf) - 5);
John Z. Bohach2ea1c532006-03-24 03:18:19 -08002399 } else {
Yinghai Lueaa944a2007-07-15 23:37:27 -07002400 strncpy(buf, str, sizeof(buf) - 1);
John Z. Bohach2ea1c532006-03-24 03:18:19 -08002401 }
Yinghai Lueaa944a2007-07-15 23:37:27 -07002402 buf[sizeof(buf) - 1] = 0;
Alex Elder249771b2014-08-06 16:09:08 -07002403 options = strchr(str, ',');
2404 if (options)
John Z. Bohach2ea1c532006-03-24 03:18:19 -08002405 *(options++) = 0;
2406#ifdef __sparc__
2407 if (!strcmp(str, "ttya"))
Yinghai Lueaa944a2007-07-15 23:37:27 -07002408 strcpy(buf, "ttyS0");
John Z. Bohach2ea1c532006-03-24 03:18:19 -08002409 if (!strcmp(str, "ttyb"))
Yinghai Lueaa944a2007-07-15 23:37:27 -07002410 strcpy(buf, "ttyS1");
John Z. Bohach2ea1c532006-03-24 03:18:19 -08002411#endif
Yinghai Lueaa944a2007-07-15 23:37:27 -07002412 for (s = buf; *s; s++)
Alex Elder249771b2014-08-06 16:09:08 -07002413 if (isdigit(*s) || *s == ',')
John Z. Bohach2ea1c532006-03-24 03:18:19 -08002414 break;
2415 idx = simple_strtoul(s, NULL, 10);
2416 *s = 0;
2417
Benjamin Herrenschmidte369d822020-02-13 10:51:32 +01002418 __add_preferred_console(buf, idx, options, brl_options, true);
Markus Armbruster9e124fe2008-05-26 23:31:07 +01002419 console_set_on_cmdline = 1;
John Z. Bohach2ea1c532006-03-24 03:18:19 -08002420 return 1;
2421}
2422__setup("console=", console_setup);
2423
Linus Torvalds1da177e2005-04-16 15:20:36 -07002424/**
Matt Mackall3c0547b2005-05-16 21:53:47 -07002425 * add_preferred_console - add a device to the list of preferred consoles.
Martin Waitzddad86c2005-11-13 16:08:14 -08002426 * @name: device name
2427 * @idx: device index
2428 * @options: options for this console
Matt Mackall3c0547b2005-05-16 21:53:47 -07002429 *
2430 * The last preferred console added will be used for kernel messages
2431 * and stdin/out/err for init. Normally this is used by console_setup
2432 * above to handle user-supplied console arguments; however it can also
2433 * be used by arch-specific code either to override the user or more
2434 * commonly to provide a default console (ie from PROM variables) when
2435 * the user has not supplied one.
2436 */
David S. Millerfb445ee2007-12-29 01:19:49 -08002437int add_preferred_console(char *name, int idx, char *options)
Matt Mackall3c0547b2005-05-16 21:53:47 -07002438{
Benjamin Herrenschmidte369d822020-02-13 10:51:32 +01002439 return __add_preferred_console(name, idx, options, NULL, false);
Matt Mackall3c0547b2005-05-16 21:53:47 -07002440}
2441
Neil Zhangd25d9fe2014-08-06 16:09:12 -07002442bool console_suspend_enabled = true;
Andres Salomon8f4ce8c2007-10-18 03:04:50 -07002443EXPORT_SYMBOL(console_suspend_enabled);
2444
2445static int __init console_suspend_disable(char *str)
2446{
Neil Zhangd25d9fe2014-08-06 16:09:12 -07002447 console_suspend_enabled = false;
Andres Salomon8f4ce8c2007-10-18 03:04:50 -07002448 return 1;
2449}
2450__setup("no_console_suspend", console_suspend_disable);
Yanmin Zhang134620f2011-10-31 17:11:27 -07002451module_param_named(console_suspend, console_suspend_enabled,
2452 bool, S_IRUGO | S_IWUSR);
2453MODULE_PARM_DESC(console_suspend, "suspend console during suspend"
2454 " and hibernate operations");
Andres Salomon8f4ce8c2007-10-18 03:04:50 -07002455
Dmitry Safonov10102a82021-07-27 14:06:35 +01002456static bool printk_console_no_auto_verbose;
2457
2458void console_verbose(void)
2459{
2460 if (console_loglevel && !printk_console_no_auto_verbose)
2461 console_loglevel = CONSOLE_LOGLEVEL_MOTORMOUTH;
2462}
2463EXPORT_SYMBOL_GPL(console_verbose);
2464
2465module_param_named(console_no_auto_verbose, printk_console_no_auto_verbose, bool, 0644);
2466MODULE_PARM_DESC(console_no_auto_verbose, "Disable console loglevel raise to highest on oops/panic/etc");
2467
Matt Mackall3c0547b2005-05-16 21:53:47 -07002468/**
Linus Torvalds557240b2006-06-19 18:16:01 -07002469 * suspend_console - suspend the console subsystem
2470 *
2471 * This disables printk() while we go into suspend states
2472 */
2473void suspend_console(void)
2474{
Andres Salomon8f4ce8c2007-10-18 03:04:50 -07002475 if (!console_suspend_enabled)
2476 return;
Tomeu Vizoso47319f72018-03-22 14:58:33 +01002477 pr_info("Suspending console(s) (use no_console_suspend to debug)\n");
Torben Hohnac751ef2011-01-25 15:07:35 -08002478 console_lock();
Linus Torvalds557240b2006-06-19 18:16:01 -07002479 console_suspended = 1;
Jan Karabd8d7cf2014-06-04 16:11:36 -07002480 up_console_sem();
Linus Torvalds557240b2006-06-19 18:16:01 -07002481}
2482
2483void resume_console(void)
2484{
Andres Salomon8f4ce8c2007-10-18 03:04:50 -07002485 if (!console_suspend_enabled)
2486 return;
Jan Karabd8d7cf2014-06-04 16:11:36 -07002487 down_console_sem();
Linus Torvalds557240b2006-06-19 18:16:01 -07002488 console_suspended = 0;
Torben Hohnac751ef2011-01-25 15:07:35 -08002489 console_unlock();
Linus Torvalds557240b2006-06-19 18:16:01 -07002490}
2491
2492/**
Kevin Cernekee034260d2010-06-03 22:11:25 -07002493 * console_cpu_notify - print deferred console messages after CPU hotplug
Sebastian Andrzej Siewior90b14882016-11-03 15:49:58 +01002494 * @cpu: unused
Kevin Cernekee034260d2010-06-03 22:11:25 -07002495 *
2496 * If printk() is called from a CPU that is not online yet, the messages
Sergey Senozhatsky64ca7522017-01-21 19:47:29 +09002497 * will be printed on the console only if there are CON_ANYTIME consoles.
2498 * This function is called when a new CPU comes online (or fails to come
2499 * up) or goes offline.
Kevin Cernekee034260d2010-06-03 22:11:25 -07002500 */
Sebastian Andrzej Siewior90b14882016-11-03 15:49:58 +01002501static int console_cpu_notify(unsigned int cpu)
Kevin Cernekee034260d2010-06-03 22:11:25 -07002502{
Thomas Gleixnerf97960f2016-11-17 17:31:55 +01002503 if (!cpuhp_tasks_frozen) {
Sergey Senozhatsky64ca7522017-01-21 19:47:29 +09002504 /* If trylock fails, someone else is doing the printing */
2505 if (console_trylock())
2506 console_unlock();
Kevin Cernekee034260d2010-06-03 22:11:25 -07002507 }
Sebastian Andrzej Siewior90b14882016-11-03 15:49:58 +01002508 return 0;
Kevin Cernekee034260d2010-06-03 22:11:25 -07002509}
2510
2511/**
Torben Hohnac751ef2011-01-25 15:07:35 -08002512 * console_lock - lock the console system for exclusive use.
Linus Torvalds1da177e2005-04-16 15:20:36 -07002513 *
Torben Hohnac751ef2011-01-25 15:07:35 -08002514 * Acquires a lock which guarantees that the caller has
Linus Torvalds1da177e2005-04-16 15:20:36 -07002515 * exclusive access to the console system and the console_drivers list.
2516 *
2517 * Can sleep, returns nothing.
2518 */
Torben Hohnac751ef2011-01-25 15:07:35 -08002519void console_lock(void)
Linus Torvalds1da177e2005-04-16 15:20:36 -07002520{
Daniel Vetter6b898c02012-09-17 23:03:31 +00002521 might_sleep();
2522
Jan Karabd8d7cf2014-06-04 16:11:36 -07002523 down_console_sem();
Arve Hjønnevåg403f3072009-02-14 02:07:24 +01002524 if (console_suspended)
2525 return;
Linus Torvalds1da177e2005-04-16 15:20:36 -07002526 console_locked = 1;
2527 console_may_schedule = 1;
2528}
Torben Hohnac751ef2011-01-25 15:07:35 -08002529EXPORT_SYMBOL(console_lock);
Linus Torvalds1da177e2005-04-16 15:20:36 -07002530
Torben Hohnac751ef2011-01-25 15:07:35 -08002531/**
2532 * console_trylock - try to lock the console system for exclusive use.
2533 *
Alex Elder0b90fec2014-08-06 16:09:03 -07002534 * Try to acquire a lock which guarantees that the caller has exclusive
2535 * access to the console system and the console_drivers list.
Torben Hohnac751ef2011-01-25 15:07:35 -08002536 *
2537 * returns 1 on success, and 0 on failure to acquire the lock.
2538 */
2539int console_trylock(void)
Linus Torvalds1da177e2005-04-16 15:20:36 -07002540{
Jan Karabd8d7cf2014-06-04 16:11:36 -07002541 if (down_trylock_console_sem())
Torben Hohnac751ef2011-01-25 15:07:35 -08002542 return 0;
Arve Hjønnevåg403f3072009-02-14 02:07:24 +01002543 if (console_suspended) {
Jan Karabd8d7cf2014-06-04 16:11:36 -07002544 up_console_sem();
Torben Hohnac751ef2011-01-25 15:07:35 -08002545 return 0;
Arve Hjønnevåg403f3072009-02-14 02:07:24 +01002546 }
Linus Torvalds1da177e2005-04-16 15:20:36 -07002547 console_locked = 1;
Sergey Senozhatskyfd5f7cd2018-01-16 13:47:16 +09002548 console_may_schedule = 0;
Torben Hohnac751ef2011-01-25 15:07:35 -08002549 return 1;
Linus Torvalds1da177e2005-04-16 15:20:36 -07002550}
Torben Hohnac751ef2011-01-25 15:07:35 -08002551EXPORT_SYMBOL(console_trylock);
Linus Torvalds1da177e2005-04-16 15:20:36 -07002552
2553int is_console_locked(void)
2554{
2555 return console_locked;
2556}
Hans de Goeded48de542018-06-28 15:20:27 +02002557EXPORT_SYMBOL(is_console_locked);
Linus Torvalds1da177e2005-04-16 15:20:36 -07002558
Sergey Senozhatskya8199372016-03-17 14:21:20 -07002559/*
2560 * Check if we have any console that is capable of printing while cpu is
2561 * booting or shutting down. Requires console_sem.
2562 */
2563static int have_callable_console(void)
2564{
2565 struct console *con;
2566
2567 for_each_console(con)
Sergey Senozhatskyadaf6592016-03-17 14:21:27 -07002568 if ((con->flags & CON_ENABLED) &&
2569 (con->flags & CON_ANYTIME))
Sergey Senozhatskya8199372016-03-17 14:21:20 -07002570 return 1;
2571
2572 return 0;
2573}
2574
2575/*
2576 * Can we actually use the console at this time on this cpu?
2577 *
2578 * Console drivers may assume that per-cpu resources have been allocated. So
2579 * unless they're explicitly marked as being able to cope (CON_ANYTIME) don't
2580 * call them until this CPU is officially up.
2581 */
2582static inline int can_use_console(void)
2583{
2584 return cpu_online(raw_smp_processor_id()) || have_callable_console();
2585}
2586
Linus Torvalds1da177e2005-04-16 15:20:36 -07002587/**
Torben Hohnac751ef2011-01-25 15:07:35 -08002588 * console_unlock - unlock the console system
Linus Torvalds1da177e2005-04-16 15:20:36 -07002589 *
Torben Hohnac751ef2011-01-25 15:07:35 -08002590 * Releases the console_lock which the caller holds on the console system
Linus Torvalds1da177e2005-04-16 15:20:36 -07002591 * and the console driver list.
2592 *
Torben Hohnac751ef2011-01-25 15:07:35 -08002593 * While the console_lock was held, console output may have been buffered
2594 * by printk(). If this is the case, console_unlock(); emits
2595 * the output prior to releasing the lock.
Linus Torvalds1da177e2005-04-16 15:20:36 -07002596 *
Kay Sievers7f3a7812012-05-09 01:37:51 +02002597 * If there is output waiting, we wake /dev/kmsg and syslog() users.
Linus Torvalds1da177e2005-04-16 15:20:36 -07002598 *
Torben Hohnac751ef2011-01-25 15:07:35 -08002599 * console_unlock(); may be called from any context.
Linus Torvalds1da177e2005-04-16 15:20:36 -07002600 */
Torben Hohnac751ef2011-01-25 15:07:35 -08002601void console_unlock(void)
Linus Torvalds1da177e2005-04-16 15:20:36 -07002602{
Tejun Heo6fe29352015-06-25 15:01:30 -07002603 static char ext_text[CONSOLE_EXT_LOG_MAX];
John Ognesscf5b0202021-03-03 11:15:20 +01002604 static char text[CONSOLE_LOG_MAX];
Linus Torvalds1da177e2005-04-16 15:20:36 -07002605 unsigned long flags;
Tejun Heo8d91f8b2016-01-15 16:58:24 -08002606 bool do_cond_resched, retry;
John Ogness896fbe22020-07-09 15:29:44 +02062607 struct printk_info info;
2608 struct printk_record r;
Petr Mladek11e4b632021-07-02 17:06:57 +02002609 u64 __maybe_unused next_seq;
Linus Torvalds1da177e2005-04-16 15:20:36 -07002610
Linus Torvalds557240b2006-06-19 18:16:01 -07002611 if (console_suspended) {
Jan Karabd8d7cf2014-06-04 16:11:36 -07002612 up_console_sem();
Linus Torvalds557240b2006-06-19 18:16:01 -07002613 return;
2614 }
Antonino A. Daplas78944e542006-08-05 12:14:16 -07002615
John Ognessf35efc72020-09-19 00:40:21 +02062616 prb_rec_init_rd(&r, &info, text, sizeof(text));
John Ogness896fbe22020-07-09 15:29:44 +02062617
Tejun Heo8d91f8b2016-01-15 16:58:24 -08002618 /*
Petr Mladek257ab442017-03-24 17:14:05 +01002619 * Console drivers are called with interrupts disabled, so
Tejun Heo8d91f8b2016-01-15 16:58:24 -08002620 * @console_may_schedule should be cleared before; however, we may
2621 * end up dumping a lot of lines, for example, if called from
2622 * console registration path, and should invoke cond_resched()
2623 * between lines if allowable. Not doing so can cause a very long
2624 * scheduling stall on a slow console leading to RCU stall and
2625 * softlockup warnings which exacerbate the issue with more
2626 * messages practically incapacitating the system.
Petr Mladek257ab442017-03-24 17:14:05 +01002627 *
2628 * console_trylock() is not able to detect the preemptive
2629 * context reliably. Therefore the value must be stored before
Randy Dunlap547bbf72020-08-06 20:32:27 -07002630 * and cleared after the "again" goto label.
Tejun Heo8d91f8b2016-01-15 16:58:24 -08002631 */
2632 do_cond_resched = console_may_schedule;
Petr Mladek257ab442017-03-24 17:14:05 +01002633again:
Antonino A. Daplas78944e542006-08-05 12:14:16 -07002634 console_may_schedule = 0;
2635
Sergey Senozhatskya8199372016-03-17 14:21:20 -07002636 /*
2637 * We released the console_sem lock, so we need to recheck if
2638 * cpu is online and (if not) is there at least one CON_ANYTIME
2639 * console.
2640 */
2641 if (!can_use_console()) {
2642 console_locked = 0;
2643 up_console_sem();
2644 return;
2645 }
2646
Kay Sievers7ff95542012-05-03 02:29:13 +02002647 for (;;) {
Tejun Heo6fe29352015-06-25 15:01:30 -07002648 size_t ext_len = 0;
John Ogness93d102f2021-07-15 21:39:56 +02062649 int handover;
Kay Sievers3ce9a7c2012-05-13 23:30:46 +02002650 size_t len;
Kay Sievers7ff95542012-05-03 02:29:13 +02002651
Kay Sievers084681d2012-06-28 09:38:53 +02002652skip:
John Ogness896fbe22020-07-09 15:29:44 +02062653 if (!prb_read_valid(prb, console_seq, &r))
Kay Sievers7ff95542012-05-03 02:29:13 +02002654 break;
2655
John Ogness896fbe22020-07-09 15:29:44 +02062656 if (console_seq != r.info->seq) {
2657 console_dropped += r.info->seq - console_seq;
2658 console_seq = r.info->seq;
2659 }
2660
2661 if (suppress_message_printing(r.info->level)) {
Kay Sievers084681d2012-06-28 09:38:53 +02002662 /*
Petr Mladeka6ae9282018-09-10 15:52:06 +02002663 * Skip record we have buffered and already printed
2664 * directly to the console when we received it, and
2665 * record that has level above the console loglevel.
Kay Sievers084681d2012-06-28 09:38:53 +02002666 */
Kay Sievers084681d2012-06-28 09:38:53 +02002667 console_seq++;
2668 goto skip;
2669 }
Kay Sievers649e6ee2012-05-10 04:30:45 +02002670
Petr Mladekf92b0702018-09-13 14:34:06 +02002671 /* Output to all consoles once old messages replayed. */
2672 if (unlikely(exclusive_console &&
2673 console_seq >= exclusive_console_stop_seq)) {
2674 exclusive_console = NULL;
2675 }
2676
John Ogness896fbe22020-07-09 15:29:44 +02062677 /*
2678 * Handle extended console text first because later
2679 * record_print_text() will modify the record buffer in-place.
2680 */
Tejun Heo6fe29352015-06-25 15:01:30 -07002681 if (nr_ext_console_drivers) {
John Ogness896fbe22020-07-09 15:29:44 +02062682 ext_len = info_print_ext_header(ext_text,
Tejun Heo6fe29352015-06-25 15:01:30 -07002683 sizeof(ext_text),
John Ogness896fbe22020-07-09 15:29:44 +02062684 r.info);
Tejun Heo6fe29352015-06-25 15:01:30 -07002685 ext_len += msg_print_ext_body(ext_text + ext_len,
2686 sizeof(ext_text) - ext_len,
John Ogness896fbe22020-07-09 15:29:44 +02062687 &r.text_buf[0],
John Ogness74caba72020-09-21 13:24:45 +02062688 r.info->text_len,
2689 &r.info->dev_info);
Tejun Heo6fe29352015-06-25 15:01:30 -07002690 }
John Ogness896fbe22020-07-09 15:29:44 +02062691 len = record_print_text(&r,
2692 console_msg_format & MSG_FORMAT_SYSLOG,
2693 printk_time);
Kay Sievers7ff95542012-05-03 02:29:13 +02002694 console_seq++;
Kay Sievers7ff95542012-05-03 02:29:13 +02002695
Steven Rostedt (VMware)dbdda842018-01-10 14:24:17 +01002696 /*
2697 * While actively printing out messages, if another printk()
2698 * were to occur on another CPU, it may wait for this one to
2699 * finish. This task can not be preempted if there is a
2700 * waiter waiting to take over.
John Ogness93d102f2021-07-15 21:39:56 +02062701 *
2702 * Interrupts are disabled because the hand over to a waiter
2703 * must not be interrupted until the hand over is completed
2704 * (@console_waiter is cleared).
Steven Rostedt (VMware)dbdda842018-01-10 14:24:17 +01002705 */
John Ogness93d102f2021-07-15 21:39:56 +02062706 printk_safe_enter_irqsave(flags);
Petr Mladekc162d5b2018-01-12 17:08:37 +01002707 console_lock_spinning_enable();
Steven Rostedt (VMware)dbdda842018-01-10 14:24:17 +01002708
Steven Rostedt81d68a92008-05-12 21:20:42 +02002709 stop_critical_timings(); /* don't trace print latency */
Sergey Senozhatskyd9c23522016-12-24 23:09:01 +09002710 call_console_drivers(ext_text, ext_len, text, len);
Steven Rostedt81d68a92008-05-12 21:20:42 +02002711 start_critical_timings();
Steven Rostedt (VMware)dbdda842018-01-10 14:24:17 +01002712
John Ogness93d102f2021-07-15 21:39:56 +02062713 handover = console_lock_spinning_disable_and_check();
Sergey Senozhatskyf9752372016-12-27 23:16:09 +09002714 printk_safe_exit_irqrestore(flags);
John Ogness93d102f2021-07-15 21:39:56 +02062715 if (handover)
2716 return;
Tejun Heo8d91f8b2016-01-15 16:58:24 -08002717
2718 if (do_cond_resched)
2719 cond_resched();
Linus Torvalds1da177e2005-04-16 15:20:36 -07002720 }
Steven Rostedt (VMware)dbdda842018-01-10 14:24:17 +01002721
Petr Mladek11e4b632021-07-02 17:06:57 +02002722 /* Get consistent value of the next-to-be-used sequence number. */
2723 next_seq = console_seq;
Feng Tangfe3d8ad2011-03-22 16:34:21 -07002724
Petr Mladek11e4b632021-07-02 17:06:57 +02002725 console_locked = 0;
Jan Karabd8d7cf2014-06-04 16:11:36 -07002726 up_console_sem();
Peter Zijlstra4f2a8d32011-06-22 11:20:09 +02002727
2728 /*
2729 * Someone could have filled up the buffer again, so re-check if there's
2730 * something to flush. In case we cannot trylock the console_sem again,
2731 * there's a new owner and the console_unlock() from them will do the
2732 * flush, no worries.
2733 */
Petr Mladek11e4b632021-07-02 17:06:57 +02002734 retry = prb_read_valid(prb, next_seq, NULL);
Peter Zijlstra4f2a8d32011-06-22 11:20:09 +02002735 if (retry && console_trylock())
2736 goto again;
Linus Torvalds1da177e2005-04-16 15:20:36 -07002737}
Torben Hohnac751ef2011-01-25 15:07:35 -08002738EXPORT_SYMBOL(console_unlock);
Linus Torvalds1da177e2005-04-16 15:20:36 -07002739
Martin Waitzddad86c2005-11-13 16:08:14 -08002740/**
2741 * console_conditional_schedule - yield the CPU if required
Linus Torvalds1da177e2005-04-16 15:20:36 -07002742 *
2743 * If the console code is currently allowed to sleep, and
2744 * if this CPU should yield the CPU to another task, do
2745 * so here.
2746 *
Torben Hohnac751ef2011-01-25 15:07:35 -08002747 * Must be called within console_lock();.
Linus Torvalds1da177e2005-04-16 15:20:36 -07002748 */
2749void __sched console_conditional_schedule(void)
2750{
2751 if (console_may_schedule)
2752 cond_resched();
2753}
2754EXPORT_SYMBOL(console_conditional_schedule);
2755
Linus Torvalds1da177e2005-04-16 15:20:36 -07002756void console_unblank(void)
2757{
2758 struct console *c;
2759
2760 /*
2761 * console_unblank can no longer be called in interrupt context unless
2762 * oops_in_progress is set to 1..
2763 */
2764 if (oops_in_progress) {
Jan Karabd8d7cf2014-06-04 16:11:36 -07002765 if (down_trylock_console_sem() != 0)
Linus Torvalds1da177e2005-04-16 15:20:36 -07002766 return;
2767 } else
Torben Hohnac751ef2011-01-25 15:07:35 -08002768 console_lock();
Linus Torvalds1da177e2005-04-16 15:20:36 -07002769
2770 console_locked = 1;
2771 console_may_schedule = 0;
Robin Getz4d091612009-07-01 21:08:37 -04002772 for_each_console(c)
Linus Torvalds1da177e2005-04-16 15:20:36 -07002773 if ((c->flags & CON_ENABLED) && c->unblank)
2774 c->unblank();
Torben Hohnac751ef2011-01-25 15:07:35 -08002775 console_unlock();
Linus Torvalds1da177e2005-04-16 15:20:36 -07002776}
Linus Torvalds1da177e2005-04-16 15:20:36 -07002777
Tejun Heo8d91f8b2016-01-15 16:58:24 -08002778/**
2779 * console_flush_on_panic - flush console content on panic
Feng Tangde6da1e2019-05-17 14:31:50 -07002780 * @mode: flush all messages in buffer or just the pending ones
Tejun Heo8d91f8b2016-01-15 16:58:24 -08002781 *
2782 * Immediately output all pending messages no matter what.
2783 */
Feng Tangde6da1e2019-05-17 14:31:50 -07002784void console_flush_on_panic(enum con_flush_mode mode)
Tejun Heo8d91f8b2016-01-15 16:58:24 -08002785{
2786 /*
2787 * If someone else is holding the console lock, trylock will fail
2788 * and may_schedule may be set. Ignore and proceed to unlock so
2789 * that messages are flushed out. As this can be called from any
2790 * context and we don't want to get preempted while flushing,
2791 * ensure may_schedule is cleared.
2792 */
2793 console_trylock();
2794 console_may_schedule = 0;
Feng Tangde6da1e2019-05-17 14:31:50 -07002795
John Ogness93d102f2021-07-15 21:39:56 +02062796 if (mode == CONSOLE_REPLAY_ALL)
John Ogness896fbe22020-07-09 15:29:44 +02062797 console_seq = prb_first_valid_seq(prb);
Tejun Heo8d91f8b2016-01-15 16:58:24 -08002798 console_unlock();
2799}
2800
Linus Torvalds1da177e2005-04-16 15:20:36 -07002801/*
2802 * Return the console tty driver structure and its associated index
2803 */
2804struct tty_driver *console_device(int *index)
2805{
2806 struct console *c;
2807 struct tty_driver *driver = NULL;
2808
Torben Hohnac751ef2011-01-25 15:07:35 -08002809 console_lock();
Robin Getz4d091612009-07-01 21:08:37 -04002810 for_each_console(c) {
Linus Torvalds1da177e2005-04-16 15:20:36 -07002811 if (!c->device)
2812 continue;
2813 driver = c->device(c, index);
2814 if (driver)
2815 break;
2816 }
Torben Hohnac751ef2011-01-25 15:07:35 -08002817 console_unlock();
Linus Torvalds1da177e2005-04-16 15:20:36 -07002818 return driver;
2819}
2820
2821/*
2822 * Prevent further output on the passed console device so that (for example)
2823 * serial drivers can disable console output before suspending a port, and can
2824 * re-enable output afterwards.
2825 */
2826void console_stop(struct console *console)
2827{
Torben Hohnac751ef2011-01-25 15:07:35 -08002828 console_lock();
Linus Torvalds1da177e2005-04-16 15:20:36 -07002829 console->flags &= ~CON_ENABLED;
Torben Hohnac751ef2011-01-25 15:07:35 -08002830 console_unlock();
Linus Torvalds1da177e2005-04-16 15:20:36 -07002831}
2832EXPORT_SYMBOL(console_stop);
2833
2834void console_start(struct console *console)
2835{
Torben Hohnac751ef2011-01-25 15:07:35 -08002836 console_lock();
Linus Torvalds1da177e2005-04-16 15:20:36 -07002837 console->flags |= CON_ENABLED;
Torben Hohnac751ef2011-01-25 15:07:35 -08002838 console_unlock();
Linus Torvalds1da177e2005-04-16 15:20:36 -07002839}
2840EXPORT_SYMBOL(console_start);
2841
Fabio M. Di Nitto7bf69392011-03-22 16:34:20 -07002842static int __read_mostly keep_bootcon;
2843
2844static int __init keep_bootcon_setup(char *str)
2845{
2846 keep_bootcon = 1;
Andrew Morton27083ba2013-11-12 15:08:50 -08002847 pr_info("debug: skip boot console de-registration.\n");
Fabio M. Di Nitto7bf69392011-03-22 16:34:20 -07002848
2849 return 0;
2850}
2851
2852early_param("keep_bootcon", keep_bootcon_setup);
2853
Linus Torvalds1da177e2005-04-16 15:20:36 -07002854/*
Benjamin Herrenschmidtad8cd1d2020-02-13 10:51:31 +01002855 * This is called by register_console() to try to match
2856 * the newly registered console with any of the ones selected
2857 * by either the command line or add_preferred_console() and
2858 * setup/enable it.
2859 *
2860 * Care need to be taken with consoles that are statically
2861 * enabled such as netconsole
2862 */
Petr Mladeked758b32021-11-22 14:26:45 +01002863static int try_enable_preferred_console(struct console *newcon,
2864 bool user_specified)
Benjamin Herrenschmidtad8cd1d2020-02-13 10:51:31 +01002865{
2866 struct console_cmdline *c;
Andy Shevchenkobba18a12020-06-18 19:47:50 +03002867 int i, err;
Benjamin Herrenschmidtad8cd1d2020-02-13 10:51:31 +01002868
2869 for (i = 0, c = console_cmdline;
2870 i < MAX_CMDLINECONSOLES && c->name[0];
2871 i++, c++) {
Benjamin Herrenschmidte369d822020-02-13 10:51:32 +01002872 if (c->user_specified != user_specified)
2873 continue;
Benjamin Herrenschmidtad8cd1d2020-02-13 10:51:31 +01002874 if (!newcon->match ||
2875 newcon->match(newcon, c->name, c->index, c->options) != 0) {
2876 /* default matching */
2877 BUILD_BUG_ON(sizeof(c->name) != sizeof(newcon->name));
2878 if (strcmp(c->name, newcon->name) != 0)
2879 continue;
2880 if (newcon->index >= 0 &&
2881 newcon->index != c->index)
2882 continue;
2883 if (newcon->index < 0)
2884 newcon->index = c->index;
2885
2886 if (_braille_register_console(newcon, c))
2887 return 0;
2888
2889 if (newcon->setup &&
Andy Shevchenkobba18a12020-06-18 19:47:50 +03002890 (err = newcon->setup(newcon, c->options)) != 0)
2891 return err;
Benjamin Herrenschmidtad8cd1d2020-02-13 10:51:31 +01002892 }
2893 newcon->flags |= CON_ENABLED;
Petr Mladekf873efe2021-11-22 14:26:47 +01002894 if (i == preferred_console)
Benjamin Herrenschmidtad8cd1d2020-02-13 10:51:31 +01002895 newcon->flags |= CON_CONSDEV;
Benjamin Herrenschmidtad8cd1d2020-02-13 10:51:31 +01002896 return 0;
2897 }
2898
2899 /*
2900 * Some consoles, such as pstore and netconsole, can be enabled even
Benjamin Herrenschmidte369d822020-02-13 10:51:32 +01002901 * without matching. Accept the pre-enabled consoles only when match()
Andy Shevchenko50460372020-06-18 19:47:51 +03002902 * and setup() had a chance to be called.
Benjamin Herrenschmidtad8cd1d2020-02-13 10:51:31 +01002903 */
Benjamin Herrenschmidte369d822020-02-13 10:51:32 +01002904 if (newcon->flags & CON_ENABLED && c->user_specified == user_specified)
Benjamin Herrenschmidtad8cd1d2020-02-13 10:51:31 +01002905 return 0;
2906
2907 return -ENOENT;
2908}
2909
Petr Mladeked758b32021-11-22 14:26:45 +01002910/* Try to enable the console unconditionally */
2911static void try_enable_default_console(struct console *newcon)
2912{
2913 if (newcon->index < 0)
2914 newcon->index = 0;
2915
2916 if (newcon->setup && newcon->setup(newcon, NULL) != 0)
2917 return;
2918
2919 newcon->flags |= CON_ENABLED;
2920
Petr Mladek4f546932021-11-22 14:26:48 +01002921 if (newcon->device)
Petr Mladeked758b32021-11-22 14:26:45 +01002922 newcon->flags |= CON_CONSDEV;
Petr Mladeked758b32021-11-22 14:26:45 +01002923}
2924
Benjamin Herrenschmidtad8cd1d2020-02-13 10:51:31 +01002925/*
Linus Torvalds1da177e2005-04-16 15:20:36 -07002926 * The console driver calls this routine during kernel initialization
2927 * to register the console printing procedure with printk() and to
2928 * print any messages that were printed by the kernel before the
2929 * console driver was initialized.
Robin Getz4d091612009-07-01 21:08:37 -04002930 *
2931 * This can happen pretty early during the boot process (because of
2932 * early_printk) - sometimes before setup_arch() completes - be careful
2933 * of what kernel features are used - they may not be initialised yet.
2934 *
2935 * There are two types of consoles - bootconsoles (early_printk) and
2936 * "real" consoles (everything which is not a bootconsole) which are
2937 * handled differently.
2938 * - Any number of bootconsoles can be registered at any time.
2939 * - As soon as a "real" console is registered, all bootconsoles
2940 * will be unregistered automatically.
2941 * - Once a "real" console is registered, any attempt to register a
2942 * bootconsoles will be rejected
Linus Torvalds1da177e2005-04-16 15:20:36 -07002943 */
Robin Getz4d091612009-07-01 21:08:37 -04002944void register_console(struct console *newcon)
Linus Torvalds1da177e2005-04-16 15:20:36 -07002945{
Petr Mladek5e8ba482021-11-22 14:26:49 +01002946 struct console *con;
2947 bool bootcon_enabled = false;
2948 bool realcon_enabled = false;
Benjamin Herrenschmidtad8cd1d2020-02-13 10:51:31 +01002949 int err;
Linus Torvalds1da177e2005-04-16 15:20:36 -07002950
Petr Mladek5e8ba482021-11-22 14:26:49 +01002951 for_each_console(con) {
2952 if (WARN(con == newcon, "console '%s%d' already registered\n",
2953 con->name, con->index))
Andy Shevchenkocaa72c32020-02-03 15:31:25 +02002954 return;
2955 }
Andreas Bießmann16cf48a2013-08-02 12:23:34 +02002956
Petr Mladek5e8ba482021-11-22 14:26:49 +01002957 for_each_console(con) {
2958 if (con->flags & CON_BOOT)
2959 bootcon_enabled = true;
2960 else
2961 realcon_enabled = true;
Gerd Hoffmann69331af2007-05-08 00:26:49 -07002962 }
2963
Petr Mladek5e8ba482021-11-22 14:26:49 +01002964 /* Do not register boot consoles when there already is a real one. */
2965 if (newcon->flags & CON_BOOT && realcon_enabled) {
2966 pr_info("Too late to register bootconsole %s%d\n",
2967 newcon->name, newcon->index);
2968 return;
2969 }
Robin Getz4d091612009-07-01 21:08:37 -04002970
Linus Torvalds1da177e2005-04-16 15:20:36 -07002971 /*
Petr Mladek4f546932021-11-22 14:26:48 +01002972 * See if we want to enable this console driver by default.
2973 *
2974 * Nope when a console is preferred by the command line, device
2975 * tree, or SPCR.
2976 *
2977 * The first real console with tty binding (driver) wins. More
2978 * consoles might get enabled before the right one is found.
2979 *
2980 * Note that a console with tty binding will have CON_CONSDEV
2981 * flag set and will be first in the list.
Linus Torvalds1da177e2005-04-16 15:20:36 -07002982 */
Petr Mladek4f546932021-11-22 14:26:48 +01002983 if (preferred_console < 0) {
2984 if (!console_drivers || !console_drivers->device ||
2985 console_drivers->flags & CON_BOOT) {
2986 try_enable_default_console(newcon);
2987 }
2988 }
Linus Torvalds1da177e2005-04-16 15:20:36 -07002989
Benjamin Herrenschmidte369d822020-02-13 10:51:32 +01002990 /* See if this console matches one we selected on the command line */
Petr Mladeked758b32021-11-22 14:26:45 +01002991 err = try_enable_preferred_console(newcon, true);
Joe Perchesbbeddf52013-07-31 13:53:45 -07002992
Benjamin Herrenschmidte369d822020-02-13 10:51:32 +01002993 /* If not, try to match against the platform default(s) */
2994 if (err == -ENOENT)
Petr Mladeked758b32021-11-22 14:26:45 +01002995 err = try_enable_preferred_console(newcon, false);
Joe Perchesbbeddf52013-07-31 13:53:45 -07002996
Benjamin Herrenschmidtad8cd1d2020-02-13 10:51:31 +01002997 /* printk() messages are not printed to the Braille console. */
2998 if (err || newcon->flags & CON_BRL)
Linus Torvalds1da177e2005-04-16 15:20:36 -07002999 return;
3000
Robin Getz8259cf42009-07-09 13:08:37 -04003001 /*
3002 * If we have a bootconsole, and are switching to a real console,
3003 * don't print everything out again, since when the boot console, and
3004 * the real console are the same physical device, it's annoying to
3005 * see the beginning boot messages twice
3006 */
Petr Mladek5e8ba482021-11-22 14:26:49 +01003007 if (bootcon_enabled &&
3008 ((newcon->flags & (CON_CONSDEV | CON_BOOT)) == CON_CONSDEV)) {
Robin Getz4d091612009-07-01 21:08:37 -04003009 newcon->flags &= ~CON_PRINTBUFFER;
Petr Mladek5e8ba482021-11-22 14:26:49 +01003010 }
Linus Torvalds1da177e2005-04-16 15:20:36 -07003011
3012 /*
3013 * Put this console in the list - keep the
3014 * preferred driver at the head of the list.
3015 */
Torben Hohnac751ef2011-01-25 15:07:35 -08003016 console_lock();
Robin Getz4d091612009-07-01 21:08:37 -04003017 if ((newcon->flags & CON_CONSDEV) || console_drivers == NULL) {
3018 newcon->next = console_drivers;
3019 console_drivers = newcon;
3020 if (newcon->next)
3021 newcon->next->flags &= ~CON_CONSDEV;
Benjamin Herrenschmidt33225d72020-02-13 10:51:33 +01003022 /* Ensure this flag is always set for the head of the list */
3023 newcon->flags |= CON_CONSDEV;
Linus Torvalds1da177e2005-04-16 15:20:36 -07003024 } else {
Robin Getz4d091612009-07-01 21:08:37 -04003025 newcon->next = console_drivers->next;
3026 console_drivers->next = newcon;
Linus Torvalds1da177e2005-04-16 15:20:36 -07003027 }
Tejun Heo6fe29352015-06-25 15:01:30 -07003028
3029 if (newcon->flags & CON_EXTENDED)
Sergey Senozhatsky96278082018-10-02 11:38:34 +09003030 nr_ext_console_drivers++;
Tejun Heo6fe29352015-06-25 15:01:30 -07003031
Robin Getz4d091612009-07-01 21:08:37 -04003032 if (newcon->flags & CON_PRINTBUFFER) {
Linus Torvalds1da177e2005-04-16 15:20:36 -07003033 /*
Torben Hohnac751ef2011-01-25 15:07:35 -08003034 * console_unlock(); will print out the buffered messages
Linus Torvalds1da177e2005-04-16 15:20:36 -07003035 * for us.
John Ogness505a27a2021-03-03 11:15:28 +01003036 *
Feng Tangfe3d8ad2011-03-22 16:34:21 -07003037 * We're about to replay the log buffer. Only do this to the
3038 * just-registered console to avoid excessive message spam to
3039 * the already-registered consoles.
Sergey Senozhatsky884e3702018-09-28 18:53:04 +09003040 *
3041 * Set exclusive_console with disabled interrupts to reduce
3042 * race window with eventual console_flush_on_panic() that
3043 * ignores console_lock.
Feng Tangfe3d8ad2011-03-22 16:34:21 -07003044 */
3045 exclusive_console = newcon;
Petr Mladekf92b0702018-09-13 14:34:06 +02003046 exclusive_console_stop_seq = console_seq;
John Ogness636babd2021-03-03 11:15:23 +01003047
3048 /* Get a consistent copy of @syslog_seq. */
John Ognessb371cbb2021-07-15 21:39:58 +02063049 mutex_lock(&syslog_lock);
John Ognessdef97da2019-12-19 12:59:22 +01063050 console_seq = syslog_seq;
John Ognessb371cbb2021-07-15 21:39:58 +02063051 mutex_unlock(&syslog_lock);
Linus Torvalds1da177e2005-04-16 15:20:36 -07003052 }
Torben Hohnac751ef2011-01-25 15:07:35 -08003053 console_unlock();
Kay Sieversfbc92a32010-12-01 18:51:05 +01003054 console_sysfs_notify();
Robin Getz8259cf42009-07-09 13:08:37 -04003055
3056 /*
3057 * By unregistering the bootconsoles after we enable the real console
3058 * we get the "console xxx enabled" message on all the consoles -
3059 * boot consoles, real consoles, etc - this is to ensure that end
3060 * users know there might be something in the kernel's log buffer that
3061 * went to the bootconsole (that they do not see on the real console)
3062 */
Andrew Morton27083ba2013-11-12 15:08:50 -08003063 pr_info("%sconsole [%s%d] enabled\n",
Kees Cook6b802392013-11-12 15:08:49 -08003064 (newcon->flags & CON_BOOT) ? "boot" : "" ,
3065 newcon->name, newcon->index);
Petr Mladek5e8ba482021-11-22 14:26:49 +01003066 if (bootcon_enabled &&
Fabio M. Di Nitto7bf69392011-03-22 16:34:20 -07003067 ((newcon->flags & (CON_CONSDEV | CON_BOOT)) == CON_CONSDEV) &&
3068 !keep_bootcon) {
Kees Cook6b802392013-11-12 15:08:49 -08003069 /* We need to iterate through all boot consoles, to make
3070 * sure we print everything out, before we unregister them.
Robin Getz8259cf42009-07-09 13:08:37 -04003071 */
Petr Mladek5e8ba482021-11-22 14:26:49 +01003072 for_each_console(con)
3073 if (con->flags & CON_BOOT)
3074 unregister_console(con);
Robin Getz8259cf42009-07-09 13:08:37 -04003075 }
Linus Torvalds1da177e2005-04-16 15:20:36 -07003076}
3077EXPORT_SYMBOL(register_console);
3078
Jesper Juhl40dc5652005-10-30 15:02:46 -08003079int unregister_console(struct console *console)
Linus Torvalds1da177e2005-04-16 15:20:36 -07003080{
Andy Shevchenko12825e62020-02-03 15:31:26 +02003081 struct console *con;
Joe Perchesbbeddf52013-07-31 13:53:45 -07003082 int res;
Linus Torvalds1da177e2005-04-16 15:20:36 -07003083
Andrew Morton27083ba2013-11-12 15:08:50 -08003084 pr_info("%sconsole [%s%d] disabled\n",
Kees Cook6b802392013-11-12 15:08:49 -08003085 (console->flags & CON_BOOT) ? "boot" : "" ,
3086 console->name, console->index);
3087
Joe Perchesbbeddf52013-07-31 13:53:45 -07003088 res = _braille_unregister_console(console);
Andy Shevchenkobb72e392020-02-03 15:31:28 +02003089 if (res < 0)
Joe Perchesbbeddf52013-07-31 13:53:45 -07003090 return res;
Andy Shevchenkobb72e392020-02-03 15:31:28 +02003091 if (res > 0)
3092 return 0;
Samuel Thibaultf7511d52008-04-30 00:54:51 -07003093
Andy Shevchenkobb72e392020-02-03 15:31:28 +02003094 res = -ENODEV;
Torben Hohnac751ef2011-01-25 15:07:35 -08003095 console_lock();
Linus Torvalds1da177e2005-04-16 15:20:36 -07003096 if (console_drivers == console) {
3097 console_drivers=console->next;
3098 res = 0;
Andy Shevchenko12825e62020-02-03 15:31:26 +02003099 } else {
3100 for_each_console(con) {
3101 if (con->next == console) {
3102 con->next = console->next;
Linus Torvalds1da177e2005-04-16 15:20:36 -07003103 res = 0;
3104 break;
Jesper Juhl40dc5652005-10-30 15:02:46 -08003105 }
Linus Torvalds1da177e2005-04-16 15:20:36 -07003106 }
3107 }
Jesper Juhl40dc5652005-10-30 15:02:46 -08003108
Andy Shevchenkoe78bedb2020-02-03 15:31:29 +02003109 if (res)
3110 goto out_disable_unlock;
3111
3112 if (console->flags & CON_EXTENDED)
Tejun Heo6fe29352015-06-25 15:01:30 -07003113 nr_ext_console_drivers--;
3114
Gerd Hoffmann69331af2007-05-08 00:26:49 -07003115 /*
Greg Edwardsab4af032005-06-23 00:09:05 -07003116 * If this isn't the last console and it has CON_CONSDEV set, we
3117 * need to set it on the next preferred console.
Linus Torvalds1da177e2005-04-16 15:20:36 -07003118 */
Gerd Hoffmann69331af2007-05-08 00:26:49 -07003119 if (console_drivers != NULL && console->flags & CON_CONSDEV)
Greg Edwardsab4af032005-06-23 00:09:05 -07003120 console_drivers->flags |= CON_CONSDEV;
Linus Torvalds1da177e2005-04-16 15:20:36 -07003121
Stephen Chivers7fa21dd2014-05-14 08:04:39 +10003122 console->flags &= ~CON_ENABLED;
Torben Hohnac751ef2011-01-25 15:07:35 -08003123 console_unlock();
Kay Sieversfbc92a32010-12-01 18:51:05 +01003124 console_sysfs_notify();
Andy Shevchenkoe78bedb2020-02-03 15:31:29 +02003125
Andy Shevchenkoed316852020-02-03 15:31:30 +02003126 if (console->exit)
3127 res = console->exit(console);
3128
Andy Shevchenkoe78bedb2020-02-03 15:31:29 +02003129 return res;
3130
3131out_disable_unlock:
3132 console->flags &= ~CON_ENABLED;
3133 console_unlock();
3134
Linus Torvalds1da177e2005-04-16 15:20:36 -07003135 return res;
3136}
3137EXPORT_SYMBOL(unregister_console);
Matt Mackalld59745c2005-05-01 08:59:02 -07003138
Thierry Reding81cc26f2016-01-15 16:58:21 -08003139/*
Nicolas Pitre0c688612017-04-12 18:37:14 -04003140 * Initialize the console device. This is called *early*, so
3141 * we can't necessarily depend on lots of kernel help here.
3142 * Just do some early initializations, and do the complex setup
3143 * later.
3144 */
3145void __init console_init(void)
3146{
Abderrahmane Benbachir58eacff2018-03-22 20:33:28 -04003147 int ret;
Ard Biesheuvel1b1eeca2018-08-21 21:56:13 -07003148 initcall_t call;
3149 initcall_entry_t *ce;
Nicolas Pitre0c688612017-04-12 18:37:14 -04003150
3151 /* Setup the default TTY line discipline. */
3152 n_tty_init();
3153
3154 /*
3155 * set up the console device so that later boot sequences can
3156 * inform about problems etc..
3157 */
Ard Biesheuvel1b1eeca2018-08-21 21:56:13 -07003158 ce = __con_initcall_start;
Abderrahmane Benbachir58eacff2018-03-22 20:33:28 -04003159 trace_initcall_level("console");
Ard Biesheuvel1b1eeca2018-08-21 21:56:13 -07003160 while (ce < __con_initcall_end) {
3161 call = initcall_from_entry(ce);
3162 trace_initcall_start(call);
3163 ret = call();
3164 trace_initcall_finish(call, ret);
3165 ce++;
Nicolas Pitre0c688612017-04-12 18:37:14 -04003166 }
3167}
3168
3169/*
Thierry Reding81cc26f2016-01-15 16:58:21 -08003170 * Some boot consoles access data that is in the init section and which will
3171 * be discarded after the initcalls have been run. To make sure that no code
3172 * will access this data, unregister the boot consoles in a late initcall.
3173 *
3174 * If for some reason, such as deferred probe or the driver being a loadable
3175 * module, the real console hasn't registered yet at this point, there will
3176 * be a brief interval in which no messages are logged to the console, which
3177 * makes it difficult to diagnose problems that occur during this time.
3178 *
3179 * To mitigate this problem somewhat, only unregister consoles whose memory
Matt Redfearn2b1be682017-07-14 14:51:12 +02003180 * intersects with the init section. Note that all other boot consoles will
Bhaskar Chowdhuryacebb552021-03-28 10:09:32 +05303181 * get unregistered when the real preferred console is registered.
Thierry Reding81cc26f2016-01-15 16:58:21 -08003182 */
Kevin Cernekee034260d2010-06-03 22:11:25 -07003183static int __init printk_late_init(void)
Robin Getz0c5564b2007-08-20 15:22:47 -04003184{
Robin Getz4d091612009-07-01 21:08:37 -04003185 struct console *con;
Sebastian Andrzej Siewior90b14882016-11-03 15:49:58 +01003186 int ret;
Robin Getz4d091612009-07-01 21:08:37 -04003187
3188 for_each_console(con) {
Petr Mladek5a814232017-07-14 14:51:13 +02003189 if (!(con->flags & CON_BOOT))
3190 continue;
3191
3192 /* Check addresses that might be used for enabled consoles. */
3193 if (init_section_intersects(con, sizeof(*con)) ||
3194 init_section_contains(con->write, 0) ||
3195 init_section_contains(con->read, 0) ||
3196 init_section_contains(con->device, 0) ||
3197 init_section_contains(con->unblank, 0) ||
3198 init_section_contains(con->data, 0)) {
Thierry Reding81cc26f2016-01-15 16:58:21 -08003199 /*
Matt Redfearn2b1be682017-07-14 14:51:12 +02003200 * Please, consider moving the reported consoles out
3201 * of the init section.
Thierry Reding81cc26f2016-01-15 16:58:21 -08003202 */
Matt Redfearn2b1be682017-07-14 14:51:12 +02003203 pr_warn("bootconsole [%s%d] uses init memory and must be disabled even before the real one is ready\n",
3204 con->name, con->index);
3205 unregister_console(con);
Robin Getzcb00e992007-08-21 23:14:58 -04003206 }
Robin Getz0c5564b2007-08-20 15:22:47 -04003207 }
Sebastian Andrzej Siewior90b14882016-11-03 15:49:58 +01003208 ret = cpuhp_setup_state_nocalls(CPUHP_PRINTK_DEAD, "printk:dead", NULL,
3209 console_cpu_notify);
3210 WARN_ON(ret < 0);
3211 ret = cpuhp_setup_state_nocalls(CPUHP_AP_ONLINE_DYN, "printk:online",
3212 console_cpu_notify, NULL);
3213 WARN_ON(ret < 0);
Xiaoming Nifaaa3572022-01-21 22:12:33 -08003214 printk_sysctl_init();
Robin Getz0c5564b2007-08-20 15:22:47 -04003215 return 0;
3216}
Kevin Cernekee034260d2010-06-03 22:11:25 -07003217late_initcall(printk_late_init);
Robin Getz0c5564b2007-08-20 15:22:47 -04003218
Joe Perches7ef3d2f2008-02-08 04:21:25 -08003219#if defined CONFIG_PRINTK
Frederic Weisbeckerdc72c322013-03-22 15:04:39 -07003220/*
3221 * Delayed printk version, for scheduler-internal messages:
3222 */
Frederic Weisbeckerdc72c322013-03-22 15:04:39 -07003223#define PRINTK_PENDING_WAKEUP 0x01
Steven Rostedt458df9f2014-06-04 16:11:38 -07003224#define PRINTK_PENDING_OUTPUT 0x02
Frederic Weisbeckerdc72c322013-03-22 15:04:39 -07003225
3226static DEFINE_PER_CPU(int, printk_pending);
Frederic Weisbeckerdc72c322013-03-22 15:04:39 -07003227
3228static void wake_up_klogd_work_func(struct irq_work *irq_work)
3229{
3230 int pending = __this_cpu_xchg(printk_pending, 0);
3231
Steven Rostedt458df9f2014-06-04 16:11:38 -07003232 if (pending & PRINTK_PENDING_OUTPUT) {
3233 /* If trylock fails, someone else is doing the printing */
3234 if (console_trylock())
3235 console_unlock();
Frederic Weisbeckerdc72c322013-03-22 15:04:39 -07003236 }
3237
3238 if (pending & PRINTK_PENDING_WAKEUP)
3239 wake_up_interruptible(&log_wait);
3240}
3241
Peter Zijlstra7a9f50a2020-06-15 11:51:29 +02003242static DEFINE_PER_CPU(struct irq_work, wake_up_klogd_work) =
3243 IRQ_WORK_INIT_LAZY(wake_up_klogd_work_func);
Frederic Weisbeckerdc72c322013-03-22 15:04:39 -07003244
3245void wake_up_klogd(void)
3246{
Sergey Senozhatskyab6f7622020-03-03 20:30:02 +09003247 if (!printk_percpu_data_ready())
3248 return;
3249
Frederic Weisbeckerdc72c322013-03-22 15:04:39 -07003250 preempt_disable();
3251 if (waitqueue_active(&log_wait)) {
3252 this_cpu_or(printk_pending, PRINTK_PENDING_WAKEUP);
Christoph Lameterbb964a92014-08-17 12:30:24 -05003253 irq_work_queue(this_cpu_ptr(&wake_up_klogd_work));
Frederic Weisbeckerdc72c322013-03-22 15:04:39 -07003254 }
3255 preempt_enable();
3256}
Dave Young717115e2008-07-25 01:45:58 -07003257
Petr Mladeka338f842018-06-27 16:08:16 +02003258void defer_console_output(void)
3259{
Sergey Senozhatskyab6f7622020-03-03 20:30:02 +09003260 if (!printk_percpu_data_ready())
3261 return;
3262
Petr Mladeka338f842018-06-27 16:08:16 +02003263 preempt_disable();
3264 __this_cpu_or(printk_pending, PRINTK_PENDING_OUTPUT);
3265 irq_work_queue(this_cpu_ptr(&wake_up_klogd_work));
3266 preempt_enable();
3267}
3268
Nicholas Piggin5d5e4522021-11-07 14:51:16 +10003269void printk_trigger_flush(void)
3270{
3271 defer_console_output();
3272}
3273
Petr Mladek719f6a72017-04-20 10:52:31 +02003274int vprintk_deferred(const char *fmt, va_list args)
3275{
3276 int r;
3277
John Ogness74caba72020-09-21 13:24:45 +02063278 r = vprintk_emit(0, LOGLEVEL_SCHED, NULL, fmt, args);
Petr Mladeka338f842018-06-27 16:08:16 +02003279 defer_console_output();
Petr Mladek719f6a72017-04-20 10:52:31 +02003280
3281 return r;
3282}
3283
Chris Down33701552021-06-15 17:52:53 +01003284int _printk_deferred(const char *fmt, ...)
Peter Zijlstra600e1452012-03-15 12:35:37 +01003285{
Peter Zijlstra600e1452012-03-15 12:35:37 +01003286 va_list args;
Peter Zijlstra600e1452012-03-15 12:35:37 +01003287 int r;
3288
Peter Zijlstra600e1452012-03-15 12:35:37 +01003289 va_start(args, fmt);
Petr Mladek719f6a72017-04-20 10:52:31 +02003290 r = vprintk_deferred(fmt, args);
Peter Zijlstra600e1452012-03-15 12:35:37 +01003291 va_end(args);
3292
Peter Zijlstra600e1452012-03-15 12:35:37 +01003293 return r;
3294}
3295
Linus Torvalds1da177e2005-04-16 15:20:36 -07003296/*
3297 * printk rate limiting, lifted from the networking subsystem.
3298 *
Uwe Kleine-König641de9d2008-07-29 22:33:38 -07003299 * This enforces a rate limit: not more than 10 kernel messages
3300 * every 5s to make a denial-of-service attack impossible.
Linus Torvalds1da177e2005-04-16 15:20:36 -07003301 */
Uwe Kleine-König641de9d2008-07-29 22:33:38 -07003302DEFINE_RATELIMIT_STATE(printk_ratelimit_state, 5 * HZ, 10);
3303
Christian Borntraeger5c828712009-10-23 14:58:11 +02003304int __printk_ratelimit(const char *func)
Linus Torvalds1da177e2005-04-16 15:20:36 -07003305{
Christian Borntraeger5c828712009-10-23 14:58:11 +02003306 return ___ratelimit(&printk_ratelimit_state, func);
Linus Torvalds1da177e2005-04-16 15:20:36 -07003307}
Christian Borntraeger5c828712009-10-23 14:58:11 +02003308EXPORT_SYMBOL(__printk_ratelimit);
Andrew Mortonf46c4832006-11-02 22:07:16 -08003309
3310/**
3311 * printk_timed_ratelimit - caller-controlled printk ratelimiting
3312 * @caller_jiffies: pointer to caller's state
3313 * @interval_msecs: minimum interval between prints
3314 *
3315 * printk_timed_ratelimit() returns true if more than @interval_msecs
3316 * milliseconds have elapsed since the last time printk_timed_ratelimit()
3317 * returned true.
3318 */
3319bool printk_timed_ratelimit(unsigned long *caller_jiffies,
3320 unsigned int interval_msecs)
3321{
Alex Elder249771b2014-08-06 16:09:08 -07003322 unsigned long elapsed = jiffies - *caller_jiffies;
3323
3324 if (*caller_jiffies && elapsed <= msecs_to_jiffies(interval_msecs))
3325 return false;
3326
3327 *caller_jiffies = jiffies;
3328 return true;
Andrew Mortonf46c4832006-11-02 22:07:16 -08003329}
3330EXPORT_SYMBOL(printk_timed_ratelimit);
Simon Kagstrom456b5652009-10-16 14:09:18 +02003331
3332static DEFINE_SPINLOCK(dump_list_lock);
3333static LIST_HEAD(dump_list);
3334
3335/**
3336 * kmsg_dump_register - register a kernel log dumper.
Randy Dunlap64855362009-12-17 15:27:27 -08003337 * @dumper: pointer to the kmsg_dumper structure
Simon Kagstrom456b5652009-10-16 14:09:18 +02003338 *
3339 * Adds a kernel log dumper to the system. The dump callback in the
3340 * structure will be called when the kernel oopses or panics and must be
3341 * set. Returns zero on success and %-EINVAL or %-EBUSY otherwise.
3342 */
3343int kmsg_dump_register(struct kmsg_dumper *dumper)
3344{
3345 unsigned long flags;
3346 int err = -EBUSY;
3347
3348 /* The dump callback needs to be set */
3349 if (!dumper->dump)
3350 return -EINVAL;
3351
3352 spin_lock_irqsave(&dump_list_lock, flags);
3353 /* Don't allow registering multiple times */
3354 if (!dumper->registered) {
3355 dumper->registered = 1;
Huang Yingfb842b002011-01-12 16:59:43 -08003356 list_add_tail_rcu(&dumper->list, &dump_list);
Simon Kagstrom456b5652009-10-16 14:09:18 +02003357 err = 0;
3358 }
3359 spin_unlock_irqrestore(&dump_list_lock, flags);
3360
3361 return err;
3362}
3363EXPORT_SYMBOL_GPL(kmsg_dump_register);
3364
3365/**
3366 * kmsg_dump_unregister - unregister a kmsg dumper.
Randy Dunlap64855362009-12-17 15:27:27 -08003367 * @dumper: pointer to the kmsg_dumper structure
Simon Kagstrom456b5652009-10-16 14:09:18 +02003368 *
3369 * Removes a dump device from the system. Returns zero on success and
3370 * %-EINVAL otherwise.
3371 */
3372int kmsg_dump_unregister(struct kmsg_dumper *dumper)
3373{
3374 unsigned long flags;
3375 int err = -EINVAL;
3376
3377 spin_lock_irqsave(&dump_list_lock, flags);
3378 if (dumper->registered) {
3379 dumper->registered = 0;
Huang Yingfb842b002011-01-12 16:59:43 -08003380 list_del_rcu(&dumper->list);
Simon Kagstrom456b5652009-10-16 14:09:18 +02003381 err = 0;
3382 }
3383 spin_unlock_irqrestore(&dump_list_lock, flags);
Huang Yingfb842b002011-01-12 16:59:43 -08003384 synchronize_rcu();
Simon Kagstrom456b5652009-10-16 14:09:18 +02003385
3386 return err;
3387}
3388EXPORT_SYMBOL_GPL(kmsg_dump_unregister);
3389
Kay Sievers7ff95542012-05-03 02:29:13 +02003390static bool always_kmsg_dump;
3391module_param_named(always_kmsg_dump, always_kmsg_dump, bool, S_IRUGO | S_IWUSR);
3392
Kees Cookfb13cb82020-05-07 19:36:22 -07003393const char *kmsg_dump_reason_str(enum kmsg_dump_reason reason)
3394{
3395 switch (reason) {
3396 case KMSG_DUMP_PANIC:
3397 return "Panic";
3398 case KMSG_DUMP_OOPS:
3399 return "Oops";
3400 case KMSG_DUMP_EMERG:
3401 return "Emergency";
3402 case KMSG_DUMP_SHUTDOWN:
3403 return "Shutdown";
3404 default:
3405 return "Unknown";
3406 }
3407}
3408EXPORT_SYMBOL_GPL(kmsg_dump_reason_str);
3409
Simon Kagstrom456b5652009-10-16 14:09:18 +02003410/**
3411 * kmsg_dump - dump kernel log to kernel message dumpers.
3412 * @reason: the reason (oops, panic etc) for dumping
3413 *
Kay Sieverse2ae7152012-06-15 14:07:51 +02003414 * Call each of the registered dumper's dump() callback, which can
3415 * retrieve the kmsg records with kmsg_dump_get_line() or
3416 * kmsg_dump_get_buffer().
Simon Kagstrom456b5652009-10-16 14:09:18 +02003417 */
3418void kmsg_dump(enum kmsg_dump_reason reason)
3419{
Simon Kagstrom456b5652009-10-16 14:09:18 +02003420 struct kmsg_dumper *dumper;
Simon Kagstrom456b5652009-10-16 14:09:18 +02003421
Huang Yingfb842b002011-01-12 16:59:43 -08003422 rcu_read_lock();
Kay Sieverse2ae7152012-06-15 14:07:51 +02003423 list_for_each_entry_rcu(dumper, &dump_list, list) {
Pavel Tatashinb1f6f162020-05-05 11:45:06 -04003424 enum kmsg_dump_reason max_reason = dumper->max_reason;
3425
3426 /*
3427 * If client has not provided a specific max_reason, default
3428 * to KMSG_DUMP_OOPS, unless always_kmsg_dump was set.
3429 */
3430 if (max_reason == KMSG_DUMP_UNDEF) {
3431 max_reason = always_kmsg_dump ? KMSG_DUMP_MAX :
3432 KMSG_DUMP_OOPS;
3433 }
3434 if (reason > max_reason)
Kay Sieverse2ae7152012-06-15 14:07:51 +02003435 continue;
3436
Kay Sieverse2ae7152012-06-15 14:07:51 +02003437 /* invoke dumper which will iterate over records */
3438 dumper->dump(dumper, reason);
Kay Sieverse2ae7152012-06-15 14:07:51 +02003439 }
Huang Yingfb842b002011-01-12 16:59:43 -08003440 rcu_read_unlock();
Simon Kagstrom456b5652009-10-16 14:09:18 +02003441}
Kay Sieverse2ae7152012-06-15 14:07:51 +02003442
3443/**
John Ognessa4f98762021-03-03 11:15:27 +01003444 * kmsg_dump_get_line - retrieve one kmsg log line
John Ognessf9f3f022021-03-03 11:15:25 +01003445 * @iter: kmsg dump iterator
Anton Vorontsov533827c2012-07-20 17:28:07 -07003446 * @syslog: include the "<4>" prefixes
3447 * @line: buffer to copy the line to
3448 * @size: maximum size of the buffer
3449 * @len: length of line placed into buffer
3450 *
3451 * Start at the beginning of the kmsg buffer, with the oldest kmsg
3452 * record, and copy one record into the provided buffer.
3453 *
3454 * Consecutive calls will return the next available record moving
3455 * towards the end of the buffer with the youngest messages.
3456 *
3457 * A return value of FALSE indicates that there are no more records to
3458 * read.
Anton Vorontsov533827c2012-07-20 17:28:07 -07003459 */
John Ognessa4f98762021-03-03 11:15:27 +01003460bool kmsg_dump_get_line(struct kmsg_dump_iter *iter, bool syslog,
3461 char *line, size_t size, size_t *len)
Anton Vorontsov533827c2012-07-20 17:28:07 -07003462{
John Ognessf9f3f022021-03-03 11:15:25 +01003463 u64 min_seq = latched_seq_read_nolock(&clear_seq);
John Ogness896fbe22020-07-09 15:29:44 +02063464 struct printk_info info;
3465 unsigned int line_count;
3466 struct printk_record r;
Anton Vorontsov533827c2012-07-20 17:28:07 -07003467 size_t l = 0;
3468 bool ret = false;
3469
John Ognessf9f3f022021-03-03 11:15:25 +01003470 if (iter->cur_seq < min_seq)
3471 iter->cur_seq = min_seq;
3472
John Ognessf35efc72020-09-19 00:40:21 +02063473 prb_rec_init_rd(&r, &info, line, size);
John Ogness896fbe22020-07-09 15:29:44 +02063474
John Ogness896fbe22020-07-09 15:29:44 +02063475 /* Read text or count text lines? */
3476 if (line) {
John Ognessf9f3f022021-03-03 11:15:25 +01003477 if (!prb_read_valid(prb, iter->cur_seq, &r))
John Ogness896fbe22020-07-09 15:29:44 +02063478 goto out;
3479 l = record_print_text(&r, syslog, printk_time);
3480 } else {
John Ognessf9f3f022021-03-03 11:15:25 +01003481 if (!prb_read_valid_info(prb, iter->cur_seq,
John Ogness896fbe22020-07-09 15:29:44 +02063482 &info, &line_count)) {
3483 goto out;
3484 }
3485 l = get_record_print_text_size(&info, line_count, syslog,
3486 printk_time);
3487
Anton Vorontsov533827c2012-07-20 17:28:07 -07003488 }
3489
John Ognessf9f3f022021-03-03 11:15:25 +01003490 iter->cur_seq = r.info->seq + 1;
Anton Vorontsov533827c2012-07-20 17:28:07 -07003491 ret = true;
3492out:
3493 if (len)
3494 *len = l;
3495 return ret;
3496}
Kay Sieverse2ae7152012-06-15 14:07:51 +02003497EXPORT_SYMBOL_GPL(kmsg_dump_get_line);
3498
3499/**
3500 * kmsg_dump_get_buffer - copy kmsg log lines
John Ognessf9f3f022021-03-03 11:15:25 +01003501 * @iter: kmsg dump iterator
Kay Sieverse2ae7152012-06-15 14:07:51 +02003502 * @syslog: include the "<4>" prefixes
Randy Dunlap4f0f4af2012-06-30 15:37:24 -07003503 * @buf: buffer to copy the line to
Kay Sieverse2ae7152012-06-15 14:07:51 +02003504 * @size: maximum size of the buffer
John Ogness726b5092021-03-03 11:15:18 +01003505 * @len_out: length of line placed into buffer
Kay Sieverse2ae7152012-06-15 14:07:51 +02003506 *
3507 * Start at the end of the kmsg buffer and fill the provided buffer
Randy Dunlap547bbf72020-08-06 20:32:27 -07003508 * with as many of the *youngest* kmsg records that fit into it.
Kay Sieverse2ae7152012-06-15 14:07:51 +02003509 * If the buffer is large enough, all available kmsg records will be
3510 * copied with a single call.
3511 *
3512 * Consecutive calls will fill the buffer with the next block of
3513 * available older records, not including the earlier retrieved ones.
3514 *
3515 * A return value of FALSE indicates that there are no more records to
3516 * read.
3517 */
John Ognessf9f3f022021-03-03 11:15:25 +01003518bool kmsg_dump_get_buffer(struct kmsg_dump_iter *iter, bool syslog,
John Ogness726b5092021-03-03 11:15:18 +01003519 char *buf, size_t size, size_t *len_out)
Kay Sieverse2ae7152012-06-15 14:07:51 +02003520{
John Ognessf9f3f022021-03-03 11:15:25 +01003521 u64 min_seq = latched_seq_read_nolock(&clear_seq);
John Ogness896fbe22020-07-09 15:29:44 +02063522 struct printk_info info;
John Ogness896fbe22020-07-09 15:29:44 +02063523 struct printk_record r;
Kay Sieverse2ae7152012-06-15 14:07:51 +02003524 u64 seq;
Kay Sieverse2ae7152012-06-15 14:07:51 +02003525 u64 next_seq;
John Ogness726b5092021-03-03 11:15:18 +01003526 size_t len = 0;
Kay Sieverse2ae7152012-06-15 14:07:51 +02003527 bool ret = false;
Tetsuo Handae80c1a92018-12-04 19:00:01 +09003528 bool time = printk_time;
Kay Sieverse2ae7152012-06-15 14:07:51 +02003529
John Ogness5f6c7642021-03-03 11:15:24 +01003530 if (!buf || !size)
Kay Sieverse2ae7152012-06-15 14:07:51 +02003531 goto out;
3532
John Ognessf9f3f022021-03-03 11:15:25 +01003533 if (iter->cur_seq < min_seq)
3534 iter->cur_seq = min_seq;
3535
John Ognessf9f3f022021-03-03 11:15:25 +01003536 if (prb_read_valid_info(prb, iter->cur_seq, &info, NULL)) {
3537 if (info.seq != iter->cur_seq) {
John Ogness13791c82021-02-11 18:37:52 +01063538 /* messages are gone, move to first available one */
John Ognessf9f3f022021-03-03 11:15:25 +01003539 iter->cur_seq = info.seq;
John Ogness13791c82021-02-11 18:37:52 +01063540 }
Kay Sieverse2ae7152012-06-15 14:07:51 +02003541 }
3542
3543 /* last entry */
John Ogness93d102f2021-07-15 21:39:56 +02063544 if (iter->cur_seq >= iter->next_seq)
Kay Sieverse2ae7152012-06-15 14:07:51 +02003545 goto out;
Kay Sieverse2ae7152012-06-15 14:07:51 +02003546
John Ogness726b5092021-03-03 11:15:18 +01003547 /*
3548 * Find first record that fits, including all following records,
John Ogness4260e0e552021-03-03 11:15:19 +01003549 * into the user-provided buffer for this dump. Pass in size-1
3550 * because this function (by way of record_print_text()) will
3551 * not write more than size-1 bytes of text into @buf.
John Ogness726b5092021-03-03 11:15:18 +01003552 */
John Ognessf9f3f022021-03-03 11:15:25 +01003553 seq = find_first_fitting_seq(iter->cur_seq, iter->next_seq,
John Ogness4260e0e552021-03-03 11:15:19 +01003554 size - 1, syslog, time);
Kay Sieverse2ae7152012-06-15 14:07:51 +02003555
John Ogness726b5092021-03-03 11:15:18 +01003556 /*
3557 * Next kmsg_dump_get_buffer() invocation will dump block of
3558 * older records stored right before this one.
3559 */
Kay Sieverse2ae7152012-06-15 14:07:51 +02003560 next_seq = seq;
Kay Sieverse2ae7152012-06-15 14:07:51 +02003561
John Ogness726b5092021-03-03 11:15:18 +01003562 prb_rec_init_rd(&r, &info, buf, size);
3563
3564 len = 0;
3565 prb_for_each_record(seq, prb, seq, &r) {
John Ognessf9f3f022021-03-03 11:15:25 +01003566 if (r.info->seq >= iter->next_seq)
John Ogness896fbe22020-07-09 15:29:44 +02063567 break;
Kay Sieverse2ae7152012-06-15 14:07:51 +02003568
John Ogness726b5092021-03-03 11:15:18 +01003569 len += record_print_text(&r, syslog, time);
John Ogness896fbe22020-07-09 15:29:44 +02063570
John Ogness726b5092021-03-03 11:15:18 +01003571 /* Adjust record to store to remaining buffer space. */
3572 prb_rec_init_rd(&r, &info, buf + len, size - len);
Kay Sieverse2ae7152012-06-15 14:07:51 +02003573 }
3574
John Ognessf9f3f022021-03-03 11:15:25 +01003575 iter->next_seq = next_seq;
Kay Sieverse2ae7152012-06-15 14:07:51 +02003576 ret = true;
Kay Sieverse2ae7152012-06-15 14:07:51 +02003577out:
John Ogness726b5092021-03-03 11:15:18 +01003578 if (len_out)
3579 *len_out = len;
Kay Sieverse2ae7152012-06-15 14:07:51 +02003580 return ret;
3581}
3582EXPORT_SYMBOL_GPL(kmsg_dump_get_buffer);
3583
3584/**
Ethon Paul325606a2020-04-18 19:35:36 +08003585 * kmsg_dump_rewind - reset the iterator
John Ognessf9f3f022021-03-03 11:15:25 +01003586 * @iter: kmsg dump iterator
Kay Sieverse2ae7152012-06-15 14:07:51 +02003587 *
3588 * Reset the dumper's iterator so that kmsg_dump_get_line() and
3589 * kmsg_dump_get_buffer() can be called again and used multiple
3590 * times within the same dumper.dump() callback.
3591 */
John Ognessf9f3f022021-03-03 11:15:25 +01003592void kmsg_dump_rewind(struct kmsg_dump_iter *iter)
Kay Sieverse2ae7152012-06-15 14:07:51 +02003593{
John Ognessa4f98762021-03-03 11:15:27 +01003594 iter->cur_seq = latched_seq_read_nolock(&clear_seq);
3595 iter->next_seq = prb_next_seq(prb);
Kay Sieverse2ae7152012-06-15 14:07:51 +02003596}
3597EXPORT_SYMBOL_GPL(kmsg_dump_rewind);
Tejun Heo196779b2013-04-30 15:27:12 -07003598
Joe Perches7ef3d2f2008-02-08 04:21:25 -08003599#endif
John Ogness766c2682021-06-17 11:56:50 +02063600
3601#ifdef CONFIG_SMP
3602static atomic_t printk_cpulock_owner = ATOMIC_INIT(-1);
3603static atomic_t printk_cpulock_nested = ATOMIC_INIT(0);
3604
3605/**
3606 * __printk_wait_on_cpu_lock() - Busy wait until the printk cpu-reentrant
3607 * spinning lock is not owned by any CPU.
3608 *
3609 * Context: Any context.
3610 */
3611void __printk_wait_on_cpu_lock(void)
3612{
3613 do {
3614 cpu_relax();
3615 } while (atomic_read(&printk_cpulock_owner) != -1);
3616}
3617EXPORT_SYMBOL(__printk_wait_on_cpu_lock);
3618
3619/**
3620 * __printk_cpu_trylock() - Try to acquire the printk cpu-reentrant
3621 * spinning lock.
3622 *
3623 * If no processor has the lock, the calling processor takes the lock and
3624 * becomes the owner. If the calling processor is already the owner of the
3625 * lock, this function succeeds immediately.
3626 *
3627 * Context: Any context. Expects interrupts to be disabled.
3628 * Return: 1 on success, otherwise 0.
3629 */
3630int __printk_cpu_trylock(void)
3631{
3632 int cpu;
3633 int old;
3634
3635 cpu = smp_processor_id();
3636
John Ogness3342aa82021-06-17 11:56:51 +02063637 /*
3638 * Guarantee loads and stores from this CPU when it is the lock owner
3639 * are _not_ visible to the previous lock owner. This pairs with
3640 * __printk_cpu_unlock:B.
3641 *
3642 * Memory barrier involvement:
3643 *
3644 * If __printk_cpu_trylock:A reads from __printk_cpu_unlock:B, then
3645 * __printk_cpu_unlock:A can never read from __printk_cpu_trylock:B.
3646 *
3647 * Relies on:
3648 *
3649 * RELEASE from __printk_cpu_unlock:A to __printk_cpu_unlock:B
3650 * of the previous CPU
3651 * matching
3652 * ACQUIRE from __printk_cpu_trylock:A to __printk_cpu_trylock:B
3653 * of this CPU
3654 */
3655 old = atomic_cmpxchg_acquire(&printk_cpulock_owner, -1,
3656 cpu); /* LMM(__printk_cpu_trylock:A) */
John Ogness766c2682021-06-17 11:56:50 +02063657 if (old == -1) {
John Ogness3342aa82021-06-17 11:56:51 +02063658 /*
3659 * This CPU is now the owner and begins loading/storing
3660 * data: LMM(__printk_cpu_trylock:B)
3661 */
John Ogness766c2682021-06-17 11:56:50 +02063662 return 1;
John Ogness3342aa82021-06-17 11:56:51 +02063663
John Ogness766c2682021-06-17 11:56:50 +02063664 } else if (old == cpu) {
3665 /* This CPU is already the owner. */
3666 atomic_inc(&printk_cpulock_nested);
3667 return 1;
3668 }
3669
3670 return 0;
3671}
3672EXPORT_SYMBOL(__printk_cpu_trylock);
3673
3674/**
3675 * __printk_cpu_unlock() - Release the printk cpu-reentrant spinning lock.
3676 *
3677 * The calling processor must be the owner of the lock.
3678 *
3679 * Context: Any context. Expects interrupts to be disabled.
3680 */
3681void __printk_cpu_unlock(void)
3682{
3683 if (atomic_read(&printk_cpulock_nested)) {
3684 atomic_dec(&printk_cpulock_nested);
3685 return;
3686 }
3687
John Ogness3342aa82021-06-17 11:56:51 +02063688 /*
3689 * This CPU is finished loading/storing data:
3690 * LMM(__printk_cpu_unlock:A)
3691 */
3692
3693 /*
3694 * Guarantee loads and stores from this CPU when it was the
3695 * lock owner are visible to the next lock owner. This pairs
3696 * with __printk_cpu_trylock:A.
3697 *
3698 * Memory barrier involvement:
3699 *
3700 * If __printk_cpu_trylock:A reads from __printk_cpu_unlock:B,
3701 * then __printk_cpu_trylock:B reads from __printk_cpu_unlock:A.
3702 *
3703 * Relies on:
3704 *
3705 * RELEASE from __printk_cpu_unlock:A to __printk_cpu_unlock:B
3706 * of this CPU
3707 * matching
3708 * ACQUIRE from __printk_cpu_trylock:A to __printk_cpu_trylock:B
3709 * of the next CPU
3710 */
3711 atomic_set_release(&printk_cpulock_owner,
3712 -1); /* LMM(__printk_cpu_unlock:B) */
John Ogness766c2682021-06-17 11:56:50 +02063713}
3714EXPORT_SYMBOL(__printk_cpu_unlock);
3715#endif /* CONFIG_SMP */