syzbot


INFO: task hung in filename_create

Status: auto-closed as invalid on 2020/04/14 04:42
Reported-by: syzbot+b39e4286c56db97c92f4@syzkaller.appspotmail.com
First crash: 1021d, last: 1017d
similar bugs (11):
Kernel Title Repro Cause bisect Fix bisect Count Last Reported Patched Status
linux-4.19 INFO: task hung in filename_create 6 1044d 1143d 0/1 auto-closed as invalid on 2020/03/17 23:03
upstream INFO: task hung in filename_create (2) 11 1028d 1132d 0/24 auto-closed as invalid on 2020/03/04 11:54
android-49 INFO: task hung in filename_create C 44 1493d 1264d 0/3 public: reported C repro on 2019/04/13 00:00
upstream INFO: task hung in filename_create (3) 16 493d 649d 0/24 auto-closed as invalid on 2021/08/20 18:08
linux-4.19 INFO: task hung in filename_create (3) 3 321d 383d 0/1 auto-closed as invalid on 2022/03/11 04:15
android-44 INFO: task hung in filename_create 1 1626d 1626d 0/2 auto-closed as invalid on 2019/02/22 14:19
linux-4.19 INFO: task hung in filename_create (2) 1 584d 584d 0/1 auto-closed as invalid on 2021/06/20 16:38
linux-4.19 INFO: task hung in filename_create (4) 1 18d 18d 0/1 upstream: reported on 2022/09/10 11:07
android-44 INFO: task hung in filename_create (2) 1 1247d 1247d 0/2 auto-closed as invalid on 2019/10/25 08:49
upstream INFO: task hung in filename_create (4) C error error 15 8d15h 280d 0/24 upstream: reported C repro on 2021/12/21 22:55
upstream INFO: task hung in filename_create 121 1337d 1622d 0/24 closed as dup on 2018/09/08 15:39

Sample crash report:
protocol 88fb is buggy, dev hsr_slave_1
protocol 88fb is buggy, dev hsr_slave_0
protocol 88fb is buggy, dev hsr_slave_1
protocol 88fb is buggy, dev hsr_slave_0
protocol 88fb is buggy, dev hsr_slave_1
INFO: task syz-executor.4:9775 blocked for more than 140 seconds.
      Not tainted 4.14.158-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
syz-executor.4  D30000  9775  31191 0x00000004
Call Trace:
 context_switch kernel/sched/core.c:2808 [inline]
 __schedule+0x7b8/0x1cd0 kernel/sched/core.c:3384
 schedule+0x92/0x1c0 kernel/sched/core.c:3428
 __rwsem_down_write_failed_common kernel/locking/rwsem-xadd.c:588 [inline]
 rwsem_down_write_failed+0x5ce/0xb50 kernel/locking/rwsem-xadd.c:617
 call_rwsem_down_write_failed+0x17/0x30 arch/x86/lib/rwsem.S:105
 __down_write arch/x86/include/asm/rwsem.h:126 [inline]
 down_write_nested+0x57/0x90 kernel/locking/rwsem.c:174
 inode_lock_nested include/linux/fs.h:753 [inline]
 filename_create+0x141/0x430 fs/namei.c:3671
 user_path_create fs/namei.c:3729 [inline]
 SYSC_mkdirat fs/namei.c:3861 [inline]
 SyS_mkdirat fs/namei.c:3853 [inline]
 SYSC_mkdir fs/namei.c:3880 [inline]
 SyS_mkdir+0x92/0x200 fs/namei.c:3878
 do_syscall_64+0x1e8/0x640 arch/x86/entry/common.c:292
 entry_SYSCALL_64_after_hwframe+0x42/0xb7
RIP: 0033:0x45a909
RSP: 002b:00007fe421e99c78 EFLAGS: 00000246 ORIG_RAX: 0000000000000053
RAX: ffffffffffffffda RBX: 0000000000000002 RCX: 000000000045a909
RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000020000180
RBP: 000000000075bfc8 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 00007fe421e9a6d4
R13: 00000000004c02fa R14: 00000000004de870 R15: 00000000ffffffff
INFO: task syz-executor.4:9776 blocked for more than 140 seconds.
      Not tainted 4.14.158-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
syz-executor.4  D29416  9776  31191 0x00000004
Call Trace:
 context_switch kernel/sched/core.c:2808 [inline]
 __schedule+0x7b8/0x1cd0 kernel/sched/core.c:3384
 schedule+0x92/0x1c0 kernel/sched/core.c:3428
 __rwsem_down_read_failed_common kernel/locking/rwsem-xadd.c:292 [inline]
 rwsem_down_read_failed+0x1f6/0x390 kernel/locking/rwsem-xadd.c:309
 call_rwsem_down_read_failed+0x18/0x30 arch/x86/lib/rwsem.S:94
 __down_read arch/x86/include/asm/rwsem.h:66 [inline]
 down_read+0x49/0xb0 kernel/locking/rwsem.c:26
 inode_lock_shared include/linux/fs.h:728 [inline]
 lookup_slow+0x138/0x440 fs/namei.c:1673
 walk_component+0x698/0x1d00 fs/namei.c:1824
 lookup_last fs/namei.c:2292 [inline]
 path_lookupat.isra.0+0x1bb/0x7b0 fs/namei.c:2342
 filename_lookup+0x18e/0x380 fs/namei.c:2376
 user_path_at_empty+0x43/0x50 fs/namei.c:2630
 user_path_at include/linux/namei.h:57 [inline]
 SYSC_chdir fs/open.c:459 [inline]
 SyS_chdir+0x86/0x190 fs/open.c:453
 do_syscall_64+0x1e8/0x640 arch/x86/entry/common.c:292
 entry_SYSCALL_64_after_hwframe+0x42/0xb7
RIP: 0033:0x45a909
RSP: 002b:00007fe421e78c78 EFLAGS: 00000246 ORIG_RAX: 0000000000000050
RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 000000000045a909
RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000020000180
RBP: 000000000075c070 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 00007fe421e796d4
R13: 00000000004c0363 R14: 00000000004d4bb0 R15: 00000000ffffffff
INFO: task syz-executor.4:9777 blocked for more than 140 seconds.
      Not tainted 4.14.158-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
syz-executor.4  D29344  9777  31191 0x00000004
Call Trace:
 context_switch kernel/sched/core.c:2808 [inline]
 __schedule+0x7b8/0x1cd0 kernel/sched/core.c:3384
 schedule+0x92/0x1c0 kernel/sched/core.c:3428
 __rwsem_down_read_failed_common kernel/locking/rwsem-xadd.c:292 [inline]
 rwsem_down_read_failed+0x1f6/0x390 kernel/locking/rwsem-xadd.c:309
 call_rwsem_down_read_failed+0x18/0x30 arch/x86/lib/rwsem.S:94
 __down_read arch/x86/include/asm/rwsem.h:66 [inline]
 down_read+0x49/0xb0 kernel/locking/rwsem.c:26
 inode_lock_shared include/linux/fs.h:728 [inline]
 do_last fs/namei.c:3330 [inline]
 path_openat+0x191c/0x3f70 fs/namei.c:3566
 do_filp_open+0x18e/0x250 fs/namei.c:3600
 do_sys_open+0x2c5/0x430 fs/open.c:1084
 SYSC_openat fs/open.c:1111 [inline]
 SyS_openat+0x30/0x40 fs/open.c:1105
 do_syscall_64+0x1e8/0x640 arch/x86/entry/common.c:292
 entry_SYSCALL_64_after_hwframe+0x42/0xb7
RIP: 0033:0x45a909
RSP: 002b:00007fe421e57c78 EFLAGS: 00000246 ORIG_RAX: 0000000000000101
RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 000000000045a909
RDX: 0000000000007a05 RSI: 00000000200001c0 RDI: ffffffffffffff9c
RBP: 000000000075c118 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000001700 R11: 0000000000000246 R12: 00007fe421e586d4
R13: 00000000004c7fb3 R14: 00000000004df0e0 R15: 00000000ffffffff
INFO: task syz-executor.4:9778 blocked for more than 140 seconds.
      Not tainted 4.14.158-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
syz-executor.4  D29328  9778  31191 0x00000004
Call Trace:
 context_switch kernel/sched/core.c:2808 [inline]
 __schedule+0x7b8/0x1cd0 kernel/sched/core.c:3384
 schedule+0x92/0x1c0 kernel/sched/core.c:3428
 __rwsem_down_read_failed_common kernel/locking/rwsem-xadd.c:292 [inline]
 rwsem_down_read_failed+0x1f6/0x390 kernel/locking/rwsem-xadd.c:309
 call_rwsem_down_read_failed+0x18/0x30 arch/x86/lib/rwsem.S:94
 __down_read arch/x86/include/asm/rwsem.h:66 [inline]
 down_read+0x49/0xb0 kernel/locking/rwsem.c:26
 inode_lock_shared include/linux/fs.h:728 [inline]
 lookup_slow+0x138/0x440 fs/namei.c:1673
 walk_component+0x698/0x1d00 fs/namei.c:1824
 lookup_last fs/namei.c:2292 [inline]
 path_lookupat.isra.0+0x1bb/0x7b0 fs/namei.c:2342
 filename_lookup+0x18e/0x380 fs/namei.c:2376
 user_path_at_empty+0x43/0x50 fs/namei.c:2630
 user_path include/linux/namei.h:62 [inline]
 do_mount+0x12b/0x27d0 fs/namespace.c:2819
 SYSC_mount fs/namespace.c:3095 [inline]
 SyS_mount+0xab/0x120 fs/namespace.c:3072
 do_syscall_64+0x1e8/0x640 arch/x86/entry/common.c:292
 entry_SYSCALL_64_after_hwframe+0x42/0xb7
RIP: 0033:0x45a909
RSP: 002b:00007fe421e36c78 EFLAGS: 00000246 ORIG_RAX: 00000000000000a5
RAX: ffffffffffffffda RBX: 0000000000000005 RCX: 000000000045a909
RDX: 0000000020000100 RSI: 0000000020000000 RDI: 0000000000000000
RBP: 000000000075c1c0 R08: 0000000020000340 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 00007fe421e376d4
R13: 00000000004c7cb8 R14: 00000000004deb40 R15: 00000000ffffffff
INFO: task syz-executor.4:9785 blocked for more than 140 seconds.
      Not tainted 4.14.158-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
syz-executor.4  D29344  9785  31191 0x00000004
Call Trace:
 context_switch kernel/sched/core.c:2808 [inline]
 __schedule+0x7b8/0x1cd0 kernel/sched/core.c:3384
 schedule+0x92/0x1c0 kernel/sched/core.c:3428
 __rwsem_down_read_failed_common kernel/locking/rwsem-xadd.c:292 [inline]
 rwsem_down_read_failed+0x1f6/0x390 kernel/locking/rwsem-xadd.c:309
 call_rwsem_down_read_failed+0x18/0x30 arch/x86/lib/rwsem.S:94
 __down_read arch/x86/include/asm/rwsem.h:66 [inline]
 down_read+0x49/0xb0 kernel/locking/rwsem.c:26
 inode_lock_shared include/linux/fs.h:728 [inline]
 lookup_slow+0x138/0x440 fs/namei.c:1673
 walk_component+0x698/0x1d00 fs/namei.c:1824
 lookup_last fs/namei.c:2292 [inline]
 path_lookupat.isra.0+0x1bb/0x7b0 fs/namei.c:2342
 filename_lookup+0x18e/0x380 fs/namei.c:2376
 user_path_at_empty+0x43/0x50 fs/namei.c:2630
 user_path include/linux/namei.h:62 [inline]
 do_mount+0x12b/0x27d0 fs/namespace.c:2819
 SYSC_mount fs/namespace.c:3095 [inline]
 SyS_mount+0xab/0x120 fs/namespace.c:3072
 do_syscall_64+0x1e8/0x640 arch/x86/entry/common.c:292
 entry_SYSCALL_64_after_hwframe+0x42/0xb7
RIP: 0033:0x45a909
RSP: 002b:00007fe421e15c78 EFLAGS: 00000246 ORIG_RAX: 00000000000000a5
RAX: ffffffffffffffda RBX: 0000000000000005 RCX: 000000000045a909
RDX: 0000000000000000 RSI: 00000000200002c0 RDI: 0000000000000000
RBP: 000000000075c268 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 00007fe421e166d4
R13: 00000000004c7d3a R14: 00000000004dec30 R15: 00000000ffffffff

Showing all locks held in the system:
1 lock held by khungtaskd/1045:
 #0:  (tasklist_lock){.+.+}, at: [<ffffffff8148c8a8>] debug_show_all_locks+0x7f/0x21f kernel/locking/lockdep.c:4544
3 locks held by rsyslogd/6933:
 #0:  (&f->f_pos_lock){+.+.}, at: [<ffffffff81966a1b>] __fdget_pos+0xab/0xd0 fs/file.c:769
 #1:  (&rq->lock){-.-.}, at: [<ffffffff86642a0a>] rq_lock kernel/sched/sched.h:1741 [inline]
 #1:  (&rq->lock){-.-.}, at: [<ffffffff86642a0a>] __schedule+0x1da/0x1cd0 kernel/sched/core.c:3321
 #2:  (rcu_read_lock){....}, at: [<ffffffff81478032>] cpuacct_charge+0x82/0x360 kernel/sched/cpuacct.c:355
2 locks held by getty/7055:
 #0:  (&tty->ldisc_sem){++++}, at: [<ffffffff866549c3>] ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:376
 #1:  (&ldata->atomic_read_lock){+.+.}, at: [<ffffffff83490d76>] n_tty_read+0x1e6/0x17b0 drivers/tty/n_tty.c:2156
2 locks held by getty/7056:
 #0:  (&tty->ldisc_sem){++++}, at: [<ffffffff866549c3>] ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:376
 #1:  (&ldata->atomic_read_lock){+.+.}, at: [<ffffffff83490d76>] n_tty_read+0x1e6/0x17b0 drivers/tty/n_tty.c:2156
2 locks held by getty/7057:
 #0:  (&tty->ldisc_sem){++++}, at: [<ffffffff866549c3>] ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:376
 #1:  (&ldata->atomic_read_lock){+.+.}, at: [<ffffffff83490d76>] n_tty_read+0x1e6/0x17b0 drivers/tty/n_tty.c:2156
2 locks held by getty/7058:
 #0:  (&tty->ldisc_sem){++++}, at: [<ffffffff866549c3>] ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:376
 #1:  (&ldata->atomic_read_lock){+.+.}, at: [<ffffffff83490d76>] n_tty_read+0x1e6/0x17b0 drivers/tty/n_tty.c:2156
2 locks held by getty/7059:
 #0:  (&tty->ldisc_sem){++++}, at: [<ffffffff866549c3>] ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:376
 #1:  (&ldata->atomic_read_lock){+.+.}, at: [<ffffffff83490d76>] n_tty_read+0x1e6/0x17b0 drivers/tty/n_tty.c:2156
2 locks held by getty/7060:
 #0:  (&tty->ldisc_sem){++++}, at: [<ffffffff866549c3>] ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:376
 #1:  (&ldata->atomic_read_lock){+.+.}, at: [<ffffffff83490d76>] n_tty_read+0x1e6/0x17b0 drivers/tty/n_tty.c:2156
2 locks held by getty/7061:
 #0:  (&tty->ldisc_sem){++++}, at: [<ffffffff866549c3>] ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:376
 #1:  (&ldata->atomic_read_lock){+.+.}, at: [<ffffffff83490d76>] n_tty_read+0x1e6/0x17b0 drivers/tty/n_tty.c:2156
1 lock held by syz-executor.4/9725:
 #0:  (&sb->s_type->i_mutex_key#20){++++}, at: [<ffffffff8191f8d8>] inode_lock_shared include/linux/fs.h:728 [inline]
 #0:  (&sb->s_type->i_mutex_key#20){++++}, at: [<ffffffff8191f8d8>] lookup_slow+0x138/0x440 fs/namei.c:1673
2 locks held by syz-executor.4/9775:
 #0:  (sb_writers#20){.+.+}, at: [<ffffffff8196fd1f>] sb_start_write include/linux/fs.h:1548 [inline]
 #0:  (sb_writers#20){.+.+}, at: [<ffffffff8196fd1f>] mnt_want_write+0x3f/0xb0 fs/namespace.c:386
 #1:  (&sb->s_type->i_mutex_key#20/1){+.+.}, at: [<ffffffff81934c41>] inode_lock_nested include/linux/fs.h:753 [inline]
 #1:  (&sb->s_type->i_mutex_key#20/1){+.+.}, at: [<ffffffff81934c41>] filename_create+0x141/0x430 fs/namei.c:3671
1 lock held by syz-executor.4/9776:
 #0:  (&sb->s_type->i_mutex_key#20){++++}, at: [<ffffffff8191f8d8>] inode_lock_shared include/linux/fs.h:728 [inline]
 #0:  (&sb->s_type->i_mutex_key#20){++++}, at: [<ffffffff8191f8d8>] lookup_slow+0x138/0x440 fs/namei.c:1673
2 locks held by syz-executor.4/9777:
 #0:  (sb_writers#20){.+.+}, at: [<ffffffff8196fd1f>] sb_start_write include/linux/fs.h:1548 [inline]
 #0:  (sb_writers#20){.+.+}, at: [<ffffffff8196fd1f>] mnt_want_write+0x3f/0xb0 fs/namespace.c:386
 #1:  (&sb->s_type->i_mutex_key#20){++++}, at: [<ffffffff8192f56c>] inode_lock_shared include/linux/fs.h:728 [inline]
 #1:  (&sb->s_type->i_mutex_key#20){++++}, at: [<ffffffff8192f56c>] do_last fs/namei.c:3330 [inline]
 #1:  (&sb->s_type->i_mutex_key#20){++++}, at: [<ffffffff8192f56c>] path_openat+0x191c/0x3f70 fs/namei.c:3566
1 lock held by syz-executor.4/9778:
 #0:  (&sb->s_type->i_mutex_key#20){++++}, at: [<ffffffff8191f8d8>] inode_lock_shared include/linux/fs.h:728 [inline]
 #0:  (&sb->s_type->i_mutex_key#20){++++}, at: [<ffffffff8191f8d8>] lookup_slow+0x138/0x440 fs/namei.c:1673
1 lock held by syz-executor.4/9785:
 #0:  (&sb->s_type->i_mutex_key#20){++++}, at: [<ffffffff8191f8d8>] inode_lock_shared include/linux/fs.h:728 [inline]
 #0:  (&sb->s_type->i_mutex_key#20){++++}, at: [<ffffffff8191f8d8>] lookup_slow+0x138/0x440 fs/namei.c:1673

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

NMI backtrace for cpu 1
CPU: 1 PID: 1045 Comm: khungtaskd Not tainted 4.14.158-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
Call Trace:
 __dump_stack lib/dump_stack.c:17 [inline]
 dump_stack+0x142/0x197 lib/dump_stack.c:58
 nmi_cpu_backtrace.cold+0x57/0x94 lib/nmi_backtrace.c:101
 nmi_trigger_cpumask_backtrace+0x141/0x189 lib/nmi_backtrace.c:62
 arch_trigger_cpumask_backtrace+0x14/0x20 arch/x86/kernel/apic/hw_nmi.c:38
 trigger_all_cpu_backtrace include/linux/nmi.h:140 [inline]
 check_hung_uninterruptible_tasks kernel/hung_task.c:195 [inline]
 watchdog+0x5e7/0xb90 kernel/hung_task.c:274
 kthread+0x319/0x430 kernel/kthread.c:232
 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:404
Sending NMI from CPU 1 to CPUs 0:
NMI backtrace for cpu 0 skipped: idling at pc 0xffffffff866554ae

Crashes (2):
Manager Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Title
ci2-linux-4-14 2019/12/16 04:41 linux-4.14.y a844dc4c5442 eef6e580 .config log report
ci2-linux-4-14 2019/12/12 03:31 linux-4.14.y a844dc4c5442 0d368675 .config log report
* Struck through repros no longer work on HEAD.