Bluetooth: hci1: command 0x0406 tx timeout Bluetooth: hci2: command 0x0406 tx timeout Bluetooth: hci3: command 0x0406 tx timeout Bluetooth: hci4: command 0x0406 tx timeout Bluetooth: hci5: command 0x0406 tx timeout INFO: task kworker/u4:2:34 blocked for more than 140 seconds. Not tainted 4.19.172-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. kworker/u4:2 D27352 34 2 0x80000000 Workqueue: events_unbound fsnotify_mark_destroy_workfn 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_timeout+0x92d/0xfe0 kernel/time/timer.c:1794 do_wait_for_common kernel/sched/completion.c:83 [inline] __wait_for_common kernel/sched/completion.c:104 [inline] wait_for_common+0x29c/0x470 kernel/sched/completion.c:115 __synchronize_srcu+0x124/0x210 kernel/rcu/srcutree.c:936 fsnotify_mark_destroy_workfn+0xfd/0x340 fs/notify/mark.c:795 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/u4:3:36 blocked for more than 140 seconds. Not tainted 4.19.172-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. kworker/u4:3 D26456 36 2 0x80000000 Workqueue: netns cleanup_net 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 _synchronize_rcu_expedited+0x419/0x6f0 kernel/rcu/tree_exp.h:686 synchronize_net+0x37/0x50 net/core/dev.c:9271 dev_deactivate_many+0x45a/0xe60 net/sched/sch_generic.c:1216 __dev_close_many+0x128/0x2e0 net/core/dev.c:1472 dev_close_many+0x24a/0x670 net/core/dev.c:1510 rollback_registered_many+0x2f7/0xe70 net/core/dev.c:8165 unregister_netdevice_many.part.0+0x1a/0x300 net/core/dev.c:9316 unregister_netdevice_many+0x36/0x50 net/core/dev.c:9315 ip_tunnel_delete_nets+0x3d3/0x580 net/ipv4/ip_tunnel.c:1078 ops_exit_list+0xf9/0x150 net/core/net_namespace.c:156 cleanup_net+0x3b4/0x8b0 net/core/net_namespace.c:553 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.0:8114 blocked for more than 140 seconds. Not tainted 4.19.172-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.0 D23256 8114 8113 0x00000000 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 exp_funnel_lock kernel/rcu/tree_exp.h:329 [inline] _synchronize_rcu_expedited+0x256/0x6f0 kernel/rcu/tree_exp.h:667 synchronize_rcu+0xc6/0x160 kernel/rcu/tree_plugin.h:818 namespace_unlock fs/namespace.c:1363 [inline] do_umount fs/namespace.c:1565 [inline] ksys_umount+0x88b/0x1070 fs/namespace.c:1660 __do_sys_umount fs/namespace.c:1671 [inline] __se_sys_umount fs/namespace.c:1669 [inline] __x64_sys_umount+0x50/0x70 fs/namespace.c:1669 do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x466f67 Code: Bad RIP value. RSP: 002b:00007ffd6973c0c8 EFLAGS: 00000246 ORIG_RAX: 00000000000000a6 RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 0000000000466f67 RDX: 00007ffd6973c19a RSI: 0000000000000002 RDI: 00007ffd6973c190 RBP: 00007ffd6973c190 R08: 00000000ffffffff R09: 00007ffd6973bf60 R10: 0000000002e9c8ab R11: 0000000000000246 R12: 00000000004af4e4 R13: 00007ffd6973d260 R14: 0000000002e9c810 R15: 00007ffd6973d2a0 INFO: task syz-executor.3:8120 blocked for more than 140 seconds. Not tainted 4.19.172-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.3 D24272 8120 8119 0x00000000 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_rcu+0xc6/0x160 kernel/rcu/tree_plugin.h:818 xt_replace_table+0x2ff/0x640 net/netfilter/x_tables.c:1394 __do_replace+0x1d7/0x870 net/ipv6/netfilter/ip6_tables.c:1087 do_replace net/ipv6/netfilter/ip6_tables.c:1160 [inline] do_ip6t_set_ctl+0x2d2/0x430 net/ipv6/netfilter/ip6_tables.c:1684 nf_sockopt net/netfilter/nf_sockopt.c:106 [inline] nf_setsockopt+0x6f/0xc0 net/netfilter/nf_sockopt.c:115 ipv6_setsockopt+0x103/0x160 net/ipv6/ipv6_sockglue.c:945 tcp_setsockopt+0x86/0xd0 net/ipv4/tcp.c:3097 __sys_setsockopt+0x14d/0x240 net/socket.c:1901 __do_sys_setsockopt net/socket.c:1912 [inline] __se_sys_setsockopt net/socket.c:1909 [inline] __x64_sys_setsockopt+0xba/0x150 net/socket.c:1909 do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x46714a Code: Bad RIP value. RSP: 002b:00007ffd15611e18 EFLAGS: 00000206 ORIG_RAX: 0000000000000036 RAX: ffffffffffffffda RBX: 0000000000000029 RCX: 000000000046714a RDX: 0000000000000040 RSI: 0000000000000029 RDI: 0000000000000003 RBP: 00007ffd15611e40 R08: 00000000000003b8 R09: 0079746972756365 R10: 0000000000539ba0 R11: 0000000000000206 R12: 00007ffd15611ea0 R13: 0000000000000003 R14: 00007ffd15611e3c R15: 0000000000539b40 INFO: task syz-executor.5:8124 blocked for more than 140 seconds. Not tainted 4.19.172-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.5 D23448 8124 8123 0x00000000 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 xt_find_table_lock+0x3d/0x430 net/netfilter/x_tables.c:1211 xt_request_find_table_lock+0x27/0xd0 net/netfilter/x_tables.c:1258 get_info+0x12f/0x4e0 net/ipv6/netfilter/ip6_tables.c:984 do_ip6t_get_ctl+0x14e/0x910 net/ipv6/netfilter/ip6_tables.c:1708 nf_sockopt net/netfilter/nf_sockopt.c:104 [inline] nf_getsockopt+0x72/0xd0 net/netfilter/nf_sockopt.c:122 ipv6_getsockopt+0x1b6/0x260 net/ipv6/ipv6_sockglue.c:1388 tcp_getsockopt+0x86/0xd0 net/ipv4/tcp.c:3618 __sys_getsockopt+0x135/0x210 net/socket.c:1938 __do_sys_getsockopt net/socket.c:1949 [inline] __se_sys_getsockopt net/socket.c:1946 [inline] __x64_sys_getsockopt+0xba/0x150 net/socket.c:1946 do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x46711a Code: Bad RIP value. RSP: 002b:00007ffdcdb13638 EFLAGS: 00000202 ORIG_RAX: 0000000000000037 RAX: ffffffffffffffda RBX: 0000000000000029 RCX: 000000000046711a RDX: 0000000000000040 RSI: 0000000000000029 RDI: 0000000000000003 RBP: 00007ffdcdb13660 R08: 00007ffdcdb1365c R09: 0079746972756365 R10: 00007ffdcdb13660 R11: 0000000000000202 R12: 0000000000000055 R13: 0000000000000003 R14: 00007ffdcdb1365c R15: 0000000000539b40 INFO: task kworker/u4:7:10146 blocked for more than 140 seconds. Not tainted 4.19.172-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. kworker/u4:7 D25832 10146 2 0x80000000 Workqueue: events_unbound fsnotify_connector_destroy_workfn 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_timeout+0x92d/0xfe0 kernel/time/timer.c:1794 do_wait_for_common kernel/sched/completion.c:83 [inline] __wait_for_common kernel/sched/completion.c:104 [inline] wait_for_common+0x29c/0x470 kernel/sched/completion.c:115 __synchronize_srcu+0x124/0x210 kernel/rcu/srcutree.c:936 fsnotify_connector_destroy_workfn+0x49/0xa0 fs/notify/mark.c:174 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.1:11653 blocked for more than 140 seconds. Not tainted 4.19.172-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.1 D27768 11653 8116 0x80000004 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:8997 vti6_exit_batch_net+0x414/0x620 net/ipv6/ip6_vti.c:1180 ops_exit_list+0xf9/0x150 net/core/net_namespace.c:156 setup_net+0x3d1/0x720 net/core/net_namespace.c:332 copy_net_ns+0x1f7/0x340 net/core/net_namespace.c:438 create_new_namespaces+0x3f6/0x7b0 kernel/nsproxy.c:107 unshare_nsproxy_namespaces+0xbd/0x1f0 kernel/nsproxy.c:206 ksys_unshare+0x36c/0x9a0 kernel/fork.c:2541 __do_sys_unshare kernel/fork.c:2609 [inline] __se_sys_unshare kernel/fork.c:2607 [inline] __x64_sys_unshare+0x2d/0x40 kernel/fork.c:2607 do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x465b09 Code: Bad RIP value. RSP: 002b:00007f99263de188 EFLAGS: 00000246 ORIG_RAX: 0000000000000110 RAX: ffffffffffffffda RBX: 000000000056c008 RCX: 0000000000465b09 RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000040040000 RBP: 00000000004b069f R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 000000000056c008 R13: 00007ffcb28f177f R14: 00007f99263de300 R15: 0000000000022000 INFO: task syz-executor.2:11744 blocked for more than 140 seconds. Not tainted 4.19.172-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.2 D28160 11744 8118 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 __netlink_dump_start+0x103/0x6f0 net/netlink/af_netlink.c:2297 netlink_dump_start include/linux/netlink.h:213 [inline] rtnetlink_rcv_msg+0x71e/0xb80 net/core/rtnetlink.c:4741 netlink_rcv_skb+0x160/0x440 net/netlink/af_netlink.c:2455 netlink_unicast_kernel net/netlink/af_netlink.c:1318 [inline] netlink_unicast+0x4d5/0x690 net/netlink/af_netlink.c:1344 netlink_sendmsg+0x6bb/0xc40 net/netlink/af_netlink.c:1909 sock_sendmsg_nosec net/socket.c:622 [inline] sock_sendmsg+0xc3/0x120 net/socket.c:632 ___sys_sendmsg+0x7bb/0x8e0 net/socket.c:2115 __sys_sendmsg net/socket.c:2153 [inline] __do_sys_sendmsg net/socket.c:2162 [inline] __se_sys_sendmsg net/socket.c:2160 [inline] __x64_sys_sendmsg+0x132/0x220 net/socket.c:2160 do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x465b09 Code: Bad RIP value. RSP: 002b:00007f87226f4188 EFLAGS: 00000246 ORIG_RAX: 000000000000002e RAX: ffffffffffffffda RBX: 000000000056bf60 RCX: 0000000000465b09 RDX: 0000000000000000 RSI: 0000000020000ac0 RDI: 0000000000000003 RBP: 00000000004b069f R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 000000000056bf60 R13: 00007ffdee6d61af R14: 00007f87226f4300 R15: 0000000000022000 Showing all locks held in the system: 3 locks held by kworker/1:0/19: #0: 00000000ac8cab96 ((wq_completion)"%s"("ipv6_addrconf")){+.+.}, at: process_one_work+0x767/0x1570 kernel/workqueue.c:2126 #1: 000000005b9f3a8f ((addr_chk_work).work){+.+.}, at: process_one_work+0x79c/0x1570 kernel/workqueue.c:2130 #2: 0000000033fe4b49 (rtnl_mutex){+.+.}, at: addrconf_verify_work+0xa/0x20 net/ipv6/addrconf.c:4476 2 locks held by kworker/u4:2/34: #0: 00000000cfa8228a ((wq_completion)"events_unbound"){+.+.}, at: process_one_work+0x767/0x1570 kernel/workqueue.c:2126 #1: 000000008ae0afb1 ((reaper_work).work){+.+.}, at: process_one_work+0x79c/0x1570 kernel/workqueue.c:2130 5 locks held by kworker/u4:3/36: #0: 0000000092c71826 ((wq_completion)"%s""netns"){+.+.}, at: process_one_work+0x767/0x1570 kernel/workqueue.c:2126 #1: 00000000d3fb6823 (net_cleanup_work){+.+.}, at: process_one_work+0x79c/0x1570 kernel/workqueue.c:2130 #2: 00000000ac4b00a7 (pernet_ops_rwsem){++++}, at: cleanup_net+0xa8/0x8b0 net/core/net_namespace.c:520 #3: 0000000033fe4b49 (rtnl_mutex){+.+.}, at: ip_tunnel_delete_nets+0x8e/0x580 net/ipv4/ip_tunnel.c:1073 #4: 000000005738f5d6 (rcu_preempt_state.exp_mutex){+.+.}, at: exp_funnel_lock kernel/rcu/tree_exp.h:297 [inline] #4: 000000005738f5d6 (rcu_preempt_state.exp_mutex){+.+.}, at: _synchronize_rcu_expedited+0x4dc/0x6f0 kernel/rcu/tree_exp.h:667 1 lock held by khungtaskd/1566: #0: 000000000df352e9 (rcu_read_lock){....}, at: debug_show_all_locks+0x53/0x265 kernel/locking/lockdep.c:4440 1 lock held by in:imklog/7780: #0: 00000000fb29ba82 (&f->f_pos_lock){+.+.}, at: __fdget_pos+0x26f/0x310 fs/file.c:767 1 lock held by syz-executor.0/8114: #0: 000000005738f5d6 (rcu_preempt_state.exp_mutex){+.+.}, at: exp_funnel_lock kernel/rcu/tree_exp.h:329 [inline] #0: 000000005738f5d6 (rcu_preempt_state.exp_mutex){+.+.}, at: _synchronize_rcu_expedited+0x256/0x6f0 kernel/rcu/tree_exp.h:667 1 lock held by syz-executor.3/8120: #0: 00000000936d1dca (&xt[i].mutex){+.+.}, at: xt_find_table_lock+0x3d/0x430 net/netfilter/x_tables.c:1211 1 lock held by syz-executor.5/8124: #0: 00000000936d1dca (&xt[i].mutex){+.+.}, at: xt_find_table_lock+0x3d/0x430 net/netfilter/x_tables.c:1211 3 locks held by kworker/0:3/8942: 2 locks held by kworker/u4:7/10146: #0: 00000000cfa8228a ((wq_completion)"events_unbound"){+.+.}, at: process_one_work+0x767/0x1570 kernel/workqueue.c:2126 #1: 000000008a541946 (connector_reaper_work){+.+.}, at: process_one_work+0x79c/0x1570 kernel/workqueue.c:2130 2 locks held by syz-executor.1/11653: #0: 00000000ac4b00a7 (pernet_ops_rwsem){++++}, at: copy_net_ns+0x1d8/0x340 net/core/net_namespace.c:434 #1: 0000000033fe4b49 (rtnl_mutex){+.+.}, at: netdev_run_todo+0x719/0xab0 net/core/dev.c:8997 1 lock held by syz-executor.2/11744: #0: 0000000033fe4b49 (rtnl_mutex){+.+.}, at: __netlink_dump_start+0x103/0x6f0 net/netlink/af_netlink.c:2297 ============================================= NMI backtrace for cpu 1 CPU: 1 PID: 1566 Comm: khungtaskd Not tainted 4.19.172-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/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: 8942 Comm: kworker/0:3 Not tainted 4.19.172-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 Workqueue: events rtc_timer_do_work RIP: 0010:mark_lock+0xc8/0x1160 kernel/locking/lockdep.c:3158 Code: 48 c1 ea 03 80 3c 02 00 0f 85 04 0d 00 00 4c 89 e0 48 23 43 30 0f 84 ad 00 00 00 b8 01 00 00 00 48 83 c4 18 5b 5d 41 5c 41 5d <41> 5e 41 5f c3 48 c7 c0 60 b7 23 8d 48 ba 00 00 00 00 00 fc ff df RSP: 0018:ffff88805524fa00 EFLAGS: 00000092 RAX: 0000000000000001 RBX: 0000000000000002 RCX: 1ffff11013722177 RDX: 1ffffffff19b2f02 RSI: ffff88809b910b98 RDI: ffffffff8cd97810 RBP: 0000000000000003 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000002 R13: ffff88809b9102c0 R14: ffff88809b910bb8 R15: 0000000000000002 FS: 0000000000000000(0000) GS:ffff8880ba000000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 00007f8c7eae1000 CR3: 00000000956df000 CR4: 00000000001406f0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: mark_held_locks+0xa6/0xf0 kernel/locking/lockdep.c:2809 __trace_hardirqs_on_caller kernel/locking/lockdep.c:2830 [inline] lockdep_hardirqs_on+0x288/0x5c0 kernel/locking/lockdep.c:2883 __raw_spin_unlock_irqrestore include/linux/spinlock_api_smp.h:160 [inline] _raw_spin_unlock_irqrestore+0x79/0xe0 kernel/locking/spinlock.c:184 spin_unlock_irqrestore include/linux/spinlock.h:384 [inline] __wake_up_common_lock+0xe0/0x170 kernel/sched/wait.c:122 rtc_handle_legacy_irq drivers/rtc/interface.c:627 [inline] rtc_uie_update_irq+0x74/0xa0 drivers/rtc/interface.c:654 rtc_timer_do_work+0x1ca/0xef0 drivers/rtc/interface.c:935 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