EXT4-fs (loop5): bad geometry: block count 1441151880758559800 exceeds size of device (66048 blocks) audit: type=1400 audit(2000000194.460:16071): avc: denied { map } for pid=8182 comm="blkid" path="/sbin/blkid" dev="sda1" ino=16128 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:object_r:file_t:s0 tclass=file permissive=1 BUG: workqueue lockup - pool cpus=0 node=0 flags=0x0 nice=0 stuck for 167s! INFO: task kworker/u4:5:1857 blocked for more than 140 seconds. Showing busy workqueues and worker pools: Not tainted 4.14.140+ #38 workqueue events: flags=0x0 pwq 0: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. cpus=0 node=0 flags=0x0 nice=0 active=5/256 in-flight: 19245:rtc_timer_do_work pending: linkwatch_event, vmstat_shepherd, free_obj_work, destroy_super_work ====================================================== WARNING: possible circular locking dependency detected 4.14.140+ #38 Not tainted ------------------------------------------------------ kworker/0:4/19245 is trying to acquire lock: (console_owner){-.-.}, at: [<0000000042fd6206>] console_trylock_spinning kernel/printk/printk.c:1652 [inline] (console_owner){-.-.}, at: [<0000000042fd6206>] vprintk_emit+0x1b8/0x330 kernel/printk/printk.c:1916 but task is already holding lock: (&(&pool->lock)->rlock){-.-.}, at: [<000000002c1d53d5>] show_workqueue_state kernel/workqueue.c:4518 [inline] (&(&pool->lock)->rlock){-.-.}, at: [<000000002c1d53d5>] show_workqueue_state.cold+0x22f/0xeb3 kernel/workqueue.c:4491 which lock already depends on the new lock. the existing dependency chain (in reverse order) is: -> #4 (&(&pool->lock)->rlock){-.-.}: __raw_spin_lock include/linux/spinlock_api_smp.h:142 [inline] _raw_spin_lock+0x2a/0x40 kernel/locking/spinlock.c:152 spin_lock include/linux/spinlock.h:317 [inline] __queue_work+0x188/0xdd0 kernel/workqueue.c:1439 queue_work_on+0x8e/0xa0 kernel/workqueue.c:1508 queue_work include/linux/workqueue.h:491 [inline] schedule_work include/linux/workqueue.h:549 [inline] put_pwq kernel/workqueue.c:1112 [inline] put_pwq+0x129/0x180 kernel/workqueue.c:1097 put_pwq_unlocked.part.0+0x30/0x70 kernel/workqueue.c:1129 put_pwq_unlocked kernel/workqueue.c:1123 [inline] destroy_workqueue+0x4c3/0x5e0 kernel/workqueue.c:4173 ext4_put_super+0xf8/0xc90 fs/ext4/super.c:910 generic_shutdown_super+0x142/0x370 fs/super.c:446 kill_block_super+0x95/0xe0 fs/super.c:1176 deactivate_locked_super+0x82/0xe0 fs/super.c:319 deactivate_super fs/super.c:350 [inline] deactivate_super+0x8c/0xa0 fs/super.c:346 cleanup_mnt+0xad/0x140 fs/namespace.c:1201 task_work_run+0x125/0x1a0 kernel/task_work.c:113 tracehook_notify_resume include/linux/tracehook.h:191 [inline] exit_to_usermode_loop+0x13b/0x160 arch/x86/entry/common.c:164 prepare_exit_to_usermode arch/x86/entry/common.c:199 [inline] syscall_return_slowpath arch/x86/entry/common.c:270 [inline] do_syscall_64+0x3a3/0x520 arch/x86/entry/common.c:297 entry_SYSCALL_64_after_hwframe+0x42/0xb7 -> #3 (&pool->lock/1){..-.}: __raw_spin_lock include/linux/spinlock_api_smp.h:142 [inline] _raw_spin_lock+0x2a/0x40 kernel/locking/spinlock.c:152 spin_lock include/linux/spinlock.h:317 [inline] __queue_work+0x188/0xdd0 kernel/workqueue.c:1439 queue_work_on+0x8e/0xa0 kernel/workqueue.c:1508 pty_write+0x173/0x1c0 drivers/tty/pty.c:124 n_tty_write+0x8fc/0xe30 drivers/tty/n_tty.c:2356 do_tty_write drivers/tty/tty_io.c:959 [inline] tty_write+0x3f4/0x6f0 drivers/tty/tty_io.c:1043 __vfs_write+0xf9/0x5a0 fs/read_write.c:482 vfs_write+0x17f/0x4d0 fs/read_write.c:546 SYSC_write fs/read_write.c:594 [inline] SyS_write+0x102/0x250 fs/read_write.c:586 do_syscall_64+0x19b/0x520 arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x42/0xb7 -> #2 (&(&port->lock)->rlock){-.-.}: __raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:110 [inline] _raw_spin_lock_irqsave+0x42/0x60 kernel/locking/spinlock.c:160 tty_port_tty_get+0x1d/0x80 drivers/tty/tty_port.c:287 tty_port_default_wakeup+0x11/0x40 drivers/tty/tty_port.c:46 serial8250_tx_chars+0x409/0xa20 drivers/tty/serial/8250/8250_port.c:1810 serial8250_handle_irq.part.0+0x1ef/0x240 drivers/tty/serial/8250/8250_port.c:1883 serial8250_handle_irq drivers/tty/serial/8250/8250_port.c:1869 [inline] serial8250_default_handle_irq+0x9c/0x110 drivers/tty/serial/8250/8250_port.c:1899 serial8250_interrupt+0xea/0x1a0 drivers/tty/serial/8250/8250_core.c:129 __handle_irq_event_percpu+0xff/0x7a0 kernel/irq/handle.c:147 handle_irq_event_percpu+0x76/0x150 kernel/irq/handle.c:187 handle_irq_event+0xa2/0x12d kernel/irq/handle.c:204 handle_edge_irq+0x21b/0x820 kernel/irq/chip.c:770 generic_handle_irq_desc include/linux/irqdesc.h:159 [inline] handle_irq+0x225/0x2e2 arch/x86/kernel/irq_64.c:87 do_IRQ+0x7f/0x1c0 arch/x86/kernel/irq.c:230 ret_from_intr+0x0/0x22 native_safe_halt+0x13/0x20 arch/x86/include/asm/irqflags.h:60 arch_safe_halt arch/x86/include/asm/paravirt.h:94 [inline] default_idle+0x61/0x3b0 arch/x86/kernel/process.c:566 cpuidle_idle_call kernel/sched/idle.c:159 [inline] do_idle+0x2e6/0x390 kernel/sched/idle.c:268 cpu_startup_entry+0xc6/0xd0 kernel/sched/idle.c:374 start_secondary+0x3a8/0x4b0 arch/x86/kernel/smpboot.c:272 secondary_startup_64+0xa5/0xb0 arch/x86/kernel/head_64.S:240 -> #1 (&port_lock_key){-.-.}: __raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:110 [inline] _raw_spin_lock_irqsave+0x42/0x60 kernel/locking/spinlock.c:160 serial8250_console_write+0x434/0x820 drivers/tty/serial/8250/8250_port.c:3232 call_console_drivers kernel/printk/printk.c:1719 [inline] console_unlock+0x6ea/0xc70 kernel/printk/printk.c:2391 vprintk_emit+0x128/0x330 kernel/printk/printk.c:1917 vprintk_func+0x58/0x152 kernel/printk/printk_safe.c:401 printk+0xba/0xed kernel/printk/printk.c:1990 register_console+0x5f4/0x9b0 kernel/printk/printk.c:2710 univ8250_console_init+0x2f/0x3a drivers/tty/serial/8250/8250_core.c:692 console_init+0x4d/0x56 kernel/printk/printk.c:2791 start_kernel+0x489/0x74a init/main.c:635 secondary_startup_64+0xa5/0xb0 arch/x86/kernel/head_64.S:240 -> #0 (console_owner){-.-.}: lock_acquire+0x12b/0x360 kernel/locking/lockdep.c:3991 console_trylock_spinning kernel/printk/printk.c:1673 [inline] vprintk_emit+0x1f5/0x330 kernel/printk/printk.c:1916 vprintk_func+0x58/0x152 kernel/printk/printk_safe.c:401 printk+0xba/0xed kernel/printk/printk.c:1990 show_pwq kernel/workqueue.c:4422 [inline] show_workqueue_state kernel/workqueue.c:4520 [inline] show_workqueue_state.cold+0x2b3/0xeb3 kernel/workqueue.c:4491 wq_watchdog_timer_fn+0x400/0x480 kernel/workqueue.c:5504 call_timer_fn+0x15b/0x6a0 kernel/time/timer.c:1279 expire_timers+0x227/0x4c0 kernel/time/timer.c:1318 __run_timers kernel/time/timer.c:1634 [inline] run_timer_softirq+0x3e3/0x5d0 kernel/time/timer.c:1649 __do_softirq+0x234/0x9ec kernel/softirq.c:288 invoke_softirq kernel/softirq.c:368 [inline] irq_exit+0x114/0x150 kernel/softirq.c:409 exiting_irq arch/x86/include/asm/apic.h:648 [inline] smp_apic_timer_interrupt+0x1a7/0x650 arch/x86/kernel/apic/apic.c:1064 apic_timer_interrupt+0x8c/0xa0 arch/x86/entry/entry_64.S:792 arch_local_irq_restore arch/x86/include/asm/paravirt.h:779 [inline] __raw_spin_unlock_irqrestore include/linux/spinlock_api_smp.h:160 [inline] _raw_spin_unlock_irqrestore+0x59/0x70 kernel/locking/spinlock.c:192 spin_unlock_irqrestore include/linux/spinlock.h:372 [inline] rtc_handle_legacy_irq+0x7a/0x180 drivers/rtc/interface.c:515 rtc_timer_do_work+0x21d/0x610 drivers/rtc/interface.c:881 process_one_work+0x7f1/0x1580 kernel/workqueue.c:2134 worker_thread+0xdd/0xdf0 kernel/workqueue.c:2271 kthread+0x31f/0x430 kernel/kthread.c:232 ret_from_fork+0x3a/0x50 arch/x86/entry/entry_64.S:404 other info that might help us debug this: Chain exists of: console_owner --> &pool->lock/1 --> &(&pool->lock)->rlock Possible unsafe locking scenario: CPU0 CPU1 ---- ---- lock(&(&pool->lock)->rlock); lock(&pool->lock/1); lock(&(&pool->lock)->rlock); lock(console_owner); *** DEADLOCK *** 6 locks held by kworker/0:4/19245: #0: ("events"){+.+.}, at: [<00000000ed1955b3>] process_one_work+0x6ff/0x1580 kernel/workqueue.c:2105 #1: ((&rtc->irqwork)){+.+.}, at: [<000000004766032d>] process_one_work+0x735/0x1580 kernel/workqueue.c:2109 #2: (&rtc->ops_lock){+.+.}, at: [<00000000dea0e739>] rtc_timer_do_work+0xc9/0x610 drivers/rtc/interface.c:868 #3: (kernel/workqueue.c:5442){+.-.}, at: [<000000005ec02de4>] lockdep_copy_map include/linux/lockdep.h:174 [inline] #3: (kernel/workqueue.c:5442){+.-.}, at: [<000000005ec02de4>] call_timer_fn+0xc6/0x6a0 kernel/time/timer.c:1269 #4: (rcu_read_lock_sched){....}, at: [<000000005ccc986e>] show_workqueue_state+0x0/0x100 kernel/workqueue.c:4390 #5: (&(&pool->lock)->rlock){-.-.}, at: [<000000002c1d53d5>] show_workqueue_state kernel/workqueue.c:4518 [inline] #5: (&(&pool->lock)->rlock){-.-.}, at: [<000000002c1d53d5>] show_workqueue_state.cold+0x22f/0xeb3 kernel/workqueue.c:4491 stack backtrace: CPU: 0 PID: 19245 Comm: kworker/0:4 Not tainted 4.14.140+ #38 Workqueue: events rtc_timer_do_work Call Trace: __dump_stack lib/dump_stack.c:17 [inline] dump_stack+0xca/0x134 lib/dump_stack.c:53 print_circular_bug.isra.0.cold+0x2dc/0x425 kernel/locking/lockdep.c:1258 check_prev_add kernel/locking/lockdep.c:1901 [inline] check_prevs_add kernel/locking/lockdep.c:2018 [inline] validate_chain kernel/locking/lockdep.c:2460 [inline] __lock_acquire+0x2f5f/0x4320 kernel/locking/lockdep.c:3487 lock_acquire+0x12b/0x360 kernel/locking/lockdep.c:3991 console_trylock_spinning kernel/printk/printk.c:1673 [inline] vprintk_emit+0x1f5/0x330 kernel/printk/printk.c:1916 vprintk_func+0x58/0x152 kernel/printk/printk_safe.c:401 printk+0xba/0xed kernel/printk/printk.c:1990 show_pwq kernel/workqueue.c:4422 [inline] show_workqueue_state kernel/workqueue.c:4520 [inline] show_workqueue_state.cold+0x2b3/0xeb3 kernel/workqueue.c:4491 wq_watchdog_timer_fn+0x400/0x480 kernel/workqueue.c:5504 call_timer_fn+0x15b/0x6a0 kernel/time/timer.c:1279 expire_timers+0x227/0x4c0 kernel/time/timer.c:1318 __run_timers kernel/time/timer.c:1634 [inline] run_timer_softirq+0x3e3/0x5d0 kernel/time/timer.c:1649 __do_softirq+0x234/0x9ec kernel/softirq.c:288 invoke_softirq kernel/softirq.c:368 [inline] irq_exit+0x114/0x150 kernel/softirq.c:409 exiting_irq arch/x86/include/asm/apic.h:648 [inline] smp_apic_timer_interrupt+0x1a7/0x650 arch/x86/kernel/apic/apic.c:1064 apic_timer_interrupt+0x8c/0xa0 arch/x86/entry/entry_64.S:792 RIP: 0010:arch_local_irq_restore arch/x86/include/asm/paravirt.h:779 [inline] RIP: 0010:__raw_spin_unlock_irqrestore include/linux/spinlock_api_smp.h:160 [inline] RIP: 0010:_raw_spin_unlock_irqrestore+0x59/0x70 kernel/locking/spinlock.c:192 RSP: 0018:ffff88819b0ffb60 EFLAGS: 00000297 ORIG_RAX: ffffffffffffff10 RAX: 0000000000000007 RBX: 0000000000000297 RCX: 1ffff110338306f4 RDX: 0000000000000000 RSI: ffff88819c183780 RDI: 0000000000000297 RBP: ffff8881d5cceb38 R08: 0000000000000001 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000090 R13: ffff8881d5ccebc8 R14: ffff8881d5ccec90 R15: ffffffffb04c6b70 spin_unlock_irqrestore include/linux/spinlock.h:372 [inline] rtc_handle_legacy_irq+0x7a/0x180 drivers/rtc/interface.c:515 rtc_timer_do_work+0x21d/0x610 drivers/rtc/interface.c:881 process_one_work+0x7f1/0x1580 kernel/workqueue.c:2134 worker_thread+0xdd/0xdf0 kernel/workqueue.c:2271 kthread+0x31f/0x430 kernel/kthread.c:232 ret_from_fork+0x3a/0x50 arch/x86/entry/entry_64.S:404 workqueue events_unbound: flags=0x2 kworker/u4:5 D pwq 4: cpus=0-1 flags=0x4 nice=0 active=4/512 in-flight: 7661:fsnotify_connector_destroy_workfn fsnotify_connector_destroy_workfn, 1857:fsnotify_mark_destroy_workfn fsnotify_mark_destroy_workfn workqueue events_power_efficient: flags=0x80 pwq 0: 26784 1857 2 0x80000000 cpus=0 node=0 flags=0x0 nice=0 active=2/256 pending: process_srcu, neigh_periodic_work workqueue mm_percpu_wq: flags=0x8 pwq 0: cpus=0 node=0 flags=0x0 nice=0 active=2/256 pending: vmstat_update, lru_add_drain_per_cpu BAR(8123) pool 0: cpus=0 node=0 flags=0x0 nice=0 hung=167s workers=5 idle: 3022 3 3040 4047 pool 4: cpus=0-1 flags=0x4 nice=0 hung=1s workers=32 idle: 11322 7395 4681 Workqueue: events_unbound fsnotify_mark_destroy_workfn 3672 7656 20210 11283 21478 21482 21440 7635 11287 3665 7389 21442 64 7384 4657 21444 7641 11276 824 4670 21434 7648 1846 1864 7630 355 11314 Call Trace: schedule+0x92/0x1c0 kernel/sched/core.c:3498 schedule_timeout+0x752/0xe90 kernel/time/timer.c:1721 do_wait_for_common kernel/sched/completion.c:91 [inline] __wait_for_common kernel/sched/completion.c:112 [inline] wait_for_common+0x29c/0x470 kernel/sched/completion.c:123 __synchronize_srcu+0x12a/0x210 kernel/rcu/srcutree.c:898 fsnotify_mark_destroy_workfn+0xfd/0x310 fs/notify/mark.c:757 process_one_work+0x7f1/0x1580 kernel/workqueue.c:2134 worker_thread+0xdd/0xdf0 kernel/workqueue.c:2271 kthread+0x31f/0x430 kernel/kthread.c:232 ret_from_fork+0x3a/0x50 arch/x86/entry/entry_64.S:404 INFO: task kworker/u4:21:7661 blocked for more than 140 seconds. Not tainted 4.14.140+ #38 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. kworker/u4:21 D27040 7661 2 0x80000000 Workqueue: events_unbound fsnotify_connector_destroy_workfn Call Trace: schedule+0x92/0x1c0 kernel/sched/core.c:3498 schedule_timeout+0x752/0xe90 kernel/time/timer.c:1721 do_wait_for_common kernel/sched/completion.c:91 [inline] __wait_for_common kernel/sched/completion.c:112 [inline] wait_for_common+0x29c/0x470 kernel/sched/completion.c:123 __synchronize_srcu+0x12a/0x210 kernel/rcu/srcutree.c:898 fsnotify_connector_destroy_workfn+0x49/0xa0 fs/notify/mark.c:156 process_one_work+0x7f1/0x1580 kernel/workqueue.c:2134 worker_thread+0xdd/0xdf0 kernel/workqueue.c:2271 kthread+0x31f/0x430 kernel/kthread.c:232 ret_from_fork+0x3a/0x50 arch/x86/entry/entry_64.S:404 INFO: task syz-executor.4:8123 blocked for more than 140 seconds. Not tainted 4.14.140+ #38 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.4 D28640 8123 6658 0x00000004 Call Trace: schedule+0x92/0x1c0 kernel/sched/core.c:3498 schedule_timeout+0x752/0xe90 kernel/time/timer.c:1721 do_wait_for_common kernel/sched/completion.c:91 [inline] __wait_for_common kernel/sched/completion.c:112 [inline] wait_for_common+0x29c/0x470 kernel/sched/completion.c:123 flush_work+0x3e2/0x720 kernel/workqueue.c:2908 lru_add_drain_all_cpuslocked mm/swap.c:722 [inline] lru_add_drain_all_cpuslocked+0x2d5/0x420 mm/swap.c:691 lru_add_drain_all+0xf/0x20 mm/swap.c:730 invalidate_bdev+0x8a/0xc0 fs/block_dev.c:109 loop_clr_fd+0x3de/0xad0 drivers/block/loop.c:1052 lo_ioctl+0x460/0x1a30 drivers/block/loop.c:1414 __blkdev_driver_ioctl block/ioctl.c:297 [inline] blkdev_ioctl+0x8d0/0x1870 block/ioctl.c:594 block_ioctl+0xd9/0x120 fs/block_dev.c:1881 vfs_ioctl fs/ioctl.c:46 [inline] file_ioctl fs/ioctl.c:500 [inline] do_vfs_ioctl+0xabe/0x1040 fs/ioctl.c:684 SYSC_ioctl fs/ioctl.c:701 [inline] SyS_ioctl+0x7f/0xb0 fs/ioctl.c:692 do_syscall_64+0x19b/0x520 arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x42/0xb7 RIP: 0033:0x4596e7 RSP: 002b:00007f2114897a88 EFLAGS: 00000246 ORIG_RAX: 0000000000000010 RAX: ffffffffffffffda RBX: 00007f2114897b40 RCX: 00000000004596e7 RDX: 0000000000000000 RSI: 0000000000004c01 RDI: 0000000000000006 RBP: 0000000000000002 R08: 00007f2114897b40 R09: 00007f2114897ae0 R10: 0000000000000040 R11: 0000000000000246 R12: 0000000000000005 R13: 00000000004c89d6 R14: 00000000004df8f8 R15: 00000000ffffffff INFO: task syz-executor.4:8136 blocked for more than 140 seconds. Not tainted 4.14.140+ #38 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.4 D29056 8136 6658 0x00000004 Call Trace: schedule+0x92/0x1c0 kernel/sched/core.c:3498 schedule_preempt_disabled+0x13/0x20 kernel/sched/core.c:3556 __mutex_lock_common kernel/locking/mutex.c:833 [inline] __mutex_lock+0x595/0x13e0 kernel/locking/mutex.c:893 lo_ioctl+0x86/0x1a30 drivers/block/loop.c:1404 __blkdev_driver_ioctl block/ioctl.c:297 [inline] blkdev_ioctl+0x8d0/0x1870 block/ioctl.c:594 block_ioctl+0xd9/0x120 fs/block_dev.c:1881 vfs_ioctl fs/ioctl.c:46 [inline] file_ioctl fs/ioctl.c:500 [inline] do_vfs_ioctl+0xabe/0x1040 fs/ioctl.c:684 SYSC_ioctl fs/ioctl.c:701 [inline] SyS_ioctl+0x7f/0xb0 fs/ioctl.c:692 do_syscall_64+0x19b/0x520 arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x42/0xb7 RIP: 0033:0x4596e7 RSP: 002b:00007f2114876a88 EFLAGS: 00000246 ORIG_RAX: 0000000000000010 RAX: ffffffffffffffda RBX: 0000000020000180 RCX: 00000000004596e7 RDX: 0000000000000005 RSI: 0000000000004c00 RDI: 0000000000000006 RBP: 0000000000000002 R08: 0000000000000000 R09: 000000000000000a R10: 0000000000000075 R11: 0000000000000246 R12: 0000000000000005 R13: 00000000004c89d6 R14: 00000000004df8f8 R15: 00000000ffffffff INFO: task blkid:8135 blocked for more than 140 seconds. Not tainted 4.14.140+ #38 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. blkid D28288 8135 3016 0x00000004 Call Trace: schedule+0x92/0x1c0 kernel/sched/core.c:3498 schedule_preempt_disabled+0x13/0x20 kernel/sched/core.c:3556 __mutex_lock_common kernel/locking/mutex.c:833 [inline] __mutex_lock+0x595/0x13e0 kernel/locking/mutex.c:893 lo_ioctl+0x86/0x1a30 drivers/block/loop.c:1404 __blkdev_driver_ioctl block/ioctl.c:297 [inline] blkdev_ioctl+0x8d0/0x1870 block/ioctl.c:594 block_ioctl+0xd9/0x120 fs/block_dev.c:1881 vfs_ioctl fs/ioctl.c:46 [inline] file_ioctl fs/ioctl.c:500 [inline] do_vfs_ioctl+0xabe/0x1040 fs/ioctl.c:684 SYSC_ioctl fs/ioctl.c:701 [inline] SyS_ioctl+0x7f/0xb0 fs/ioctl.c:692 do_syscall_64+0x19b/0x520 arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x42/0xb7 RIP: 0033:0x7f0925119347 RSP: 002b:00007fff9ab1f658 EFLAGS: 00000246 ORIG_RAX: 0000000000000010 RAX: ffffffffffffffda RBX: 000000000061e030 RCX: 00007f0925119347 RDX: 0000000000000000 RSI: 0000000000005331 RDI: 0000000000000003 RBP: 0000000000000003 R08: 00007f09253c95a0 R09: 0000000000000008 R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000 R13: 0000000000000000 R14: 0000000000000003 R15: 0000000000000005 INFO: task syz-executor.0:8145 blocked for more than 140 seconds. Not tainted 4.14.140+ #38 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.0 D28288 8145 5312 0x00000004 Call Trace: schedule+0x92/0x1c0 kernel/sched/core.c:3498 schedule_preempt_disabled+0x13/0x20 kernel/sched/core.c:3556 __mutex_lock_common kernel/locking/mutex.c:833 [inline] __mutex_lock+0x595/0x13e0 kernel/locking/mutex.c:893 lru_add_drain_all_cpuslocked+0x6c/0x420 mm/swap.c:704 lru_add_drain_all+0xf/0x20 mm/swap.c:730 do_mlock+0x90/0x5d0 mm/mlock.c:673 SYSC_mlock mm/mlock.c:713 [inline] SyS_mlock+0x1e/0x30 mm/mlock.c:711 do_syscall_64+0x19b/0x520 arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x42/0xb7 RIP: 0033:0x459879 RSP: 002b:00007fdb1ef98c78 EFLAGS: 00000246 ORIG_RAX: 0000000000000095 RAX: ffffffffffffffda RBX: 0000000000000002 RCX: 0000000000459879 RDX: 0000000000000000 RSI: 0000000000001000 RDI: 0000000020fff000 RBP: 000000000075bf20 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00007fdb1ef996d4 R13: 00000000004c5d65 R14: 00000000004da7c8 R15: 00000000ffffffff INFO: task syz-executor.0:8148 blocked for more than 140 seconds. Not tainted 4.14.140+ #38 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.0 D26064 8148 5312 0x00000004 Call Trace: schedule+0x92/0x1c0 kernel/sched/core.c:3498 schedule_preempt_disabled+0x13/0x20 kernel/sched/core.c:3556 __mutex_lock_common kernel/locking/mutex.c:833 [inline] __mutex_lock+0x595/0x13e0 kernel/locking/mutex.c:893 lru_add_drain_all_cpuslocked+0x6c/0x420 mm/swap.c:704 lru_add_drain_all+0xf/0x20 mm/swap.c:730 do_mlock+0x90/0x5d0 mm/mlock.c:673 SYSC_mlock mm/mlock.c:713 [inline] SyS_mlock+0x1e/0x30 mm/mlock.c:711 do_syscall_64+0x19b/0x520 arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x42/0xb7 RIP: 0033:0x459879 RSP: 002b:00007fdb1ef77c78 EFLAGS: 00000246 ORIG_RAX: 0000000000000095 RAX: ffffffffffffffda RBX: 0000000000000002 RCX: 0000000000459879 RDX: 0000000000000000 RSI: 0000000000001000 RDI: 0000000020fff000 RBP: 000000000075bfc8 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00007fdb1ef786d4 R13: 00000000004c5d65 R14: 00000000004da7c8 R15: 00000000ffffffff INFO: task syz-executor.5:8179 blocked for more than 140 seconds. Not tainted 4.14.140+ #38 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.5 D28640 8179 6362 0x00000004 Call Trace: schedule+0x92/0x1c0 kernel/sched/core.c:3498 schedule_preempt_disabled+0x13/0x20 kernel/sched/core.c:3556 __mutex_lock_common kernel/locking/mutex.c:833 [inline] __mutex_lock+0x595/0x13e0 kernel/locking/mutex.c:893 lru_add_drain_all_cpuslocked+0x6c/0x420 mm/swap.c:704 lru_add_drain_all+0xf/0x20 mm/swap.c:730 invalidate_bdev+0x8a/0xc0 fs/block_dev.c:109 loop_clr_fd+0x3de/0xad0 drivers/block/loop.c:1052 lo_ioctl+0x460/0x1a30 drivers/block/loop.c:1414 __blkdev_driver_ioctl block/ioctl.c:297 [inline] blkdev_ioctl+0x8d0/0x1870 block/ioctl.c:594 block_ioctl+0xd9/0x120 fs/block_dev.c:1881 vfs_ioctl fs/ioctl.c:46 [inline] file_ioctl fs/ioctl.c:500 [inline] do_vfs_ioctl+0xabe/0x1040 fs/ioctl.c:684 SYSC_ioctl fs/ioctl.c:701 [inline] SyS_ioctl+0x7f/0xb0 fs/ioctl.c:692 do_syscall_64+0x19b/0x520 arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x42/0xb7 RIP: 0033:0x4596e7 RSP: 002b:00007efeefb1aa88 EFLAGS: 00000246 ORIG_RAX: 0000000000000010 RAX: ffffffffffffffda RBX: 00007efeefb1ab40 RCX: 00000000004596e7 RDX: 0000000000000000 RSI: 0000000000004c01 RDI: 0000000000000004 RBP: 0000000000001000 R08: 00007efeefb1ab40 R09: 00007efeefb1aae0 R10: 0000000000000001 R11: 0000000000000246 R12: 0000000000000003 R13: 00000000004c89d6 R14: 00000000004df8f8 R15: 00000000ffffffff INFO: task blkid:8182 blocked for more than 140 seconds. Not tainted 4.14.140+ #38 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. blkid D28192 8182 333 0x00000004 Call Trace: schedule+0x92/0x1c0 kernel/sched/core.c:3498 schedule_preempt_disabled+0x13/0x20 kernel/sched/core.c:3556 __mutex_lock_common kernel/locking/mutex.c:833 [inline] __mutex_lock+0x595/0x13e0 kernel/locking/mutex.c:893 lo_ioctl+0x86/0x1a30 drivers/block/loop.c:1404 __blkdev_driver_ioctl block/ioctl.c:297 [inline] blkdev_ioctl+0x8d0/0x1870 block/ioctl.c:594 block_ioctl+0xd9/0x120 fs/block_dev.c:1881 vfs_ioctl fs/ioctl.c:46 [inline] file_ioctl fs/ioctl.c:500 [inline] do_vfs_ioctl+0xabe/0x1040 fs/ioctl.c:684 SYSC_ioctl fs/ioctl.c:701 [inline] SyS_ioctl+0x7f/0xb0 fs/ioctl.c:692 do_syscall_64+0x19b/0x520 arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x42/0xb7 RIP: 0033:0x7f29853cb347 RSP: 002b:00007ffce584d748 EFLAGS: 00000246 ORIG_RAX: 0000000000000010 RAX: ffffffffffffffda RBX: 0000000000a41030 RCX: 00007f29853cb347 RDX: 0000000000000000 RSI: 0000000000005331 RDI: 0000000000000003 RBP: 0000000000000003 R08: 00007f298567b5a0 R09: 0000000000000008 R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000 R13: 0000000008100000 R14: 0000000000000003 R15: 0000000000000005 INFO: lockdep is turned off. NMI backtrace for cpu 1 CPU: 1 PID: 23 Comm: khungtaskd Not tainted 4.14.140+ #38 Call Trace: __dump_stack lib/dump_stack.c:17 [inline] dump_stack+0xca/0x134 lib/dump_stack.c:53 nmi_cpu_backtrace.cold+0x47/0x86 lib/nmi_backtrace.c:101 nmi_trigger_cpumask_backtrace+0x119/0x147 lib/nmi_backtrace.c:62 trigger_all_cpu_backtrace include/linux/nmi.h:140 [inline] check_hung_uninterruptible_tasks kernel/hung_task.c:195 [inline] watchdog+0x629/0xbe0 kernel/hung_task.c:274 kthread+0x31f/0x430 kernel/kthread.c:232 ret_from_fork+0x3a/0x50 arch/x86/entry/entry_64.S:404 Sending NMI from CPU 1 to CPUs 0: NMI backtrace for cpu 0 CPU: 0 PID: 19245 Comm: kworker/0:4 Not tainted 4.14.140+ #38 Workqueue: events rtc_timer_do_work task: 0000000028b73398 task.stack: 000000008f30c7c5 RIP: 0010:__read_once_size include/linux/compiler.h:183 [inline] RIP: 0010:arch_atomic_read arch/x86/include/asm/atomic.h:31 [inline] RIP: 0010:atomic_read include/asm-generic/atomic-instrumented.h:22 [inline] RIP: 0010:static_key_count include/linux/jump_label.h:193 [inline] RIP: 0010:static_key_false include/linux/jump_label.h:203 [inline] RIP: 0010:trace_lock_release include/trace/events/lock.h:58 [inline] RIP: 0010:lock_release+0x10c/0x740 kernel/locking/lockdep.c:4009 RSP: 0018:ffff88819b0ffab0 EFLAGS: 00000046 RAX: fffffbfff6385a32 RBX: 1ffff1103361ff59 RCX: ffffffffaf6025ec RDX: 0000000000000000 RSI: 0000000000000004 RDI: ffffffffb1c2d188 RBP: ffff88819c182f00 R08: 0000000000000001 R09: fffffbfff6385a32 R10: fffffbfff6385a31 R11: ffffffffb1c2d18b R12: ffff8881d5ccebe0 R13: ffff8881d5ccebc8 R14: ffff8881d5ccec90 R15: ffffffffb04c6b70 FS: 0000000000000000(0000) GS:ffff8881dba00000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 0000000001c7c000 CR3: 000000007f226002 CR4: 00000000001606b0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000600 Call Trace: __raw_spin_unlock_irqrestore include/linux/spinlock_api_smp.h:158 [inline] _raw_spin_unlock_irqrestore+0x1b/0x70 kernel/locking/spinlock.c:192 spin_unlock_irqrestore include/linux/spinlock.h:372 [inline] rtc_handle_legacy_irq+0x10b/0x180 drivers/rtc/interface.c:521 rtc_timer_do_work+0x21d/0x610 drivers/rtc/interface.c:881 process_one_work+0x7f1/0x1580 kernel/workqueue.c:2134 worker_thread+0xdd/0xdf0 kernel/workqueue.c:2271 kthread+0x31f/0x430 kernel/kthread.c:232 ret_from_fork+0x3a/0x50 arch/x86/entry/entry_64.S:404 Code: 07 83 c0 03 38 d0 7c 08 84 d2 0f 85 14 05 00 00 c7 85 2c 08 00 00 01 00 00 00 be 04 00 00 00 48 c7 c7 88 d1 c2 b1 e8 b4 8c 33 00 <8b> 05 96 ab 62 02 85 c0 0f 8f 39 03 00 00 65 8b 05 2f 5b a1 50