audit: type=1804 audit(1592180050.464:1939): pid=13062 uid=0 auid=0 ses=4 subj=system_u:system_r:kernel_t:s0 op=invalid_pcr cause=ToMToU comm="syz-executor.4" name="/dev/vcsa" dev="sda1" ino=16339 res=1 NOHZ: local_softirq_pending 08 NOHZ: local_softirq_pending 08 INFO: task syz-executor.3:13055 blocked for more than 140 seconds. Not tainted 4.19.128-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.3 D29424 13055 6729 0x00000004 Call Trace: context_switch kernel/sched/core.c:2826 [inline] __schedule+0x8a2/0x1fc0 kernel/sched/core.c:3515 schedule+0x8d/0x1b0 kernel/sched/core.c:3559 __rwsem_down_read_failed_common kernel/locking/rwsem-xadd.c:292 [inline] rwsem_down_read_failed+0x21a/0x3b0 kernel/locking/rwsem-xadd.c:309 call_rwsem_down_read_failed+0x14/0x30 arch/x86/lib/rwsem.S:94 __down_read arch/x86/include/asm/rwsem.h:83 [inline] down_read+0x45/0xb0 kernel/locking/rwsem.c:26 inode_lock_shared include/linux/fs.h:758 [inline] lookup_slow+0x43/0x70 fs/namei.c:1688 walk_component+0x759/0xd30 fs/namei.c:1811 lookup_last fs/namei.c:2274 [inline] path_lookupat.isra.0+0x1f5/0x8c0 fs/namei.c:2319 filename_lookup+0x1b0/0x410 fs/namei.c:2349 user_path_at include/linux/namei.h:57 [inline] vfs_statx+0x113/0x1e0 fs/stat.c:185 vfs_lstat include/linux/fs.h:3134 [inline] __do_sys_newlstat fs/stat.c:350 [inline] __se_sys_newlstat+0x96/0x120 fs/stat.c:344 do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x45ca69 Code: Bad RIP value. RSP: 002b:00007f74366bdc78 EFLAGS: 00000246 ORIG_RAX: 0000000000000006 RAX: ffffffffffffffda RBX: 00000000004f6300 RCX: 000000000045ca69 RDX: 0000000000000000 RSI: 0000000020000400 RDI: 00000000200003c0 RBP: 000000000078c040 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00000000ffffffff R13: 0000000000000744 R14: 00000000004ca38d R15: 00007f74366be6d4 INFO: task syz-executor.3:13056 blocked for more than 140 seconds. Not tainted 4.19.128-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.3 D29536 13056 6729 0x00000004 Call Trace: context_switch kernel/sched/core.c:2826 [inline] __schedule+0x8a2/0x1fc0 kernel/sched/core.c:3515 schedule+0x8d/0x1b0 kernel/sched/core.c:3559 __rwsem_down_read_failed_common kernel/locking/rwsem-xadd.c:292 [inline] rwsem_down_read_failed+0x21a/0x3b0 kernel/locking/rwsem-xadd.c:309 call_rwsem_down_read_failed+0x14/0x30 arch/x86/lib/rwsem.S:94 __down_read arch/x86/include/asm/rwsem.h:83 [inline] down_read+0x45/0xb0 kernel/locking/rwsem.c:26 inode_lock_shared include/linux/fs.h:758 [inline] lookup_slow+0x43/0x70 fs/namei.c:1688 walk_component+0x759/0xd30 fs/namei.c:1811 lookup_last fs/namei.c:2274 [inline] path_lookupat.isra.0+0x1f5/0x8c0 fs/namei.c:2319 filename_lookup+0x1b0/0x410 fs/namei.c:2349 user_path include/linux/namei.h:62 [inline] do_mount+0x13d/0x2b50 fs/namespace.c:2739 ksys_mount+0xd7/0x150 fs/namespace.c:3015 __do_sys_mount fs/namespace.c:3029 [inline] __se_sys_mount fs/namespace.c:3026 [inline] __x64_sys_mount+0xba/0x150 fs/namespace.c:3026 do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x45ca69 Code: Bad RIP value. RSP: 002b:00007f743669cc78 EFLAGS: 00000246 ORIG_RAX: 00000000000000a5 RAX: ffffffffffffffda RBX: 00000000004f6cc0 RCX: 000000000045ca69 RDX: 0000000020000380 RSI: 0000000020000340 RDI: 00000000200001c0 RBP: 000000000078c0e0 R08: 0000000020000480 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00000000ffffffff R13: 000000000000076b R14: 00000000004ca563 R15: 00007f743669d6d4 INFO: task syz-executor.3:13057 blocked for more than 140 seconds. Not tainted 4.19.128-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.3 D29744 13057 6729 0x00000004 Call Trace: context_switch kernel/sched/core.c:2826 [inline] __schedule+0x8a2/0x1fc0 kernel/sched/core.c:3515 schedule+0x8d/0x1b0 kernel/sched/core.c:3559 __rwsem_down_read_failed_common kernel/locking/rwsem-xadd.c:292 [inline] rwsem_down_read_failed+0x21a/0x3b0 kernel/locking/rwsem-xadd.c:309 call_rwsem_down_read_failed+0x14/0x30 arch/x86/lib/rwsem.S:94 __down_read arch/x86/include/asm/rwsem.h:83 [inline] down_read+0x45/0xb0 kernel/locking/rwsem.c:26 inode_lock_shared include/linux/fs.h:758 [inline] lookup_slow+0x43/0x70 fs/namei.c:1688 walk_component+0x759/0xd30 fs/namei.c:1811 lookup_last fs/namei.c:2274 [inline] path_lookupat.isra.0+0x1f5/0x8c0 fs/namei.c:2319 filename_lookup+0x1b0/0x410 fs/namei.c:2349 user_path_at include/linux/namei.h:57 [inline] ksys_chdir+0x84/0x1d0 fs/open.c:458 __do_sys_chdir fs/open.c:480 [inline] __se_sys_chdir fs/open.c:478 [inline] __x64_sys_chdir+0x2d/0x40 fs/open.c:478 do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x45ca69 Code: Bad RIP value. RSP: 002b:00007f743667bc78 EFLAGS: 00000246 ORIG_RAX: 0000000000000050 RAX: ffffffffffffffda RBX: 00000000004dae80 RCX: 000000000045ca69 RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000020000040 RBP: 000000000078c180 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00000000ffffffff R13: 0000000000000072 R14: 00000000004c25a9 R15: 00007f743667c6d4 INFO: task syz-executor.3:13059 blocked for more than 140 seconds. Not tainted 4.19.128-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.3 D29536 13059 6729 0x00000004 Call Trace: context_switch kernel/sched/core.c:2826 [inline] __schedule+0x8a2/0x1fc0 kernel/sched/core.c:3515 schedule+0x8d/0x1b0 kernel/sched/core.c:3559 __rwsem_down_read_failed_common kernel/locking/rwsem-xadd.c:292 [inline] rwsem_down_read_failed+0x21a/0x3b0 kernel/locking/rwsem-xadd.c:309 call_rwsem_down_read_failed+0x14/0x30 arch/x86/lib/rwsem.S:94 __down_read arch/x86/include/asm/rwsem.h:83 [inline] down_read+0x45/0xb0 kernel/locking/rwsem.c:26 inode_lock_shared include/linux/fs.h:758 [inline] lookup_slow+0x43/0x70 fs/namei.c:1688 walk_component+0x759/0xd30 fs/namei.c:1811 lookup_last fs/namei.c:2274 [inline] path_lookupat.isra.0+0x1f5/0x8c0 fs/namei.c:2319 filename_lookup+0x1b0/0x410 fs/namei.c:2349 user_path include/linux/namei.h:62 [inline] do_mount+0x13d/0x2b50 fs/namespace.c:2739 ksys_mount+0xd7/0x150 fs/namespace.c:3015 __do_sys_mount fs/namespace.c:3029 [inline] __se_sys_mount fs/namespace.c:3026 [inline] __x64_sys_mount+0xba/0x150 fs/namespace.c:3026 do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x45ca69 Code: Bad RIP value. RSP: 002b:00007f743665ac78 EFLAGS: 00000246 ORIG_RAX: 00000000000000a5 RAX: ffffffffffffffda RBX: 00000000004f6c40 RCX: 000000000045ca69 RDX: 0000000020000140 RSI: 0000000020000000 RDI: 0000000000000000 RBP: 000000000078c220 R08: 0000000020000300 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00000000ffffffff R13: 0000000000000769 R14: 00000000004ca549 R15: 00007f743665b6d4 INFO: task syz-executor.3:13061 blocked for more than 140 seconds. Not tainted 4.19.128-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.3 D29904 13061 6729 0x00000004 Call Trace: context_switch kernel/sched/core.c:2826 [inline] __schedule+0x8a2/0x1fc0 kernel/sched/core.c:3515 schedule+0x8d/0x1b0 kernel/sched/core.c:3559 __rwsem_down_read_failed_common kernel/locking/rwsem-xadd.c:292 [inline] rwsem_down_read_failed+0x21a/0x3b0 kernel/locking/rwsem-xadd.c:309 call_rwsem_down_read_failed+0x14/0x30 arch/x86/lib/rwsem.S:94 __down_read arch/x86/include/asm/rwsem.h:83 [inline] down_read+0x45/0xb0 kernel/locking/rwsem.c:26 inode_lock_shared include/linux/fs.h:758 [inline] do_last fs/namei.c:3326 [inline] path_openat+0x1a04/0x2eb0 fs/namei.c:3537 do_filp_open+0x1a1/0x280 fs/namei.c:3567 do_sys_open+0x3aa/0x510 fs/open.c:1085 do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x45ca69 Code: Bad RIP value. RSP: 002b:00007f7436639c78 EFLAGS: 00000246 ORIG_RAX: 0000000000000002 RAX: ffffffffffffffda RBX: 00000000004f7600 RCX: 000000000045ca69 RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000020000080 RBP: 000000000078c2c0 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00000000ffffffff R13: 0000000000000790 R14: 00000000005261df R15: 00007f743663a6d4 Showing all locks held in the system: 1 lock held by khungtaskd/1079: #0: 000000004d5ba277 (rcu_read_lock){....}, at: debug_show_all_locks+0x53/0x265 kernel/locking/lockdep.c:4440 1 lock held by in:imklog/6124: 2 locks held by agetty/6135: #0: 000000003d8823c1 (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x22/0x80 drivers/tty/tty_ldisc.c:272 #1: 00000000bc0ae9c6 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x217/0x1a50 drivers/tty/n_tty.c:2154 2 locks held by syz-executor.3/13033: #0: 0000000018b257c5 (sb_writers#25){.+.+}, at: sb_start_write include/linux/fs.h:1579 [inline] #0: 0000000018b257c5 (sb_writers#25){.+.+}, at: mnt_want_write+0x3a/0xb0 fs/namespace.c:360 #1: 00000000ad4cc8dc (&sb->s_type->i_mutex_key#30/1){+.+.}, at: inode_lock_nested include/linux/fs.h:783 [inline] #1: 00000000ad4cc8dc (&sb->s_type->i_mutex_key#30/1){+.+.}, at: filename_create+0x15a/0x490 fs/namei.c:3638 1 lock held by syz-executor.3/13055: #0: 00000000ad4cc8dc (&sb->s_type->i_mutex_key#30){++++}, at: inode_lock_shared include/linux/fs.h:758 [inline] #0: 00000000ad4cc8dc (&sb->s_type->i_mutex_key#30){++++}, at: lookup_slow+0x43/0x70 fs/namei.c:1688 1 lock held by syz-executor.3/13056: #0: 00000000ad4cc8dc (&sb->s_type->i_mutex_key#30){++++}, at: inode_lock_shared include/linux/fs.h:758 [inline] #0: 00000000ad4cc8dc (&sb->s_type->i_mutex_key#30){++++}, at: lookup_slow+0x43/0x70 fs/namei.c:1688 1 lock held by syz-executor.3/13057: #0: 00000000ad4cc8dc (&sb->s_type->i_mutex_key#30){++++}, at: inode_lock_shared include/linux/fs.h:758 [inline] #0: 00000000ad4cc8dc (&sb->s_type->i_mutex_key#30){++++}, at: lookup_slow+0x43/0x70 fs/namei.c:1688 1 lock held by syz-executor.3/13059: #0: 00000000ad4cc8dc (&sb->s_type->i_mutex_key#30){++++}, at: inode_lock_shared include/linux/fs.h:758 [inline] #0: 00000000ad4cc8dc (&sb->s_type->i_mutex_key#30){++++}, at: lookup_slow+0x43/0x70 fs/namei.c:1688 1 lock held by syz-executor.3/13061: #0: 00000000ad4cc8dc (&sb->s_type->i_mutex_key#30){++++}, at: inode_lock_shared include/linux/fs.h:758 [inline] #0: 00000000ad4cc8dc (&sb->s_type->i_mutex_key#30){++++}, at: do_last fs/namei.c:3326 [inline] #0: 00000000ad4cc8dc (&sb->s_type->i_mutex_key#30){++++}, at: path_openat+0x1a04/0x2eb0 fs/namei.c:3537 ============================================= NMI backtrace for cpu 1 CPU: 1 PID: 1079 Comm: khungtaskd Not tainted 4.19.128-syzkaller #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+0x1fc/0x2fe lib/dump_stack.c:118 nmi_cpu_backtrace.cold+0x63/0xa2 lib/nmi_backtrace.c:101 nmi_trigger_cpumask_backtrace+0x1a6/0x1eb lib/nmi_backtrace.c:62 trigger_all_cpu_backtrace include/linux/nmi.h:146 [inline] check_hung_uninterruptible_tasks kernel/hung_task.c:203 [inline] watchdog+0x962/0xe40 kernel/hung_task.c:287 kthread+0x30b/0x410 kernel/kthread.c:246 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:415 Sending NMI from CPU 1 to CPUs 0: NMI backtrace for cpu 0 CPU: 0 PID: 2036 Comm: kworker/u4:2 Not tainted 4.19.128-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 Workqueue: bat_events batadv_nc_worker RIP: 0010:bytes_is_nonzero mm/kasan/kasan.c:167 [inline] RIP: 0010:memory_is_nonzero mm/kasan/kasan.c:184 [inline] RIP: 0010:memory_is_poisoned_n mm/kasan/kasan.c:210 [inline] RIP: 0010:memory_is_poisoned mm/kasan/kasan.c:241 [inline] RIP: 0010:check_memory_region_inline mm/kasan/kasan.c:257 [inline] RIP: 0010:check_memory_region+0x108/0x180 mm/kasan/kasan.c:267 Code: 4a 8d 04 23 4d 85 c0 75 25 49 89 e9 49 29 c1 e9 74 ff ff ff 4d 85 c9 74 be 49 01 d9 eb 09 48 83 c0 01 4c 39 c8 74 b0 80 38 00 <74> f2 eb a4 4c 89 c0 49 39 c2 74 4b 5b 5d 41 5c e9 93 0f 00 00 49 RSP: 0018:ffff8882118bfa10 EFLAGS: 00000046 RAX: fffffbfff164e629 RBX: fffffbfff164e629 RCX: ffffffff814fbda8 RDX: 0000000000000001 RSI: 0000000000000004 RDI: ffffffff8b273148 RBP: fffffbfff164e62a R08: 0000000000000001 R09: fffffbfff164e62a R10: fffffbfff164e629 R11: ffffffff8b27314b R12: 0000000000000000 R13: 0000000000000000 R14: ffff888051488200 R15: ffff8880921c1030 FS: 0000000000000000(0000) GS:ffff8880ae600000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 00007f8094834000 CR3: 0000000096262000 CR4: 00000000001406f0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: atomic_inc include/asm-generic/atomic-instrumented.h:109 [inline] __lock_acquire+0x278/0x4380 kernel/locking/lockdep.c:3307 lock_acquire+0x170/0x3c0 kernel/locking/lockdep.c:3907 __raw_spin_lock_bh include/linux/spinlock_api_smp.h:135 [inline] _raw_spin_lock_bh+0x2f/0x40 kernel/locking/spinlock.c:168 spin_lock_bh include/linux/spinlock.h:334 [inline] batadv_nc_purge_paths+0xdc/0x340 net/batman-adv/network-coding.c:453 batadv_nc_worker+0x299/0x760 net/batman-adv/network-coding.c:731 process_one_work+0x892/0x1580 kernel/workqueue.c:2155 worker_thread+0x96/0xe20 kernel/workqueue.c:2298 kthread+0x30b/0x410 kernel/kthread.c:246 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:415