INFO: task syz-executor.5:23216 can't die for more than 143 seconds. syz-executor.5 D28128 23216 8899 0x00004004 Call Trace: context_switch kernel/sched/core.c:3384 [inline] __schedule+0x828/0x1c20 kernel/sched/core.c:4065 schedule+0xd9/0x260 kernel/sched/core.c:4132 schedule_preempt_disabled+0x13/0x20 kernel/sched/core.c:4191 __mutex_lock_common kernel/locking/mutex.c:1033 [inline] __mutex_lock+0x7b0/0x13c0 kernel/locking/mutex.c:1103 mutex_lock_nested+0x16/0x20 kernel/locking/mutex.c:1118 pipe_lock_nested fs/pipe.c:63 [inline] pipe_lock fs/pipe.c:71 [inline] pipe_wait+0x1ce/0x1f0 fs/pipe.c:119 pipe_write+0x5fa/0xf40 fs/pipe.c:497 call_write_iter include/linux/fs.h:1902 [inline] new_sync_write+0x4d3/0x770 fs/read_write.c:483 __vfs_write+0xe1/0x110 fs/read_write.c:496 vfs_write+0x268/0x5d0 fs/read_write.c:558 ksys_write+0x14f/0x290 fs/read_write.c:611 __do_sys_write fs/read_write.c:623 [inline] __se_sys_write fs/read_write.c:620 [inline] __x64_sys_write+0x73/0xb0 fs/read_write.c:620 do_syscall_64+0xfa/0x760 arch/x86/entry/common.c:290 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x4598e9 Code: Bad RIP value. RSP: 002b:00007f91000aec78 EFLAGS: 00000246 ORIG_RAX: 0000000000000001 RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 00000000004598e9 RDX: 00000000fffffc8f RSI: 0000000020000140 RDI: 0000000000000009 RBP: 000000000075bf20 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00007f91000af6d4 R13: 00000000004c9a0d R14: 00000000004e10e8 R15: 00000000ffffffff INFO: task syz-executor.5:23216 blocked for more than 143 seconds. Not tainted 5.3.0-next-20190918 #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.5 D28128 23216 8899 0x00004004 Call Trace: context_switch kernel/sched/core.c:3384 [inline] __schedule+0x828/0x1c20 kernel/sched/core.c:4065 schedule+0xd9/0x260 kernel/sched/core.c:4132 schedule_preempt_disabled+0x13/0x20 kernel/sched/core.c:4191 __mutex_lock_common kernel/locking/mutex.c:1033 [inline] __mutex_lock+0x7b0/0x13c0 kernel/locking/mutex.c:1103 mutex_lock_nested+0x16/0x20 kernel/locking/mutex.c:1118 pipe_lock_nested fs/pipe.c:63 [inline] pipe_lock fs/pipe.c:71 [inline] pipe_wait+0x1ce/0x1f0 fs/pipe.c:119 pipe_write+0x5fa/0xf40 fs/pipe.c:497 call_write_iter include/linux/fs.h:1902 [inline] new_sync_write+0x4d3/0x770 fs/read_write.c:483 __vfs_write+0xe1/0x110 fs/read_write.c:496 vfs_write+0x268/0x5d0 fs/read_write.c:558 ksys_write+0x14f/0x290 fs/read_write.c:611 __do_sys_write fs/read_write.c:623 [inline] __se_sys_write fs/read_write.c:620 [inline] __x64_sys_write+0x73/0xb0 fs/read_write.c:620 do_syscall_64+0xfa/0x760 arch/x86/entry/common.c:290 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x4598e9 Code: Bad RIP value. RSP: 002b:00007f91000aec78 EFLAGS: 00000246 ORIG_RAX: 0000000000000001 RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 00000000004598e9 RDX: 00000000fffffc8f RSI: 0000000020000140 RDI: 0000000000000009 RBP: 000000000075bf20 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00007f91000af6d4 R13: 00000000004c9a0d R14: 00000000004e10e8 R15: 00000000ffffffff INFO: task syz-executor.5:23220 can't die for more than 144 seconds. syz-executor.5 R running task 25208 23220 8899 0x00004006 Call Trace: INFO: task syz-executor.5:23223 can't die for more than 144 seconds. syz-executor.5 D28544 23223 8899 0x00000004 Call Trace: context_switch kernel/sched/core.c:3384 [inline] __schedule+0x828/0x1c20 kernel/sched/core.c:4065 schedule+0xd9/0x260 kernel/sched/core.c:4132 rwsem_down_write_slowpath+0x70b/0xf90 kernel/locking/rwsem.c:1238 __down_write kernel/locking/rwsem.c:1392 [inline] down_write+0x13c/0x150 kernel/locking/rwsem.c:1535 inode_lock include/linux/fs.h:791 [inline] process_measurement+0x6cf/0x16b0 security/integrity/ima/ima_main.c:230 ima_file_check+0xc5/0x110 security/integrity/ima/ima_main.c:438 do_last fs/namei.c:3412 [inline] path_openat+0x1142/0x46d0 fs/namei.c:3525 do_filp_open+0x1a1/0x280 fs/namei.c:3555 do_sys_open+0x3fe/0x5d0 fs/open.c:1097 __do_sys_openat fs/open.c:1124 [inline] __se_sys_openat fs/open.c:1118 [inline] __x64_sys_openat+0x9d/0x100 fs/open.c:1118 do_syscall_64+0xfa/0x760 arch/x86/entry/common.c:290 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x4598e9 Code: Bad RIP value. RSP: 002b:00007f910006cc78 EFLAGS: 00000246 ORIG_RAX: 0000000000000101 RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00000000004598e9 RDX: 0000000000007a05 RSI: 0000000020000140 RDI: ffffffffffffff9c RBP: 000000000075c070 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000001700 R11: 0000000000000246 R12: 00007f910006d6d4 R13: 00000000004c6115 R14: 00000000004daec0 R15: 00000000ffffffff INFO: task syz-executor.5:23223 blocked for more than 145 seconds. Not tainted 5.3.0-next-20190918 #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.5 D28544 23223 8899 0x00000004 Call Trace: context_switch kernel/sched/core.c:3384 [inline] __schedule+0x828/0x1c20 kernel/sched/core.c:4065 schedule+0xd9/0x260 kernel/sched/core.c:4132 rwsem_down_write_slowpath+0x70b/0xf90 kernel/locking/rwsem.c:1238 __down_write kernel/locking/rwsem.c:1392 [inline] down_write+0x13c/0x150 kernel/locking/rwsem.c:1535 inode_lock include/linux/fs.h:791 [inline] process_measurement+0x6cf/0x16b0 security/integrity/ima/ima_main.c:230 ima_file_check+0xc5/0x110 security/integrity/ima/ima_main.c:438 do_last fs/namei.c:3412 [inline] path_openat+0x1142/0x46d0 fs/namei.c:3525 do_filp_open+0x1a1/0x280 fs/namei.c:3555 do_sys_open+0x3fe/0x5d0 fs/open.c:1097 __do_sys_openat fs/open.c:1124 [inline] __se_sys_openat fs/open.c:1118 [inline] __x64_sys_openat+0x9d/0x100 fs/open.c:1118 do_syscall_64+0xfa/0x760 arch/x86/entry/common.c:290 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x4598e9 Code: Bad RIP value. RSP: 002b:00007f910006cc78 EFLAGS: 00000246 ORIG_RAX: 0000000000000101 RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00000000004598e9 RDX: 0000000000007a05 RSI: 0000000020000140 RDI: ffffffffffffff9c RBP: 000000000075c070 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000001700 R11: 0000000000000246 R12: 00007f910006d6d4 R13: 00000000004c6115 R14: 00000000004daec0 R15: 00000000ffffffff Showing all locks held in the system: 1 lock held by khungtaskd/1065: #0: ffffffff88fa9e80 (rcu_read_lock){....}, at: debug_show_all_locks+0x5f/0x27e kernel/locking/lockdep.c:5337 1 lock held by rsyslogd/8751: #0: ffff8880a19651a0 (&f->f_pos_lock){+.+.}, at: __fdget_pos+0xee/0x110 fs/file.c:801 2 locks held by getty/8841: #0: ffff8880a756a090 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:340 #1: ffffc90005f472e0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1c10 drivers/tty/n_tty.c:2156 2 locks held by getty/8842: #0: ffff88809a4ce090 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:340 #1: ffffc90005f4b2e0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1c10 drivers/tty/n_tty.c:2156 2 locks held by getty/8843: #0: ffff88809ee8e090 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:340 #1: ffffc90005f312e0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1c10 drivers/tty/n_tty.c:2156 2 locks held by getty/8844: #0: ffff8880a74ac090 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:340 #1: ffffc90005f292e0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1c10 drivers/tty/n_tty.c:2156 2 locks held by getty/8845: #0: ffff88809969a090 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:340 #1: ffffc90005f532e0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1c10 drivers/tty/n_tty.c:2156 2 locks held by getty/8846: #0: ffff888097036090 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:340 #1: ffffc90005f4f2e0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1c10 drivers/tty/n_tty.c:2156 2 locks held by getty/8847: #0: ffff88809a01f090 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:340 #1: ffffc90005f212e0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1c10 drivers/tty/n_tty.c:2156 1 lock held by syz-executor.5/23216: #0: ffff8880a4d20860 (&pipe->mutex/1){+.+.}, at: pipe_lock_nested fs/pipe.c:63 [inline] #0: ffff8880a4d20860 (&pipe->mutex/1){+.+.}, at: pipe_lock fs/pipe.c:71 [inline] #0: ffff8880a4d20860 (&pipe->mutex/1){+.+.}, at: pipe_wait+0x1ce/0x1f0 fs/pipe.c:119 3 locks held by syz-executor.5/23220: 2 locks held by syz-executor.5/23223: #0: ffff888215eee420 (sb_writers#3){.+.+}, at: sb_start_write include/linux/fs.h:1650 [inline] #0: ffff888215eee420 (sb_writers#3){.+.+}, at: mnt_want_write+0x3f/0xc0 fs/namespace.c:354 #1: ffff888057d8c748 (&sb->s_type->i_mutex_key#11){++++}, at: inode_lock include/linux/fs.h:791 [inline] #1: ffff888057d8c748 (&sb->s_type->i_mutex_key#11){++++}, at: process_measurement+0x6cf/0x16b0 security/integrity/ima/ima_main.c:230 ============================================= NMI backtrace for cpu 1 CPU: 1 PID: 1065 Comm: khungtaskd Not tainted 5.3.0-next-20190918 #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+0x172/0x1f0 lib/dump_stack.c:113 nmi_cpu_backtrace.cold+0x70/0xb2 lib/nmi_backtrace.c:101 nmi_trigger_cpumask_backtrace+0x23b/0x28b 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:146 [inline] check_hung_uninterruptible_tasks kernel/hung_task.c:269 [inline] watchdog+0xc99/0x1360 kernel/hung_task.c:353 kthread+0x361/0x430 kernel/kthread.c:255 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:352 Sending NMI from CPU 1 to CPUs 0: NMI backtrace for cpu 0 CPU: 0 PID: 23220 Comm: syz-executor.5 Not tainted 5.3.0-next-20190918 #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 RIP: 0010:__sanitizer_cov_trace_pc+0x3b/0x50 kernel/kcov.c:107 Code: 28 8f 7e 81 e2 00 01 1f 00 48 8b 75 08 75 2b 8b 90 00 13 00 00 83 fa 02 75 20 48 8b 88 08 13 00 00 8b 80 04 13 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 65 RSP: 0018:ffff888074d7f358 EFLAGS: 00000246 RAX: 0000000000040000 RBX: 0000000000000000 RCX: ffffc90010be7000 RDX: 000000000003ffff RSI: ffffffff83402d20 RDI: 0000000000000005 RBP: ffff888074d7f358 R08: ffff8880634b2500 R09: ffffffff81f9dca0 R10: ffff888074d7f730 R11: ffff888057d8c457 R12: 0000000000000000 R13: 000000000000f000 R14: 0000000000000000 R15: 0000000000000000 FS: 00007f910008e700(0000) GS:ffff8880ae800000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 00000000004598bf CR3: 000000009331b000 CR4: 00000000001406f0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: bvec_iter_advance include/linux/bvec.h:96 [inline] bvec_iter_advance include/linux/bvec.h:87 [inline] iov_iter_alignment+0x5d0/0x830 lib/iov_iter.c:1200 do_blockdev_direct_IO+0x1dd/0x8420 fs/direct-io.c:1181 __blockdev_direct_IO+0xa1/0xca fs/direct-io.c:1413 ext4_direct_IO_write fs/ext4/inode.c:3742 [inline] ext4_direct_IO+0xd60/0x1c30 fs/ext4/inode.c:3871 generic_file_direct_write+0x20a/0x4a0 mm/filemap.c:3207 __generic_file_write_iter+0x2ee/0x630 mm/filemap.c:3390 ext4_file_write_iter+0x317/0x13c0 fs/ext4/file.c:268 call_write_iter include/linux/fs.h:1902 [inline] do_iter_readv_writev+0x5f8/0x8f0 fs/read_write.c:693 do_iter_write fs/read_write.c:970 [inline] do_iter_write+0x184/0x610 fs/read_write.c:951 vfs_iter_write+0x77/0xb0 fs/read_write.c:983 iter_file_splice_write+0x66d/0xbe0 fs/splice.c:746 do_splice_from fs/splice.c:848 [inline] do_splice+0x785/0x1540 fs/splice.c:1161 __do_sys_splice fs/splice.c:1436 [inline] __se_sys_splice fs/splice.c:1416 [inline] __x64_sys_splice+0x2c6/0x330 fs/splice.c:1416 do_syscall_64+0xfa/0x760 arch/x86/entry/common.c:290 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x4598e9 Code: fd b7 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 b7 fb ff c3 66 2e 0f 1f 84 00 00 00 00 RSP: 002b:00007f910008dc78 EFLAGS: 00000246 ORIG_RAX: 0000000000000113 RAX: ffffffffffffffda RBX: 0000000000000006 RCX: 00000000004598e9 RDX: 000000000000000a RSI: 0000000000000000 RDI: 0000000000000008 RBP: 000000000075bfc8 R08: 000100000000ffe0 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00007f910008e6d4 R13: 00000000004c90ca R14: 00000000004df570 R15: 00000000ffffffff