[reiserfs?] INFO: task hung in queue_log_writer

9 views
Skip to first unread message

syzbot

unread,
Jan 8, 2023, 1:46:37 PM1/8/23
to syzkaller...@googlegroups.com
Hello,

syzbot found the following issue on:

HEAD commit: 3f8a27f9e27b Linux 4.19.211
git tree: linux-4.19.y
console output: https://syzkaller.appspot.com/x/log.txt?x=14badb76480000
kernel config: https://syzkaller.appspot.com/x/.config?x=9b9277b418617afe
dashboard link: https://syzkaller.appspot.com/bug?extid=c360748f8febb365d65e
compiler: gcc version 10.2.1 20210110 (Debian 10.2.1-6)

Unfortunately, I don't have any reproducer for this issue yet.

Downloadable assets:
disk image: https://storage.googleapis.com/syzbot-assets/98c0bdb4abb3/disk-3f8a27f9.raw.xz
vmlinux: https://storage.googleapis.com/syzbot-assets/ea228ff02669/vmlinux-3f8a27f9.xz

IMPORTANT: if you fix the issue, please add the following tag to the commit:
Reported-by: syzbot+c36074...@syzkaller.appspotmail.com

audit: type=1800 audit(1673203507.453:310): pid=24187 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=collect_data cause=failed(directio) comm="syz-executor.5" name="bus" dev="sda1" ino=13866 res=0
Bluetooth: hci9: command 0x041b tx timeout
Bluetooth: hci9: command 0x040f tx timeout
Bluetooth: hci9: command 0x0419 tx timeout
INFO: task kworker/u4:0:8232 blocked for more than 140 seconds.
Not tainted 4.19.211-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
kworker/u4:0 D25696 8232 2 0x80000000
Workqueue: writeback wb_workfn (flush-7:2)
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
queue_log_writer+0x27a/0x2d0 fs/reiserfs/journal.c:2990
do_journal_begin_r+0x97b/0x10b0 fs/reiserfs/journal.c:3113
journal_begin+0x162/0x400 fs/reiserfs/journal.c:3265
reiserfs_write_inode+0x1f0/0x2d0 fs/reiserfs/inode.c:1787
write_inode fs/fs-writeback.c:1244 [inline]
__writeback_single_inode+0x733/0x11d0 fs/fs-writeback.c:1442
writeback_sb_inodes+0x537/0xef0 fs/fs-writeback.c:1647
wb_writeback+0x28d/0xcc0 fs/fs-writeback.c:1820
wb_do_writeback fs/fs-writeback.c:1965 [inline]
wb_workfn+0x29b/0x1250 fs/fs-writeback.c:2006
process_one_work+0x864/0x1570 kernel/workqueue.c:2153
worker_thread+0x64c/0x1130 kernel/workqueue.c:2296
kthread+0x33f/0x460 kernel/kthread.c:259
ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:415
INFO: task syz-executor.0:22029 blocked for more than 140 seconds.
Not tainted 4.19.211-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
syz-executor.0 D28304 22029 8160 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
__rwsem_down_read_failed_common kernel/locking/rwsem-xadd.c:292 [inline]
rwsem_down_read_failed+0x20a/0x390 kernel/locking/rwsem-xadd.c:309
call_rwsem_down_read_failed+0x14/0x30 arch/x86/lib/rwsem.S:94
__down_read arch/x86/include/asm/rwsem.h:83 [inline]
down_read+0x44/0x80 kernel/locking/rwsem.c:26
iterate_supers+0xdb/0x290 fs/super.c:631
ksys_sync+0x86/0x150 fs/sync.c:113
__ia32_sys_sync+0xa/0x10 fs/sync.c:124
do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293
entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x7f20a86740c9
Code: Bad RIP value.
RSP: 002b:00007f20a6be6168 EFLAGS: 00000246 ORIG_RAX: 00000000000000a2
RAX: ffffffffffffffda RBX: 00007f20a8793f80 RCX: 00007f20a86740c9
RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000000
RBP: 00007f20a86cfae9 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007fffaf5838df R14: 00007f20a6be6300 R15: 0000000000022000
INFO: task syz-executor.0:22151 blocked for more than 140 seconds.
Not tainted 4.19.211-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
syz-executor.0 D28296 22151 8160 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
__rwsem_down_read_failed_common kernel/locking/rwsem-xadd.c:292 [inline]
rwsem_down_read_failed+0x20a/0x390 kernel/locking/rwsem-xadd.c:309
call_rwsem_down_read_failed+0x14/0x30 arch/x86/lib/rwsem.S:94
__down_read arch/x86/include/asm/rwsem.h:83 [inline]
down_read+0x44/0x80 kernel/locking/rwsem.c:26
iterate_supers+0xdb/0x290 fs/super.c:631
ksys_sync+0x86/0x150 fs/sync.c:113
__ia32_sys_sync+0xa/0x10 fs/sync.c:124
do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293
entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x7f20a86740c9
Code: Bad RIP value.
RSP: 002b:00007f209f7c5168 EFLAGS: 00000246 ORIG_RAX: 00000000000000a2
RAX: ffffffffffffffda RBX: 00007f20a8794050 RCX: 00007f20a86740c9
RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000000
RBP: 00007f20a86cfae9 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007fffaf5838df R14: 00007f209f7c5300 R15: 0000000000022000
INFO: task syz-executor.0:22163 blocked for more than 140 seconds.
Not tainted 4.19.211-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
syz-executor.0 D30080 22163 8160 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
__rwsem_down_read_failed_common kernel/locking/rwsem-xadd.c:292 [inline]
rwsem_down_read_failed+0x20a/0x390 kernel/locking/rwsem-xadd.c:309
call_rwsem_down_read_failed+0x14/0x30 arch/x86/lib/rwsem.S:94
__down_read arch/x86/include/asm/rwsem.h:83 [inline]
down_read+0x44/0x80 kernel/locking/rwsem.c:26
iterate_supers+0xdb/0x290 fs/super.c:631
ksys_sync+0x86/0x150 fs/sync.c:113
__ia32_sys_sync+0xa/0x10 fs/sync.c:124
do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293
entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x7f20a86740c9
Code: Bad RIP value.
RSP: 002b:00007f209f7a4168 EFLAGS: 00000246 ORIG_RAX: 00000000000000a2
RAX: ffffffffffffffda RBX: 00007f20a8794120 RCX: 00007f20a86740c9
RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000000
RBP: 00007f20a86cfae9 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007fffaf5838df R14: 00007f209f7a4300 R15: 0000000000022000
INFO: task syz-executor.0:22170 blocked for more than 140 seconds.
Not tainted 4.19.211-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
syz-executor.0 D29472 22170 8160 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
__rwsem_down_read_failed_common kernel/locking/rwsem-xadd.c:292 [inline]
rwsem_down_read_failed+0x20a/0x390 kernel/locking/rwsem-xadd.c:309
call_rwsem_down_read_failed+0x14/0x30 arch/x86/lib/rwsem.S:94
__down_read arch/x86/include/asm/rwsem.h:83 [inline]
down_read+0x44/0x80 kernel/locking/rwsem.c:26
iterate_supers+0xdb/0x290 fs/super.c:631
ksys_sync+0x86/0x150 fs/sync.c:113
__ia32_sys_sync+0xa/0x10 fs/sync.c:124
do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293
entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x7f20a86740c9
Code: Bad RIP value.
RSP: 002b:00007f209f783168 EFLAGS: 00000246 ORIG_RAX: 00000000000000a2
RAX: ffffffffffffffda RBX: 00007f20a87941f0 RCX: 00007f20a86740c9
RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000000
RBP: 00007f20a86cfae9 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007fffaf5838df R14: 00007f209f783300 R15: 0000000000022000
INFO: task syz-executor.0:22186 blocked for more than 140 seconds.
Not tainted 4.19.211-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
syz-executor.0 D24968 22186 8160 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
__rwsem_down_read_failed_common kernel/locking/rwsem-xadd.c:292 [inline]
rwsem_down_read_failed+0x20a/0x390 kernel/locking/rwsem-xadd.c:309
call_rwsem_down_read_failed+0x14/0x30 arch/x86/lib/rwsem.S:94
__down_read arch/x86/include/asm/rwsem.h:83 [inline]
down_read+0x44/0x80 kernel/locking/rwsem.c:26
iterate_supers+0xdb/0x290 fs/super.c:631
ksys_sync+0x86/0x150 fs/sync.c:113
__ia32_sys_sync+0xa/0x10 fs/sync.c:124
do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293
entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x7f20a86740c9
Code: Bad RIP value.
RSP: 002b:00007f209f762168 EFLAGS: 00000246 ORIG_RAX: 00000000000000a2
RAX: ffffffffffffffda RBX: 00007f20a87942c0 RCX: 00007f20a86740c9
RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000000
RBP: 00007f20a86cfae9 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007fffaf5838df R14: 00007f209f762300 R15: 0000000000022000
INFO: task syz-executor.5:22063 blocked for more than 140 seconds.
Not tainted 4.19.211-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
syz-executor.5 D25368 22063 8178 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
__rwsem_down_read_failed_common kernel/locking/rwsem-xadd.c:292 [inline]
rwsem_down_read_failed+0x20a/0x390 kernel/locking/rwsem-xadd.c:309
call_rwsem_down_read_failed+0x14/0x30 arch/x86/lib/rwsem.S:94
__down_read arch/x86/include/asm/rwsem.h:83 [inline]
down_read+0x44/0x80 kernel/locking/rwsem.c:26
iterate_supers+0xdb/0x290 fs/super.c:631
ksys_sync+0x86/0x150 fs/sync.c:113
__ia32_sys_sync+0xa/0x10 fs/sync.c:124
do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293
entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x7fbfdb9d90c9
Code: Bad RIP value.
RSP: 002b:00007fbfd9f4b168 EFLAGS: 00000246 ORIG_RAX: 00000000000000a2
RAX: ffffffffffffffda RBX: 00007fbfdbaf8f80 RCX: 00007fbfdb9d90c9
RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000000
RBP: 00007fbfdba34ae9 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007ffc0174a3af R14: 00007fbfd9f4b300 R15: 0000000000022000
INFO: task syz-executor.5:22132 blocked for more than 140 seconds.
Not tainted 4.19.211-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
syz-executor.5 D26792 22132 8178 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
__rwsem_down_read_failed_common kernel/locking/rwsem-xadd.c:292 [inline]
rwsem_down_read_failed+0x20a/0x390 kernel/locking/rwsem-xadd.c:309
call_rwsem_down_read_failed+0x14/0x30 arch/x86/lib/rwsem.S:94
__down_read arch/x86/include/asm/rwsem.h:83 [inline]
down_read+0x44/0x80 kernel/locking/rwsem.c:26
iterate_supers+0xdb/0x290 fs/super.c:631
ksys_sync+0x86/0x150 fs/sync.c:113
__ia32_sys_sync+0xa/0x10 fs/sync.c:124
do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293
entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x7fbfdb9d90c9
Code: Bad RIP value.
RSP: 002b:00007fbfd2b2a168 EFLAGS: 00000246 ORIG_RAX: 00000000000000a2
RAX: ffffffffffffffda RBX: 00007fbfdbaf9050 RCX: 00007fbfdb9d90c9
RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000000
RBP: 00007fbfdba34ae9 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007ffc0174a3af R14: 00007fbfd2b2a300 R15: 0000000000022000
INFO: task syz-executor.5:22146 blocked for more than 140 seconds.
Not tainted 4.19.211-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
syz-executor.5 D29920 22146 8178 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
__rwsem_down_read_failed_common kernel/locking/rwsem-xadd.c:292 [inline]
rwsem_down_read_failed+0x20a/0x390 kernel/locking/rwsem-xadd.c:309
call_rwsem_down_read_failed+0x14/0x30 arch/x86/lib/rwsem.S:94
__down_read arch/x86/include/asm/rwsem.h:83 [inline]
down_read+0x44/0x80 kernel/locking/rwsem.c:26
iterate_supers+0xdb/0x290 fs/super.c:631
ksys_sync+0x86/0x150 fs/sync.c:113
__ia32_sys_sync+0xa/0x10 fs/sync.c:124
do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293
entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x7fbfdb9d90c9
Code: Bad RIP value.
RSP: 002b:00007fbfd2b09168 EFLAGS: 00000246 ORIG_RAX: 00000000000000a2
RAX: ffffffffffffffda RBX: 00007fbfdbaf9120 RCX: 00007fbfdb9d90c9
RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000000
RBP: 00007fbfdba34ae9 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007ffc0174a3af R14: 00007fbfd2b09300 R15: 0000000000022000
INFO: task syz-executor.5:22161 blocked for more than 140 seconds.
Not tainted 4.19.211-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
syz-executor.5 D29920 22161 8178 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
__rwsem_down_read_failed_common kernel/locking/rwsem-xadd.c:292 [inline]
rwsem_down_read_failed+0x20a/0x390 kernel/locking/rwsem-xadd.c:309
call_rwsem_down_read_failed+0x14/0x30 arch/x86/lib/rwsem.S:94
__down_read arch/x86/include/asm/rwsem.h:83 [inline]
down_read+0x44/0x80 kernel/locking/rwsem.c:26
iterate_supers+0xdb/0x290 fs/super.c:631
ksys_sync+0x86/0x150 fs/sync.c:113
__ia32_sys_sync+0xa/0x10 fs/sync.c:124
do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293
entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x7fbfdb9d90c9
Code: Bad RIP value.
RSP: 002b:00007fbfd2ae8168 EFLAGS: 00000246 ORIG_RAX: 00000000000000a2
RAX: ffffffffffffffda RBX: 00007fbfdbaf91f0 RCX: 00007fbfdb9d90c9
RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000000
RBP: 00007fbfdba34ae9 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007ffc0174a3af R14: 00007fbfd2ae8300 R15: 0000000000022000

Showing all locks held in the system:
1 lock held by khungtaskd/1569:
#0: 00000000d68ea3e5 (rcu_read_lock){....}, at: debug_show_all_locks+0x53/0x265 kernel/locking/lockdep.c:4441
1 lock held by in:imklog/7840:
#0: 00000000663bf1c8 (&f->f_pos_lock){+.+.}, at: __fdget_pos+0x26f/0x310 fs/file.c:767
2 locks held by kworker/u4:0/8232:
#0: 0000000015162c1f ((wq_completion)"writeback"){+.+.}, at: process_one_work+0x767/0x1570 kernel/workqueue.c:2124
#1: 0000000080d2711d ((work_completion)(&(&wb->dwork)->work)){+.+.}, at: process_one_work+0x79c/0x1570 kernel/workqueue.c:2128
1 lock held by syz-executor.0/22029:
#0: 00000000b6f4652a (&type->s_umount_key#77){++++}, at: iterate_supers+0xdb/0x290 fs/super.c:631
1 lock held by syz-executor.0/22151:
#0: 00000000b6f4652a (&type->s_umount_key#77){++++}, at: iterate_supers+0xdb/0x290 fs/super.c:631
1 lock held by syz-executor.0/22163:
#0: 00000000b6f4652a (&type->s_umount_key#77){++++}, at: iterate_supers+0xdb/0x290 fs/super.c:631
1 lock held by syz-executor.0/22170:
#0: 00000000b6f4652a (&type->s_umount_key#77){++++}, at: iterate_supers+0xdb/0x290 fs/super.c:631
1 lock held by syz-executor.0/22186:
#0: 00000000b6f4652a (&type->s_umount_key#77){++++}, at: iterate_supers+0xdb/0x290 fs/super.c:631
1 lock held by syz-executor.5/22063:
#0: 00000000b6f4652a (&type->s_umount_key#77){++++}, at: iterate_supers+0xdb/0x290 fs/super.c:631
1 lock held by syz-executor.5/22132:
#0: 00000000b6f4652a (&type->s_umount_key#77){++++}, at: iterate_supers+0xdb/0x290 fs/super.c:631
1 lock held by syz-executor.5/22146:
#0: 00000000b6f4652a (&type->s_umount_key#77){++++}, at: iterate_supers+0xdb/0x290 fs/super.c:631
1 lock held by syz-executor.5/22161:
#0: 00000000b6f4652a (&type->s_umount_key#77){++++}, at: iterate_supers+0xdb/0x290 fs/super.c:631
1 lock held by syz-executor.5/22169:
#0: 00000000b6f4652a (&type->s_umount_key#77){++++}, at: iterate_supers+0xdb/0x290 fs/super.c:631
4 locks held by syz-executor.2/22077:
#0: 0000000033c87883 (&type->s_umount_key#58/1){+.+.}, at: alloc_super fs/super.c:226 [inline]
#0: 0000000033c87883 (&type->s_umount_key#58/1){+.+.}, at: sget_userns+0x20b/0xcd0 fs/super.c:519
#1: 00000000497a2e5c (sb_writers#25){.+.+}, at: sb_start_write include/linux/fs.h:1579 [inline]
#1: 00000000497a2e5c (sb_writers#25){.+.+}, at: mnt_want_write+0x3a/0xb0 fs/namespace.c:360
#2: 000000005ee99433 (&type->i_mutex_dir_key#13){++++}, at: inode_lock include/linux/fs.h:748 [inline]
#2: 000000005ee99433 (&type->i_mutex_dir_key#13){++++}, at: vfs_removexattr+0xb2/0x240 fs/xattr.c:465
#3: 000000002dc7879a (&type->i_mutex_dir_key#13/3){+.+.}, at: inode_lock_nested include/linux/fs.h:783 [inline]
#3: 000000002dc7879a (&type->i_mutex_dir_key#13/3){+.+.}, at: lookup_and_delete_xattr fs/reiserfs/xattr.c:484 [inline]
#3: 000000002dc7879a (&type->i_mutex_dir_key#13/3){+.+.}, at: reiserfs_xattr_set_handle+0x7fd/0xb40 fs/reiserfs/xattr.c:527
2 locks held by syz-executor.2/22104:
#0: 00000000b6f4652a (&type->s_umount_key#77){++++}, at: do_remount fs/namespace.c:2307 [inline]
#0: 00000000b6f4652a (&type->s_umount_key#77){++++}, at: do_mount+0xa5b/0x2f50 fs/namespace.c:2813
#1: 00000000f71ffbfd (&bdi->wb_switch_rwsem){+.+.}, at: bdi_down_write_wb_switch_rwsem fs/fs-writeback.c:338 [inline]
#1: 00000000f71ffbfd (&bdi->wb_switch_rwsem){+.+.}, at: sync_inodes_sb+0x180/0x9a0 fs/fs-writeback.c:2457
1 lock held by syz-executor.5/23792:
#0: 00000000b6f4652a (&type->s_umount_key#77){++++}, at: iterate_supers+0xdb/0x290 fs/super.c:631
1 lock held by syz-executor.5/23803:
#0: 00000000b6f4652a (&type->s_umount_key#77){++++}, at: iterate_supers+0xdb/0x290 fs/super.c:631
1 lock held by syz-executor.5/23808:
#0: 00000000b6f4652a (&type->s_umount_key#77){++++}, at: iterate_supers+0xdb/0x290 fs/super.c:631
1 lock held by syz-executor.5/23812:
#0: 00000000b6f4652a (&type->s_umount_key#77){++++}, at: iterate_supers+0xdb/0x290 fs/super.c:631
1 lock held by syz-executor.5/23823:
#0: 00000000b6f4652a (&type->s_umount_key#77){++++}, at: iterate_supers+0xdb/0x290 fs/super.c:631
1 lock held by syz-executor.5/23826:
#0: 00000000b6f4652a (&type->s_umount_key#77){++++}, at: iterate_supers+0xdb/0x290 fs/super.c:631
1 lock held by syz-executor.5/24178:
#0: 00000000b6f4652a (&type->s_umount_key#77){++++}, at: iterate_supers+0xdb/0x290 fs/super.c:631
1 lock held by syz-executor.5/24181:
#0: 00000000b6f4652a (&type->s_umount_key#77){++++}, at: iterate_supers+0xdb/0x290 fs/super.c:631
1 lock held by syz-executor.5/24182:
#0: 00000000b6f4652a (&type->s_umount_key#77){++++}, at: iterate_supers+0xdb/0x290 fs/super.c:631
1 lock held by syz-executor.5/24183:
#0: 00000000b6f4652a (&type->s_umount_key#77){++++}, at: iterate_supers+0xdb/0x290 fs/super.c:631
1 lock held by syz-executor.5/24184:
#0: 00000000b6f4652a (&type->s_umount_key#77){++++}, at: iterate_supers+0xdb/0x290 fs/super.c:631
1 lock held by syz-executor.5/24187:
#0: 00000000b6f4652a (&type->s_umount_key#77){++++}, at: iterate_supers+0xdb/0x290 fs/super.c:631

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

NMI backtrace for cpu 1
CPU: 1 PID: 1569 Comm: khungtaskd Not tainted 4.19.211-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 10/26/2022
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 skipped: idling at native_safe_halt+0xe/0x10 arch/x86/include/asm/irqflags.h:60


---
This report is generated by a bot. It may contain errors.
See https://goo.gl/tpsmEJ for more information about syzbot.
syzbot engineers can be reached at syzk...@googlegroups.com.

syzbot will keep track of this issue. See:
https://goo.gl/tpsmEJ#status for how to communicate with syzbot.

syzbot

unread,
Feb 2, 2023, 3:08:39 PM2/2/23
to syzkaller...@googlegroups.com
syzbot has found a reproducer for the following issue on:

HEAD commit: 3f8a27f9e27b Linux 4.19.211
git tree: linux-4.19.y
console output: https://syzkaller.appspot.com/x/log.txt?x=16bdc073480000
kernel config: https://syzkaller.appspot.com/x/.config?x=9b9277b418617afe
dashboard link: https://syzkaller.appspot.com/bug?extid=c360748f8febb365d65e
compiler: gcc version 10.2.1 20210110 (Debian 10.2.1-6)
syz repro: https://syzkaller.appspot.com/x/repro.syz?x=134e7231480000
C reproducer: https://syzkaller.appspot.com/x/repro.c?x=14d461c3480000
mounted in repro: https://storage.googleapis.com/syzbot-assets/2d0cf328a82b/mount_0.gz

IMPORTANT: if you fix the issue, please add the following tag to the commit:
Reported-by: syzbot+c36074...@syzkaller.appspotmail.com

REISERFS (device loop5): checking transaction log (loop5)
REISERFS (device loop2): using ordered data mode
REISERFS (device loop3): using ordered data mode
reiserfs: using flush barriers
reiserfs: using flush barriers
INFO: task kworker/u4:2:8162 blocked for more than 140 seconds.
REISERFS (device loop5): Using r5 hash to sort names
reiserfs: using flush barriers
Not tainted 4.19.211-syzkaller #0
REISERFS warning (device loop5): jdm-13090 reiserfs_new_inode: ACLs aren't enabled in the fs, but vfs thinks they are!
REISERFS (device loop2): journal params: device loop2, size 512, journal first block 18, max trans len 256, max batch 225, max commit age 30, max trans age 30
REISERFS (device loop3): journal params: device loop3, size 512, journal first block 18, max trans len 256, max batch 225, max commit age 30, max trans age 30
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
REISERFS (device loop0): journal params: device loop0, size 512, journal first block 18, max trans len 256, max batch 225, max commit age 30, max trans age 30
kworker/u4:2 D27504 8162 2 0x80000000
REISERFS (device loop5): Created .reiserfs_priv - reserved for xattr storage.
REISERFS (device loop2): checking transaction log (loop2)
REISERFS (device loop0): checking transaction log (loop0)
REISERFS (device loop3): checking transaction log (loop3)
overlayfs: upper fs needs to support d_type.
REISERFS (device loop2): Using r5 hash to sort names
REISERFS (device loop0): Using r5 hash to sort names
REISERFS (device loop3): Using r5 hash to sort names
overlayfs: upper fs does not support tmpfile.
Workqueue: writeback wb_workfn (flush-7:1)
REISERFS warning (device loop0): jdm-13090 reiserfs_new_inode: ACLs aren't enabled in the fs, but vfs thinks they are!
REISERFS warning (device loop2): jdm-13090 reiserfs_new_inode: ACLs aren't enabled in the fs, but vfs thinks they are!
overlayfs: upper fs does not support file handles, falling back to index=off.
Call Trace:
REISERFS warning (device loop5): super-6502 reiserfs_getopt: unknown mount option "��<<�G4��mR���� u����0� �w�2���� �����"
REISERFS warning (device loop3): jdm-13090 reiserfs_new_inode: ACLs aren't enabled in the fs, but vfs thinks they are!
REISERFS (device loop0): Created .reiserfs_priv - reserved for xattr storage.
context_switch kernel/sched/core.c:2828 [inline]
__schedule+0x887/0x2040 kernel/sched/core.c:3517
overlayfs: failed to resolve './file0': -2
REISERFS (device loop2): Created .reiserfs_priv - reserved for xattr storage.
REISERFS (device loop3): Created .reiserfs_priv - reserved for xattr storage.
overlayfs: upper fs needs to support d_type.
overlayfs: upper fs does not support tmpfile.
schedule+0x8d/0x1b0 kernel/sched/core.c:3561
overlayfs: upper fs needs to support d_type.
overlayfs: upper fs does not support tmpfile.
overlayfs: upper fs needs to support d_type.
overlayfs: upper fs does not support file handles, falling back to index=off.
queue_log_writer+0x27a/0x2d0 fs/reiserfs/journal.c:2990
REISERFS warning (device loop0): super-6502 reiserfs_getopt: unknown mount option "��<<�G4��mR���� u����0� �w�2���� �����"
overlayfs: upper fs does not support tmpfile.
overlayfs: upper fs does not support file handles, falling back to index=off.
REISERFS warning (device loop3): super-6502 reiserfs_getopt: unknown mount option "��<<�G4��mR���� u����0� �w�2���� �����"
REISERFS warning (device loop2): super-6502 reiserfs_getopt: unknown mount option "��<<�G4��mR���� u����0� �w�2���� �����"
overlayfs: failed to resolve './file0': -2
overlayfs: failed to resolve './file0': -2
check_journal_end fs/reiserfs/journal.c:3687 [inline]
do_journal_end+0x8c0/0x4840 fs/reiserfs/journal.c:4054
overlayfs: upper fs does not support file handles, falling back to index=off.
reiserfs_write_inode+0x27a/0x2d0 fs/reiserfs/inode.c:1789
overlayfs: failed to resolve './file0': -2
write_inode fs/fs-writeback.c:1244 [inline]
__writeback_single_inode+0x733/0x11d0 fs/fs-writeback.c:1442
writeback_sb_inodes+0x537/0xef0 fs/fs-writeback.c:1647
wb_writeback+0x28d/0xcc0 fs/fs-writeback.c:1820
wb_do_writeback fs/fs-writeback.c:1965 [inline]
wb_workfn+0x29b/0x1250 fs/fs-writeback.c:2006
process_one_work+0x864/0x1570 kernel/workqueue.c:2153
worker_thread+0x64c/0x1130 kernel/workqueue.c:2296
kthread+0x33f/0x460 kernel/kthread.c:259
ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:415
INFO: task syz-executor416:11822 blocked for more than 140 seconds.
Not tainted 4.19.211-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
syz-executor416 D25336 11822 8102 0x00000006
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
bit_wait+0x12/0x90 kernel/sched/wait_bit.c:197
__wait_on_bit+0x7e/0x150 kernel/sched/wait_bit.c:48
__inode_wait_for_writeback+0x153/0x1f0 fs/fs-writeback.c:1265
inode_wait_for_writeback+0x22/0x30 fs/fs-writeback.c:1277
evict+0x2b7/0x760 fs/inode.c:556
iput_final fs/inode.c:1555 [inline]
iput+0x4f1/0x860 fs/inode.c:1581
dentry_unlink_inode+0x265/0x320 fs/dcache.c:374
d_delete+0x210/0x280 fs/dcache.c:2372
xattr_unlink+0x139/0x190 fs/reiserfs/xattr.c:96
lookup_and_delete_xattr fs/reiserfs/xattr.c:492 [inline]
reiserfs_xattr_set_handle+0x88e/0xb40 fs/reiserfs/xattr.c:527
reiserfs_xattr_set+0x411/0x570 fs/reiserfs/xattr.c:631
trusted_set+0xa6/0xd0 fs/reiserfs/xattr_trusted.c:30
__vfs_removexattr+0xf3/0x160 fs/xattr.c:413
__vfs_removexattr_locked+0x15c/0x340 fs/xattr.c:445
vfs_removexattr+0xc1/0x240 fs/xattr.c:466
ovl_make_workdir fs/overlayfs/super.c:1139 [inline]
ovl_get_workdir fs/overlayfs/super.c:1198 [inline]
ovl_fill_super+0x13f9/0x3f10 fs/overlayfs/super.c:1601
mount_nodev+0x60/0x110 fs/super.c:1204
mount_fs+0xa3/0x310 fs/super.c:1261
vfs_kern_mount.part.0+0x68/0x470 fs/namespace.c:961
vfs_kern_mount fs/namespace.c:951 [inline]
do_new_mount fs/namespace.c:2492 [inline]
do_mount+0x115c/0x2f50 fs/namespace.c:2822
REISERFS (device loop5): found reiserfs format "3.6" with non-standard journal
REISERFS (device loop5): using ordered data mode
reiserfs: using flush barriers
ksys_mount+0xcf/0x130 fs/namespace.c:3038
REISERFS (device loop0): found reiserfs format "3.6" with non-standard journal
REISERFS (device loop5): journal params: device loop5, size 512, journal first block 18, max trans len 256, max batch 225, max commit age 30, max trans age 30
REISERFS (device loop0): using ordered data mode
__do_sys_mount fs/namespace.c:3052 [inline]
__se_sys_mount fs/namespace.c:3049 [inline]
__x64_sys_mount+0xba/0x150 fs/namespace.c:3049
reiserfs: using flush barriers
do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293
entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x7f11b26682d9
Code: Bad RIP value.
RSP: 002b:00007f11b2613208 EFLAGS: 00000246 ORIG_RAX: 00000000000000a5
REISERFS (device loop0): journal params: device loop0, size 512, journal first block 18, max trans len 256, max batch 225, max commit age 30, max trans age 30
RAX: ffffffffffffffda RBX: 00007f11b26ee788 RCX: 00007f11b26682d9
REISERFS (device loop5): checking transaction log (loop5)
REISERFS (device loop2): found reiserfs format "3.6" with non-standard journal
REISERFS (device loop0): checking transaction log (loop0)
RDX: 0000000020000080 RSI: 00000000200000c0 RDI: 0000000000000000
REISERFS (device loop2): using ordered data mode
RBP: 00007f11b26ee780 R08: 0000000020000480 R09: 0000000000000000
reiserfs: using flush barriers
REISERFS (device loop0): Using r5 hash to sort names
REISERFS (device loop3): found reiserfs format "3.6" with non-standard journal
REISERFS warning (device loop0): jdm-13090 reiserfs_new_inode: ACLs aren't enabled in the fs, but vfs thinks they are!
REISERFS (device loop2): journal params: device loop2, size 512, journal first block 18, max trans len 256, max batch 225, max commit age 30, max trans age 30
R10: 0000000000000000 R11: 0000000000000246 R12: 00007f11b26ee78c
REISERFS (device loop5): Using r5 hash to sort names
REISERFS (device loop0): Created .reiserfs_priv - reserved for xattr storage.
REISERFS (device loop3): using ordered data mode
R13: 00007fff40e8cbdf R14: 00007f11b2613300 R15: 0000000000022000
REISERFS warning (device loop5): jdm-13090 reiserfs_new_inode: ACLs aren't enabled in the fs, but vfs thinks they are!
INFO: task syz-executor416:11862 blocked for more than 140 seconds.
reiserfs: using flush barriers
REISERFS (device loop2): checking transaction log (loop2)
overlayfs: upper fs needs to support d_type.
REISERFS (device loop5): Created .reiserfs_priv - reserved for xattr storage.
overlayfs: upper fs does not support tmpfile.
Not tainted 4.19.211-syzkaller #0
overlayfs: upper fs does not support file handles, falling back to index=off.
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
overlayfs: failed to resolve './file0': -2
syz-executor416 D27728 11862 8102 0x00000004
REISERFS (device loop3): journal params: device loop3, size 512, journal first block 18, max trans len 256, max batch 225, max commit age 30, max trans age 30
Call Trace:
context_switch kernel/sched/core.c:2828 [inline]
__schedule+0x887/0x2040 kernel/sched/core.c:3517
REISERFS (device loop2): Using r5 hash to sort names
REISERFS warning (device loop0): super-6502 reiserfs_getopt: unknown mount option "��<<�G4��mR���� u����0� �w�2���� �����"
REISERFS warning (device loop2): jdm-13090 reiserfs_new_inode: ACLs aren't enabled in the fs, but vfs thinks they are!
overlayfs: upper fs needs to support d_type.
overlayfs: upper fs does not support tmpfile.
overlayfs: upper fs does not support file handles, falling back to index=off.
schedule+0x8d/0x1b0 kernel/sched/core.c:3561
REISERFS (device loop3): checking transaction log (loop3)
wb_wait_for_completion+0x175/0x1f0 fs/fs-writeback.c:222
overlayfs: failed to resolve './file0': -2
REISERFS (device loop2): Created .reiserfs_priv - reserved for xattr storage.
REISERFS (device loop3): Using r5 hash to sort names
REISERFS warning (device loop5): super-6502 reiserfs_getopt: unknown mount option "��<<�G4��mR���� u����0� �w�2���� �����"
REISERFS warning (device loop3): jdm-13090 reiserfs_new_inode: ACLs aren't enabled in the fs, but vfs thinks they are!
overlayfs: upper fs needs to support d_type.
sync_inodes_sb+0x19d/0x9a0 fs/fs-writeback.c:2459
overlayfs: upper fs does not support tmpfile.
REISERFS (device loop3): Created .reiserfs_priv - reserved for xattr storage.
overlayfs: upper fs does not support file handles, falling back to index=off.
overlayfs: failed to resolve './file0': -2
__sync_filesystem fs/sync.c:34 [inline]
sync_filesystem+0x15c/0x250 fs/sync.c:67
reiserfs_remount+0x150/0x1540 fs/reiserfs/super.c:1458
REISERFS warning (device loop2): super-6502 reiserfs_getopt: unknown mount option "��<<�G4��mR���� u����0� �w�2���� �����"
overlayfs: upper fs needs to support d_type.
do_remount_sb+0x1a0/0x6a0 fs/super.c:888
overlayfs: upper fs does not support tmpfile.
overlayfs: upper fs does not support file handles, falling back to index=off.
do_remount fs/namespace.c:2313 [inline]
do_mount+0x1a62/0x2f50 fs/namespace.c:2813
REISERFS warning (device loop3): super-6502 reiserfs_getopt: unknown mount option "��<<�G4��mR���� u����0� �w�2���� �����"
overlayfs: failed to resolve './file0': -2
ksys_mount+0xcf/0x130 fs/namespace.c:3038
__do_sys_mount fs/namespace.c:3052 [inline]
__se_sys_mount fs/namespace.c:3049 [inline]
__x64_sys_mount+0xba/0x150 fs/namespace.c:3049
do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293
entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x7f11b266979a
Code: 48 c7 c2 b8 ff ff ff f7 d8 64 89 02 b8 ff ff ff ff eb d2 e8 a8 00 00 00 0f 1f 84 00 00 00 00 00 49 89 ca b8 a5 00 00 00 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 c7 c1 b8 ff ff ff f7 d8 64 89 01 48
RSP: 002b:00007f11aa5f2038 EFLAGS: 00000286 ORIG_RAX: 00000000000000a5
RAX: ffffffffffffffda RBX: 00007f11aa5f26b8 RCX: 00007f11b266979a
RDX: 00000000200000c0 RSI: 0000000020000100 RDI: 0000000000000000
RBP: 00000000ffffffff R08: 00007f11aa5f20d0 R09: 0000000020000000
R10: 0000000001a484bc R11: 0000000000000286 R12: 0000000020000100
R13: 00000000200000c0 R14: 0000000000000000 R15: 00000000200009c0
INFO: task kworker/u4:4:12087 blocked for more than 140 seconds.
Not tainted 4.19.211-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
kworker/u4:4 D26600 12087 2 0x80000000
Workqueue: writeback wb_workfn (flush-7:4)
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
queue_log_writer+0x27a/0x2d0 fs/reiserfs/journal.c:2990
do_journal_begin_r+0x97b/0x10b0 fs/reiserfs/journal.c:3113
journal_begin+0x162/0x400 fs/reiserfs/journal.c:3265
reiserfs_write_inode+0x1f0/0x2d0 fs/reiserfs/inode.c:1787
write_inode fs/fs-writeback.c:1244 [inline]
__writeback_single_inode+0x733/0x11d0 fs/fs-writeback.c:1442
writeback_sb_inodes+0x537/0xef0 fs/fs-writeback.c:1647
wb_writeback+0x28d/0xcc0 fs/fs-writeback.c:1820
wb_do_writeback fs/fs-writeback.c:1965 [inline]
wb_workfn+0x29b/0x1250 fs/fs-writeback.c:2006
process_one_work+0x864/0x1570 kernel/workqueue.c:2153
worker_thread+0x64c/0x1130 kernel/workqueue.c:2296
kthread+0x33f/0x460 kernel/kthread.c:259
ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:415
INFO: task syz-executor416:13775 blocked for more than 140 seconds.
Not tainted 4.19.211-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
syz-executor416 D25336 13775 8105 0x00000006
Call Trace:
context_switch kernel/sched/core.c:2828 [inline]
__schedule+0x887/0x2040 kernel/sched/core.c:3517
REISERFS (device loop3): found reiserfs format "3.6" with non-standard journal
REISERFS (device loop5): found reiserfs format "3.6" with non-standard journal
REISERFS (device loop5): using ordered data mode
schedule+0x8d/0x1b0 kernel/sched/core.c:3561
REISERFS (device loop2): found reiserfs format "3.6" with non-standard journal
REISERFS (device loop3): using ordered data mode
bit_wait+0x12/0x90 kernel/sched/wait_bit.c:197
reiserfs: using flush barriers
__wait_on_bit+0x7e/0x150 kernel/sched/wait_bit.c:48
reiserfs: using flush barriers
REISERFS (device loop2): using ordered data mode
REISERFS (device loop5): journal params: device loop5, size 512, journal first block 18, max trans len 256, max batch 225, max commit age 30, max trans age 30
REISERFS (device loop3): journal params: device loop3, size 512, journal first block 18, max trans len 256, max batch 225, max commit age 30, max trans age 30
REISERFS (device loop3): checking transaction log (loop3)
reiserfs: using flush barriers
REISERFS (device loop3): Using r5 hash to sort names
REISERFS warning (device loop3): jdm-13090 reiserfs_new_inode: ACLs aren't enabled in the fs, but vfs thinks they are!
REISERFS (device loop0): found reiserfs format "3.6" with non-standard journal
REISERFS (device loop3): Created .reiserfs_priv - reserved for xattr storage.
REISERFS (device loop5): checking transaction log (loop5)
overlayfs: upper fs needs to support d_type.
overlayfs: upper fs does not support tmpfile.
REISERFS (device loop2): journal params: device loop2, size 512, journal first block 18, max trans len 256, max batch 225, max commit age 30, max trans age 30
overlayfs: upper fs does not support file handles, falling back to index=off.
__inode_wait_for_writeback+0x153/0x1f0 fs/fs-writeback.c:1265
overlayfs: failed to resolve './file0': -2
REISERFS (device loop0): using ordered data mode
reiserfs: using flush barriers
REISERFS warning (device loop3): super-6502 reiserfs_getopt: unknown mount option "��<<�G4��mR���� u����0� �w�2���� �����"
REISERFS (device loop0): journal params: device loop0, size 512, journal first block 18, max trans len 256, max batch 225, max commit age 30, max trans age 30
REISERFS (device loop5): Using r5 hash to sort names
REISERFS warning (device loop5): jdm-13090 reiserfs_new_inode: ACLs aren't enabled in the fs, but vfs thinks they are!
REISERFS (device loop2): checking transaction log (loop2)
inode_wait_for_writeback+0x22/0x30 fs/fs-writeback.c:1277
evict+0x2b7/0x760 fs/inode.c:556
REISERFS (device loop5): Created .reiserfs_priv - reserved for xattr storage.
REISERFS (device loop0): checking transaction log (loop0)
iput_final fs/inode.c:1555 [inline]
iput+0x4f1/0x860 fs/inode.c:1581
REISERFS (device loop0): Using r5 hash to sort names
dentry_unlink_inode+0x265/0x320 fs/dcache.c:374
REISERFS (device loop2): Using r5 hash to sort names
d_delete+0x210/0x280 fs/dcache.c:2372
REISERFS warning (device loop2): jdm-13090 reiserfs_new_inode: ACLs aren't enabled in the fs, but vfs thinks they are!
REISERFS warning (device loop0): jdm-13090 reiserfs_new_inode: ACLs aren't enabled in the fs, but vfs thinks they are!
REISERFS (device loop2): Created .reiserfs_priv - reserved for xattr storage.
xattr_unlink+0x139/0x190 fs/reiserfs/xattr.c:96
overlayfs: upper fs needs to support d_type.
overlayfs: upper fs does not support tmpfile.
REISERFS (device loop0): Created .reiserfs_priv - reserved for xattr storage.
overlayfs: upper fs needs to support d_type.
overlayfs: upper fs does not support file handles, falling back to index=off.
overlayfs: upper fs does not support tmpfile.
lookup_and_delete_xattr fs/reiserfs/xattr.c:492 [inline]
reiserfs_xattr_set_handle+0x88e/0xb40 fs/reiserfs/xattr.c:527
overlayfs: upper fs needs to support d_type.
overlayfs: upper fs does not support tmpfile.
REISERFS warning (device loop5): super-6502 reiserfs_getopt: unknown mount option "��<<�G4��mR���� u����0� �w�2���� �����"
overlayfs: upper fs does not support file handles, falling back to index=off.
REISERFS warning (device loop2): super-6502 reiserfs_getopt: unknown mount option "��<<�G4��mR���� u����0� �w�2���� �����"
overlayfs: upper fs does not support file handles, falling back to index=off.
overlayfs: failed to resolve './file0': -2
REISERFS warning (device loop0): super-6502 reiserfs_getopt: unknown mount option "��<<�G4��mR���� u����0� �w�2���� �����"
overlayfs: failed to resolve './file0': -2
reiserfs_xattr_set+0x411/0x570 fs/reiserfs/xattr.c:631
overlayfs: failed to resolve './file0': -2
trusted_set+0xa6/0xd0 fs/reiserfs/xattr_trusted.c:30
__vfs_removexattr+0xf3/0x160 fs/xattr.c:413
__vfs_removexattr_locked+0x15c/0x340 fs/xattr.c:445
vfs_removexattr+0xc1/0x240 fs/xattr.c:466
ovl_make_workdir fs/overlayfs/super.c:1139 [inline]
ovl_get_workdir fs/overlayfs/super.c:1198 [inline]
ovl_fill_super+0x13f9/0x3f10 fs/overlayfs/super.c:1601
mount_nodev+0x60/0x110 fs/super.c:1204
mount_fs+0xa3/0x310 fs/super.c:1261
vfs_kern_mount.part.0+0x68/0x470 fs/namespace.c:961
vfs_kern_mount fs/namespace.c:951 [inline]
do_new_mount fs/namespace.c:2492 [inline]
do_mount+0x115c/0x2f50 fs/namespace.c:2822
ksys_mount+0xcf/0x130 fs/namespace.c:3038
__do_sys_mount fs/namespace.c:3052 [inline]
__se_sys_mount fs/namespace.c:3049 [inline]
__x64_sys_mount+0xba/0x150 fs/namespace.c:3049
do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293
entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x7f11b26682d9
Code: Bad RIP value.
RSP: 002b:00007f11b2613208 EFLAGS: 00000246 ORIG_RAX: 00000000000000a5
RAX: ffffffffffffffda RBX: 00007f11b26ee788 RCX: 00007f11b26682d9
RDX: 0000000020000080 RSI: 00000000200000c0 RDI: 0000000000000000
RBP: 00007f11b26ee780 R08: 0000000020000480 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 00007f11b26ee78c
R13: 00007fff40e8cbdf R14: 00007f11b2613300 R15: 0000000000022000
INFO: task syz-executor416:13810 blocked for more than 140 seconds.
Not tainted 4.19.211-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
syz-executor416 D29128 13810 8105 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
wb_wait_for_completion+0x175/0x1f0 fs/fs-writeback.c:222
sync_inodes_sb+0x19d/0x9a0 fs/fs-writeback.c:2459
__sync_filesystem fs/sync.c:34 [inline]
sync_filesystem+0x15c/0x250 fs/sync.c:67
reiserfs_remount+0x150/0x1540 fs/reiserfs/super.c:1458
do_remount_sb+0x1a0/0x6a0 fs/super.c:888
do_remount fs/namespace.c:2313 [inline]
do_mount+0x1a62/0x2f50 fs/namespace.c:2813
ksys_mount+0xcf/0x130 fs/namespace.c:3038
__do_sys_mount fs/namespace.c:3052 [inline]
__se_sys_mount fs/namespace.c:3049 [inline]
__x64_sys_mount+0xba/0x150 fs/namespace.c:3049
do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293
entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x7f11b266979a
REISERFS (device loop0): found reiserfs format "3.6" with non-standard journal
Code: Bad RIP value.
RSP: 002b:00007f11aa5f2038 EFLAGS: 00000286 ORIG_RAX: 00000000000000a5
REISERFS (device loop2): found reiserfs format "3.6" with non-standard journal
REISERFS (device loop0): using ordered data mode
REISERFS (device loop2): using ordered data mode
REISERFS (device loop5): found reiserfs format "3.6" with non-standard journal
RAX: ffffffffffffffda RBX: 00007f11aa5f26b8 RCX: 00007f11b266979a
REISERFS (device loop3): found reiserfs format "3.6" with non-standard journal
reiserfs: using flush barriers
REISERFS (device loop5): using ordered data mode
reiserfs: using flush barriers
reiserfs: using flush barriers
REISERFS (device loop3): using ordered data mode
REISERFS (device loop0): journal params: device loop0, size 512, journal first block 18, max trans len 256, max batch 225, max commit age 30, max trans age 30
REISERFS (device loop5): journal params: device loop5, size 512, journal first block 18, max trans len 256, max batch 225, max commit age 30, max trans age 30
RDX: 00000000200000c0 RSI: 0000000020000100 RDI: 0000000000000000
reiserfs: using flush barriers
REISERFS (device loop2): journal params: device loop2, size 512, journal first block 18, max trans len 256, max batch 225, max commit age 30, max trans age 30
REISERFS (device loop3): journal params: device loop3, size 512, journal first block 18, max trans len 256, max batch 225, max commit age 30, max trans age 30
REISERFS (device loop0): checking transaction log (loop0)
RBP: 00000000ffffffff R08: 00007f11aa5f20d0 R09: 0000000020000000
R10: 0000000001a484bc R11: 0000000000000286 R12: 0000000020000100
REISERFS (device loop5): checking transaction log (loop5)
R13: 00000000200000c0 R14: 0000000000000000 R15: 00000000200009c0
REISERFS (device loop3): checking transaction log (loop3)
REISERFS (device loop2): checking transaction log (loop2)
REISERFS (device loop3): Using r5 hash to sort names

Showing all locks held in the system:
REISERFS (device loop5): Using r5 hash to sort names
REISERFS warning (device loop3): jdm-13090 reiserfs_new_inode: ACLs aren't enabled in the fs, but vfs thinks they are!
1 lock held by khungtaskd/1570:
REISERFS (device loop0): Using r5 hash to sort names
REISERFS warning (device loop5): jdm-13090 reiserfs_new_inode: ACLs aren't enabled in the fs, but vfs thinks they are!
REISERFS warning (device loop0): jdm-13090 reiserfs_new_inode: ACLs aren't enabled in the fs, but vfs thinks they are!
REISERFS (device loop3): Created .reiserfs_priv - reserved for xattr storage.
#0: 000000001a1f4388 (rcu_read_lock){....}, at: debug_show_all_locks+0x53/0x265 kernel/locking/lockdep.c:4441
REISERFS (device loop5): Created .reiserfs_priv - reserved for xattr storage.
REISERFS (device loop2): Using r5 hash to sort names
REISERFS warning (device loop2): jdm-13090 reiserfs_new_inode: ACLs aren't enabled in the fs, but vfs thinks they are!
1 lock held by in:imklog/7824:
overlayfs: upper fs needs to support d_type.
2 locks held by kworker/u4:2/8162:
overlayfs: upper fs does not support tmpfile.
REISERFS (device loop0): Created .reiserfs_priv - reserved for xattr storage.
overlayfs: upper fs needs to support d_type.
REISERFS (device loop2): Created .reiserfs_priv - reserved for xattr storage.
overlayfs: upper fs does not support file handles, falling back to index=off.
overlayfs: upper fs does not support tmpfile.
#0: 00000000f8f8318b ((wq_completion)"writeback"){+.+.}, at: process_one_work+0x767/0x1570 kernel/workqueue.c:2124
overlayfs: upper fs does not support file handles, falling back to index=off.
REISERFS warning (device loop5): super-6502 reiserfs_getopt: unknown mount option "��<<�G4��mR���� u����0� �w�2���� �����"
#1: 000000005b7a0496 ((work_completion)(&(&wb->dwork)->work)){+.+.}, at: process_one_work+0x79c/0x1570 kernel/workqueue.c:2128
overlayfs: upper fs needs to support d_type.
overlayfs: upper fs needs to support d_type.
overlayfs: upper fs does not support tmpfile.
overlayfs: upper fs does not support tmpfile.
overlayfs: upper fs does not support file handles, falling back to index=off.
overlayfs: failed to resolve './file0': -2
REISERFS warning (device loop3): super-6502 reiserfs_getopt: unknown mount option "��<<�G4��mR���� u����0� �w�2���� �����"
REISERFS warning (device loop0): super-6502 reiserfs_getopt: unknown mount option "��<<�G4��mR���� u����0� �w�2���� �����"
overlayfs: upper fs does not support file handles, falling back to index=off.
overlayfs: failed to resolve './file0': -2
REISERFS warning (device loop2): super-6502 reiserfs_getopt: unknown mount option "��<<�G4��mR���� u����0� �w�2���� �����"
4 locks held by syz-executor416/11822:
#0: 000000009a2ed322 (&type->s_umount_key#46/1){+.+.}, at: alloc_super fs/super.c:226 [inline]
#0: 000000009a2ed322 (&type->s_umount_key#46/1){+.+.}, at: sget_userns+0x20b/0xcd0 fs/super.c:519
overlayfs: failed to resolve './file0': -2
#1: 00000000be347a4e (sb_writers#11){.+.+}, at: sb_start_write include/linux/fs.h:1579 [inline]
#1: 00000000be347a4e (sb_writers#11){.+.+}, at: mnt_want_write+0x3a/0xb0 fs/namespace.c:360
overlayfs: failed to resolve './file0': -2
#2: 00000000c7cf14cb (&type->i_mutex_dir_key#7){++++}, at: inode_lock include/linux/fs.h:748 [inline]
#2: 00000000c7cf14cb (&type->i_mutex_dir_key#7){++++}, at: vfs_removexattr+0xb2/0x240 fs/xattr.c:465
#3: 000000004f8e85fb (&type->i_mutex_dir_key#7/3){+.+.}, at: inode_lock_nested include/linux/fs.h:783 [inline]
#3: 000000004f8e85fb (&type->i_mutex_dir_key#7/3){+.+.}, at: lookup_and_delete_xattr fs/reiserfs/xattr.c:484 [inline]
#3: 000000004f8e85fb (&type->i_mutex_dir_key#7/3){+.+.}, at: reiserfs_xattr_set_handle+0x7fd/0xb40 fs/reiserfs/xattr.c:527
2 locks held by syz-executor416/11862:
#0: 00000000e516bba4 (&type->s_umount_key#47){+.+.}, at: do_remount fs/namespace.c:2307 [inline]
#0: 00000000e516bba4 (&type->s_umount_key#47){+.+.}, at: do_mount+0xa5b/0x2f50 fs/namespace.c:2813
#1: 00000000760b0eea (&bdi->wb_switch_rwsem){+.+.}, at: bdi_down_write_wb_switch_rwsem fs/fs-writeback.c:338 [inline]
#1: 00000000760b0eea (&bdi->wb_switch_rwsem){+.+.}, at: sync_inodes_sb+0x180/0x9a0 fs/fs-writeback.c:2457
2 locks held by kworker/u4:4/12087:
#0: 00000000f8f8318b ((wq_completion)"writeback"){+.+.}, at: process_one_work+0x767/0x1570 kernel/workqueue.c:2124
#1: 00000000a3dc9d92 ((work_completion)(&(&wb->dwork)->work)){+.+.}, at: process_one_work+0x79c/0x1570 kernel/workqueue.c:2128
4 locks held by syz-executor416/13775:
#0: 00000000f803407c (&type->s_umount_key#46/1){+.+.}, at: alloc_super fs/super.c:226 [inline]
#0: 00000000f803407c (&type->s_umount_key#46/1){+.+.}, at: sget_userns+0x20b/0xcd0 fs/super.c:519
#1: 0000000065583bbc (sb_writers#11){.+.+}, at: sb_start_write include/linux/fs.h:1579 [inline]
#1: 0000000065583bbc (sb_writers#11){.+.+}, at: mnt_want_write+0x3a/0xb0 fs/namespace.c:360
#2: 000000006eb1b2c7 (&type->i_mutex_dir_key#7){++++}, at: inode_lock include/linux/fs.h:748 [inline]
#2: 000000006eb1b2c7 (&type->i_mutex_dir_key#7){++++}, at: vfs_removexattr+0xb2/0x240 fs/xattr.c:465
#3: 000000003b3bd0ee (&type->i_mutex_dir_key#7/3){+.+.}, at: inode_lock_nested include/linux/fs.h:783 [inline]
#3: 000000003b3bd0ee (&type->i_mutex_dir_key#7/3){+.+.}, at: lookup_and_delete_xattr fs/reiserfs/xattr.c:484 [inline]
#3: 000000003b3bd0ee (&type->i_mutex_dir_key#7/3){+.+.}, at: reiserfs_xattr_set_handle+0x7fd/0xb40 fs/reiserfs/xattr.c:527
2 locks held by syz-executor416/13810:
#0: 00000000bf7784cc (&type->s_umount_key#47){+.+.}, at: do_remount fs/namespace.c:2307 [inline]
#0: 00000000bf7784cc (&type->s_umount_key#47){+.+.}, at: do_mount+0xa5b/0x2f50 fs/namespace.c:2813
#1: 0000000061ee5d43 (&bdi->wb_switch_rwsem){+.+.}, at: bdi_down_write_wb_switch_rwsem fs/fs-writeback.c:338 [inline]
#1: 0000000061ee5d43 (&bdi->wb_switch_rwsem){+.+.}, at: sync_inodes_sb+0x180/0x9a0 fs/fs-writeback.c:2457

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

NMI backtrace for cpu 0
CPU: 0 PID: 1570 Comm: khungtaskd Not tainted 4.19.211-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/12/2023
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 0 to CPUs 1:
NMI backtrace for cpu 1
CPU: 1 PID: 8103 Comm: syz-executor416 Not tainted 4.19.211-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/12/2023
RIP: 0010:bytes_is_nonzero mm/kasan/kasan.c:167 [inline]
RIP: 0010:memory_is_nonzero mm/kasan/kasan.c:184 [inline]
RIP: 0010:memory_is_poisoned_n mm/kasan/kasan.c:210 [inline]
RIP: 0010:memory_is_poisoned mm/kasan/kasan.c:241 [inline]
RIP: 0010:check_memory_region_inline mm/kasan/kasan.c:257 [inline]
RIP: 0010:check_memory_region+0xcb/0x170 mm/kasan/kasan.c:267
Code: 0e 80 38 00 74 f2 48 85 c0 0f 85 9c 00 00 00 5b 5d 41 5c c3 48 85 d2 74 f6 48 01 ea eb 09 48 83 c0 01 48 39 d0 74 e8 80 38 00 <74> f2 eb d8 41 bc 08 00 00 00 48 89 ea 45 29 dc 4e 8d 5c 25 00 eb
RSP: 0018:ffff888095067710 EFLAGS: 00000046
RAX: fffffbfff19bb375 RBX: fffffbfff19bb376 RCX: ffffffff814afa31
RDX: fffffbfff19bb376 RSI: 0000000000000004 RDI: ffffffff8cdd9ba8
RBP: fffffbfff19bb375 R08: 0000000000000001 R09: fffffbfff19bb375
R10: ffffffff8cdd9bab R11: 0000000000000000 R12: 0000000000000001
R13: ffff888094d9e540 R14: ffffc900093761a0 R15: 0000000000000001
FS: 00005555570ac400(0000) GS:ffff8880ba100000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007efd3802c6e0 CR3: 0000000095483000 CR4: 00000000003406e0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
atomic_inc include/asm-generic/atomic-instrumented.h:109 [inline]
__lock_acquire+0x251/0x3ff0 kernel/locking/lockdep.c:3308
lock_acquire+0x170/0x3c0 kernel/locking/lockdep.c:3908
__raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:110 [inline]
_raw_spin_lock_irqsave+0x8c/0xc0 kernel/locking/spinlock.c:152
__wake_up_common_lock+0xb0/0x170 kernel/sched/wait.c:120
do_journal_end+0x33f1/0x4840 fs/reiserfs/journal.c:4383
do_journal_release fs/reiserfs/journal.c:1937 [inline]
journal_release+0x31c/0x4d0 fs/reiserfs/journal.c:1981
reiserfs_put_super+0xe0/0x5c0 fs/reiserfs/super.c:616
generic_shutdown_super+0x144/0x370 fs/super.c:456
kill_block_super+0x97/0xf0 fs/super.c:1185
deactivate_locked_super+0x94/0x160 fs/super.c:329
deactivate_super+0x174/0x1a0 fs/super.c:360
cleanup_mnt+0x1a8/0x290 fs/namespace.c:1098
task_work_run+0x148/0x1c0 kernel/task_work.c:113
tracehook_notify_resume include/linux/tracehook.h:193 [inline]
exit_to_usermode_loop+0x251/0x2a0 arch/x86/entry/common.c:167
prepare_exit_to_usermode arch/x86/entry/common.c:198 [inline]
syscall_return_slowpath arch/x86/entry/common.c:271 [inline]
do_syscall_64+0x538/0x620 arch/x86/entry/common.c:296
entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x7f11b26696d7
Code: ff d0 48 89 c7 b8 3c 00 00 00 0f 05 48 c7 c1 b8 ff ff ff f7 d8 64 89 01 48 83 c8 ff c3 66 0f 1f 44 00 00 b8 a6 00 00 00 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 c7 c1 b8 ff ff ff f7 d8 64 89 01 48
RSP: 002b:00007fff40e8bb68 EFLAGS: 00000202 ORIG_RAX: 00000000000000a6
RAX: 0000000000000000 RBX: 0000000000000000 RCX: 00007f11b26696d7
RDX: 00007fff40e8bc2b RSI: 000000000000000a RDI: 00007fff40e8bc20
RBP: 00007fff40e8bc20 R08: 00000000ffffffff R09: 00007fff40e8ba00
R10: 00005555570ad783 R11: 0000000000000202 R12: 00007fff40e8cce0
R13: 00005555570ad6f0 R14: 00007fff40e8bb90 R15: 00007fff40e8cd00

syzbot

unread,
Feb 6, 2023, 3:12:52 AM2/6/23
to syzkaller...@googlegroups.com
Hello,

syzbot found the following issue on:

HEAD commit: a8ad60f2af58 Linux 4.14.305
git tree: linux-4.14.y
console output: https://syzkaller.appspot.com/x/log.txt?x=16b321c5480000
kernel config: https://syzkaller.appspot.com/x/.config?x=2f23dc9802022031
dashboard link: https://syzkaller.appspot.com/bug?extid=018600b145e4f975becd
compiler: gcc version 10.2.1 20210110 (Debian 10.2.1-6)

Unfortunately, I don't have any reproducer for this issue yet.

Downloadable assets:
disk image: https://storage.googleapis.com/syzbot-assets/c38348fd389d/disk-a8ad60f2.raw.xz
vmlinux: https://storage.googleapis.com/syzbot-assets/3a775d221689/vmlinux-a8ad60f2.xz
kernel image: https://storage.googleapis.com/syzbot-assets/32e71e04d2b4/bzImage-a8ad60f2.xz

IMPORTANT: if you fix the issue, please add the following tag to the commit:
Reported-by: syzbot+018600...@syzkaller.appspotmail.com

batman_adv: batadv0: Interface activated: batadv_slave_1
IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_1: link becomes ready
IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_batadv: link becomes ready
Bluetooth: hci7 command 0x041b tx timeout
INFO: task kworker/u4:6:9359 blocked for more than 140 seconds.
Not tainted 4.14.305-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
kworker/u4:6 D28192 9359 2 0x80000000
Workqueue: writeback wb_workfn (flush-7:5)
Call Trace:
context_switch kernel/sched/core.c:2811 [inline]
__schedule+0x88b/0x1de0 kernel/sched/core.c:3386
schedule+0x8d/0x1b0 kernel/sched/core.c:3430
queue_log_writer+0x237/0x290 fs/reiserfs/journal.c:2987
check_journal_end fs/reiserfs/journal.c:3684 [inline]
do_journal_end+0x7c9/0x4310 fs/reiserfs/journal.c:4051
reiserfs_write_inode+0x204/0x250 fs/reiserfs/inode.c:1788
write_inode fs/fs-writeback.c:1241 [inline]
__writeback_single_inode+0x6a4/0x1010 fs/fs-writeback.c:1439
writeback_sb_inodes+0x48b/0xd30 fs/fs-writeback.c:1645
wb_writeback+0x243/0xb80 fs/fs-writeback.c:1820
wb_do_writeback fs/fs-writeback.c:1952 [inline]
wb_workfn+0x2bd/0xf50 fs/fs-writeback.c:1988
process_one_work+0x793/0x14a0 kernel/workqueue.c:2117
worker_thread+0x5cc/0xff0 kernel/workqueue.c:2251
kthread+0x30d/0x420 kernel/kthread.c:232
ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:406
INFO: task syz-executor.5:9401 blocked for more than 140 seconds.
Not tainted 4.14.305-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
syz-executor.5 D25560 9401 8008 0x00000006
Call Trace:
context_switch kernel/sched/core.c:2811 [inline]
__schedule+0x88b/0x1de0 kernel/sched/core.c:3386
schedule+0x8d/0x1b0 kernel/sched/core.c:3430
bit_wait+0x12/0x90 kernel/sched/wait_bit.c:240
__wait_on_bit+0x86/0x150 kernel/sched/wait_bit.c:51
__inode_wait_for_writeback+0x123/0x190 fs/fs-writeback.c:1262
inode_wait_for_writeback+0x22/0x30 fs/fs-writeback.c:1274
evict+0x292/0x700 fs/inode.c:551
iput_final fs/inode.c:1523 [inline]
iput+0x458/0x7e0 fs/inode.c:1550
dentry_unlink_inode+0x25c/0x310 fs/dcache.c:387
d_delete+0x1c5/0x280 fs/dcache.c:2417
xattr_unlink+0x114/0x160 fs/reiserfs/xattr.c:96
lookup_and_delete_xattr fs/reiserfs/xattr.c:492 [inline]
reiserfs_xattr_set_handle+0x6d2/0x980 fs/reiserfs/xattr.c:527
reiserfs_xattr_set+0x387/0x4d0 fs/reiserfs/xattr.c:631
trusted_set+0x86/0xb0 fs/reiserfs/xattr_trusted.c:30
__vfs_removexattr+0xcf/0x120 fs/xattr.c:416
__vfs_removexattr_locked+0x12e/0x2f0 fs/xattr.c:448
vfs_removexattr+0xb1/0x210 fs/xattr.c:469
ovl_fill_super+0x1170/0x2610 fs/overlayfs/super.c:1029
mount_nodev+0x4c/0xf0 fs/super.c:1180
mount_fs+0x92/0x2a0 fs/super.c:1237
vfs_kern_mount.part.0+0x5b/0x470 fs/namespace.c:1046
vfs_kern_mount fs/namespace.c:1036 [inline]
do_new_mount fs/namespace.c:2572 [inline]
do_mount+0xe65/0x2a30 fs/namespace.c:2905
SYSC_mount fs/namespace.c:3121 [inline]
SyS_mount+0xa8/0x120 fs/namespace.c:3098
do_syscall_64+0x1d5/0x640 arch/x86/entry/common.c:292
entry_SYSCALL_64_after_hwframe+0x5e/0xd3
RIP: 0033:0x7f6c495a60c9
RSP: 002b:00007f6c47b18168 EFLAGS: 00000246 ORIG_RAX: 00000000000000a5
RAX: ffffffffffffffda RBX: 00007f6c496c5f80 RCX: 00007f6c495a60c9
RDX: 0000000020000080 RSI: 00000000200000c0 RDI: 0000000000000000
RBP: 00007f6c49601ae9 R08: 0000000020000480 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007ffcbdc489ff R14: 00007f6c47b18300 R15: 0000000000022000
INFO: task syz-executor.5:9413 blocked for more than 140 seconds.
Not tainted 4.14.305-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
syz-executor.5 D28056 9413 8008 0x00000004
Call Trace:
context_switch kernel/sched/core.c:2811 [inline]
__schedule+0x88b/0x1de0 kernel/sched/core.c:3386
schedule+0x8d/0x1b0 kernel/sched/core.c:3430
wb_wait_for_completion fs/fs-writeback.c:222 [inline]
wb_wait_for_completion+0x118/0x170 fs/fs-writeback.c:218
sync_inodes_sb+0x173/0x880 fs/fs-writeback.c:2447
__sync_filesystem fs/sync.c:34 [inline]
sync_filesystem fs/sync.c:67 [inline]
sync_filesystem+0x12f/0x230 fs/sync.c:48
reiserfs_remount+0x10f/0x1320 fs/reiserfs/super.c:1453
do_remount_sb+0x150/0x530 fs/super.c:868
do_remount fs/namespace.c:2393 [inline]
do_mount+0x15f3/0x2a30 fs/namespace.c:2896
SYSC_mount fs/namespace.c:3121 [inline]
SyS_mount+0xa8/0x120 fs/namespace.c:3098
do_syscall_64+0x1d5/0x640 arch/x86/entry/common.c:292
entry_SYSCALL_64_after_hwframe+0x5e/0xd3
RIP: 0033:0x7f6c495a75fa
RSP: 002b:00007f6c3faf6f88 EFLAGS: 00000206 ORIG_RAX: 00000000000000a5
RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007f6c495a75fa
RDX: 00000000200000c0 RSI: 0000000020000100 RDI: 0000000000000000
RBP: 00007f6c3faf7020 R08: 00007f6c3faf7020 R09: 0000000001a484bc
R10: 0000000001a484bc R11: 0000000000000206 R12: 00000000200000c0
R13: 0000000020000100 R14: 00007f6c3faf6fe0 R15: 00000000200009c0

Showing all locks held in the system:
1 lock held by khungtaskd/1533:
#0: (tasklist_lock){.+.+}, at: [<ffffffff8702d99c>] debug_show_all_locks+0x7c/0x21a kernel/locking/lockdep.c:4548
2 locks held by kworker/u4:6/9359:
#0: ("writeback"){+.+.}, at: [<ffffffff813660e0>] process_one_work+0x6b0/0x14a0 kernel/workqueue.c:2088
#1: ((&(&wb->dwork)->work)){+.+.}, at: [<ffffffff81366116>] process_one_work+0x6e6/0x14a0 kernel/workqueue.c:2092
3 locks held by syz-executor.5/9401:
#0: (&type->s_umount_key#47/1){+.+.}, at: [<ffffffff81879146>] alloc_super fs/super.c:251 [inline]
#0: (&type->s_umount_key#47/1){+.+.}, at: [<ffffffff81879146>] sget_userns+0x556/0xc10 fs/super.c:516
#1: (&type->i_mutex_dir_key#8){++++}, at: [<ffffffff818f3bf2>] inode_lock include/linux/fs.h:719 [inline]
#1: (&type->i_mutex_dir_key#8){++++}, at: [<ffffffff818f3bf2>] vfs_removexattr+0xa2/0x210 fs/xattr.c:468
#2: (&type->i_mutex_dir_key#8/3){+.+.}, at: [<ffffffff81b3db02>] inode_lock_nested include/linux/fs.h:754 [inline]
#2: (&type->i_mutex_dir_key#8/3){+.+.}, at: [<ffffffff81b3db02>] lookup_and_delete_xattr fs/reiserfs/xattr.c:484 [inline]
#2: (&type->i_mutex_dir_key#8/3){+.+.}, at: [<ffffffff81b3db02>] reiserfs_xattr_set_handle+0x652/0x980 fs/reiserfs/xattr.c:527
2 locks held by syz-executor.5/9413:
#0: (&type->s_umount_key#48){++++}, at: [<ffffffff818e9777>] do_remount fs/namespace.c:2387 [inline]
#0: (&type->s_umount_key#48){++++}, at: [<ffffffff818e9777>] do_mount+0x837/0x2a30 fs/namespace.c:2896
#1: (&bdi->wb_switch_rwsem){+.+.}, at: [<ffffffff8190f236>] bdi_down_write_wb_switch_rwsem fs/fs-writeback.c:338 [inline]
#1: (&bdi->wb_switch_rwsem){+.+.}, at: [<ffffffff8190f236>] sync_inodes_sb+0x156/0x880 fs/fs-writeback.c:2445
2 locks held by syz-executor.1/11894:
#0: (sb_writers#4){.+.+}, at: [<ffffffff8187058f>] file_start_write include/linux/fs.h:2714 [inline]
#0: (sb_writers#4){.+.+}, at: [<ffffffff8187058f>] do_sendfile+0x84f/0xb30 fs/read_write.c:1440
#1: (&type->s_umount_key#48){++++}, at: [<ffffffff8187b57a>] iterate_supers+0xda/0x490 fs/super.c:611
2 locks held by syz-executor.1/12266:
#0: (sb_writers#4){.+.+}, at: [<ffffffff8187058f>] file_start_write include/linux/fs.h:2714 [inline]
#0: (sb_writers#4){.+.+}, at: [<ffffffff8187058f>] do_sendfile+0x84f/0xb30 fs/read_write.c:1440
#1: (&type->s_umount_key#48){++++}, at: [<ffffffff8187b57a>] iterate_supers+0xda/0x490 fs/super.c:611

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

NMI backtrace for cpu 1
CPU: 1 PID: 1533 Comm: khungtaskd Not tainted 4.14.305-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/12/2023
Call Trace:
__dump_stack lib/dump_stack.c:17 [inline]
dump_stack+0x1b2/0x281 lib/dump_stack.c:58
nmi_cpu_backtrace.cold+0x57/0x93 lib/nmi_backtrace.c:101
nmi_trigger_cpumask_backtrace+0x13a/0x180 lib/nmi_backtrace.c:62
trigger_all_cpu_backtrace include/linux/nmi.h:140 [inline]
check_hung_uninterruptible_tasks kernel/hung_task.c:195 [inline]
watchdog+0x5b9/0xb40 kernel/hung_task.c:274
kthread+0x30d/0x420 kernel/kthread.c:232
ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:406
Sending NMI from CPU 1 to CPUs 0:
NMI backtrace for cpu 0
CPU: 0 PID: 4625 Comm: systemd-journal Not tainted 4.14.305-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/12/2023
task: ffff8880a1262180 task.stack: ffff8880a1268000
RIP: 0010:__sanitizer_cov_trace_pc+0x23/0x50 kernel/kcov.c:68
RSP: 0018:ffff8880a126fa20 EFLAGS: 00000246
RAX: ffff8880a1262180 RBX: 0000000000000000 RCX: 1ffffffff11999ac
RDX: 0000000000000000 RSI: 0000000000000000 RDI: ffffffff88e0dba8
RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000020011
R10: ffff8880a1262a08 R11: ffff8880a1262180 R12: dffffc0000000000
R13: 0000000000000000 R14: 00007fa7b4ad99c7 R15: 0000000000001000
FS: 00007fa7b581e8c0(0000) GS:ffff8880ba400000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007fa7aeec2000 CR3: 00000000a12cf000 CR4: 00000000003406f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
read_seqcount_retry include/linux/seqlock.h:220 [inline]
latch_tree_find include/linux/rbtree_latch.h:208 [inline]
bpf_prog_kallsyms_find.part.0+0x11d/0x240 kernel/bpf/core.c:468
bpf_prog_kallsyms_find include/linux/rcupdate.h:630 [inline]
is_bpf_text_address+0x13b/0x150 kernel/bpf/core.c:503
kernel_text_address kernel/extable.c:150 [inline]
kernel_text_address+0xbd/0xf0 kernel/extable.c:120
__kernel_text_address+0x9/0x30 kernel/extable.c:105
unwind_get_return_address arch/x86/kernel/unwind_orc.c:252 [inline]
unwind_get_return_address+0x51/0x90 arch/x86/kernel/unwind_orc.c:247
__save_stack_trace+0xa0/0x160 arch/x86/kernel/stacktrace.c:45
save_stack mm/kasan/kasan.c:447 [inline]
set_track mm/kasan/kasan.c:459 [inline]
kasan_kmalloc+0xeb/0x160 mm/kasan/kasan.c:551
kmem_cache_alloc+0x124/0x3c0 mm/slab.c:3552
getname_flags+0xc8/0x550 fs/namei.c:138
user_path_at_empty+0x2a/0x50 fs/namei.c:2631
user_path_at include/linux/namei.h:57 [inline]
SYSC_faccessat fs/open.c:403 [inline]
SyS_faccessat+0x21b/0x680 fs/open.c:353
do_syscall_64+0x1d5/0x640 arch/x86/entry/common.c:292
entry_SYSCALL_64_after_hwframe+0x5e/0xd3
RIP: 0033:0x7fa7b4ad99c7
RSP: 002b:00007fff7e049278 EFLAGS: 00000246 ORIG_RAX: 0000000000000015
RAX: ffffffffffffffda RBX: 00007fff7e04c2a0 RCX: 00007fa7b4ad99c7
RDX: 0000000000000000 RSI: 0000000000000000 RDI: 00005580f811d9a3
RBP: 00007fff7e0493c0 R08: 00005580f81133e5 R09: 0000000000000018
R10: 0000000000000030 R11: 0000000000000246 R12: 0000000000000000
R13: 0000000000000000 R14: 00005580f982b8a0 R15: 00007fff7e0498b0
Code: 90 90 90 90 90 90 90 90 65 48 8b 04 25 c0 7f 02 00 48 85 c0 74 1a 65 8b 15 8b 28 ad 7e 81 e2 00 01 1f 00 75 0b 8b 90 58 13 00 00 <83> fa 01 74 01 c3 48 8b 34 24 48 8b 88 60 13 00 00 8b 80 5c 13
Reply all
Reply to author
Forward
0 new messages