Kernel panic after power cycling of 3 USB ports a few times |
||||||
Issue description
Chrome Version: (copy from chrome://version)
CHROMEOS_RELEASE_DESCRIPTION=9765.31.0 (Official Build) dev-channel guado test
What steps will reproduce the problem?
(1) Rebooting Guado with new dev image 9765.31.0
(2) Power cycle 3 USB ports a few times
What is the expected result?
After restoring power for USB ports, all devices can be enumerated. No kernel crash, no panic.
What happens instead?
====================
Kernel panic which causes Guado rebooting
202 | 2017-08-21 14:35:41 | SUS Power Fail
203 | 2017-08-21 14:35:41 | System Reset
204 | 2017-08-21 14:35:41 | ACPI Wake | S5
205 | 2017-08-21 14:35:41 | Wake Source | Power Button | 0
206 | 2017-08-21 14:35:41 | Chrome OS Developer Mode <-----------
207 | 2017-08-21 21:14:12 | Kernel Event | Panic <=========== reboot triggered by panic
208 | 2017-08-21 21:14:13 | System boot | 213
209 | 2017-08-21 21:14:13 | System Reset
210 | 2017-08-21 21:14:13 | Wake Source | GPIO | 27
211 | 2017-08-21 21:14:14 | Chrome OS Developer Mode
2017-08-21T21:09:31.992077-07:00 INFO kernel: [23618.727524] usb 1-3.1: New USB device found, idVendor=058f, idProduct=6254
2017-08-21T21:09:31.992096-07:00 INFO kernel: [23618.727541] usb 1-3.1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
2017-08-21T21:09:32.103103-07:00 INFO kernel: [23618.838601] hub 1-3.1:1.0: USB hub found
2017-08-21T21:09:32.103128-07:00 INFO kernel: [23618.838688] hub 1-3.1:1.0: 4 ports detected
2017-08-21T21:09:42.233133-07:00 ERR kernel: [23628.976628] hub 1-3.1:1.0: hub_port_status failed (err = -110)
2017-08-21T21:09:47.404112-07:00 INFO kernel: [23634.151805] usb 1-3.1.1: new full-speed USB device number 64 using xhci_hcd
2017-08-21T21:09:50.860587-07:00 NOTICE ag[13485]: autotest server[stack::_cmd_usb_devices|run|wrapper] -> ssh_run(usb-devices)
2017-08-21T21:09:51.896097-07:00 WARNING kernel: [23638.647866] udevd[160]: seq 2353 '/devices/pci0000:00/0000:00:14.0/usb1/1-3/1-3.1/1-3.1.1/1-3.1.1:1.0/0003:266E:0110.001C/hidraw/hidraw2' is taking a long time
2017-08-21T21:10:02.822081-07:00 ERR kernel: [23649.582972] usb 1-3.1.1: device descriptor read/64, error -110
2017-08-21T21:10:02.924083-07:00 ERR kernel: [23649.684336] xhci_hcd 0000:00:14.0: Setup ERROR: setup context command for slot 19.
2017-08-21T21:10:03.924110-07:00 ERR kernel: [23650.685126] hub 1-3.1:1.0: cannot disable port 1 (err = -110)
2017-08-21T21:10:04.924139-07:00 ERR kernel: [23651.685957] hub 1-3.1:1.0: cannot reset port 1 (err = -110)
2017-08-21T21:10:05.924124-07:00 ERR kernel: [23652.686774] hub 1-3.1:1.0: cannot reset port 1 (err = -110)
2017-08-21T21:10:06.924142-07:00 ERR kernel: [23653.687572] hub 1-3.1:1.0: cannot reset port 1 (err = -110)
2017-08-21T21:10:13.004129-07:00 INFO kernel: [23659.772531] usb 1-3.1.1: new full-speed USB device number 65 using xhci_hcd
2017-08-21T21:10:28.422139-07:00 ERR kernel: [23675.203574] usb 1-3.1.1: device descriptor read/64, error -110
2017-08-21T21:10:28.523092-07:00 ERR kernel: [23675.303997] xhci_hcd 0000:00:14.0: Setup ERROR: setup context command for slot 14.
2017-08-21T21:10:29.523153-07:00 ERR kernel: [23676.304853] hub 1-3.1:1.0: cannot disable port 1 (err = -110)
2017-08-21T21:10:30.523109-07:00 ERR kernel: [23677.305672] hub 1-3.1:1.0: cannot reset port 1 (err = -110)
2017-08-21T21:10:31.523160-07:00 ERR kernel: [23678.306415] hub 1-3.1:1.0: cannot reset port 1 (err = -110)
2017-08-21T21:10:32.523092-07:00 ERR kernel: [23679.307218] hub 1-3.1:1.0: cannot reset port 1 (err = -110)
2017-08-21T21:10:38.603088-07:00 INFO kernel: [23685.392147] usb 1-3.1.1: new full-speed USB device number 66 using xhci_hcd
2017-08-21T21:10:43.666095-07:00 WARNING kernel: [23690.459187] xhci_hcd 0000:00:14.0: Timeout while waiting for setup device command
2017-08-21T21:10:52.275061-07:00 ERR kernel: [23699.075388] xhci_hcd 0000:00:14.0: Stopped the command ring failed, maybe the host is dead
2017-08-21T21:10:52.275074-07:00 ERR kernel: [23699.075418] xhci_hcd 0000:00:14.0: Abort command ring failed
2017-08-21T21:10:52.275075-07:00 ERR kernel: [23699.075442] xhci_hcd 0000:00:14.0: HC died; cleaning up
2017-08-21T21:10:52.275076-07:00 WARNING kernel: [23699.075447] xhci_hcd 0000:00:14.0: Timeout while waiting for setup device command
2017-08-21T21:10:52.477116-07:00 ERR kernel: [23699.277285] usb 1-3.1.1: device not accepting address 66, error -62
2017-08-21T21:10:52.477152-07:00 ERR kernel: [23699.277331] hub 1-3.1:1.0: couldn't allocate port 1 usb_device
2017-08-21T21:10:52.477157-07:00 INFO kernel: [23699.277373] usb 1-2: USB disconnect, device number 54
2017-08-21T21:10:52.477161-07:00 INFO kernel: [23699.277860] usb 1-3: USB disconnect, device number 55
2017-08-21T21:10:52.477164-07:00 INFO kernel: [23699.277876] usb 1-3.1: USB disconnect, device number 63
2017-08-21T21:10:52.478080-07:00 INFO kernel: [23699.278421] usb 1-3.2: USB disconnect, device number 57
2017-08-21T21:11:51.896075-07:00 ERR kernel: [23758.744793] udevd[160]: seq 2353 '/devices/pci0000:00/0000:00:14.0/usb1/1-3/1-3.1/1-3.1.1/1-3.1.1:1.0/0003:266E:0110.001C/hidraw/hidraw2' killed
2017-08-21T21:11:51.899067-07:00 WARNING kernel: [23758.748129] udevd[160]: worker [13364] terminated by signal 9 (Killed) <<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<
2017-08-21T21:11:51.899082-07:00 ERR kernel: [23758.748153] udevd[160]: worker [13364] failed while handling '/devices/pci0000:00/0000:00:14.0/usb1/1-3/1-3.1/1-3.1.1/1-3.1.1:1.0/0003:266E:0110.001C/hidraw/hidraw2'
2017-08-21T21:12:52.896096-07:00 WARNING kernel: [23819.794141] udevd[160]: seq 2397 '/devices/pci0000:00/0000:00:14.0/usb1/1-3/1-3.1' is taking a long time <<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<
2017-08-21T21:14:47.139835-07:00 INFO kernel: [ 0.000000] Initializing cgroup subsys cpuset
2017-08-21T21:14:47.139892-07:00 INFO kernel: [ 0.000000] Initializing cgroup subsys cpu
2017-08-21T21:14:47.139895-07:00 INFO kernel: [ 0.000000] Initializing cgroup subsys cpuacct
Please use labels and text to provide additional information.
For graphics-related bugs, please copy/paste the contents of the about:gpu
page at the end of this report.
,
Aug 23 2017
Host controller died which then triggered the hung task detector. [23699.075388] xhci_hcd 0000:00:14.0: Stopped the command ring failed, maybe the host is dead [23699.075418] xhci_hcd 0000:00:14.0: Abort command ring failed [23699.075442] xhci_hcd 0000:00:14.0: HC died; cleaning up [23699.075447] xhci_hcd 0000:00:14.0: Timeout while waiting for setup device command
,
Aug 23 2017
,
Aug 23 2017
,
Aug 1
,
Aug 25
Haven't started this, so making the bug available.
,
Dec 20
Do you have any update? Thanks. |
||||||
►
Sign in to add a comment |
||||||
Comment 1 by mzhuo@chromium.org
, Aug 22 2017