syzbot


INFO: task hung in ext4_buffered_write_iter (3)

Status: auto-obsoleted due to no activity on 2023/11/04 07:21
Subsystems: ext4
[Documentation on labels]
First crash: 273d, last: 273d
Similar bugs (2)
Kernel Title Repro Cause bisect Fix bisect Count Last Reported Patched Status
upstream INFO: task hung in ext4_buffered_write_iter ext4 1 1327d 1327d 0/26 auto-closed as invalid on 2020/12/15 19:03
upstream INFO: task hung in ext4_buffered_write_iter (2) ext4 24 373d 569d 0/26 auto-obsoleted due to no activity on 2023/07/27 13:19

Sample crash report:
INFO: task syz-executor.5:18487 blocked for more than 143 seconds.
      Not tainted 6.5.0-rc4-syzkaller-00245-gf6a691685962 #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.5  state:D stack:28456 pid:18487 ppid:12651  flags:0x00004006
Call Trace:
 <TASK>
 context_switch kernel/sched/core.c:5381 [inline]
 __schedule+0x1873/0x48f0 kernel/sched/core.c:6710
 schedule+0xc3/0x180 kernel/sched/core.c:6786
 schedule_preempt_disabled+0x13/0x20 kernel/sched/core.c:6845
 rwsem_down_write_slowpath+0xedd/0x13a0 kernel/locking/rwsem.c:1178
 __down_write_common+0x1aa/0x200 kernel/locking/rwsem.c:1306
 inode_lock include/linux/fs.h:771 [inline]
 ext4_buffered_write_iter+0x97/0x350 fs/ext4/file.c:294
 ext4_file_write_iter+0x1df/0x1b10
 call_write_iter include/linux/fs.h:1871 [inline]
 new_sync_write fs/read_write.c:491 [inline]
 vfs_write+0x782/0xaf0 fs/read_write.c:584
 ksys_write+0x1a0/0x2c0 fs/read_write.c:637
 do_syscall_x64 arch/x86/entry/common.c:50 [inline]
 do_syscall_64+0x41/0xc0 arch/x86/entry/common.c:80
 entry_SYSCALL_64_after_hwframe+0x63/0xcd
RIP: 0033:0x7f557e27cae9
RSP: 002b:00007f5574a1d0c8 EFLAGS: 00000246 ORIG_RAX: 0000000000000001
RAX: ffffffffffffffda RBX: 00007f557e39c050 RCX: 00007f557e27cae9
RDX: 0000000000000020 RSI: 0000000020002c40 RDI: 0000000000000004
RBP: 00007f557e2c847a R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 000000000000006e R14: 00007f557e39c050 R15: 00007fff5ce071f8
 </TASK>

Showing all locks held in the system:
1 lock held by rcu_tasks_kthre/13:
 #0: ffffffff8d328db0 (rcu_tasks.tasks_gp_mutex){+.+.}-{3:3}, at: rcu_tasks_one_gp+0x29/0xd20 kernel/rcu/tasks.h:522
1 lock held by rcu_tasks_trace/14:
 #0: ffffffff8d329170 (rcu_tasks_trace.tasks_gp_mutex){+.+.}-{3:3}, at: rcu_tasks_one_gp+0x29/0xd20 kernel/rcu/tasks.h:522
1 lock held by khungtaskd/28:
 #0: ffffffff8d328be0 (rcu_read_lock){....}-{1:2}, at: rcu_lock_acquire+0x0/0x30
2 locks held by getty/4777:
 #0: ffff8880295a0098 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x25/0x70 drivers/tty/tty_ldisc.c:243
 #1: ffffc900015c02f0 (&ldata->atomic_read_lock){+.+.}-{3:3}, at: n_tty_read+0x6b1/0x1dc0 drivers/tty/n_tty.c:2187
5 locks held by syz-executor.5/18484:
 #0: ffff888078ce4d48 (&f->f_pos_lock){+.+.}-{3:3}, at: __fdget_pos+0x2c1/0x370 fs/file.c:1062
 #1: ffff88807688c410 (sb_writers#4){.+.+}-{0:0}, at: vfs_write+0x216/0xaf0 fs/read_write.c:580
 #2: ffff888075827200 (&sb->s_type->i_mutex_key#7){++++}-{3:3}, at: inode_lock include/linux/fs.h:771 [inline]
 #2: ffff888075827200 (&sb->s_type->i_mutex_key#7){++++}-{3:3}, at: ext4_dio_write_iter fs/ext4/file.c:564 [inline]
 #2: ffff888075827200 (&sb->s_type->i_mutex_key#7){++++}-{3:3}, at: ext4_file_write_iter+0x37e/0x1b10 fs/ext4/file.c:720
 #3: ffff8880758273a0 (mapping.invalidate_lock){++++}-{3:3}, at: filemap_invalidate_lock include/linux/fs.h:816 [inline]
 #3: ffff8880758273a0 (mapping.invalidate_lock){++++}-{3:3}, at: ext4_truncate_failed_write fs/ext4/truncate.h:20 [inline]
 #3: ffff8880758273a0 (mapping.invalidate_lock){++++}-{3:3}, at: ext4_handle_inode_extension+0x643/0x8c0 fs/ext4/file.c:383
 #4: ffff888075827088 (&ei->i_data_sem){++++}-{3:3}, at: ext4_truncate+0x981/0x1150 fs/ext4/inode.c:4122
3 locks held by syz-executor.5/18487:
 #0: ffff8880408145c8 (&f->f_pos_lock){+.+.}-{3:3}, at: __fdget_pos+0x2c1/0x370 fs/file.c:1062
 #1: ffff88807688c410 (sb_writers#4){.+.+}-{0:0}, at: vfs_write+0x216/0xaf0 fs/read_write.c:580
 #2: ffff888075827200 (&sb->s_type->i_mutex_key#7){++++}-{3:3}, at: inode_lock include/linux/fs.h:771 [inline]
 #2: ffff888075827200 (&sb->s_type->i_mutex_key#7){++++}-{3:3}, at: ext4_buffered_write_iter+0x97/0x350 fs/ext4/file.c:294
1 lock held by syz-executor.1/20375:
 #0: ffff888077496410 (sb_writers#18){.+.+}-{0:0}, at: mnt_want_write_file+0x61/0x200 fs/namespace.c:447

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

NMI backtrace for cpu 0
CPU: 0 PID: 28 Comm: khungtaskd Not tainted 6.5.0-rc4-syzkaller-00245-gf6a691685962 #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 07/12/2023
Call Trace:
 <TASK>
 __dump_stack lib/dump_stack.c:88 [inline]
 dump_stack_lvl+0x1e7/0x2d0 lib/dump_stack.c:106
 nmi_cpu_backtrace+0x498/0x4d0 lib/nmi_backtrace.c:113
 nmi_trigger_cpumask_backtrace+0x187/0x300 lib/nmi_backtrace.c:62
 trigger_all_cpu_backtrace include/linux/nmi.h:160 [inline]
 check_hung_uninterruptible_tasks kernel/hung_task.c:222 [inline]
 watchdog+0xec2/0xf00 kernel/hung_task.c:379
 kthread+0x2b8/0x350 kernel/kthread.c:389
 ret_from_fork+0x2e/0x60 arch/x86/kernel/process.c:145
 ret_from_fork_asm+0x11/0x20 arch/x86/entry/entry_64.S:304
 </TASK>
Sending NMI from CPU 0 to CPUs 1:
NMI backtrace for cpu 1
CPU: 1 PID: 5010 Comm: syz-fuzzer Not tainted 6.5.0-rc4-syzkaller-00245-gf6a691685962 #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 07/12/2023
RIP: 0010:lockdep_recursion_finish kernel/locking/lockdep.c:467 [inline]
RIP: 0010:lock_is_held_type+0x106/0x190 kernel/locking/lockdep.c:5833
Code: 31 c0 f6 45 22 03 0f 95 c0 31 ed 44 39 f0 40 0f 94 c5 eb 05 bd 01 00 00 00 48 c7 c7 40 a0 0a 8b e8 af 16 00 00 b8 ff ff ff ff <65> 0f c1 05 9a 13 46 75 83 f8 01 75 40 48 c7 04 24 00 00 00 00 9c
RSP: 0018:ffffc9000395ecf0 EFLAGS: 00000082
RAX: 00000000ffffffff RBX: 0000000000000001 RCX: dffffc0000000000
RDX: 0000000000000005 RSI: ffffffff8b0aa040 RDI: ffffffff8b58a3c0
RBP: 0000000000000001 R08: ffffffff8e9864ef R09: 1ffffffff1d30c9d
R10: dffffc0000000000 R11: fffffbfff1d30c9e R12: 0000000000000046
R13: ffff888027f0d940 R14: 00000000ffffffff R15: ffff8880b993bf98
FS:  000000c00005a090(0000) GS:ffff8880b9900000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 0000555556830938 CR3: 000000007e273000 CR4: 00000000003506e0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
 <NMI>
 </NMI>
 <TASK>
 lock_is_held include/linux/lockdep.h:288 [inline]
 lockdep_assert_rq_held kernel/sched/sched.h:1357 [inline]
 rq_clock_pelt kernel/sched/pelt.h:66 [inline]
 cfs_rq_clock_pelt kernel/sched/pelt.h:174 [inline]
 update_load_avg+0xdd/0x14b0 kernel/sched/fair.c:4244
 enqueue_entity+0x11c/0x1790 kernel/sched/fair.c:4856
 enqueue_task_fair+0x23f/0xcd0 kernel/sched/fair.c:6336
 enqueue_task+0x19d/0x2e0 kernel/sched/core.c:2082
 activate_task+0x61/0xc0 kernel/sched/core.c:2112
 attach_task+0xee/0x180 kernel/sched/fair.c:8865
 attach_tasks kernel/sched/fair.c:8900 [inline]
 load_balance+0x5fd2/0x8170 kernel/sched/fair.c:10890
 newidle_balance+0x660/0xff0 kernel/sched/fair.c:11891
 pick_next_task_fair+0x289/0xdc0 kernel/sched/fair.c:8182
 __pick_next_task kernel/sched/core.c:6013 [inline]
 pick_next_task kernel/sched/core.c:6088 [inline]
 __schedule+0x7c6/0x48f0 kernel/sched/core.c:6674
 schedule+0xc3/0x180 kernel/sched/core.c:6786
 futex_wait_queue+0x151/0x1e0 kernel/futex/waitwake.c:355
 futex_wait+0x207/0x5c0 kernel/futex/waitwake.c:656
 do_futex+0x331/0x530 kernel/futex/syscalls.c:106
 __do_sys_futex kernel/futex/syscalls.c:183 [inline]
 __se_sys_futex+0x3f8/0x480 kernel/futex/syscalls.c:164
 do_syscall_x64 arch/x86/entry/common.c:50 [inline]
 do_syscall_64+0x41/0xc0 arch/x86/entry/common.c:80
 entry_SYSCALL_64_after_hwframe+0x63/0xcd
RIP: 0033:0x46b6a3
Code: 24 20 c3 cc cc cc cc 48 8b 7c 24 08 8b 74 24 10 8b 54 24 14 4c 8b 54 24 18 4c 8b 44 24 20 44 8b 4c 24 28 b8 ca 00 00 00 0f 05 <89> 44 24 30 c3 cc cc cc cc cc cc cc cc cc cc cc cc cc cc cc cc cc
RSP: 002b:000000c000069e78 EFLAGS: 00000202 ORIG_RAX: 00000000000000ca
RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 000000000046b6a3
RDX: 0000000000000000 RSI: 0000000000000080 RDI: 0000000001fb9a80
RBP: 000000c000069ec0 R08: 0000000000000000 R09: 0000000000000000
R10: 000000c000069eb0 R11: 0000000000000202 R12: 000000c000069eb0
R13: 000000c006ddf800 R14: 000000c0000064e0 R15: 0000000000000010
 </TASK>

Crashes (1):
Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Assets (help?) Manager Title
2023/08/06 07:13 upstream f6a691685962 4ffcc9ef .config console log report info [disk image] [vmlinux] [kernel image] ci2-upstream-fs INFO: task hung in ext4_buffered_write_iter
* Struck through repros no longer work on HEAD.