syzbot


INFO: task hung in filename_create

Status: auto-closed as invalid on 2020/03/17 23:03
Reported-by: syzbot+d0cbe5efb6e8567f8206@syzkaller.appspotmail.com
First crash: 1098d, last: 999d
similar bugs (10):
Kernel Title Repro Cause bisect Fix bisect Count Last Reported Patched Status
upstream INFO: task hung in filename_create (2) 11 982d 1087d 0/23 auto-closed as invalid on 2020/03/04 11:54
android-49 INFO: task hung in filename_create C 44 1448d 1219d 0/3 public: reported C repro on 2019/04/13 00:00
upstream INFO: task hung in filename_create (3) 16 448d 604d 0/23 auto-closed as invalid on 2021/08/20 18:08
linux-4.19 INFO: task hung in filename_create (3) 3 276d 338d 0/1 auto-closed as invalid on 2022/03/11 04:15
android-44 INFO: task hung in filename_create 1 1581d 1581d 0/2 auto-closed as invalid on 2019/02/22 14:19
linux-4.19 INFO: task hung in filename_create (2) 1 539d 539d 0/1 auto-closed as invalid on 2021/06/20 16:38
linux-4.14 INFO: task hung in filename_create 2 971d 976d 0/1 auto-closed as invalid on 2020/04/14 04:42
android-44 INFO: task hung in filename_create (2) 1 1202d 1202d 0/2 auto-closed as invalid on 2019/10/25 08:49
upstream INFO: task hung in filename_create (4) C error error 14 8d17h 235d 0/23 upstream: reported C repro on 2021/12/21 22:55
upstream INFO: task hung in filename_create 121 1292d 1577d 0/23 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_0
protocol 88fb is buggy, dev hsr_slave_1
protocol 88fb is buggy, dev hsr_slave_1
INFO: task syz-executor.5:32183 blocked for more than 140 seconds.
      Not tainted 4.19.84 #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
syz-executor.5  D29272 32183   7799 0x00000004
Call Trace:
 context_switch kernel/sched/core.c:2826 [inline]
 __schedule+0x866/0x1dc0 kernel/sched/core.c:3515
 schedule+0x92/0x1c0 kernel/sched/core.c:3559
 __rwsem_down_write_failed_common kernel/locking/rwsem-xadd.c:589 [inline]
 rwsem_down_write_failed+0x774/0xc30 kernel/locking/rwsem-xadd.c:618
 call_rwsem_down_write_failed+0x17/0x30 arch/x86/lib/rwsem.S:117
 __down_write arch/x86/include/asm/rwsem.h:142 [inline]
 down_write_nested+0x57/0x90 kernel/locking/rwsem.c:194
 inode_lock_nested include/linux/fs.h:782 [inline]
 filename_create+0x17c/0x4f0 fs/namei.c:3635
 user_path_create fs/namei.c:3693 [inline]
 do_mknodat fs/namei.c:3754 [inline]
 do_mknodat+0x1a4/0x480 fs/namei.c:3742
 __do_sys_mknod fs/namei.c:3794 [inline]
 __se_sys_mknod fs/namei.c:3792 [inline]
 __x64_sys_mknod+0x7b/0xb0 fs/namei.c:3792
 do_syscall_64+0xfd/0x620 arch/x86/entry/common.c:293
 entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x45a639
Code: Bad RIP value.
RSP: 002b:00007fd5e4ef4c78 EFLAGS: 00000246 ORIG_RAX: 0000000000000085
RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 000000000045a639
RDX: 000000000000070a RSI: 0000000000000000 RDI: 0000000020000000
RBP: 000000000075c070 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 00007fd5e4ef56d4
R13: 00000000004c7033 R14: 00000000004dc780 R15: 00000000ffffffff

Showing all locks held in the system:
4 locks held by kworker/u4:3/328:
1 lock held by khungtaskd/1033:
 #0: 00000000ef514c08 (rcu_read_lock){....}, at: debug_show_all_locks+0x5f/0x27e kernel/locking/lockdep.c:4438
3 locks held by kworker/1:2/2708:
 #0: 000000006ae1a66c ((wq_completion)"events"){+.+.}, at: __write_once_size include/linux/compiler.h:220 [inline]
 #0: 000000006ae1a66c ((wq_completion)"events"){+.+.}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline]
 #0: 000000006ae1a66c ((wq_completion)"events"){+.+.}, at: atomic64_set include/asm-generic/atomic-instrumented.h:40 [inline]
 #0: 000000006ae1a66c ((wq_completion)"events"){+.+.}, at: atomic_long_set include/asm-generic/atomic-long.h:59 [inline]
 #0: 000000006ae1a66c ((wq_completion)"events"){+.+.}, at: set_work_data kernel/workqueue.c:617 [inline]
 #0: 000000006ae1a66c ((wq_completion)"events"){+.+.}, at: set_work_pool_and_clear_pending kernel/workqueue.c:644 [inline]
 #0: 000000006ae1a66c ((wq_completion)"events"){+.+.}, at: process_one_work+0x87e/0x1750 kernel/workqueue.c:2124
 #1: 00000000c4212bd5 ((linkwatch_work).work){+.+.}, at: process_one_work+0x8b4/0x1750 kernel/workqueue.c:2128
 #2: 00000000e1fbf2f1 (rtnl_mutex){+.+.}, at: rtnl_lock+0x17/0x20 net/core/rtnetlink.c:77
1 lock held by rsyslogd/7402:
 #0: 000000002d2031f2 (&f->f_pos_lock){+.+.}, at: __fdget_pos+0xee/0x110 fs/file.c:767
2 locks held by getty/7525:
 #0: 000000002d73d27b (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:362
 #1: 0000000057c87c8b (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1b30 drivers/tty/n_tty.c:2154
2 locks held by getty/7526:
 #0: 000000007c55bf3b (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:362
 #1: 00000000bfd1ee0e (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1b30 drivers/tty/n_tty.c:2154
2 locks held by getty/7527:
 #0: 00000000c54f9cc1 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:362
 #1: 00000000d75f2b1b (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1b30 drivers/tty/n_tty.c:2154
2 locks held by getty/7528:
 #0: 00000000c2b38ddf (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:362
 #1: 00000000d868bf25 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1b30 drivers/tty/n_tty.c:2154
2 locks held by getty/7529:
 #0: 0000000054564a89 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:362
 #1: 00000000a668bf61 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1b30 drivers/tty/n_tty.c:2154
2 locks held by getty/7530:
 #0: 00000000d04c9d02 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:362
 #1: 00000000e7f20317 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1b30 drivers/tty/n_tty.c:2154
2 locks held by getty/7531:
 #0: 0000000034977d40 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:362
 #1: 0000000031baa774 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1b30 drivers/tty/n_tty.c:2154
3 locks held by kworker/0:3/7580:
 #0: 000000006ae1a66c ((wq_completion)"events"){+.+.}, at: __write_once_size include/linux/compiler.h:220 [inline]
 #0: 000000006ae1a66c ((wq_completion)"events"){+.+.}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline]
 #0: 000000006ae1a66c ((wq_completion)"events"){+.+.}, at: atomic64_set include/asm-generic/atomic-instrumented.h:40 [inline]
 #0: 000000006ae1a66c ((wq_completion)"events"){+.+.}, at: atomic_long_set include/asm-generic/atomic-long.h:59 [inline]
 #0: 000000006ae1a66c ((wq_completion)"events"){+.+.}, at: set_work_data kernel/workqueue.c:617 [inline]
 #0: 000000006ae1a66c ((wq_completion)"events"){+.+.}, at: set_work_pool_and_clear_pending kernel/workqueue.c:644 [inline]
 #0: 000000006ae1a66c ((wq_completion)"events"){+.+.}, at: process_one_work+0x87e/0x1750 kernel/workqueue.c:2124
 #1: 000000009dd04984 (deferred_process_work){+.+.}, at: process_one_work+0x8b4/0x1750 kernel/workqueue.c:2128
 #2: 00000000e1fbf2f1 (rtnl_mutex){+.+.}, at: rtnl_lock+0x17/0x20 net/core/rtnetlink.c:77
2 locks held by syz-executor.3/10016:
 #0: 000000006ffe2068 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:362
 #1: 0000000025687a26 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1b30 drivers/tty/n_tty.c:2154
2 locks held by syz-executor.5/32166:
 #0: 000000001e94e721 (sb_writers#22){.+.+}, at: sb_start_write include/linux/fs.h:1578 [inline]
 #0: 000000001e94e721 (sb_writers#22){.+.+}, at: mnt_want_write+0x3f/0xc0 fs/namespace.c:360
 #1: 00000000732ae75b (&sb->s_type->i_mutex_key#29/1){+.+.}, at: inode_lock_nested include/linux/fs.h:782 [inline]
 #1: 00000000732ae75b (&sb->s_type->i_mutex_key#29/1){+.+.}, at: filename_create+0x17c/0x4f0 fs/namei.c:3635
2 locks held by syz-executor.5/32183:
 #0: 000000001e94e721 (sb_writers#22){.+.+}, at: sb_start_write include/linux/fs.h:1578 [inline]
 #0: 000000001e94e721 (sb_writers#22){.+.+}, at: mnt_want_write+0x3f/0xc0 fs/namespace.c:360
 #1: 00000000732ae75b (&sb->s_type->i_mutex_key#29/1){+.+.}, at: inode_lock_nested include/linux/fs.h:782 [inline]
 #1: 00000000732ae75b (&sb->s_type->i_mutex_key#29/1){+.+.}, at: filename_create+0x17c/0x4f0 fs/namei.c:3635

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

NMI backtrace for cpu 1
CPU: 1 PID: 1033 Comm: khungtaskd Not tainted 4.19.84 #0
kobject: 'batman_adv' (000000001053ff14): kobject_uevent_env
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
Call Trace:
kobject: 'batman_adv' (000000001053ff14): kobject_uevent_env: filter function caused the event to drop!
 __dump_stack lib/dump_stack.c:77 [inline]
 dump_stack+0x197/0x210 lib/dump_stack.c:118
 nmi_cpu_backtrace.cold+0x63/0xa4 lib/nmi_backtrace.c:101
kobject: 'batman_adv' (000000001053ff14): kobject_cleanup, parent           (null)
 nmi_trigger_cpumask_backtrace+0x1b0/0x1f8 lib/nmi_backtrace.c:62
kobject: 'batman_adv' (000000001053ff14): calling ktype release
 arch_trigger_cpumask_backtrace+0x14/0x20 arch/x86/kernel/apic/hw_nmi.c:38
kobject: (000000001053ff14): dynamic_kobj_release
 trigger_all_cpu_backtrace include/linux/nmi.h:146 [inline]
 check_hung_uninterruptible_tasks kernel/hung_task.c:203 [inline]
 watchdog+0x9df/0xee0 kernel/hung_task.c:287
 kthread+0x354/0x420 kernel/kthread.c:246
kobject: 'batman_adv': free name
 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:415
Sending NMI from CPU 1 to CPUs 0:
kobject: 'rx-0' (00000000c794e4b9): kobject_cleanup, parent 00000000df267ba5
NMI backtrace for cpu 0
CPU: 0 PID: 328 Comm: kworker/u4:3 Not tainted 4.19.84 #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
Workqueue: netns cleanup_net
RIP: 0010:__sanitizer_cov_trace_const_cmp1+0x0/0x20 kernel/kcov.c:173
Code: 5d c3 0f 1f 84 00 00 00 00 00 55 48 89 f2 48 89 fe bf 06 00 00 00 48 89 e5 48 8b 4d 08 e8 18 ff ff ff 5d c3 66 0f 1f 44 00 00 <55> 40 0f b6 d6 40 0f b6 f7 bf 01 00 00 00 48 89 e5 48 8b 4d 08 e8
RSP: 0018:ffff8880a979f318 EFLAGS: 00000046
RAX: ffff8880a906a2c0 RBX: 00000000fffffffe RCX: ffffffff86eec946
RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000000
RBP: ffff8880a979f448 R08: ffff8880a906a2c0 R09: fffffbfff1467455
R10: fffffbfff1467454 R11: ffffffff8a33a2a0 R12: 0000000000000000
R13: 0000000000000000 R14: 0000000000000002 R15: ffffffff8a33a2a3
FS:  0000000000000000(0000) GS:ffff8880ae800000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 000000c42b4b4a78 CR3: 00000000a1a05000 CR4: 00000000001406f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
 vsnprintf+0x26b/0x19a0 lib/vsprintf.c:2359
 sprintf+0xc0/0x100 lib/vsprintf.c:2495
 print_time kernel/printk/printk.c:1229 [inline]
 print_prefix+0x386/0x3f0 kernel/printk/printk.c:1252
 msg_print_text+0xc9/0x1c0 kernel/printk/printk.c:1279
 console_unlock+0x392/0x10b0 kernel/printk/printk.c:2384
 vprintk_emit+0x238/0x690 kernel/printk/printk.c:1927
 vprintk_default+0x28/0x30 kernel/printk/printk.c:1968
 vprintk_func+0x7e/0x189 kernel/printk/printk_safe.c:398
 printk+0xba/0xed kernel/printk/printk.c:2001
 kobject_cleanup lib/kobject.c:638 [inline]
 kobject_release lib/kobject.c:691 [inline]
 kref_put include/linux/kref.h:70 [inline]
 kobject_put.cold+0x88/0x2e6 lib/kobject.c:708
 net_rx_queue_update_kobjects+0x361/0x480 net/core/net-sysfs.c:979
 remove_queue_kobjects net/core/net-sysfs.c:1567 [inline]
 netdev_unregister_kobject+0x155/0x1f0 net/core/net-sysfs.c:1718
 rollback_registered_many+0x6bb/0xda0 net/core/dev.c:8029
 unregister_netdevice_many.part.0+0x1b/0x1f0 net/core/dev.c:9115
 unregister_netdevice_many net/core/dev.c:9114 [inline]
 default_device_exit_batch+0x34e/0x410 net/core/dev.c:9586
 ops_exit_list.isra.0+0xfc/0x150 net/core/net_namespace.c:156
 cleanup_net+0x404/0x970 net/core/net_namespace.c:553
 process_one_work+0x989/0x1750 kernel/workqueue.c:2153
 worker_thread+0x98/0xe40 kernel/workqueue.c:2296
 kthread+0x354/0x420 kernel/kthread.c:246
 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:415

Crashes (6):
Manager Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Title
ci2-linux-4-19 2019/11/18 23:02 linux-4.19.y c555efaf1402 d5696d51 .config log report
ci2-linux-4-19 2019/11/17 04:36 linux-4.19.y c555efaf1402 cdac920b .config log report
ci2-linux-4-19 2019/11/11 10:29 linux-4.19.y 5ee93551c703 dc438b91 .config log report
ci2-linux-4-19 2019/09/23 12:46 linux-4.19.y d573e8a79f70 d96e88f3 .config log report
ci2-linux-4-19 2019/09/20 08:06 linux-4.19.y dbc29aff8d04 4d3ae0b7 .config log report
ci2-linux-4-19 2019/08/11 15:31 linux-4.19.y 893af1c79e42 acb51638 .config log report