syzbot


INFO: task hung in jbd2_journal_commit_transaction (2)

Status: auto-closed as invalid on 2021/06/09 10:13
Subsystems: ext4
[Documentation on labels]
First crash: 1225d, last: 1225d
Similar bugs (8)
Kernel Title Repro Cause bisect Fix bisect Count Last Reported Patched Status
android-44 INFO: task hung in jbd2_journal_commit_transaction C 6 2210d 1923d 0/2 public: reported C repro on 2019/04/13 00:00
android-49 INFO: task hung in jbd2_journal_commit_transaction 5 2117d 2262d 0/3 auto-closed as invalid on 2019/03/29 12:13
upstream INFO: task hung in jbd2_journal_commit_transaction (5) usb ext4 C error 240 1d06h 64d 0/27 upstream: reported C repro on 2024/05/15 03:54
linux-6.1 INFO: task hung in jbd2_journal_commit_transaction 1 413d 413d 0/3 auto-obsoleted due to no activity on 2023/09/09 09:50
upstream INFO: task hung in jbd2_journal_commit_transaction (4) ext4 7 356d 504d 0/27 auto-obsoleted due to no activity on 2023/10/25 18:13
upstream INFO: task hung in jbd2_journal_commit_transaction (3) ext4 C error error 24 658d 942d 0/27 auto-obsoleted due to no activity on 2023/01/27 09:20
upstream INFO: task hung in jbd2_journal_commit_transaction ext4 C 52 2104d 2123d 0/27 closed as dup on 2018/10/02 14:53
android-414 INFO: task hung in jbd2_journal_commit_transaction C 31 2109d 1925d 0/1 public: reported C repro on 2019/04/11 00:00

Sample crash report:
INFO: task jbd2/sda1-8:4806 blocked for more than 143 seconds.
      Not tainted 5.12.0-rc2-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:jbd2/sda1-8     state:D stack:26288 pid: 4806 ppid:     2 flags:0x00004000
Call Trace:
 context_switch kernel/sched/core.c:4324 [inline]
 __schedule+0x90c/0x21a0 kernel/sched/core.c:5075
 schedule+0xcf/0x270 kernel/sched/core.c:5154
 io_schedule+0xba/0x130 kernel/sched/core.c:7211
 bit_wait_io+0x12/0xd0 kernel/sched/wait_bit.c:209
 __wait_on_bit+0x60/0x190 kernel/sched/wait_bit.c:49
 out_of_line_wait_on_bit+0xd5/0x110 kernel/sched/wait_bit.c:64
 wait_on_bit_io include/linux/wait_bit.h:101 [inline]
 __wait_on_buffer+0x7c/0x90 fs/buffer.c:122
 wait_on_buffer include/linux/buffer_head.h:354 [inline]
 journal_wait_on_commit_record fs/jbd2/commit.c:175 [inline]
 jbd2_journal_commit_transaction+0x4db8/0x6ba0 fs/jbd2/commit.c:931
 kjournald2+0x1d0/0x930 fs/jbd2/journal.c:213
 kthread+0x3b1/0x4a0 kernel/kthread.c:292
 ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:294
INFO: task syz-executor.2:11853 blocked for more than 143 seconds.
      Not tainted 5.12.0-rc2-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.2  state:D stack:24280 pid:11853 ppid:  8611 flags:0x20004004
Call Trace:
 context_switch kernel/sched/core.c:4324 [inline]
 __schedule+0x90c/0x21a0 kernel/sched/core.c:5075
 schedule+0xcf/0x270 kernel/sched/core.c:5154
 jbd2_log_wait_commit+0x2d4/0x430 fs/jbd2/journal.c:712
 jbd2_complete_transaction+0x184/0x200 fs/jbd2/journal.c:846
 ext4_fc_commit+0x7e2/0x2300 fs/ext4/fast_commit.c:1211
 ext4_fsync_journal fs/ext4/fsync.c:115 [inline]
 ext4_sync_file+0x3cd/0xfd0 fs/ext4/fsync.c:174
 vfs_fsync_range+0x13a/0x220 fs/sync.c:200
 generic_write_sync include/linux/fs.h:2843 [inline]
 ext4_buffered_write_iter+0x36a/0x4d0 fs/ext4/file.c:277
 ext4_file_write_iter+0x423/0x14e0 fs/ext4/file.c:663
 call_write_iter include/linux/fs.h:1977 [inline]
 do_iter_readv_writev+0x46f/0x740 fs/read_write.c:740
 do_iter_write+0x188/0x670 fs/read_write.c:866
 vfs_iter_write+0x70/0xa0 fs/read_write.c:907
 iter_file_splice_write+0x723/0xc70 fs/splice.c:689
 do_splice_from fs/splice.c:767 [inline]
 direct_splice_actor+0x110/0x180 fs/splice.c:936
 splice_direct_to_actor+0x34b/0x8c0 fs/splice.c:891
 do_splice_direct+0x1b3/0x280 fs/splice.c:979
 do_sendfile+0x9f0/0x1110 fs/read_write.c:1260
 __do_compat_sys_sendfile fs/read_write.c:1346 [inline]
 __se_compat_sys_sendfile fs/read_write.c:1329 [inline]
 __ia32_compat_sys_sendfile+0x1dd/0x220 fs/read_write.c:1329
 do_syscall_32_irqs_on arch/x86/entry/common.c:77 [inline]
 __do_fast_syscall_32+0x56/0x80 arch/x86/entry/common.c:139
 do_fast_syscall_32+0x2f/0x70 arch/x86/entry/common.c:164
 entry_SYSENTER_compat_after_hwframe+0x4d/0x5c
RIP: 0023:0xf7f2e549
RSP: 002b:00000000f55285fc EFLAGS: 00000296 ORIG_RAX: 00000000000000bb
RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 0000000000000004
RDX: 0000000000000000 RSI: 000000001d00c0d0 RDI: 0000000000000000
RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000000
R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000

Showing all locks held in the system:
1 lock held by khungtaskd/1622:
 #0: ffffffff8bf74220 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x53/0x260 kernel/locking/lockdep.c:6327
6 locks held by kworker/0:1H/2143:
1 lock held by in:imklog/8134:
 #0: ffff88801d0ed770 (&f->f_pos_lock){+.+.}-{3:3}, at: __fdget_pos+0xe9/0x100 fs/file.c:961
5 locks held by kworker/0:4/9628:
1 lock held by syz-executor.2/11853:
 #0: ffff888021ec6460 (sb_writers#5){.+.+}-{0:0}, at: __do_compat_sys_sendfile fs/read_write.c:1346 [inline]
 #0: ffff888021ec6460 (sb_writers#5){.+.+}-{0:0}, at: __se_compat_sys_sendfile fs/read_write.c:1329 [inline]
 #0: ffff888021ec6460 (sb_writers#5){.+.+}-{0:0}, at: __ia32_compat_sys_sendfile+0x1dd/0x220 fs/read_write.c:1329

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

NMI backtrace for cpu 1
CPU: 1 PID: 1622 Comm: khungtaskd Not tainted 5.12.0-rc2-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
Call Trace:
 __dump_stack lib/dump_stack.c:79 [inline]
 dump_stack+0x141/0x1d7 lib/dump_stack.c:120
 nmi_cpu_backtrace.cold+0x44/0xd7 lib/nmi_backtrace.c:105
 nmi_trigger_cpumask_backtrace+0x1b3/0x230 lib/nmi_backtrace.c:62
 trigger_all_cpu_backtrace include/linux/nmi.h:146 [inline]
 check_hung_uninterruptible_tasks kernel/hung_task.c:209 [inline]
 watchdog+0xd48/0xfb0 kernel/hung_task.c:294
 kthread+0x3b1/0x4a0 kernel/kthread.c:292
 ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:294
Sending NMI from CPU 1 to CPUs 0:
NMI backtrace for cpu 0
CPU: 0 PID: 136 Comm: kworker/u4:3 Not tainted 5.12.0-rc2-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
Workqueue: bat_events batadv_nc_worker
RIP: 0010:rcu_lock_acquire include/linux/rcupdate.h:267 [inline]
RIP: 0010:rcu_read_lock include/linux/rcupdate.h:656 [inline]
RIP: 0010:batadv_nc_purge_orig_hash net/batman-adv/network-coding.c:404 [inline]
RIP: 0010:batadv_nc_worker+0x121/0xe50 net/batman-adv/network-coding.c:715
Code: 40 8b 44 24 3c 48 8b 11 48 8d 1c c2 e8 f8 5b bb f8 e8 b3 0e cf f8 45 31 c9 45 31 c0 31 d2 31 f6 b9 02 00 00 00 68 93 8f a4 88 <48> c7 c7 20 42 f7 8b e8 33 d8 b4 f8 e8 ee 66 5f 00 31 ff 89 c5 89
RSP: 0018:ffffc9000140fc88 EFLAGS: 00000246
RAX: 0000000000000000 RBX: ffff888012a80e98 RCX: 0000000000000002
RDX: 0000000000000000 RSI: 0000000000000000 RDI: ffff888011ccbb4c
RBP: 0000000000000001 R08: 0000000000000000 R09: 0000000000000000
R10: ffffffff88a49679 R11: 0000000000000000 R12: ffffc9000140fda8
R13: 0000000000000000 R14: dffffc0000000000 R15: 00000000000001d3
FS:  0000000000000000(0000) GS:ffff8880b9c00000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007f5c12599078 CR3: 000000000bc8e000 CR4: 00000000001506f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
 process_one_work+0x98d/0x1600 kernel/workqueue.c:2275
 worker_thread+0x64c/0x1120 kernel/workqueue.c:2421
 kthread+0x3b1/0x4a0 kernel/kthread.c:292
 ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:294

Crashes (1):
Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Assets (help?) Manager Title
2021/03/11 10:05 upstream a74e6a014c9d c2ca1f2a .config console log report info ci-upstream-kasan-gce-386 INFO: task hung in jbd2_journal_commit_transaction
* Struck through repros no longer work on HEAD.