syz-executor0(13960): getblk(): executed=9 bh_count=0 bh_state=0 syz-executor0(13976): getblk(): executed=9 bh_count=0 bh_state=0 syz-executor0(13960): getblk(): executed=9 bh_count=0 bh_state=0 syz-executor0(13976): getblk(): executed=9 bh_count=0 bh_state=0 syz-executor0(13960): getblk(): executed=9 bh_count=0 bh_state=0 INFO: task syz-executor0:13971 blocked for more than 140 seconds. Not tainted 4.20.0-rc1-next-20181109+ #110 syz-executor0(13976): getblk(): executed=9 bh_count=0 bh_state=0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor0 D12872 13971 6051 0x00000004 Call Trace: context_switch kernel/sched/core.c:2831 [inline] __schedule+0x8cf/0x21d0 kernel/sched/core.c:3472 schedule+0xef/0x370 kernel/sched/core.c:3516 schedule_preempt_disabled+0x13/0x20 kernel/sched/core.c:3574 __mutex_lock_common kernel/locking/mutex.c:1002 [inline] __mutex_lock+0xaff/0x16f0 kernel/locking/mutex.c:1072 mutex_lock_nested+0x16/0x20 kernel/locking/mutex.c:1087 __fdget_pos+0x1bb/0x200 fs/file.c:766 fdget_pos include/linux/file.h:70 [inline] ksys_write+0x7f/0x260 fs/read_write.c:593 __do_sys_write fs/read_write.c:610 [inline] __se_sys_write fs/read_write.c:607 [inline] __x64_sys_write+0x73/0xb0 fs/read_write.c:607 do_syscall_64+0x1b9/0x820 arch/x86/entry/common.c:290 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x457569 Code: fd b3 fb ff c3 66 2e 0f 1f 84 00 00 00 00 00 66 90 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 0f 83 cb b3 fb ff c3 66 2e 0f 1f 84 00 00 00 00 RSP: 002b:00007fb31d028c78 EFLAGS: 00000246 ORIG_RAX: 0000000000000001 RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 0000000000457569 RDX: 00000000fffffd97 RSI: 0000000020000180 RDI: 0000000000000007 RBP: 000000000072bfa0 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00007fb31d0296d4 R13: 00000000004c5cf1 R14: 00000000004da0a8 R15: 00000000ffffffff INFO: task syz-executor0:14001 blocked for more than 140 seconds. Not tainted 4.20.0-rc1-next-20181109+ #110 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor0 D18440 14001 6051 0x00000004 Call Trace: context_switch kernel/sched/core.c:2831 [inline] __schedule+0x8cf/0x21d0 kernel/sched/core.c:3472 schedule+0xef/0x370 kernel/sched/core.c:3516 __rwsem_down_write_failed_common+0xc9a/0x15e0 kernel/locking/rwsem-xadd.c:577 rwsem_down_write_failed+0xe/0x10 kernel/locking/rwsem-xadd.c:606 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+0xa5/0x130 kernel/locking/rwsem.c:72 inode_lock include/linux/fs.h:764 [inline] do_last fs/namei.c:3321 [inline] path_openat+0x15c4/0x5150 fs/namei.c:3534 do_filp_open+0x255/0x380 fs/namei.c:3564 do_sys_open+0x568/0x700 fs/open.c:1063 ksys_open include/linux/syscalls.h:1292 [inline] __do_sys_creat fs/open.c:1121 [inline] __se_sys_creat fs/open.c:1119 [inline] __x64_sys_creat+0x61/0x80 fs/open.c:1119 do_syscall_64+0x1b9/0x820 arch/x86/entry/common.c:290 entry_SYSCALL_64_after_hwframe+0x49/0xbe syz-executor0(13960): getblk(): executed=9 bh_count=0 bh_state=0 RIP: 0033:0x457569 Code: Bad RIP value. RSP: 002b:00007fb31cfe6c78 EFLAGS: 00000246 ORIG_RAX: 0000000000000055 RAX: ffffffffffffffda RBX: 0000000000000002 RCX: 0000000000457569 RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000020000180 RBP: 000000000072c0e0 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00007fb31cfe76d4 R13: 00000000004bdbef R14: 00000000004cd070 R15: 00000000ffffffff INFO: task syz-executor0:14020 blocked for more than 140 seconds. Not tainted 4.20.0-rc1-next-20181109+ #110 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor0 D15320 14020 6051 0x00000004 Call Trace: context_switch kernel/sched/core.c:2831 [inline] __schedule+0x8cf/0x21d0 kernel/sched/core.c:3472 schedule+0xef/0x370 kernel/sched/core.c:3516 __rwsem_down_write_failed_common+0xc9a/0x15e0 kernel/locking/rwsem-xadd.c:577 syz-executor0(13976): getblk(): executed=9 bh_count=0 bh_state=0 rwsem_down_write_failed+0xe/0x10 kernel/locking/rwsem-xadd.c:606 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+0xa9/0x130 kernel/locking/rwsem.c:195 inode_lock_nested include/linux/fs.h:799 [inline] filename_create+0x1b2/0x5b0 fs/namei.c:3635 user_path_create fs/namei.c:3693 [inline] do_mknodat+0x1c2/0x530 fs/namei.c:3755 __do_sys_mknod fs/namei.c:3795 [inline] __se_sys_mknod fs/namei.c:3793 [inline] __x64_sys_mknod+0x7b/0xb0 fs/namei.c:3793 do_syscall_64+0x1b9/0x820 arch/x86/entry/common.c:290 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x457569 Code: fd b3 fb ff c3 66 2e 0f 1f 84 00 00 00 00 00 66 90 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 0f 83 cb b3 fb ff c3 66 2e 0f 1f 84 00 00 00 00 RSP: 002b:00007fb31cfc5c78 EFLAGS: 00000246 ORIG_RAX: 0000000000000085 RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 0000000000457569 RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000020000340 RBP: 000000000072c180 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00007fb31cfc66d4 R13: 00000000004c2b2e R14: 00000000004d4798 R15: 00000000ffffffff INFO: task syz-executor0:14024 blocked for more than 140 seconds. Not tainted 4.20.0-rc1-next-20181109+ #110 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor0 D25280 14024 6051 0x00000004 Call Trace: context_switch kernel/sched/core.c:2831 [inline] __schedule+0x8cf/0x21d0 kernel/sched/core.c:3472 schedule+0xef/0x370 kernel/sched/core.c:3516 __rwsem_down_read_failed_common kernel/locking/rwsem-xadd.c:280 [inline] rwsem_down_read_failed+0x371/0x710 kernel/locking/rwsem-xadd.c:297 call_rwsem_down_read_failed+0x18/0x30 arch/x86/lib/rwsem.S:94 __down_read arch/x86/include/asm/rwsem.h:83 [inline] down_read+0x9b/0x120 kernel/locking/rwsem.c:26 inode_lock_shared include/linux/fs.h:774 [inline] do_last fs/namei.c:3323 [inline] path_openat+0x2444/0x5150 fs/namei.c:3534 do_filp_open+0x255/0x380 fs/namei.c:3564 do_sys_open+0x568/0x700 fs/open.c:1063 __do_sys_openat fs/open.c:1090 [inline] __se_sys_openat fs/open.c:1084 [inline] __x64_sys_openat+0x9d/0x100 fs/open.c:1084 do_syscall_64+0x1b9/0x820 arch/x86/entry/common.c:290 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x457569 Code: fd b3 fb ff c3 66 2e 0f 1f 84 00 00 00 00 00 66 90 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 0f 83 cb b3 fb ff c3 66 2e 0f 1f 84 00 00 00 00 RSP: 002b:00007fb31cf83c78 EFLAGS: 00000246 ORIG_RAX: 0000000000000101 RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 0000000000457569 RDX: 0000000000000002 RSI: 0000000020000200 RDI: 0000000000000010 RBP: 000000000072c2c0 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00007fb31cf846d4 R13: 00000000004c2e2f R14: 00000000004d4d98 R15: 00000000ffffffff Showing all locks held in the system: 1 lock held by khungtaskd/1010: #0: 000000009cb1014a (rcu_read_lock){....}, at: debug_show_all_locks+0xd0/0x424 kernel/locking/lockdep.c:4379 1 lock held by rsyslogd/5924: #0: 00000000d6ded2a7 (&f->f_pos_lock){+.+.}, at: __fdget_pos+0x1bb/0x200 fs/file.c:766 2 locks held by getty/6014: #0: 00000000f821d1fc (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 #1: 000000002859de75 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1e80 drivers/tty/n_tty.c:2154 2 locks held by getty/6015: #0: 000000003a293b33 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 #1: 000000003a9e3bee (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1e80 drivers/tty/n_tty.c:2154 2 locks held by getty/6016: #0: 000000002ae0a95f (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 #1: 000000006ab6ae1e (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1e80 drivers/tty/n_tty.c:2154 2 locks held by getty/6017: #0: 00000000c6682874 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 #1: 00000000f7d7ea03 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1e80 drivers/tty/n_tty.c:2154 2 locks held by getty/6018: #0: 00000000b69926c6 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 #1: 00000000a1c2990c (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1e80 drivers/tty/n_tty.c:2154 2 locks held by getty/6019: #0: 00000000ec3eef43 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 #1: 0000000089cc27d2 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1e80 drivers/tty/n_tty.c:2154 2 locks held by getty/6020: #0: 000000008c07a272 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 #1: 00000000cbce3a64 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1e80 drivers/tty/n_tty.c:2154 syz-executor0(13960): getblk(): executed=9 bh_count=0 bh_state=0 1 lock held by syz-executor2/10336: 2 locks held by syz-executor5/11417: #0: 0000000033bcfc1f (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 #1: 00000000f1cb4c70 (&tty->atomic_write_lock){+.+.}, at: tty_write_lock+0x23/0x90 drivers/tty/tty_io.c:885 2 locks held by syz-executor3/11602: #0: 0000000002436ddc (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 #1: 00000000548272b5 (&tty->atomic_write_lock){+.+.}, at: tty_write_lock+0x23/0x90 drivers/tty/tty_io.c:885 4 locks held by syz-executor0/13960: 1 lock held by syz-executor0/13971: #0: 000000007a61659a (&f->f_pos_lock){+.+.}, at: __fdget_pos+0x1bb/0x200 fs/file.c:766 3 locks held by syz-executor0/13976: 2 locks held by syz-executor0/14001: #0: 00000000fc414f1a (sb_writers#19){.+.+}, at: sb_start_write include/linux/fs.h:1607 [inline] #0: 00000000fc414f1a (sb_writers#19){.+.+}, at: mnt_want_write+0x3f/0xc0 fs/namespace.c:359 #1: 00000000d9f3cfb0 (&sb->s_type->i_mutex_key#27){++++}, at: inode_lock include/linux/fs.h:764 [inline] #1: 00000000d9f3cfb0 (&sb->s_type->i_mutex_key#27){++++}, at: do_last fs/namei.c:3321 [inline] #1: 00000000d9f3cfb0 (&sb->s_type->i_mutex_key#27){++++}, at: path_openat+0x15c4/0x5150 fs/namei.c:3534 2 locks held by syz-executor0/14020: #0: 00000000fc414f1a (sb_writers#19){.+.+}, at: sb_start_write include/linux/fs.h:1607 [inline] #0: 00000000fc414f1a (sb_writers#19){.+.+}, at: mnt_want_write+0x3f/0xc0 fs/namespace.c:359 #1: 00000000d9f3cfb0 (&sb->s_type->i_mutex_key#26/1){+.+.}, at: inode_lock_nested include/linux/fs.h:799 [inline] #1: 00000000d9f3cfb0 (&sb->s_type->i_mutex_key#26/1){+.+.}, at: filename_create+0x1b2/0x5b0 fs/namei.c:3635 2 locks held by syz-executor0/14024: #0: 00000000fc414f1a (sb_writers#19){.+.+}, at: sb_start_write include/linux/fs.h:1607 [inline] #0: 00000000fc414f1a (sb_writers#19){.+.+}, at: mnt_want_write+0x3f/0xc0 fs/namespace.c:359 #1: 00000000d9f3cfb0 (&sb->s_type->i_mutex_key#27){++++}, at: inode_lock_shared include/linux/fs.h:774 [inline] #1: 00000000d9f3cfb0 (&sb->s_type->i_mutex_key#27){++++}, at: do_last fs/namei.c:3323 [inline] #1: 00000000d9f3cfb0 (&sb->s_type->i_mutex_key#27){++++}, at: path_openat+0x2444/0x5150 fs/namei.c:3534 ============================================= NMI backtrace for cpu 1 CPU: 1 PID: 1010 Comm: khungtaskd Not tainted 4.20.0-rc1-next-20181109+ #110 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+0x244/0x39d lib/dump_stack.c:113 nmi_cpu_backtrace.cold.2+0x5c/0xa1 lib/nmi_backtrace.c:101 nmi_trigger_cpumask_backtrace+0x1e8/0x22a 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:144 [inline] check_hung_uninterruptible_tasks kernel/hung_task.c:205 [inline] watchdog+0xb4c/0x1060 kernel/hung_task.c:289 kthread+0x35a/0x440 kernel/kthread.c:246 ret_from_fork+0x3a/0x50 arch/x86/entry/entry_64.S:352 Sending NMI from CPU 1 to CPUs 0: INFO: NMI handler (nmi_cpu_backtrace_handler) took too long to run: 1.618 msecs NMI backtrace for cpu 0 CPU: 0 PID: 13960 Comm: syz-executor0 Not tainted 4.20.0-rc1-next-20181109+ #110 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 RIP: 0010:__read_once_size include/linux/compiler.h:182 [inline] RIP: 0010:__sanitizer_cov_trace_pc+0x3b/0x50 kernel/kcov.c:106 Code: 65 8b 15 08 45 82 7e 81 e2 00 01 1f 00 75 2b 8b 90 d8 12 00 00 83 fa 02 75 20 48 8b 88 e0 12 00 00 8b 80 dc 12 00 00 48 8b 11 <48> 83 c2 01 48 39 d0 76 07 48 89 34 d1 48 89 11 5d c3 0f 1f 00 55 RSP: 0018:ffff880180b4ea48 EFLAGS: 00000246 RAX: 0000000000040000 RBX: ffff88017388d3f0 RCX: ffffc90005ddd000 RDX: 000000000003ffff RSI: ffffffff81e12d25 RDI: ffff8801b16ec008 RBP: ffff880180b4ea48 R08: ffff88018320c200 R09: ffffed003b5c5b67 R10: 0000000000000005 R11: ffff8801dae2db3b R12: dffffc0000000000 R13: 0000000000000007 R14: 0000000000000001 R15: 0000000000000020 FS: 00007fb31d04a700(0000) GS:ffff8801dae00000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: ffffffffff600400 CR3: 00000001bbb1d000 CR4: 00000000001426f0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: constant_test_bit arch/x86/include/asm/bitops.h:325 [inline] buffer_mapped include/linux/buffer_head.h:126 [inline] init_page_buffers+0x2b5/0x570 fs/buffer.c:901 grow_dev_page fs/buffer.c:954 [inline] grow_buffers fs/buffer.c:1029 [inline] __getblk_slow fs/buffer.c:1062 [inline] __getblk_gfp+0xcfb/0x1030 fs/buffer.c:1351 __bread_gfp+0x2d/0x310 fs/buffer.c:1385 sb_bread include/linux/buffer_head.h:307 [inline] fat_ent_bread+0x173/0x290 fs/fat/fatent.c:107 fat_ent_read_block fs/fat/fatent.c:442 [inline] fat_alloc_clusters+0x8db/0x16f0 fs/fat/fatent.c:490 fat_add_cluster+0x84/0x160 fs/fat/inode.c:101 __fat_get_block fs/fat/inode.c:148 [inline] fat_get_block+0x385/0xb30 fs/fat/inode.c:183 __block_write_begin_int+0x5ef/0x1d90 fs/buffer.c:1997 __block_write_begin fs/buffer.c:2047 [inline] block_write_begin+0xda/0x370 fs/buffer.c:2106 cont_write_begin+0x5ba/0x920 fs/buffer.c:2459 fat_write_begin+0x8d/0x120 fs/fat/inode.c:229 generic_perform_write+0x3aa/0x6a0 mm/filemap.c:3140 __generic_file_write_iter+0x26e/0x630 mm/filemap.c:3265 generic_file_write_iter+0x34d/0x6b0 mm/filemap.c:3293 call_write_iter include/linux/fs.h:1867 [inline] new_sync_write fs/read_write.c:474 [inline] __vfs_write+0x6b8/0x9f0 fs/read_write.c:487 vfs_write+0x1fc/0x560 fs/read_write.c:549 ksys_write+0x101/0x260 fs/read_write.c:598 __do_sys_write fs/read_write.c:610 [inline] __se_sys_write fs/read_write.c:607 [inline] __x64_sys_write+0x73/0xb0 fs/read_write.c:607 do_syscall_64+0x1b9/0x820 arch/x86/entry/common.c:290 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x457569 Code: fd b3 fb ff c3 66 2e 0f 1f 84 00 00 00 00 00 66 90 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 0f 83 cb b3 fb ff c3 66 2e 0f 1f 84 00 00 00 00 RSP: 002b:00007fb31d049c78 EFLAGS: 00000246 ORIG_RAX: 0000000000000001 RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 0000000000457569 RDX: 00000000fffffd97 RSI: 0000000020000180 RDI: 0000000000000007 RBP: 000000000072bf00 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00007fb31d04a6d4 R13: 00000000004c5cf1 R14: 00000000004da0a8 R15: 00000000ffffffff