INFO: task hung in usb_bulk

INFO: task hung in usb_bulk_msg
Status: upstream: reported C repro on 2018/09/06 16:59
Reported-by: syzbot+7a7613e5ba9ae7bd15f9@syzkaller.appspotmail.com
First crash: 977d, last: 17d

Cause bisection: failed (bisect log)

Fix bisection: fixed by (bisect log) [merge commit]:
commit de925e2fbb44eed8a2a7ce166b485fed5eae01aa
Author: Linus Torvalds <torvalds@linux-foundation.org>
Date: Wed Dec 16 23:44:44 2020 +0000

Merge branch 'for-linus' of git://git.kernel.org/pub/scm/linux/kernel/git/hid/hid

similar bugs (2):
Kernel	Title	Repro	Cause bisect	Fix bisect	Count	Last	Reported	Patched	Status
linux-4.14	INFO: task hung in usb_bulk_msg	C			55	17d	690d	0/1	upstream: reported C repro on 2019/06/20 04:21
linux-4.19	INFO: task hung in usb_bulk_msg	C			47	10d	756d	0/1	upstream: reported C repro on 2019/04/15 07:30

Sample crash report:

INFO: task syz-executor463:6861 blocked for more than 143 seconds.
      Not tainted 5.9.0-rc2-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor463 state:D stack:26864 pid: 6861 ppid:  6855 flags:0x00000000
Call Trace:
 context_switch kernel/sched/core.c:3778 [inline]
 __schedule+0x8e5/0x21e0 kernel/sched/core.c:4527
 schedule+0xd0/0x2a0 kernel/sched/core.c:4602
 schedule_timeout+0x1d8/0x250 kernel/time/timer.c:1855
 do_wait_for_common kernel/sched/completion.c:85 [inline]
 __wait_for_common kernel/sched/completion.c:106 [inline]
 wait_for_common kernel/sched/completion.c:117 [inline]
 wait_for_completion_timeout+0x15e/0x270 kernel/sched/completion.c:157
 usb_start_wait_urb+0x144/0x2b0 drivers/usb/core/message.c:63
 usb_bulk_msg+0x226/0x550 drivers/usb/core/message.c:254
 do_proc_bulk+0x39b/0x710 drivers/usb/core/devio.c:1231
 proc_bulk drivers/usb/core/devio.c:1268 [inline]
 usbdev_do_ioctl drivers/usb/core/devio.c:2542 [inline]
 usbdev_ioctl+0x586/0x3360 drivers/usb/core/devio.c:2708
 vfs_ioctl fs/ioctl.c:48 [inline]
 __do_sys_ioctl fs/ioctl.c:753 [inline]
 __se_sys_ioctl fs/ioctl.c:739 [inline]
 __x64_sys_ioctl+0x193/0x200 fs/ioctl.c:739
 do_syscall_64+0x2d/0x70 arch/x86/entry/common.c:46
 entry_SYSCALL_64_after_hwframe+0x44/0xa9
RIP: 0033:0x443f89
Code: Bad RIP value.
RSP: 002b:00007ffe8124ff08 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
RAX: ffffffffffffffda RBX: 00000000004002e0 RCX: 0000000000443f89
RDX: 0000000020000000 RSI: 00000000c0185502 RDI: 0000000000000003
RBP: 00000000006ce018 R08: 00000000004002e0 R09: 00000000004002e0
R10: 00000000004002e0 R11: 0000000000000246 R12: 0000000000401c10
R13: 0000000000401ca0 R14: 0000000000000000 R15: 0000000000000000

Showing all locks held in the system:
1 lock held by khungtaskd/1171:
 #0: ffffffff89bd6900 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x53/0x260 kernel/locking/lockdep.c:5825
1 lock held by in:imklog/6546:
 #0: ffff8880a67ffaf0 (&f->f_pos_lock){+.+.}-{3:3}, at: __fdget_pos+0xe9/0x100 fs/file.c:930

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

NMI backtrace for cpu 0
CPU: 0 PID: 1171 Comm: khungtaskd Not tainted 5.9.0-rc2-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+0x18f/0x20d lib/dump_stack.c:118
 nmi_cpu_backtrace.cold+0x70/0xb1 lib/nmi_backtrace.c:101
 nmi_trigger_cpumask_backtrace+0x1b3/0x223 lib/nmi_backtrace.c:62
 trigger_all_cpu_backtrace include/linux/nmi.h:146 [inline]
 check_hung_uninterruptible_tasks kernel/hung_task.c:209 [inline]
 watchdog+0xd7d/0x1000 kernel/hung_task.c:295
 kthread+0x3b5/0x4a0 kernel/kthread.c:292
 ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:294
Sending NMI from CPU 0 to CPUs 1:
NMI backtrace for cpu 1
CPU: 1 PID: 3901 Comm: systemd-journal Not tainted 5.9.0-rc2-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
RIP: 0010:get_current arch/x86/include/asm/current.h:15 [inline]
RIP: 0010:__sanitizer_cov_trace_pc+0x0/0x60 kernel/kcov.c:196
Code: 48 89 ef 5d e9 a1 a3 3f 00 5d be 03 00 00 00 e9 36 27 27 02 66 0f 1f 44 00 00 48 8b be b0 01 00 00 e8 b4 ff ff ff 31 c0 c3 90 <65> 48 8b 14 25 c0 fe 01 00 65 8b 05 60 bf 8d 7e a9 00 01 ff 00 48
RSP: 0018:ffffc90005387d60 EFLAGS: 00000246
RAX: 0000000000000000 RBX: ffff88808e8bade0 RCX: ffffffff81bd1aab
RDX: ffff8880a64d8380 RSI: ffffffff81bd1ab9 RDI: ffff88808e8bade0
RBP: 0000000080000000 R08: 0000000000000001 R09: ffff88808e8bbdbf
R10: 0000000000000002 R11: 0000000000000000 R12: 0000000000000000
R13: 0000000000000000 R14: 0000000000000000 R15: ffffffff8ab264c8
FS:  00007f99b1df88c0(0000) GS:ffff8880ae700000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007f99af1ac000 CR3: 00000000a71c1000 CR4: 00000000001506e0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
 __virt_addr_valid+0x18/0x2b0 arch/x86/mm/physaddr.c:49
 check_heap_object mm/usercopy.c:228 [inline]
 __check_object_size mm/usercopy.c:286 [inline]
 __check_object_size+0xc1/0x3e4 mm/usercopy.c:256
 check_object_size include/linux/thread_info.h:119 [inline]
 strncpy_from_user+0xaf/0x3e0 lib/strncpy_from_user.c:119
 getname_flags.part.0+0x95/0x4f0 fs/namei.c:149
 getname_flags+0x9a/0xe0 include/linux/audit.h:320
 getname fs/namei.c:209 [inline]
 user_path_create fs/namei.c:3524 [inline]
 do_mkdirat+0x8d/0x2d0 fs/namei.c:3664
 do_syscall_64+0x2d/0x70 arch/x86/entry/common.c:46
 entry_SYSCALL_64_after_hwframe+0x44/0xa9
RIP: 0033:0x7f99b10b4687
Code: 00 b8 ff ff ff ff c3 0f 1f 40 00 48 8b 05 09 d8 2b 00 64 c7 00 5f 00 00 00 b8 ff ff ff ff c3 0f 1f 40 00 b8 53 00 00 00 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d e1 d7 2b 00 f7 d8 64 89 01 48
RSP: 002b:00007ffefe4e5b08 EFLAGS: 00000293 ORIG_RAX: 0000000000000053
RAX: ffffffffffffffda RBX: 00007ffefe4e8b70 RCX: 00007f99b10b4687
RDX: 0000000000000000 RSI: 00000000000001ed RDI: 0000564a771358c0
RBP: 00007ffefe4e5b40 R08: 0000564a76dcd3e5 R09: 0000000000000018
R10: 0000000000000069 R11: 0000000000000293 R12: 0000000000000000
R13: 0000000000000001 R14: 0000564a771358c0 R15: 00007ffefe4e6180

Crashes (524):
Manager	Time	Kernel	Commit	Syzkaller	Config	Log	Report	Syz repro	C repro	VM info	Title
ci-upstream-kasan-gce-selinux-root	2020/08/29 09:45	upstream	96d454cd	d5a3ae1f	.config	log	report	syz	C
ci-upstream-kasan-gce-root	2020/08/29 05:36	upstream	96d454cd	d5a3ae1f	.config	log	report	syz	C
ci-upstream-kasan-gce-selinux-root	2020/08/29 04:17	upstream	96d454cd	d5a3ae1f	.config	log	report	syz	C
ci-upstream-kasan-gce	2020/08/28 16:44	upstream	15bc20c6	816e0689	.config	log	report	syz	C
ci-upstream-kasan-gce-root	2020/08/28 12:52	upstream	15bc20c6	816e0689	.config	log	report	syz	C
ci-upstream-kasan-gce-386	2020/08/28 16:12	upstream	15bc20c6	816e0689	.config	log	report	syz	C
ci-upstream-kasan-gce-root	2021/04/23 14:39	upstream	18a3c5f7	17f0b706	.config	log	report			info	INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce	2021/04/14 00:18	upstream	eebe426d	a184b83e	.config	log	report			info	INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce	2021/04/13 19:51	upstream	89698bec	a184b83e	.config	log	report			info	INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce	2021/04/12 13:50	upstream	d434405a	bfeda1b1	.config	log	report			info	INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce	2021/04/11 23:49	upstream	7d900724	bfeda1b1	.config	log	report			info	INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce-selinux-root	2021/04/11 06:11	upstream	52e44129	bfeda1b1	.config	log	report			info	INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce	2021/02/21 03:07	upstream	f40ddce8	3e5ed8b4	.config	log	report			info	INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce	2021/02/06 00:07	upstream	dd86e7fa	23a562df	.config	log	report			info	INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce-root	2020/09/27 22:51	upstream	eeddbe68	5dd8aee8	.config	log	report			info
ci-upstream-kasan-gce	2020/09/27 20:16	upstream	a1bffa48	5dd8aee8	.config	log	report			info
ci-upstream-kasan-gce	2020/09/22 03:24	upstream	ba4f184e	9e1fa68e	.config	log	report			info
ci-upstream-kasan-gce	2020/09/12 12:06	upstream	e8878ab8	79fb24e2	.config	log	report
ci-upstream-kasan-gce	2020/09/10 06:53	upstream	34d4ddd3	409809d8	.config	log	report
ci-upstream-kasan-gce	2020/09/10 02:10	upstream	34d4ddd3	409809d8	.config	log	report
ci-upstream-kasan-gce	2020/09/09 06:16	upstream	612ab8ad	abf9ba4f	.config	log	report
ci-upstream-kasan-gce	2020/09/08 14:59	upstream	f4d51dff	abf9ba4f	.config	log	report
ci-upstream-kasan-gce-selinux-root	2020/09/07 09:58	upstream	f4d51dff	abf9ba4f	.config	log	report
ci-upstream-kasan-gce-root	2020/09/06 20:19	upstream	dd9fb9bb	abf9ba4f	.config	log	report
ci-upstream-kasan-gce	2020/09/06 18:43	upstream	dd9fb9bb	abf9ba4f	.config	log	report
ci-upstream-kasan-gce-selinux-root	2020/09/06 18:26	upstream	dd9fb9bb	abf9ba4f	.config	log	report
ci-upstream-kasan-gce	2020/09/06 02:38	upstream	9322c47b	abf9ba4f	.config	log	report
ci-upstream-kasan-gce-root	2020/09/04 23:41	upstream	59126901	abf9ba4f	.config	log	report
ci-upstream-kasan-gce-selinux-root	2020/09/04 20:11	upstream	59126901	abf9ba4f	.config	log	report
ci-upstream-kasan-gce	2020/09/04 17:54	upstream	59126901	abf9ba4f	.config	log	report
ci-upstream-kasan-gce-root	2020/09/03 16:22	upstream	fc3abb53	abf9ba4f	.config	log	report
ci-upstream-kasan-gce	2020/09/03 14:36	upstream	fc3abb53	abf9ba4f	.config	log	report
ci-upstream-kasan-gce-root	2020/08/31 06:32	upstream	dcc5c6f0	d5a3ae1f	.config	log	report
ci-upstream-kasan-gce	2020/08/28 08:42	upstream	15bc20c6	816e0689	.config	log	report
ci-upstream-kasan-gce	2020/08/28 08:35	upstream	15bc20c6	816e0689	.config	log	report
ci-upstream-kasan-gce-selinux-root	2020/08/26 06:24	upstream	abb3438d	344da168	.config	log	report
ci-upstream-kasan-gce-root	2020/07/06 11:49	upstream	7cc2a8ea	51095195	.config	log	report
ci-upstream-kasan-gce	2020/07/06 05:09	upstream	7cc2a8ea	51095195	.config	log	report
ci-upstream-kasan-gce-selinux-root	2020/04/29 12:31	upstream	3f777e19	e3ecea2e	.config	log	report
ci-upstream-kasan-gce	2020/04/26 15:58	upstream	b2768df2	99b258dd	.config	log	report
ci-upstream-kasan-gce	2020/03/31 07:21	upstream	673b41e0	c8d1cc20	.config	log	report
ci-upstream-kasan-gce-root	2020/03/11 09:43	upstream	e9414845	35f53e45	.config	log	report
ci-upstream-kasan-gce-smack-root	2020/02/11 01:26	upstream	bb6d3fb3	18847f55	.config	log	report
ci-upstream-kasan-gce-selinux-root	2018/09/06 11:20	upstream	b36fdc68	0bb7a7eb	.config	log	report
ci-upstream-kasan-gce-386	2020/09/09 08:47	upstream	6f6a73c8	abf9ba4f	.config	log	report
ci-upstream-kasan-gce-386	2020/09/07 19:41	upstream	f4d51dff	abf9ba4f	.config	log	report
ci-upstream-kasan-gce-386	2020/09/07 02:59	upstream	f4d51dff	abf9ba4f	.config	log	report
ci-upstream-kasan-gce-386	2020/07/18 16:10	upstream	6a70f89c	9c812472	.config	log	report
ci-upstream-kasan-gce-386	2020/07/07 01:20	upstream	7cc2a8ea	51095195	.config	log	report
ci-upstream-kasan-gce-386	2020/07/03 23:46	upstream	7cc2a8ea	51095195	.config	log	report
ci-upstream-kasan-gce-386	2020/07/03 20:59	upstream	7cc2a8ea	bed10395	.config	log	report
ci-upstream-kasan-gce-386	2020/07/02 19:38	upstream	cd77006e	bed10395	.config	log	report
ci-upstream-kasan-gce-386	2020/06/12 10:40	upstream	7ae77150	58802067	.config	log	report
ci-upstream-kasan-gce-386	2020/04/25 04:53	upstream	b4f63322	03d97a1b	.config	log	report
ci-upstream-kasan-gce-386	2020/04/11 18:54	upstream	5b8b9d0c	a8c6a3f8	.config	log	report
ci-upstream-linux-next-kasan-gce-root	2020/07/16 10:02	linux-next	ca0e494a	f3bec699	.config	log	report
ci-upstream-linux-next-kasan-gce-root	2020/07/15 02:06	linux-next	5fb3d604	609fb517	.config	log	report
ci-upstream-linux-next-kasan-gce-root	2020/05/01 16:37	linux-next	ac935d22	a4d01b80	.config	log	report