linux-usb.vger.kernel.org archive mirror
 help / color / mirror / Atom feed
* USB port resume can take 60 seconds in worst case scenario
@ 2021-04-12 18:59 Pratham Pratap
  2021-04-12 20:04 ` Alan Stern
  2021-04-14  8:18 ` Oliver Neukum
  0 siblings, 2 replies; 4+ messages in thread
From: Pratham Pratap @ 2021-04-12 18:59 UTC (permalink / raw)
  To: linux-usb

Hi,

The current implementation of usb_port_resume 
(usb_reset_and_verify_device()) can take up-to 60 secs in worst-case 
scenario if the device (let's say the device went bad and is 
unresponsive to any setup packets) connected went into runtime suspend 
and resumed back. Is it fine to have a configurable upper bound? Since 
it can induce delay in the overall system resume if the host is waking 
up from PM suspend.

[USB port resume in worst case ]

usb_port_resume()
finish_port_resume()
usb_get_std_status()
usb_get_status()
USB_CTRL_GET_TIMEOUT : 5 sec


usb_reset_and_verify_device()
SET_CONFIG_TRIES 3 (use_new_scheme: 2 /old scheme: 1)
hub_port_init()
GET_DESCRIPTOR_TRIES 2
operations < 3

     2*2*3 (12) * 5(USB_CTRL_GET_TIMEOUT) = 60 sec


Thanks,

Pratham


^ permalink raw reply	[flat|nested] 4+ messages in thread

* Re: USB port resume can take 60 seconds in worst case scenario
  2021-04-12 18:59 USB port resume can take 60 seconds in worst case scenario Pratham Pratap
@ 2021-04-12 20:04 ` Alan Stern
  2021-04-16  4:47   ` Pratham Pratap
  2021-04-14  8:18 ` Oliver Neukum
  1 sibling, 1 reply; 4+ messages in thread
From: Alan Stern @ 2021-04-12 20:04 UTC (permalink / raw)
  To: Pratham Pratap; +Cc: linux-usb

On Tue, Apr 13, 2021 at 12:29:35AM +0530, Pratham Pratap wrote:
> Hi,
> 
> The current implementation of usb_port_resume
> (usb_reset_and_verify_device()) can take up-to 60 secs in worst-case
> scenario if the device (let's say the device went bad and is unresponsive to
> any setup packets) connected went into runtime suspend and resumed back. Is
> it fine to have a configurable upper bound? Since it can induce delay in the
> overall system resume if the host is waking up from PM suspend.
> 
> [USB port resume in worst case ]
> 
> usb_port_resume()
> finish_port_resume()
> usb_get_std_status()
> usb_get_status()
> USB_CTRL_GET_TIMEOUT : 5 sec
> 
> 
> usb_reset_and_verify_device()
> SET_CONFIG_TRIES 3 (use_new_scheme: 2 /old scheme: 1)
> hub_port_init()
> GET_DESCRIPTOR_TRIES 2
> operations < 3
> 
>     2*2*3 (12) * 5(USB_CTRL_GET_TIMEOUT) = 60 sec

I'm not sure where you got that 2*2*3 from.

Is this a real problem?  How often have you observed this to happen?

If you know any particular devices that die like this when they are 
suspended, have you tried adding them to the USB quirks list with the 
USB_QUIRK_RESET_RESUME flag?

There is the usb "persist" parameter.  If you set it to false, what 
happens to this delay?

Alan Stern

^ permalink raw reply	[flat|nested] 4+ messages in thread

* Re: USB port resume can take 60 seconds in worst case scenario
  2021-04-12 18:59 USB port resume can take 60 seconds in worst case scenario Pratham Pratap
  2021-04-12 20:04 ` Alan Stern
@ 2021-04-14  8:18 ` Oliver Neukum
  1 sibling, 0 replies; 4+ messages in thread
From: Oliver Neukum @ 2021-04-14  8:18 UTC (permalink / raw)
  To: Pratham Pratap, linux-usb

Am Dienstag, den 13.04.2021, 00:29 +0530 schrieb Pratham Pratap:
> Hi,
> 
> The current implementation of usb_port_resume 
> (usb_reset_and_verify_device()) can take up-to 60 secs in worst-case 
> scenario if the device (let's say the device went bad and is 
> unresponsive to any setup packets) connected went into runtime suspend 
> and resumed back. Is it fine to have a configurable upper bound? Since 
> it can induce delay in the overall system resume if the host is waking 
> up from PM suspend.

Well, in that case you have bad hardware. Generally if hardware
does not behave like it should we ought to come up eventually,
but a delay is acceptable.
If however the device really takes almost the full timeout
it is technically withing spec.

We could say that we can configure that a device should get less
retries in that specific case, but a pure time limit looks
like not so good an idea to me.

	Regards
		Oliver



^ permalink raw reply	[flat|nested] 4+ messages in thread

* Re: USB port resume can take 60 seconds in worst case scenario
  2021-04-12 20:04 ` Alan Stern
@ 2021-04-16  4:47   ` Pratham Pratap
  0 siblings, 0 replies; 4+ messages in thread
From: Pratham Pratap @ 2021-04-16  4:47 UTC (permalink / raw)
  To: Alan Stern; +Cc: linux-usb

Hi Alan,

Yes this is a real problem and not observed very often.

Thanks for the suggestions, I will give it a try to see if it helps. BTW 
below are the logs for the same.

<3>[  217.425866] [2: kworker/u16:18:19265]  xhci-hcd xhci-hcd.4.auto: 
xhci-plat resume
<3>[  217.425883] [2: kworker/u16:18:19265]  xhci-hcd xhci-hcd.4.auto: 
xhci-plat runtime resume
<6>[  217.425945] [2: kworker/u16:18:19265]  xhci-hcd xhci-hcd.4.auto: 
// Setting command ring address to 0xeffab001
<6>[  217.425991] [2: kworker/u16:18:19265]  xhci-hcd xhci-hcd.4.auto: 
xhci_resume: starting port polling.
<6>[  217.426007] [2: kworker/u16:18:19265]  xhci-hcd xhci-hcd.4.auto: 
xhci_hub_status_data: stopping port polling.
<6>[  217.426020] [2: kworker/u16:18:19265]  xhci-hcd xhci-hcd.4.auto: 
xhci_hub_status_data: stopping port polling.
<6>[  217.426096] [0: kworker/u16:23:19270]  usb_resume_both : 
test_in_resume = 1
<6>[  217.426125] [3: kworker/u16:16:19263]  usb_resume_both : 
test_in_resume = 1
<3>[  217.426153] [0: kworker/u16:23:19270]  hub 1-0:1.0: hub_resume
<3>[  217.426170] [3: kworker/u16:16:19263]  hub 2-0:1.0: hub_resume
<6>[  217.426189] [0: kworker/u16:23:19270]  xhci-hcd xhci-hcd.4.auto: 
Get port status 1-1 read: 0x663, return 0x107
<6>[  217.426204] [3: kworker/u16:16:19263]  xhci-hcd xhci-hcd.4.auto: 
Get port status 2-1 read: 0x2a0, return 0x2a0
<3>[  217.426276] [0: kworker/u16:23:19270]  usb usb1-port1: status 0107 
change 0000
<6>[  217.426311] [3: kworker/u16:16:19263]  usb_resume_both : 
test_in_resume = 0
<6>[  217.426321] [0: kworker/u16:23:19270]  usb_resume_both : 
test_in_resume = 0
<6>[  217.426426] [1: kworker/u16:17:19264]  usb_resume_both : 
test_in_resume = 1
<6>[  217.426453] [1: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
Get port status 1-1 read: 0x663, return 0x107
<6>[  217.426576] [3: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
clear USB_PORT_FEAT_SUSPEND
<6>[  217.426585] [3: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
PORTSC 0663
<6>[  217.426601] [3: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
Set port 1-1 link state, portsc: 0x663, write 0x107e1
<6>[  217.429592] [0:   Binder:728_2:11912] pca9468_charger_resume: 
update_timer
<6>[  217.429650] [0:   Binder:728_2:11912] max77705:max77705_resume
<6>[  217.429664] [0:   Binder:728_2:11912]  pdic_max77705: 
max77705_muic_resume
<6>[  217.429759] [0:   Binder:728_2:11912]  [VIB] max77705_vib: 
max77705_vibrator_resume: set default pinctrl
<6>[  217.432060] [1: kworker/u16:12:19259]  pci-msm-rc 0000:00:00.0: 
Refused to change power state, currently in D3
<3>[  217.432198] [0:   Binder:728_2:11912]  [SDE] 
ss_is_sot_hs_from_drm_mode : invalid drm_mode name len (0)
<3>[  217.432208] [0:   Binder:728_2:11912]  [SDE] 
ss_is_phs_from_drm_mode : invalid drm_mode name len (0)
<6>[  217.435836] [0:   Binder:728_2:11912] fps_qbt2000_resume: ret = 0
<6>[  217.435894] [0:   Binder:728_2:11912]  [pn547] pn547_resume: 
sec_nfc: resume!
<6>[  217.448208] [3: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
Set port 1-1 link state, portsc: 0x7e3, write 0x10601
<6>[  217.448258]I[0:      swapper/0:    0]  xhci-hcd xhci-hcd.4.auto: 
Port change event, 1-1, id 1, portsc: 0x400603
<6>[  217.448273]I[0:      swapper/0:    0]  xhci-hcd xhci-hcd.4.auto: 
handle_port_status: starting port polling.
<3>[  217.448321] [2: kworker/u16:17:19264]  usb 1-1: usb resume
<3>[  217.449147]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
msm_dwc3_pwr_irq received
<3>[  217.449158]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
dwc3_pwr_event_handler irq_stat=3C102C
<3>[  217.449266]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
dwc3_pwr_event_handler link state = 0x0005
<3>[  217.449274]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
dwc3_pwr_event_handler: unexpected PWR_EVNT, irq_stat=3C1020
<6>[  217.492146] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
Get port status 1-1 read: 0x603, return 0x40103
<6>[  217.508200] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
clear port1 suspend/resume change, portsc: 0x603
<3>[  217.508269] [2: kworker/u16:17:19264]  usb 1-1: Waited 0ms for CONNECT
<3>[  217.508280] [2: kworker/u16:17:19264]  usb 1-1: finish resume
<6>[  217.508293] [2: kworker/u16:17:19264] usb_start_wait_urb: 
reset_resume=0 , test_in_resume == 1, parent =-227291136
<6>[  217.508304] [2: kworker/u16:17:19264]  CPU: 2 PID: 19264 Comm: 
kworker/u16:17 Tainted: G S         O 
5.4.61-qgki-21278872-userdebug-abO1QSQW_TEST #1
<6>[  217.508311] [2: kworker/u16:17:19264]  Hardware name: Samsung O1Q 
USA PROJECT - REV0.5 (board-id,12) (DT)
<6>[  217.508341] [2: kworker/u16:17:19264]  Workqueue: events_unbound 
async_run_entry_fn
<6>[  217.508348] [2: kworker/u16:17:19264]  Call trace:
<6>[  217.508359] [2: kworker/u16:17:19264] dump_backtrace.cfi_jt+0x0/0x4
<6>[  217.508373] [2: kworker/u16:17:19264] show_stack+0x18/0x24
<6>[  217.508383] [2: kworker/u16:17:19264] dump_stack+0xb8/0x114
<6>[  217.508396] [2: kworker/u16:17:19264] usb_start_wait_urb+0xc4/0x150
<6>[  217.508403] [2: kworker/u16:17:19264] usb_control_msg+0xe0/0x15c
<6>[  217.508409] [2: kworker/u16:17:19264] usb_get_status+0xa4/0x114
<6>[  217.508415] [2: kworker/u16:17:19264] usb_port_resume+0x524/0x654
<6>[  217.508424] [2: kworker/u16:17:19264] generic_resume+0x24/0x58
<6>[  217.508430] [2: kworker/u16:17:19264] usb_resume_both+0x104/0x1cc
<6>[  217.508435] [2: kworker/u16:17:19264] usb_resume+0x2c/0x118
<6>[  217.508441] [2: kworker/u16:17:19264] usb_dev_resume+0x14/0x20
<6>[  217.508452] [2: kworker/u16:17:19264] device_resume+0x314/0x49c
<6>[  217.508459] [2: kworker/u16:17:19264] async_resume+0x24/0xfc
<6>[  217.508469] [2: kworker/u16:17:19264] async_run_entry_fn+0x60/0x17c
<6>[  217.508479] [2: kworker/u16:17:19264] process_one_work+0x2d8/0x574
<6>[  217.508486] [2: kworker/u16:17:19264] worker_thread+0x28c/0x518
<6>[  217.508495] [2: kworker/u16:17:19264] kthread+0x16c/0x17c
<6>[  217.508506] [2: kworker/u16:17:19264] ret_from_fork+0x10/0x18
<6>[  217.647785]I[2:      swapper/2:    0]  xhci-hcd xhci-hcd.4.auto: 
xhci_hub_status_data: stopping port polling.
<6>[  218.438774] [0:    kworker/0:1:    7]  pdic_max77705: 
max77705_muic_print_reg_log USBC1:0x27, USBC2:0x05, BC:0x80, CC0:0x82, 
CC1:0x9, PD0:0x0, PD1:0xc7 attached_dev:3
<6>[  218.438785] [0:    kworker/0:1:    7]  pdic_max77705: 
max77705_muic_print_reg_log UIC_INT_M:0x4, CC_INT_M:0x20, PD_INT_M:0x0, 
VDM_INT_M:0xf0, PMIC_MASK:0xf2, WDT:0, POR:0
<6>[  218.848199] [2:    kworker/2:1:   64]  PM: Active wake lock:
<6>[  218.848218] [2:    kworker/2:1:   64]  PM: [timerfd]: 
active_count(1), active_time(1461), total_time(1461)
<6>[  218.848227] [2:    kworker/2:1:   64]  PM: [timerfd]: 
active_count(30), active_time(1464), total_time(1504)
<6>[  218.848232] [2:    kworker/2:1:   64]  PM: [timerfd]: 
active_count(51), active_time(1464), total_time(1646)
<6>[  218.848258] [2:    kworker/2:1:   64]  PM: a600000.ssusb: 
active_count(4), active_time(1424), total_time(71254)
<6>[  220.640568] [2:    kworker/2:2:  488] 
tsens[0:325][1:328][2:328][3:328][4:328][5:328][6:328][7:325][8:325][9:321][10:328][11:325][12:328][13:331][14:328][15:325][16:321][17:325][18:321][19:318][20:321][21:325][22:325][23:325][24:325][25:318][26:321][27:328][28:318]
<6>[  220.647048] [2:    kworker/2:1:   64]  thermal_sys: 
[71:295][72:370][76:293][77:289][79:324]
<0>[  222.432157]I[1:      swapper/1:    0]  usb 1-1: **** DPM device 
timeout ****
<6>[  222.432165]I[1:      swapper/1:    0]  Call trace:
<6>[  222.432179]I[1:      swapper/1:    0] __switch_to+0x2b0/0x2e0
<6>[  222.432190]I[1:      swapper/1:    0] __schedule+0x614/0x8c8
<6>[  222.432195]I[1:      swapper/1:    0] schedule+0x8c/0xc0
<6>[  222.432202]I[1:      swapper/1:    0] schedule_timeout+0x90/0x120
<6>[  222.432207]I[1:      swapper/1:    0] wait_for_common+0xd0/0x16c
<6>[  222.432214]I[1:      swapper/1:    0] 
wait_for_completion_timeout+0x14/0x20
<6>[  222.432223]I[1:      swapper/1:    0] usb_start_wait_urb+0xd4/0x150
<6>[  222.432229]I[1:      swapper/1:    0] usb_control_msg+0xe0/0x15c
<6>[  222.432236]I[1:      swapper/1:    0] usb_get_status+0xa4/0x114
<6>[  222.432242]I[1:      swapper/1:    0] usb_port_resume+0x524/0x654
<6>[  222.432251]I[1:      swapper/1:    0] generic_resume+0x24/0x58
<6>[  222.432257]I[1:      swapper/1:    0] usb_resume_both+0x104/0x1cc
<6>[  222.432262]I[1:      swapper/1:    0] usb_resume+0x2c/0x118
<6>[  222.432268]I[1:      swapper/1:    0] usb_dev_resume+0x14/0x20
<6>[  222.432276]I[1:      swapper/1:    0] device_resume+0x314/0x49c
<6>[  222.432282]I[1:      swapper/1:    0] async_resume+0x24/0xfc
<6>[  222.432290]I[1:      swapper/1:    0] async_run_entry_fn+0x60/0x17c
<6>[  222.432298]I[1:      swapper/1:    0] process_one_work+0x2d8/0x574
<6>[  222.432307]I[1:      swapper/1:    0] worker_thread+0x28c/0x518
<6>[  222.432313]I[1:      swapper/1:    0] kthread+0x16c/0x17c
<6>[  222.432322]I[1:      swapper/1:    0] ret_from_fork+0x10/0x18
<4>[  222.432330]I[1:      swapper/1:    0]  usb 1-1: **** DPM usb 
watchdog warning usb : 1-1
<3>[  222.688204] [2: kworker/u16:17:19264]  usb 1-1: retry with 
reset-resume
<6>[  222.688245] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
set port reset, actual port 0 status  = 0x6f1
<6>[  222.738574]I[0:      swapper/0:    0]  xhci-hcd xhci-hcd.4.auto: 
Port change event, 1-1, id 1, portsc: 0x200603
<6>[  222.738589]I[0:      swapper/0:    0]  xhci-hcd xhci-hcd.4.auto: 
handle_port_status: starting port polling.
<3>[  222.739557]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
msm_dwc3_pwr_irq received
<3>[  222.739572]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
dwc3_pwr_event_handler irq_stat=3C102C
<3>[  222.739686]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
dwc3_pwr_event_handler link state = 0x0005
<3>[  222.739693]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
dwc3_pwr_event_handler: unexpected PWR_EVNT, irq_stat=3C1020
<6>[  222.752140] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
Get port status 1-1 read: 0x200603, return 0x100103
<6>[  222.752223] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
clear port1 reset change, portsc: 0x603
<6>[  222.808195] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
Resetting device with slot ID 1
<6>[  222.808217] [2: kworker/u16:17:19264]  queue_command : 
hcd->reset_resume = 739155968, xhci->reset_resume = 0
<6>[  222.808227] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
// Ding dong!
<6>[  222.810036]I[0:      swapper/0:    0]  xhci-hcd xhci-hcd.4.auto: 
Completed reset device command.
<6>[  222.810292] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
Successful reset device command.
<6>[  222.810606] [2: kworker/u16:17:19264]  usb 1-1: reset full-speed 
USB device number 2 using xhci-hcd
<6>[  222.810621] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
Slot already in default state
<6>[  222.810632] [2: kworker/u16:17:19264] usb_start_wait_urb: 
reset_resume=1 , test_in_resume == 1, parent =-227291136
<6>[  222.810642] [2: kworker/u16:17:19264]  CPU: 2 PID: 19264 Comm: 
kworker/u16:17 Tainted: G S         O 
5.4.61-qgki-21278872-userdebug-abO1QSQW_TEST #1
<6>[  222.810648] [2: kworker/u16:17:19264]  Hardware name: Samsung O1Q 
USA PROJECT - REV0.5 (board-id,12) (DT)
<6>[  222.810667] [2: kworker/u16:17:19264]  Workqueue: events_unbound 
async_run_entry_fn
<6>[  222.810674] [2: kworker/u16:17:19264]  Call trace:
<6>[  222.810684] [2: kworker/u16:17:19264] dump_backtrace.cfi_jt+0x0/0x4
<6>[  222.810691] [2: kworker/u16:17:19264] show_stack+0x18/0x24
<6>[  222.810699] [2: kworker/u16:17:19264] dump_stack+0xb8/0x114
<6>[  222.810707] [2: kworker/u16:17:19264] usb_start_wait_urb+0xc4/0x150
<6>[  222.810714] [2: kworker/u16:17:19264] usb_control_msg+0xe0/0x15c
<6>[  222.810722] [2: kworker/u16:17:19264] hub_port_init+0x2f0/0xe80
<6>[  222.810729] [2: kworker/u16:17:19264] 
usb_reset_and_verify_device+0x114/0x614
<6>[  222.810735] [2: kworker/u16:17:19264] usb_port_resume+0x384/0x654
<6>[  222.810744] [2: kworker/u16:17:19264] generic_resume+0x24/0x58
<6>[  222.810750] [2: kworker/u16:17:19264] usb_resume_both+0x104/0x1cc
<6>[  222.810757] [2: kworker/u16:17:19264] usb_resume+0x2c/0x118
<6>[  222.810763] [2: kworker/u16:17:19264] usb_dev_resume+0x14/0x20
<6>[  222.810771] [2: kworker/u16:17:19264] device_resume+0x314/0x49c
<6>[  222.810777] [2: kworker/u16:17:19264] async_resume+0x24/0xfc
<6>[  222.810784] [2: kworker/u16:17:19264] async_run_entry_fn+0x60/0x17c
<6>[  222.810791] [2: kworker/u16:17:19264] process_one_work+0x2d8/0x574
<6>[  222.810797] [2: kworker/u16:17:19264] worker_thread+0x28c/0x518
<6>[  222.810804] [2: kworker/u16:17:19264] kthread+0x16c/0x17c
<6>[  222.810811] [2: kworker/u16:17:19264] ret_from_fork+0x10/0x18
<3>[  222.811016]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
msm_dwc3_pwr_irq received
<3>[  222.811028]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
dwc3_pwr_event_handler irq_stat=3C102C
<3>[  222.811165]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
dwc3_pwr_event_handler link state = 0x0005
<3>[  222.811172]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
dwc3_pwr_event_handler: unexpected PWR_EVNT, irq_stat=3C1020
<6>[  222.856156]I[0:      swapper/0:    0]  xhci-hcd xhci-hcd.4.auto: 
xhci_hub_status_data: stopping port polling.
<6>[  223.328254] [2: kworker/u16:17:19264] usb_start_wait_urb: 
reset_resume=1 , test_in_resume == 1, parent =-227291136
<6>[  223.328266] [2: kworker/u16:17:19264]  CPU: 2 PID: 19264 Comm: 
kworker/u16:17 Tainted: G S         O 
5.4.61-qgki-21278872-userdebug-abO1QSQW_TEST #1
<6>[  223.328272] [2: kworker/u16:17:19264]  Hardware name: Samsung O1Q 
USA PROJECT - REV0.5 (board-id,12) (DT)
<6>[  223.328284] [2: kworker/u16:17:19264]  Workqueue: events_unbound 
async_run_entry_fn
<6>[  223.328291] [2: kworker/u16:17:19264]  Call trace:
<6>[  223.328298] [2: kworker/u16:17:19264] dump_backtrace.cfi_jt+0x0/0x4
<6>[  223.328305] [2: kworker/u16:17:19264] show_stack+0x18/0x24
<6>[  223.328313] [2: kworker/u16:17:19264] dump_stack+0xb8/0x114
<6>[  223.328323] [2: kworker/u16:17:19264] usb_start_wait_urb+0xc4/0x150
<6>[  223.328329] [2: kworker/u16:17:19264] usb_control_msg+0xe0/0x15c
<6>[  223.328334] [2: kworker/u16:17:19264] hub_port_init+0x384/0xe80
<6>[  223.328341] [2: kworker/u16:17:19264] 
usb_reset_and_verify_device+0x114/0x614
<6>[  223.328346] [2: kworker/u16:17:19264] usb_port_resume+0x384/0x654
<6>[  223.328355] [2: kworker/u16:17:19264] generic_resume+0x24/0x58
<6>[  223.328362] [2: kworker/u16:17:19264] usb_resume_both+0x104/0x1cc
<6>[  223.328368] [2: kworker/u16:17:19264] usb_resume+0x2c/0x118
<6>[  223.328374] [2: kworker/u16:17:19264] usb_dev_resume+0x14/0x20
<6>[  223.328382] [2: kworker/u16:17:19264] device_resume+0x314/0x49c
<6>[  223.328388] [2: kworker/u16:17:19264] async_resume+0x24/0xfc
<6>[  223.328395] [2: kworker/u16:17:19264] async_run_entry_fn+0x60/0x17c
<6>[  223.328402] [2: kworker/u16:17:19264] process_one_work+0x2d8/0x574
<6>[  223.328410] [2: kworker/u16:17:19264] worker_thread+0x28c/0x518
<6>[  223.328418] [2: kworker/u16:17:19264] kthread+0x16c/0x17c
<6>[  223.328424] [2: kworker/u16:17:19264] ret_from_fork+0x10/0x18
<6>[  223.840308] [2: kworker/u16:17:19264] usb_start_wait_urb: 
reset_resume=1 , test_in_resume == 1, parent =-227291136
<6>[  223.840318] [2: kworker/u16:17:19264]  CPU: 2 PID: 19264 Comm: 
kworker/u16:17 Tainted: G S         O 
5.4.61-qgki-21278872-userdebug-abO1QSQW_TEST #1
<6>[  223.840323] [2: kworker/u16:17:19264]  Hardware name: Samsung O1Q 
USA PROJECT - REV0.5 (board-id,12) (DT)
<6>[  223.840336] [2: kworker/u16:17:19264]  Workqueue: events_unbound 
async_run_entry_fn
<6>[  223.840343] [2: kworker/u16:17:19264]  Call trace:
<6>[  223.840349] [2: kworker/u16:17:19264] dump_backtrace.cfi_jt+0x0/0x4
<6>[  223.840358] [2: kworker/u16:17:19264] show_stack+0x18/0x24
<6>[  223.840365] [2: kworker/u16:17:19264] dump_stack+0xb8/0x114
<6>[  223.840373] [2: kworker/u16:17:19264] usb_start_wait_urb+0xc4/0x150
<6>[  223.840379] [2: kworker/u16:17:19264] usb_control_msg+0xe0/0x15c
<6>[  223.840385] [2: kworker/u16:17:19264] hub_port_init+0x4b8/0xe80
<6>[  223.840392] [2: kworker/u16:17:19264] 
usb_reset_and_verify_device+0x114/0x614
<6>[  223.840397] [2: kworker/u16:17:19264] usb_port_resume+0x384/0x654
<6>[  223.840406] [2: kworker/u16:17:19264] generic_resume+0x24/0x58
<6>[  223.840412] [2: kworker/u16:17:19264] usb_resume_both+0x104/0x1cc
<6>[  223.840418] [2: kworker/u16:17:19264] usb_resume+0x2c/0x118
<6>[  223.840424] [2: kworker/u16:17:19264] usb_dev_resume+0x14/0x20
<6>[  223.840431] [2: kworker/u16:17:19264] device_resume+0x314/0x49c
<6>[  223.840437] [2: kworker/u16:17:19264] async_resume+0x24/0xfc
<6>[  223.840444] [2: kworker/u16:17:19264] async_run_entry_fn+0x60/0x17c
<6>[  223.840451] [2: kworker/u16:17:19264] process_one_work+0x2d8/0x574
<6>[  223.840458] [2: kworker/u16:17:19264] worker_thread+0x28c/0x518
<6>[  223.840464] [2: kworker/u16:17:19264] kthread+0x16c/0x17c
<6>[  223.840470] [2: kworker/u16:17:19264] ret_from_fork+0x10/0x18
<6>[  223.968186] [2:    kworker/2:1:   64]  PM: Active wake lock:
<6>[  223.968201] [2:    kworker/2:1:   64]  PM: [timerfd]: 
active_count(1), active_time(6581), total_time(6581)
<6>[  223.968209] [2:    kworker/2:1:   64]  PM: [timerfd]: 
active_count(30), active_time(6584), total_time(6624)
<6>[  223.968216] [2:    kworker/2:1:   64]  PM: [timerfd]: 
active_count(51), active_time(6584), total_time(6766)
<6>[  223.968235] [2:    kworker/2:1:   64]  PM: a600000.ssusb: 
active_count(4), active_time(6544), total_time(76374)
<6>[  224.352248] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
set port reset, actual port 0 status  = 0x6f1
<6>[  224.402575]I[0:      swapper/0:    0]  xhci-hcd xhci-hcd.4.auto: 
Port change event, 1-1, id 1, portsc: 0x200603
<6>[  224.402587]I[0:      swapper/0:    0]  xhci-hcd xhci-hcd.4.auto: 
handle_port_status: starting port polling.
<3>[  224.403551]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
msm_dwc3_pwr_irq received
<3>[  224.403566]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
dwc3_pwr_event_handler irq_stat=3C102C
<3>[  224.403681]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
dwc3_pwr_event_handler link state = 0x0005
<3>[  224.403689]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
dwc3_pwr_event_handler: unexpected PWR_EVNT, irq_stat=3C1020
<6>[  224.416141] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
Get port status 1-1 read: 0x200603, return 0x100103
<6>[  224.416222] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
clear port1 reset change, portsc: 0x603
<6>[  224.472220] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
Resetting device with slot ID 1
<6>[  224.472233] [2: kworker/u16:17:19264]  queue_command : 
hcd->reset_resume = 739155968, xhci->reset_resume = 0
<6>[  224.472240] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
// Ding dong!
<6>[  224.472475]I[0:      swapper/0:    0]  xhci-hcd xhci-hcd.4.auto: 
Completed reset device command.
<6>[  224.472738] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
Can't reset device (slot ID 1) in default state
<6>[  224.472750] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
Not freeing device rings.
<3>[  224.472762] [2: kworker/u16:17:19264]  usb 1-1: device descriptor 
read/64, error -71
<6>[  224.473002] [2: kworker/u16:17:19264] send_usb_host_certi_uevent: 
WARNING=no_response
<3>[  224.473266]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
msm_dwc3_pwr_irq received
<3>[  224.473278]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
dwc3_pwr_event_handler irq_stat=3C102C
<3>[  224.473390]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
dwc3_pwr_event_handler link state = 0x0005
<3>[  224.473398]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
dwc3_pwr_event_handler: unexpected PWR_EVNT, irq_stat=3C1020
<6>[  224.576257] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
Slot already in default state
<6>[  224.576272] [2: kworker/u16:17:19264] usb_start_wait_urb: 
reset_resume=1 , test_in_resume == 1, parent =-227291136
<6>[  224.576279] [2: kworker/u16:17:19264]  CPU: 2 PID: 19264 Comm: 
kworker/u16:17 Tainted: G S         O 
5.4.61-qgki-21278872-userdebug-abO1QSQW_TEST #1
<6>[  224.576284] [2: kworker/u16:17:19264]  Hardware name: Samsung O1Q 
USA PROJECT - REV0.5 (board-id,12) (DT)
<6>[  224.576295] [2: kworker/u16:17:19264]  Workqueue: events_unbound 
async_run_entry_fn
<6>[  224.576301] [2: kworker/u16:17:19264]  Call trace:
<6>[  224.576308] [2: kworker/u16:17:19264] dump_backtrace.cfi_jt+0x0/0x4
<6>[  224.576315] [2: kworker/u16:17:19264] show_stack+0x18/0x24
<6>[  224.576322] [2: kworker/u16:17:19264] dump_stack+0xb8/0x114
<6>[  224.576329] [2: kworker/u16:17:19264] usb_start_wait_urb+0xc4/0x150
<6>[  224.576335] [2: kworker/u16:17:19264] usb_control_msg+0xe0/0x15c
<6>[  224.576340] [2: kworker/u16:17:19264] hub_port_init+0x2f0/0xe80
<6>[  224.576346] [2: kworker/u16:17:19264] 
usb_reset_and_verify_device+0x114/0x614
<6>[  224.576352] [2: kworker/u16:17:19264] usb_port_resume+0x384/0x654
<6>[  224.576360] [2: kworker/u16:17:19264] generic_resume+0x24/0x58
<6>[  224.576365] [2: kworker/u16:17:19264] usb_resume_both+0x104/0x1cc
<6>[  224.576370] [2: kworker/u16:17:19264] usb_resume+0x2c/0x118
<6>[  224.576377] [2: kworker/u16:17:19264] usb_dev_resume+0x14/0x20
<6>[  224.576383] [2: kworker/u16:17:19264] device_resume+0x314/0x49c
<6>[  224.576389] [2: kworker/u16:17:19264] async_resume+0x24/0xfc
<6>[  224.576396] [2: kworker/u16:17:19264] async_run_entry_fn+0x60/0x17c
<6>[  224.576402] [2: kworker/u16:17:19264] process_one_work+0x2d8/0x574
<6>[  224.576409] [2: kworker/u16:17:19264] worker_thread+0x28c/0x518
<6>[  224.576416] [2: kworker/u16:17:19264] kthread+0x16c/0x17c
<6>[  224.576422] [2: kworker/u16:17:19264] ret_from_fork+0x10/0x18
<6>[  224.592128]I[0:      swapper/0:    0]  xhci-hcd xhci-hcd.4.auto: 
xhci_hub_status_data: stopping port polling.
<6>[  225.088192] [2: kworker/u16:17:19264] usb_start_wait_urb: 
reset_resume=1 , test_in_resume == 1, parent =-227291136
<6>[  225.088202] [2: kworker/u16:17:19264]  CPU: 2 PID: 19264 Comm: 
kworker/u16:17 Tainted: G S         O 
5.4.61-qgki-21278872-userdebug-abO1QSQW_TEST #1
<6>[  225.088208] [2: kworker/u16:17:19264]  Hardware name: Samsung O1Q 
USA PROJECT - REV0.5 (board-id,12) (DT)
<6>[  225.088220] [2: kworker/u16:17:19264]  Workqueue: events_unbound 
async_run_entry_fn
<6>[  225.088226] [2: kworker/u16:17:19264]  Call trace:
<6>[  225.088233] [2: kworker/u16:17:19264] dump_backtrace.cfi_jt+0x0/0x4
<6>[  225.088242] [2: kworker/u16:17:19264] show_stack+0x18/0x24
<6>[  225.088249] [2: kworker/u16:17:19264] dump_stack+0xb8/0x114
<6>[  225.088257] [2: kworker/u16:17:19264] usb_start_wait_urb+0xc4/0x150
<6>[  225.088264] [2: kworker/u16:17:19264] usb_control_msg+0xe0/0x15c
<6>[  225.088270] [2: kworker/u16:17:19264] hub_port_init+0x384/0xe80
<6>[  225.088275] [2: kworker/u16:17:19264] 
usb_reset_and_verify_device+0x114/0x614
<6>[  225.088281] [2: kworker/u16:17:19264] usb_port_resume+0x384/0x654
<6>[  225.088288] [2: kworker/u16:17:19264] generic_resume+0x24/0x58
<6>[  225.088294] [2: kworker/u16:17:19264] usb_resume_both+0x104/0x1cc
<6>[  225.088299] [2: kworker/u16:17:19264] usb_resume+0x2c/0x118
<6>[  225.088305] [2: kworker/u16:17:19264] usb_dev_resume+0x14/0x20
<6>[  225.088311] [2: kworker/u16:17:19264] device_resume+0x314/0x49c
<6>[  225.088319] [2: kworker/u16:17:19264] async_resume+0x24/0xfc
<6>[  225.088325] [2: kworker/u16:17:19264] async_run_entry_fn+0x60/0x17c
<6>[  225.088332] [2: kworker/u16:17:19264] process_one_work+0x2d8/0x574
<6>[  225.088339] [2: kworker/u16:17:19264] worker_thread+0x28c/0x518
<6>[  225.088346] [2: kworker/u16:17:19264] kthread+0x16c/0x17c
<6>[  225.088352] [2: kworker/u16:17:19264] ret_from_fork+0x10/0x18
<6>[  225.600236] [2: kworker/u16:17:19264] usb_start_wait_urb: 
reset_resume=1 , test_in_resume == 1, parent =-227291136
<6>[  225.600248] [2: kworker/u16:17:19264]  CPU: 2 PID: 19264 Comm: 
kworker/u16:17 Tainted: G S         O 
5.4.61-qgki-21278872-userdebug-abO1QSQW_TEST #1
<6>[  225.600253] [2: kworker/u16:17:19264]  Hardware name: Samsung O1Q 
USA PROJECT - REV0.5 (board-id,12) (DT)
<6>[  225.600265] [2: kworker/u16:17:19264]  Workqueue: events_unbound 
async_run_entry_fn
<6>[  225.600271] [2: kworker/u16:17:19264]  Call trace:
<6>[  225.600277] [2: kworker/u16:17:19264] dump_backtrace.cfi_jt+0x0/0x4
<6>[  225.600285] [2: kworker/u16:17:19264] show_stack+0x18/0x24
<6>[  225.600293] [2: kworker/u16:17:19264] dump_stack+0xb8/0x114
<6>[  225.600300] [2: kworker/u16:17:19264] usb_start_wait_urb+0xc4/0x150
<6>[  225.600306] [2: kworker/u16:17:19264] usb_control_msg+0xe0/0x15c
<6>[  225.600312] [2: kworker/u16:17:19264] hub_port_init+0x4b8/0xe80
<6>[  225.600318] [2: kworker/u16:17:19264] 
usb_reset_and_verify_device+0x114/0x614
<6>[  225.600323] [2: kworker/u16:17:19264] usb_port_resume+0x384/0x654
<6>[  225.600331] [2: kworker/u16:17:19264] generic_resume+0x24/0x58
<6>[  225.600338] [2: kworker/u16:17:19264] usb_resume_both+0x104/0x1cc
<6>[  225.600343] [2: kworker/u16:17:19264] usb_resume+0x2c/0x118
<6>[  225.600349] [2: kworker/u16:17:19264] usb_dev_resume+0x14/0x20
<6>[  225.600355] [2: kworker/u16:17:19264] device_resume+0x314/0x49c
<6>[  225.600362] [2: kworker/u16:17:19264] async_resume+0x24/0xfc
<6>[  225.600368] [2: kworker/u16:17:19264] async_run_entry_fn+0x60/0x17c
<6>[  225.600374] [2: kworker/u16:17:19264] process_one_work+0x2d8/0x574
<6>[  225.600381] [2: kworker/u16:17:19264] worker_thread+0x28c/0x518
<6>[  225.600387] [2: kworker/u16:17:19264] kthread+0x16c/0x17c
<6>[  225.600393] [2: kworker/u16:17:19264] ret_from_fork+0x10/0x18
<6>[  225.760483] [2:    kworker/2:2:  488] 
tsens[0:328][1:328][2:335][3:331][4:331][5:328][6:328][7:328][8:325][9:328][10:328][11:328][12:331][13:338][14:325][15:328][16:328][17:328][18:328][19:321][20:325][21:328][22:328][23:328][24:325][25:318][26:325][27:331][28:321]
<6>[  225.765653] [2:    kworker/2:1:   64]  thermal_sys: 
[71:296][72:370][76:294][77:292][79:325]
<6>[  226.112272] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
set port reset, actual port 0 status  = 0x6f1
<6>[  226.162595]I[0:      swapper/0:    0]  xhci-hcd xhci-hcd.4.auto: 
Port change event, 1-1, id 1, portsc: 0x200603
<6>[  226.162608]I[0:      swapper/0:    0]  xhci-hcd xhci-hcd.4.auto: 
handle_port_status: starting port polling.
<3>[  226.163551]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
msm_dwc3_pwr_irq received
<3>[  226.163566]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
dwc3_pwr_event_handler irq_stat=3C102C
<3>[  226.163696]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
dwc3_pwr_event_handler link state = 0x0005
<3>[  226.163705]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
dwc3_pwr_event_handler: unexpected PWR_EVNT, irq_stat=3C1020
<6>[  226.176141] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
Get port status 1-1 read: 0x200603, return 0x100103
<6>[  226.176205] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
clear port1 reset change, portsc: 0x603
<6>[  226.232192] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
Resetting device with slot ID 1
<6>[  226.232205] [2: kworker/u16:17:19264]  queue_command : 
hcd->reset_resume = 739155968, xhci->reset_resume = 0
<6>[  226.232212] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
// Ding dong!
<6>[  226.232441]I[0:      swapper/0:    0]  xhci-hcd xhci-hcd.4.auto: 
Completed reset device command.
<6>[  226.232696] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
Can't reset device (slot ID 1) in default state
<6>[  226.232708] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
Not freeing device rings.
<3>[  226.232718] [2: kworker/u16:17:19264]  usb 1-1: device descriptor 
read/64, error -71
<6>[  226.232792] [2: kworker/u16:17:19264] send_usb_host_certi_uevent: 
WARNING=no_response
<3>[  226.233140]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
msm_dwc3_pwr_irq received
<3>[  226.233152]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
dwc3_pwr_event_handler irq_stat=3C102C
<3>[  226.233284]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
dwc3_pwr_event_handler link state = 0x0005
<3>[  226.233290]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
dwc3_pwr_event_handler: unexpected PWR_EVNT, irq_stat=3C1020
<6>[  226.328155]I[0:      swapper/0:    0]  xhci-hcd xhci-hcd.4.auto: 
xhci_hub_status_data: stopping port polling.
<6>[  226.336143] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
disable port 1-1, portsc: 0x6e1
<6>[  226.336212] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
set port reset, actual port 0 status  = 0x6f1
<6>[  226.386538]I[0:      swapper/0:    0]  xhci-hcd xhci-hcd.4.auto: 
Port change event, 1-1, id 1, portsc: 0x200603
<6>[  226.386551]I[0:      swapper/0:    0]  xhci-hcd xhci-hcd.4.auto: 
handle_port_status: starting port polling.
<3>[  226.387142]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
msm_dwc3_pwr_irq received
<3>[  226.387153]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
dwc3_pwr_event_handler irq_stat=3C102C
<3>[  226.387260]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
dwc3_pwr_event_handler link state = 0x0005
<3>[  226.387269]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
dwc3_pwr_event_handler: unexpected PWR_EVNT, irq_stat=3C1020
<6>[  226.400197] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
Get port status 1-1 read: 0x200603, return 0x100103
<6>[  226.400257] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
clear port1 reset change, portsc: 0x603
<6>[  226.456192] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
Resetting device with slot ID 1
<6>[  226.456205] [2: kworker/u16:17:19264]  queue_command : 
hcd->reset_resume = 739155968, xhci->reset_resume = 0
<6>[  226.456213] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
// Ding dong!
<6>[  226.456448]I[0:      swapper/0:    0]  xhci-hcd xhci-hcd.4.auto: 
Completed reset device command.
<6>[  226.456509] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
Can't reset device (slot ID 1) in default state
<6>[  226.456517] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
Not freeing device rings.
<6>[  226.456528] [2: kworker/u16:17:19264]  usb 1-1: reset full-speed 
USB device number 2 using xhci-hcd
<6>[  226.456536] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
Slot already in default state
<6>[  226.456545] [2: kworker/u16:17:19264] usb_start_wait_urb: 
reset_resume=1 , test_in_resume == 1, parent =-227291136
<6>[  226.456552] [2: kworker/u16:17:19264]  CPU: 2 PID: 19264 Comm: 
kworker/u16:17 Tainted: G S         O 
5.4.61-qgki-21278872-userdebug-abO1QSQW_TEST #1
<6>[  226.456558] [2: kworker/u16:17:19264]  Hardware name: Samsung O1Q 
USA PROJECT - REV0.5 (board-id,12) (DT)
<6>[  226.456570] [2: kworker/u16:17:19264]  Workqueue: events_unbound 
async_run_entry_fn
<6>[  226.456576] [2: kworker/u16:17:19264]  Call trace:
<6>[  226.456583] [2: kworker/u16:17:19264] dump_backtrace.cfi_jt+0x0/0x4
<6>[  226.456591] [2: kworker/u16:17:19264] show_stack+0x18/0x24
<6>[  226.456599] [2: kworker/u16:17:19264] dump_stack+0xb8/0x114
<6>[  226.456607] [2: kworker/u16:17:19264] usb_start_wait_urb+0xc4/0x150
<6>[  226.456613] [2: kworker/u16:17:19264] usb_control_msg+0xe0/0x15c
<6>[  226.456620] [2: kworker/u16:17:19264] hub_port_init+0x2f0/0xe80
<6>[  226.456626] [2: kworker/u16:17:19264] 
usb_reset_and_verify_device+0x114/0x614
<6>[  226.456631] [2: kworker/u16:17:19264] usb_port_resume+0x384/0x654
<6>[  226.456639] [2: kworker/u16:17:19264] generic_resume+0x24/0x58
<6>[  226.456644] [2: kworker/u16:17:19264] usb_resume_both+0x104/0x1cc
<6>[  226.456650] [2: kworker/u16:17:19264] usb_resume+0x2c/0x118
<6>[  226.456656] [2: kworker/u16:17:19264] usb_dev_resume+0x14/0x20
<6>[  226.456663] [2: kworker/u16:17:19264] device_resume+0x314/0x49c
<6>[  226.456670] [2: kworker/u16:17:19264] async_resume+0x24/0xfc
<6>[  226.456677] [2: kworker/u16:17:19264] async_run_entry_fn+0x60/0x17c
<6>[  226.456684] [2: kworker/u16:17:19264] process_one_work+0x2d8/0x574
<6>[  226.456691] [2: kworker/u16:17:19264] worker_thread+0x28c/0x518
<6>[  226.456698] [2: kworker/u16:17:19264] kthread+0x16c/0x17c
<6>[  226.456704] [2: kworker/u16:17:19264] ret_from_fork+0x10/0x18
<3>[  226.457319]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
msm_dwc3_pwr_irq received
<3>[  226.457332]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
dwc3_pwr_event_handler irq_stat=3C102C
<3>[  226.457458]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
dwc3_pwr_event_handler link state = 0x0005
<3>[  226.457466]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
dwc3_pwr_event_handler: unexpected PWR_EVNT, irq_stat=3C1020
<6>[  226.576156]I[0:      swapper/0:    0]  xhci-hcd xhci-hcd.4.auto: 
xhci_hub_status_data: stopping port polling.
<6>[  226.977517] [2: kworker/u16:17:19264] usb_start_wait_urb: 
reset_resume=1 , test_in_resume == 1, parent =-227291136
<6>[  226.977539] [2: kworker/u16:17:19264]  CPU: 2 PID: 19264 Comm: 
kworker/u16:17 Tainted: G S         O 
5.4.61-qgki-21278872-userdebug-abO1QSQW_TEST #1
<6>[  226.977546] [2: kworker/u16:17:19264]  Hardware name: Samsung O1Q 
USA PROJECT - REV0.5 (board-id,12) (DT)
<6>[  226.977575] [2: kworker/u16:17:19264]  Workqueue: events_unbound 
async_run_entry_fn
<6>[  226.977583] [2: kworker/u16:17:19264]  Call trace:
<6>[  226.977595] [2: kworker/u16:17:19264] dump_backtrace.cfi_jt+0x0/0x4
<6>[  226.977607] [2: kworker/u16:17:19264] show_stack+0x18/0x24
<6>[  226.977620] [2: kworker/u16:17:19264] dump_stack+0xb8/0x114
<6>[  226.977634] [2: kworker/u16:17:19264] usb_start_wait_urb+0xc4/0x150
<6>[  226.977640] [2: kworker/u16:17:19264] usb_control_msg+0xe0/0x15c
<6>[  226.977647] [2: kworker/u16:17:19264] hub_port_init+0x384/0xe80
<6>[  226.977653] [2: kworker/u16:17:19264] 
usb_reset_and_verify_device+0x114/0x614
<6>[  226.977659] [2: kworker/u16:17:19264] usb_port_resume+0x384/0x654
<6>[  226.977668] [2: kworker/u16:17:19264] generic_resume+0x24/0x58
<6>[  226.977674] [2: kworker/u16:17:19264] usb_resume_both+0x104/0x1cc
<6>[  226.977679] [2: kworker/u16:17:19264] usb_resume+0x2c/0x118
<6>[  226.977685] [2: kworker/u16:17:19264] usb_dev_resume+0x14/0x20
<6>[  226.977696] [2: kworker/u16:17:19264] device_resume+0x314/0x49c
<6>[  226.977702] [2: kworker/u16:17:19264] async_resume+0x24/0xfc
<6>[  226.977710] [2: kworker/u16:17:19264] async_run_entry_fn+0x60/0x17c
<6>[  226.977720] [2: kworker/u16:17:19264] process_one_work+0x2d8/0x574
<6>[  226.977726] [2: kworker/u16:17:19264] worker_thread+0x28c/0x518
<6>[  226.977733] [2: kworker/u16:17:19264] kthread+0x16c/0x17c
<6>[  226.977742] [2: kworker/u16:17:19264] ret_from_fork+0x10/0x18
<6>[  227.489431] [2: kworker/u16:17:19264] usb_start_wait_urb: 
reset_resume=1 , test_in_resume == 1, parent =-227291136
<6>[  227.489454] [2: kworker/u16:17:19264]  CPU: 2 PID: 19264 Comm: 
kworker/u16:17 Tainted: G S         O 
5.4.61-qgki-21278872-userdebug-abO1QSQW_TEST #1
<6>[  227.489460] [2: kworker/u16:17:19264]  Hardware name: Samsung O1Q 
USA PROJECT - REV0.5 (board-id,12) (DT)
<6>[  227.489491] [2: kworker/u16:17:19264]  Workqueue: events_unbound 
async_run_entry_fn
<6>[  227.489499] [2: kworker/u16:17:19264]  Call trace:
<6>[  227.489510] [2: kworker/u16:17:19264] dump_backtrace.cfi_jt+0x0/0x4
<6>[  227.489523] [2: kworker/u16:17:19264] show_stack+0x18/0x24
<6>[  227.489533] [2: kworker/u16:17:19264] dump_stack+0xb8/0x114
<6>[  227.489549] [2: kworker/u16:17:19264] usb_start_wait_urb+0xc4/0x150
<6>[  227.489555] [2: kworker/u16:17:19264] usb_control_msg+0xe0/0x15c
<6>[  227.489561] [2: kworker/u16:17:19264] hub_port_init+0x4b8/0xe80
<6>[  227.489568] [2: kworker/u16:17:19264] 
usb_reset_and_verify_device+0x114/0x614
<6>[  227.489574] [2: kworker/u16:17:19264] usb_port_resume+0x384/0x654
<6>[  227.489582] [2: kworker/u16:17:19264] generic_resume+0x24/0x58
<6>[  227.489588] [2: kworker/u16:17:19264] usb_resume_both+0x104/0x1cc
<6>[  227.489594] [2: kworker/u16:17:19264] usb_resume+0x2c/0x118
<6>[  227.489600] [2: kworker/u16:17:19264] usb_dev_resume+0x14/0x20
<6>[  227.489610] [2: kworker/u16:17:19264] device_resume+0x314/0x49c
<6>[  227.489616] [2: kworker/u16:17:19264] async_resume+0x24/0xfc
<6>[  227.489625] [2: kworker/u16:17:19264] async_run_entry_fn+0x60/0x17c
<6>[  227.489634] [2: kworker/u16:17:19264] process_one_work+0x2d8/0x574
<6>[  227.489640] [2: kworker/u16:17:19264] worker_thread+0x28c/0x518
<6>[  227.489648] [2: kworker/u16:17:19264] kthread+0x16c/0x17c
<6>[  227.489657] [2: kworker/u16:17:19264] ret_from_fork+0x10/0x18
<6>[  228.001545] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
set port reset, actual port 0 status  = 0x6f1
<3>[  228.052844]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
msm_dwc3_pwr_irq received
<3>[  228.052871]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
dwc3_pwr_event_handler irq_stat=3C102C
<3>[  228.052997]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
dwc3_pwr_event_handler link state = 0x0005
<3>[  228.053005]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
dwc3_pwr_event_handler: unexpected PWR_EVNT, irq_stat=3C1020
<6>[  228.053089]I[0:      swapper/0:    0]  xhci-hcd xhci-hcd.4.auto: 
Port change event, 1-1, id 1, portsc: 0x200603
<6>[  228.053103]I[0:      swapper/0:    0]  xhci-hcd xhci-hcd.4.auto: 
handle_port_status: starting port polling.
<6>[  228.065342] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
Get port status 1-1 read: 0x200603, return 0x100103
<6>[  228.065472] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
clear port1 reset change, portsc: 0x603
<6>[  228.065506] [2:  kworker/u16:7:  386] fps_qbt2000_work_func_debug: 
ldo:1,ipc:1,wuhb:0,tz:1,type:qbt2000,int:1,0
<6>[  228.121404] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
Resetting device with slot ID 1
<6>[  228.121444] [2: kworker/u16:17:19264]  queue_command : 
hcd->reset_resume = 739155968, xhci->reset_resume = 0
<6>[  228.121454] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
// Ding dong!
<6>[  228.121745]I[0:      swapper/0:    0]  xhci-hcd xhci-hcd.4.auto: 
Completed reset device command.
<6>[  228.122055] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
Can't reset device (slot ID 1) in default state
<6>[  228.122065] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
Not freeing device rings.
<3>[  228.122088] [2: kworker/u16:17:19264]  usb 1-1: device descriptor 
read/64, error -71
<6>[  228.122270] [2: kworker/u16:17:19264] send_usb_host_certi_uevent: 
WARNING=no_response
<6>[  228.225395] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
Slot already in default state
<6>[  228.225432] [2: kworker/u16:17:19264] usb_start_wait_urb: 
reset_resume=1 , test_in_resume == 1, parent =-227291136
<6>[  228.225443] [2: kworker/u16:17:19264]  CPU: 2 PID: 19264 Comm: 
kworker/u16:17 Tainted: G S         O 
5.4.61-qgki-21278872-userdebug-abO1QSQW_TEST #1
<6>[  228.225450] [2: kworker/u16:17:19264]  Hardware name: Samsung O1Q 
USA PROJECT - REV0.5 (board-id,12) (DT)
<6>[  228.225479] [2: kworker/u16:17:19264]  Workqueue: events_unbound 
async_run_entry_fn
<6>[  228.225487] [2: kworker/u16:17:19264]  Call trace:
<6>[  228.225499] [2: kworker/u16:17:19264] dump_backtrace.cfi_jt+0x0/0x4
<6>[  228.225512] [2: kworker/u16:17:19264] show_stack+0x18/0x24
<6>[  228.225522] [2: kworker/u16:17:19264] dump_stack+0xb8/0x114
<6>[  228.225534] [2: kworker/u16:17:19264] usb_start_wait_urb+0xc4/0x150
<6>[  228.225540] [2: kworker/u16:17:19264] usb_control_msg+0xe0/0x15c
<6>[  228.225547] [2: kworker/u16:17:19264] hub_port_init+0x2f0/0xe80
<6>[  228.225553] [2: kworker/u16:17:19264] 
usb_reset_and_verify_device+0x114/0x614
<6>[  228.225559] [2: kworker/u16:17:19264] usb_port_resume+0x384/0x654
<6>[  228.225568] [2: kworker/u16:17:19264] generic_resume+0x24/0x58
<6>[  228.225574] [2: kworker/u16:17:19264] usb_resume_both+0x104/0x1cc
<6>[  228.225579] [2: kworker/u16:17:19264] usb_resume+0x2c/0x118
<6>[  228.225586] [2: kworker/u16:17:19264] usb_dev_resume+0x14/0x20
<6>[  228.225596] [2: kworker/u16:17:19264] device_resume+0x314/0x49c
<6>[  228.225602] [2: kworker/u16:17:19264] async_resume+0x24/0xfc
<6>[  228.225610] [2: kworker/u16:17:19264] async_run_entry_fn+0x60/0x17c
<6>[  228.225620] [2: kworker/u16:17:19264] process_one_work+0x2d8/0x574
<6>[  228.225627] [2: kworker/u16:17:19264] worker_thread+0x28c/0x518
<6>[  228.225635] [2: kworker/u16:17:19264] kthread+0x16c/0x17c
<6>[  228.225645] [2: kworker/u16:17:19264] ret_from_fork+0x10/0x18
<6>[  228.313293]I[0:      swapper/0:    0]  xhci-hcd xhci-hcd.4.auto: 
xhci_hub_status_data: stopping port polling.
<6>[  228.737417] [2: kworker/u16:17:19264] usb_start_wait_urb: 
reset_resume=1 , test_in_resume == 1, parent =-227291136
<6>[  228.737440] [2: kworker/u16:17:19264]  CPU: 2 PID: 19264 Comm: 
kworker/u16:17 Tainted: G S         O 
5.4.61-qgki-21278872-userdebug-abO1QSQW_TEST #1
<6>[  228.737446] [2: kworker/u16:17:19264]  Hardware name: Samsung O1Q 
USA PROJECT - REV0.5 (board-id,12) (DT)
<6>[  228.737477] [2: kworker/u16:17:19264]  Workqueue: events_unbound 
async_run_entry_fn
<6>[  228.737484] [2: kworker/u16:17:19264]  Call trace:
<6>[  228.737496] [2: kworker/u16:17:19264] dump_backtrace.cfi_jt+0x0/0x4
<6>[  228.737508] [2: kworker/u16:17:19264] show_stack+0x18/0x24
<6>[  228.737518] [2: kworker/u16:17:19264] dump_stack+0xb8/0x114
<6>[  228.737529] [2: kworker/u16:17:19264] usb_start_wait_urb+0xc4/0x150
<6>[  228.737535] [2: kworker/u16:17:19264] usb_control_msg+0xe0/0x15c
<6>[  228.737542] [2: kworker/u16:17:19264] hub_port_init+0x384/0xe80
<6>[  228.737548] [2: kworker/u16:17:19264] 
usb_reset_and_verify_device+0x114/0x614
<6>[  228.737555] [2: kworker/u16:17:19264] usb_port_resume+0x384/0x654
<6>[  228.737564] [2: kworker/u16:17:19264] generic_resume+0x24/0x58
<6>[  228.737571] [2: kworker/u16:17:19264] usb_resume_both+0x104/0x1cc
<6>[  228.737576] [2: kworker/u16:17:19264] usb_resume+0x2c/0x118
<6>[  228.737582] [2: kworker/u16:17:19264] usb_dev_resume+0x14/0x20
<6>[  228.737592] [2: kworker/u16:17:19264] device_resume+0x314/0x49c
<6>[  228.737599] [2: kworker/u16:17:19264] async_resume+0x24/0xfc
<6>[  228.737607] [2: kworker/u16:17:19264] async_run_entry_fn+0x60/0x17c
<6>[  228.737616] [2: kworker/u16:17:19264] process_one_work+0x2d8/0x574
<6>[  228.737623] [2: kworker/u16:17:19264] worker_thread+0x28c/0x518
<6>[  228.737631] [2: kworker/u16:17:19264] kthread+0x16c/0x17c
<6>[  228.737641] [2: kworker/u16:17:19264] ret_from_fork+0x10/0x18
<6>[  229.089394] [2:    kworker/2:1:   64]  PM: Active wake lock:
<6>[  229.089430] [2:    kworker/2:1:   64]  PM: [timerfd]: 
active_count(1), active_time(11702), total_time(11702)
<6>[  229.089438] [2:    kworker/2:1:   64]  PM: [timerfd]: 
active_count(30), active_time(11705), total_time(11745)
<6>[  229.089445] [2:    kworker/2:1:   64]  PM: [timerfd]: 
active_count(51), active_time(11705), total_time(11887)
<6>[  229.089489] [2:    kworker/2:1:   64]  PM: a600000.ssusb: 
active_count(4), active_time(11665), total_time(81495)
<6>[  229.249559] [2: kworker/u16:17:19264] usb_start_wait_urb: 
reset_resume=1 , test_in_resume == 1, parent =-227291136
<6>[  229.249583] [2: kworker/u16:17:19264]  CPU: 2 PID: 19264 Comm: 
kworker/u16:17 Tainted: G S         O 
5.4.61-qgki-21278872-userdebug-abO1QSQW_TEST #1
<6>[  229.249589] [2: kworker/u16:17:19264]  Hardware name: Samsung O1Q 
USA PROJECT - REV0.5 (board-id,12) (DT)
<6>[  229.249623] [2: kworker/u16:17:19264]  Workqueue: events_unbound 
async_run_entry_fn
<6>[  229.249633] [2: kworker/u16:17:19264]  Call trace:
<6>[  229.249646] [2: kworker/u16:17:19264] dump_backtrace.cfi_jt+0x0/0x4
<6>[  229.249660] [2: kworker/u16:17:19264] show_stack+0x18/0x24
<6>[  229.249673] [2: kworker/u16:17:19264] dump_stack+0xb8/0x114
<6>[  229.249686] [2: kworker/u16:17:19264] usb_start_wait_urb+0xc4/0x150
<6>[  229.249692] [2: kworker/u16:17:19264] usb_control_msg+0xe0/0x15c
<6>[  229.249701] [2: kworker/u16:17:19264] hub_port_init+0x4b8/0xe80
<6>[  229.249708] [2: kworker/u16:17:19264] 
usb_reset_and_verify_device+0x114/0x614
<6>[  229.249715] [2: kworker/u16:17:19264] usb_port_resume+0x384/0x654
<6>[  229.249725] [2: kworker/u16:17:19264] generic_resume+0x24/0x58
<6>[  229.249732] [2: kworker/u16:17:19264] usb_resume_both+0x104/0x1cc
<6>[  229.249737] [2: kworker/u16:17:19264] usb_resume+0x2c/0x118
<6>[  229.249744] [2: kworker/u16:17:19264] usb_dev_resume+0x14/0x20
<6>[  229.249758] [2: kworker/u16:17:19264] device_resume+0x314/0x49c
<6>[  229.249766] [2: kworker/u16:17:19264] async_resume+0x24/0xfc
<6>[  229.249776] [2: kworker/u16:17:19264] async_run_entry_fn+0x60/0x17c
<6>[  229.249787] [2: kworker/u16:17:19264] process_one_work+0x2d8/0x574
<6>[  229.249795] [2: kworker/u16:17:19264] worker_thread+0x28c/0x518
<6>[  229.249803] [2: kworker/u16:17:19264] kthread+0x16c/0x17c
<6>[  229.249815] [2: kworker/u16:17:19264] ret_from_fork+0x10/0x18
<6>[  229.761558] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
set port reset, actual port 0 status  = 0x6f1
<3>[  229.812859]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
msm_dwc3_pwr_irq received
<3>[  229.812885]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
dwc3_pwr_event_handler irq_stat=3C102C
<3>[  229.813011]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
dwc3_pwr_event_handler link state = 0x0005
<3>[  229.813020]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
dwc3_pwr_event_handler: unexpected PWR_EVNT, irq_stat=3C1020
<6>[  229.813103]I[0:      swapper/0:    0]  xhci-hcd xhci-hcd.4.auto: 
Port change event, 1-1, id 1, portsc: 0x200603
<6>[  229.813117]I[0:      swapper/0:    0]  xhci-hcd xhci-hcd.4.auto: 
handle_port_status: starting port polling.
<6>[  229.825574] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
Get port status 1-1 read: 0x200603, return 0x100103
<6>[  229.825677] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
clear port1 reset change, portsc: 0x603
<6>[  229.881517] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
Resetting device with slot ID 1
<6>[  229.881560] [2: kworker/u16:17:19264]  queue_command : 
hcd->reset_resume = 739155968, xhci->reset_resume = 0
<6>[  229.881569] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
// Ding dong!
<6>[  229.881884]I[0:      swapper/0:    0]  xhci-hcd xhci-hcd.4.auto: 
Completed reset device command.
<6>[  229.881961] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
Can't reset device (slot ID 1) in default state
<6>[  229.881969] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
Not freeing device rings.
<3>[  229.881987] [2: kworker/u16:17:19264]  usb 1-1: device descriptor 
read/64, error -71
<6>[  229.882150] [2: kworker/u16:17:19264] send_usb_host_certi_uevent: 
WARNING=no_response
<3>[  229.882726]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
msm_dwc3_pwr_irq received
<3>[  229.882741]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
dwc3_pwr_event_handler irq_stat=3C102C
<3>[  229.882874]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
dwc3_pwr_event_handler link state = 0x0005
<3>[  229.882883]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
dwc3_pwr_event_handler: unexpected PWR_EVNT, irq_stat=3C1020
<6>[  229.985591] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
disable port 1-1, portsc: 0x6e1
<6>[  229.985704] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
set port reset, actual port 0 status  = 0x6f1
<3>[  230.037025]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
msm_dwc3_pwr_irq received
<3>[  230.037052]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
dwc3_pwr_event_handler irq_stat=3C102C
<3>[  230.037157]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
dwc3_pwr_event_handler link state = 0x0005
<3>[  230.037165]I[0:      swapper/0:    0]  msm-dwc3 a600000.ssusb: 
dwc3_pwr_event_handler: unexpected PWR_EVNT, irq_stat=3C1020
<6>[  230.037240]I[0:      swapper/0:    0]  xhci-hcd xhci-hcd.4.auto: 
Port change event, 1-1, id 1, portsc: 0x200603
<6>[  230.037253]I[0:      swapper/0:    0]  xhci-hcd xhci-hcd.4.auto: 
handle_port_status: starting port polling.
<6>[  230.049459] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
Get port status 1-1 read: 0x200603, return 0x100103
<6>[  230.049561] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
clear port1 reset change, portsc: 0x603
<6>[  230.105521] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
Resetting device with slot ID 1
<6>[  230.105564] [2: kworker/u16:17:19264]  queue_command : 
hcd->reset_resume = 739155968, xhci->reset_resume = 0
<6>[  230.105575] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
// Ding dong!
<6>[  230.105892]I[0:      swapper/0:    0]  xhci-hcd xhci-hcd.4.auto: 
Completed reset device command.
<6>[  230.105966] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
Can't reset device (slot ID 1) in default state
<6>[  230.105974] [2: kworker/u16:17:19264]  xhci-hcd xhci-hcd.4.auto: 
Not freeing device rings.
<6>[  230.105995] [2: kworker/u16:17:19264]  usb 1-1: reset full-speed 
USB device number 2 using xhci-hcd
<3>[  230.106004] [2: kworker/u16:17:19264]  usb 1-1: udev->wusb=0
<3>[  230.106011] [2: kworker/u16:17:19264]  usb 1-1: set address start 
in reset resume<3>[  230.106018] [2: kworker/u16:17:19264]  usb 1-1: set 
address set reset resume as 1


--Pratham

On 4/13/2021 1:34 AM, Alan Stern wrote:
> On Tue, Apr 13, 2021 at 12:29:35AM +0530, Pratham Pratap wrote:
>> Hi,
>>
>> The current implementation of usb_port_resume
>> (usb_reset_and_verify_device()) can take up-to 60 secs in worst-case
>> scenario if the device (let's say the device went bad and is unresponsive to
>> any setup packets) connected went into runtime suspend and resumed back. Is
>> it fine to have a configurable upper bound? Since it can induce delay in the
>> overall system resume if the host is waking up from PM suspend.
>>
>> [USB port resume in worst case ]
>>
>> usb_port_resume()
>> finish_port_resume()
>> usb_get_std_status()
>> usb_get_status()
>> USB_CTRL_GET_TIMEOUT : 5 sec
>>
>>
>> usb_reset_and_verify_device()
>> SET_CONFIG_TRIES 3 (use_new_scheme: 2 /old scheme: 1)
>> hub_port_init()
>> GET_DESCRIPTOR_TRIES 2
>> operations < 3
>>
>>      2*2*3 (12) * 5(USB_CTRL_GET_TIMEOUT) = 60 sec
> I'm not sure where you got that 2*2*3 from.
>
> Is this a real problem?  How often have you observed this to happen?
>
> If you know any particular devices that die like this when they are
> suspended, have you tried adding them to the USB quirks list with the
> USB_QUIRK_RESET_RESUME flag?
>
> There is the usb "persist" parameter.  If you set it to false, what
> happens to this delay?
>
> Alan Stern

^ permalink raw reply	[flat|nested] 4+ messages in thread

end of thread, other threads:[~2021-04-16  4:48 UTC | newest]

Thread overview: 4+ messages (download: mbox.gz / follow: Atom feed)
-- links below jump to the message on this page --
2021-04-12 18:59 USB port resume can take 60 seconds in worst case scenario Pratham Pratap
2021-04-12 20:04 ` Alan Stern
2021-04-16  4:47   ` Pratham Pratap
2021-04-14  8:18 ` Oliver Neukum

This is a public inbox, see mirroring instructions
for how to clone and mirror all data and code used for this inbox;
as well as URLs for NNTP newsgroup(s).