Bluetooth: hci7: command 0x0419 tx timeout Bluetooth: hci8: command 0x0419 tx timeout INFO: task syz-executor.2:18683 blocked for more than 140 seconds. Not tainted 4.19.211-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.2 D28648 18683 8166 0x00000004 Call Trace: context_switch kernel/sched/core.c:2828 [inline] __schedule+0x887/0x2040 kernel/sched/core.c:3517 schedule+0x8d/0x1b0 kernel/sched/core.c:3561 __rwsem_down_write_failed_common kernel/locking/rwsem-xadd.c:589 [inline] rwsem_down_write_failed+0x3aa/0x760 kernel/locking/rwsem-xadd.c:618 call_rwsem_down_write_failed+0x13/0x20 arch/x86/lib/rwsem.S:117 __down_write arch/x86/include/asm/rwsem.h:142 [inline] down_write+0x4f/0x90 kernel/locking/rwsem.c:72 inode_lock include/linux/fs.h:748 [inline] fuse_flush+0x1fd/0x5b0 fs/fuse/file.c:421 filp_close+0xb4/0x160 fs/open.c:1162 __close_fd+0x133/0x200 fs/file.c:636 __do_sys_close fs/open.c:1181 [inline] __se_sys_close fs/open.c:1179 [inline] __x64_sys_close+0x69/0x100 fs/open.c:1179 do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x7fd2a844ff8b Code: Bad RIP value. RSP: 002b:00007ffdeb1dc950 EFLAGS: 00000293 ORIG_RAX: 0000000000000003 RAX: ffffffffffffffda RBX: 0000000000000006 RCX: 00007fd2a844ff8b RDX: 0000001b2fb20000 RSI: 0000001b2fb264fc RDI: 0000000000000005 RBP: 00007fd2a85bf980 R08: 0000000000000000 R09: 000000003253460c R10: 001c3f65413a04cf R11: 0000000000000293 R12: 00000000000afc4a R13: 00007ffdeb1dca50 R14: 00007fd2a85be120 R15: 0000000000000032 INFO: task syz-executor.2:18689 blocked for more than 140 seconds. Not tainted 4.19.211-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.2 D28184 18689 8166 0x00000004 Call Trace: context_switch kernel/sched/core.c:2828 [inline] __schedule+0x887/0x2040 kernel/sched/core.c:3517 schedule+0x8d/0x1b0 kernel/sched/core.c:3561 fuse_wait_on_page_writeback fs/fuse/file.c:383 [inline] fuse_wait_on_page_writeback.isra.0+0x11b/0x170 fs/fuse/file.c:379 fuse_launder_page fs/fuse/file.c:2033 [inline] fuse_launder_page+0xb6/0xe0 fs/fuse/file.c:2026 do_launder_page mm/truncate.c:655 [inline] invalidate_inode_pages2_range+0x795/0x1110 mm/truncate.c:725 fuse_finish_open+0x2e2/0x590 fs/fuse/file.c:182 fuse_open_common+0x236/0x2c0 fs/fuse/file.c:222 do_dentry_open+0x4aa/0x1160 fs/open.c:796 do_last fs/namei.c:3421 [inline] path_openat+0x793/0x2df0 fs/namei.c:3537 do_filp_open+0x18c/0x3f0 fs/namei.c:3567 do_sys_open+0x3b3/0x520 fs/open.c:1085 do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x7fd2a849e0d9 Code: Bad RIP value. RSP: 002b:00007fd2a6a10168 EFLAGS: 00000246 ORIG_RAX: 0000000000000002 RAX: ffffffffffffffda RBX: 00007fd2a85bdf80 RCX: 00007fd2a849e0d9 RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000020000100 RBP: 00007fd2a84f9ae9 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000 R13: 00007ffdeb1dc8ef R14: 00007fd2a6a10300 R15: 0000000000022000 INFO: task syz-executor.2:18701 blocked for more than 140 seconds. Not tainted 4.19.211-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.2 D28856 18701 8166 0x00000004 Call Trace: context_switch kernel/sched/core.c:2828 [inline] __schedule+0x887/0x2040 kernel/sched/core.c:3517 schedule+0x8d/0x1b0 kernel/sched/core.c:3561 io_schedule+0xb5/0x120 kernel/sched/core.c:5181 wait_on_page_bit_common mm/filemap.c:1123 [inline] __lock_page+0x316/0x460 mm/filemap.c:1296 lock_page include/linux/pagemap.h:484 [inline] invalidate_inode_pages2_range+0xb3f/0x1110 mm/truncate.c:713 fuse_finish_open+0x2e2/0x590 fs/fuse/file.c:182 fuse_open_common+0x254/0x2c0 fs/fuse/file.c:222 do_dentry_open+0x4aa/0x1160 fs/open.c:796 do_last fs/namei.c:3421 [inline] path_openat+0x793/0x2df0 fs/namei.c:3537 do_filp_open+0x18c/0x3f0 fs/namei.c:3567 do_sys_open+0x3b3/0x520 fs/open.c:1085 do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x7fd2a849e0d9 Code: Bad RIP value. RSP: 002b:00007fd2a69ef168 EFLAGS: 00000246 ORIG_RAX: 0000000000000055 RAX: ffffffffffffffda RBX: 00007fd2a85be050 RCX: 00007fd2a849e0d9 RDX: 0000000000000000 RSI: 0000000000000000 RDI: 00000000200001c0 RBP: 00007fd2a84f9ae9 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000 R13: 00007ffdeb1dc8ef R14: 00007fd2a69ef300 R15: 0000000000022000 Showing all locks held in the system: 1 lock held by khungtaskd/1571: #0: 000000003a745a3d (rcu_read_lock){....}, at: debug_show_all_locks+0x53/0x265 kernel/locking/lockdep.c:4441 2 locks held by systemd-journal/4685: 1 lock held by in:imklog/7808: #0: 0000000010844974 (&f->f_pos_lock){+.+.}, at: __fdget_pos+0x26f/0x310 fs/file.c:767 2 locks held by kworker/u4:5/8538: #0: 00000000cefb986a (&rq->lock){-.-.}, at: rq_lock kernel/sched/sched.h:1826 [inline] #0: 00000000cefb986a (&rq->lock){-.-.}, at: __schedule+0x1f9/0x2040 kernel/sched/core.c:3455 #1: 000000003a745a3d (rcu_read_lock){....}, at: trace_sched_stat_runtime include/trace/events/sched.h:428 [inline] #1: 000000003a745a3d (rcu_read_lock){....}, at: update_curr+0x2c3/0x870 kernel/sched/fair.c:857 3 locks held by kworker/u4:8/32200: #0: 00000000cefb986a (&rq->lock){-.-.}, at: idle_balance kernel/sched/fair.c:9702 [inline] #0: 00000000cefb986a (&rq->lock){-.-.}, at: pick_next_task_fair+0x556/0x1570 kernel/sched/fair.c:6841 #1: 000000003a745a3d (rcu_read_lock){....}, at: cpu_of kernel/sched/sched.h:923 [inline] #1: 000000003a745a3d (rcu_read_lock){....}, at: __update_idle_core+0x39/0x3e0 kernel/sched/fair.c:6057 #2: 000000001c6710fe (&base->lock){-.-.}, at: lock_timer_base+0x55/0x1b0 kernel/time/timer.c:950 1 lock held by syz-executor.2/18683: #0: 0000000063b7333b (&sb->s_type->i_mutex_key#22){+.+.}, at: inode_lock include/linux/fs.h:748 [inline] #0: 0000000063b7333b (&sb->s_type->i_mutex_key#22){+.+.}, at: fuse_flush+0x1fd/0x5b0 fs/fuse/file.c:421 2 locks held by syz-executor.2/18701: #0: 00000000de8feda1 (sb_writers#17){.+.+}, at: sb_start_write include/linux/fs.h:1579 [inline] #0: 00000000de8feda1 (sb_writers#17){.+.+}, at: mnt_want_write+0x3a/0xb0 fs/namespace.c:360 #1: 0000000063b7333b (&sb->s_type->i_mutex_key#22){+.+.}, at: inode_lock include/linux/fs.h:748 [inline] #1: 0000000063b7333b (&sb->s_type->i_mutex_key#22){+.+.}, at: fuse_open_common+0x1bc/0x2c0 fs/fuse/file.c:215 1 lock held by syz-executor.2/19388: #0: 00000000a1ce15e8 (&sb->s_type->i_mutex_key#22){+.+.}, at: inode_lock include/linux/fs.h:748 [inline] #0: 00000000a1ce15e8 (&sb->s_type->i_mutex_key#22){+.+.}, at: fuse_flush+0x1fd/0x5b0 fs/fuse/file.c:421 2 locks held by syz-executor.2/19406: #0: 0000000070af289d (sb_writers#17){.+.+}, at: sb_start_write include/linux/fs.h:1579 [inline] #0: 0000000070af289d (sb_writers#17){.+.+}, at: mnt_want_write+0x3a/0xb0 fs/namespace.c:360 #1: 00000000a1ce15e8 (&sb->s_type->i_mutex_key#22){+.+.}, at: inode_lock include/linux/fs.h:748 [inline] #1: 00000000a1ce15e8 (&sb->s_type->i_mutex_key#22){+.+.}, at: fuse_open_common+0x1bc/0x2c0 fs/fuse/file.c:215 1 lock held by syz-executor.1/19433: #0: 000000001ba5fa0c (&sb->s_type->i_mutex_key#22){+.+.}, at: inode_lock include/linux/fs.h:748 [inline] #0: 000000001ba5fa0c (&sb->s_type->i_mutex_key#22){+.+.}, at: fuse_flush+0x1fd/0x5b0 fs/fuse/file.c:421 2 locks held by syz-executor.1/19441: #0: 0000000039cea2d5 (sb_writers#17){.+.+}, at: sb_start_write include/linux/fs.h:1579 [inline] #0: 0000000039cea2d5 (sb_writers#17){.+.+}, at: mnt_want_write+0x3a/0xb0 fs/namespace.c:360 #1: 000000001ba5fa0c (&sb->s_type->i_mutex_key#22){+.+.}, at: inode_lock include/linux/fs.h:748 [inline] #1: 000000001ba5fa0c (&sb->s_type->i_mutex_key#22){+.+.}, at: fuse_open_common+0x1bc/0x2c0 fs/fuse/file.c:215 1 lock held by syz-executor.1/20399: #0: 000000006523f1e0 (&sb->s_type->i_mutex_key#22){+.+.}, at: inode_lock include/linux/fs.h:748 [inline] #0: 000000006523f1e0 (&sb->s_type->i_mutex_key#22){+.+.}, at: fuse_flush+0x1fd/0x5b0 fs/fuse/file.c:421 2 locks held by syz-executor.1/20422: #0: 0000000001606209 (sb_writers#17){.+.+}, at: sb_start_write include/linux/fs.h:1579 [inline] #0: 0000000001606209 (sb_writers#17){.+.+}, at: mnt_want_write+0x3a/0xb0 fs/namespace.c:360 #1: 000000006523f1e0 (&sb->s_type->i_mutex_key#22){+.+.}, at: inode_lock include/linux/fs.h:748 [inline] #1: 000000006523f1e0 (&sb->s_type->i_mutex_key#22){+.+.}, at: fuse_open_common+0x1bc/0x2c0 fs/fuse/file.c:215 2 locks held by syz-executor.1/20434: #0: 0000000001606209 (sb_writers#17){.+.+}, at: sb_start_write include/linux/fs.h:1579 [inline] #0: 0000000001606209 (sb_writers#17){.+.+}, at: mnt_want_write+0x3a/0xb0 fs/namespace.c:360 #1: 000000006523f1e0 (&sb->s_type->i_mutex_key#22){+.+.}, at: inode_lock include/linux/fs.h:748 [inline] #1: 000000006523f1e0 (&sb->s_type->i_mutex_key#22){+.+.}, at: chown_common+0x2d0/0x550 fs/open.c:648 ============================================= NMI backtrace for cpu 1 CPU: 1 PID: 1571 Comm: khungtaskd Not tainted 4.19.211-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 10/26/2022 Call Trace: __dump_stack lib/dump_stack.c:77 [inline] dump_stack+0x1fc/0x2ef lib/dump_stack.c:118 nmi_cpu_backtrace.cold+0x63/0xa2 lib/nmi_backtrace.c:101 nmi_trigger_cpumask_backtrace+0x1a6/0x1f0 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+0x991/0xe60 kernel/hung_task.c:287 kthread+0x33f/0x460 kernel/kthread.c:259 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: 7 Comm: kworker/u4:0 Not tainted 4.19.211-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 10/26/2022 Workqueue: phy12 ieee80211_iface_work RIP: 0010:lookup_chain_cache kernel/locking/lockdep.c:2318 [inline] RIP: 0010:lookup_chain_cache_add kernel/locking/lockdep.c:2337 [inline] RIP: 0010:validate_chain kernel/locking/lockdep.c:2391 [inline] RIP: 0010:__lock_acquire+0xbed/0x3ff0 kernel/locking/lockdep.c:3416 Code: db 74 55 48 83 eb 08 74 4f 48 bd 00 00 00 00 00 fc ff df eb 06 48 83 eb 08 74 3d 48 8d 7b 18 48 89 f8 48 c1 e8 03 80 3c 28 00 <0f> 85 8c 1e 00 00 4c 3b 63 18 0f 84 f1 fc ff ff 48 8d 7b 08 48 89 RSP: 0018:ffff8880b5a46ff0 EFLAGS: 00000046 RAX: 1ffffffff18f0a3b RBX: ffffffff8c7851c0 RCX: 0000000000000526 RDX: 1ffffffff19a33ce RSI: 00000000ab0410ad RDI: ffffffff8c7851d8 RBP: dffffc0000000000 R08: ffffffff8cd19e70 R09: 0000000000000004 R10: ffff8880b5a36ae8 R11: 000000004470b61e R12: a36fb1658dedb8b9 R13: ffff8880b5a361c0 R14: ffff8880b5a36b00 R15: 0000000000000000 FS: 0000000000000000(0000) GS:ffff8880ba000000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 00007fbb80a2e000 CR3: 00000000a144f000 CR4: 00000000003406f0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: lock_acquire+0x170/0x3c0 kernel/locking/lockdep.c:3908 __raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:110 [inline] _raw_spin_lock_irqsave+0x8c/0xc0 kernel/locking/spinlock.c:152 debug_object_activate+0x12f/0x450 lib/debugobjects.c:472 debug_rcu_head_queue kernel/rcu/rcu.h:193 [inline] __call_rcu.constprop.0+0x31/0x7f0 kernel/rcu/tree.c:2977 cfg80211_bss_update+0x47a/0x2590 net/wireless/scan.c:967 cfg80211_inform_bss_frame_data+0x69c/0xeb0 net/wireless/scan.c:1283 ieee80211_bss_info_update+0x42d/0x1800 net/mac80211/scan.c:105 ieee80211_rx_bss_info net/mac80211/ibss.c:1125 [inline] ieee80211_rx_mgmt_probe_beacon+0xb4f/0x15c0 net/mac80211/ibss.c:1607 ieee80211_ibss_rx_queued_mgmt+0xe27/0x18b0 net/mac80211/ibss.c:1634 ieee80211_iface_work+0x5c4/0x8a0 net/mac80211/iface.c:1341 process_one_work+0x864/0x1570 kernel/workqueue.c:2153 worker_thread+0x64c/0x1130 kernel/workqueue.c:2296 kthread+0x33f/0x460 kernel/kthread.c:259 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:415