INFO: task kworker/0:2:102 blocked for more than 143 seconds. Not tainted 5.3.0-rc7+ #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. kworker/0:2 D24544 102 2 0x80004000 Workqueue: usb_hub_wq hub_event Call Trace: schedule+0xca/0x250 kernel/sched/core.c:3947 schedule_timeout+0x440/0xb20 kernel/time/timer.c:1807 usb_start_wait_urb.constprop.0+0x29d/0x2e0 drivers/net/usb/kaweth.c:1238 kaweth_internal_control_msg drivers/net/usb/kaweth.c:1274 [inline] kaweth_control.constprop.0+0x360/0x490 drivers/net/usb/kaweth.c:269 kaweth_read_configuration drivers/net/usb/kaweth.c:287 [inline] kaweth_probe.cold+0xeb/0x1205 drivers/net/usb/kaweth.c:1065 usb_probe_interface+0x305/0x7a0 drivers/usb/core/driver.c:361 really_probe+0x281/0x6d0 drivers/base/dd.c:548 driver_probe_device+0x101/0x1b0 drivers/base/dd.c:721 __device_attach_driver+0x1c2/0x220 drivers/base/dd.c:828 bus_for_each_drv+0x162/0x1e0 drivers/base/bus.c:454 __device_attach+0x217/0x360 drivers/base/dd.c:894 bus_probe_device+0x1e4/0x290 drivers/base/bus.c:514 device_add+0xae6/0x16f0 drivers/base/core.c:2165 usb_set_configuration+0xdf6/0x1670 drivers/usb/core/message.c:2023 generic_probe+0x9d/0xd5 drivers/usb/core/generic.c:210 usb_probe_device+0x99/0x100 drivers/usb/core/driver.c:266 really_probe+0x281/0x6d0 drivers/base/dd.c:548 driver_probe_device+0x101/0x1b0 drivers/base/dd.c:721 __device_attach_driver+0x1c2/0x220 drivers/base/dd.c:828 bus_for_each_drv+0x162/0x1e0 drivers/base/bus.c:454 __device_attach+0x217/0x360 drivers/base/dd.c:894 bus_probe_device+0x1e4/0x290 drivers/base/bus.c:514 device_add+0xae6/0x16f0 drivers/base/core.c:2165 usb_new_device.cold+0x6a4/0xe79 drivers/usb/core/hub.c:2536 hub_port_connect drivers/usb/core/hub.c:5098 [inline] hub_port_connect_change drivers/usb/core/hub.c:5213 [inline] port_event drivers/usb/core/hub.c:5359 [inline] hub_event+0x1b5c/0x3640 drivers/usb/core/hub.c:5441 process_one_work+0x92b/0x1530 kernel/workqueue.c:2269 worker_thread+0x96/0xe20 kernel/workqueue.c:2415 kthread+0x318/0x420 kernel/kthread.c:255 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:352 INFO: task syz-executor.0:8494 blocked for more than 144 seconds. Not tainted 5.3.0-rc7+ #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.0 D28520 8494 1746 0x80004006 Call Trace: schedule+0xca/0x250 kernel/sched/core.c:3947 wdm_flush+0x2ea/0x3c0 drivers/usb/class/cdc-wdm.c:590 filp_close+0xb4/0x160 fs/open.c:1166 close_files fs/file.c:388 [inline] put_files_struct fs/file.c:416 [inline] put_files_struct+0x1d8/0x2e0 fs/file.c:413 exit_files+0x7e/0xa0 fs/file.c:445 do_exit+0x8bc/0x2c00 kernel/exit.c:874 do_group_exit+0x125/0x340 kernel/exit.c:983 get_signal+0x466/0x23d0 kernel/signal.c:2734 do_signal+0x88/0x14e0 arch/x86/kernel/signal.c:815 exit_to_usermode_loop+0x1a2/0x200 arch/x86/entry/common.c:159 prepare_exit_to_usermode arch/x86/entry/common.c:194 [inline] syscall_return_slowpath arch/x86/entry/common.c:274 [inline] do_syscall_64+0x45f/0x580 arch/x86/entry/common.c:299 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x457db1 Code: Bad RIP value. RSP: 002b:00007ffca1ebd640 EFLAGS: 00000293 ORIG_RAX: 0000000000000023 RAX: fffffffffffffdfc RBX: 0000000000065971 RCX: 0000000000457db1 RDX: 0000000000000000 RSI: 0000000000000000 RDI: 00007ffca1ebd650 RBP: 0000000000000001 R08: 00000000522aaf4f R09: 00000000522aaf53 R10: 00007ffca1ebd740 R11: 0000000000000293 R12: 000000000075bf20 R13: 000000000075c9a0 R14: 0000000000760508 R15: 000000000075bfd4 INFO: task syz-executor.2:8558 blocked for more than 145 seconds. Not tainted 5.3.0-rc7+ #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.2 D29160 8558 1760 0x00000004 Call Trace: schedule+0xca/0x250 kernel/sched/core.c:3947 wdm_flush+0x2ea/0x3c0 drivers/usb/class/cdc-wdm.c:590 filp_close+0xb4/0x160 fs/open.c:1166 __close_fd+0x133/0x200 fs/file.c:636 __do_sys_close fs/open.c:1185 [inline] __se_sys_close fs/open.c:1183 [inline] __x64_sys_close+0x69/0x100 fs/open.c:1183 do_syscall_64+0xb7/0x580 arch/x86/entry/common.c:296 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x4135d1 Code: 41 b9 b0 20 41 00 41 b8 0c 98 65 00 ba 05 00 00 00 bf 5c 38 44 00 ff 15 b5 a0 24 00 85 c0 0f 85 6f fd ff ff 31 c9 31 f6 41 b9 20 41 00 41 b8 10 98 65 00 ba 04 00 00 00 bf 6b 38 44 00 ff 15 RSP: 002b:00007fd9454e2c40 EFLAGS: 00000293 ORIG_RAX: 0000000000000003 RAX: ffffffffffffffda RBX: 0000000000000001 RCX: 00000000004135d1 RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000000 RBP: 000000000075bf20 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000293 R12: 00007fd9454e36d4 R13: 00000000004befba R14: 00000000004e01d0 R15: 00000000ffffffff Showing all locks held in the system: 3 locks held by ksoftirqd/0/9: #0: 00000000ca96bb58 (&rq->lock){-.-.}, at: idle_balance kernel/sched/fair.c:9869 [inline] #0: 00000000ca96bb58 (&rq->lock){-.-.}, at: pick_next_task_fair+0xaf9/0x1910 kernel/sched/fair.c:6906 #1: 00000000ca96bb58 (&rq->lock){-.-.}, at: rq_lock kernel/sched/sched.h:1207 [inline] #1: 00000000ca96bb58 (&rq->lock){-.-.}, at: attach_tasks kernel/sched/fair.c:7501 [inline] #1: 00000000ca96bb58 (&rq->lock){-.-.}, at: load_balance+0xada/0x24c0 kernel/sched/fair.c:8901 #2: 00000000c8b5a577 (rcu_read_lock){....}, at: trace_sched_stat_runtime include/trace/events/sched.h:435 [inline] #2: 00000000c8b5a577 (rcu_read_lock){....}, at: update_curr+0x27f/0x810 kernel/sched/fair.c:861 1 lock held by khungtaskd/23: #0: 00000000c8b5a577 (rcu_read_lock){....}, at: debug_show_all_locks+0x53/0x269 kernel/locking/lockdep.c:5254 5 locks held by kworker/0:2/102: #0: 00000000e0cef7a8 ((wq_completion)usb_hub_wq){+.+.}, at: __write_once_size include/linux/compiler.h:226 [inline] #0: 00000000e0cef7a8 ((wq_completion)usb_hub_wq){+.+.}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline] #0: 00000000e0cef7a8 ((wq_completion)usb_hub_wq){+.+.}, at: atomic64_set include/asm-generic/atomic-instrumented.h:855 [inline] #0: 00000000e0cef7a8 ((wq_completion)usb_hub_wq){+.+.}, at: atomic_long_set include/asm-generic/atomic-long.h:40 [inline] #0: 00000000e0cef7a8 ((wq_completion)usb_hub_wq){+.+.}, at: set_work_data kernel/workqueue.c:620 [inline] #0: 00000000e0cef7a8 ((wq_completion)usb_hub_wq){+.+.}, at: set_work_pool_and_clear_pending kernel/workqueue.c:647 [inline] #0: 00000000e0cef7a8 ((wq_completion)usb_hub_wq){+.+.}, at: process_one_work+0x827/0x1530 kernel/workqueue.c:2240 #1: 0000000076e1f6c5 ((work_completion)(&hub->events)){+.+.}, at: process_one_work+0x85b/0x1530 kernel/workqueue.c:2244 #2: 00000000f5a9c3a5 (&dev->mutex){....}, at: device_lock include/linux/device.h:1223 [inline] #2: 00000000f5a9c3a5 (&dev->mutex){....}, at: hub_event+0x17c/0x3640 drivers/usb/core/hub.c:5387 #3: 00000000ef6263e7 (&dev->mutex){....}, at: device_lock include/linux/device.h:1223 [inline] #3: 00000000ef6263e7 (&dev->mutex){....}, at: __device_attach+0x7b/0x360 drivers/base/dd.c:871 #4: 000000007795c505 (&dev->mutex){....}, at: device_lock include/linux/device.h:1223 [inline] #4: 000000007795c505 (&dev->mutex){....}, at: __device_attach+0x7b/0x360 drivers/base/dd.c:871 1 lock held by rsyslogd/1605: 2 locks held by getty/1695: #0: 00000000aee731ae (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x22/0x80 drivers/tty/tty_ldisc.c:272 #1: 000000009e15e62c (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x223/0x1ae0 drivers/tty/n_tty.c:2156 2 locks held by getty/1696: #0: 000000009bed87e7 (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x22/0x80 drivers/tty/tty_ldisc.c:272 #1: 000000007e5a2ebd (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x223/0x1ae0 drivers/tty/n_tty.c:2156 2 locks held by getty/1697: #0: 00000000a4f8e844 (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x22/0x80 drivers/tty/tty_ldisc.c:272 #1: 00000000d9f2266b (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x223/0x1ae0 drivers/tty/n_tty.c:2156 2 locks held by getty/1698: #0: 00000000d39e8b4b (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x22/0x80 drivers/tty/tty_ldisc.c:272 #1: 00000000283b3896 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x223/0x1ae0 drivers/tty/n_tty.c:2156 2 locks held by getty/1699: #0: 00000000b84b47dd (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x22/0x80 drivers/tty/tty_ldisc.c:272 #1: 00000000f23d1b9e (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x223/0x1ae0 drivers/tty/n_tty.c:2156 2 locks held by getty/1700: #0: 00000000a4c6e7f4 (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x22/0x80 drivers/tty/tty_ldisc.c:272 #1: 000000006ae6e0fa (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x223/0x1ae0 drivers/tty/n_tty.c:2156 2 locks held by getty/1701: #0: 0000000026d51791 (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x22/0x80 drivers/tty/tty_ldisc.c:272 #1: 000000002e29ef0e (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x223/0x1ae0 drivers/tty/n_tty.c:2156 ============================================= NMI backtrace for cpu 1 CPU: 1 PID: 23 Comm: khungtaskd Not tainted 5.3.0-rc7+ #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+0xca/0x13e lib/dump_stack.c:113 nmi_cpu_backtrace.cold+0x55/0x96 lib/nmi_backtrace.c:101 nmi_trigger_cpumask_backtrace+0x1b0/0x1c7 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+0x9a4/0xe50 kernel/hung_task.c:289 kthread+0x318/0x420 kernel/kthread.c:255 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:352 Sending NMI from CPU 1 to CPUs 0: cdc_wdm 1-1:0.162: wdm_int_callback - 0 bytes cdc_wdm 1-1:0.162: nonzero urb status received: -71 NMI backtrace for cpu 0 CPU: 0 PID: 0 Comm: swapper/0 Not tainted 5.3.0-rc7+ #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 RIP: 0010:io_serial_in+0x60/0x80 drivers/tty/serial/8250/8250_port.c:450 Code: 0f b6 8d e9 00 00 00 48 8d 7d 38 48 b8 00 00 00 00 00 fc ff df 48 89 fa 48 c1 ea 03 d3 e3 80 3c 02 00 75 13 03 5d 38 89 da ec <5b> 0f b6 c0 5d c3 e8 85 72 4f ff eb c9 e8 ae 72 4f ff eb e6 66 90 RSP: 0018:ffff8881db209468 EFLAGS: 00000002 RAX: dffffc0000000060 RBX: 00000000000003fd RCX: 0000000000000000 RDX: 00000000000003fd RSI: ffffffff8215101c RDI: ffffffff89a2f7b8 RBP: ffffffff89a2f780 R08: ffffffff86c2b200 R09: ffffed103b641293 R10: ffffed103b641292 R11: 0000000000000003 R12: 0000000000000020 R13: fffffbfff1345f40 R14: fffffbfff1345ef9 R15: dffffc0000000000 FS: 0000000000000000(0000) GS:ffff8881db200000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: ffffffffff600400 CR3: 00000001d5ce8000 CR4: 00000000001406f0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: serial_in drivers/tty/serial/8250/8250.h:113 [inline] wait_for_xmitr+0x9a/0x220 drivers/tty/serial/8250/8250_port.c:2012 serial8250_console_putchar+0x1b/0x50 drivers/tty/serial/8250/8250_port.c:3183 uart_console_write+0x59/0x100 drivers/tty/serial/serial_core.c:1923 serial8250_console_write+0x2f8/0x880 drivers/tty/serial/8250/8250_port.c:3247 call_console_drivers kernel/printk/printk.c:1781 [inline] console_unlock+0x898/0xc40 kernel/printk/printk.c:2463 vprintk_emit+0x171/0x3e0 kernel/printk/printk.c:1986 dev_vprintk_emit+0x4fc/0x541 drivers/base/core.c:3283 dev_printk_emit+0xba/0xf1 drivers/base/core.c:3294 __dev_printk+0x1db/0x203 drivers/base/core.c:3306 _dev_err+0xd7/0x109 drivers/base/core.c:3349 wdm_int_callback.cold+0x82/0x2ad drivers/usb/class/cdc-wdm.c:252 __usb_hcd_giveback_urb+0x1f2/0x470 drivers/usb/core/hcd.c:1657 usb_hcd_giveback_urb+0x368/0x420 drivers/usb/core/hcd.c:1722 dummy_timer+0x120f/0x2fa2 drivers/usb/gadget/udc/dummy_hcd.c:1965 call_timer_fn+0x179/0x650 kernel/time/timer.c:1322 expire_timers kernel/time/timer.c:1366 [inline] __run_timers kernel/time/timer.c:1685 [inline] __run_timers kernel/time/timer.c:1653 [inline] run_timer_softirq+0x5cc/0x14b0 kernel/time/timer.c:1698 __do_softirq+0x221/0x912 kernel/softirq.c:292 invoke_softirq kernel/softirq.c:373 [inline] irq_exit+0x178/0x1a0 kernel/softirq.c:413 exiting_irq arch/x86/include/asm/apic.h:537 [inline] smp_apic_timer_interrupt+0x12f/0x500 arch/x86/kernel/apic/apic.c:1133 apic_timer_interrupt+0xf/0x20 arch/x86/entry/entry_64.S:830 RIP: 0010:default_idle+0x28/0x2e0 arch/x86/kernel/process.c:581 Code: 90 90 41 56 41 55 65 44 8b 2d 54 d8 93 7a 41 54 55 53 0f 1f 44 00 00 e8 46 49 d5 fb e9 07 00 00 00 0f 00 2d ea 7d 54 00 fb f4 <65> 44 8b 2d 30 d8 93 7a 0f 1f 44 00 00 5b 5d 41 5c 41 5d 41 5e c3 RSP: 0018:ffffffff86c07da8 EFLAGS: 00000246 ORIG_RAX: ffffffffffffff13 RAX: 0000000000000007 RBX: ffffffff86c2b200 RCX: 0000000000000000 RDX: 0000000000000000 RSI: 0000000000000006 RDI: ffffffff86c2ba44 RBP: fffffbfff0d85640 R08: ffffffff86c2b200 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000000 R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000 cpuidle_idle_call kernel/sched/idle.c:154 [inline] do_idle+0x3c2/0x4f0 kernel/sched/idle.c:263 cpu_startup_entry+0x14/0x20 kernel/sched/idle.c:354 start_kernel+0x838/0x872 init/main.c:785 secondary_startup_64+0xa4/0xb0 arch/x86/kernel/head_64.S:241