syzbot
INFO: task hung in __fuse_request_send
Status:
upstream: reported C repro on 2019/06/18 06:08
Reported-by: syzbot+9a6bd350433f4ec03f80@syzkaller.appspotmail.com
First crash: 2609d, last: 1319d
▶
▼
Fix bisection attempts (14)
Sample crash report:
INFO: task syz-executor964:8247 blocked for more than 140 seconds.
Not tainted 4.19.207-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
syz-executor964 D28184 8247 8132 0x00000004
Call Trace:
context_switch kernel/sched/core.c:2828 [inline]
__schedule+0x887/0x2040 kernel/sched/core.c:3517
schedule+0x8d/0x1b0 kernel/sched/core.c:3561
request_wait_answer+0x3dc/0x750 fs/fuse/dev.c:485
__fuse_request_send+0x123/0x1c0 fs/fuse/dev.c:505
fuse_simple_request+0x2e6/0x820 fs/fuse/dev.c:576
fuse_access+0x21b/0x2f0 fs/fuse/dir.c:1092
fuse_permission+0x33c/0x5a0 fs/fuse/dir.c:1164
do_inode_permission fs/namei.c:386 [inline]
inode_permission.part.0+0x276/0x450 fs/namei.c:451
inode_permission+0x35/0x140 fs/namei.c:406
ksys_chdir+0xc9/0x1d0 fs/open.c:462
__do_sys_chdir fs/open.c:480 [inline]
__se_sys_chdir fs/open.c:478 [inline]
__x64_sys_chdir+0x2d/0x40 fs/open.c:478
do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293
entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x7f82cc34ce39
Code: Bad RIP value.
RSP: 002b:00007f82cc2fd208 EFLAGS: 00000246 ORIG_RAX: 0000000000000050
RAX: ffffffffffffffda RBX: 00007f82cc3d74c8 RCX: 00007f82cc34ce39
RDX: 00007f82cc34ce39 RSI: 5064a7e0d1041c60 RDI: 00000000200020c0
RBP: 00007f82cc3d74c0 R08: 0000000000000000 R09: 00007f82cc3d74c8
R10: 0000000000000000 R11: 0000000000000246 R12: 00007f82cc3d74cc
R13: 00007fffa5d2aa0f R14: 00007f82cc2fd300 R15: 0000000000022000
INFO: task syz-executor964:8276 blocked for more than 140 seconds.
Not tainted 4.19.207-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
syz-executor964 D27840 8276 8132 0x00000004
Call Trace:
context_switch kernel/sched/core.c:2828 [inline]
__schedule+0x887/0x2040 kernel/sched/core.c:3517
schedule+0x8d/0x1b0 kernel/sched/core.c:3561
request_wait_answer+0x3dc/0x750 fs/fuse/dev.c:485
__fuse_request_send+0x123/0x1c0 fs/fuse/dev.c:505
fuse_simple_request+0x2e6/0x820 fs/fuse/dev.c:576
fuse_access+0x21b/0x2f0 fs/fuse/dir.c:1092
fuse_permission+0x33c/0x5a0 fs/fuse/dir.c:1164
do_inode_permission fs/namei.c:386 [inline]
inode_permission.part.0+0x276/0x450 fs/namei.c:451
inode_permission+0x35/0x140 fs/namei.c:406
ksys_chdir+0xc9/0x1d0 fs/open.c:462
__do_sys_chdir fs/open.c:480 [inline]
__se_sys_chdir fs/open.c:478 [inline]
__x64_sys_chdir+0x2d/0x40 fs/open.c:478
do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293
entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x7f82cc34ce39
Code: Bad RIP value.
RSP: 002b:00007f82cc2fd208 EFLAGS: 00000246 ORIG_RAX: 0000000000000050
RAX: ffffffffffffffda RBX: 00007f82cc3d74c8 RCX: 00007f82cc34ce39
RDX: 00007f82cc34ce39 RSI: 5064a7e0d1041c60 RDI: 00000000200020c0
RBP: 00007f82cc3d74c0 R08: 0000000000000000 R09: 00007f82cc3d74c8
R10: 00007f82cc3d74c8 R11: 0000000000000246 R12: 00007f82cc3d74cc
R13: 00007fffa5d2aa0f R14: 00007f82cc2fd300 R15: 0000000000022000
INFO: task syz-executor964:8352 blocked for more than 140 seconds.
Not tainted 4.19.207-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
syz-executor964 D27800 8352 8132 0x00000004
Call Trace:
context_switch kernel/sched/core.c:2828 [inline]
__schedule+0x887/0x2040 kernel/sched/core.c:3517
schedule+0x8d/0x1b0 kernel/sched/core.c:3561
request_wait_answer+0x3dc/0x750 fs/fuse/dev.c:485
__fuse_request_send+0x123/0x1c0 fs/fuse/dev.c:505
fuse_simple_request+0x2e6/0x820 fs/fuse/dev.c:576
fuse_access+0x21b/0x2f0 fs/fuse/dir.c:1092
fuse_permission+0x33c/0x5a0 fs/fuse/dir.c:1164
do_inode_permission fs/namei.c:386 [inline]
inode_permission.part.0+0x276/0x450 fs/namei.c:451
inode_permission+0x35/0x140 fs/namei.c:406
ksys_chdir+0xc9/0x1d0 fs/open.c:462
__do_sys_chdir fs/open.c:480 [inline]
__se_sys_chdir fs/open.c:478 [inline]
__x64_sys_chdir+0x2d/0x40 fs/open.c:478
do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293
entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x7f82cc34ce39
Code: Bad RIP value.
RSP: 002b:00007f82cc2fd208 EFLAGS: 00000246 ORIG_RAX: 0000000000000050
RAX: ffffffffffffffda RBX: 00007f82cc3d74c8 RCX: 00007f82cc34ce39
RDX: 00007f82cc34ce39 RSI: 5064a7e0d1041c60 RDI: 00000000200020c0
RBP: 00007f82cc3d74c0 R08: 0000000000000000 R09: 00007f82cc3d74c8
R10: 0000000000000000 R11: 0000000000000246 R12: 00007f82cc3d74cc
R13: 00007fffa5d2aa0f R14: 00007f82cc2fd300 R15: 0000000000022000
INFO: task syz-executor964:8500 blocked for more than 140 seconds.
Not tainted 4.19.207-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
syz-executor964 D27592 8500 8132 0x00000004
Call Trace:
context_switch kernel/sched/core.c:2828 [inline]
__schedule+0x887/0x2040 kernel/sched/core.c:3517
schedule+0x8d/0x1b0 kernel/sched/core.c:3561
request_wait_answer+0x3dc/0x750 fs/fuse/dev.c:485
__fuse_request_send+0x123/0x1c0 fs/fuse/dev.c:505
fuse_simple_request+0x2e6/0x820 fs/fuse/dev.c:576
fuse_access+0x21b/0x2f0 fs/fuse/dir.c:1092
fuse_permission+0x33c/0x5a0 fs/fuse/dir.c:1164
do_inode_permission fs/namei.c:386 [inline]
inode_permission.part.0+0x276/0x450 fs/namei.c:451
inode_permission+0x35/0x140 fs/namei.c:406
ksys_chdir+0xc9/0x1d0 fs/open.c:462
__do_sys_chdir fs/open.c:480 [inline]
__se_sys_chdir fs/open.c:478 [inline]
__x64_sys_chdir+0x2d/0x40 fs/open.c:478
do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293
entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x7f82cc34ce39
Code: Bad RIP value.
RSP: 002b:00007f82cc2fd208 EFLAGS: 00000246 ORIG_RAX: 0000000000000050
RAX: ffffffffffffffda RBX: 00007f82cc3d74c8 RCX: 00007f82cc34ce39
RDX: 00007f82cc34ce39 RSI: 5064a7e0d1041c60 RDI: 00000000200020c0
RBP: 00007f82cc3d74c0 R08: 0000000000000000 R09: 00007f82cc3d74c8
R10: 0000000000000000 R11: 0000000000000246 R12: 00007f82cc3d74cc
R13: 00007fffa5d2aa0f R14: 00007f82cc2fd300 R15: 0000000000022000
INFO: task syz-executor964:8633 blocked for more than 140 seconds.
Not tainted 4.19.207-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
syz-executor964 D27944 8633 8132 0x00000004
Call Trace:
context_switch kernel/sched/core.c:2828 [inline]
__schedule+0x887/0x2040 kernel/sched/core.c:3517
schedule+0x8d/0x1b0 kernel/sched/core.c:3561
request_wait_answer+0x3dc/0x750 fs/fuse/dev.c:485
__fuse_request_send+0x123/0x1c0 fs/fuse/dev.c:505
fuse_simple_request+0x2e6/0x820 fs/fuse/dev.c:576
fuse_access+0x21b/0x2f0 fs/fuse/dir.c:1092
fuse_permission+0x33c/0x5a0 fs/fuse/dir.c:1164
do_inode_permission fs/namei.c:386 [inline]
inode_permission.part.0+0x276/0x450 fs/namei.c:451
inode_permission+0x35/0x140 fs/namei.c:406
ksys_chdir+0xc9/0x1d0 fs/open.c:462
__do_sys_chdir fs/open.c:480 [inline]
__se_sys_chdir fs/open.c:478 [inline]
__x64_sys_chdir+0x2d/0x40 fs/open.c:478
do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293
entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x7f82cc34ce39
Code: Bad RIP value.
RSP: 002b:00007f82cc2fd208 EFLAGS: 00000246 ORIG_RAX: 0000000000000050
RAX: ffffffffffffffda RBX: 00007f82cc3d74c8 RCX: 00007f82cc34ce39
RDX: 00007f82cc34ce39 RSI: 5064a7e0d1041c60 RDI: 00000000200020c0
RBP: 00007f82cc3d74c0 R08: 0000000000000000 R09: 00007f82cc3d74c8
R10: 0000000000000000 R11: 0000000000000246 R12: 00007f82cc3d74cc
R13: 00007fffa5d2aa0f R14: 00007f82cc2fd300 R15: 0000000000022000
Showing all locks held in the system:
1 lock held by khungtaskd/1570:
#0: 00000000891295d9 (rcu_read_lock){....}, at: debug_show_all_locks+0x53/0x265 kernel/locking/lockdep.c:4441
=============================================
NMI backtrace for cpu 1
CPU: 1 PID: 1570 Comm: khungtaskd Not tainted 4.19.207-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+0x1fc/0x2ef lib/dump_stack.c:118
nmi_cpu_backtrace.cold+0x63/0xa2 lib/nmi_backtrace.c:101
nmi_trigger_cpumask_backtrace+0x1a6/0x1f0 lib/nmi_backtrace.c:62
trigger_all_cpu_backtrace include/linux/nmi.h:146 [inline]
check_hung_uninterruptible_tasks kernel/hung_task.c:203 [inline]
watchdog+0x991/0xe60 kernel/hung_task.c:287
kthread+0x33f/0x460 kernel/kthread.c:259
ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:415
Sending NMI from CPU 1 to CPUs 0:
NMI backtrace for cpu 0
CPU: 0 PID: 4691 Comm: systemd-journal Not tainted 4.19.207-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
RIP: 0010:rol32 include/linux/bitops.h:83 [inline]
RIP: 0010:iterate_chain_key kernel/locking/lockdep.c:314 [inline]
RIP: 0010:__lock_acquire+0x860/0x3ff0 kernel/locking/lockdep.c:3411
Code: da 89 d9 48 c1 ea 20 89 d0 41 29 d0 01 da c1 c0 04 44 31 c0 44 8d 04 10 29 c1 c1 c0 06 48 8b 3c 24 31 c8 89 c1 29 c2 44 01 c0 <c1> c1 08 31 ca 89 d1 41 29 d0 01 c2 c1 c1 10 89 d6 41 31 c8 44 89
RSP: 0018:ffff8880a13ffb58 EFLAGS: 00000096
RAX: 00000000ffffdb00 RBX: 0000000000000000 RCX: 00000000ffffda6c
RDX: 0000000000002594 RSI: ffff8880a13f6dc8 RDI: 0000000000000000
RBP: ffff8880a13f6dea R08: 0000000000000094 R09: 0000000000000000
R10: ffff8880a13f6dc8 R11: 0000000000000000 R12: 0000000000040094
R13: ffff8880a13f6540 R14: ffff8880a13f6de0 R15: 0000000000000001
FS: 00007f3323e0b8c0(0000) GS:ffff8880ba000000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007f33211e8000 CR3: 00000000a0c14000 CR4: 00000000001406f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
lock_acquire+0x170/0x3c0 kernel/locking/lockdep.c:3908
__fs_reclaim_acquire mm/page_alloc.c:3759 [inline]
fs_reclaim_acquire+0x105/0x130 mm/page_alloc.c:3770
slab_pre_alloc_hook mm/slab.h:419 [inline]
slab_alloc mm/slab.c:3383 [inline]
kmem_cache_alloc+0x21/0x370 mm/slab.c:3557
getname_flags+0xce/0x590 fs/namei.c:140
user_path_at_empty+0x2a/0x50 fs/namei.c:2609
user_path_at include/linux/namei.h:57 [inline]
do_faccessat+0x248/0x7a0 fs/open.c:397
do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293
entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x7f33230c69c7
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:00007ffe8bf710c8 EFLAGS: 00000246 ORIG_RAX: 0000000000000015
RAX: ffffffffffffffda RBX: 00007ffe8bf73fe0 RCX: 00007f33230c69c7
RDX: 00007f3323b37a00 RSI: 0000000000000000 RDI: 0000557e6773f9a3
RBP: 00007ffe8bf71100 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000069 R11: 0000000000000246 R12: 0000000000000000
R13: 0000000000000000 R14: 00007ffe8bf73fe0 R15: 00007ffe8bf715f0
----------------
Code disassembly (best guess):
0: da 89 d9 48 c1 ea fimull -0x153eb727(%rcx)
6: 20 89 d0 41 29 d0 and %cl,-0x2fd6be30(%rcx)
c: 01 da add %ebx,%edx
e: c1 c0 04 rol $0x4,%eax
11: 44 31 c0 xor %r8d,%eax
14: 44 8d 04 10 lea (%rax,%rdx,1),%r8d
18: 29 c1 sub %eax,%ecx
1a: c1 c0 06 rol $0x6,%eax
1d: 48 8b 3c 24 mov (%rsp),%rdi
21: 31 c8 xor %ecx,%eax
23: 89 c1 mov %eax,%ecx
25: 29 c2 sub %eax,%edx
27: 44 01 c0 add %r8d,%eax
* 2a: c1 c1 08 rol $0x8,%ecx <-- trapping instruction
2d: 31 ca xor %ecx,%edx
2f: 89 d1 mov %edx,%ecx
31: 41 29 d0 sub %edx,%r8d
34: 01 c2 add %eax,%edx
36: c1 c1 10 rol $0x10,%ecx
39: 89 d6 mov %edx,%esi
3b: 41 31 c8 xor %ecx,%r8d
3e: 44 rex.R
3f: 89 .byte 0x89
* Struck through repros no longer work on HEAD.