syzbot


INFO: task hung in flush_async_commits (2)

Status: auto-obsoleted due to no activity on 2023/12/28 15:52
Subsystems: reiserfs
[Documentation on labels]
First crash: 339d, last: 271d
Similar bugs (2)
Kernel Title Repro Cause bisect Fix bisect Count Last Reported Patched Status
linux-5.15 INFO: task hung in flush_async_commits 1 24d 24d 0/3 upstream: reported on 2024/06/02 16:31
upstream INFO: task hung in flush_async_commits reiserfs 4 508d 558d 0/27 auto-obsoleted due to no activity on 2023/05/05 20:14

Sample crash report:
INFO: task kworker/1:2:1784 blocked for more than 143 seconds.
      Not tainted 6.6.0-rc3-syzkaller-00055-g9ed22ae6be81 #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:kworker/1:2     state:D stack:23336 pid:1784  ppid:2      flags:0x00004000
Workqueue: reiserfs/loop0 flush_async_commits

Call Trace:
 <TASK>
 context_switch kernel/sched/core.c:5382 [inline]
 __schedule+0x196c/0x4af0 kernel/sched/core.c:6695
 schedule+0xc3/0x180 kernel/sched/core.c:6771
 schedule_preempt_disabled+0x13/0x20 kernel/sched/core.c:6830
 __mutex_lock_common kernel/locking/mutex.c:679 [inline]
 __mutex_lock+0x6a3/0xd60 kernel/locking/mutex.c:747
 reiserfs_write_lock+0x7a/0xd0 fs/reiserfs/lock.c:27
 flush_async_commits+0x46/0xc0 fs/reiserfs/journal.c:3554
 process_one_work kernel/workqueue.c:2630 [inline]
 process_scheduled_works+0x90f/0x1400 kernel/workqueue.c:2703
 worker_thread+0xa5f/0xff0 kernel/workqueue.c:2784
 kthread+0x2d3/0x370 kernel/kthread.c:388
 ret_from_fork+0x48/0x80 arch/x86/kernel/process.c:147
 ret_from_fork_asm+0x11/0x20 arch/x86/entry/entry_64.S:304
 </TASK>
INFO: task kworker/0:6:5149 blocked for more than 144 seconds.
      Not tainted 6.6.0-rc3-syzkaller-00055-g9ed22ae6be81 #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:kworker/0:6     state:D stack:23528 pid:5149  ppid:2      flags:0x00004000
Workqueue: events_long flush_old_commits
Call Trace:
 <TASK>
 context_switch kernel/sched/core.c:5382 [inline]
 __schedule+0x196c/0x4af0 kernel/sched/core.c:6695
 schedule+0xc3/0x180 kernel/sched/core.c:6771
 schedule_preempt_disabled+0x13/0x20 kernel/sched/core.c:6830
 __mutex_lock_common kernel/locking/mutex.c:679 [inline]
 __mutex_lock+0x6a3/0xd60 kernel/locking/mutex.c:747
 reiserfs_write_lock_nested+0x5f/0xd0 fs/reiserfs/lock.c:78
 queue_log_writer+0x249/0x330 fs/reiserfs/journal.c:2988
 do_journal_begin_r+0xbd4/0x1020 fs/reiserfs/journal.c:3108
 journal_begin+0x14c/0x360 fs/reiserfs/journal.c:3260
 reiserfs_sync_fs fs/reiserfs/super.c:77 [inline]
 flush_old_commits+0x1f3/0x2f0 fs/reiserfs/super.c:111
 process_one_work kernel/workqueue.c:2630 [inline]
 process_scheduled_works+0x90f/0x1400 kernel/workqueue.c:2703
 worker_thread+0xa5f/0xff0 kernel/workqueue.c:2784
 kthread+0x2d3/0x370 kernel/kthread.c:388
 ret_from_fork+0x48/0x80 arch/x86/kernel/process.c:147
 ret_from_fork_asm+0x11/0x20 arch/x86/entry/entry_64.S:304
 </TASK>

Showing all locks held in the system:
2 locks held by kworker/0:1/9:
 #0: ffff8880b983c318 (&rq->__lock){-.-.}-{2:2}, at: raw_spin_rq_lock_nested+0x2a/0x140 kernel/sched/core.c:558
 #1: ffff8880b9828808 (&per_cpu_ptr(group->pcpu, cpu)->seq){-.-.}-{0:0}, at: psi_task_switch+0x441/0x770 kernel/sched/psi.c:999
1 lock held by khungtaskd/29:
 #0: ffffffff8d32c420 (rcu_read_lock){....}-{1:2}, at: rcu_lock_acquire include/linux/rcupdate.h:303 [inline]
 #0: ffffffff8d32c420 (rcu_read_lock){....}-{1:2}, at: rcu_read_lock include/linux/rcupdate.h:749 [inline]
 #0: ffffffff8d32c420 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x55/0x2a0 kernel/locking/lockdep.c:6613
3 locks held by kworker/1:2/1784:
 #0: ffff8880299a5538 ((wq_completion)reiserfs/loop0){+.+.}-{0:0}, at: process_one_work kernel/workqueue.c:2605 [inline]
 #0: ffff8880299a5538 ((wq_completion)reiserfs/loop0){+.+.}-{0:0}, at: process_scheduled_works+0x825/0x1400 kernel/workqueue.c:2703
 #1: ffffc90005e7fd20 ((work_completion)(&(&journal->j_work)->work)){+.+.}-{0:0}, at: process_one_work kernel/workqueue.c:2605 [inline]
 #1: ffffc90005e7fd20 ((work_completion)(&(&journal->j_work)->work)){+.+.}-{0:0}, at: process_scheduled_works+0x825/0x1400 kernel/workqueue.c:2703
 #2: ffff88801cccd090 (&sbi->lock){+.+.}-{3:3}, at: reiserfs_write_lock+0x7a/0xd0 fs/reiserfs/lock.c:27
2 locks held by getty/4796:
 #0: ffff88814abbd0a0 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x25/0x70 drivers/tty/tty_ldisc.c:243
 #1: ffffc900015c72f0 (&ldata->atomic_read_lock){+.+.}-{3:3}, at: n_tty_read+0x6b1/0x1dc0 drivers/tty/n_tty.c:2206
4 locks held by syz-executor.2/5085:
4 locks held by kworker/1:6/5136:
 #0: ffff888012871538 ((wq_completion)events_long){+.+.}-{0:0}, at: process_one_work kernel/workqueue.c:2605 [inline]
 #0: ffff888012871538 ((wq_completion)events_long){+.+.}-{0:0}, at: process_scheduled_works+0x825/0x1400 kernel/workqueue.c:2703
 #1: ffffc90004dafd20 ((work_completion)(&(&sbi->old_work)->work)){+.+.}-{0:0}, at: process_one_work kernel/workqueue.c:2605 [inline]
 #1: ffffc90004dafd20 ((work_completion)(&(&sbi->old_work)->work)){+.+.}-{0:0}, at: process_scheduled_works+0x825/0x1400 kernel/workqueue.c:2703
 #2: ffff8880219640e0 (&type->s_umount_key#25){++++}-{3:3}, at: flush_old_commits+0xcb/0x2f0 fs/reiserfs/super.c:97
 #3: ffff88802f685090 (&sbi->lock){+.+.}-{3:3}, at: reiserfs_write_lock+0x7a/0xd0 fs/reiserfs/lock.c:27
2 locks held by kworker/1:8/5139:
 #0: 
ffff888012872938 ((wq_completion)rcu_gp){+.+.}-{0:0}, at: process_one_work kernel/workqueue.c:2605 [inline]
ffff888012872938 ((wq_completion)rcu_gp){+.+.}-{0:0}, at: process_scheduled_works+0x825/0x1400 kernel/workqueue.c:2703
 #1: 
ffffc90004dbfd20 ((work_completion)(&rew->rew_work)){+.+.}-{0:0}, at: process_one_work kernel/workqueue.c:2605 [inline]
ffffc90004dbfd20 ((work_completion)(&rew->rew_work)){+.+.}-{0:0}, at: process_scheduled_works+0x825/0x1400 kernel/workqueue.c:2703
4 locks held by kworker/0:6/5149:
 #0: 
ffff888012871538
 ((wq_completion)events_long){+.+.}-{0:0}, at: process_one_work kernel/workqueue.c:2605 [inline]
 ((wq_completion)events_long){+.+.}-{0:0}, at: process_scheduled_works+0x825/0x1400 kernel/workqueue.c:2703
 #1: ffffc90004e27d20 ((work_completion)(&(&sbi->old_work)->work)){+.+.}-{0:0}, at: process_one_work kernel/workqueue.c:2605 [inline]
 #1: ffffc90004e27d20 ((work_completion)(&(&sbi->old_work)->work)){+.+.}-{0:0}, at: process_scheduled_works+0x825/0x1400 kernel/workqueue.c:2703
 #2: ffff88802054c0e0 (&type->s_umount_key#25){++++}-{3:3}, at: flush_old_commits+0xcb/0x2f0 fs/reiserfs/super.c:97
 #3: 
ffff88801cccd090 (&sbi->lock){+.+.}-{3:3}, at: reiserfs_write_lock_nested+0x5f/0xd0 fs/reiserfs/lock.c:78
3 locks held by kworker/u4:11/5503:
 #0: ffff888141a61d38 ((wq_completion)writeback){+.+.}-{0:0}, at: process_one_work kernel/workqueue.c:2605 [inline]
 #0: ffff888141a61d38 ((wq_completion)writeback){+.+.}-{0:0}, at: process_scheduled_works+0x825/0x1400 kernel/workqueue.c:2703
 #1: 
ffffc9000ad07d20 ((work_completion)(&(&wb->dwork)->work)){+.+.}-{0:0}, at: process_one_work kernel/workqueue.c:2605 [inline]
ffffc9000ad07d20 ((work_completion)(&(&wb->dwork)->work)){+.+.}-{0:0}, at: process_scheduled_works+0x825/0x1400 kernel/workqueue.c:2703
 #2: ffff88802054c0e0 (&type->s_umount_key#25){++++}-{3:3}, at: super_trylock_shared+0x22/0xf0 fs/super.c:607
1 lock held by syz-executor.5/8240:
 #0: ffffffff8d331db8 (rcu_state.exp_mutex){+.+.}-{3:3}, at: exp_funnel_lock kernel/rcu/tree_exp.h:325 [inline]
 #0: ffffffff8d331db8 (rcu_state.exp_mutex){+.+.}-{3:3}, at: synchronize_rcu_expedited+0x46c/0x890 kernel/rcu/tree_exp.h:992
4 locks held by syz-executor.0/20141:
4 locks held by syz-executor.1/20284:
2 locks held by syz-executor.1/20315:
 #0: ffff888021964410 (sb_writers#31){.+.+}-{0:0}, at: do_sys_ftruncate+0x258/0x390 fs/open.c:191
 #1: ffff88803608e640 (&sb->s_type->i_mutex_key#38){+.+.}-{3:3}, at: inode_lock include/linux/fs.h:802 [inline]
 #1: ffff88803608e640 (&sb->s_type->i_mutex_key#38){+.+.}-{3:3}, at: do_truncate+0x20c/0x300 fs/open.c:64
1 lock held by syz-executor.1/20318:
 #0: ffff88802f685090 (&sbi->lock){+.+.}-{3:3}, at: reiserfs_write_lock+0x7a/0xd0 fs/reiserfs/lock.c:27
5 locks held by syz-executor.1/21905:
2 locks held by syz-executor.1/21908:
 #0: ffff88802a8c6410 (sb_writers#4){.+.+}-{0:0}, at: vfs_write+0x216/0xaf0 fs/read_write.c:580
 #1: ffff888049dcde00 (&sb->s_type->i_mutex_key#7){++++}-{3:3}, at: inode_lock include/linux/fs.h:802 [inline]
 #1: ffff888049dcde00 (&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/21909:
 #0: ffff888049dcde00 (&sb->s_type->i_mutex_key#7){++++}-{3:3}, at: inode_lock include/linux/fs.h:802 [inline]
 #0: ffff888049dcde00 (&sb->s_type->i_mutex_key#7){++++}-{3:3}, at: process_measurement+0x43b/0x1cf0 security/integrity/ima/ima_main.c:247
3 locks held by syz-executor.0/21910:

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

NMI backtrace for cpu 1
CPU: 1 PID: 29 Comm: khungtaskd Not tainted 6.6.0-rc3-syzkaller-00055-g9ed22ae6be81 #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 09/06/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+0x198/0x310 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+0xfa9/0xff0 kernel/hung_task.c:379
 kthread+0x2d3/0x370 kernel/kthread.c:388
 ret_from_fork+0x48/0x80 arch/x86/kernel/process.c:147
 ret_from_fork_asm+0x11/0x20 arch/x86/entry/entry_64.S:304
 </TASK>
Sending NMI from CPU 1 to CPUs 0:
NMI backtrace for cpu 0
CPU: 0 PID: 2826 Comm: kworker/u4:8 Not tainted 6.6.0-rc3-syzkaller-00055-g9ed22ae6be81 #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 09/06/2023
Workqueue: bat_events batadv_nc_worker
RIP: 0010:check_preemption_disabled+0x5c/0x110 lib/smp_processor_id.c:19
Code: 25 28 00 00 00 48 3b 44 24 08 0f 85 c7 00 00 00 89 d8 48 83 c4 10 5b 41 5c 41 5e 41 5f c3 48 c7 04 24 00 00 00 00 9c 8f 04 24 <f7> 04 24 00 02 00 00 74 c9 49 89 f6 49 89 ff 65 4c 8b 25 ed 51 36
RSP: 0018:ffffc9000b5b7a28 EFLAGS: 00000046
RAX: 0000000080000000 RBX: 0000000000000000 RCX: ffffc9000b5b7a03
RDX: 0000000000000002 RSI: ffffffff8b0ab5a0 RDI: ffffffff8b599aa0
RBP: ffffc9000b5b7b88 R08: ffffffff8e9a78ef R09: 1ffffffff1d34f1d
R10: dffffc0000000000 R11: fffffbfff1d34f1e R12: 1ffff920016b6f58
R13: 0000000000000246 R14: ffffc9000b5b7af0 R15: dffffc0000000000
FS:  0000000000000000(0000) GS:ffff8880b9800000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 0000000020001600 CR3: 000000000d130000 CR4: 00000000003506f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
 <NMI>
 </NMI>
 <TASK>
 lockdep_recursion_finish kernel/locking/lockdep.c:467 [inline]
 lock_release+0x5c8/0x9d0 kernel/locking/lockdep.c:5775
 rcu_lock_release include/linux/rcupdate.h:308 [inline]
 rcu_read_unlock include/linux/rcupdate.h:782 [inline]
 batadv_nc_purge_orig_hash net/batman-adv/network-coding.c:412 [inline]
 batadv_nc_worker+0x290/0x610 net/batman-adv/network-coding.c:719
 process_one_work kernel/workqueue.c:2630 [inline]
 process_scheduled_works+0x90f/0x1400 kernel/workqueue.c:2703
 worker_thread+0xa5f/0xff0 kernel/workqueue.c:2784
 kthread+0x2d3/0x370 kernel/kthread.c:388
 ret_from_fork+0x48/0x80 arch/x86/kernel/process.c:147
 ret_from_fork_asm+0x11/0x20 arch/x86/entry/entry_64.S:304
 </TASK>

Crashes (3):
Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Assets (help?) Manager Title
2023/09/29 15:48 upstream 9ed22ae6be81 8e26a358 .config console log report info [disk image] [vmlinux] [kernel image] ci2-upstream-fs INFO: task hung in flush_async_commits
2023/07/24 06:02 git://git.kernel.org/pub/scm/linux/kernel/git/arm64/linux.git for-kernelci e40939bbfc68 27cbe77f .config console log report info [disk image] [vmlinux] [kernel image] ci-upstream-gce-arm64 INFO: task hung in flush_async_commits
2023/07/23 05:12 git://git.kernel.org/pub/scm/linux/kernel/git/arm64/linux.git for-kernelci e40939bbfc68 27cbe77f .config console log report info [disk image] [vmlinux] [kernel image] ci-upstream-gce-arm64 INFO: task hung in flush_async_commits
* Struck through repros no longer work on HEAD.