Bluetooth: hci1: command 0x0406 tx timeout Bluetooth: hci2: command 0x0406 tx timeout Bluetooth: hci3: command 0x0406 tx timeout Bluetooth: hci5: command 0x0406 tx timeout Bluetooth: hci4: command 0x0406 tx timeout INFO: task kworker/0:1:14 blocked for more than 140 seconds. Not tainted 4.19.162-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. kworker/0:1 D27064 14 2 0x80000000 Workqueue: events linkwatch_event 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 schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:3619 __mutex_lock_common kernel/locking/mutex.c:1002 [inline] __mutex_lock+0x647/0x1260 kernel/locking/mutex.c:1072 linkwatch_event+0xb/0x60 net/core/link_watch.c:236 process_one_work+0x864/0x1570 kernel/workqueue.c:2155 worker_thread+0x64c/0x1130 kernel/workqueue.c:2298 kthread+0x33f/0x460 kernel/kthread.c:259 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:415 INFO: task kworker/1:3:9123 blocked for more than 140 seconds. Not tainted 4.19.162-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. kworker/1:3 D25784 9123 2 0x80000000 Workqueue: ipv6_addrconf addrconf_dad_work 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 schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:3619 __mutex_lock_common kernel/locking/mutex.c:1002 [inline] __mutex_lock+0x647/0x1260 kernel/locking/mutex.c:1072 addrconf_dad_work+0x9c/0x10a0 net/ipv6/addrconf.c:3988 process_one_work+0x864/0x1570 kernel/workqueue.c:2155 worker_thread+0x64c/0x1130 kernel/workqueue.c:2298 kthread+0x33f/0x460 kernel/kthread.c:259 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:415 INFO: task syz-executor.4:10278 blocked for more than 140 seconds. Not tainted 4.19.162-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.4 D27592 10278 8148 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 exp_funnel_lock kernel/rcu/tree_exp.h:320 [inline] _synchronize_rcu_expedited+0x60c/0x6f0 kernel/rcu/tree_exp.h:667 synchronize_net net/core/dev.c:9266 [inline] rollback_registered_many+0x959/0xe70 net/core/dev.c:8175 rollback_registered+0xe9/0x1b0 net/core/dev.c:8230 unregister_netdevice_queue+0x1de/0x3e0 net/core/dev.c:9292 unregister_netdevice include/linux/netdevice.h:2614 [inline] __tun_detach+0x100d/0x1320 drivers/net/tun.c:737 tun_detach drivers/net/tun.c:754 [inline] tun_chr_close+0xd9/0x180 drivers/net/tun.c:3275 __fput+0x2ce/0x890 fs/file_table.c:278 task_work_run+0x148/0x1c0 kernel/task_work.c:113 tracehook_notify_resume include/linux/tracehook.h:193 [inline] exit_to_usermode_loop+0x251/0x2a0 arch/x86/entry/common.c:167 prepare_exit_to_usermode arch/x86/entry/common.c:198 [inline] syscall_return_slowpath arch/x86/entry/common.c:271 [inline] do_syscall_64+0x538/0x620 arch/x86/entry/common.c:296 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x417a51 Code: 24 48 8b 4c 24 40 48 89 4c 24 08 e8 29 f4 00 00 8b 44 24 18 8b 4c 24 1c 39 c8 75 22 48 8b 44 24 38 48 89 04 24 e8 1f 33 ff ff <8b> 44 24 18 8b 4c 24 1c 39 c8 48 8b 44 24 40 e9 5a ff ff ff 48 8b RSP: 002b:00007ffc5583be80 EFLAGS: 00000293 ORIG_RAX: 0000000000000003 RAX: 0000000000000000 RBX: 0000000000000004 RCX: 0000000000417a51 RDX: 0000001b30f20000 RSI: 00000000bb4f891c RDI: 0000000000000003 RBP: 0000000000000001 R08: 00000000000112a5 R09: 00000000bb4f891c R10: 00000000bb4f8920 R11: 0000000000000293 R12: 000000000119ca00 R13: 000000000119ca00 R14: 00000000000003e8 R15: 000000000119c0dc INFO: task syz-executor.5:10299 blocked for more than 140 seconds. Not tainted 4.19.162-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.5 D28072 10299 8150 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 schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:3619 __mutex_lock_common kernel/locking/mutex.c:1002 [inline] __mutex_lock+0x647/0x1260 kernel/locking/mutex.c:1072 netdev_run_todo+0x719/0xab0 net/core/dev.c:8992 tun_detach drivers/net/tun.c:757 [inline] tun_chr_close+0xf5/0x180 drivers/net/tun.c:3275 __fput+0x2ce/0x890 fs/file_table.c:278 task_work_run+0x148/0x1c0 kernel/task_work.c:113 tracehook_notify_resume include/linux/tracehook.h:193 [inline] exit_to_usermode_loop+0x251/0x2a0 arch/x86/entry/common.c:167 prepare_exit_to_usermode arch/x86/entry/common.c:198 [inline] syscall_return_slowpath arch/x86/entry/common.c:271 [inline] do_syscall_64+0x538/0x620 arch/x86/entry/common.c:296 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x45e0f9 Code: 2a 03 00 00 48 83 ec 58 48 89 6c 24 50 48 8d 6c 24 50 8b 44 24 68 85 c0 0f 84 3a 02 00 00 48 8b 4c 24 60 48 8d 15 07 96 b0 00 07 48 8b 92 c0 01 00 00 48 85 d2 0f 84 15 02 00 00 48 39 8a c8 RSP: 002b:00007f0ed7a1ac68 EFLAGS: 00000246 ORIG_RAX: 0000000000000010 RAX: 0000000000000000 RBX: 0000000000000003 RCX: 000000000045e0f9 RDX: 00000000200000c0 RSI: 00000000400454ca RDI: 0000000000000004 RBP: 000000000119bfc0 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 000000000119bf8c R13: 00007ffe4a3213ff R14: 00007f0ed7a1b9c0 R15: 000000000119bf8c INFO: task syz-executor.5:10337 blocked for more than 140 seconds. Not tainted 4.19.162-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.5 D29360 10337 8150 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 schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:3619 __mutex_lock_common kernel/locking/mutex.c:1002 [inline] __mutex_lock+0x647/0x1260 kernel/locking/mutex.c:1072 __tun_chr_ioctl.isra.0+0x4e0/0x3bd0 drivers/net/tun.c:2907 vfs_ioctl fs/ioctl.c:46 [inline] file_ioctl fs/ioctl.c:501 [inline] do_vfs_ioctl+0xcdb/0x12e0 fs/ioctl.c:688 ksys_ioctl+0x9b/0xc0 fs/ioctl.c:705 __do_sys_ioctl fs/ioctl.c:712 [inline] __se_sys_ioctl fs/ioctl.c:710 [inline] __x64_sys_ioctl+0x6f/0xb0 fs/ioctl.c:710 do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x45e0f9 Code: 2a 03 00 00 48 83 ec 58 48 89 6c 24 50 48 8d 6c 24 50 8b 44 24 68 85 c0 0f 84 3a 02 00 00 48 8b 4c 24 60 48 8d 15 07 96 b0 00 07 48 8b 92 c0 01 00 00 48 85 d2 0f 84 15 02 00 00 48 39 8a c8 RSP: 002b:00007f0ed79d8c68 EFLAGS: 00000246 ORIG_RAX: 0000000000000010 RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 000000000045e0f9 RDX: 00000000200000c0 RSI: 00000000400454ca RDI: 0000000000000004 RBP: 000000000119c110 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 000000000119c0dc R13: 00007ffe4a3213ff R14: 00007f0ed79d99c0 R15: 000000000119c0dc Showing all locks held in the system: 3 locks held by kworker/0:1/14: #0: 000000006452ab07 ((wq_completion)"events"){+.+.}, at: process_one_work+0x767/0x1570 kernel/workqueue.c:2126 #1: 00000000a7e71dc1 ((linkwatch_work).work){+.+.}, at: process_one_work+0x79c/0x1570 kernel/workqueue.c:2130 #2: 00000000629dca3f (rtnl_mutex){+.+.}, at: linkwatch_event+0xb/0x60 net/core/link_watch.c:236 4 locks held by kworker/u4:1/23: #0: 000000007839918e (&rq->lock){-.-.}, at: rq_lock kernel/sched/sched.h:1830 [inline] #0: 000000007839918e (&rq->lock){-.-.}, at: __schedule+0x1f9/0x2040 kernel/sched/core.c:3455 #1: 0000000064ca5e5b (rcu_read_lock){....}, at: trace_sched_stat_runtime include/trace/events/sched.h:428 [inline] #1: 0000000064ca5e5b (rcu_read_lock){....}, at: update_curr+0x2c3/0x870 kernel/sched/fair.c:857 #2: 00000000091e6061 (&wdev->mtx){+.+.}, at: sdata_lock net/mac80211/ieee80211_i.h:990 [inline] #2: 00000000091e6061 (&wdev->mtx){+.+.}, at: ieee80211_ibss_work+0x85/0xe10 net/mac80211/ibss.c:1675 #3: 0000000064ca5e5b (rcu_read_lock){....}, at: sdata_assert_lock net/mac80211/ieee80211_i.h:1007 [inline] #3: 0000000064ca5e5b (rcu_read_lock){....}, at: ieee80211_sta_active_ibss+0x86/0x350 net/mac80211/ibss.c:668 2 locks held by kworker/u4:2/32: #0: 000000007839918e (&rq->lock){-.-.}, at: idle_balance kernel/sched/fair.c:9701 [inline] #0: 000000007839918e (&rq->lock){-.-.}, at: pick_next_task_fair+0x556/0x1570 kernel/sched/fair.c:6840 #1: 0000000064ca5e5b (rcu_read_lock){....}, at: cpu_of kernel/sched/sched.h:927 [inline] #1: 0000000064ca5e5b (rcu_read_lock){....}, at: __update_idle_core+0x39/0x3e0 kernel/sched/fair.c:6057 1 lock held by khungtaskd/1564: #0: 0000000064ca5e5b (rcu_read_lock){....}, at: debug_show_all_locks+0x53/0x265 kernel/locking/lockdep.c:4440 1 lock held by in:imklog/7818: #0: 000000006434be2b (&f->f_pos_lock){+.+.}, at: __fdget_pos+0x26f/0x310 fs/file.c:767 3 locks held by kworker/1:3/9123: #0: 000000001aaf9714 ((wq_completion)"%s"("ipv6_addrconf")){+.+.}, at: process_one_work+0x767/0x1570 kernel/workqueue.c:2126 #1: 00000000112c57ee ((work_completion)(&(&ifa->dad_work)->work)){+.+.}, at: process_one_work+0x79c/0x1570 kernel/workqueue.c:2130 #2: 00000000629dca3f (rtnl_mutex){+.+.}, at: addrconf_dad_work+0x9c/0x10a0 net/ipv6/addrconf.c:3988 3 locks held by kworker/0:5/9677: #0: 000000001aaf9714 ((wq_completion)"%s"("ipv6_addrconf")){+.+.}, at: process_one_work+0x767/0x1570 kernel/workqueue.c:2126 #1: 00000000fe87cae7 ((addr_chk_work).work){+.+.}, at: process_one_work+0x79c/0x1570 kernel/workqueue.c:2130 #2: 00000000629dca3f (rtnl_mutex){+.+.}, at: addrconf_verify_work+0xa/0x20 net/ipv6/addrconf.c:4475 1 lock held by syz-executor.4/10278: #0: 00000000629dca3f (rtnl_mutex){+.+.}, at: tun_detach drivers/net/tun.c:751 [inline] #0: 00000000629dca3f (rtnl_mutex){+.+.}, at: tun_chr_close+0x3a/0x180 drivers/net/tun.c:3275 1 lock held by syz-executor.5/10299: #0: 00000000629dca3f (rtnl_mutex){+.+.}, at: netdev_run_todo+0x719/0xab0 net/core/dev.c:8992 1 lock held by syz-executor.5/10337: #0: 00000000629dca3f (rtnl_mutex){+.+.}, at: __tun_chr_ioctl.isra.0+0x4e0/0x3bd0 drivers/net/tun.c:2907 ============================================= NMI backtrace for cpu 1 CPU: 1 PID: 1564 Comm: khungtaskd Not tainted 4.19.162-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+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: 7819 Comm: rs:main Q:Reg Not tainted 4.19.162-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 RIP: 0010:generic_perform_write+0x2/0x4d0 mm/filemap.c:3131 Code: ff ff 4c 89 ef e8 ee 2a 1c 00 e9 40 ff ff ff e8 e4 2a 1c 00 e9 fc fe ff ff e8 da 2a 1c 00 e9 ce fe ff ff 0f 1f 44 00 00 41 57 <49> 89 f7 41 56 49 89 d6 41 55 41 54 55 48 89 fd 53 48 bb 00 00 00 RSP: 0018:ffff8880a0fbfb78 EFLAGS: 00000246 RAX: dffffc0000000000 RBX: ffff8880a0fbfd40 RCX: ffffffff817fb1ee RDX: 0000000000049f13 RSI: ffff8880a0fbfd90 RDI: ffff8880b3fc3300 RBP: ffff8880b3fc3300 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000005 R11: 0000000000000000 R12: 0000000000000000 R13: ffff8880a0fbfd48 R14: ffff88808e499778 R15: 0000000000000000 FS: 00007f2da9d66700(0000) GS:ffff8880ba000000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 00007f39461fb000 CR3: 0000000094e25000 CR4: 00000000001406f0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: __generic_file_write_iter+0x24b/0x610 mm/filemap.c:3295 ext4_file_write_iter+0x2fe/0xf20 fs/ext4/file.c:272 call_write_iter include/linux/fs.h:1821 [inline] new_sync_write fs/read_write.c:474 [inline] __vfs_write+0x51b/0x770 fs/read_write.c:487 vfs_write+0x1f3/0x540 fs/read_write.c:549 ksys_write+0x12b/0x2a0 fs/read_write.c:599 do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x7f2dac7aa1cd Code: c2 20 00 00 75 10 b8 01 00 00 00 0f 05 48 3d 01 f0 ff ff 73 31 c3 48 83 ec 08 e8 ae fc ff ff 48 89 04 24 b8 01 00 00 00 0f 05 <48> 8b 3c 24 48 89 c2 e8 f7 fc ff ff 48 89 d0 48 83 c4 08 48 3d 01 RSP: 002b:00007f2da9d65590 EFLAGS: 00000293 ORIG_RAX: 0000000000000001 RAX: ffffffffffffffda RBX: 00007f2da0022cf0 RCX: 00007f2dac7aa1cd RDX: 000000000000045b RSI: 00007f2da0022cf0 RDI: 0000000000000006 RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000293 R12: 00007f2da0022a70 R13: 00007f2da9d655b0 R14: 000055670a82f360 R15: 000000000000045b