INFO: task kworker/0:1:24 blocked for more than 140 seconds. Not tainted 4.14.258-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. kworker/0:1 D27112 24 2 0x80000000 Workqueue: usb_hub_wq hub_event Call Trace: context_switch kernel/sched/core.c:2811 [inline] __schedule+0x88b/0x1de0 kernel/sched/core.c:3387 schedule+0x8d/0x1b0 kernel/sched/core.c:3431 usb_kill_urb.part.0+0x125/0x190 drivers/usb/core/urb.c:691 usb_kill_urb+0x7c/0x90 drivers/usb/core/urb.c:686 usb_start_wait_urb+0x209/0x440 drivers/usb/core/message.c:62 usb_internal_control_msg drivers/usb/core/message.c:100 [inline] usb_control_msg+0x302/0x450 drivers/usb/core/message.c:151 usb_get_descriptor+0xc0/0x160 drivers/usb/core/message.c:652 usb_get_device_descriptor+0x71/0xd0 drivers/usb/core/message.c:924 hub_port_init+0x590/0x28b0 drivers/usb/core/hub.c:4691 hub_port_connect drivers/usb/core/hub.c:4954 [inline] hub_port_connect_change drivers/usb/core/hub.c:5144 [inline] port_event drivers/usb/core/hub.c:5250 [inline] hub_event+0x1948/0x3f60 drivers/usb/core/hub.c:5330 process_one_work+0x793/0x14a0 kernel/workqueue.c:2117 worker_thread+0x5cc/0xff0 kernel/workqueue.c:2251 kthread+0x30d/0x420 kernel/kthread.c:232 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:404 INFO: task kworker/1:5:9604 blocked for more than 140 seconds. Not tainted 4.14.258-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. kworker/1:5 D28560 9604 2 0x80000000 Workqueue: usb_hub_wq hub_event Call Trace: context_switch kernel/sched/core.c:2811 [inline] __schedule+0x88b/0x1de0 kernel/sched/core.c:3387 schedule+0x8d/0x1b0 kernel/sched/core.c:3431 usb_kill_urb.part.0+0x125/0x190 drivers/usb/core/urb.c:691 usb_kill_urb+0x7c/0x90 drivers/usb/core/urb.c:686 usb_start_wait_urb+0x209/0x440 drivers/usb/core/message.c:62 usb_internal_control_msg drivers/usb/core/message.c:100 [inline] usb_control_msg+0x302/0x450 drivers/usb/core/message.c:151 usb_get_descriptor+0xc0/0x160 drivers/usb/core/message.c:652 usb_get_device_descriptor+0x71/0xd0 drivers/usb/core/message.c:924 hub_port_init+0x590/0x28b0 drivers/usb/core/hub.c:4691 hub_port_connect drivers/usb/core/hub.c:4954 [inline] hub_port_connect_change drivers/usb/core/hub.c:5144 [inline] port_event drivers/usb/core/hub.c:5250 [inline] hub_event+0x1948/0x3f60 drivers/usb/core/hub.c:5330 process_one_work+0x793/0x14a0 kernel/workqueue.c:2117 worker_thread+0x5cc/0xff0 kernel/workqueue.c:2251 kthread+0x30d/0x420 kernel/kthread.c:232 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:404 INFO: task kworker/1:2:18984 blocked for more than 140 seconds. Not tainted 4.14.258-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. kworker/1:2 D28560 18984 2 0x80000000 Workqueue: usb_hub_wq hub_event Call Trace: context_switch kernel/sched/core.c:2811 [inline] __schedule+0x88b/0x1de0 kernel/sched/core.c:3387 schedule+0x8d/0x1b0 kernel/sched/core.c:3431 schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:3489 __mutex_lock_common kernel/locking/mutex.c:833 [inline] __mutex_lock+0x669/0x1310 kernel/locking/mutex.c:893 hub_port_connect drivers/usb/core/hub.c:4921 [inline] hub_port_connect_change drivers/usb/core/hub.c:5144 [inline] port_event drivers/usb/core/hub.c:5250 [inline] hub_event+0x15ea/0x3f60 drivers/usb/core/hub.c:5330 process_one_work+0x793/0x14a0 kernel/workqueue.c:2117 worker_thread+0x5cc/0xff0 kernel/workqueue.c:2251 kthread+0x30d/0x420 kernel/kthread.c:232 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:404 INFO: task kworker/1:4:21082 blocked for more than 140 seconds. Not tainted 4.14.258-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. kworker/1:4 D28872 21082 2 0x80000000 Workqueue: usb_hub_wq hub_event Call Trace: context_switch kernel/sched/core.c:2811 [inline] __schedule+0x88b/0x1de0 kernel/sched/core.c:3387 schedule+0x8d/0x1b0 kernel/sched/core.c:3431 schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:3489 __mutex_lock_common kernel/locking/mutex.c:833 [inline] __mutex_lock+0x669/0x1310 kernel/locking/mutex.c:893 hub_port_connect drivers/usb/core/hub.c:4921 [inline] hub_port_connect_change drivers/usb/core/hub.c:5144 [inline] port_event drivers/usb/core/hub.c:5250 [inline] hub_event+0x15ea/0x3f60 drivers/usb/core/hub.c:5330 process_one_work+0x793/0x14a0 kernel/workqueue.c:2117 worker_thread+0x5cc/0xff0 kernel/workqueue.c:2251 kthread+0x30d/0x420 kernel/kthread.c:232 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:404 Showing all locks held in the system: 5 locks held by kworker/0:1/24: #0: ("usb_hub_wq"){+.+.}, at: [] process_one_work+0x6b0/0x14a0 kernel/workqueue.c:2088 #1: ((&hub->events)){+.+.}, at: [] process_one_work+0x6e6/0x14a0 kernel/workqueue.c:2092 #2: (&dev->mutex){....}, at: [] device_lock include/linux/device.h:1082 [inline] #2: (&dev->mutex){....}, at: [] hub_event+0x108/0x3f60 drivers/usb/core/hub.c:5276 #3: (&port_dev->status_lock){+.+.}, at: [] usb_lock_port drivers/usb/core/hub.c:2936 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_port_connect drivers/usb/core/hub.c:4920 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_port_connect_change drivers/usb/core/hub.c:5144 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] port_event drivers/usb/core/hub.c:5250 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_event+0x15c0/0x3f60 drivers/usb/core/hub.c:5330 #4: (hcd->address0_mutex){+.+.}, at: [] hub_port_connect drivers/usb/core/hub.c:4921 [inline] #4: (hcd->address0_mutex){+.+.}, at: [] hub_port_connect_change drivers/usb/core/hub.c:5144 [inline] #4: (hcd->address0_mutex){+.+.}, at: [] port_event drivers/usb/core/hub.c:5250 [inline] #4: (hcd->address0_mutex){+.+.}, at: [] hub_event+0x15ea/0x3f60 drivers/usb/core/hub.c:5330 2 locks held by kworker/u4:3/248: #0: ("events_unbound"){+.+.}, at: [] process_one_work+0x6b0/0x14a0 kernel/workqueue.c:2088 #1: ((&sub_info->work)){+.+.}, at: [] process_one_work+0x6e6/0x14a0 kernel/workqueue.c:2092 1 lock held by khungtaskd/1533: #0: (tasklist_lock){.+.+}, at: [] debug_show_all_locks+0x7c/0x21a kernel/locking/lockdep.c:4548 5 locks held by kworker/1:5/9604: #0: ("usb_hub_wq"){+.+.}, at: [] process_one_work+0x6b0/0x14a0 kernel/workqueue.c:2088 #1: ((&hub->events)){+.+.}, at: [] process_one_work+0x6e6/0x14a0 kernel/workqueue.c:2092 #2: (&dev->mutex){....}, at: [] device_lock include/linux/device.h:1082 [inline] #2: (&dev->mutex){....}, at: [] hub_event+0x108/0x3f60 drivers/usb/core/hub.c:5276 #3: (&port_dev->status_lock){+.+.}, at: [] usb_lock_port drivers/usb/core/hub.c:2936 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_port_connect drivers/usb/core/hub.c:4920 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_port_connect_change drivers/usb/core/hub.c:5144 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] port_event drivers/usb/core/hub.c:5250 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_event+0x15c0/0x3f60 drivers/usb/core/hub.c:5330 #4: (hcd->address0_mutex){+.+.}, at: [] hub_port_connect drivers/usb/core/hub.c:4921 [inline] #4: (hcd->address0_mutex){+.+.}, at: [] hub_port_connect_change drivers/usb/core/hub.c:5144 [inline] #4: (hcd->address0_mutex){+.+.}, at: [] port_event drivers/usb/core/hub.c:5250 [inline] #4: (hcd->address0_mutex){+.+.}, at: [] hub_event+0x15ea/0x3f60 drivers/usb/core/hub.c:5330 5 locks held by kworker/1:2/18984: #0: ("usb_hub_wq"){+.+.}, at: [] process_one_work+0x6b0/0x14a0 kernel/workqueue.c:2088 #1: ((&hub->events)){+.+.}, at: [] process_one_work+0x6e6/0x14a0 kernel/workqueue.c:2092 #2: (&dev->mutex){....}, at: [] device_lock include/linux/device.h:1082 [inline] #2: (&dev->mutex){....}, at: [] hub_event+0x108/0x3f60 drivers/usb/core/hub.c:5276 #3: (&port_dev->status_lock){+.+.}, at: [] usb_lock_port drivers/usb/core/hub.c:2936 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_port_connect drivers/usb/core/hub.c:4920 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_port_connect_change drivers/usb/core/hub.c:5144 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] port_event drivers/usb/core/hub.c:5250 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_event+0x15c0/0x3f60 drivers/usb/core/hub.c:5330 #4: (hcd->address0_mutex){+.+.}, at: [] hub_port_connect drivers/usb/core/hub.c:4921 [inline] #4: (hcd->address0_mutex){+.+.}, at: [] hub_port_connect_change drivers/usb/core/hub.c:5144 [inline] #4: (hcd->address0_mutex){+.+.}, at: [] port_event drivers/usb/core/hub.c:5250 [inline] #4: (hcd->address0_mutex){+.+.}, at: [] hub_event+0x15ea/0x3f60 drivers/usb/core/hub.c:5330 5 locks held by kworker/1:4/21082: #0: ("usb_hub_wq"){+.+.}, at: [] process_one_work+0x6b0/0x14a0 kernel/workqueue.c:2088 #1: ((&hub->events)){+.+.}, at: [] process_one_work+0x6e6/0x14a0 kernel/workqueue.c:2092 #2: (&dev->mutex){....}, at: [] device_lock include/linux/device.h:1082 [inline] #2: (&dev->mutex){....}, at: [] hub_event+0x108/0x3f60 drivers/usb/core/hub.c:5276 #3: (&port_dev->status_lock){+.+.}, at: [] usb_lock_port drivers/usb/core/hub.c:2936 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_port_connect drivers/usb/core/hub.c:4920 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_port_connect_change drivers/usb/core/hub.c:5144 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] port_event drivers/usb/core/hub.c:5250 [inline] #3: (&port_dev->status_lock){+.+.}, at: [] hub_event+0x15c0/0x3f60 drivers/usb/core/hub.c:5330 #4: (hcd->address0_mutex){+.+.}, at: [] hub_port_connect drivers/usb/core/hub.c:4921 [inline] #4: (hcd->address0_mutex){+.+.}, at: [] hub_port_connect_change drivers/usb/core/hub.c:5144 [inline] #4: (hcd->address0_mutex){+.+.}, at: [] port_event drivers/usb/core/hub.c:5250 [inline] #4: (hcd->address0_mutex){+.+.}, at: [] hub_event+0x15ea/0x3f60 drivers/usb/core/hub.c:5330 ============================================= NMI backtrace for cpu 1 CPU: 1 PID: 1533 Comm: khungtaskd Not tainted 4.14.258-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/0x281 lib/dump_stack.c:58 nmi_cpu_backtrace.cold+0x57/0x93 lib/nmi_backtrace.c:101 nmi_trigger_cpumask_backtrace+0x13a/0x180 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 1 to CPUs 0: NMI backtrace for cpu 0 CPU: 0 PID: 248 Comm: kworker/u4:3 Not tainted 4.14.258-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 Workqueue: events_unbound call_usermodehelper_exec_work task: ffff8880b4d76680 task.stack: ffff8880b5188000 RIP: 0010:__read_once_size include/linux/compiler.h:185 [inline] RIP: 0010:atomic_read arch/x86/include/asm/atomic.h:27 [inline] RIP: 0010:rcu_dynticks_curr_cpu_in_eqs kernel/rcu/tree.c:362 [inline] RIP: 0010:rcu_is_watching+0x5a/0xb0 kernel/rcu/tree.c:1130 RSP: 0018:ffff8880b518f7e8 EFLAGS: 00000a03 RAX: dffffc0000000000 RBX: ffff8880ba42ca80 RCX: 1ffffffff1198dac RDX: 0000000000000000 RSI: ffffffff87ccf200 RDI: ffff8880ba42ca8c RBP: ffff8880b4d76680 R08: 0000000000001000 R09: ffffed100a487000 R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000001 R13: ffff88813fffd1c0 R14: 00000000015080c0 R15: 0000000000400000 FS: 0000000000000000(0000) GS:ffff8880ba400000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 00007ffc9d32cd0c CR3: 000000004be8e000 CR4: 00000000003406f0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: rcu_read_lock_sched_held+0xc6/0x1d0 kernel/rcu/update.c:111 trace_mm_page_alloc include/trace/events/kmem.h:195 [inline] __alloc_pages_nodemask+0x1a6e/0x2720 mm/page_alloc.c:4214 __alloc_pages include/linux/gfp.h:484 [inline] __alloc_pages_node include/linux/gfp.h:497 [inline] alloc_pages_node include/linux/gfp.h:511 [inline] alloc_thread_stack_node kernel/fork.c:236 [inline] dup_task_struct kernel/fork.c:519 [inline] copy_process.part.0+0x265/0x71c0 kernel/fork.c:1631 copy_process kernel/fork.c:1606 [inline] _do_fork+0x184/0xc80 kernel/fork.c:2092 kernel_thread+0x2f/0x40 kernel/fork.c:2154 call_usermodehelper_exec_sync kernel/umh.c:132 [inline] call_usermodehelper_exec_work+0x97/0x2a0 kernel/umh.c:184 process_one_work+0x793/0x14a0 kernel/workqueue.c:2117 worker_thread+0x5cc/0xff0 kernel/workqueue.c:2251 kthread+0x30d/0x420 kernel/kthread.c:232 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:404 Code: 48 c1 e9 03 80 3c 11 00 75 5b 48 03 1c c5 60 6d cc 88 48 b8 00 00 00 00 00 fc ff df 48 8d 7b 0c 48 89 fa 48 c1 ea 03 0f b6 14 02 <48> 89 f8 83 e0 07 83 c0 03 38 d0 7c 04 84 d2 75 22 8b 43 0c d1 ---------------- Code disassembly (best guess): 0: 48 c1 e9 03 shr $0x3,%rcx 4: 80 3c 11 00 cmpb $0x0,(%rcx,%rdx,1) 8: 75 5b jne 0x65 a: 48 03 1c c5 60 6d cc add -0x773392a0(,%rax,8),%rbx 11: 88 12: 48 b8 00 00 00 00 00 movabs $0xdffffc0000000000,%rax 19: fc ff df 1c: 48 8d 7b 0c lea 0xc(%rbx),%rdi 20: 48 89 fa mov %rdi,%rdx 23: 48 c1 ea 03 shr $0x3,%rdx 27: 0f b6 14 02 movzbl (%rdx,%rax,1),%edx * 2b: 48 89 f8 mov %rdi,%rax <-- trapping instruction 2e: 83 e0 07 and $0x7,%eax 31: 83 c0 03 add $0x3,%eax 34: 38 d0 cmp %dl,%al 36: 7c 04 jl 0x3c 38: 84 d2 test %dl,%dl 3a: 75 22 jne 0x5e 3c: 8b 43 0c mov 0xc(%rbx),%eax 3f: d1 .byte 0xd1