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