INFO: task kworker/0:4:3094 blocked for more than 143 seconds. Not tainted 5.7.0-rc6-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. kworker/0:4 D23352 3094 2 0x80004000 Workqueue: usb_hub_wq hub_event Call Trace: context_switch kernel/sched/core.c:3367 [inline] __schedule+0x892/0x1d80 kernel/sched/core.c:4083 lock_downgrade+0x720/0x720 kernel/locking/lockdep.c:4599 __sched_text_start+0x8/0x8 mark_held_locks+0xe0/0xe0 kernel/locking/lockdep.c:3620 __trace_hardirqs_on_caller kernel/locking/lockdep.c:3657 [inline] lockdep_hardirqs_on+0x3c7/0x5d0 kernel/locking/lockdep.c:3702 schedule+0xcd/0x2b0 kernel/sched/core.c:4158 schedule_timeout+0x501/0x7d0 kernel/time/timer.c:1874 test_bit include/asm-generic/bitops/instrumented-non-atomic.h:110 [inline] hlock_class kernel/locking/lockdep.c:179 [inline] mark_lock+0x12b/0x1510 kernel/locking/lockdep.c:3912 find_held_lock+0x2d/0x110 kernel/locking/lockdep.c:4458 usleep_range+0x160/0x160 kernel/time/timer.c:2093 print_usage_bug+0x200/0x200 kernel/locking/lockdep.c:101 lock_downgrade+0x720/0x720 kernel/locking/lockdep.c:4599 mark_held_locks+0x9f/0xe0 kernel/locking/lockdep.c:3628 __raw_spin_unlock_irqrestore include/linux/spinlock_api_smp.h:160 [inline] _raw_spin_unlock_irqrestore+0x39/0x40 kernel/locking/spinlock.c:191 __raw_spin_unlock_irq include/linux/spinlock_api_smp.h:168 [inline] _raw_spin_unlock_irq+0x1f/0x30 kernel/locking/spinlock.c:199 do_wait_for_common kernel/sched/completion.c:85 [inline] __wait_for_common kernel/sched/completion.c:106 [inline] wait_for_common kernel/sched/completion.c:117 [inline] wait_for_completion+0x16f/0x280 kernel/sched/completion.c:138 wait_for_completion_interruptible+0x2f0/0x2f0 kernel/sched/completion.c:89 lock_is_held include/linux/lockdep.h:406 [inline] rcu_read_lock_sched_held+0x9c/0xd0 kernel/rcu/update.c:121 rcu_read_lock_bh_held+0xb0/0xb0 kernel/rcu/update.c:333 kthread_stop+0x17a/0x780 kernel/kthread.c:572 hwrng_unregister+0x24f/0x330 drivers/char/hw_random/core.c:556 chaoskey_disconnect+0x216/0x290 drivers/usb/misc/chaoskey.c:232 usb_unbind_interface+0x1bd/0x8a0 drivers/usb/core/driver.c:436 __pm_runtime_idle+0xd1/0x310 drivers/base/power/runtime.c:1021 usb_autoresume_device+0x60/0x60 include/linux/pm_runtime.h:252 __device_release_driver drivers/base/dd.c:1110 [inline] device_release_driver_internal+0x432/0x500 drivers/base/dd.c:1141 bus_remove_device+0x2eb/0x5a0 drivers/base/bus.c:533 device_del+0x481/0xd30 drivers/base/core.c:2715 device_create_with_groups+0x120/0x120 drivers/base/core.c:3308 usb_remove_ep_devs+0x3e/0x80 drivers/usb/core/endpoint.c:215 remove_intf_ep_devs+0x13f/0x1d0 drivers/usb/core/message.c:1121 usb_disable_device+0x23d/0x790 drivers/usb/core/message.c:1245 usb_disconnect+0x293/0x900 drivers/usb/core/hub.c:2217 hub_port_connect drivers/usb/core/hub.c:5059 [inline] hub_port_connect_change drivers/usb/core/hub.c:5348 [inline] port_event drivers/usb/core/hub.c:5494 [inline] hub_event+0x1abf/0x43c0 drivers/usb/core/hub.c:5576 hub_port_debounce+0x350/0x350 drivers/usb/core/hub.c:4441 __x64_sys_sysinfo+0x30/0x40 kernel/sys.c:2604 lock_is_held include/linux/lockdep.h:406 [inline] rcu_read_lock_sched_held+0x9c/0xd0 kernel/rcu/update.c:121 rcu_read_lock_bh_held+0xb0/0xb0 kernel/rcu/update.c:333 __raw_spin_unlock_irq include/linux/spinlock_api_smp.h:168 [inline] _raw_spin_unlock_irq+0x1f/0x30 kernel/locking/spinlock.c:199 process_one_work+0x965/0x1630 kernel/workqueue.c:2268 lock_release+0x720/0x720 kernel/locking/lockdep.c:4689 pwq_dec_nr_in_flight+0x310/0x310 kernel/workqueue.c:1198 rwlock_bug.part.0+0x90/0x90 include/linux/sched.h:1332 wq_worker_sleeping+0x4e/0x200 kernel/workqueue.c:874 worker_thread+0x96/0xe20 kernel/workqueue.c:2414 process_one_work+0x1630/0x1630 kernel/workqueue.c:1029 kthread+0x326/0x430 kernel/kthread.c:268 kthread_create_on_node+0xf0/0xf0 kernel/kthread.c:405 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:351 INFO: task kworker/0:5:3162 blocked for more than 143 seconds. Not tainted 5.7.0-rc6-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. kworker/0:5 D23720 3162 2 0x80004000 Workqueue: usb_hub_wq hub_event Call Trace: context_switch kernel/sched/core.c:3367 [inline] __schedule+0x892/0x1d80 kernel/sched/core.c:4083 lock_downgrade+0x720/0x720 kernel/locking/lockdep.c:4599 __sched_text_start+0x8/0x8 mark_held_locks+0xe0/0xe0 kernel/locking/lockdep.c:3620 __trace_hardirqs_on_caller kernel/locking/lockdep.c:3657 [inline] lockdep_hardirqs_on+0x3c7/0x5d0 kernel/locking/lockdep.c:3702 schedule+0xcd/0x2b0 kernel/sched/core.c:4158 schedule_timeout+0x501/0x7d0 kernel/time/timer.c:1874 test_bit include/asm-generic/bitops/instrumented-non-atomic.h:110 [inline] hlock_class kernel/locking/lockdep.c:179 [inline] mark_lock+0x12b/0x1510 kernel/locking/lockdep.c:3912 find_held_lock+0x2d/0x110 kernel/locking/lockdep.c:4458 usleep_range+0x160/0x160 kernel/time/timer.c:2093 print_usage_bug+0x200/0x200 kernel/locking/lockdep.c:101 lock_downgrade+0x720/0x720 kernel/locking/lockdep.c:4599 mark_held_locks+0x9f/0xe0 kernel/locking/lockdep.c:3628 __raw_spin_unlock_irq include/linux/spinlock_api_smp.h:168 [inline] _raw_spin_unlock_irq+0x1f/0x30 kernel/locking/spinlock.c:199 do_wait_for_common kernel/sched/completion.c:85 [inline] __wait_for_common kernel/sched/completion.c:106 [inline] wait_for_common kernel/sched/completion.c:117 [inline] wait_for_completion+0x16f/0x280 kernel/sched/completion.c:138 wait_for_completion_interruptible+0x2f0/0x2f0 kernel/sched/completion.c:89 lock_is_held include/linux/lockdep.h:406 [inline] rcu_read_lock_sched_held+0x9c/0xd0 kernel/rcu/update.c:121 rcu_read_lock_bh_held+0xb0/0xb0 kernel/rcu/update.c:333 kthread_stop+0x17a/0x780 kernel/kthread.c:572 hwrng_unregister+0x24f/0x330 drivers/char/hw_random/core.c:556 chaoskey_disconnect+0x216/0x290 drivers/usb/misc/chaoskey.c:232 usb_unbind_interface+0x1bd/0x8a0 drivers/usb/core/driver.c:436 __pm_runtime_idle+0xd1/0x310 drivers/base/power/runtime.c:1021 usb_autoresume_device+0x60/0x60 include/linux/pm_runtime.h:252 __device_release_driver drivers/base/dd.c:1110 [inline] device_release_driver_internal+0x432/0x500 drivers/base/dd.c:1141 bus_remove_device+0x2eb/0x5a0 drivers/base/bus.c:533 device_del+0x481/0xd30 drivers/base/core.c:2715 device_create_with_groups+0x120/0x120 drivers/base/core.c:3308 usb_remove_ep_devs+0x3e/0x80 drivers/usb/core/endpoint.c:215 remove_intf_ep_devs+0x13f/0x1d0 drivers/usb/core/message.c:1121 usb_disable_device+0x23d/0x790 drivers/usb/core/message.c:1245 usb_disconnect+0x293/0x900 drivers/usb/core/hub.c:2217 hub_port_connect drivers/usb/core/hub.c:5059 [inline] hub_port_connect_change drivers/usb/core/hub.c:5348 [inline] port_event drivers/usb/core/hub.c:5494 [inline] hub_event+0x1abf/0x43c0 drivers/usb/core/hub.c:5576 hub_port_debounce+0x350/0x350 drivers/usb/core/hub.c:4441 __x64_sys_sysinfo+0x30/0x40 kernel/sys.c:2604 lock_is_held include/linux/lockdep.h:406 [inline] rcu_read_lock_sched_held+0x9c/0xd0 kernel/rcu/update.c:121 rcu_read_lock_bh_held+0xb0/0xb0 kernel/rcu/update.c:333 __raw_spin_unlock_irq include/linux/spinlock_api_smp.h:168 [inline] _raw_spin_unlock_irq+0x1f/0x30 kernel/locking/spinlock.c:199 process_one_work+0x965/0x1630 kernel/workqueue.c:2268 lock_release+0x720/0x720 kernel/locking/lockdep.c:4689 pwq_dec_nr_in_flight+0x310/0x310 kernel/workqueue.c:1198 rwlock_bug.part.0+0x90/0x90 include/linux/sched.h:1332 worker_thread+0x96/0xe20 kernel/workqueue.c:2414 process_one_work+0x1630/0x1630 kernel/workqueue.c:1029 kthread+0x326/0x430 kernel/kthread.c:268 kthread_create_on_node+0xf0/0xf0 kernel/kthread.c:405 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:351 Showing all locks held in the system: 3 locks held by kworker/1:1/21: #0: ffff8881da028d38 ((wq_completion)events){+.+.}-{0:0}, at: __write_once_size include/linux/compiler.h:226 [inline] #0: ffff8881da028d38 ((wq_completion)events){+.+.}-{0:0}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline] #0: ffff8881da028d38 ((wq_completion)events){+.+.}-{0:0}, at: atomic64_set include/asm-generic/atomic-instrumented.h:855 [inline] #0: ffff8881da028d38 ((wq_completion)events){+.+.}-{0:0}, at: atomic_long_set include/asm-generic/atomic-long.h:40 [inline] #0: ffff8881da028d38 ((wq_completion)events){+.+.}-{0:0}, at: set_work_data kernel/workqueue.c:615 [inline] #0: ffff8881da028d38 ((wq_completion)events){+.+.}-{0:0}, at: set_work_pool_and_clear_pending kernel/workqueue.c:642 [inline] #0: ffff8881da028d38 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0x844/0x1630 kernel/workqueue.c:2239 #1: ffff8881da317dc0 ((work_completion)(&fw_work->work)){+.+.}-{0:0}, at: process_one_work+0x878/0x1630 kernel/workqueue.c:2243 #2: ffff8881d4af3218 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:768 [inline] #2: ffff8881d4af3218 (&dev->mutex){....}-{3:3}, at: ath9k_hif_usb_firmware_fail drivers/net/wireless/ath/ath9k/hif_usb.c:1077 [inline] #2: ffff8881d4af3218 (&dev->mutex){....}-{3:3}, at: ath9k_hif_usb_firmware_cb+0x388/0x510 drivers/net/wireless/ath/ath9k/hif_usb.c:1210 1 lock held by khungtaskd/23: #0: ffffffff87111260 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x53/0x264 kernel/locking/lockdep.c:5754 6 locks held by kworker/0:2/95: 2 locks held by systemd-journal/148: #0: ffff8881db334958 (&rq->lock){-.-.}-{2:2}, at: newidle_balance+0xa14/0xe30 kernel/sched/fair.c:10512 #1: ffffffff87111260 (rcu_read_lock){....}-{1:2}, at: __update_idle_core+0x42/0x3f0 kernel/sched/fair.c:5969 1 lock held by in:imklog/273: 5 locks held by kworker/0:4/3094: #0: ffff8881d8d79d38 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: __write_once_size include/linux/compiler.h:226 [inline] #0: ffff8881d8d79d38 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline] #0: ffff8881d8d79d38 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: atomic64_set include/asm-generic/atomic-instrumented.h:855 [inline] #0: ffff8881d8d79d38 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: atomic_long_set include/asm-generic/atomic-long.h:40 [inline] #0: ffff8881d8d79d38 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: set_work_data kernel/workqueue.c:615 [inline] #0: ffff8881d8d79d38 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: set_work_pool_and_clear_pending kernel/workqueue.c:642 [inline] #0: ffff8881d8d79d38 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: process_one_work+0x844/0x1630 kernel/workqueue.c:2239 #1: ffff8881ac0afdc0 ((work_completion)(&hub->events)){+.+.}-{0:0}, at: process_one_work+0x878/0x1630 kernel/workqueue.c:2243 #2: ffff8881d4ad3218 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:768 [inline] #2: ffff8881d4ad3218 (&dev->mutex){....}-{3:3}, at: hub_event+0x1be/0x43c0 drivers/usb/core/hub.c:5522 #3: ffff8881cc25e218 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:768 [inline] #3: ffff8881cc25e218 (&dev->mutex){....}-{3:3}, at: usb_disconnect+0x91/0x900 drivers/usb/core/hub.c:2208 #4: ffff8881c9f3b1a8 (&dev->mutex){....}-{3:3}, at: device_release_driver_internal+0x23/0x500 drivers/base/dd.c:1138 5 locks held by kworker/0:5/3162: #0: ffff8881d8d79d38 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: __write_once_size include/linux/compiler.h:226 [inline] #0: ffff8881d8d79d38 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline] #0: ffff8881d8d79d38 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: atomic64_set include/asm-generic/atomic-instrumented.h:855 [inline] #0: ffff8881d8d79d38 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: atomic_long_set include/asm-generic/atomic-long.h:40 [inline] #0: ffff8881d8d79d38 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: set_work_data kernel/workqueue.c:615 [inline] #0: ffff8881d8d79d38 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: set_work_pool_and_clear_pending kernel/workqueue.c:642 [inline] #0: ffff8881d8d79d38 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: process_one_work+0x844/0x1630 kernel/workqueue.c:2239 #1: ffff8881ca0a7dc0 ((work_completion)(&hub->events)){+.+.}-{0:0}, at: process_one_work+0x878/0x1630 kernel/workqueue.c:2243 #2: ffff8881d4b0b218 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:768 [inline] #2: ffff8881d4b0b218 (&dev->mutex){....}-{3:3}, at: hub_event+0x1be/0x43c0 drivers/usb/core/hub.c:5522 #3: ffff8881c6f4e218 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:768 [inline] #3: ffff8881c6f4e218 (&dev->mutex){....}-{3:3}, at: usb_disconnect+0x91/0x900 drivers/usb/core/hub.c:2208 #4: ffff8881d05c41a8 (&dev->mutex){....}-{3:3}, at: device_release_driver_internal+0x23/0x500 drivers/base/dd.c:1138 5 locks held by kworker/0:6/3172: 3 locks held by kworker/0:8/3447: ============================================= NMI backtrace for cpu 0 CPU: 0 PID: 23 Comm: khungtaskd Not tainted 5.7.0-rc6-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+0xef/0x16e lib/dump_stack.c:118 irq_force_complete_move.cold+0x13/0x47 arch/x86/kernel/apic/vector.c:1023 nmi_cpu_backtrace.cold+0x70/0xb1 lib/nmi_backtrace.c:101 lapic_can_unplug_cpu.cold+0x3b/0x3b nmi_trigger_cpumask_backtrace+0x1db/0x207 lib/nmi_backtrace.c:62 trigger_all_cpu_backtrace include/linux/nmi.h:146 [inline] check_hung_uninterruptible_tasks kernel/hung_task.c:205 [inline] watchdog+0xa99/0xfd0 kernel/hung_task.c:289 reset_hung_task_detector+0x30/0x30 kernel/hung_task.c:243 kthread+0x326/0x430 kernel/kthread.c:268 kthread_create_on_node+0xf0/0xf0 kernel/kthread.c:405 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:351 Sending NMI from CPU 0 to CPUs 1: NMI backtrace for cpu 1 CPU: 1 PID: 148 Comm: systemd-journal Not tainted 5.7.0-rc6-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 RIP: 0010:___bpf_prog_run+0x4422/0x6a60 kernel/bpf/core.c:1585 Code: e2 07 0f b6 04 18 38 d0 7f 08 84 c0 0f 85 19 1d 00 00 41 0f b6 47 01 83 e0 0f 4c 8d 74 c5 00 4c 89 f0 48 c1 e8 03 80 3c 18 00 <0f> 85 01 21 00 00 49 8d 7f 04 49 8b 16 48 89 f8 48 c1 e8 03 0f b6 RSP: 0018:ffff8881d18dfb20 EFLAGS: 00000246 RAX: 1ffff1103a31bf7d RBX: dffffc0000000000 RCX: ffffffff814aa832 RDX: 0000000000000001 RSI: ffffffff814aa7b9 RDI: ffffc900008cc0b1 RBP: ffff8881d18dfbe8 R08: ffff8881d1eb18c0 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000000 R12: ffffed103a31bf7f R13: 0000000000000000 R14: ffff8881d18dfbe8 R15: ffffc900008cc0b0 FS: 00007f7f2584f8c0(0000) GS:ffff8881db300000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 00007f7f22fbd000 CR3: 00000001d1e00000 CR4: 00000000001406e0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: find_held_lock+0x2d/0x110 kernel/locking/lockdep.c:4458 __bpf_prog_run32+0x8f/0xd0 kernel/bpf/core.c:1681 __bpf_prog_run64+0xd0/0xd0 kernel/bpf/core.c:1681 test_bit include/asm-generic/bitops/instrumented-non-atomic.h:110 [inline] hlock_class kernel/locking/lockdep.c:179 [inline] mark_lock+0x12b/0x1510 kernel/locking/lockdep.c:3912 wait_for_completion+0x280/0x280 __raw_write_unlock_irq include/linux/rwlock_api_smp.h:267 [inline] _raw_write_unlock_irq+0x1f/0x30 kernel/locking/spinlock.c:343 test_bit include/asm-generic/bitops/instrumented-non-atomic.h:110 [inline] hlock_class kernel/locking/lockdep.c:179 [inline] __lock_acquire+0xcb8/0x6650 kernel/locking/lockdep.c:4352 bpf_dispatcher_nop_func include/linux/bpf.h:545 [inline] bpf_prog_run_pin_on_cpu include/linux/filter.h:599 [inline] seccomp_run_filters kernel/seccomp.c:272 [inline] __seccomp_filter+0x156/0x1300 kernel/seccomp.c:817 seccomp_notify_release+0x290/0x290 kernel/seccomp.c:1018 mark_held_locks+0xe0/0xe0 kernel/locking/lockdep.c:3620 ep_send_events_proc+0xc30/0xc30 include/linux/list.h:72 lock_downgrade+0x720/0x720 kernel/locking/lockdep.c:4599 __secure_computing+0xac/0x280 kernel/seccomp.c:950 syscall_trace_enter+0x2a3/0xcd0 arch/x86/entry/common.c:119 syscall_slow_exit_work+0x5f0/0x5f0 include/linux/tracehook.h:75 trace_hardirqs_off_caller+0x55/0x200 kernel/trace/trace_preemptirq.c:73 do_syscall_64+0x462/0x5a0 arch/x86/entry/common.c:291 entry_SYSCALL_64_after_hwframe+0x49/0xb3 RIP: 0033:0x7f7f24ddf210 Code: 73 01 c3 48 8b 0d 98 7d 20 00 f7 d8 64 89 01 48 83 c8 ff c3 66 0f 1f 44 00 00 83 3d b9 c1 20 00 00 75 10 b8 00 00 00 00 0f 05 <48> 3d 01 f0 ff ff 73 31 c3 48 83 ec 08 e8 4e fc ff ff 48 89 04 24 RSP: 002b:00007ffc222ceed8 EFLAGS: 00000246 ORIG_RAX: 0000000000000000 RAX: ffffffffffffffda RBX: 00007ffc222d1950 RCX: 00007f7f24ddf210 RDX: 0000000000002000 RSI: 00007ffc222cf750 RDI: 0000000000000009 RBP: 0000000000000000 R08: 0000000000000008 R09: 000000000000022c R10: 00000000ffffffff R11: 0000000000000246 R12: 00007ffc222cf750 R13: 00007ffc222d18a8 R14: 00005633abd0b958 R15: 0005a7a5d6252873