INFO: task kworker/0:3:3223 blocked for more than 143 seconds. Not tainted 5.4.0-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. kworker/0:3 D22928 3223 2 0x80004000 Workqueue: usb_hub_wq hub_event Call Trace: schedule+0xcd/0x2b0 kernel/sched/core.c:4155 schedule_timeout+0x682/0xb20 kernel/time/timer.c:1871 do_wait_for_common kernel/sched/completion.c:83 [inline] __wait_for_common kernel/sched/completion.c:104 [inline] wait_for_common kernel/sched/completion.c:115 [inline] wait_for_completion+0x26f/0x3c0 kernel/sched/completion.c:136 kthread_stop+0x160/0x6e0 kernel/kthread.c:559 dvb_ca_en50221_release+0x91/0x1d0 drivers/media/dvb-core/dvb_ca_en50221.c:1934 tt3650_ci_uninit drivers/media/usb/dvb-usb/pctv452e.c:364 [inline] pctv452e_usb_disconnect+0xb0/0xf0 drivers/media/usb/dvb-usb/pctv452e.c:1061 usb_unbind_interface+0x1bd/0x8a0 drivers/usb/core/driver.c:423 __device_release_driver drivers/base/dd.c:1134 [inline] device_release_driver_internal+0x42f/0x500 drivers/base/dd.c:1165 bus_remove_device+0x2dc/0x4a0 drivers/base/bus.c:532 device_del+0x481/0xd30 drivers/base/core.c:2664 usb_disable_device+0x211/0x690 drivers/usb/core/message.c:1237 usb_disconnect+0x284/0x8d0 drivers/usb/core/hub.c:2200 hub_port_connect drivers/usb/core/hub.c:5035 [inline] hub_port_connect_change drivers/usb/core/hub.c:5324 [inline] port_event drivers/usb/core/hub.c:5470 [inline] hub_event+0x1753/0x3860 drivers/usb/core/hub.c:5552 process_one_work+0x92b/0x1530 kernel/workqueue.c:2264 worker_thread+0x96/0xe20 kernel/workqueue.c:2410 kthread+0x318/0x420 kernel/kthread.c:255 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:352 Showing all locks held in the system: 4 locks held by kworker/0:1/12: #0: ffff8881d913b928 ((wq_completion)usb_hub_wq){+.+.}, at: __write_once_size include/linux/compiler.h:226 [inline] #0: ffff8881d913b928 ((wq_completion)usb_hub_wq){+.+.}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline] #0: ffff8881d913b928 ((wq_completion)usb_hub_wq){+.+.}, at: atomic64_set include/asm-generic/atomic-instrumented.h:855 [inline] #0: ffff8881d913b928 ((wq_completion)usb_hub_wq){+.+.}, at: atomic_long_set include/asm-generic/atomic-long.h:40 [inline] #0: ffff8881d913b928 ((wq_completion)usb_hub_wq){+.+.}, at: set_work_data kernel/workqueue.c:615 [inline] #0: ffff8881d913b928 ((wq_completion)usb_hub_wq){+.+.}, at: set_work_pool_and_clear_pending kernel/workqueue.c:642 [inline] #0: ffff8881d913b928 ((wq_completion)usb_hub_wq){+.+.}, at: process_one_work+0x827/0x1530 kernel/workqueue.c:2235 #1: ffff8881da627dd0 ((work_completion)(&hub->events)){+.+.}, at: process_one_work+0x85b/0x1530 kernel/workqueue.c:2239 #2: ffff8881d56d6200 (&dev->mutex){....}, at: device_lock include/linux/device.h:1493 [inline] #2: ffff8881d56d6200 (&dev->mutex){....}, at: hub_event+0x1b2/0x3860 drivers/usb/core/hub.c:5498 #3: ffff8881db434418 (&rq->lock){-.-.}, at: rq_lock kernel/sched/sched.h:1215 [inline] #3: ffff8881db434418 (&rq->lock){-.-.}, at: __schedule+0x21c/0x1d80 kernel/sched/core.c:4029 1 lock held by khungtaskd/23: #0: ffffffff86cfe560 (rcu_read_lock){....}, at: debug_show_all_locks+0x53/0x264 kernel/locking/lockdep.c:5332 5 locks held by kworker/0:2/101: #0: ffff8881d913b928 ((wq_completion)usb_hub_wq){+.+.}, at: __write_once_size include/linux/compiler.h:226 [inline] #0: ffff8881d913b928 ((wq_completion)usb_hub_wq){+.+.}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline] #0: ffff8881d913b928 ((wq_completion)usb_hub_wq){+.+.}, at: atomic64_set include/asm-generic/atomic-instrumented.h:855 [inline] #0: ffff8881d913b928 ((wq_completion)usb_hub_wq){+.+.}, at: atomic_long_set include/asm-generic/atomic-long.h:40 [inline] #0: ffff8881d913b928 ((wq_completion)usb_hub_wq){+.+.}, at: set_work_data kernel/workqueue.c:615 [inline] #0: ffff8881d913b928 ((wq_completion)usb_hub_wq){+.+.}, at: set_work_pool_and_clear_pending kernel/workqueue.c:642 [inline] #0: ffff8881d913b928 ((wq_completion)usb_hub_wq){+.+.}, at: process_one_work+0x827/0x1530 kernel/workqueue.c:2235 #1: ffff8881d5107dd0 ((work_completion)(&hub->events)){+.+.}, at: process_one_work+0x85b/0x1530 kernel/workqueue.c:2239 #2: ffff8881d5679200 (&dev->mutex){....}, at: device_lock include/linux/device.h:1493 [inline] #2: ffff8881d5679200 (&dev->mutex){....}, at: hub_event+0x1b2/0x3860 drivers/usb/core/hub.c:5498 #3: ffff8881adfcf200 (&dev->mutex){....}, at: device_lock include/linux/device.h:1493 [inline] #3: ffff8881adfcf200 (&dev->mutex){....}, at: __device_attach+0x7b/0x360 drivers/base/dd.c:871 #4: ffff8881cf3b0190 (&dev->mutex){....}, at: device_lock include/linux/device.h:1493 [inline] #4: ffff8881cf3b0190 (&dev->mutex){....}, at: __device_attach+0x7b/0x360 drivers/base/dd.c:871 1 lock held by rsyslogd/1603: 2 locks held by getty/1694: #0: ffff8881d1480090 (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x22/0x80 drivers/tty/tty_ldisc.c:272 #1: ffffc900004452e0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x223/0x1ae0 drivers/tty/n_tty.c:2156 2 locks held by getty/1695: #0: ffff8881d198f090 (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x22/0x80 drivers/tty/tty_ldisc.c:272 #1: ffffc900004412e0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x223/0x1ae0 drivers/tty/n_tty.c:2156 2 locks held by getty/1696: #0: ffff8881d15e8090 (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x22/0x80 drivers/tty/tty_ldisc.c:272 #1: ffffc9000046d2e0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x223/0x1ae0 drivers/tty/n_tty.c:2156 2 locks held by getty/1697: #0: ffff8881d19a6090 (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x22/0x80 drivers/tty/tty_ldisc.c:272 #1: ffffc9000045d2e0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x223/0x1ae0 drivers/tty/n_tty.c:2156 2 locks held by getty/1698: #0: ffff8881d19a7090 (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x22/0x80 drivers/tty/tty_ldisc.c:272 #1: ffffc900004692e0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x223/0x1ae0 drivers/tty/n_tty.c:2156 2 locks held by getty/1699: #0: ffff8881d1482090 (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x22/0x80 drivers/tty/tty_ldisc.c:272 #1: ffffc900004592e0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x223/0x1ae0 drivers/tty/n_tty.c:2156 2 locks held by getty/1700: #0: ffff8881d1988090 (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x22/0x80 drivers/tty/tty_ldisc.c:272 #1: ffffc900004352e0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x223/0x1ae0 drivers/tty/n_tty.c:2156 5 locks held by kworker/0:3/3223: #0: ffff8881d913b928 ((wq_completion)usb_hub_wq){+.+.}, at: __write_once_size include/linux/compiler.h:226 [inline] #0: ffff8881d913b928 ((wq_completion)usb_hub_wq){+.+.}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline] #0: ffff8881d913b928 ((wq_completion)usb_hub_wq){+.+.}, at: atomic64_set include/asm-generic/atomic-instrumented.h:855 [inline] #0: ffff8881d913b928 ((wq_completion)usb_hub_wq){+.+.}, at: atomic_long_set include/asm-generic/atomic-long.h:40 [inline] #0: ffff8881d913b928 ((wq_completion)usb_hub_wq){+.+.}, at: set_work_data kernel/workqueue.c:615 [inline] #0: ffff8881d913b928 ((wq_completion)usb_hub_wq){+.+.}, at: set_work_pool_and_clear_pending kernel/workqueue.c:642 [inline] #0: ffff8881d913b928 ((wq_completion)usb_hub_wq){+.+.}, at: process_one_work+0x827/0x1530 kernel/workqueue.c:2235 #1: ffff8881aee6fdd0 ((work_completion)(&hub->events)){+.+.}, at: process_one_work+0x85b/0x1530 kernel/workqueue.c:2239 #2: ffff8881d55ab200 (&dev->mutex){....}, at: device_lock include/linux/device.h:1493 [inline] #2: ffff8881d55ab200 (&dev->mutex){....}, at: hub_event+0x1b2/0x3860 drivers/usb/core/hub.c:5498 #3: ffff8881cdf2c200 (&dev->mutex){....}, at: device_lock include/linux/device.h:1493 [inline] #3: ffff8881cdf2c200 (&dev->mutex){....}, at: usb_disconnect+0x91/0x8d0 drivers/usb/core/hub.c:2191 #4: ffff8881d0a4c190 (&dev->mutex){....}, at: device_release_driver_internal+0x23/0x500 drivers/base/dd.c:1162 5 locks held by kworker/1:4/3277: 3 locks held by kworker/0:6/3693: #0: ffff8881d913b928 ((wq_completion)usb_hub_wq){+.+.}, at: __write_once_size include/linux/compiler.h:226 [inline] #0: ffff8881d913b928 ((wq_completion)usb_hub_wq){+.+.}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline] #0: ffff8881d913b928 ((wq_completion)usb_hub_wq){+.+.}, at: atomic64_set include/asm-generic/atomic-instrumented.h:855 [inline] #0: ffff8881d913b928 ((wq_completion)usb_hub_wq){+.+.}, at: atomic_long_set include/asm-generic/atomic-long.h:40 [inline] #0: ffff8881d913b928 ((wq_completion)usb_hub_wq){+.+.}, at: set_work_data kernel/workqueue.c:615 [inline] #0: ffff8881d913b928 ((wq_completion)usb_hub_wq){+.+.}, at: set_work_pool_and_clear_pending kernel/workqueue.c:642 [inline] #0: ffff8881d913b928 ((wq_completion)usb_hub_wq){+.+.}, at: process_one_work+0x827/0x1530 kernel/workqueue.c:2235 #1: ffff8881d24cfdd0 ((work_completion)(&hub->events)){+.+.}, at: process_one_work+0x85b/0x1530 kernel/workqueue.c:2239 #2: ffff8881d569f200 (&dev->mutex){....}, at: device_lock include/linux/device.h:1493 [inline] #2: ffff8881d569f200 (&dev->mutex){....}, at: hub_event+0x1b2/0x3860 drivers/usb/core/hub.c:5498 3 locks held by kdvb-ca-0:0/8799: 5 locks held by kworker/0:10/10394: #0: ffff8881d913b928 ((wq_completion)usb_hub_wq){+.+.}, at: __write_once_size include/linux/compiler.h:226 [inline] #0: ffff8881d913b928 ((wq_completion)usb_hub_wq){+.+.}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline] #0: ffff8881d913b928 ((wq_completion)usb_hub_wq){+.+.}, at: atomic64_set include/asm-generic/atomic-instrumented.h:855 [inline] #0: ffff8881d913b928 ((wq_completion)usb_hub_wq){+.+.}, at: atomic_long_set include/asm-generic/atomic-long.h:40 [inline] #0: ffff8881d913b928 ((wq_completion)usb_hub_wq){+.+.}, at: set_work_data kernel/workqueue.c:615 [inline] #0: ffff8881d913b928 ((wq_completion)usb_hub_wq){+.+.}, at: set_work_pool_and_clear_pending kernel/workqueue.c:642 [inline] #0: ffff8881d913b928 ((wq_completion)usb_hub_wq){+.+.}, at: process_one_work+0x827/0x1530 kernel/workqueue.c:2235 #1: ffff8881c8fffdd0 ((work_completion)(&hub->events)){+.+.}, at: process_one_work+0x85b/0x1530 kernel/workqueue.c:2239 #2: ffff8881d565a200 (&dev->mutex){....}, at: device_lock include/linux/device.h:1493 [inline] #2: ffff8881d565a200 (&dev->mutex){....}, at: hub_event+0x1b2/0x3860 drivers/usb/core/hub.c:5498 #3: ffff8881db434418 (&rq->lock){-.-.}, at: rq_lock kernel/sched/sched.h:1215 [inline] #3: ffff8881db434418 (&rq->lock){-.-.}, at: __schedule+0x21c/0x1d80 kernel/sched/core.c:4029 #4: ffffffff86cfe560 (rcu_read_lock){....}, at: trace_sched_stat_runtime include/trace/events/sched.h:435 [inline] #4: ffffffff86cfe560 (rcu_read_lock){....}, at: update_curr+0x281/0x810 kernel/sched/fair.c:859 ============================================= NMI backtrace for cpu 1 CPU: 1 PID: 23 Comm: khungtaskd Not tainted 5.4.0-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 Call Trace: __dump_stack lib/dump_stack.c:77 [inline] dump_stack+0xef/0x16e lib/dump_stack.c:118 nmi_cpu_backtrace.cold+0x55/0x96 lib/nmi_backtrace.c:101 nmi_trigger_cpumask_backtrace+0x1b0/0x1c7 lib/nmi_backtrace.c:62 trigger_all_cpu_backtrace include/linux/nmi.h:146 [inline] check_hung_uninterruptible_tasks kernel/hung_task.c:205 [inline] watchdog+0xa7c/0xf80 kernel/hung_task.c:289 kthread+0x318/0x420 kernel/kthread.c:255 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:352 Sending NMI from CPU 1 to CPUs 0: NMI backtrace for cpu 0 CPU: 0 PID: 8799 Comm: kdvb-ca-0:0 Not tainted 5.4.0-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 RIP: 0010:__lock_acquire+0x2c2/0x3b60 kernel/locking/lockdep.c:3895 Code: 02 00 0f 85 25 2c 00 00 49 8d 47 18 4d 89 77 10 48 89 c2 48 89 44 24 38 48 b8 00 00 00 00 00 fc ff df 48 c1 ea 03 80 3c 02 00 <0f> 85 d2 2b 00 00 48 8b 04 24 48 8d bd 1c 08 00 00 48 89 fa 48 c1 RSP: 0018:ffff8881db409718 EFLAGS: 00000046 RAX: dffffc0000000000 RBX: 0000000000000006 RCX: 0000000000000002 RDX: 1ffff11039ea812b RSI: 000000000000002a RDI: ffff8881cf540950 RBP: ffff8881cf540000 R08: 0000000000000000 R09: 0000000000000001 R10: 00000000000000f0 R11: ffffffff87873e07 R12: 000000000000002a R13: 0000000000000000 R14: ffffffff86cfe560 R15: ffff8881cf540940 FS: 0000000000000000(0000) GS:ffff8881db400000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 00007fc43c713000 CR3: 00000001d3538000 CR4: 00000000001406f0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: lock_acquire+0x127/0x320 kernel/locking/lockdep.c:4485 rcu_lock_acquire include/linux/rcupdate.h:208 [inline] rcu_read_lock include/linux/rcupdate.h:617 [inline] cgroup_account_cputime include/linux/cgroup.h:775 [inline] update_curr+0x2b3/0x810 kernel/sched/fair.c:860 enqueue_entity kernel/sched/fair.c:3990 [inline] enqueue_task_fair+0x797/0x2300 kernel/sched/fair.c:5231 enqueue_task kernel/sched/core.c:1301 [inline] activate_task+0xfb/0x320 kernel/sched/core.c:1323 ttwu_do_activate+0xca/0x130 kernel/sched/core.c:2265 ttwu_queue kernel/sched/core.c:2410 [inline] try_to_wake_up+0xb18/0x15e0 kernel/sched/core.c:2644 __wake_up_common+0x147/0x650 kernel/sched/wait.c:93 complete+0x51/0x70 kernel/sched/completion.c:36 transfer drivers/usb/gadget/udc/dummy_hcd.c:1496 [inline] dummy_timer+0x1845/0x2fdb drivers/usb/gadget/udc/dummy_hcd.c:1950 call_timer_fn+0x179/0x650 kernel/time/timer.c:1404 expire_timers kernel/time/timer.c:1449 [inline] __run_timers kernel/time/timer.c:1773 [inline] __run_timers kernel/time/timer.c:1740 [inline] run_timer_softirq+0x5e3/0x1490 kernel/time/timer.c:1786 __do_softirq+0x221/0x912 kernel/softirq.c:292 invoke_softirq kernel/softirq.c:373 [inline] irq_exit+0x178/0x1a0 kernel/softirq.c:413 exiting_irq arch/x86/include/asm/apic.h:536 [inline] smp_apic_timer_interrupt+0x12f/0x500 arch/x86/kernel/apic/apic.c:1137 apic_timer_interrupt+0xf/0x20 arch/x86/entry/entry_64.S:829 RIP: 0010:arch_local_irq_restore arch/x86/include/asm/irqflags.h:85 [inline] RIP: 0010:console_trylock_spinning kernel/printk/printk.c:1751 [inline] RIP: 0010:vprintk_emit+0x3c8/0x3d0 kernel/printk/printk.c:1995 Code: 00 83 fb ff 75 d6 e9 e0 fc ff ff e8 32 b1 15 00 e8 ed ed 1a 00 41 56 9d e9 b6 fd ff ff e8 20 b1 15 00 e8 db ed 1a 00 41 56 9d 2a ff ff ff 0f 1f 00 55 48 89 f5 53 48 89 fb e8 03 b1 15 00 49 RSP: 0018:ffff8881cb737b60 EFLAGS: 00000293 ORIG_RAX: ffffffffffffff13 RAX: 0000000000000007 RBX: 0000000000000200 RCX: 0000000000000006 RDX: 0000000000000000 RSI: 0000000000000008 RDI: ffff8881cf54084c RBP: ffff8881cb737ba8 R08: ffff8881cf540000 R09: fffffbfff11aecbb R10: fffffbfff11aecba R11: ffffffff88d765d7 R12: 000000000000002d R13: ffff8881da67c980 R14: 0000000000000293 R15: 0000000000000000 vprintk_func+0x75/0x113 kernel/printk/printk_safe.c:386 printk+0xba/0xed kernel/printk/printk.c:2056 tt3650_ci_msg.cold+0x30/0x3e drivers/media/usb/dvb-usb/pctv452e.c:141 tt3650_ci_msg_locked+0x83/0xb0 drivers/media/usb/dvb-usb/pctv452e.c:157 tt3650_ci_poll_slot_status+0x90/0x110 drivers/media/usb/dvb-usb/pctv452e.c:333 dvb_ca_en50221_check_camstatus+0x102/0x330 drivers/media/dvb-core/dvb_ca_en50221.c:234 dvb_ca_en50221_thread_state_machine drivers/media/dvb-core/dvb_ca_en50221.c:1128 [inline] dvb_ca_en50221_thread+0x26b/0x13e0 drivers/media/dvb-core/dvb_ca_en50221.c:1317 kthread+0x318/0x420 kernel/kthread.c:255 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:352