Bluetooth: hci4 command 0x0406 tx timeout Bluetooth: hci0 command 0x0406 tx timeout Bluetooth: hci1 command 0x0406 tx timeout Bluetooth: hci2 command 0x0406 tx timeout Bluetooth: hci5 command 0x0406 tx timeout BUG: workqueue lockup - pool cpus=1 node=0 flags=0x0 nice=0 stuck for 171s! INFO: task kworker/u4:0:5 blocked for more than 140 seconds. Showing busy workqueues and worker pools: workqueue events: flags=0x0 pwq 2: cpus=1 node=0 flags=0x0 nice=0 active=19/256 refcnt=20 Not tainted 4.14.215-syzkaller #0 in-flight: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. 9015:rtc_timer_do_work kworker/u4:0 D pending: 26408 5 2 0x80000000 destroy_super_work Workqueue: events_unbound fsnotify_mark_destroy_workfn , defense_work_handler, defense_work_handler, defense_work_handler, defense_work_handler, cache_reap, macvlan_process_broadcast, macvlan_process_broadcast, hci_cmd_timeout, macvlan_process_broadcast, macvlan_process_broadcast, perf_sched_delayed, macvlan_process_broadcast, macvlan_process_broadcast, macvlan_process_broadcast, macvlan_process_broadcast, sg_remove_sfp_usercontext, macvlan_process_broadcast workqueue events_long: flags=0x0 pwq 2: cpus=1 node=0 flags=0x0 nice=0 active=1/256 refcnt=2 pending: gc_worker workqueue events_unbound: flags=0x2 pwq 4: cpus=0-1 flags=0x4 nice=0 active=4/512 refcnt=7 in-flight: 5:fsnotify_mark_destroy_workfn fsnotify_mark_destroy_workfn, 22:fsnotify_connector_destroy_workfn fsnotify_connector_destroy_workfn workqueue events_power_efficient: flags=0x80 Call Trace: pwq 2: cpus=1 node=0 context_switch kernel/sched/core.c:2808 [inline] __schedule+0x88b/0x1de0 kernel/sched/core.c:3384 flags=0x0 nice=0 active=4/256 refcnt=5 pending: process_srcu, fb_flashcursor, neigh_periodic_work, check_lifetime workqueue mm_percpu_wq: flags=0x8 pwq 2: cpus=1 node=0 flags=0x0 nice=0 active=2/256 refcnt=4 pending: lru_add_drain_per_cpu BAR(13051), vmstat_update workqueue cgroup_destroy: flags=0x0 pwq 2: cpus=1 node=0 flags=0x0 nice=0 active=1/1 refcnt=3 pending: css_free_work_fn delayed: css_free_work_fn workqueue cgroup_pidlist_destroy: flags=0x0 pwq 2: cpus=1 node=0 flags=0x0 nice=0 active=1/1 refcnt=6 pending: cgroup_pidlist_destroy_work_fn delayed: cgroup_pidlist_destroy_work_fn, cgroup_pidlist_destroy_work_fn , cgroup_pidlist_destroy_work_fn schedule+0x8d/0x1b0 kernel/sched/core.c:3428 , cgroup_pidlist_destroy_work_fn workqueue ipv6_addrconf: flags=0x40008 schedule_timeout+0x80a/0xe90 kernel/time/timer.c:1724 pwq 2: cpus=1 node=0 flags=0x0 nice=0 active=1/1 refcnt=2 pending: addrconf_verify_work workqueue bat_events: flags=0xe000a pwq 4: cpus=0-1 flags=0x4 nice=0 active=1/1 refcnt=5 pending: do_wait_for_common kernel/sched/completion.c:91 [inline] __wait_for_common kernel/sched/completion.c:112 [inline] wait_for_common+0x272/0x430 kernel/sched/completion.c:123 batadv_dat_purge delayed: batadv_bla_periodic_work pool 2: cpus=1 node=0 flags=0x0 nice=0 hung=172s workers=6 idle: 2649 __synchronize_srcu+0x10a/0x1d0 kernel/rcu/srcutree.c:898 9405 18 9391 23 pool 4: cpus=0-1 flags=0x4 nice=0 hung=0s workers=7 idle: 2863 192 32 9302 9456 fsnotify_mark_destroy_workfn+0xed/0x2e0 fs/notify/mark.c:757 process_one_work+0x793/0x14a0 kernel/workqueue.c:2116 worker_thread+0x5cc/0xff0 kernel/workqueue.c:2250 kthread+0x30d/0x420 kernel/kthread.c:232 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:404 INFO: task kworker/u4:1:22 blocked for more than 140 seconds. Not tainted 4.14.215-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. kworker/u4:1 D26968 22 2 0x80000000 Workqueue: events_unbound fsnotify_connector_destroy_workfn Call Trace: context_switch kernel/sched/core.c:2808 [inline] __schedule+0x88b/0x1de0 kernel/sched/core.c:3384 schedule+0x8d/0x1b0 kernel/sched/core.c:3428 schedule_timeout+0x80a/0xe90 kernel/time/timer.c:1724 do_wait_for_common kernel/sched/completion.c:91 [inline] __wait_for_common kernel/sched/completion.c:112 [inline] wait_for_common+0x272/0x430 kernel/sched/completion.c:123 __synchronize_srcu+0x10a/0x1d0 kernel/rcu/srcutree.c:898 fsnotify_connector_destroy_workfn+0x49/0xa0 fs/notify/mark.c:156 process_one_work+0x793/0x14a0 kernel/workqueue.c:2116 worker_thread+0x5cc/0xff0 kernel/workqueue.c:2250 kthread+0x30d/0x420 kernel/kthread.c:232 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:404 INFO: task systemd-udevd:13034 blocked for more than 140 seconds. Not tainted 4.14.215-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. systemd-udevd D28648 13034 4627 0x00000100 Call Trace: context_switch kernel/sched/core.c:2808 [inline] __schedule+0x88b/0x1de0 kernel/sched/core.c:3384 schedule+0x8d/0x1b0 kernel/sched/core.c:3428 blk_queue_enter+0x3e2/0x4b0 block/blk-core.c:800 generic_make_request block/blk-core.c:2223 [inline] generic_make_request+0x19d/0x850 block/blk-core.c:2173 submit_bio+0x234/0x390 block/blk-core.c:2303 mpage_bio_submit fs/mpage.c:66 [inline] mpage_readpages+0x431/0x5f0 fs/mpage.c:393 read_pages mm/readahead.c:121 [inline] __do_page_cache_readahead+0x522/0x940 mm/readahead.c:199 force_page_cache_readahead+0x1ef/0x310 mm/readahead.c:232 page_cache_sync_readahead mm/readahead.c:513 [inline] page_cache_sync_readahead+0xca/0xf0 mm/readahead.c:503 generic_file_buffered_read mm/filemap.c:2003 [inline] generic_file_read_iter+0xfbc/0x21c0 mm/filemap.c:2273 blkdev_read_iter+0xfe/0x160 fs/block_dev.c:1946 call_read_iter include/linux/fs.h:1772 [inline] new_sync_read fs/read_write.c:401 [inline] __vfs_read+0x449/0x620 fs/read_write.c:413 vfs_read+0x139/0x340 fs/read_write.c:447 SYSC_read fs/read_write.c:574 [inline] SyS_read+0xf2/0x210 fs/read_write.c:567 do_syscall_64+0x1d5/0x640 arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x46/0xbb RIP: 0033:0x7fa1b2fdf210 RSP: 002b:00007ffd23b98018 EFLAGS: 00000246 ORIG_RAX: 0000000000000000 RAX: ffffffffffffffda RBX: 000055f8914205f0 RCX: 00007fa1b2fdf210 RDX: 0000000000000400 RSI: 000055f891420618 RDI: 000000000000000f RBP: 000055f891420430 R08: 00007fa1b2fc9f88 R09: 0000000000000430 R10: 000000000000006d R11: 0000000000000246 R12: 0000000000000000 R13: 0000000000000400 R14: 000055f891420480 R15: 0000000000000400 INFO: task syz-executor.5:13051 blocked for more than 140 seconds. Not tainted 4.14.215-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.5 D27616 13051 8020 0x00000004 Call Trace: context_switch kernel/sched/core.c:2808 [inline] __schedule+0x88b/0x1de0 kernel/sched/core.c:3384 schedule+0x8d/0x1b0 kernel/sched/core.c:3428 schedule_timeout+0x80a/0xe90 kernel/time/timer.c:1724 do_wait_for_common kernel/sched/completion.c:91 [inline] __wait_for_common kernel/sched/completion.c:112 [inline] wait_for_common+0x272/0x430 kernel/sched/completion.c:123 flush_work+0x3fe/0x770 kernel/workqueue.c:2893 lru_add_drain_all_cpuslocked+0x2e6/0x450 mm/swap.c:722 lru_add_drain_all+0xf/0x20 mm/swap.c:730 invalidate_bdev+0x8a/0xc0 fs/block_dev.c:109 loop_clr_fd+0x4c8/0xc20 drivers/block/loop.c:1062 lo_ioctl+0x895/0x1cd0 drivers/block/loop.c:1424 __blkdev_driver_ioctl block/ioctl.c:297 [inline] blkdev_ioctl+0x540/0x1830 block/ioctl.c:594 block_ioctl+0xd9/0x120 fs/block_dev.c:1893 vfs_ioctl fs/ioctl.c:46 [inline] file_ioctl fs/ioctl.c:500 [inline] do_vfs_ioctl+0x75a/0xff0 fs/ioctl.c:684 SYSC_ioctl fs/ioctl.c:701 [inline] SyS_ioctl+0x7f/0xb0 fs/ioctl.c:692 do_syscall_64+0x1d5/0x640 arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x46/0xbb RIP: 0033:0x45e087 RSP: 002b:00007f265263ca78 EFLAGS: 00000246 ORIG_RAX: 0000000000000010 RAX: ffffffffffffffda RBX: ffffffffffffffff RCX: 000000000045e087 RDX: 0000000000000000 RSI: 0000000000004c01 RDI: 0000000000000008 RBP: 00007f265263d6d4 R08: 00007f265263cb10 R09: 0000000020000000 R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000016 R13: 00000000200000c0 R14: 0000000020000600 R15: 0000000020000740 Showing all locks held in the system: 2 locks held by kworker/u4:0/5: #0: ("events_unbound"){+.+.}, at: [] process_one_work+0x6b0/0x14a0 kernel/workqueue.c:2087 #1: ((reaper_work).work){+.+.}, at: [] process_one_work+0x6e6/0x14a0 kernel/workqueue.c:2091 2 locks held by kworker/u4:1/22: #0: ("events_unbound"){+.+.}, at: [] process_one_work+0x6b0/0x14a0 kernel/workqueue.c:2087 #1: (connector_reaper_work){+.+.}, at: [] process_one_work+0x6e6/0x14a0 kernel/workqueue.c:2091 1 lock held by khungtaskd/1522: #0: (tasklist_lock){.+.+}, at: [] debug_show_all_locks+0x7c/0x21a kernel/locking/lockdep.c:4548 3 locks held by syz-executor.5/13051: #0: (&lo->lo_ctl_mutex/1){+.+.}, at: [] lo_ioctl+0x87/0x1cd0 drivers/block/loop.c:1414 #1: (cpu_hotplug_lock.rw_sem){++++}, at: [] get_online_cpus include/linux/cpu.h:145 [inline] #1: (cpu_hotplug_lock.rw_sem){++++}, at: [] lru_add_drain_all+0xa/0x20 mm/swap.c:729 #2: (lock#6){+.+.}, at: [] lru_add_drain_all_cpuslocked+0x6c/0x450 mm/swap.c:704 ============================================= NMI backtrace for cpu 0 CPU: 0 PID: 1522 Comm: khungtaskd Not tainted 4.14.215-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 Call Trace: __dump_stack lib/dump_stack.c:17 [inline] dump_stack+0x1b2/0x283 lib/dump_stack.c:58 nmi_cpu_backtrace.cold+0x57/0x93 lib/nmi_backtrace.c:101 nmi_trigger_cpumask_backtrace+0x13a/0x17f lib/nmi_backtrace.c:62 trigger_all_cpu_backtrace include/linux/nmi.h:140 [inline] check_hung_uninterruptible_tasks kernel/hung_task.c:195 [inline] watchdog+0x5b9/0xb40 kernel/hung_task.c:274 kthread+0x30d/0x420 kernel/kthread.c:232 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:404 Sending NMI from CPU 0 to CPUs 1: NMI backtrace for cpu 1 CPU: 1 PID: 4610 Comm: systemd-journal Not tainted 4.14.215-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 task: ffff8880a1f424c0 task.stack: ffff8880a1f48000 RIP: 0010:unwind_next_frame+0xf57/0x17d0 arch/x86/kernel/unwind_orc.c:474 RSP: 0018:ffff8880a1f4f9a0 EFLAGS: 00000246 RAX: 0000000000000001 RBX: 1ffff110143e9f3b RCX: ffffffff8a69e9c6 RDX: 0000000000000001 RSI: 0000000000000001 RDI: ffff8880a1f4fae0 RBP: 0000000000000001 R08: ffffffff8a69e9ca R09: 0000000000000003 R10: ffff8880a1f4fae8 R11: 0000000000000001 R12: ffff8880a1f4fb2d R13: ffff8880a1f4fb30 R14: ffff8880a1f4fb48 R15: ffff8880a1f4faf8 FS: 00007f325ea898c0(0000) GS:ffff8880ba500000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 00007f325bf1e000 CR3: 00000000a23d8000 CR4: 00000000001406e0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: __unwind_start+0x594/0x930 arch/x86/kernel/unwind_orc.c:583 unwind_start arch/x86/include/asm/unwind.h:60 [inline] __save_stack_trace+0x63/0x160 arch/x86/kernel/stacktrace.c:43 save_stack mm/kasan/kasan.c:447 [inline] set_track mm/kasan/kasan.c:459 [inline] kasan_kmalloc+0xeb/0x160 mm/kasan/kasan.c:551 slab_post_alloc_hook mm/slab.h:442 [inline] slab_alloc mm/slab.c:3390 [inline] kmem_cache_alloc+0x111/0x3c0 mm/slab.c:3550 getname_flags+0xc8/0x550 fs/namei.c:138 do_sys_open+0x1ce/0x410 fs/open.c:1075 do_syscall_64+0x1d5/0x640 arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x46/0xbb RIP: 0033:0x7f325e019840 RSP: 002b:00007ffe055e7ad8 EFLAGS: 00000246 ORIG_RAX: 0000000000000002 RAX: ffffffffffffffda RBX: 00007ffe055e7de0 RCX: 00007f325e019840 RDX: 00000000000001a0 RSI: 0000000000080042 RDI: 0000564ad3c282f0 RBP: 000000000000000d R08: 000000000000c0ff R09: 00000000ffffffff R10: 0000000000000069 R11: 0000000000000246 R12: 00000000ffffffff R13: 0000564ad3c1b040 R14: 00007ffe055e7da0 R15: 0000564ad3c28df0 Code: 41 84 c0 0f 85 d1 02 00 00 48 0f bf 71 02 4c 89 ff 4c 01 e6 e8 1b ef ff ff 84 c0 0f 85 46 fe ff ff e9 a8 f4 ff ff 4c 8b 54 24 58 <48> 8d 79 02 48 be 00 00 00 00 00 fc ff df 49 8d 57 40 48 89 f8