syzbot


INFO: task hung in dvb_ca_en50221_release

Status: auto-closed as invalid on 2020/05/02 03:01
Subsystems: media
[Documentation on labels]
First crash: 1626d, last: 1556d
Similar bugs (1)
Kernel Title Repro Cause bisect Fix bisect Count Last Reported Patched Status
upstream INFO: task hung in dvb_ca_en50221_release (2) media 1 1363d 1363d 0/26 auto-closed as invalid on 2020/11/10 22:44

Sample crash report:
INFO: task kworker/0:4:4498 blocked for more than 144 seconds.
      Not tainted 5.5.0-rc7-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
kworker/0:4     D22384  4498      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+0x17a/0x780 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+0x2eb/0x5a0 drivers/base/bus.c:532
 device_del+0x481/0xd30 drivers/base/core.c:2664
 usb_disable_device+0x23d/0x790 drivers/usb/core/message.c:1237
 usb_disconnect+0x293/0x900 drivers/usb/core/hub.c:2201
 hub_port_connect drivers/usb/core/hub.c:5036 [inline]
 hub_port_connect_change drivers/usb/core/hub.c:5325 [inline]
 port_event drivers/usb/core/hub.c:5471 [inline]
 hub_event+0x1a1d/0x4300 drivers/usb/core/hub.c:5553
 process_one_work+0x945/0x15c0 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:
1 lock held by khungtaskd/22:
 #0: ffffffff871055a0 (rcu_read_lock){....}, at: debug_show_all_locks+0x53/0x264 kernel/locking/lockdep.c:5331
3 locks held by kworker/1:2/83:
1 lock held by rsyslogd/1676:
2 locks held by getty/1768:
 #0: ffff8881cee55090 (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x22/0x80 drivers/tty/tty_ldisc.c:267
 #1: ffffc9000044d2e0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x21d/0x1b30 drivers/tty/n_tty.c:2156
2 locks held by getty/1769:
 #0: ffff8881cf8d2090 (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x22/0x80 drivers/tty/tty_ldisc.c:267
 #1: ffffc9000046d2e0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x21d/0x1b30 drivers/tty/n_tty.c:2156
2 locks held by getty/1770:
 #0: ffff8881cefdc090 (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x22/0x80 drivers/tty/tty_ldisc.c:267
 #1: ffffc900004652e0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x21d/0x1b30 drivers/tty/n_tty.c:2156
2 locks held by getty/1771:
 #0: ffff8881cee68090 (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x22/0x80 drivers/tty/tty_ldisc.c:267
 #1: ffffc900004552e0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x21d/0x1b30 drivers/tty/n_tty.c:2156
2 locks held by getty/1772:
 #0: ffff8881cefdb090 (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x22/0x80 drivers/tty/tty_ldisc.c:267
 #1: ffffc900004612e0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x21d/0x1b30 drivers/tty/n_tty.c:2156
2 locks held by getty/1773:
 #0: ffff8881cf39c090 (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x22/0x80 drivers/tty/tty_ldisc.c:267
 #1: ffffc9000043d2e0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x21d/0x1b30 drivers/tty/n_tty.c:2156
5 locks held by kworker/0:4/4498:
 #0: ffff8881d8e92d28 ((wq_completion)usb_hub_wq){+.+.}, at: __write_once_size include/linux/compiler.h:226 [inline]
 #0: ffff8881d8e92d28 ((wq_completion)usb_hub_wq){+.+.}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline]
 #0: ffff8881d8e92d28 ((wq_completion)usb_hub_wq){+.+.}, at: atomic64_set include/asm-generic/atomic-instrumented.h:855 [inline]
 #0: ffff8881d8e92d28 ((wq_completion)usb_hub_wq){+.+.}, at: atomic_long_set include/asm-generic/atomic-long.h:40 [inline]
 #0: ffff8881d8e92d28 ((wq_completion)usb_hub_wq){+.+.}, at: set_work_data kernel/workqueue.c:615 [inline]
 #0: ffff8881d8e92d28 ((wq_completion)usb_hub_wq){+.+.}, at: set_work_pool_and_clear_pending kernel/workqueue.c:642 [inline]
 #0: ffff8881d8e92d28 ((wq_completion)usb_hub_wq){+.+.}, at: process_one_work+0x827/0x15c0 kernel/workqueue.c:2235
 #1: ffff8881abaafdd0 ((work_completion)(&hub->events)){+.+.}, at: process_one_work+0x85b/0x15c0 kernel/workqueue.c:2239
 #2: ffff8881d4e24200 (&dev->mutex){....}, at: device_lock include/linux/device.h:1493 [inline]
 #2: ffff8881d4e24200 (&dev->mutex){....}, at: hub_event+0x1be/0x4300 drivers/usb/core/hub.c:5499
 #3: ffff8881d40aa200 (&dev->mutex){....}, at: device_lock include/linux/device.h:1493 [inline]
 #3: ffff8881d40aa200 (&dev->mutex){....}, at: usb_disconnect+0x91/0x900 drivers/usb/core/hub.c:2192
 #4: ffff8881cb8b0190 (&dev->mutex){....}, at: device_release_driver_internal+0x23/0x500 drivers/base/dd.c:1162
3 locks held by kworker/1:7/4713:
 #0: ffff8881d8e92d28 ((wq_completion)usb_hub_wq){+.+.}, at: __write_once_size include/linux/compiler.h:226 [inline]
 #0: ffff8881d8e92d28 ((wq_completion)usb_hub_wq){+.+.}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline]
 #0: ffff8881d8e92d28 ((wq_completion)usb_hub_wq){+.+.}, at: atomic64_set include/asm-generic/atomic-instrumented.h:855 [inline]
 #0: ffff8881d8e92d28 ((wq_completion)usb_hub_wq){+.+.}, at: atomic_long_set include/asm-generic/atomic-long.h:40 [inline]
 #0: ffff8881d8e92d28 ((wq_completion)usb_hub_wq){+.+.}, at: set_work_data kernel/workqueue.c:615 [inline]
 #0: ffff8881d8e92d28 ((wq_completion)usb_hub_wq){+.+.}, at: set_work_pool_and_clear_pending kernel/workqueue.c:642 [inline]
 #0: ffff8881d8e92d28 ((wq_completion)usb_hub_wq){+.+.}, at: process_one_work+0x827/0x15c0 kernel/workqueue.c:2235
 #1: ffff8881c152fdd0 ((work_completion)(&hub->events)){+.+.}, at: process_one_work+0x85b/0x15c0 kernel/workqueue.c:2239
 #2: ffff8881d4d31200 (&dev->mutex){....}, at: device_lock include/linux/device.h:1493 [inline]
 #2: ffff8881d4d31200 (&dev->mutex){....}, at: hub_event+0x1be/0x4300 drivers/usb/core/hub.c:5499
2 locks held by getty/14483:
 #0: ffff8881d360e090 (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x22/0x80 drivers/tty/tty_ldisc.c:267
 #1: ffffc9000e0da2e0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x21d/0x1b30 drivers/tty/n_tty.c:2156
5 locks held by kdvb-ca-0:0/17612:

=============================================

NMI backtrace for cpu 1
CPU: 1 PID: 22 Comm: khungtaskd Not tainted 5.5.0-rc7-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+0x70/0xb1 lib/nmi_backtrace.c:101
 nmi_trigger_cpumask_backtrace+0x1db/0x207 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+0xa99/0xfd0 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: 17612 Comm: kdvb-ca-0:0 Not tainted 5.5.0-rc7-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
RIP: 0010:__lock_acquire+0x78/0x3b60 kernel/locking/lockdep.c:3815
Code: 04 24 48 8d 84 24 88 00 00 00 48 c1 e8 03 48 89 44 24 10 48 89 c3 48 b8 00 00 00 00 00 fc ff df 48 8d 14 03 c7 02 f1 f1 f1 f1 <c7> 42 04 00 f3 f3 f3 48 c7 c2 f4 e4 e1 87 65 48 8b 1c 25 28 00 00
RSP: 0018:ffff8881db209b68 EFLAGS: 00000806
RAX: dffffc0000000000 RBX: 1ffff1103b64137e RCX: 0000000000000000
RDX: ffffed103b64137e RSI: 0000000000000000 RDI: ffff8881cf748be0
RBP: ffff8881cc0c0000 R08: 0000000000000001 R09: 0000000000000000
R10: fffffbfff0fc3ab0 R11: ffffffff87e1d587 R12: 0000000000000000
R13: 0000000000000000 R14: ffff8881cf748be0 R15: 0000000000000000
FS:  0000000000000000(0000) GS:ffff8881db200000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007f4c64aaabec CR3: 00000001c9a27000 CR4: 00000000001406f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
 <IRQ>
 lock_acquire+0x130/0x340 kernel/locking/lockdep.c:4484
 __raw_spin_lock include/linux/spinlock_api_smp.h:142 [inline]
 _raw_spin_lock+0x27/0x40 kernel/locking/spinlock.c:151
 spin_lock include/linux/spinlock.h:338 [inline]
 tcp_write_timer+0x26/0x2b0 net/ipv4/tcp_timer.c:623
 call_timer_fn+0x195/0x6f0 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+0x5f9/0x1500 kernel/time/timer.c:1786
 __do_softirq+0x21e/0x950 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+0x141/0x540 arch/x86/kernel/apic/apic.c:1137
 apic_timer_interrupt+0xf/0x20 arch/x86/entry/entry_64.S:829
 </IRQ>
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 82 d6 15 00 e8 ad 1a 1b 00 41 56 9d e9 b6 fd ff ff e8 70 d6 15 00 e8 9b 1a 1b 00 41 56 9d <e9> 2a ff ff ff 0f 1f 00 55 48 89 f5 53 48 89 fb e8 53 d6 15 00 49
RSP: 0018:ffff8881abb4fb60 EFLAGS: 00000293 ORIG_RAX: ffffffffffffff13
RAX: 0000000000000007 RBX: 0000000000000200 RCX: 0000000000000006
RDX: 0000000000000000 RSI: 0000000000000008 RDI: ffff8881cc0c084c
RBP: ffff8881abb4fba8 R08: ffff8881cc0c0000 R09: fffffbfff1269cba
R10: fffffbfff1269cb9 R11: ffffffff8934e5cf R12: 000000000000002d
R13: ffff8881da24e200 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

Crashes (15):
Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Assets (help?) Manager Title
2020/02/02 03:00 https://github.com/google/kasan.git usb-fuzzer cd234325a5f1 2274ad39 .config console log report ci2-upstream-usb
2020/01/30 04:15 https://github.com/google/kasan.git usb-fuzzer cd234325a5f1 5ed23f9a .config console log report ci2-upstream-usb
2020/01/29 08:22 https://github.com/google/kasan.git usb-fuzzer cd234325a5f1 c8e81ce4 .config console log report ci2-upstream-usb
2019/12/27 04:46 https://github.com/google/kasan.git usb-fuzzer ecdf2214f472 be5c2c81 .config console log report ci2-upstream-usb
2019/12/11 14:20 https://github.com/google/kasan.git usb-fuzzer a38cc9afab8a 0d368675 .config console log report ci2-upstream-usb
2019/12/10 23:17 https://github.com/google/kasan.git usb-fuzzer a38cc9afab8a 101194eb .config console log report ci2-upstream-usb
2019/12/09 02:43 https://github.com/google/kasan.git usb-fuzzer 1f22d15c209f 1508f453 .config console log report ci2-upstream-usb
2019/12/08 11:57 https://github.com/google/kasan.git usb-fuzzer 1f22d15c209f 1508f453 .config console log report ci2-upstream-usb
2019/12/08 09:24 https://github.com/google/kasan.git usb-fuzzer 1f22d15c209f 1508f453 .config console log report ci2-upstream-usb
2019/12/06 10:19 https://github.com/google/kasan.git usb-fuzzer 1f22d15c209f 98b4ef2d .config console log report ci2-upstream-usb
2019/12/05 03:16 https://github.com/google/kasan.git usb-fuzzer 1f22d15c209f b2088328 .config console log report ci2-upstream-usb
2019/12/05 00:01 https://github.com/google/kasan.git usb-fuzzer 1f22d15c209f b2088328 .config console log report ci2-upstream-usb
2019/11/26 15:16 https://github.com/google/kasan.git usb-fuzzer da06441bb485 598ca6c8 .config console log report ci2-upstream-usb
2019/11/25 19:35 https://github.com/google/kasan.git usb-fuzzer da06441bb485 598ca6c8 .config console log report ci2-upstream-usb
2019/11/24 08:51 https://github.com/google/kasan.git usb-fuzzer da06441bb485 598ca6c8 .config console log report ci2-upstream-usb
* Struck through repros no longer work on HEAD.