syzbot


INFO: task hung in lru_add_drain_all

Status: auto-closed as invalid on 2021/06/04 15:54
Reported-by: syzbot+05a1b690987a7dc26a6e@syzkaller.appspotmail.com
First crash: 1148d, last: 1148d
Similar bugs (2)
Kernel Title Repro Cause bisect Fix bisect Count Last Reported Patched Status
upstream INFO: task hung in lru_add_drain_all mm C done inconclusive 22 1066d 1362d 0/26 auto-obsoleted due to no activity on 2023/04/26 14:41
linux-4.19 INFO: task hung in lru_add_drain_all (2) 1 898d 898d 0/1 auto-closed as invalid on 2022/02/09 00:46

Sample crash report:
Bluetooth: hci1: command 0x0406 tx timeout
Bluetooth: hci2: command 0x0406 tx timeout
Bluetooth: hci3: command 0x0406 tx timeout
Bluetooth: hci4: command 0x0406 tx timeout
Bluetooth: hci5: command 0x0406 tx timeout
INFO: task syz-executor.1:8140 blocked for more than 140 seconds.
      Not tainted 4.19.172-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
syz-executor.1  D24200  8140      1 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
 schedule_timeout+0x92d/0xfe0 kernel/time/timer.c:1794
 do_wait_for_common kernel/sched/completion.c:83 [inline]
 __wait_for_common kernel/sched/completion.c:104 [inline]
 wait_for_common+0x29c/0x470 kernel/sched/completion.c:115
 __flush_work+0x4bb/0x8b0 kernel/workqueue.c:2928
 lru_add_drain_all+0x374/0x4d0 mm/swap.c:699
 invalidate_bdev+0x96/0xd0 fs/block_dev.c:97
 ext4_put_super+0x745/0x1010 fs/ext4/super.c:1034
 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:0x466f67
Code: Bad RIP value.
RSP: 002b:00007ffc00b61e58 EFLAGS: 00000246 ORIG_RAX: 00000000000000a6
RAX: 0000000000000000 RBX: 0000000000000000 RCX: 0000000000466f67
RDX: 00007ffc00b61f2b RSI: 0000000000000002 RDI: 00007ffc00b61f20
RBP: 00007ffc00b61f20 R08: 00000000ffffffff R09: 00007ffc00b61cf0
R10: 0000000001eca8ab R11: 0000000000000246 R12: 00000000004af4e4
R13: 00007ffc00b62ff0 R14: 0000000001eca810 R15: 00007ffc00b63030
INFO: task syz-executor.3:15650 blocked for more than 140 seconds.
      Not tainted 4.19.172-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
syz-executor.3  D26656 15650   8144 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
 schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:3619
 __mutex_lock_common kernel/locking/mutex.c:1002 [inline]
 __mutex_lock+0x647/0x1260 kernel/locking/mutex.c:1072
 sock_ioctl+0x29e/0x5d0 net/socket.c:1039
 vfs_ioctl fs/ioctl.c:46 [inline]
 file_ioctl fs/ioctl.c:501 [inline]
 do_vfs_ioctl+0xcdb/0x12e0 fs/ioctl.c:688
 ksys_ioctl+0x9b/0xc0 fs/ioctl.c:705
 __do_sys_ioctl fs/ioctl.c:712 [inline]
 __se_sys_ioctl fs/ioctl.c:710 [inline]
 __x64_sys_ioctl+0x6f/0xb0 fs/ioctl.c:710
 do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293
 entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x465b09
Code: 44 24 30 48 8b 08 48 89 0c 24 48 89 44 24 08 c6 44 24 10 01 e8 28 78 fa ff 48 8b 44 24 18 48 89 44 24 38 48 8b 6c 24 20 48 83 <c4> 28 c3 e8 0f 4d 00 00 eb ad cc cc cc cc cc cc cc cc cc cc cc cc
RSP: 002b:00007fe80b628188 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
RAX: ffffffffffffffda RBX: 000000000056bf60 RCX: 0000000000465b09
RDX: 0000000020000440 RSI: 00000000000089a0 RDI: 0000000000000004
RBP: 00000000004b069f R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 000000000056bf60
R13: 00007ffc2120cc7f R14: 00007fe80b628300 R15: 0000000000022000
INFO: task syz-executor.3:15652 blocked for more than 140 seconds.
      Not tainted 4.19.172-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
syz-executor.3  D28640 15652   8144 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
 schedule_timeout+0x92d/0xfe0 kernel/time/timer.c:1794
 do_wait_for_common kernel/sched/completion.c:83 [inline]
 __wait_for_common kernel/sched/completion.c:104 [inline]
 wait_for_common+0x29c/0x470 kernel/sched/completion.c:115
 __flush_work+0x4bb/0x8b0 kernel/workqueue.c:2928
 flush_all_backlogs net/core/dev.c:5283 [inline]
 rollback_registered_many+0x4b1/0xe70 net/core/dev.c:8173
 rollback_registered+0xe9/0x1b0 net/core/dev.c:8230
 unregister_netdevice_queue+0x1de/0x3e0 net/core/dev.c:9297
 br_del_bridge+0xc8/0x110 net/bridge/br_if.c:488
 br_ioctl_deviceless_stub+0x27f/0x730 net/bridge/br_ioctl.c:380
 sock_ioctl+0x2b9/0x5d0 net/socket.c:1041
 vfs_ioctl fs/ioctl.c:46 [inline]
 file_ioctl fs/ioctl.c:501 [inline]
 do_vfs_ioctl+0xcdb/0x12e0 fs/ioctl.c:688
 ksys_ioctl+0x9b/0xc0 fs/ioctl.c:705
 __do_sys_ioctl fs/ioctl.c:712 [inline]
 __se_sys_ioctl fs/ioctl.c:710 [inline]
 __x64_sys_ioctl+0x6f/0xb0 fs/ioctl.c:710
 do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293
 entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x465b09
Code: Bad RIP value.
RSP: 002b:00007fe80b607188 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
RAX: ffffffffffffffda RBX: 000000000056c008 RCX: 0000000000465b09
RDX: 0000000020000300 RSI: 00000000000089a1 RDI: 0000000000000004
RBP: 00000000004b069f R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 000000000056c008
R13: 00007ffc2120cc7f R14: 00007fe80b607300 R15: 0000000000022000

Showing all locks held in the system:
1 lock held by khungtaskd/1567:
 #0: 00000000bd49ebff (rcu_read_lock){....}, at: debug_show_all_locks+0x53/0x265 kernel/locking/lockdep.c:4440
1 lock held by in:imklog/7847:
 #0: 000000005f4e0e74 (&f->f_pos_lock){+.+.}, at: __fdget_pos+0x26f/0x310 fs/file.c:767
2 locks held by syz-executor.1/8140:
 #0: 000000007dfcd904 (&type->s_umount_key#39){++++}, at: deactivate_super+0x16c/0x1a0 fs/super.c:359
 #1: 00000000fd51f5fb (lock#6){+.+.}, at: lru_add_drain_all+0x5a/0x4d0 mm/swap.c:681
3 locks held by kworker/0:4/9360:
1 lock held by syz-executor.0/15632:
1 lock held by syz-executor.3/15650:
 #0: 000000001cb134ec (br_ioctl_mutex){+.+.}, at: sock_ioctl+0x29e/0x5d0 net/socket.c:1039
3 locks held by syz-executor.3/15652:
 #0: 000000001cb134ec (br_ioctl_mutex){+.+.}, at: sock_ioctl+0x29e/0x5d0 net/socket.c:1039
 #1: 00000000b4a64b5f (rtnl_mutex){+.+.}, at: br_del_bridge+0x14/0x110 net/bridge/br_if.c:472
 #2: 00000000486de663 (cpu_hotplug_lock.rw_sem){++++}, at: get_online_cpus include/linux/cpu.h:137 [inline]
 #2: 00000000486de663 (cpu_hotplug_lock.rw_sem){++++}, at: flush_all_backlogs net/core/dev.c:5276 [inline]
 #2: 00000000486de663 (cpu_hotplug_lock.rw_sem){++++}, at: rollback_registered_many+0x3a8/0xe70 net/core/dev.c:8173

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

NMI backtrace for cpu 1
CPU: 1 PID: 1567 Comm: khungtaskd Not tainted 4.19.172-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
Call Trace:
 __dump_stack lib/dump_stack.c:77 [inline]
 dump_stack+0x1fc/0x2ef lib/dump_stack.c:118
 nmi_cpu_backtrace.cold+0x63/0xa2 lib/nmi_backtrace.c:101
 nmi_trigger_cpumask_backtrace+0x1a6/0x1f0 lib/nmi_backtrace.c:62
 trigger_all_cpu_backtrace include/linux/nmi.h:146 [inline]
 check_hung_uninterruptible_tasks kernel/hung_task.c:203 [inline]
 watchdog+0x991/0xe60 kernel/hung_task.c:287
 kthread+0x33f/0x460 kernel/kthread.c:259
 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:415
Sending NMI from CPU 1 to CPUs 0:
NMI backtrace for cpu 0
CPU: 0 PID: 15632 Comm: syz-executor.0 Not tainted 4.19.172-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
RIP: 0010:__sanitizer_cov_trace_pc+0x27/0x50 kernel/kcov.c:104
Code: 90 90 90 48 8b 34 24 65 48 8b 04 25 80 df 01 00 65 8b 15 3c 85 9f 7e 81 e2 00 01 1f 00 75 2b 8b 90 60 13 00 00 83 fa 02 75 20 <48> 8b 88 68 13 00 00 8b 80 64 13 00 00 48 8b 11 48 83 c2 01 48 39
RSP: 0018:ffff888092667830 EFLAGS: 00000246
RAX: ffff8880566e6480 RBX: ffff8880a38889d0 RCX: ffffc90005c3f000
RDX: 0000000000000002 RSI: ffffffff83ee1bb9 RDI: ffff8880a38889d0
RBP: ffff888239b19180 R08: 0000000000000000 R09: 00000000fffffe00
R10: 0000000000000005 R11: 0000000000000000 R12: ffff8880a3888940
R13: ffff888239b19250 R14: ffff8880a3888988 R15: ffff888239b19198
FS:  00007fd7274f3700(0000) GS:ffff8880ba000000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 0000001b3052e000 CR3: 00000000ab9c2000 CR4: 00000000001406f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
 put_device+0x9/0x30 drivers/base/core.c:2265
 disk_put_part include/linux/genhd.h:256 [inline]
 __blkdev_get+0x3c1/0x1480 fs/block_dev.c:1500
 blkdev_get+0xb0/0x940 fs/block_dev.c:1627
 blkdev_open+0x202/0x290 fs/block_dev.c:1788
 do_dentry_open+0x4aa/0x1160 fs/open.c:796
 do_last fs/namei.c:3421 [inline]
 path_openat+0x793/0x2df0 fs/namei.c:3537
 do_filp_open+0x18c/0x3f0 fs/namei.c:3567
 do_sys_open+0x3b3/0x520 fs/open.c:1085
 do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293
 entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x465b09
Code: ff ff c3 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 40 00 48 89 f8 48 89 f7 48 89 d6 48 89 ca 4d 89 c2 4d 89 c8 4c 8b 4c 24 08 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 c7 c1 bc ff ff ff f7 d8 64 89 01 48
RSP: 002b:00007fd7274f3188 EFLAGS: 00000246 ORIG_RAX: 0000000000000101
RAX: ffffffffffffffda RBX: 000000000056bf60 RCX: 0000000000465b09
RDX: 0000000000000000 RSI: 00000000200001c0 RDI: ffffffffffffff9c
RBP: 00000000004b069f R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 000000000056bf60
R13: 00007ffe02ef74af R14: 00007fd7274f3300 R15: 0000000000022000

Crashes (1):
Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Assets (help?) Manager Title
2021/02/04 15:54 linux-4.19.y 811218eceeaa 42b90a7c .config console log report info ci2-linux-4-19 INFO: task hung in lru_add_drain_all
* Struck through repros no longer work on HEAD.