------------[ cut here ]------------ ====================================================== WARNING: possible circular locking dependency detected syzkaller #0 Tainted: G L ------------------------------------------------------ swapper/0/0 is trying to acquire lock: ffffffff8ecf5ac0 (console_owner){-.-.}-{0:0}, at: console_lock_spinning_enable+0x61/0x80 kernel/printk/printk.c:1902 but task is already holding lock: ffff88802b23baa0 (&rq->__lock){-.-.}-{2:2}, at: raw_spin_rq_lock_nested kernel/sched/core.c:685 [inline] ffff88802b23baa0 (&rq->__lock){-.-.}-{2:2}, at: raw_spin_rq_lock_nested+0x88/0x140 kernel/sched/core.c:669 which lock already depends on the new lock. the existing dependency chain (in reverse order) is: -> #4 (&rq->__lock){-.-.}-{2:2}: lock_acquire kernel/locking/lockdep.c:5886 [inline] lock_acquire+0x1b9/0x370 kernel/locking/lockdep.c:5843 _raw_spin_lock_nested+0x31/0x40 kernel/locking/spinlock.c:413 raw_spin_rq_lock_nested+0x2c/0x140 kernel/sched/core.c:677 raw_spin_rq_lock kernel/sched/sched.h:1678 [inline] _task_rq_lock+0xcf/0x500 kernel/sched/core.c:772 cgroup_move_task+0x81/0x320 kernel/sched/psi.c:1176 css_set_move_task+0x285/0x600 kernel/cgroup/cgroup.c:927 cgroup_post_fork+0x1f9/0x9a0 kernel/cgroup/cgroup.c:7084 copy_process+0x64da/0x8370 kernel/fork.c:2574 kernel_clone+0x176/0x9d0 kernel/fork.c:2772 rest_init+0xa3/0x2e0 init/main.c:688 start_kernel+0x48e/0x490 init/main.c:1181 x86_64_start_reservations+0x24/0x30 arch/x86/kernel/head64.c:310 x86_64_start_kernel+0x12b/0x130 arch/x86/kernel/head64.c:291 common_startup_64+0x13e/0x158 -> #3 (&p->pi_lock){-.-.}-{2:2}: lock_acquire kernel/locking/lockdep.c:5886 [inline] lock_acquire+0x1b9/0x370 kernel/locking/lockdep.c:5843 __raw_spin_lock_irq_disable include/linux/spinlock_api_smp.h:174 [inline] _raw_spin_lock_irq_disable+0x5e/0x90 kernel/locking/spinlock.c:197 class_raw_spinlock_irqsave_constructor include/linux/spinlock.h:594 [inline] try_to_wake_up+0xc1/0x1c90 kernel/sched/core.c:4302 __queue_work+0x4a6/0x1370 kernel/workqueue.c:2458 queue_work_on+0x1a9/0x1e0 kernel/workqueue.c:2501 queue_work include/linux/workqueue.h:699 [inline] rpm_suspend+0xf6b/0x1220 drivers/base/power/runtime.c:685 rpm_idle+0x60c/0x790 drivers/base/power/runtime.c:559 __pm_runtime_idle+0xba/0x1a0 drivers/base/power/runtime.c:1129 pm_runtime_put include/linux/pm_runtime.h:551 [inline] __device_attach+0x37e/0x4d0 drivers/base/dd.c:1116 device_initial_probe+0xaf/0xd0 drivers/base/dd.c:1153 bus_probe_device+0x64/0x160 drivers/base/bus.c:620 device_add+0x121d/0x1970 drivers/base/core.c:3776 serial_base_port_add+0x227/0x2b0 drivers/tty/serial/serial_base_bus.c:186 serial_core_port_device_add drivers/tty/serial/serial_core.c:3275 [inline] serial_core_register_port+0x13c/0x16f0 drivers/tty/serial/serial_core.c:3314 serial8250_register_8250_port+0x15af/0x2330 drivers/tty/serial/8250/8250_core.c:828 serial_pnp_probe+0x436/0x930 drivers/tty/serial/8250/8250_pnp.c:480 pnp_device_probe+0x2b3/0x4a0 drivers/pnp/driver.c:111 call_driver_probe drivers/base/dd.c:628 [inline] really_probe+0x241/0xa60 drivers/base/dd.c:706 __driver_probe_device+0x210/0x460 drivers/base/dd.c:868 driver_probe_device+0x4a/0x140 drivers/base/dd.c:898 __driver_attach+0x21f/0x5b0 drivers/base/dd.c:1292 bus_for_each_dev+0x13e/0x1d0 drivers/base/bus.c:383 bus_add_driver+0x305/0x5b0 drivers/base/bus.c:763 driver_register+0x1e2/0x360 drivers/base/driver.c:174 serial8250_init+0xcc/0x1c0 drivers/tty/serial/8250/8250_platform.c:317 do_one_initcall+0x11c/0x6f0 init/main.c:1353 do_initcall_level init/main.c:1415 [inline] do_initcalls init/main.c:1431 [inline] do_basic_setup init/main.c:1451 [inline] kernel_init_freeable+0x6ea/0x7b0 init/main.c:1666 kernel_init+0x21/0x1e0 init/main.c:1556 ret_from_fork+0x730/0xd60 arch/x86/kernel/process.c:158 ret_from_fork_asm+0x1a/0x30 arch/x86/entry/entry_64.S:245 -> #2 (&dev->power.lock){-.-.}-{3:3}: lock_acquire kernel/locking/lockdep.c:5886 [inline] lock_acquire+0x1b9/0x370 kernel/locking/lockdep.c:5843 __raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:155 [inline] _raw_spin_lock_irqsave+0x3a/0x60 kernel/locking/spinlock.c:181 __pm_runtime_resume+0xa9/0x170 drivers/base/power/runtime.c:1196 pm_runtime_get include/linux/pm_runtime.h:494 [inline] __uart_start+0x1b0/0x510 drivers/tty/serial/serial_core.c:149 uart_write+0x211/0xb20 drivers/tty/serial/serial_core.c:629 process_output_block drivers/tty/n_tty.c:557 [inline] n_tty_write+0x431/0x1160 drivers/tty/n_tty.c:2366 iterate_tty_write drivers/tty/tty_io.c:1006 [inline] file_tty_write.isra.0+0x4d2/0x890 drivers/tty/tty_io.c:1054 tty_write drivers/tty/tty_io.c:1075 [inline] redirected_tty_write drivers/tty/tty_io.c:1098 [inline] redirected_tty_write+0xd4/0x120 drivers/tty/tty_io.c:1078 new_sync_write fs/read_write.c:595 [inline] vfs_write+0x6af/0x1050 fs/read_write.c:687 ksys_write+0x12a/0x250 fs/read_write.c:739 do_syscall_x64 arch/x86/entry/syscall_64.c:61 [inline] do_syscall_64+0x121/0x770 arch/x86/entry/syscall_64.c:84 entry_SYSCALL_64_after_hwframe+0x77/0x7f -> #1 (&port_lock_key){-.-.}-{3:3}: lock_acquire kernel/locking/lockdep.c:5886 [inline] lock_acquire+0x1b9/0x370 kernel/locking/lockdep.c:5843 __raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:155 [inline] _raw_spin_lock_irqsave+0x3a/0x60 kernel/locking/spinlock.c:181 uart_port_lock_irqsave include/linux/serial_core.h:719 [inline] serial8250_console_write+0x177/0x1a50 drivers/tty/serial/8250/8250_port.c:3344 console_emit_next_record kernel/printk/printk.c:3183 [inline] console_flush_one_record+0x78e/0xf10 kernel/printk/printk.c:3268 console_flush_all kernel/printk/printk.c:3350 [inline] __console_flush_and_unlock kernel/printk/printk.c:3380 [inline] console_unlock+0x103/0x260 kernel/printk/printk.c:3420 vprintk_emit+0x407/0x6b0 kernel/printk/printk.c:2479 _printk+0xcf/0x110 kernel/printk/printk.c:2504 register_console.cold+0xc0/0x248 kernel/printk/printk.c:4212 univ8250_console_init+0x6f/0x80 drivers/tty/serial/8250/8250_core.c:515 console_init+0x3d5/0x5b0 kernel/printk/printk.c:4411 start_kernel+0x314/0x490 init/main.c:1118 x86_64_start_reservations+0x24/0x30 arch/x86/kernel/head64.c:310 x86_64_start_kernel+0x12b/0x130 arch/x86/kernel/head64.c:291 common_startup_64+0x13e/0x158 -> #0 (console_owner){-.-.}-{0:0}: check_prev_add+0xeb/0xe60 kernel/locking/lockdep.c:3181 check_prevs_add kernel/locking/lockdep.c:3300 [inline] validate_chain kernel/locking/lockdep.c:3924 [inline] __lock_acquire+0x1492/0x1ec0 kernel/locking/lockdep.c:5253 lock_acquire kernel/locking/lockdep.c:5886 [inline] lock_acquire+0x1b9/0x370 kernel/locking/lockdep.c:5843 console_lock_spinning_enable+0x72/0x80 kernel/printk/printk.c:1902 console_emit_next_record kernel/printk/printk.c:3177 [inline] console_flush_one_record+0x737/0xf10 kernel/printk/printk.c:3268 console_flush_all kernel/printk/printk.c:3350 [inline] __console_flush_and_unlock kernel/printk/printk.c:3380 [inline] console_unlock+0x103/0x260 kernel/printk/printk.c:3420 vprintk_emit+0x407/0x6b0 kernel/printk/printk.c:2479 _printk+0xcf/0x110 kernel/printk/printk.c:2504 __report_bug.cold+0x34/0x141 lib/bug.c:248 report_bug+0xb3/0x220 lib/bug.c:286 handle_bug+0x16a/0x2a0 arch/x86/kernel/traps.c:436 exc_invalid_op+0x17/0x50 arch/x86/kernel/traps.c:490 asm_exc_invalid_op+0x1a/0x20 arch/x86/include/asm/idtentry.h:593 lockdep_assert_rq_held kernel/sched/sched.h:1666 [inline] lockdep_assert_rq_held kernel/sched/sched.h:1663 [inline] update_rq_clock+0x40a/0xd20 kernel/sched/core.c:875 pick_next_task kernel/sched/core.c:6361 [inline] __schedule+0x1c69/0x6920 kernel/sched/core.c:7185 schedule_idle+0x54/0x80 kernel/sched/core.c:7388 do_idle+0x365/0x5b0 kernel/sched/idle.c:384 cpu_startup_entry+0x4f/0x60 kernel/sched/idle.c:454 rest_init+0x2d3/0x2e0 init/main.c:723 start_kernel+0x48e/0x490 init/main.c:1181 x86_64_start_reservations+0x24/0x30 arch/x86/kernel/head64.c:310 x86_64_start_kernel+0x12b/0x130 arch/x86/kernel/head64.c:291 common_startup_64+0x13e/0x158 other info that might help us debug this: Chain exists of: console_owner --> &p->pi_lock --> &rq->__lock Possible unsafe locking scenario: CPU0 CPU1 ---- ---- lock(&rq->__lock); lock(&p->pi_lock); lock(&rq->__lock); lock(console_owner); *** DEADLOCK *** locks held by swapper/0/0: 3, last CPU#0: #0: ffff88802b23baa0 (&rq->__lock){-.-.}-{2:2}, at: raw_spin_rq_lock_nested kernel/sched/core.c:685 [inline] #0: ffff88802b23baa0 (&rq->__lock){-.-.}-{2:2}, at: raw_spin_rq_lock_nested+0x88/0x140 kernel/sched/core.c:669 #1: ffffffff8edd5f00 (console_lock){+.+.}-{0:0}, at: _printk+0xcf/0x110 kernel/printk/printk.c:2504 #2: ffffffff8edd5f78 (console_srcu){....}-{0:0}, at: rcu_try_lock_acquire include/linux/rcupdate.h:305 [inline] #2: ffffffff8edd5f78 (console_srcu){....}-{0:0}, at: srcu_read_lock_nmisafe include/linux/srcu.h:428 [inline] #2: ffffffff8edd5f78 (console_srcu){....}-{0:0}, at: console_srcu_read_lock kernel/printk/printk.c:291 [inline] #2: ffffffff8edd5f78 (console_srcu){....}-{0:0}, at: console_flush_one_record+0xfd/0xf10 kernel/printk/printk.c:3246 stack backtrace: CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Tainted: G L syzkaller #0 PREEMPT(full) Tainted: [L]=SOFTLOCKUP Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.16.3-debian-1.16.3-2 04/01/2014 Call Trace: __dump_stack lib/dump_stack.c:94 [inline] dump_stack_lvl+0x100/0x190 lib/dump_stack.c:120 print_circular_bug.cold+0x178/0x1be kernel/locking/lockdep.c:2059 check_noncircular+0x146/0x160 kernel/locking/lockdep.c:2191 check_prev_add+0xeb/0xe60 kernel/locking/lockdep.c:3181 check_prevs_add kernel/locking/lockdep.c:3300 [inline] validate_chain kernel/locking/lockdep.c:3924 [inline] __lock_acquire+0x1492/0x1ec0 kernel/locking/lockdep.c:5253 lock_acquire kernel/locking/lockdep.c:5886 [inline] lock_acquire+0x1b9/0x370 kernel/locking/lockdep.c:5843 console_lock_spinning_enable+0x72/0x80 kernel/printk/printk.c:1902 console_emit_next_record kernel/printk/printk.c:3177 [inline] console_flush_one_record+0x737/0xf10 kernel/printk/printk.c:3268 console_flush_all kernel/printk/printk.c:3350 [inline] __console_flush_and_unlock kernel/printk/printk.c:3380 [inline] console_unlock+0x103/0x260 kernel/printk/printk.c:3420 vprintk_emit+0x407/0x6b0 kernel/printk/printk.c:2479 _printk+0xcf/0x110 kernel/printk/printk.c:2504 __report_bug.cold+0x34/0x141 lib/bug.c:248 report_bug+0xb3/0x220 lib/bug.c:286 handle_bug+0x16a/0x2a0 arch/x86/kernel/traps.c:436 exc_invalid_op+0x17/0x50 arch/x86/kernel/traps.c:490 asm_exc_invalid_op+0x1a/0x20 arch/x86/include/asm/idtentry.h:593 RIP: 0010:lockdep_assert_rq_held kernel/sched/sched.h:1666 [inline] RIP: 0010:lockdep_assert_rq_held kernel/sched/sched.h:1663 [inline] RIP: 0010:update_rq_clock+0x40a/0xd20 kernel/sched/core.c:875 Code: ab c8 0b 00 00 48 83 c4 18 5b 5d 41 5c 41 5d 41 5e 41 5f c3 cc cc cc cc a8 04 0f 84 df fc ff ff 90 0f 0b 90 e9 d6 fc ff ff 90 <0f> 0b 90 e9 92 fc ff ff 4c 8d 83 c0 0b 00 00 48 b8 00 00 00 00 00 RSP: 0018:ffffffff8ea07b40 EFLAGS: 00010046 RAX: 0000000000000000 RBX: ffff88802b33ba40 RCX: 0000000000000001 RDX: 0000000000000046 RSI: ffffffff8e3b00d6 RDI: ffffffff8c615180 RBP: ffffffff8ea07ce0 R08: 0000000000000001 R09: 0000000000000001 R10: ffff88802b23c5d8 R11: 0000000000000000 R12: ffffffff9143b264 R13: ffff88802b33c920 R14: ffff88802b33ba40 R15: 0000000000000001 pick_next_task kernel/sched/core.c:6361 [inline] __schedule+0x1c69/0x6920 kernel/sched/core.c:7185 schedule_idle+0x54/0x80 kernel/sched/core.c:7388 do_idle+0x365/0x5b0 kernel/sched/idle.c:384 cpu_startup_entry+0x4f/0x60 kernel/sched/idle.c:454 rest_init+0x2d3/0x2e0 init/main.c:723 start_kernel+0x48e/0x490 init/main.c:1181 x86_64_start_reservations+0x24/0x30 arch/x86/kernel/head64.c:310 x86_64_start_kernel+0x12b/0x130 arch/x86/kernel/head64.c:291 common_startup_64+0x13e/0x158 debug_locks && !(lock_is_held(&(__rq_lockp(rq))->dep_map) != 0) WARNING: kernel/sched/sched.h:1666 at lockdep_assert_rq_held kernel/sched/sched.h:1666 [inline], CPU#0: swapper/0/0 WARNING: kernel/sched/sched.h:1666 at lockdep_assert_rq_held kernel/sched/sched.h:1663 [inline], CPU#0: swapper/0/0 WARNING: kernel/sched/sched.h:1666 at update_rq_clock+0x40a/0xd20 kernel/sched/core.c:875, CPU#0: swapper/0/0 Modules linked in: CPU: 0 UID: 0 PID: 0 Comm: swapper/0 Tainted: G L syzkaller #0 PREEMPT(full) Tainted: [L]=SOFTLOCKUP Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.16.3-debian-1.16.3-2 04/01/2014 RIP: 0010:lockdep_assert_rq_held kernel/sched/sched.h:1666 [inline] RIP: 0010:lockdep_assert_rq_held kernel/sched/sched.h:1663 [inline] RIP: 0010:update_rq_clock+0x40a/0xd20 kernel/sched/core.c:875 Code: ab c8 0b 00 00 48 83 c4 18 5b 5d 41 5c 41 5d 41 5e 41 5f c3 cc cc cc cc a8 04 0f 84 df fc ff ff 90 0f 0b 90 e9 d6 fc ff ff 90 <0f> 0b 90 e9 92 fc ff ff 4c 8d 83 c0 0b 00 00 48 b8 00 00 00 00 00 RSP: 0018:ffffffff8ea07b40 EFLAGS: 00010046 RAX: 0000000000000000 RBX: ffff88802b33ba40 RCX: 0000000000000001 RDX: 0000000000000046 RSI: ffffffff8e3b00d6 RDI: ffffffff8c615180 RBP: ffffffff8ea07ce0 R08: 0000000000000001 R09: 0000000000000001 R10: ffff88802b23c5d8 R11: 0000000000000000 R12: ffffffff9143b264 R13: ffff88802b33c920 R14: ffff88802b33ba40 R15: 0000000000000001 FS: 0000000000000000(0000) GS:ffff8880969a9000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 00000000f5454da4 CR3: 000000004bc0c000 CR4: 0000000000352ef0 Call Trace: pick_next_task kernel/sched/core.c:6361 [inline] __schedule+0x1c69/0x6920 kernel/sched/core.c:7185 schedule_idle+0x54/0x80 kernel/sched/core.c:7388 do_idle+0x365/0x5b0 kernel/sched/idle.c:384 cpu_startup_entry+0x4f/0x60 kernel/sched/idle.c:454 rest_init+0x2d3/0x2e0 init/main.c:723 start_kernel+0x48e/0x490 init/main.c:1181 x86_64_start_reservations+0x24/0x30 arch/x86/kernel/head64.c:310 x86_64_start_kernel+0x12b/0x130 arch/x86/kernel/head64.c:291 common_startup_64+0x13e/0x158