syzbot


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: 1360d, last: 204d

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 78 1d07h 1073d 0/1 upstream: reported C repro on 2019/06/20 04:21
linux-4.19 INFO: task hung in usb_bulk_msg C 149 3d05h 1139d 0/1 upstream: reported C repro on 2019/04/15 07:30

Sample crash report:
INFO: task syz-executor323:6547 blocked for more than 143 seconds.
      Not tainted 5.15.0-rc4-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor323 state:D stack:26760 pid: 6547 ppid:  6546 flags:0x00000004
Call Trace:
 context_switch kernel/sched/core.c:4940 [inline]
 __schedule+0x940/0x26f0 kernel/sched/core.c:6287
 schedule+0xd3/0x270 kernel/sched/core.c:6366
 schedule_timeout+0x1db/0x2a0 kernel/time/timer.c:1857
 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+0x171/0x280 kernel/sched/completion.c:157
 usb_start_wait_urb+0x144/0x4c0 drivers/usb/core/message.c:63
 usb_bulk_msg+0x226/0x550 drivers/usb/core/message.c:387
 do_proc_bulk+0x3a3/0x750 drivers/usb/core/devio.c:1236
 proc_bulk drivers/usb/core/devio.c:1273 [inline]
 usbdev_do_ioctl drivers/usb/core/devio.c:2547 [inline]
 usbdev_ioctl+0x586/0x36c0 drivers/usb/core/devio.c:2713
 vfs_ioctl fs/ioctl.c:51 [inline]
 __do_sys_ioctl fs/ioctl.c:874 [inline]
 __se_sys_ioctl fs/ioctl.c:860 [inline]
 __x64_sys_ioctl+0x193/0x200 fs/ioctl.c:860
 do_syscall_x64 arch/x86/entry/common.c:50 [inline]
 do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80
 entry_SYSCALL_64_after_hwframe+0x44/0xae
RIP: 0033:0x7f341de923a9
RSP: 002b:00007ffce9d5ab98 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007f341de923a9
RDX: 00000000200002c0 RSI: 00000000c0185502 RDI: 0000000000000003
RBP: 0000000000000000 R08: 00007ffce9d5ad38 R09: 00007ffce9d5ad38
R10: 00007ffce9d5a610 R11: 0000000000000246 R12: 00007f341de516c0
R13: 431bde82d7b634db R14: 0000000000000000 R15: 0000000000000000

Showing all locks held in the system:
1 lock held by khungtaskd/27:
 #0: ffffffff8b97d3e0 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x53/0x260 kernel/locking/lockdep.c:6446
1 lock held by in:imklog/6449:
 #0: ffff88801f8eab70 (&f->f_pos_lock){+.+.}-{3:3}, at: __fdget_pos+0xe9/0x100 fs/file.c:990

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

NMI backtrace for cpu 0
CPU: 0 PID: 27 Comm: khungtaskd Not tainted 5.15.0-rc4-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
Call Trace:
 __dump_stack lib/dump_stack.c:88 [inline]
 dump_stack_lvl+0xcd/0x134 lib/dump_stack.c:106
 nmi_cpu_backtrace.cold+0x47/0x144 lib/nmi_backtrace.c:105
 nmi_trigger_cpumask_backtrace+0x1ae/0x220 lib/nmi_backtrace.c:62
 trigger_all_cpu_backtrace include/linux/nmi.h:146 [inline]
 check_hung_uninterruptible_tasks kernel/hung_task.c:210 [inline]
 watchdog+0xc1d/0xf50 kernel/hung_task.c:295
 kthread+0x3e5/0x4d0 kernel/kthread.c:319
 ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:295
Sending NMI from CPU 0 to CPUs 1:
NMI backtrace for cpu 1
CPU: 1 PID: 2963 Comm: systemd-journal Not tainted 5.15.0-rc4-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
RIP: 0010:preempt_count arch/x86/include/asm/preempt.h:27 [inline]
RIP: 0010:check_preemption_disabled+0x1b/0x170 lib/smp_processor_id.c:16
Code: 0f 1f 44 00 00 0f 0b e9 23 ff ff ff cc cc cc 41 56 41 55 49 89 f5 41 54 55 48 89 fd 53 0f 1f 44 00 00 65 44 8b 25 bd 37 cc 76 <65> 8b 1d 4e 92 cc 76 81 e3 ff ff ff 7f 31 ff 89 de 0f 1f 44 00 00
RSP: 0018:ffffc90002b67a50 EFLAGS: 00000046
RAX: 0000000000000007 RBX: 1ffff9200056cf52 RCX: 0000000000000000
RDX: 0000000000000000 RSI: ffffffff898be600 RDI: ffffffff89e3a2a0
RBP: ffffffff89e3a2a0 R08: 0000000000000000 R09: ffff8880b9d32a8b
R10: ffffed10173a6551 R11: 0000000000086089 R12: 0000000000000001
R13: ffffffff898be600 R14: ffffffff904afe88 R15: 0000000000000000
FS:  00007f3e540f58c0(0000) GS:ffff8880b9d00000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007f3e514d9000 CR3: 000000007ea5b000 CR4: 00000000003506e0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
 lockdep_recursion_inc kernel/locking/lockdep.c:433 [inline]
 lock_acquire kernel/locking/lockdep.c:5624 [inline]
 lock_acquire+0x170/0x510 kernel/locking/lockdep.c:5590
 __raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:110 [inline]
 _raw_spin_lock_irqsave+0x39/0x50 kernel/locking/spinlock.c:162
 __debug_check_no_obj_freed lib/debugobjects.c:980 [inline]
 debug_check_no_obj_freed+0xc7/0x420 lib/debugobjects.c:1023
 free_pages_prepare mm/page_alloc.c:1343 [inline]
 free_pcp_prepare+0x24e/0x780 mm/page_alloc.c:1389
 free_unref_page_prepare mm/page_alloc.c:3315 [inline]
 free_unref_page+0x19/0x690 mm/page_alloc.c:3394
 slab_destroy mm/slab.c:1627 [inline]
 slabs_destroy+0x89/0xc0 mm/slab.c:1647
 cache_flusharray mm/slab.c:3418 [inline]
 ___cache_free+0x4c6/0x610 mm/slab.c:3480
 qlink_free mm/kasan/quarantine.c:146 [inline]
 qlist_free_all+0x4e/0x110 mm/kasan/quarantine.c:165
 kasan_quarantine_reduce+0x180/0x200 mm/kasan/quarantine.c:272
 __kasan_slab_alloc+0x92/0xa0 mm/kasan/common.c:444
 kasan_slab_alloc include/linux/kasan.h:254 [inline]
 slab_post_alloc_hook mm/slab.h:519 [inline]
 slab_alloc mm/slab.c:3323 [inline]
 kmem_cache_alloc+0x25f/0x540 mm/slab.c:3507
 prepare_creds+0x3f/0x7b0 kernel/cred.c:262
 access_override_creds fs/open.c:351 [inline]
 do_faccessat+0x3f4/0x850 fs/open.c:415
 do_syscall_x64 arch/x86/entry/common.c:50 [inline]
 do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80
 entry_SYSCALL_64_after_hwframe+0x44/0xae
RIP: 0033:0x7f3e533b09c7
Code: 83 c4 08 48 3d 01 f0 ff ff 73 01 c3 48 8b 0d c8 d4 2b 00 f7 d8 64 89 01 48 83 c8 ff c3 66 0f 1f 44 00 00 b8 15 00 00 00 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d a1 d4 2b 00 f7 d8 64 89 01 48
RSP: 002b:00007ffc44340c28 EFLAGS: 00000246 ORIG_RAX: 0000000000000015
RAX: ffffffffffffffda RBX: 00007ffc44343b40 RCX: 00007f3e533b09c7
RDX: 00007f3e53e21a00 RSI: 0000000000000000 RDI: 00005648140059a3
RBP: 00007ffc44340c60 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000069 R11: 0000000000000246 R12: 0000000000000000
R13: 0000000000000000 R14: 00007ffc44343b40 R15: 00007ffc44341150
INFO: NMI handler (nmi_cpu_backtrace_handler) took too long to run: 1.171 msecs
----------------
Code disassembly (best guess):
   0:	0f 1f 44 00 00       	nopl   0x0(%rax,%rax,1)
   5:	0f 0b                	ud2
   7:	e9 23 ff ff ff       	jmpq   0xffffff2f
   c:	cc                   	int3
   d:	cc                   	int3
   e:	cc                   	int3
   f:	41 56                	push   %r14
  11:	41 55                	push   %r13
  13:	49 89 f5             	mov    %rsi,%r13
  16:	41 54                	push   %r12
  18:	55                   	push   %rbp
  19:	48 89 fd             	mov    %rdi,%rbp
  1c:	53                   	push   %rbx
  1d:	0f 1f 44 00 00       	nopl   0x0(%rax,%rax,1)
  22:	65 44 8b 25 bd 37 cc 	mov    %gs:0x76cc37bd(%rip),%r12d        # 0x76cc37e7
  29:	76
* 2a:	65 8b 1d 4e 92 cc 76 	mov    %gs:0x76cc924e(%rip),%ebx        # 0x76cc927f <-- trapping instruction
  31:	81 e3 ff ff ff 7f    	and    $0x7fffffff,%ebx
  37:	31 ff                	xor    %edi,%edi
  39:	89 de                	mov    %ebx,%esi
  3b:	0f 1f 44 00 00       	nopl   0x0(%rax,%rax,1)

Crashes (557):
Manager Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Title
ci-upstream-kasan-gce-selinux-root 2021/10/08 14:36 upstream 1da38549dd64 efe0f24d .config log report syz C INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce-selinux-root 2020/08/29 09:45 upstream 96d454cd2c16 d5a3ae1f .config log report syz C
ci-upstream-kasan-gce-root 2020/08/29 05:36 upstream 96d454cd2c16 d5a3ae1f .config log report syz C
ci-upstream-kasan-gce-selinux-root 2020/08/29 04:17 upstream 96d454cd2c16 d5a3ae1f .config log report syz C
ci-upstream-kasan-gce 2020/08/28 16:44 upstream 15bc20c6af4c 816e0689 .config log report syz C
ci-upstream-kasan-gce-root 2020/08/28 12:52 upstream 15bc20c6af4c 816e0689 .config log report syz C
ci-upstream-kasan-gce-386 2020/08/28 16:12 upstream 15bc20c6af4c 816e0689 .config log report syz C
ci-upstream-kasan-gce 2021/11/04 17:38 upstream 7ddb58cb0eca 4c1be0be .config log report info INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce 2021/11/04 03:19 upstream dcd68326d29b 4c1be0be .config log report info INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce-selinux-root 2021/11/01 21:16 upstream 8bb7eca972ad 098b5d53 .config log report info INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce 2021/11/01 18:40 upstream 8bb7eca972ad 098b5d53 .config log report info INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce 2021/10/31 08:53 upstream 119c85055d86 098b5d53 .config log report info INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce-root 2021/10/23 15:31 upstream 9c0c4d24ac00 282f03fb .config log report info INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce 2021/10/14 08:29 upstream 348949d9a444 5462d470 .config log report info INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce-root 2021/10/06 06:33 upstream f6274b06e326 0a63fd36 .config log report info INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce 2021/10/05 23:56 upstream f6274b06e326 0a63fd36 .config log report info INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce 2021/10/03 04:16 upstream ab2a7a35c4e7 db0f5787 .config log report info INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce 2021/09/30 08:15 upstream 02d5e016800d be530f6c .config log report info INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce-root 2021/09/27 19:07 upstream 5816b3e6577e 78494d16 .config log report info INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce-root 2021/09/27 16:18 upstream 5816b3e6577e 78494d16 .config log report info INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce-root 2021/09/26 05:23 upstream a5e0aceabef6 8cac236e .config log report info INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce-root 2021/09/24 13:04 upstream f9e36107ec70 8cac236e .config log report info INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce-root 2021/09/22 14:26 upstream 92477dd1faa6 169724fe .config log report info INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce-root 2021/09/17 09:00 upstream bdb575f87217 5b989942 .config log report info INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce-root 2021/09/16 10:41 upstream b7213ffa0e58 07e953c1 .config log report info INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce-selinux-root 2021/09/07 05:41 upstream 27151f177827 6ca60148 .config log report info INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce 2021/09/06 07:10 upstream 0319b848b155 d236a457 .config log report info INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce-root 2021/09/04 12:17 upstream 7cca308cfdc0 d236a457 .config log report info INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce 2021/08/15 10:54 upstream ba31f97d43be 2489ab88 .config log report info INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce-selinux-root 2021/08/09 06:51 upstream 66745863ecde 6972b106 .config log report info INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce 2021/08/08 19:09 upstream 85a90500f9a1 6972b106 .config log report info INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce 2021/07/27 06:46 upstream ff1176468d36 fd511809 .config log report info INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce 2021/07/04 11:02 upstream 3dbdb38e2869 55aa55c2 .config log report info INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce 2021/06/15 04:12 upstream 009c9aa5be65 1ba81399 .config log report info INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce 2021/05/31 01:22 upstream b90e90f40b4f 325a8dab .config log report info INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce-root 2021/04/23 14:39 upstream 18a3c5f7abfd 17f0b706 .config log report info INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce 2021/04/14 00:18 upstream eebe426d32e1 a184b83e .config log report info INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce 2021/04/13 19:51 upstream 89698becf06d a184b83e .config log report info INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce 2021/04/12 13:50 upstream d434405aaab7 bfeda1b1 .config log report info INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce 2021/04/11 23:49 upstream 7d900724913c bfeda1b1 .config log report info INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce-selinux-root 2021/04/11 06:11 upstream 52e44129fba5 bfeda1b1 .config log report info INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce 2021/02/21 03:07 upstream f40ddce88593 3e5ed8b4 .config log report info INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce 2021/02/06 00:07 upstream dd86e7fa07a3 23a562df .config log report info INFO: task hung in usb_bulk_msg
ci-qemu2-arm32 2021/11/05 12:08 upstream bf152b0b41dc 4c1be0be .config log report info INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce-386 2021/09/29 02:32 upstream d33bec7b3dfa d82cb927 .config log report info INFO: task hung in usb_bulk_msg
ci-upstream-kasan-gce-root 2020/09/27 22:51 upstream eeddbe6841cd 5dd8aee8 .config log report info
ci-upstream-kasan-gce 2020/09/27 20:16 upstream a1bffa48745a 5dd8aee8 .config log report info
ci-upstream-kasan-gce 2020/09/22 03:24 upstream ba4f184e126b 9e1fa68e .config log report info
ci-upstream-kasan-gce 2020/09/12 12:06 upstream e8878ab82545 79fb24e2 .config log report
ci-upstream-kasan-gce 2020/09/10 06:53 upstream 34d4ddd359db 409809d8 .config log report
ci-upstream-kasan-gce 2020/09/10 02:10 upstream 34d4ddd359db 409809d8 .config log report
ci-upstream-kasan-gce 2020/09/09 06:16 upstream 612ab8ad6414 abf9ba4f .config log report
ci-upstream-kasan-gce 2020/09/08 14:59 upstream f4d51dffc6c0 abf9ba4f .config log report
ci-upstream-kasan-gce-selinux-root 2020/09/07 09:58 upstream f4d51dffc6c0 abf9ba4f .config log report
ci-upstream-kasan-gce-smack-root 2020/02/11 01:26 upstream bb6d3fb354c5 18847f55 .config log report
ci-upstream-kasan-gce-selinux-root 2018/09/06 11:20 upstream b36fdc6853a3 0bb7a7eb .config log report
ci-upstream-kasan-gce-386 2020/09/09 08:47 upstream 6f6a73c8b715 abf9ba4f .config log report
ci-upstream-kasan-gce-386 2020/09/07 19:41 upstream f4d51dffc6c0 abf9ba4f .config log report
ci-upstream-kasan-gce-386 2020/09/07 02:59 upstream f4d51dffc6c0 abf9ba4f .config log report
ci-upstream-linux-next-kasan-gce-root 2020/07/16 10:02 linux-next ca0e494af5ed f3bec699 .config log report