syz-executor0(10105): getblk(): executed=9 bh_count=0 bh_state=0 syz-executor0(10105): getblk(): executed=9 bh_count=0 bh_state=0 syz-executor0(10105): getblk(): executed=9 bh_count=0 bh_state=0 syz-executor0(10105): getblk(): executed=9 bh_count=0 bh_state=0 syz-executor0(10105): getblk(): executed=9 bh_count=0 bh_state=0 INFO: task syz-executor0:10107 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 D24872 10107 6045 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 d_wait_lookup fs/dcache.c:2408 [inline] d_alloc_parallel+0x1478/0x1f40 fs/dcache.c:2490 lookup_open+0x560/0x1b90 fs/namei.c:3147 do_last fs/namei.c:3324 [inline] path_openat+0x2464/0x5150 fs/namei.c:3534 syz-executor0(10105): getblk(): executed=9 bh_count=0 bh_state=0 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: Bad RIP value. RSP: 002b:00007ff8b8298c78 EFLAGS: 00000246 ORIG_RAX: 0000000000000101 RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 0000000000457569 RDX: 0000000000000002 RSI: 0000000020000200 RDI: 0000000000000004 RBP: 000000000072bfa0 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00007ff8b82996d4 R13: 00000000004c2e2f R14: 00000000004d4d98 R15: 00000000ffffffff INFO: task syz-executor0:10190 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 D22992 10190 6045 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 d_wait_lookup fs/dcache.c:2408 [inline] d_alloc_parallel+0x1478/0x1f40 fs/dcache.c:2490 lookup_open+0x560/0x1b90 fs/namei.c:3147 do_last fs/namei.c:3324 [inline] path_openat+0x2464/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: Bad RIP value. RSP: 002b:00007ff8b8256c78 EFLAGS: 00000246 ORIG_RAX: 0000000000000101 RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 0000000000457569 RDX: 0000000000000002 RSI: 0000000020000080 RDI: 0000000000000004 RBP: 000000000072c0e0 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00007ff8b82576d4 R13: 00000000004c2e2f R14: 00000000004d4d98 R15: 00000000ffffffff INFO: task syz-executor0:10192 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 D25656 10192 6045 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 d_wait_lookup fs/dcache.c:2408 [inline] d_alloc_parallel+0x1478/0x1f40 fs/dcache.c:2490 lookup_open+0x560/0x1b90 fs/namei.c:3147 do_last fs/namei.c:3324 [inline] path_openat+0x2464/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: Bad RIP value. RSP: 002b:00007ff8b8235c78 EFLAGS: 00000246 ORIG_RAX: 0000000000000101 RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 0000000000457569 RDX: 0000000000000002 RSI: 0000000020000200 RDI: 0000000000000007 RBP: 000000000072c180 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00007ff8b82366d4 R13: 00000000004c2e2f R14: 00000000004d4d98 R15: 00000000ffffffff Showing all locks held in the system: 2 locks held by kworker/0:0/5: #0: 00000000f501a945 ((wq_completion)"events"){+.+.}, at: __write_once_size include/linux/compiler.h:209 [inline] #0: 00000000f501a945 ((wq_completion)"events"){+.+.}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline] #0: 00000000f501a945 ((wq_completion)"events"){+.+.}, at: atomic64_set include/asm-generic/atomic-instrumented.h:855 [inline] #0: 00000000f501a945 ((wq_completion)"events"){+.+.}, at: atomic_long_set include/asm-generic/atomic-long.h:40 [inline] #0: 00000000f501a945 ((wq_completion)"events"){+.+.}, at: set_work_data kernel/workqueue.c:617 [inline] #0: 00000000f501a945 ((wq_completion)"events"){+.+.}, at: set_work_pool_and_clear_pending kernel/workqueue.c:644 [inline] #0: 00000000f501a945 ((wq_completion)"events"){+.+.}, at: process_one_work+0xb43/0x1c40 kernel/workqueue.c:2124 #1: 00000000c6693dd8 ((work_completion)(&smc->tcp_listen_work)){+.+.}, at: process_one_work+0xb9a/0x1c40 kernel/workqueue.c:2128 2 locks held by kworker/1:1/22: #0: 00000000f501a945 ((wq_completion)"events"){+.+.}, at: __write_once_size include/linux/compiler.h:209 [inline] #0: 00000000f501a945 ((wq_completion)"events"){+.+.}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline] #0: 00000000f501a945 ((wq_completion)"events"){+.+.}, at: atomic64_set include/asm-generic/atomic-instrumented.h:855 [inline] #0: 00000000f501a945 ((wq_completion)"events"){+.+.}, at: atomic_long_set include/asm-generic/atomic-long.h:40 [inline] #0: 00000000f501a945 ((wq_completion)"events"){+.+.}, at: set_work_data kernel/workqueue.c:617 [inline] #0: 00000000f501a945 ((wq_completion)"events"){+.+.}, at: set_work_pool_and_clear_pending kernel/workqueue.c:644 [inline] #0: 00000000f501a945 ((wq_completion)"events"){+.+.}, at: process_one_work+0xb43/0x1c40 kernel/workqueue.c:2124 #1: 000000008ece2124 ((work_completion)(&smc->tcp_listen_work)){+.+.}, at: process_one_work+0xb9a/0x1c40 kernel/workqueue.c:2128 1 lock held by khungtaskd/1010: #0: 00000000feb6f2e6 (rcu_read_lock){....}, at: debug_show_all_locks+0xd0/0x424 kernel/locking/lockdep.c:4379 1 lock held by rsyslogd/5917: #0: 00000000b94e42c2 (&f->f_pos_lock){+.+.}, at: __fdget_pos+0x1bb/0x200 fs/file.c:766 2 locks held by getty/6008: #0: 0000000023df7abe (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 #1: 0000000010de2486 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1e80 drivers/tty/n_tty.c:2154 2 locks held by getty/6009: #0: 00000000f467d2d2 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 #1: 000000000d3f3565 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1e80 drivers/tty/n_tty.c:2154 2 locks held by getty/6010: #0: 00000000ab5ffed3 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 #1: 00000000d6f27c96 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1e80 drivers/tty/n_tty.c:2154 2 locks held by getty/6011: #0: 000000001f9f004d (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 #1: 000000009c3ef42e (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1e80 drivers/tty/n_tty.c:2154 2 locks held by getty/6012: #0: 0000000044de1d4f (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 #1: 000000009007f14e (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1e80 drivers/tty/n_tty.c:2154 2 locks held by getty/6013: #0: 00000000df65fffe (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 #1: 00000000140c08bb (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1e80 drivers/tty/n_tty.c:2154 2 locks held by getty/6014: #0: 00000000a312bb18 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x32/0x40 drivers/tty/tty_ldsem.c:353 #1: 000000009621398e (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1e80 drivers/tty/n_tty.c:2154 1 lock held by syz-executor5/9812: #0: 0000000069d8beb5 (&sig->cred_guard_mutex){+.+.}, at: prepare_bprm_creds+0x53/0x120 fs/exec.c:1404 3 locks held by syz-executor0/10105: 2 locks held by syz-executor0/10107: #0: 000000003504a0fa (sb_writers#18){.+.+}, at: sb_start_write include/linux/fs.h:1607 [inline] #0: 000000003504a0fa (sb_writers#18){.+.+}, at: mnt_want_write+0x3f/0xc0 fs/namespace.c:359 #1: 0000000080b11440 (&sb->s_type->i_mutex_key#25){.+.+}, at: inode_lock_shared include/linux/fs.h:774 [inline] #1: 0000000080b11440 (&sb->s_type->i_mutex_key#25){.+.+}, at: do_last fs/namei.c:3323 [inline] #1: 0000000080b11440 (&sb->s_type->i_mutex_key#25){.+.+}, at: path_openat+0x2444/0x5150 fs/namei.c:3534 2 locks held by syz-executor0/10190: #0: 000000003504a0fa (sb_writers#18){.+.+}, at: sb_start_write include/linux/fs.h:1607 [inline] #0: 000000003504a0fa (sb_writers#18){.+.+}, at: mnt_want_write+0x3f/0xc0 fs/namespace.c:359 #1: 0000000080b11440 (&sb->s_type->i_mutex_key#25){.+.+}, at: inode_lock_shared include/linux/fs.h:774 [inline] #1: 0000000080b11440 (&sb->s_type->i_mutex_key#25){.+.+}, at: do_last fs/namei.c:3323 [inline] #1: 0000000080b11440 (&sb->s_type->i_mutex_key#25){.+.+}, at: path_openat+0x2444/0x5150 fs/namei.c:3534 2 locks held by syz-executor0/10192: #0: 000000003504a0fa (sb_writers#18){.+.+}, at: sb_start_write include/linux/fs.h:1607 [inline] #0: 000000003504a0fa (sb_writers#18){.+.+}, at: mnt_want_write+0x3f/0xc0 fs/namespace.c:359 #1: 0000000080b11440 (&sb->s_type->i_mutex_key#25){.+.+}, at: inode_lock_shared include/linux/fs.h:774 [inline] #1: 0000000080b11440 (&sb->s_type->i_mutex_key#25){.+.+}, at: do_last fs/namei.c:3323 [inline] #1: 0000000080b11440 (&sb->s_type->i_mutex_key#25){.+.+}, at: path_openat+0x2444/0x5150 fs/namei.c:3534 ============================================= NMI backtrace for cpu 0 CPU: 0 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 0 to CPUs 1: NMI backtrace for cpu 1 CPU: 1 PID: 10105 Comm: syz-executor0 Not tainted 4.20.0-rc1-next-20181109+ #110 INFO: NMI handler (nmi_cpu_backtrace_handler) took too long to run: 1.890 msecs Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 RIP: 0010:__lock_is_held+0x67/0x140 kernel/locking/lockdep.c:3661 Code: 04 02 89 75 c4 84 c0 74 08 3c 03 0f 8e c7 00 00 00 4c 8b 6d c8 45 31 ff 48 b8 00 00 00 00 00 fc ff df 4d 8d b4 24 80 08 00 00 <49> c1 ed 03 49 01 c5 41 8b 84 24 78 08 00 00 85 c0 7f 24 e9 85 00 RSP: 0018:ffff880182796390 EFLAGS: 00000046 RAX: dffffc0000000000 RBX: 0000000000000282 RCX: 0000000000000000 RDX: 1ffff100305dc9af RSI: 00000000ffffffff RDI: ffffffff8959b980 RBP: ffff8801827963d0 R08: ffff880182ee4500 R09: ffffed003b5e5b67 R10: ffffed003b5e5b67 R11: ffff8801daf2db3b R12: ffff880182ee4500 R13: ffff880182ee4d78 R14: ffff880182ee4d80 R15: 0000000000000000 FS: 00007ff8b82ba700(0000) GS:ffff8801daf00000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: ffffffffff600400 CR3: 00000001ccdef000 CR4: 00000000001406e0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: lock_is_held_type+0x118/0x210 kernel/locking/lockdep.c:3882 lock_is_held include/linux/lockdep.h:339 [inline] rcu_read_lock_held+0xa9/0xc0 kernel/rcu/update.c:281 xa_entry include/linux/xarray.h:848 [inline] xas_descend+0x413/0x510 lib/xarray.c:198 xas_load+0x145/0x1e0 lib/xarray.c:234 find_get_entry+0x3ca/0x1120 mm/filemap.c:1415 pagecache_get_page+0x12f/0xf00 mm/filemap.c:1518 find_get_page_flags include/linux/pagemap.h:278 [inline] __find_get_block_slow fs/buffer.c:205 [inline] __find_get_block+0x635/0xf10 fs/buffer.c:1325 __getblk_slow fs/buffer.c:1058 [inline] __getblk_gfp+0x3d3/0x1030 fs/buffer.c:1351 __bread_gfp+0x2d/0x310 fs/buffer.c:1385 sb_bread include/linux/buffer_head.h:307 [inline] fat__get_entry+0x5a6/0xa40 fs/fat/dir.c:101 fat_get_entry fs/fat/dir.c:129 [inline] fat_search_long+0x33b/0x1570 fs/fat/dir.c:479 vfat_find+0x16d/0x1a0 fs/fat/namei_vfat.c:697 vfat_lookup+0x107/0x640 fs/fat/namei_vfat.c:711 lookup_open+0x72e/0x1b90 fs/namei.c:3213 do_last fs/namei.c:3324 [inline] path_openat+0x2464/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:00007ff8b82b9c78 EFLAGS: 00000246 ORIG_RAX: 0000000000000101 RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 0000000000457569 RDX: 0000000000000002 RSI: 0000000020000080 RDI: 0000000000000004 RBP: 000000000072bf00 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00007ff8b82ba6d4 R13: 00000000004c2e2f R14: 00000000004d4d98 R15: 00000000ffffffff