firmware
firmware copied to clipboard
Published
20 hours ago •
raspberrypi
raspberrypi
rpi3 kernel: [61372.274158] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on
Hello. Using a Raspberry Pi 3 Model B+ with latest Raspberry Pi OS (64-bit):
Linux rpi3 6.1.19-v8+ #1637 SMP PREEMPT Tue Mar 14 11:11:47 GMT 2023 aarch64 GNU/Linux
root@rpi3:~# cat /etc/debian_version
11.6
On one USB port I have a USB to RS485 adapter (using PL2303 chip):
Apr 2 15:16:43 rpi3 kernel: [ 12.199081] usbcore: registered new interface driver usbserial_generic
Apr 2 15:16:43 rpi3 kernel: [ 12.200645] usbserial: USB Serial support registered for generic
Apr 2 15:16:43 rpi3 kernel: [ 12.260137] usbcore: registered new interface driver pl2303
Apr 2 15:16:43 rpi3 kernel: [ 12.273678] usbserial: USB Serial support registered for pl2303
Apr 2 15:16:43 rpi3 kernel: [ 12.282038] pl2303 1-1.1.3:1.0: pl2303 converter detected
Apr 2 15:16:43 rpi3 kernel: [ 12.317290] usb 1-1.1.3: pl2303 converter now attached to ttyUSB0
root@rpi3:~# lsusb -v
Bus 001 Device 004: ID 0930:6544 Toshiba Corp. TransMemory-Mini / Kingston DataTraveler 2.0 Stick
Device Descriptor:
bLength 18
bDescriptorType 1
bcdUSB 2.00
bDeviceClass 0
bDeviceSubClass 0
bDeviceProtocol 0
bMaxPacketSize0 64
idVendor 0x0930 Toshiba Corp.
idProduct 0x6544 TransMemory-Mini / Kingston DataTraveler 2.0 Stick
bcdDevice 1.00
iManufacturer 1 Kingston
iProduct 2 DataTraveler 2.0
iSerial 3 0019B92B28C9C8C135450044
bNumConfigurations 1
Configuration Descriptor:
bLength 9
bDescriptorType 2
wTotalLength 0x0020
bNumInterfaces 1
bConfigurationValue 1
iConfiguration 0
bmAttributes 0x80
(Bus Powered)
MaxPower 100mA
Interface Descriptor:
bLength 9
bDescriptorType 4
bInterfaceNumber 0
bAlternateSetting 0
bNumEndpoints 2
bInterfaceClass 8 Mass Storage
bInterfaceSubClass 6 SCSI
bInterfaceProtocol 80 Bulk-Only
iInterface 0
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x81 EP 1 IN
bmAttributes 2
Transfer Type Bulk
Synch Type None
Usage Type Data
wMaxPacketSize 0x0200 1x 512 bytes
bInterval 255
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x02 EP 2 OUT
bmAttributes 2
Transfer Type Bulk
Synch Type None
Usage Type Data
wMaxPacketSize 0x0200 1x 512 bytes
bInterval 255
Device Qualifier (for other device speed):
bLength 10
bDescriptorType 6
bcdUSB 2.00
bDeviceClass 0
bDeviceSubClass 0
bDeviceProtocol 0
bMaxPacketSize0 64
bNumConfigurations 1
can't get debug descriptor: Resource temporarily unavailable
Device Status: 0x0000
(Bus Powered)
Bus 001 Device 005: ID 067b:2303 Prolific Technology, Inc. PL2303 Serial Port / Mobile Action MA-8910P
Device Descriptor:
bLength 18
bDescriptorType 1
bcdUSB 1.10
bDeviceClass 0
bDeviceSubClass 0
bDeviceProtocol 0
bMaxPacketSize0 64
idVendor 0x067b Prolific Technology, Inc.
idProduct 0x2303 PL2303 Serial Port / Mobile Action MA-8910P
bcdDevice 3.00
iManufacturer 1 Prolific Technology Inc.
iProduct 2 USB-Serial Controller
iSerial 0
bNumConfigurations 1
Configuration Descriptor:
bLength 9
bDescriptorType 2
wTotalLength 0x0027
bNumInterfaces 1
bConfigurationValue 1
iConfiguration 0
bmAttributes 0x80
(Bus Powered)
MaxPower 100mA
Interface Descriptor:
bLength 9
bDescriptorType 4
bInterfaceNumber 0
bAlternateSetting 0
bNumEndpoints 3
bInterfaceClass 255 Vendor Specific Class
bInterfaceSubClass 0
bInterfaceProtocol 0
iInterface 0
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x81 EP 1 IN
bmAttributes 3
Transfer Type Interrupt
Synch Type None
Usage Type Data
wMaxPacketSize 0x000a 1x 10 bytes
bInterval 1
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x02 EP 2 OUT
bmAttributes 2
Transfer Type Bulk
Synch Type None
Usage Type Data
wMaxPacketSize 0x0040 1x 64 bytes
bInterval 0
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x83 EP 3 IN
bmAttributes 2
Transfer Type Bulk
Synch Type None
Usage Type Data
wMaxPacketSize 0x0040 1x 64 bytes
bInterval 0
can't get debug descriptor: Resource temporarily unavailable
Device Status: 0x0000
(Bus Powered)
Bus 001 Device 006: ID 0424:7800 Microchip Technology, Inc. (formerly SMSC)
Device Descriptor:
bLength 18
bDescriptorType 1
bcdUSB 2.10
bDeviceClass 255 Vendor Specific Class
bDeviceSubClass 0
bDeviceProtocol 255
bMaxPacketSize0 64
idVendor 0x0424 Microchip Technology, Inc. (formerly SMSC)
idProduct 0x7800
bcdDevice 3.00
iManufacturer 0
iProduct 0
iSerial 0
bNumConfigurations 1
Configuration Descriptor:
bLength 9
bDescriptorType 2
wTotalLength 0x0027
bNumInterfaces 1
bConfigurationValue 1
iConfiguration 0
bmAttributes 0xe0
Self Powered
Remote Wakeup
MaxPower 2mA
Interface Descriptor:
bLength 9
bDescriptorType 4
bInterfaceNumber 0
bAlternateSetting 0
bNumEndpoints 3
bInterfaceClass 255 Vendor Specific Class
bInterfaceSubClass 0
bInterfaceProtocol 255
iInterface 0
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x81 EP 1 IN
bmAttributes 2
Transfer Type Bulk
Synch Type None
Usage Type Data
wMaxPacketSize 0x0200 1x 512 bytes
bInterval 0
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x02 EP 2 OUT
bmAttributes 2
Transfer Type Bulk
Synch Type None
Usage Type Data
wMaxPacketSize 0x0200 1x 512 bytes
bInterval 0
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x83 EP 3 IN
bmAttributes 3
Transfer Type Interrupt
Synch Type None
Usage Type Data
wMaxPacketSize 0x0010 1x 16 bytes
bInterval 4
Binary Object Store Descriptor:
bLength 5
bDescriptorType 15
wTotalLength 0x0016
bNumDeviceCaps 2
USB 2.0 Extension Device Capability:
bLength 7
bDescriptorType 16
bDevCapabilityType 2
bmAttributes 0x00000006
BESL Link Power Management (LPM) Supported
SuperSpeed USB Device Capability:
bLength 10
bDescriptorType 16
bDevCapabilityType 3
bmAttributes 0x00
wSpeedsSupported 0x000e
Device can operate at Full Speed (12Mbps)
Device can operate at High Speed (480Mbps)
Device can operate at SuperSpeed (5Gbps)
bFunctionalitySupport 1
Lowest fully-functional device speed is Full Speed (12Mbps)
bU1DevExitLat 10 micro seconds
bU2DevExitLat 1500 micro seconds
can't get debug descriptor: Resource temporarily unavailable
Device Status: 0x0001
Self Powered
Bus 001 Device 003: ID 0424:2514 Microchip Technology, Inc. (formerly SMSC) USB 2.0 Hub
Device Descriptor:
bLength 18
bDescriptorType 1
bcdUSB 2.00
bDeviceClass 9 Hub
bDeviceSubClass 0
bDeviceProtocol 2 TT per port
bMaxPacketSize0 64
idVendor 0x0424 Microchip Technology, Inc. (formerly SMSC)
idProduct 0x2514 USB 2.0 Hub
bcdDevice b.b3
iManufacturer 0
iProduct 0
iSerial 0
bNumConfigurations 1
Configuration Descriptor:
bLength 9
bDescriptorType 2
wTotalLength 0x0029
bNumInterfaces 1
bConfigurationValue 1
iConfiguration 0
bmAttributes 0xe0
Self Powered
Remote Wakeup
MaxPower 2mA
Interface Descriptor:
bLength 9
bDescriptorType 4
bInterfaceNumber 0
bAlternateSetting 0
bNumEndpoints 1
bInterfaceClass 9 Hub
bInterfaceSubClass 0
bInterfaceProtocol 1 Single TT
iInterface 0
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x81 EP 1 IN
bmAttributes 3
Transfer Type Interrupt
Synch Type None
Usage Type Data
wMaxPacketSize 0x0001 1x 1 bytes
bInterval 12
Interface Descriptor:
bLength 9
bDescriptorType 4
bInterfaceNumber 0
bAlternateSetting 1
bNumEndpoints 1
bInterfaceClass 9 Hub
bInterfaceSubClass 0
bInterfaceProtocol 2 TT per port
iInterface 0
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x81 EP 1 IN
bmAttributes 3
Transfer Type Interrupt
Synch Type None
Usage Type Data
wMaxPacketSize 0x0001 1x 1 bytes
bInterval 12
Hub Descriptor:
bLength 9
bDescriptorType 41
nNbrPorts 3
wHubCharacteristic 0x000d
Per-port power switching
Compound device
Per-port overcurrent protection
TT think time 8 FS bits
bPwrOn2PwrGood 50 * 2 milli seconds
bHubContrCurrent 1 milli Ampere
DeviceRemovable 0x02
PortPwrCtrlMask 0xff
Hub Port Status:
Port 1: 0000.0503 highspeed power enable connect
Port 2: 0000.0100 power
Port 3: 0000.0103 power enable connect
Device Qualifier (for other device speed):
bLength 10
bDescriptorType 6
bcdUSB 2.00
bDeviceClass 9 Hub
bDeviceSubClass 0
bDeviceProtocol 0 Full speed (or root) hub
bMaxPacketSize0 64
bNumConfigurations 1
can't get debug descriptor: Resource temporarily unavailable
Device Status: 0x0001
Self Powered
Bus 001 Device 002: ID 0424:2514 Microchip Technology, Inc. (formerly SMSC) USB 2.0 Hub
Device Descriptor:
bLength 18
bDescriptorType 1
bcdUSB 2.00
bDeviceClass 9 Hub
bDeviceSubClass 0
bDeviceProtocol 2 TT per port
bMaxPacketSize0 64
idVendor 0x0424 Microchip Technology, Inc. (formerly SMSC)
idProduct 0x2514 USB 2.0 Hub
bcdDevice b.b3
iManufacturer 0
iProduct 0
iSerial 0
bNumConfigurations 1
Configuration Descriptor:
bLength 9
bDescriptorType 2
wTotalLength 0x0029
bNumInterfaces 1
bConfigurationValue 1
iConfiguration 0
bmAttributes 0xe0
Self Powered
Remote Wakeup
MaxPower 2mA
Interface Descriptor:
bLength 9
bDescriptorType 4
bInterfaceNumber 0
bAlternateSetting 0
bNumEndpoints 1
bInterfaceClass 9 Hub
bInterfaceSubClass 0
bInterfaceProtocol 1 Single TT
iInterface 0
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x81 EP 1 IN
bmAttributes 3
Transfer Type Interrupt
Synch Type None
Usage Type Data
wMaxPacketSize 0x0001 1x 1 bytes
bInterval 12
Interface Descriptor:
bLength 9
bDescriptorType 4
bInterfaceNumber 0
bAlternateSetting 1
bNumEndpoints 1
bInterfaceClass 9 Hub
bInterfaceSubClass 0
bInterfaceProtocol 2 TT per port
iInterface 0
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x81 EP 1 IN
bmAttributes 3
Transfer Type Interrupt
Synch Type None
Usage Type Data
wMaxPacketSize 0x0001 1x 1 bytes
bInterval 12
Hub Descriptor:
bLength 9
bDescriptorType 41
nNbrPorts 4
wHubCharacteristic 0x000d
Per-port power switching
Compound device
Per-port overcurrent protection
TT think time 8 FS bits
bPwrOn2PwrGood 50 * 2 milli seconds
bHubContrCurrent 1 milli Ampere
DeviceRemovable 0x02
PortPwrCtrlMask 0xff
Hub Port Status:
Port 1: 0000.0503 highspeed power enable connect
Port 2: 0000.0100 power
Port 3: 0000.0503 highspeed power enable connect
Port 4: 0000.0100 power
Device Qualifier (for other device speed):
bLength 10
bDescriptorType 6
bcdUSB 2.00
bDeviceClass 9 Hub
bDeviceSubClass 0
bDeviceProtocol 0 Full speed (or root) hub
bMaxPacketSize0 64
bNumConfigurations 1
can't get debug descriptor: Resource temporarily unavailable
Device Status: 0x0001
Self Powered
Bus 001 Device 001: ID 1d6b:0002 Linux Foundation 2.0 root hub
Device Descriptor:
bLength 18
bDescriptorType 1
bcdUSB 2.00
bDeviceClass 9 Hub
bDeviceSubClass 0
bDeviceProtocol 1 Single TT
bMaxPacketSize0 64
idVendor 0x1d6b Linux Foundation
idProduct 0x0002 2.0 root hub
bcdDevice 6.01
iManufacturer 3 Linux 6.1.19-v8+ dwc_otg_hcd
iProduct 2 DWC OTG Controller
iSerial 1 3f980000.usb
bNumConfigurations 1
Configuration Descriptor:
bLength 9
bDescriptorType 2
wTotalLength 0x0019
bNumInterfaces 1
bConfigurationValue 1
iConfiguration 0
bmAttributes 0xe0
Self Powered
Remote Wakeup
MaxPower 0mA
Interface Descriptor:
bLength 9
bDescriptorType 4
bInterfaceNumber 0
bAlternateSetting 0
bNumEndpoints 1
bInterfaceClass 9 Hub
bInterfaceSubClass 0
bInterfaceProtocol 0 Full speed (or root) hub
iInterface 0
Endpoint Descriptor:
bLength 7
bDescriptorType 5
bEndpointAddress 0x81 EP 1 IN
bmAttributes 3
Transfer Type Interrupt
Synch Type None
Usage Type Data
wMaxPacketSize 0x0004 1x 4 bytes
bInterval 12
Hub Descriptor:
bLength 9
bDescriptorType 41
nNbrPorts 1
wHubCharacteristic 0x0008
Ganged power switching
Per-port overcurrent protection
TT think time 8 FS bits
bPwrOn2PwrGood 1 * 2 milli seconds
bHubContrCurrent 0 milli Ampere
DeviceRemovable 0x00
PortPwrCtrlMask 0xff
Hub Port Status:
Port 1: 0000.0503 highspeed power enable connect
can't get device qualifier: Resource temporarily unavailable
can't get debug descriptor: Resource temporarily unavailable
Device Status: 0x0001
Self Powered
On this RS485 interface /dev/ttyUSB0 I poll every 2 seconds a SDM120 Smart Meter (Modbus) with this software.
All works well except I have lots of WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on in /var/log/messages.
See here an extract:
Apr 3 07:07:43 rpi3 kernel: [55406.970480] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 2
Apr 3 07:08:05 rpi3 kernel: [55428.794721]
Apr 3 07:08:05 rpi3 kernel: [55428.794737] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 6
Apr 3 07:08:21 rpi3 kernel: [55445.146825]
Apr 3 07:08:21 rpi3 kernel: [55445.146841] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 5
Apr 3 07:08:21 rpi3 kernel: [55445.147251]
Apr 3 07:08:21 rpi3 kernel: [55445.147254] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 7
Apr 3 07:09:10 rpi3 kernel: [55493.851483]
Apr 3 07:09:10 rpi3 kernel: [55493.851499] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 6
Apr 3 07:09:27 rpi3 kernel: [55511.035465]
Apr 3 07:09:27 rpi3 kernel: [55511.035481] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 5
Apr 3 07:09:37 rpi3 kernel: [55520.763577]
Apr 3 07:09:37 rpi3 kernel: [55520.763593] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 0
Apr 3 07:09:37 rpi3 kernel: [55520.764016]
Apr 3 07:09:37 rpi3 kernel: [55520.764019] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 4
Apr 3 07:09:44 rpi3 kernel: [55528.059855]
Apr 3 07:09:44 rpi3 kernel: [55528.059872] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 0
Apr 3 07:10:35 rpi3 kernel: [55578.844230]
Apr 3 07:10:35 rpi3 kernel: [55578.844246] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 7
Apr 3 07:10:48 rpi3 kernel: [55591.804200]
Apr 3 07:10:48 rpi3 kernel: [55591.804216] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 1
Apr 3 07:10:48 rpi3 kernel: [55591.804636]
Apr 3 07:10:48 rpi3 kernel: [55591.804640] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 3
Apr 3 07:11:46 rpi3 kernel: [55649.692970]
Apr 3 07:11:46 rpi3 kernel: [55649.692986] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 0
Apr 3 07:11:57 rpi3 kernel: [55661.533102]
Apr 3 07:11:57 rpi3 kernel: [55661.533119] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 4
Apr 3 07:13:46 rpi3 kernel: [55770.109949]
Apr 3 07:13:46 rpi3 kernel: [55770.109966] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 6
Apr 3 07:13:53 rpi3 kernel: [55777.405957]
Apr 3 07:13:53 rpi3 kernel: [55777.405973] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 1
Apr 3 07:13:53 rpi3 kernel: [55777.406395]
Apr 3 07:13:53 rpi3 kernel: [55777.406398] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 5
Apr 3 07:14:46 rpi3 kernel: [55830.334463]
Apr 3 07:14:46 rpi3 kernel: [55830.334479] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 3
Apr 3 07:15:33 rpi3 kernel: [55876.926970]
Apr 3 07:15:33 rpi3 kernel: [55876.926986] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 1
Apr 3 07:16:39 rpi3 kernel: [55943.327586]
Apr 3 07:16:39 rpi3 kernel: [55943.327602] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 5
Apr 3 07:16:39 rpi3 kernel: [55943.328032]
Apr 3 07:16:39 rpi3 kernel: [55943.328035] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 2
Apr 3 07:16:56 rpi3 kernel: [55959.903701]
Apr 3 07:16:56 rpi3 kernel: [55959.903717] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 5
Apr 3 07:16:56 rpi3 kernel: [55959.904135]
Apr 3 07:16:56 rpi3 kernel: [55959.904138] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 6
Apr 3 07:17:08 rpi3 kernel: [55971.903972]
Apr 3 07:17:08 rpi3 kernel: [55971.903987] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 3
Apr 3 07:17:27 rpi3 kernel: [55991.487949]
Apr 3 07:17:27 rpi3 kernel: [55991.487965] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 0
Apr 3 07:17:27 rpi3 kernel: [55991.488389]
Apr 3 07:17:27 rpi3 kernel: [55991.488393] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 4
Apr 3 07:17:35 rpi3 kernel: [55998.720229]
Apr 3 07:17:35 rpi3 kernel: [55998.720245] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 3
Apr 3 07:18:26 rpi3 kernel: [56049.728598]
Apr 3 07:18:26 rpi3 kernel: [56049.728615] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 4
Apr 3 07:20:31 rpi3 kernel: [56174.945843]
Apr 3 07:20:31 rpi3 kernel: [56174.945859] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 1
Apr 3 07:21:15 rpi3 kernel: [56218.658224]
Apr 3 07:21:15 rpi3 kernel: [56218.658241] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 4
Apr 3 07:21:22 rpi3 kernel: [56226.434080]
Apr 3 07:21:22 rpi3 kernel: [56226.434097] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 4
Apr 3 07:22:05 rpi3 kernel: [56268.610913]
Apr 3 07:22:05 rpi3 kernel: [56268.610931] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 7
Apr 3 07:22:48 rpi3 kernel: [56311.746977]
Apr 3 07:22:48 rpi3 kernel: [56311.746994] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 3
Apr 3 07:23:13 rpi3 kernel: [56336.707222]
Apr 3 07:23:13 rpi3 kernel: [56336.707237] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 1
Apr 3 07:25:18 rpi3 kernel: [56462.468340]
Apr 3 07:25:18 rpi3 kernel: [56462.468356] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 1
Apr 3 07:26:01 rpi3 kernel: [56505.316998]
Apr 3 07:26:01 rpi3 kernel: [56505.317022] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 1
Apr 3 07:26:23 rpi3 kernel: [56527.108953]
Apr 3 07:26:23 rpi3 kernel: [56527.108969] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 2
Apr 3 07:27:08 rpi3 kernel: [56572.421335]
Apr 3 07:27:08 rpi3 kernel: [56572.421351] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 6
Apr 3 07:27:42 rpi3 kernel: [56605.893864]
Apr 3 07:27:42 rpi3 kernel: [56605.893881] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 1
Apr 3 07:29:14 rpi3 kernel: [56697.638604]
Apr 3 07:29:14 rpi3 kernel: [56697.638621] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 7
Apr 3 07:30:01 rpi3 kernel: [56744.743121]
Apr 3 07:30:01 rpi3 kernel: [56744.743140] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 7
Apr 3 07:30:17 rpi3 kernel: [56761.191232]
Apr 3 07:30:17 rpi3 kernel: [56761.191249] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 4
Apr 3 07:30:39 rpi3 kernel: [56782.759468]
Apr 3 07:30:39 rpi3 kernel: [56782.759485] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 6
Apr 3 07:30:58 rpi3 kernel: [56802.535598]
Apr 3 07:30:58 rpi3 kernel: [56802.535615] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 7
Apr 3 07:32:34 rpi3 kernel: [56898.536457]
Apr 3 07:32:34 rpi3 kernel: [56898.536473] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 2
Apr 3 07:35:37 rpi3 kernel: [57081.001961]
Apr 3 07:35:37 rpi3 kernel: [57081.001977] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 2
Apr 3 07:36:50 rpi3 kernel: [57154.378707]
Apr 3 07:36:50 rpi3 kernel: [57154.378723] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 7
Apr 3 07:36:50 rpi3 kernel: [57154.379148]
Apr 3 07:36:50 rpi3 kernel: [57154.379151] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 6
Apr 3 07:36:57 rpi3 kernel: [57161.546974]
Apr 3 07:36:57 rpi3 kernel: [57161.546991] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 6
Apr 3 07:39:04 rpi3 kernel: [57287.595958]
Apr 3 07:39:04 rpi3 kernel: [57287.595974] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 1
Apr 3 07:40:13 rpi3 kernel: [57357.388579]
Apr 3 07:40:13 rpi3 kernel: [57357.388595] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 7
Apr 3 07:40:13 rpi3 kernel: [57357.389015]
Apr 3 07:40:13 rpi3 kernel: [57357.389018] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 5
Apr 3 07:42:00 rpi3 kernel: [57463.789588]
Apr 3 07:42:00 rpi3 kernel: [57463.789604] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 1
Apr 3 07:42:00 rpi3 kernel: [57463.790029]
Apr 3 07:42:00 rpi3 kernel: [57463.790032] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 6
Apr 3 07:42:16 rpi3 kernel: [57480.429714]
Apr 3 07:42:16 rpi3 kernel: [57480.429731] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 3
Apr 3 07:42:26 rpi3 kernel: [57489.773836]
Apr 3 07:42:26 rpi3 kernel: [57489.773853] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 5
Apr 3 07:42:26 rpi3 kernel: [57489.774268]
Apr 3 07:42:26 rpi3 kernel: [57489.774272] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 0
Apr 3 07:42:54 rpi3 kernel: [57518.510089]
Apr 3 07:42:54 rpi3 kernel: [57518.510105] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 4
Apr 3 07:43:04 rpi3 kernel: [57528.494227]
Apr 3 07:43:04 rpi3 kernel: [57528.494243] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 4
Apr 3 07:44:42 rpi3 kernel: [57625.679098]
Apr 3 07:44:42 rpi3 kernel: [57625.679114] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 6
Apr 3 07:45:59 rpi3 kernel: [57702.703707]
Apr 3 07:45:59 rpi3 kernel: [57702.703723] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 3
Apr 3 07:45:59 rpi3 kernel: [57702.704141]
Apr 3 07:45:59 rpi3 kernel: [57702.704144] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 5
Apr 3 07:46:44 rpi3 kernel: [57747.984347]
Apr 3 07:46:44 rpi3 kernel: [57747.984363] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 5
Apr 3 07:47:52 rpi3 kernel: [57816.432847]
Apr 3 07:47:52 rpi3 kernel: [57816.432863] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 6
Apr 3 07:48:17 rpi3 kernel: [57840.721232]
Apr 3 07:48:17 rpi3 kernel: [57840.721248] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 6
Apr 3 07:49:25 rpi3 kernel: [57908.977716]
Apr 3 07:49:25 rpi3 kernel: [57908.977733] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 5
Apr 3 07:49:25 rpi3 kernel: [57908.978162]
Apr 3 07:49:25 rpi3 kernel: [57908.978166] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 7
Apr 3 07:49:28 rpi3 kernel: [57911.665849]
Apr 3 07:49:28 rpi3 kernel: [57911.665865] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 2
Apr 3 07:50:16 rpi3 kernel: [57959.634229]
Apr 3 07:50:16 rpi3 kernel: [57959.634246] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 3
Apr 3 07:50:54 rpi3 kernel: [57998.418581]
Apr 3 07:50:54 rpi3 kernel: [57998.418597] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 1
Apr 3 07:50:54 rpi3 kernel: [57998.419019]
Apr 3 07:50:54 rpi3 kernel: [57998.419022] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 2
Apr 3 07:51:23 rpi3 kernel: [58027.251109]
Apr 3 07:51:23 rpi3 kernel: [58027.251126] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 2
Apr 3 07:52:30 rpi3 kernel: [58093.747342]
Apr 3 07:52:30 rpi3 kernel: [58093.747358] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 4
Apr 3 07:53:04 rpi3 kernel: [58127.987715]
Apr 3 07:53:04 rpi3 kernel: [58127.987731] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 7
Apr 3 07:53:22 rpi3 kernel: [58146.355963]
Apr 3 07:53:22 rpi3 kernel: [58146.355979] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 3
Apr 3 07:53:22 rpi3 kernel: [58146.356409]
Apr 3 07:53:22 rpi3 kernel: [58146.356412] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 6
Apr 3 07:53:51 rpi3 kernel: [58175.380220]
Apr 3 07:53:51 rpi3 kernel: [58175.380236] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 5
Apr 3 07:53:51 rpi3 kernel: [58175.380664]
Apr 3 07:53:51 rpi3 kernel: [58175.380668] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 1
Apr 3 07:54:20 rpi3 kernel: [58204.436476]
Apr 3 07:54:20 rpi3 kernel: [58204.436492] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 2
Apr 3 07:55:09 rpi3 kernel: [58253.461112]
Apr 3 07:55:09 rpi3 kernel: [58253.461128] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 2
Apr 3 07:55:12 rpi3 kernel: [58256.052830]
Apr 3 07:55:12 rpi3 kernel: [58256.052846] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 4
Apr 3 07:55:12 rpi3 kernel: [58256.053254]
Apr 3 07:55:12 rpi3 kernel: [58256.053257] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 1
Apr 3 07:55:49 rpi3 kernel: [58292.597223]
Apr 3 07:55:49 rpi3 kernel: [58292.597240] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 1
Apr 3 07:56:01 rpi3 kernel: [58304.949479]
Apr 3 07:56:01 rpi3 kernel: [58304.949496] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 1
Apr 3 07:56:42 rpi3 kernel: [58345.973850]
Apr 3 07:56:42 rpi3 kernel: [58345.973867] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 1
Apr 3 07:57:17 rpi3 kernel: [58381.462083]
Apr 3 07:57:17 rpi3 kernel: [58381.462099] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 6
Apr 3 07:57:59 rpi3 kernel: [58422.902479]
Apr 3 07:57:59 rpi3 kernel: [58422.902494] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 0
Apr 3 07:58:37 rpi3 kernel: [58461.334976]
Apr 3 07:58:37 rpi3 kernel: [58461.334992] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 2
Apr 3 07:58:42 rpi3 kernel: [58465.910842]
Apr 3 07:58:42 rpi3 kernel: [58465.910858] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 2
Apr 3 07:59:11 rpi3 kernel: [58495.127083]
Apr 3 07:59:11 rpi3 kernel: [58495.127099] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 4
Apr 3 07:59:11 rpi3 kernel: [58495.127517]
Apr 3 07:59:11 rpi3 kernel: [58495.127521] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 0
Apr 3 07:59:25 rpi3 kernel: [58509.239226]
Apr 3 07:59:25 rpi3 kernel: [58509.239242] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 0
Apr 3 08:01:00 rpi3 kernel: [58604.440363]
Apr 3 08:01:00 rpi3 kernel: [58604.440380] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 7
Apr 3 08:01:32 rpi3 kernel: [58635.640341]
Apr 3 08:01:32 rpi3 kernel: [58635.640357] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 7
Apr 3 08:01:53 rpi3 kernel: [58656.824594]
Apr 3 08:01:53 rpi3 kernel: [58656.824609] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 1
Apr 3 08:02:36 rpi3 kernel: [58700.313254]
Apr 3 08:02:36 rpi3 kernel: [58700.313271] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 6
Apr 3 08:02:53 rpi3 kernel: [58717.369093]
Apr 3 08:02:53 rpi3 kernel: [58717.369109] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 1
Apr 3 08:03:23 rpi3 kernel: [58746.713601]
Apr 3 08:03:23 rpi3 kernel: [58746.713617] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 6
Apr 3 08:03:32 rpi3 kernel: [58756.057473]
Apr 3 08:03:32 rpi3 kernel: [58756.057490] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 0
Apr 3 08:03:58 rpi3 kernel: [58781.849853]
Apr 3 08:03:58 rpi3 kernel: [58781.849869] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 6
Apr 3 08:04:13 rpi3 kernel: [58796.921985]
Apr 3 08:04:13 rpi3 kernel: [58796.922002] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 7
Apr 3 08:04:57 rpi3 kernel: [58841.050343]
Apr 3 08:04:57 rpi3 kernel: [58841.050359] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 1
Apr 3 08:05:16 rpi3 kernel: [58860.250468]
Apr 3 08:05:16 rpi3 kernel: [58860.250484] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 4
Apr 3 08:06:02 rpi3 kernel: [58905.946854]
Apr 3 08:06:02 rpi3 kernel: [58905.946871] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 3
Apr 3 08:06:18 rpi3 kernel: [58922.459237]
Apr 3 08:06:18 rpi3 kernel: [58922.459254] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 3
Apr 3 08:06:57 rpi3 kernel: [58961.371465]
Apr 3 08:06:57 rpi3 kernel: [58961.371481] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 0
Apr 3 08:07:10 rpi3 kernel: [58973.723459]
Apr 3 08:07:10 rpi3 kernel: [58973.723476] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 3
Apr 3 08:07:10 rpi3 kernel: [58973.723900]
Apr 3 08:07:10 rpi3 kernel: [58973.723903] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 4
Apr 3 08:07:35 rpi3 kernel: [58998.715713]
Apr 3 08:07:35 rpi3 kernel: [58998.715730] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 3
Apr 3 08:07:35 rpi3 kernel: [58998.716150]
Apr 3 08:07:35 rpi3 kernel: [58998.716154] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 4
Apr 3 08:08:15 rpi3 kernel: [59039.388085]
Apr 3 08:08:15 rpi3 kernel: [59039.388100] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 4
Apr 3 08:08:15 rpi3 kernel: [59039.388516]
Apr 3 08:08:15 rpi3 kernel: [59039.388519] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 5
Apr 3 08:08:20 rpi3 kernel: [59044.572213]
Apr 3 08:08:20 rpi3 kernel: [59044.572229] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 5
Apr 3 08:08:20 rpi3 kernel: [59044.572648]
Apr 3 08:08:20 rpi3 kernel: [59044.572652] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 7
Apr 3 08:08:28 rpi3 kernel: [59051.836352]
Apr 3 08:08:28 rpi3 kernel: [59051.836368] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 3
Apr 3 08:09:14 rpi3 kernel: [59097.820723]
Apr 3 08:09:14 rpi3 kernel: [59097.820739] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 1
Apr 3 08:09:21 rpi3 kernel: [59104.956707]
Apr 3 08:09:21 rpi3 kernel: [59104.956723] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 7
Apr 3 08:09:21 rpi3 kernel: [59104.957140]
Apr 3 08:09:21 rpi3 kernel: [59104.957143] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 4
Apr 3 08:10:22 rpi3 kernel: [59165.949335]
Apr 3 08:10:22 rpi3 kernel: [59165.949351] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 6
Apr 3 08:13:18 rpi3 kernel: [59342.142968]
Apr 3 08:13:18 rpi3 kernel: [59342.142985] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 0
Apr 3 08:13:18 rpi3 kernel: [59342.143407]
Apr 3 08:13:18 rpi3 kernel: [59342.143410] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 7
Apr 3 08:13:28 rpi3 kernel: [59351.935108]
Apr 3 08:13:28 rpi3 kernel: [59351.935124] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 6
Apr 3 08:13:52 rpi3 kernel: [59375.999229]
Apr 3 08:13:52 rpi3 kernel: [59375.999244] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 1
Apr 3 08:13:56 rpi3 kernel: [59380.575493]
Apr 3 08:13:56 rpi3 kernel: [59380.575510] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 3
Apr 3 08:14:04 rpi3 kernel: [59388.383336]
Apr 3 08:14:04 rpi3 kernel: [59388.383352] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 5
Apr 3 08:14:12 rpi3 kernel: [59396.191473]
Apr 3 08:14:12 rpi3 kernel: [59396.191490] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 0
Apr 3 08:14:19 rpi3 kernel: [59403.327745]
Apr 3 08:14:19 rpi3 kernel: [59403.327762] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 3
Apr 3 08:15:29 rpi3 kernel: [59472.736102]
Apr 3 08:15:29 rpi3 kernel: [59472.736119] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 4
Apr 3 08:15:39 rpi3 kernel: [59483.104358]
Apr 3 08:15:39 rpi3 kernel: [59483.104374] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 0
Apr 3 08:16:11 rpi3 kernel: [59515.360586]
Apr 3 08:16:11 rpi3 kernel: [59515.360602] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 5
Apr 3 08:16:11 rpi3 kernel: [59515.361022]
Apr 3 08:16:11 rpi3 kernel: [59515.361025] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 4
Apr 3 08:16:26 rpi3 kernel: [59530.048597]
Apr 3 08:16:26 rpi3 kernel: [59530.048614] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 5
Apr 3 08:17:00 rpi3 kernel: [59563.713116]
Apr 3 08:17:00 rpi3 kernel: [59563.713133] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 4
Apr 3 08:17:29 rpi3 kernel: [59593.345215]
Apr 3 08:17:29 rpi3 kernel: [59593.345232] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 0
Apr 3 08:17:41 rpi3 kernel: [59605.217487]
Apr 3 08:17:41 rpi3 kernel: [59605.217503] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 4
Apr 3 08:19:03 rpi3 kernel: [59686.690250]
Apr 3 08:19:03 rpi3 kernel: [59686.690269] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 2
Apr 3 08:19:44 rpi3 kernel: [59728.130471]
Apr 3 08:19:44 rpi3 kernel: [59728.130487] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 3
Apr 3 08:19:49 rpi3 kernel: [59732.706598]
Apr 3 08:19:49 rpi3 kernel: [59732.706615] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 4
Apr 3 08:19:49 rpi3 kernel: [59732.707057]
Apr 3 08:19:49 rpi3 kernel: [59732.707061] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 1
Apr 3 08:20:15 rpi3 kernel: [59758.978863]
Apr 3 08:20:15 rpi3 kernel: [59758.978879] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 3
Apr 3 08:23:10 rpi3 kernel: [59934.308483]
Apr 3 08:23:10 rpi3 kernel: [59934.308499] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 2
Apr 3 08:28:54 rpi3 kernel: [60278.407724]
Apr 3 08:28:54 rpi3 kernel: [60278.407740] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 1
Apr 3 08:28:54 rpi3 kernel: [60278.408171]
Apr 3 08:28:54 rpi3 kernel: [60278.408174] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 0
Apr 3 08:28:59 rpi3 kernel: [60283.591590]
Apr 3 08:28:59 rpi3 kernel: [60283.591606] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 7
Apr 3 08:28:59 rpi3 kernel: [60283.592025]
Apr 3 08:28:59 rpi3 kernel: [60283.592028] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 4
Apr 3 08:30:00 rpi3 kernel: [60343.912218]
Apr 3 08:30:00 rpi3 kernel: [60343.912234] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 0
Apr 3 08:30:58 rpi3 kernel: [60402.472855]
Apr 3 08:30:58 rpi3 kernel: [60402.472871] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 5
Apr 3 08:32:13 rpi3 kernel: [60476.617472]
Apr 3 08:32:13 rpi3 kernel: [60476.617488] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 2
Apr 3 08:32:13 rpi3 kernel: [60476.617918]
Apr 3 08:32:13 rpi3 kernel: [60476.617921] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 7
Apr 3 08:33:18 rpi3 kernel: [60542.314112]
Apr 3 08:33:18 rpi3 kernel: [60542.314128] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 7
Apr 3 08:33:43 rpi3 kernel: [60566.634368]
Apr 3 08:33:43 rpi3 kernel: [60566.634385] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 7
Apr 3 08:35:00 rpi3 kernel: [60644.554966]
Apr 3 08:35:00 rpi3 kernel: [60644.554982] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 0
Apr 3 08:35:15 rpi3 kernel: [60659.595092]
Apr 3 08:35:15 rpi3 kernel: [60659.595108] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 1
Apr 3 08:35:23 rpi3 kernel: [60667.051101]
Apr 3 08:35:23 rpi3 kernel: [60667.051117] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 1
Apr 3 08:36:18 rpi3 kernel: [60722.155855]
Apr 3 08:36:18 rpi3 kernel: [60722.155871] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 2
Apr 3 08:36:45 rpi3 kernel: [60748.939968]
Apr 3 08:36:45 rpi3 kernel: [60748.939985] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 1
Apr 3 08:37:06 rpi3 kernel: [60770.060092]
Apr 3 08:37:06 rpi3 kernel: [60770.060108] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 6
Apr 3 08:37:06 rpi3 kernel: [60770.060528]
Apr 3 08:37:06 rpi3 kernel: [60770.060531] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 1
Apr 3 08:38:25 rpi3 kernel: [60848.748986]
Apr 3 08:38:25 rpi3 kernel: [60848.749003] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 2
Apr 3 08:39:03 rpi3 kernel: [60887.181225]
Apr 3 08:39:03 rpi3 kernel: [60887.181240] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 3
Apr 3 08:39:39 rpi3 kernel: [60923.277746]
Apr 3 08:39:39 rpi3 kernel: [60923.277763] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 3
Apr 3 08:39:54 rpi3 kernel: [60937.773856]
Apr 3 08:39:54 rpi3 kernel: [60937.773873] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 5
Apr 3 08:39:54 rpi3 kernel: [60937.774306]
Apr 3 08:39:54 rpi3 kernel: [60937.774309] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 3
Apr 3 08:40:09 rpi3 kernel: [60952.845847]
Apr 3 08:40:09 rpi3 kernel: [60952.845863] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 5
Apr 3 08:40:09 rpi3 kernel: [60952.846280]
Apr 3 08:40:09 rpi3 kernel: [60952.846284] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 7
Apr 3 08:42:39 rpi3 kernel: [61103.375435]
Apr 3 08:42:39 rpi3 kernel: [61103.375459] WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer to complete on 2
I have the same warning on messages also if I try to use another USB ot RS485 adapter using the "ch341" chip.
Thanks for your support.
I am also seeing this a lot on my installation.
RASPBERRY PI VERSION VERSION
Raspberry Pi 3B+
RETTY_NAME="Debian GNU/Linux 11 (bullseye)" NAME="Debian GNU/Linux" VERSION_ID="11" VERSION="11 (bullseye)" VERSION_CODENAME=bullseye ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/"
Client: Docker Engine - Community Version: 24.0.2 API version: 1.43 Go version: go1.20.4 Git commit: cb74dfc Built: Thu May 25 21:50:59 2023 OS/Arch: linux/arm64 Context: default
DOCKER VERSION
Server: Docker Engine - Community Engine: Version: 24.0.2 API version: 1.43 (minimum version 1.12) Go version: go1.20.4 Git commit: 659604f Built: Thu May 25 21:50:59 2023 OS/Arch: linux/arm64 Experimental: false containerd: Version: 1.6.21 GitCommit: 3dce8eb055cbb6872793272b4f20ed16117344f8 runc: Version: 1.1.7 GitCommit: v1.1.7-0-g860f061 docker-init: Version: 0.19.0 GitCommit: de40ad0
Hello.
For now I have changed my setup so instead to use https://github.com/gianfrdp/SDM120C software to poll my SDM120 meter, I'm using mbusd and "call" it via mbpoll command.
So the software that uses the serial port is mbusd and in this way I don't have any more Timed out waiting for FSM NP transfer to complete on the /var/log/messages.
I had the same issue with the 64bits edition of Raspberry Pi OS. I reinstalled the 32bits version, and the WARN::dwc_otg_hcd_urb_dequeue:639: Timed out waiting for FSM NP transfer errors are completely gone.
At some points before reinstalling, the Raspberry Pi was even losing the network after a few hours. Everything is solved by moving back to the 32bits edition.
My model is: Raspberry Pi 3 Model B Plus Rev 1.3
The dwc_otg's driver makes heavy use of FIQs to improve performance. Until fairly recently the arm64 support didn't recognise FIQs; it looks like they are now supported to some extent, but the dwc_otg driver hasn't been updated to use it - you can bet that won't be a simple task.
For now, the advice on arm64 is the same as it's always been - use "dtoverlay=dwc2" to select the upstream DWC2 driver.
thank you for the pointer. however it appears to not be possible to boot from a usb drive using the dwc2 driver.
dtoverlay=dwc2,dr_mode=host
also disabling fiq in config.txt isn't taken into account by the driver, if it is even still possible. https://forums.raspberrypi.com/viewtopic.php?t=70437
dwc_otg.fiq_enable=0
dwc_otg.fiq_fsm_enable=0
$ dmesg | grep FIQ
dwc_otg: FIQ enabled
dwc_otg: FIQ split-transaction FSM enabled
I'll revert to armv7l as well.
edit : reverted to armv7l, issue does still appear, but much less often. edit2 : moved to emmc on sd adapter, no more issues.
Same, 64-bit Debian Bookworm on a Raspberry Pi 3+. I'm also using a USB-to-RJ45 cable to read my smart energy meter.
also disabling fiq in config.txt isn't taken into account by the driver, if it is even still possible. dwc_otg.fiq_enable=0 dwc_otg.fiq_fsm_enable=0
These setting go in cmdline.txt (on existing line), not config.txt.
