* g_webcam Isoch high bandwidth transfer @ 2016-09-20 17:04 Bin Liu 2016-09-21 8:01 ` Felipe Balbi 0 siblings, 1 reply; 19+ messages in thread From: Bin Liu @ 2016-09-20 17:04 UTC (permalink / raw) To: linux-usb, linux-media Hi, I am trying to check Isoch high bandwidth transfer with g_webcam.ko in high-speed connection. First I hacked webcam.c as follows to enable 640x480@30fps mode. diff --git a/drivers/usb/gadget/legacy/webcam.c b/drivers/usb/gadget/legacy/webcam.c index 72c976b..9eb315f 100644 --- a/drivers/usb/gadget/legacy/webcam.c +++ b/drivers/usb/gadget/legacy/webcam.c @@ -191,15 +191,15 @@ static const struct UVC_FRAME_UNCOMPRESSED(3) uvc_frame_yuv_360p = { .bFrameIndex = 1, .bmCapabilities = 0, .wWidth = cpu_to_le16(640), - .wHeight = cpu_to_le16(360), + .wHeight = cpu_to_le16(480), .dwMinBitRate = cpu_to_le32(18432000), .dwMaxBitRate = cpu_to_le32(55296000), - .dwMaxVideoFrameBufferSize = cpu_to_le32(460800), - .dwDefaultFrameInterval = cpu_to_le32(666666), + .dwMaxVideoFrameBufferSize = cpu_to_le32(614400), + .dwDefaultFrameInterval = cpu_to_le32(333333), .bFrameIntervalType = 3, - .dwFrameInterval[0] = cpu_to_le32(666666), - .dwFrameInterval[1] = cpu_to_le32(1000000), - .dwFrameInterval[2] = cpu_to_le32(5000000), + .dwFrameInterval[0] = cpu_to_le32(333333), + .dwFrameInterval[1] = cpu_to_le32(666666), + .dwFrameInterval[2] = cpu_to_le32(1000000), }; then loaded g_webcam.ko as # modprobe g_webcam streaming_maxpacket=3072 The endpoint descriptor showing on the host is Endpoint Descriptor: bLength 7 bDescriptorType 5 bEndpointAddress 0x8d EP 13 IN bmAttributes 5 Transfer Type Isochronous Synch Type Asynchronous Usage Type Data wMaxPacketSize 0x1400 3x 1024 bytes bInterval 1 However the usb bus trace shows only one transaction with 1024-bytes packet in every SOF. The host only sends one IN packet in every SOF, I am expecting 2~3 1024-bytes transactions, since this would be required to transfer 640x480@30fps YUV frames in high-speed. DId I miss anything in the setup? Thanks, -Bin. ^ permalink raw reply related [flat|nested] 19+ messages in thread
* Re: g_webcam Isoch high bandwidth transfer 2016-09-20 17:04 g_webcam Isoch high bandwidth transfer Bin Liu @ 2016-09-21 8:01 ` Felipe Balbi 2016-09-21 13:27 ` Bin Liu 0 siblings, 1 reply; 19+ messages in thread From: Felipe Balbi @ 2016-09-21 8:01 UTC (permalink / raw) To: Bin Liu, linux-usb, linux-media [-- Attachment #1: Type: text/plain, Size: 2604 bytes --] Hi, Bin Liu <b-liu@ti.com> writes: > Hi, > > I am trying to check Isoch high bandwidth transfer with g_webcam.ko in > high-speed connection. > > First I hacked webcam.c as follows to enable 640x480@30fps mode. > > diff --git a/drivers/usb/gadget/legacy/webcam.c b/drivers/usb/gadget/legacy/webcam.c > index 72c976b..9eb315f 100644 > --- a/drivers/usb/gadget/legacy/webcam.c > +++ b/drivers/usb/gadget/legacy/webcam.c > @@ -191,15 +191,15 @@ static const struct UVC_FRAME_UNCOMPRESSED(3) uvc_frame_yuv_360p = { > .bFrameIndex = 1, > .bmCapabilities = 0, > .wWidth = cpu_to_le16(640), > - .wHeight = cpu_to_le16(360), > + .wHeight = cpu_to_le16(480), > .dwMinBitRate = cpu_to_le32(18432000), > .dwMaxBitRate = cpu_to_le32(55296000), > - .dwMaxVideoFrameBufferSize = cpu_to_le32(460800), > - .dwDefaultFrameInterval = cpu_to_le32(666666), > + .dwMaxVideoFrameBufferSize = cpu_to_le32(614400), > + .dwDefaultFrameInterval = cpu_to_le32(333333), > .bFrameIntervalType = 3, > - .dwFrameInterval[0] = cpu_to_le32(666666), > - .dwFrameInterval[1] = cpu_to_le32(1000000), > - .dwFrameInterval[2] = cpu_to_le32(5000000), > + .dwFrameInterval[0] = cpu_to_le32(333333), > + .dwFrameInterval[1] = cpu_to_le32(666666), > + .dwFrameInterval[2] = cpu_to_le32(1000000), > }; > > then loaded g_webcam.ko as > > # modprobe g_webcam streaming_maxpacket=3072 > > The endpoint descriptor showing on the host is > > Endpoint Descriptor: > bLength 7 > bDescriptorType 5 > bEndpointAddress 0x8d EP 13 IN > bmAttributes 5 > Transfer Type Isochronous > Synch Type Asynchronous > Usage Type Data > wMaxPacketSize 0x1400 3x 1024 bytes > bInterval 1 > > However the usb bus trace shows only one transaction with 1024-bytes packet in > every SOF. The host only sends one IN packet in every SOF, I am expecting 2~3 > 1024-bytes transactions, since this would be required to transfer 640x480@30fps > YUV frames in high-speed. > > DId I miss anything in the setup? MUSB or DWC3? This looks like a UDC bug to me. Can you show a screenshot of your bus analyzer? When host sends IN token, are you replying with DATA0, DATA1 or DATA2? -- balbi [-- Attachment #2: signature.asc --] [-- Type: application/pgp-signature, Size: 800 bytes --] ^ permalink raw reply [flat|nested] 19+ messages in thread
* Re: g_webcam Isoch high bandwidth transfer 2016-09-21 8:01 ` Felipe Balbi @ 2016-09-21 13:27 ` Bin Liu 2016-09-21 14:58 ` Bin Liu 2016-09-22 7:37 ` Felipe Balbi 0 siblings, 2 replies; 19+ messages in thread From: Bin Liu @ 2016-09-21 13:27 UTC (permalink / raw) To: Felipe Balbi; +Cc: linux-usb, linux-media [-- Attachment #1: Type: text/plain, Size: 2852 bytes --] On Wed, Sep 21, 2016 at 11:01:21AM +0300, Felipe Balbi wrote: > > Hi, > > Bin Liu <b-liu@ti.com> writes: > > Hi, > > > > I am trying to check Isoch high bandwidth transfer with g_webcam.ko in > > high-speed connection. > > > > First I hacked webcam.c as follows to enable 640x480@30fps mode. > > > > diff --git a/drivers/usb/gadget/legacy/webcam.c b/drivers/usb/gadget/legacy/webcam.c > > index 72c976b..9eb315f 100644 > > --- a/drivers/usb/gadget/legacy/webcam.c > > +++ b/drivers/usb/gadget/legacy/webcam.c > > @@ -191,15 +191,15 @@ static const struct UVC_FRAME_UNCOMPRESSED(3) uvc_frame_yuv_360p = { > > .bFrameIndex = 1, > > .bmCapabilities = 0, > > .wWidth = cpu_to_le16(640), > > - .wHeight = cpu_to_le16(360), > > + .wHeight = cpu_to_le16(480), > > .dwMinBitRate = cpu_to_le32(18432000), > > .dwMaxBitRate = cpu_to_le32(55296000), > > - .dwMaxVideoFrameBufferSize = cpu_to_le32(460800), > > - .dwDefaultFrameInterval = cpu_to_le32(666666), > > + .dwMaxVideoFrameBufferSize = cpu_to_le32(614400), > > + .dwDefaultFrameInterval = cpu_to_le32(333333), > > .bFrameIntervalType = 3, > > - .dwFrameInterval[0] = cpu_to_le32(666666), > > - .dwFrameInterval[1] = cpu_to_le32(1000000), > > - .dwFrameInterval[2] = cpu_to_le32(5000000), > > + .dwFrameInterval[0] = cpu_to_le32(333333), > > + .dwFrameInterval[1] = cpu_to_le32(666666), > > + .dwFrameInterval[2] = cpu_to_le32(1000000), > > }; > > > > then loaded g_webcam.ko as > > > > # modprobe g_webcam streaming_maxpacket=3072 > > > > The endpoint descriptor showing on the host is > > > > Endpoint Descriptor: > > bLength 7 > > bDescriptorType 5 > > bEndpointAddress 0x8d EP 13 IN > > bmAttributes 5 > > Transfer Type Isochronous > > Synch Type Asynchronous > > Usage Type Data > > wMaxPacketSize 0x1400 3x 1024 bytes > > bInterval 1 > > > > However the usb bus trace shows only one transaction with 1024-bytes packet in > > every SOF. The host only sends one IN packet in every SOF, I am expecting 2~3 > > 1024-bytes transactions, since this would be required to transfer 640x480@30fps > > YUV frames in high-speed. > > > > DId I miss anything in the setup? > > MUSB or DWC3? This looks like a UDC bug to me. Can you show a screenshot Happened on both MUSB and DWC3. > of your bus analyzer? When host sends IN token, are you replying with The trace screenshot on DWC3 is attached. > DATA0, DATA1 or DATA2? Good hint! It is DATA0! > > -- > balbi Regards, -Bin. [-- Attachment #2: dwc3-g_webcam-DATA0-only-bus-trace.png --] [-- Type: image/png, Size: 71300 bytes --] ^ permalink raw reply [flat|nested] 19+ messages in thread
* Re: g_webcam Isoch high bandwidth transfer 2016-09-21 13:27 ` Bin Liu @ 2016-09-21 14:58 ` Bin Liu 2016-09-22 7:37 ` Felipe Balbi 1 sibling, 0 replies; 19+ messages in thread From: Bin Liu @ 2016-09-21 14:58 UTC (permalink / raw) To: Felipe Balbi, linux-usb, linux-media On Wed, Sep 21, 2016 at 08:27:02AM -0500, Bin Liu wrote: > On Wed, Sep 21, 2016 at 11:01:21AM +0300, Felipe Balbi wrote: > > > > Hi, > > > > Bin Liu <b-liu@ti.com> writes: > > > Hi, > > > > > > I am trying to check Isoch high bandwidth transfer with g_webcam.ko in > > > high-speed connection. > > > > > > First I hacked webcam.c as follows to enable 640x480@30fps mode. > > > > > > diff --git a/drivers/usb/gadget/legacy/webcam.c b/drivers/usb/gadget/legacy/webcam.c > > > index 72c976b..9eb315f 100644 > > > --- a/drivers/usb/gadget/legacy/webcam.c > > > +++ b/drivers/usb/gadget/legacy/webcam.c > > > @@ -191,15 +191,15 @@ static const struct UVC_FRAME_UNCOMPRESSED(3) uvc_frame_yuv_360p = { > > > .bFrameIndex = 1, > > > .bmCapabilities = 0, > > > .wWidth = cpu_to_le16(640), > > > - .wHeight = cpu_to_le16(360), > > > + .wHeight = cpu_to_le16(480), > > > .dwMinBitRate = cpu_to_le32(18432000), > > > .dwMaxBitRate = cpu_to_le32(55296000), > > > - .dwMaxVideoFrameBufferSize = cpu_to_le32(460800), > > > - .dwDefaultFrameInterval = cpu_to_le32(666666), > > > + .dwMaxVideoFrameBufferSize = cpu_to_le32(614400), > > > + .dwDefaultFrameInterval = cpu_to_le32(333333), > > > .bFrameIntervalType = 3, > > > - .dwFrameInterval[0] = cpu_to_le32(666666), > > > - .dwFrameInterval[1] = cpu_to_le32(1000000), > > > - .dwFrameInterval[2] = cpu_to_le32(5000000), > > > + .dwFrameInterval[0] = cpu_to_le32(333333), > > > + .dwFrameInterval[1] = cpu_to_le32(666666), > > > + .dwFrameInterval[2] = cpu_to_le32(1000000), > > > }; > > > > > > then loaded g_webcam.ko as > > > > > > # modprobe g_webcam streaming_maxpacket=3072 > > > > > > The endpoint descriptor showing on the host is > > > > > > Endpoint Descriptor: > > > bLength 7 > > > bDescriptorType 5 > > > bEndpointAddress 0x8d EP 13 IN > > > bmAttributes 5 > > > Transfer Type Isochronous > > > Synch Type Asynchronous > > > Usage Type Data > > > wMaxPacketSize 0x1400 3x 1024 bytes > > > bInterval 1 > > > > > > However the usb bus trace shows only one transaction with 1024-bytes packet in > > > every SOF. The host only sends one IN packet in every SOF, I am expecting 2~3 > > > 1024-bytes transactions, since this would be required to transfer 640x480@30fps > > > YUV frames in high-speed. > > > > > > DId I miss anything in the setup? > > > > MUSB or DWC3? This looks like a UDC bug to me. Can you show a screenshot > > Happened on both MUSB and DWC3. Indeed, it is MUSB gadget driver problem. > > > of your bus analyzer? When host sends IN token, are you replying with > > The trace screenshot on DWC3 is attached. > > > DATA0, DATA1 or DATA2? > > Good hint! It is DATA0! > > > > > -- > > balbi > > Regards, > -Bin. ^ permalink raw reply [flat|nested] 19+ messages in thread
* Re: g_webcam Isoch high bandwidth transfer 2016-09-21 13:27 ` Bin Liu 2016-09-21 14:58 ` Bin Liu @ 2016-09-22 7:37 ` Felipe Balbi 2016-09-22 8:08 ` Felipe Balbi 1 sibling, 1 reply; 19+ messages in thread From: Felipe Balbi @ 2016-09-22 7:37 UTC (permalink / raw) To: Bin Liu; +Cc: linux-usb, linux-media [-- Attachment #1: Type: text/plain, Size: 3244 bytes --] Hi, Bin Liu <b-liu@ti.com> writes: > On Wed, Sep 21, 2016 at 11:01:21AM +0300, Felipe Balbi wrote: >> >> Hi, >> >> Bin Liu <b-liu@ti.com> writes: >> > Hi, >> > >> > I am trying to check Isoch high bandwidth transfer with g_webcam.ko in >> > high-speed connection. >> > >> > First I hacked webcam.c as follows to enable 640x480@30fps mode. >> > >> > diff --git a/drivers/usb/gadget/legacy/webcam.c b/drivers/usb/gadget/legacy/webcam.c >> > index 72c976b..9eb315f 100644 >> > --- a/drivers/usb/gadget/legacy/webcam.c >> > +++ b/drivers/usb/gadget/legacy/webcam.c >> > @@ -191,15 +191,15 @@ static const struct UVC_FRAME_UNCOMPRESSED(3) uvc_frame_yuv_360p = { >> > .bFrameIndex = 1, >> > .bmCapabilities = 0, >> > .wWidth = cpu_to_le16(640), >> > - .wHeight = cpu_to_le16(360), >> > + .wHeight = cpu_to_le16(480), >> > .dwMinBitRate = cpu_to_le32(18432000), >> > .dwMaxBitRate = cpu_to_le32(55296000), >> > - .dwMaxVideoFrameBufferSize = cpu_to_le32(460800), >> > - .dwDefaultFrameInterval = cpu_to_le32(666666), >> > + .dwMaxVideoFrameBufferSize = cpu_to_le32(614400), >> > + .dwDefaultFrameInterval = cpu_to_le32(333333), >> > .bFrameIntervalType = 3, >> > - .dwFrameInterval[0] = cpu_to_le32(666666), >> > - .dwFrameInterval[1] = cpu_to_le32(1000000), >> > - .dwFrameInterval[2] = cpu_to_le32(5000000), >> > + .dwFrameInterval[0] = cpu_to_le32(333333), >> > + .dwFrameInterval[1] = cpu_to_le32(666666), >> > + .dwFrameInterval[2] = cpu_to_le32(1000000), >> > }; >> > >> > then loaded g_webcam.ko as >> > >> > # modprobe g_webcam streaming_maxpacket=3072 >> > >> > The endpoint descriptor showing on the host is >> > >> > Endpoint Descriptor: >> > bLength 7 >> > bDescriptorType 5 >> > bEndpointAddress 0x8d EP 13 IN >> > bmAttributes 5 >> > Transfer Type Isochronous >> > Synch Type Asynchronous >> > Usage Type Data >> > wMaxPacketSize 0x1400 3x 1024 bytes >> > bInterval 1 >> > >> > However the usb bus trace shows only one transaction with 1024-bytes packet in >> > every SOF. The host only sends one IN packet in every SOF, I am expecting 2~3 >> > 1024-bytes transactions, since this would be required to transfer 640x480@30fps >> > YUV frames in high-speed. >> > >> > DId I miss anything in the setup? >> >> MUSB or DWC3? This looks like a UDC bug to me. Can you show a screenshot > > Happened on both MUSB and DWC3. > >> of your bus analyzer? When host sends IN token, are you replying with > > The trace screenshot on DWC3 is attached. > >> DATA0, DATA1 or DATA2? > > Good hint! It is DATA0! yeah, should've been DATA2. I'll check if we're missing anything for High Bandwidth Iso on DWC3. Can you confirm if it works of tails on DWC3? On your follow-up mail you mentioned it's a bug in MUSB. What about DWC3? -- balbi [-- Attachment #2: signature.asc --] [-- Type: application/pgp-signature, Size: 800 bytes --] ^ permalink raw reply [flat|nested] 19+ messages in thread
* Re: g_webcam Isoch high bandwidth transfer 2016-09-22 7:37 ` Felipe Balbi @ 2016-09-22 8:08 ` Felipe Balbi 2016-09-22 10:06 ` Felipe Balbi 0 siblings, 1 reply; 19+ messages in thread From: Felipe Balbi @ 2016-09-22 8:08 UTC (permalink / raw) To: Bin Liu; +Cc: linux-usb, linux-media [-- Attachment #1: Type: text/plain, Size: 5383 bytes --] Hi, Felipe Balbi <felipe.balbi@linux.intel.com> writes: > Bin Liu <b-liu@ti.com> writes: >> On Wed, Sep 21, 2016 at 11:01:21AM +0300, Felipe Balbi wrote: >>> >>> Hi, >>> >>> Bin Liu <b-liu@ti.com> writes: >>> > Hi, >>> > >>> > I am trying to check Isoch high bandwidth transfer with g_webcam.ko in >>> > high-speed connection. >>> > >>> > First I hacked webcam.c as follows to enable 640x480@30fps mode. >>> > >>> > diff --git a/drivers/usb/gadget/legacy/webcam.c b/drivers/usb/gadget/legacy/webcam.c >>> > index 72c976b..9eb315f 100644 >>> > --- a/drivers/usb/gadget/legacy/webcam.c >>> > +++ b/drivers/usb/gadget/legacy/webcam.c >>> > @@ -191,15 +191,15 @@ static const struct UVC_FRAME_UNCOMPRESSED(3) uvc_frame_yuv_360p = { >>> > .bFrameIndex = 1, >>> > .bmCapabilities = 0, >>> > .wWidth = cpu_to_le16(640), >>> > - .wHeight = cpu_to_le16(360), >>> > + .wHeight = cpu_to_le16(480), >>> > .dwMinBitRate = cpu_to_le32(18432000), >>> > .dwMaxBitRate = cpu_to_le32(55296000), >>> > - .dwMaxVideoFrameBufferSize = cpu_to_le32(460800), >>> > - .dwDefaultFrameInterval = cpu_to_le32(666666), >>> > + .dwMaxVideoFrameBufferSize = cpu_to_le32(614400), >>> > + .dwDefaultFrameInterval = cpu_to_le32(333333), >>> > .bFrameIntervalType = 3, >>> > - .dwFrameInterval[0] = cpu_to_le32(666666), >>> > - .dwFrameInterval[1] = cpu_to_le32(1000000), >>> > - .dwFrameInterval[2] = cpu_to_le32(5000000), >>> > + .dwFrameInterval[0] = cpu_to_le32(333333), >>> > + .dwFrameInterval[1] = cpu_to_le32(666666), >>> > + .dwFrameInterval[2] = cpu_to_le32(1000000), >>> > }; >>> > >>> > then loaded g_webcam.ko as >>> > >>> > # modprobe g_webcam streaming_maxpacket=3072 >>> > >>> > The endpoint descriptor showing on the host is >>> > >>> > Endpoint Descriptor: >>> > bLength 7 >>> > bDescriptorType 5 >>> > bEndpointAddress 0x8d EP 13 IN >>> > bmAttributes 5 >>> > Transfer Type Isochronous >>> > Synch Type Asynchronous >>> > Usage Type Data >>> > wMaxPacketSize 0x1400 3x 1024 bytes >>> > bInterval 1 >>> > >>> > However the usb bus trace shows only one transaction with 1024-bytes packet in >>> > every SOF. The host only sends one IN packet in every SOF, I am expecting 2~3 >>> > 1024-bytes transactions, since this would be required to transfer 640x480@30fps >>> > YUV frames in high-speed. >>> > >>> > DId I miss anything in the setup? >>> >>> MUSB or DWC3? This looks like a UDC bug to me. Can you show a screenshot >> >> Happened on both MUSB and DWC3. >> >>> of your bus analyzer? When host sends IN token, are you replying with >> >> The trace screenshot on DWC3 is attached. >> >>> DATA0, DATA1 or DATA2? >> >> Good hint! It is DATA0! > > yeah, should've been DATA2. I'll check if we're missing anything for > High Bandwidth Iso on DWC3. Can you confirm if it works of tails on > DWC3? On your follow-up mail you mentioned it's a bug in MUSB. What > about DWC3? I'm assuming DWC3 really breaks. Here's a patch for that: 8<---------------------------------- cut here ---------------------------------- From 62807011c00055785575bb39d92bfe8836817e2f Mon Sep 17 00:00:00 2001 From: Felipe Balbi <felipe.balbi@linux.intel.com> Date: Thu, 22 Sep 2016 11:01:01 +0300 Subject: [PATCH] usb: dwc3: gadget: set PCM1 field of isochronous-first TRBs In case of High-Speed, High-Bandwidth endpoints, we need to tell DWC3 that we have more than one packet per interval. We do that by setting PCM1 field of Isochronous-First TRB. Signed-off-by: Felipe Balbi <felipe.balbi@linux.intel.com> --- drivers/usb/dwc3/gadget.c | 14 ++++++++++++-- 1 file changed, 12 insertions(+), 2 deletions(-) diff --git a/drivers/usb/dwc3/gadget.c b/drivers/usb/dwc3/gadget.c index 602f12254161..106623faf060 100644 --- a/drivers/usb/dwc3/gadget.c +++ b/drivers/usb/dwc3/gadget.c @@ -787,6 +787,9 @@ static void dwc3_prepare_one_trb(struct dwc3_ep *dep, unsigned length, unsigned chain, unsigned node) { struct dwc3_trb *trb; + struct dwc3 *dwc = dep->dwc; + struct usb_gadget *gadget = &dwc->gadget; + enum usb_device_speed speed = speed; dwc3_trace(trace_dwc3_gadget, "%s: req %p dma %08llx length %d%s", dep->name, req, (unsigned long long) dma, @@ -813,10 +816,17 @@ static void dwc3_prepare_one_trb(struct dwc3_ep *dep, break; case USB_ENDPOINT_XFER_ISOC: - if (!node) + if (!node) { trb->ctrl = DWC3_TRBCTL_ISOCHRONOUS_FIRST; - else + + if (speed == USB_SPEED_HIGH) { + struct usb_endpoint *ep = &dep->endpoint; + u8 pkts = DIV_ROUNDUP(ep->maxpacket, 1024); + trb->size |= DWC3_TRB_SIZE_PCM1(pkts - 1); + } + } else { trb->ctrl = DWC3_TRBCTL_ISOCHRONOUS; + } /* always enable Interrupt on Missed ISOC */ trb->ctrl |= DWC3_TRB_CTRL_ISP_IMI; -- 2.10.0 Let me know if this helps DWC3, also, let me know how you're using g_webcam, I'd like to test that out on my side too ;-) -- balbi [-- Attachment #2: signature.asc --] [-- Type: application/pgp-signature, Size: 800 bytes --] ^ permalink raw reply related [flat|nested] 19+ messages in thread
* Re: g_webcam Isoch high bandwidth transfer 2016-09-22 8:08 ` Felipe Balbi @ 2016-09-22 10:06 ` Felipe Balbi 2016-09-22 13:33 ` Bin Liu 0 siblings, 1 reply; 19+ messages in thread From: Felipe Balbi @ 2016-09-22 10:06 UTC (permalink / raw) To: Bin Liu; +Cc: linux-usb, linux-media [-- Attachment #1: Type: text/plain, Size: 6679 bytes --] Hi, Felipe Balbi <felipe.balbi@linux.intel.com> writes: > Felipe Balbi <felipe.balbi@linux.intel.com> writes: >> Bin Liu <b-liu@ti.com> writes: >>> On Wed, Sep 21, 2016 at 11:01:21AM +0300, Felipe Balbi wrote: >>>> >>>> Hi, >>>> >>>> Bin Liu <b-liu@ti.com> writes: >>>> > Hi, >>>> > >>>> > I am trying to check Isoch high bandwidth transfer with g_webcam.ko in >>>> > high-speed connection. >>>> > >>>> > First I hacked webcam.c as follows to enable 640x480@30fps mode. >>>> > >>>> > diff --git a/drivers/usb/gadget/legacy/webcam.c b/drivers/usb/gadget/legacy/webcam.c >>>> > index 72c976b..9eb315f 100644 >>>> > --- a/drivers/usb/gadget/legacy/webcam.c >>>> > +++ b/drivers/usb/gadget/legacy/webcam.c >>>> > @@ -191,15 +191,15 @@ static const struct UVC_FRAME_UNCOMPRESSED(3) uvc_frame_yuv_360p = { >>>> > .bFrameIndex = 1, >>>> > .bmCapabilities = 0, >>>> > .wWidth = cpu_to_le16(640), >>>> > - .wHeight = cpu_to_le16(360), >>>> > + .wHeight = cpu_to_le16(480), >>>> > .dwMinBitRate = cpu_to_le32(18432000), >>>> > .dwMaxBitRate = cpu_to_le32(55296000), >>>> > - .dwMaxVideoFrameBufferSize = cpu_to_le32(460800), >>>> > - .dwDefaultFrameInterval = cpu_to_le32(666666), >>>> > + .dwMaxVideoFrameBufferSize = cpu_to_le32(614400), >>>> > + .dwDefaultFrameInterval = cpu_to_le32(333333), >>>> > .bFrameIntervalType = 3, >>>> > - .dwFrameInterval[0] = cpu_to_le32(666666), >>>> > - .dwFrameInterval[1] = cpu_to_le32(1000000), >>>> > - .dwFrameInterval[2] = cpu_to_le32(5000000), >>>> > + .dwFrameInterval[0] = cpu_to_le32(333333), >>>> > + .dwFrameInterval[1] = cpu_to_le32(666666), >>>> > + .dwFrameInterval[2] = cpu_to_le32(1000000), >>>> > }; >>>> > >>>> > then loaded g_webcam.ko as >>>> > >>>> > # modprobe g_webcam streaming_maxpacket=3072 >>>> > >>>> > The endpoint descriptor showing on the host is >>>> > >>>> > Endpoint Descriptor: >>>> > bLength 7 >>>> > bDescriptorType 5 >>>> > bEndpointAddress 0x8d EP 13 IN >>>> > bmAttributes 5 >>>> > Transfer Type Isochronous >>>> > Synch Type Asynchronous >>>> > Usage Type Data >>>> > wMaxPacketSize 0x1400 3x 1024 bytes >>>> > bInterval 1 >>>> > >>>> > However the usb bus trace shows only one transaction with 1024-bytes packet in >>>> > every SOF. The host only sends one IN packet in every SOF, I am expecting 2~3 >>>> > 1024-bytes transactions, since this would be required to transfer 640x480@30fps >>>> > YUV frames in high-speed. >>>> > >>>> > DId I miss anything in the setup? >>>> >>>> MUSB or DWC3? This looks like a UDC bug to me. Can you show a screenshot >>> >>> Happened on both MUSB and DWC3. >>> >>>> of your bus analyzer? When host sends IN token, are you replying with >>> >>> The trace screenshot on DWC3 is attached. >>> >>>> DATA0, DATA1 or DATA2? >>> >>> Good hint! It is DATA0! >> >> yeah, should've been DATA2. I'll check if we're missing anything for >> High Bandwidth Iso on DWC3. Can you confirm if it works of tails on >> DWC3? On your follow-up mail you mentioned it's a bug in MUSB. What >> about DWC3? > > I'm assuming DWC3 really breaks. Here's a patch for that: > > 8<---------------------------------- cut here ---------------------------------- > From 62807011c00055785575bb39d92bfe8836817e2f Mon Sep 17 00:00:00 2001 > From: Felipe Balbi <felipe.balbi@linux.intel.com> > Date: Thu, 22 Sep 2016 11:01:01 +0300 > Subject: [PATCH] usb: dwc3: gadget: set PCM1 field of isochronous-first TRBs > > In case of High-Speed, High-Bandwidth endpoints, we > need to tell DWC3 that we have more than one packet > per interval. We do that by setting PCM1 field of > Isochronous-First TRB. > > Signed-off-by: Felipe Balbi <felipe.balbi@linux.intel.com> > --- > drivers/usb/dwc3/gadget.c | 14 ++++++++++++-- > 1 file changed, 12 insertions(+), 2 deletions(-) > > diff --git a/drivers/usb/dwc3/gadget.c b/drivers/usb/dwc3/gadget.c > index 602f12254161..106623faf060 100644 > --- a/drivers/usb/dwc3/gadget.c > +++ b/drivers/usb/dwc3/gadget.c > @@ -787,6 +787,9 @@ static void dwc3_prepare_one_trb(struct dwc3_ep *dep, > unsigned length, unsigned chain, unsigned node) > { > struct dwc3_trb *trb; > + struct dwc3 *dwc = dep->dwc; > + struct usb_gadget *gadget = &dwc->gadget; > + enum usb_device_speed speed = speed; and of course I sent the wrong version :-) Here's one that actually compiles, sorry about that. 8<---------------------------------- cut here ---------------------------------- From 44282f6c664b17e6b9dffbc31e72258be84823a4 Mon Sep 17 00:00:00 2001 From: Felipe Balbi <felipe.balbi@linux.intel.com> Date: Thu, 22 Sep 2016 11:01:01 +0300 Subject: [PATCH] usb: dwc3: gadget: set PCM1 field of isochronous-first TRBs In case of High-Speed, High-Bandwidth endpoints, we need to tell DWC3 that we have more than one packet per interval. We do that by setting PCM1 field of Isochronous-First TRB. Signed-off-by: Felipe Balbi <felipe.balbi@linux.intel.com> --- drivers/usb/dwc3/gadget.c | 14 ++++++++++++-- 1 file changed, 12 insertions(+), 2 deletions(-) diff --git a/drivers/usb/dwc3/gadget.c b/drivers/usb/dwc3/gadget.c index 602f12254161..34a7b1bf0522 100644 --- a/drivers/usb/dwc3/gadget.c +++ b/drivers/usb/dwc3/gadget.c @@ -787,6 +787,9 @@ static void dwc3_prepare_one_trb(struct dwc3_ep *dep, unsigned length, unsigned chain, unsigned node) { struct dwc3_trb *trb; + struct dwc3 *dwc = dep->dwc; + struct usb_gadget *gadget = &dwc->gadget; + enum usb_device_speed speed = gadget->speed; dwc3_trace(trace_dwc3_gadget, "%s: req %p dma %08llx length %d%s", dep->name, req, (unsigned long long) dma, @@ -813,10 +816,17 @@ static void dwc3_prepare_one_trb(struct dwc3_ep *dep, break; case USB_ENDPOINT_XFER_ISOC: - if (!node) + if (!node) { trb->ctrl = DWC3_TRBCTL_ISOCHRONOUS_FIRST; - else + + if (speed == USB_SPEED_HIGH) { + struct usb_ep *ep = &dep->endpoint; + u8 pkts = DIV_ROUND_UP(ep->maxpacket, 1024); + trb->size |= DWC3_TRB_SIZE_PCM1(pkts - 1); + } + } else { trb->ctrl = DWC3_TRBCTL_ISOCHRONOUS; + } /* always enable Interrupt on Missed ISOC */ trb->ctrl |= DWC3_TRB_CTRL_ISP_IMI; -- 2.10.0 -- balbi [-- Attachment #2: signature.asc --] [-- Type: application/pgp-signature, Size: 800 bytes --] ^ permalink raw reply related [flat|nested] 19+ messages in thread
* Re: g_webcam Isoch high bandwidth transfer 2016-09-22 10:06 ` Felipe Balbi @ 2016-09-22 13:33 ` Bin Liu 2016-09-22 19:48 ` Felipe Balbi 0 siblings, 1 reply; 19+ messages in thread From: Bin Liu @ 2016-09-22 13:33 UTC (permalink / raw) To: Felipe Balbi; +Cc: linux-usb, linux-media On Thu, Sep 22, 2016 at 01:06:46PM +0300, Felipe Balbi wrote: > > Hi, > > Felipe Balbi <felipe.balbi@linux.intel.com> writes: > > Felipe Balbi <felipe.balbi@linux.intel.com> writes: > >> Bin Liu <b-liu@ti.com> writes: > >>> On Wed, Sep 21, 2016 at 11:01:21AM +0300, Felipe Balbi wrote: > >>>> > >>>> Hi, > >>>> > >>>> Bin Liu <b-liu@ti.com> writes: > >>>> > Hi, > >>>> > > >>>> > I am trying to check Isoch high bandwidth transfer with g_webcam.ko in > >>>> > high-speed connection. > >>>> > > >>>> > First I hacked webcam.c as follows to enable 640x480@30fps mode. > >>>> > > >>>> > diff --git a/drivers/usb/gadget/legacy/webcam.c b/drivers/usb/gadget/legacy/webcam.c > >>>> > index 72c976b..9eb315f 100644 > >>>> > --- a/drivers/usb/gadget/legacy/webcam.c > >>>> > +++ b/drivers/usb/gadget/legacy/webcam.c > >>>> > @@ -191,15 +191,15 @@ static const struct UVC_FRAME_UNCOMPRESSED(3) uvc_frame_yuv_360p = { > >>>> > .bFrameIndex = 1, > >>>> > .bmCapabilities = 0, > >>>> > .wWidth = cpu_to_le16(640), > >>>> > - .wHeight = cpu_to_le16(360), > >>>> > + .wHeight = cpu_to_le16(480), > >>>> > .dwMinBitRate = cpu_to_le32(18432000), > >>>> > .dwMaxBitRate = cpu_to_le32(55296000), > >>>> > - .dwMaxVideoFrameBufferSize = cpu_to_le32(460800), > >>>> > - .dwDefaultFrameInterval = cpu_to_le32(666666), > >>>> > + .dwMaxVideoFrameBufferSize = cpu_to_le32(614400), > >>>> > + .dwDefaultFrameInterval = cpu_to_le32(333333), > >>>> > .bFrameIntervalType = 3, > >>>> > - .dwFrameInterval[0] = cpu_to_le32(666666), > >>>> > - .dwFrameInterval[1] = cpu_to_le32(1000000), > >>>> > - .dwFrameInterval[2] = cpu_to_le32(5000000), > >>>> > + .dwFrameInterval[0] = cpu_to_le32(333333), > >>>> > + .dwFrameInterval[1] = cpu_to_le32(666666), > >>>> > + .dwFrameInterval[2] = cpu_to_le32(1000000), > >>>> > }; > >>>> > > >>>> > then loaded g_webcam.ko as > >>>> > > >>>> > # modprobe g_webcam streaming_maxpacket=3072 > >>>> > > >>>> > The endpoint descriptor showing on the host is > >>>> > > >>>> > Endpoint Descriptor: > >>>> > bLength 7 > >>>> > bDescriptorType 5 > >>>> > bEndpointAddress 0x8d EP 13 IN > >>>> > bmAttributes 5 > >>>> > Transfer Type Isochronous > >>>> > Synch Type Asynchronous > >>>> > Usage Type Data > >>>> > wMaxPacketSize 0x1400 3x 1024 bytes > >>>> > bInterval 1 > >>>> > > >>>> > However the usb bus trace shows only one transaction with 1024-bytes packet in > >>>> > every SOF. The host only sends one IN packet in every SOF, I am expecting 2~3 > >>>> > 1024-bytes transactions, since this would be required to transfer 640x480@30fps > >>>> > YUV frames in high-speed. > >>>> > > >>>> > DId I miss anything in the setup? > >>>> > >>>> MUSB or DWC3? This looks like a UDC bug to me. Can you show a screenshot > >>> > >>> Happened on both MUSB and DWC3. > >>> > >>>> of your bus analyzer? When host sends IN token, are you replying with > >>> > >>> The trace screenshot on DWC3 is attached. > >>> > >>>> DATA0, DATA1 or DATA2? > >>> > >>> Good hint! It is DATA0! > >> > >> yeah, should've been DATA2. I'll check if we're missing anything for > >> High Bandwidth Iso on DWC3. Can you confirm if it works of tails on > >> DWC3? On your follow-up mail you mentioned it's a bug in MUSB. What > >> about DWC3? > > > > I'm assuming DWC3 really breaks. Here's a patch for that: > > > > 8<---------------------------------- cut here ---------------------------------- > > From 62807011c00055785575bb39d92bfe8836817e2f Mon Sep 17 00:00:00 2001 > > From: Felipe Balbi <felipe.balbi@linux.intel.com> > > Date: Thu, 22 Sep 2016 11:01:01 +0300 > > Subject: [PATCH] usb: dwc3: gadget: set PCM1 field of isochronous-first TRBs > > > > In case of High-Speed, High-Bandwidth endpoints, we > > need to tell DWC3 that we have more than one packet > > per interval. We do that by setting PCM1 field of > > Isochronous-First TRB. > > > > Signed-off-by: Felipe Balbi <felipe.balbi@linux.intel.com> > > --- > > drivers/usb/dwc3/gadget.c | 14 ++++++++++++-- > > 1 file changed, 12 insertions(+), 2 deletions(-) > > > > diff --git a/drivers/usb/dwc3/gadget.c b/drivers/usb/dwc3/gadget.c > > index 602f12254161..106623faf060 100644 > > --- a/drivers/usb/dwc3/gadget.c > > +++ b/drivers/usb/dwc3/gadget.c > > @@ -787,6 +787,9 @@ static void dwc3_prepare_one_trb(struct dwc3_ep *dep, > > unsigned length, unsigned chain, unsigned node) > > { > > struct dwc3_trb *trb; > > + struct dwc3 *dwc = dep->dwc; > > + struct usb_gadget *gadget = &dwc->gadget; > > + enum usb_device_speed speed = speed; > > and of course I sent the wrong version :-) > > Here's one that actually compiles, sorry about that. No worries, I was sleeping ;-) I will test it out early next week. Thanks. Regards, -Bin. > > 8<---------------------------------- cut here ---------------------------------- > From 44282f6c664b17e6b9dffbc31e72258be84823a4 Mon Sep 17 00:00:00 2001 > From: Felipe Balbi <felipe.balbi@linux.intel.com> > Date: Thu, 22 Sep 2016 11:01:01 +0300 > Subject: [PATCH] usb: dwc3: gadget: set PCM1 field of isochronous-first TRBs > > In case of High-Speed, High-Bandwidth endpoints, we > need to tell DWC3 that we have more than one packet > per interval. We do that by setting PCM1 field of > Isochronous-First TRB. > > Signed-off-by: Felipe Balbi <felipe.balbi@linux.intel.com> > --- > drivers/usb/dwc3/gadget.c | 14 ++++++++++++-- > 1 file changed, 12 insertions(+), 2 deletions(-) > > diff --git a/drivers/usb/dwc3/gadget.c b/drivers/usb/dwc3/gadget.c > index 602f12254161..34a7b1bf0522 100644 > --- a/drivers/usb/dwc3/gadget.c > +++ b/drivers/usb/dwc3/gadget.c > @@ -787,6 +787,9 @@ static void dwc3_prepare_one_trb(struct dwc3_ep *dep, > unsigned length, unsigned chain, unsigned node) > { > struct dwc3_trb *trb; > + struct dwc3 *dwc = dep->dwc; > + struct usb_gadget *gadget = &dwc->gadget; > + enum usb_device_speed speed = gadget->speed; > > dwc3_trace(trace_dwc3_gadget, "%s: req %p dma %08llx length %d%s", > dep->name, req, (unsigned long long) dma, > @@ -813,10 +816,17 @@ static void dwc3_prepare_one_trb(struct dwc3_ep *dep, > break; > > case USB_ENDPOINT_XFER_ISOC: > - if (!node) > + if (!node) { > trb->ctrl = DWC3_TRBCTL_ISOCHRONOUS_FIRST; > - else > + > + if (speed == USB_SPEED_HIGH) { > + struct usb_ep *ep = &dep->endpoint; > + u8 pkts = DIV_ROUND_UP(ep->maxpacket, 1024); > + trb->size |= DWC3_TRB_SIZE_PCM1(pkts - 1); > + } > + } else { > trb->ctrl = DWC3_TRBCTL_ISOCHRONOUS; > + } > > /* always enable Interrupt on Missed ISOC */ > trb->ctrl |= DWC3_TRB_CTRL_ISP_IMI; > -- > 2.10.0 > > > > -- > balbi ^ permalink raw reply [flat|nested] 19+ messages in thread
* Re: g_webcam Isoch high bandwidth transfer 2016-09-22 13:33 ` Bin Liu @ 2016-09-22 19:48 ` Felipe Balbi 2016-09-22 20:11 ` Bin Liu 0 siblings, 1 reply; 19+ messages in thread From: Felipe Balbi @ 2016-09-22 19:48 UTC (permalink / raw) To: Bin Liu; +Cc: linux-usb, linux-media Hi, Bin Liu <b-liu@ti.com> writes: [...] >> Here's one that actually compiles, sorry about that. > > No worries, I was sleeping ;-) > > I will test it out early next week. Thanks. meanwhile, how about some instructions on how to test this out myself? How are you using g_webcam and what are you running on host side? Got a nice list of commands there I can use? I think I can get to bottom of this much quicker if I can reproduce it locally ;-) -- balbi ^ permalink raw reply [flat|nested] 19+ messages in thread
* Re: g_webcam Isoch high bandwidth transfer 2016-09-22 19:48 ` Felipe Balbi @ 2016-09-22 20:11 ` Bin Liu 2016-09-23 0:23 ` yfw 2016-09-23 7:49 ` Felipe Balbi 0 siblings, 2 replies; 19+ messages in thread From: Bin Liu @ 2016-09-22 20:11 UTC (permalink / raw) To: Felipe Balbi; +Cc: linux-usb, linux-media, nh26223 +Fengwei Yin per his request. On Thu, Sep 22, 2016 at 10:48:40PM +0300, Felipe Balbi wrote: > > Hi, > > Bin Liu <b-liu@ti.com> writes: > > [...] > > >> Here's one that actually compiles, sorry about that. > > > > No worries, I was sleeping ;-) > > > > I will test it out early next week. Thanks. > > meanwhile, how about some instructions on how to test this out myself? > How are you using g_webcam and what are you running on host side? Got a > nice list of commands there I can use? I think I can get to bottom of > this much quicker if I can reproduce it locally ;-) On device side: - first patch g_webcam as in my first email in this thread to enable 640x480@30fps; - # modprobe g_webcam streaming_maxpacket=3072 - then run uvc-gadget to feed the YUV frames; http://git.ideasonboard.org/uvc-gadget.git On host side: - first check the device ep descriptor, which should be wMaxPacketSize 0x1400 3x 1024 bytes - then use luvcview or yavta to capture the video stream Capture the bus trace to check if multiple IN transactions happens in each SOF. The data buffer size in the usb_request coming from the uvc driver is 5120 bytes, so there should be 3 IN transactions if the UDC works correctly. Regards, -Bin. ^ permalink raw reply [flat|nested] 19+ messages in thread
* Re: g_webcam Isoch high bandwidth transfer 2016-09-22 20:11 ` Bin Liu @ 2016-09-23 0:23 ` yfw 2016-09-23 7:49 ` Felipe Balbi 1 sibling, 0 replies; 19+ messages in thread From: yfw @ 2016-09-23 0:23 UTC (permalink / raw) To: Bin Liu, Felipe Balbi, linux-usb, linux-media Hi Bin, On 2016/9/23 4:11, Bin Liu wrote: > +Fengwei Yin per his request. Thanks a lot for adding me to this thread. > > On Thu, Sep 22, 2016 at 10:48:40PM +0300, Felipe Balbi wrote: >> >> Hi, >> >> Bin Liu <b-liu@ti.com> writes: >> >> [...] >> >>>> Here's one that actually compiles, sorry about that. >>> >>> No worries, I was sleeping ;-) >>> >>> I will test it out early next week. Thanks. >> >> meanwhile, how about some instructions on how to test this out myself? >> How are you using g_webcam and what are you running on host side? Got a >> nice list of commands there I can use? I think I can get to bottom of >> this much quicker if I can reproduce it locally ;-) I am using similar use case with a different gadget function driver. > > On device side: > - first patch g_webcam as in my first email in this thread to enable > 640x480@30fps; > - # modprobe g_webcam streaming_maxpacket=3072 > - then run uvc-gadget to feed the YUV frames; > http://git.ideasonboard.org/uvc-gadget.git - I am using uvc function driver + configfs. - maxpacket in configfs was set to 3072. - uvc-gadget from the same source as Bin. > > On host side: > - first check the device ep descriptor, which should be > wMaxPacketSize 0x1400 3x 1024 bytes > - then use luvcview or yavta to capture the video stream - lsusb give me same wMaxPacketSize. - I am using example (changed a little bit) from libuvc. Regards Yin, Fengwei > > Capture the bus trace to check if multiple IN transactions happens in > each SOF. > > The data buffer size in the usb_request coming from the uvc driver is > 5120 bytes, so there should be 3 IN transactions if the UDC works > correctly. > > Regards, > -Bin. > ^ permalink raw reply [flat|nested] 19+ messages in thread
* Re: g_webcam Isoch high bandwidth transfer 2016-09-22 20:11 ` Bin Liu 2016-09-23 0:23 ` yfw @ 2016-09-23 7:49 ` Felipe Balbi 2016-09-23 8:10 ` yfw ` (2 more replies) 1 sibling, 3 replies; 19+ messages in thread From: Felipe Balbi @ 2016-09-23 7:49 UTC (permalink / raw) To: Bin Liu; +Cc: linux-usb, linux-media, nh26223, laurent.pinchart [-- Attachment #1: Type: text/plain, Size: 61003 bytes --] Hi, Bin Liu <b-liu@ti.com> writes: > +Fengwei Yin per his request. > > On Thu, Sep 22, 2016 at 10:48:40PM +0300, Felipe Balbi wrote: >> >> Hi, >> >> Bin Liu <b-liu@ti.com> writes: >> >> [...] >> >> >> Here's one that actually compiles, sorry about that. >> > >> > No worries, I was sleeping ;-) >> > >> > I will test it out early next week. Thanks. >> >> meanwhile, how about some instructions on how to test this out myself? >> How are you using g_webcam and what are you running on host side? Got a >> nice list of commands there I can use? I think I can get to bottom of >> this much quicker if I can reproduce it locally ;-) > > On device side: > - first patch g_webcam as in my first email in this thread to enable > 640x480@30fps; > - # modprobe g_webcam streaming_maxpacket=3072 > - then run uvc-gadget to feed the YUV frames; > http://git.ideasonboard.org/uvc-gadget.git as is, g_webcam never enumerates to the host. It's calls to usb_function_active() and usb_function_deactivate() are unbalanced. Do you have any other changes to g_webcam? Also, uvc-gadget.git doesn't compile, had to modify it a bit: -#include "../drivers/usb/gadget/uvc.h" +#include "../drivers/usb/gadget/function/uvc.h" Also fixed a build warning: @@ -732,6 +732,8 @@ int main(int argc, char *argv[]) fd_set wfds = fds; ret = select(dev->fd + 1, NULL, &wfds, &efds, NULL); + if (ret < 0) + return ret; if (FD_ISSET(dev->fd, &efds)) uvc_events_process(dev); if (FD_ISSET(dev->fd, &wfds)) Laurent, have you tested g_webcam recently? What's the magic to get it working? Here's what I get out of dmesg: [ 58.568380] usb 1-9: new high-speed USB device number 5 using xhci_hcd [ 58.738680] usb 1-9: New USB device found, idVendor=1d6b, idProduct=0102 [ 58.738683] usb 1-9: New USB device strings: Mfr=1, Product=2, SerialNumber=0 [ 58.738685] usb 1-9: Product: Webcam gadget [ 58.738687] usb 1-9: Manufacturer: Linux Foundation [ 58.739133] g_webcam gadget: high-speed config #1: Video [ 58.739138] g_webcam gadget: uvc_function_set_alt(0, 0) [ 58.739139] g_webcam gadget: reset UVC Control [ 58.739149] g_webcam gadget: uvc_function_set_alt(1, 0) [ 58.804369] uvcvideo: Found UVC 1.00 device Webcam gadget (1d6b:0102) [ 58.804479] g_webcam gadget: uvc_function_set_alt(1, 0) [ 64.188459] uvcvideo: UVC non compliance - GET_DEF(PROBE) not supported. Enabling workaround. [ 69.307458] uvcvideo: Failed to query (129) UVC probe control : -110 (exp. 26). [ 69.307459] uvcvideo: Failed to initialize the device (-5). [ 69.307505] usbcore: registered new interface driver uvcvideo [ 69.307506] USB Video Class driver (1.1.1) [ 146.646012] ------------[ cut here ]------------ [ 146.646023] WARNING: CPU: 0 PID: 2616 at drivers/usb/gadget/composite.c:371 usb_function_activate+0x77/0x80 [libcomposite] [ 146.646024] Modules linked in: uvcvideo g_webcam usb_f_uvc videobuf2_vmalloc videobuf2_memops videobuf2_v4l2 videobuf2_core videodev libcomposite kvm_intel kvm psmouse e1000e input_leds hid_generic usbhid atkbd irqbypass evdev [ 146.646054] CPU: 0 PID: 2616 Comm: gst-launch-1.0 Not tainted 4.8.0-rc7-next-20160922-00004-gc71031593917-dirty #20 [ 146.646055] Hardware name: Intel Corporation Skylake Client platform/Skylake Y LPDDR3 RVP3, BIOS SKLSE2R1.R00.B097.B02.1509020030 09/02/2015 [ 146.646058] ffffc9000769bb70 [ 146.646059] ffffffff8132d415 [ 146.646060] 0000000000000000 [ 146.646061] 0000000000000000 [ 146.646063] ffffc9000769bbb0 [ 146.646063] ffffffff8105ec1b [ 146.646064] 000001730769bb90 [ 146.646066] 00000000ffffffea [ 146.646070] ffff88016c03a150 [ 146.646072] 0000000000000282 ffff88016d793000 ffffc9000769befc [ 146.646077] Call Trace: [ 146.646086] [<ffffffff8132d415>] dump_stack+0x68/0x93 [ 146.646090] [<ffffffff8105ec1b>] __warn+0xcb/0xf0 [ 146.646095] [<ffffffff8105ed0d>] warn_slowpath_null+0x1d/0x20 [ 146.646099] [<ffffffffa03f1ea7>] usb_function_activate+0x77/0x80 [libcomposite] [ 146.646105] [<ffffffffa044a6de>] uvc_function_connect+0x1e/0x40 [usb_f_uvc] [ 146.646110] [<ffffffffa044b2ae>] uvc_v4l2_open+0x6e/0x80 [usb_f_uvc] [ 146.646116] [<ffffffffa04014f0>] v4l2_open+0xa0/0x100 [videodev] [ 146.646121] [<ffffffff811a5431>] chrdev_open+0xa1/0x1d0 [ 146.646125] [<ffffffff811a5390>] ? cdev_put+0x30/0x30 [ 146.646129] [<ffffffff8119dd60>] do_dentry_open.isra.17+0x150/0x2e0 [ 146.646133] [<ffffffff8119f115>] vfs_open+0x45/0x60 [ 146.646137] [<ffffffff811af1ed>] path_openat+0x62d/0x1370 [ 146.646141] [<ffffffff811b0094>] ? putname+0x54/0x60 [ 146.646146] [<ffffffff811b10ce>] do_filp_open+0x7e/0xe0 [ 146.646150] [<ffffffff81083868>] ? preempt_count_sub+0x48/0x70 [ 146.646154] [<ffffffff816f07d6>] ? _raw_spin_unlock+0x16/0x30 [ 146.646160] [<ffffffff811bf009>] ? __alloc_fd+0xc9/0x180 [ 146.646164] [<ffffffff8119f4e3>] do_sys_open+0x123/0x200 [ 146.646170] [<ffffffff8119f5de>] SyS_open+0x1e/0x20 [ 146.646174] [<ffffffff816f0e2a>] entry_SYSCALL_64_fastpath+0x18/0xa8 [ 146.646177] ---[ end trace 1a4f7b9817d19b04 ]--- [ 146.646180] g_webcam gadget: UVC connect failed with -22 [ 146.653808] usb 1-9: USB disconnect, device number 5 [ 146.653986] g_webcam gadget: UVC disconnect failed with -110 And dwc3 trace: # tracer: nop # # entries-in-buffer/entries-written: 445/445 #P:4 # # _-----=> irqs-off # / _----=> need-resched # | / _---=> hardirq/softirq # || / _--=> preempt-depth # ||| / delay # TASK-PID CPU# |||| TIMESTAMP FUNCTION # | | | |||| | | modprobe-2560 [001] .... 35.602546: dwc3_alloc_request: ep0out: req ffff88016c03ad80 length 0/0 zsI ==> 0 modprobe-2560 [001] .... 35.602566: dwc3_alloc_request: ep0out: req ffff88016c03acc0 length 0/0 zsI ==> 0 modprobe-2560 [001] d..1 35.602725: dwc3_gadget: Enabling ep0out modprobe-2560 [001] d..1 35.602730: dwc3_gadget_ep_cmd: ep0out: cmd 'Start New Configuration' [1033] params 00000000 00000000 00000000 --> status: Successful modprobe-2560 [001] d..1 35.602829: dwc3_gadget_ep_cmd: ep0out: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful modprobe-2560 [001] d..1 35.602920: dwc3_gadget_ep_cmd: ep0in: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful modprobe-2560 [001] d..1 35.603012: dwc3_gadget_ep_cmd: ep1out: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful modprobe-2560 [001] d..1 35.603104: dwc3_gadget_ep_cmd: ep1in: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful modprobe-2560 [001] d..1 35.603195: dwc3_gadget_ep_cmd: ep2out: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful modprobe-2560 [001] d..1 35.603286: dwc3_gadget_ep_cmd: ep2in: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful modprobe-2560 [001] d..1 35.603378: dwc3_gadget_ep_cmd: ep3out: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful modprobe-2560 [001] d..1 35.603470: dwc3_gadget_ep_cmd: ep3in: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful modprobe-2560 [001] d..1 35.603561: dwc3_gadget_ep_cmd: ep4out: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful modprobe-2560 [001] d..1 35.603652: dwc3_gadget_ep_cmd: ep4in: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful modprobe-2560 [001] d..1 35.603744: dwc3_gadget_ep_cmd: ep5out: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful modprobe-2560 [001] d..1 35.603836: dwc3_gadget_ep_cmd: ep5in: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful modprobe-2560 [001] d..1 35.603927: dwc3_gadget_ep_cmd: ep6out: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful modprobe-2560 [001] d..1 35.604018: dwc3_gadget_ep_cmd: ep6in: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful modprobe-2560 [001] d..1 35.604110: dwc3_gadget_ep_cmd: ep7out: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful modprobe-2560 [001] d..1 35.604202: dwc3_gadget_ep_cmd: ep7in: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful modprobe-2560 [001] d..1 35.604294: dwc3_gadget_ep_cmd: ep8out: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful modprobe-2560 [001] d..1 35.604386: dwc3_gadget_ep_cmd: ep8in: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful modprobe-2560 [001] d..1 35.604477: dwc3_gadget_ep_cmd: ep9out: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful modprobe-2560 [001] d..1 35.604568: dwc3_gadget_ep_cmd: ep9in: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful modprobe-2560 [001] d..1 35.604660: dwc3_gadget_ep_cmd: ep10out: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful modprobe-2560 [001] d..1 35.604751: dwc3_gadget_ep_cmd: ep10in: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful modprobe-2560 [001] d..1 35.604843: dwc3_gadget_ep_cmd: ep11out: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful modprobe-2560 [001] d..1 35.604934: dwc3_gadget_ep_cmd: ep11in: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful modprobe-2560 [001] d..1 35.605026: dwc3_gadget_ep_cmd: ep12out: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful modprobe-2560 [001] d..1 35.605117: dwc3_gadget_ep_cmd: ep12in: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful modprobe-2560 [001] d..1 35.605209: dwc3_gadget_ep_cmd: ep13out: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful modprobe-2560 [001] d..1 35.605301: dwc3_gadget_ep_cmd: ep13in: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful modprobe-2560 [001] d..1 35.605392: dwc3_gadget_ep_cmd: ep14out: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful modprobe-2560 [001] d..1 35.605483: dwc3_gadget_ep_cmd: ep14in: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful modprobe-2560 [001] d..1 35.605575: dwc3_gadget_ep_cmd: ep15out: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful modprobe-2560 [001] d..1 35.605667: dwc3_gadget_ep_cmd: ep15in: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful modprobe-2560 [001] d..1 35.605941: dwc3_gadget_ep_cmd: ep0out: cmd 'Set Endpoint Configuration' [1025] params 00001000 00000500 00000000 --> status: Successful modprobe-2560 [001] d..1 35.605944: dwc3_gadget: Enabling ep0in modprobe-2560 [001] d..1 35.606216: dwc3_gadget_ep_cmd: ep0in: cmd 'Set Endpoint Configuration' [1025] params 00001000 02000500 00000000 --> status: Successful modprobe-2560 [001] d..1 35.606219: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 8 ctrl 00000c23 (HLcs:SC:setup) modprobe-2560 [001] d..1 35.606222: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful v4l_id-2582 [001] d..2 35.607976: dwc3_gadget: gadget g_webcam data soft-connect v4l_id-2582 [001] d..2 35.608042: dwc3_gadget: gadget g_webcam data soft-disconnect uvc-gadget-2598 [003] d..2 58.206076: dwc3_gadget: gadget g_webcam data soft-connect irq/17-dwc3-2578 [001] d..1 58.412564: dwc3_event: event (00000101): Reset [U0] irq/17-dwc3-2578 [001] d..1 58.469611: dwc3_event: event (00000201): Connection Done [U0] irq/17-dwc3-2578 [001] d..1 58.469622: dwc3_gadget: Enabling ep0out irq/17-dwc3-2578 [001] d..1 58.469626: dwc3_gadget_ep_cmd: ep0out: cmd 'Set Endpoint Configuration' [1025] params 80000200 00000500 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.469628: dwc3_gadget: Enabling ep0in irq/17-dwc3-2578 [001] d..1 58.469632: dwc3_gadget_ep_cmd: ep0in: cmd 'Set Endpoint Configuration' [1025] params 80000200 02000500 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.568509: dwc3_event: event (0000c040): ep0out: Transfer Complete irq/17-dwc3-2578 [001] d..1 58.568512: dwc3_ep0: ep0out: Transfer Complete: state 'Setup Phase' irq/17-dwc3-2578 [001] d..1 58.568513: dwc3_ep0: Setup Phase irq/17-dwc3-2578 [001] d..1 58.568514: dwc3_ctrl_req: bRequestType 80 bRequest 06 wValue 0100 wIndex 0000 wLength 64 irq/17-dwc3-2578 [001] d..1 58.568515: dwc3_ep0: Forwarding to gadget driver irq/17-dwc3-2578 [001] d..1 58.568518: dwc3_ep0: queueing request ffff88016c03ad80 to ep0out length 18 state 'Setup Phase' irq/17-dwc3-2578 [001] d..1 58.568521: dwc3_prepare_trb: ep0in: 0/0 trb ffff880084c02000 buf 000000008025e000 size 18 ctrl 00000c53 (HLcs:SC:data) irq/17-dwc3-2578 [001] d..1 58.568531: dwc3_gadget_ep_cmd: ep0in: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.568534: dwc3_event: event (000010c2): ep0in: Transfer Not Ready (Not Active) irq/17-dwc3-2578 [001] d..1 58.568535: dwc3_ep0: ep0in: Transfer Not Ready (Not Active): state 'Data Phase' irq/17-dwc3-2578 [001] d..1 58.568536: dwc3_ep0: Control Data irq/17-dwc3-2578 [001] d..1 58.568641: dwc3_event: event (0000c042): ep0in: Transfer Complete irq/17-dwc3-2578 [001] d..1 58.568642: dwc3_ep0: ep0in: Transfer Complete: state 'Data Phase' irq/17-dwc3-2578 [001] d..1 58.568642: dwc3_ep0: Data Phase irq/17-dwc3-2578 [001] d..1 58.568643: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 000000008025e000 size 0 ctrl 00000c52 (hLcs:SC:data) irq/17-dwc3-2578 [001] d..1 58.568644: dwc3_gadget_giveback: ep0out: req ffff88016c03ad80 length 18/18 ZsI ==> 0 irq/17-dwc3-2578 [001] d..1 58.568645: dwc3_event: event (000020c0): ep0out: Transfer Not Ready (Not Active) irq/17-dwc3-2578 [001] d..1 58.568645: dwc3_ep0: ep0out: Transfer Not Ready (Not Active): state 'Data Phase' irq/17-dwc3-2578 [001] d..1 58.568646: dwc3_ep0: Control Status irq/17-dwc3-2578 [001] d..1 58.568646: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c43 (HLcs:SC:status3) irq/17-dwc3-2578 [001] d..1 58.568653: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.568790: dwc3_event: event (0000c040): ep0out: Transfer Complete irq/17-dwc3-2578 [001] d..1 58.568792: dwc3_ep0: ep0out: Transfer Complete: state 'Status Phase' irq/17-dwc3-2578 [001] d..1 58.568793: dwc3_ep0: Status Phase irq/17-dwc3-2578 [001] d..1 58.568793: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c42 (hLcs:SC:status3) irq/17-dwc3-2578 [001] d..1 58.568794: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 8 ctrl 00000c23 (HLcs:SC:setup) irq/17-dwc3-2578 [001] d..1 58.568798: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.572389: dwc3_event: event (00000101): Reset [U0] irq/17-dwc3-2578 [001] d..1 58.625961: dwc3_event: event (00000201): Connection Done [U0] irq/17-dwc3-2578 [001] d..1 58.625970: dwc3_gadget: Enabling ep0out irq/17-dwc3-2578 [001] d..1 58.625975: dwc3_gadget_ep_cmd: ep0out: cmd 'Set Endpoint Configuration' [1025] params 80000200 00000500 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.625976: dwc3_gadget: Enabling ep0in irq/17-dwc3-2578 [001] d..1 58.625980: dwc3_gadget_ep_cmd: ep0in: cmd 'Set Endpoint Configuration' [1025] params 80000200 02000500 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.724491: dwc3_event: event (0000c040): ep0out: Transfer Complete irq/17-dwc3-2578 [001] d..1 58.724495: dwc3_ep0: ep0out: Transfer Complete: state 'Setup Phase' irq/17-dwc3-2578 [001] d..1 58.724495: dwc3_ep0: Setup Phase irq/17-dwc3-2578 [001] d..1 58.724496: dwc3_ctrl_req: bRequestType 00 bRequest 05 wValue 0004 wIndex 0000 wLength 0 irq/17-dwc3-2578 [001] d..1 58.724497: dwc3_ep0: USB_REQ_SET_ADDRESS irq/17-dwc3-2578 [001] d..1 58.724501: dwc3_event: event (000020c2): ep0in: Transfer Not Ready (Not Active) irq/17-dwc3-2578 [001] d..1 58.724502: dwc3_ep0: ep0in: Transfer Not Ready (Not Active): state 'Setup Phase' irq/17-dwc3-2578 [001] d..1 58.724503: dwc3_ep0: Control Status irq/17-dwc3-2578 [001] d..1 58.724504: dwc3_prepare_trb: ep0in: 0/0 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c33 (HLcs:SC:status2) irq/17-dwc3-2578 [001] d..1 58.724508: dwc3_gadget_ep_cmd: ep0in: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.724622: dwc3_event: event (0000c042): ep0in: Transfer Complete irq/17-dwc3-2578 [001] d..1 58.724624: dwc3_ep0: ep0in: Transfer Complete: state 'Status Phase' irq/17-dwc3-2578 [001] d..1 58.724625: dwc3_ep0: Status Phase irq/17-dwc3-2578 [001] d..1 58.724625: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c32 (hLcs:SC:status2) irq/17-dwc3-2578 [001] d..1 58.724626: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 8 ctrl 00000c23 (HLcs:SC:setup) irq/17-dwc3-2578 [001] d..1 58.724630: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.736479: dwc3_event: event (0000c040): ep0out: Transfer Complete irq/17-dwc3-2578 [001] d..1 58.736481: dwc3_ep0: ep0out: Transfer Complete: state 'Setup Phase' irq/17-dwc3-2578 [001] d..1 58.736481: dwc3_ep0: Setup Phase irq/17-dwc3-2578 [001] d..1 58.736482: dwc3_ctrl_req: bRequestType 80 bRequest 06 wValue 0100 wIndex 0000 wLength 18 irq/17-dwc3-2578 [001] d..1 58.736482: dwc3_ep0: Forwarding to gadget driver irq/17-dwc3-2578 [001] d..1 58.736484: dwc3_ep0: queueing request ffff88016c03ad80 to ep0out length 18 state 'Setup Phase' irq/17-dwc3-2578 [001] d..1 58.736487: dwc3_prepare_trb: ep0in: 0/0 trb ffff880084c02000 buf 000000008025e800 size 18 ctrl 00000c53 (HLcs:SC:data) irq/17-dwc3-2578 [001] d..1 58.736498: dwc3_gadget_ep_cmd: ep0in: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.736500: dwc3_event: event (000010c2): ep0in: Transfer Not Ready (Not Active) irq/17-dwc3-2578 [001] d..1 58.736501: dwc3_ep0: ep0in: Transfer Not Ready (Not Active): state 'Data Phase' irq/17-dwc3-2578 [001] d..1 58.736502: dwc3_ep0: Control Data irq/17-dwc3-2578 [001] d..1 58.736606: dwc3_event: event (0000c042): ep0in: Transfer Complete irq/17-dwc3-2578 [001] d..1 58.736608: dwc3_ep0: ep0in: Transfer Complete: state 'Data Phase' irq/17-dwc3-2578 [001] d..1 58.736608: dwc3_ep0: Data Phase irq/17-dwc3-2578 [001] d..1 58.736609: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 000000008025e800 size 0 ctrl 00000c52 (hLcs:SC:data) irq/17-dwc3-2578 [001] d..1 58.736610: dwc3_gadget_giveback: ep0out: req ffff88016c03ad80 length 18/18 zsI ==> 0 irq/17-dwc3-2578 [001] d..1 58.736611: dwc3_event: event (000020c0): ep0out: Transfer Not Ready (Not Active) irq/17-dwc3-2578 [001] d..1 58.736611: dwc3_ep0: ep0out: Transfer Not Ready (Not Active): state 'Data Phase' irq/17-dwc3-2578 [001] d..1 58.736612: dwc3_ep0: Control Status irq/17-dwc3-2578 [001] d..1 58.736612: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c43 (HLcs:SC:status3) irq/17-dwc3-2578 [001] d..1 58.736620: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.736750: dwc3_event: event (0000c040): ep0out: Transfer Complete irq/17-dwc3-2578 [001] d..1 58.736751: dwc3_ep0: ep0out: Transfer Complete: state 'Status Phase' irq/17-dwc3-2578 [001] d..1 58.736752: dwc3_ep0: Status Phase irq/17-dwc3-2578 [001] d..1 58.736752: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c42 (hLcs:SC:status3) irq/17-dwc3-2578 [001] d..1 58.736753: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 8 ctrl 00000c23 (HLcs:SC:setup) irq/17-dwc3-2578 [001] d..1 58.736757: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.736851: dwc3_event: event (0000c040): ep0out: Transfer Complete irq/17-dwc3-2578 [001] d..1 58.736853: dwc3_ep0: ep0out: Transfer Complete: state 'Setup Phase' irq/17-dwc3-2578 [001] d..1 58.736854: dwc3_ep0: Setup Phase irq/17-dwc3-2578 [001] d..1 58.736854: dwc3_ctrl_req: bRequestType 80 bRequest 06 wValue 0f00 wIndex 0000 wLength 5 irq/17-dwc3-2578 [001] d..1 58.736855: dwc3_ep0: Forwarding to gadget driver irq/17-dwc3-2578 [001] d..1 58.736856: dwc3_ep0: queueing request ffff88016c03ad80 to ep0out length 5 state 'Setup Phase' irq/17-dwc3-2578 [001] d..1 58.736858: dwc3_prepare_trb: ep0in: 0/0 trb ffff880084c02000 buf 000000008025f000 size 5 ctrl 00000c53 (HLcs:SC:data) irq/17-dwc3-2578 [001] d..1 58.736867: dwc3_gadget_ep_cmd: ep0in: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.736870: dwc3_event: event (000010c2): ep0in: Transfer Not Ready (Not Active) irq/17-dwc3-2578 [001] d..1 58.736870: dwc3_ep0: ep0in: Transfer Not Ready (Not Active): state 'Data Phase' irq/17-dwc3-2578 [001] d..1 58.736871: dwc3_ep0: Control Data irq/17-dwc3-2578 [001] d..1 58.736979: dwc3_event: event (0000c042): ep0in: Transfer Complete irq/17-dwc3-2578 [001] d..1 58.736980: dwc3_ep0: ep0in: Transfer Complete: state 'Data Phase' irq/17-dwc3-2578 [001] d..1 58.736981: dwc3_ep0: Data Phase irq/17-dwc3-2578 [001] d..1 58.736981: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 000000008025f000 size 0 ctrl 00000c52 (hLcs:SC:data) irq/17-dwc3-2578 [001] d..1 58.736982: dwc3_gadget_giveback: ep0out: req ffff88016c03ad80 length 5/5 zsI ==> 0 irq/17-dwc3-2578 [001] d..1 58.736983: dwc3_event: event (000020c0): ep0out: Transfer Not Ready (Not Active) irq/17-dwc3-2578 [001] d..1 58.736983: dwc3_ep0: ep0out: Transfer Not Ready (Not Active): state 'Data Phase' irq/17-dwc3-2578 [001] d..1 58.736984: dwc3_ep0: Control Status irq/17-dwc3-2578 [001] d..1 58.736985: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c43 (HLcs:SC:status3) irq/17-dwc3-2578 [001] d..1 58.736992: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.737131: dwc3_event: event (0000c040): ep0out: Transfer Complete irq/17-dwc3-2578 [001] d..1 58.737133: dwc3_ep0: ep0out: Transfer Complete: state 'Status Phase' irq/17-dwc3-2578 [001] d..1 58.737134: dwc3_ep0: Status Phase irq/17-dwc3-2578 [001] d..1 58.737134: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c42 (hLcs:SC:status3) irq/17-dwc3-2578 [001] d..1 58.737135: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 8 ctrl 00000c23 (HLcs:SC:setup) irq/17-dwc3-2578 [001] d..1 58.737142: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.737208: dwc3_event: event (0000c040): ep0out: Transfer Complete irq/17-dwc3-2578 [001] d..1 58.737208: dwc3_ep0: ep0out: Transfer Complete: state 'Setup Phase' irq/17-dwc3-2578 [001] d..1 58.737209: dwc3_ep0: Setup Phase irq/17-dwc3-2578 [001] d..1 58.737209: dwc3_ctrl_req: bRequestType 80 bRequest 06 wValue 0f00 wIndex 0000 wLength 22 irq/17-dwc3-2578 [001] d..1 58.737210: dwc3_ep0: Forwarding to gadget driver irq/17-dwc3-2578 [001] d..1 58.737211: dwc3_ep0: queueing request ffff88016c03ad80 to ep0out length 22 state 'Setup Phase' irq/17-dwc3-2578 [001] d..1 58.737213: dwc3_prepare_trb: ep0in: 0/0 trb ffff880084c02000 buf 000000008025f800 size 22 ctrl 00000c53 (HLcs:SC:data) irq/17-dwc3-2578 [001] d..1 58.737221: dwc3_gadget_ep_cmd: ep0in: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.737223: dwc3_event: event (000010c2): ep0in: Transfer Not Ready (Not Active) irq/17-dwc3-2578 [001] d..1 58.737224: dwc3_ep0: ep0in: Transfer Not Ready (Not Active): state 'Data Phase' irq/17-dwc3-2578 [001] d..1 58.737225: dwc3_ep0: Control Data irq/17-dwc3-2578 [001] d..1 58.737299: dwc3_event: event (0000c042): ep0in: Transfer Complete irq/17-dwc3-2578 [001] d..1 58.737299: dwc3_ep0: ep0in: Transfer Complete: state 'Data Phase' irq/17-dwc3-2578 [001] d..1 58.737300: dwc3_ep0: Data Phase irq/17-dwc3-2578 [001] d..1 58.737300: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 000000008025f800 size 0 ctrl 00000c52 (hLcs:SC:data) irq/17-dwc3-2578 [001] d..1 58.737301: dwc3_gadget_giveback: ep0out: req ffff88016c03ad80 length 22/22 zsI ==> 0 irq/17-dwc3-2578 [001] d..1 58.737301: dwc3_event: event (000020c0): ep0out: Transfer Not Ready (Not Active) irq/17-dwc3-2578 [001] d..1 58.737302: dwc3_ep0: ep0out: Transfer Not Ready (Not Active): state 'Data Phase' irq/17-dwc3-2578 [001] d..1 58.737302: dwc3_ep0: Control Status irq/17-dwc3-2578 [001] d..1 58.737303: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c43 (HLcs:SC:status3) irq/17-dwc3-2578 [001] d..1 58.737306: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.737411: dwc3_event: event (0000c040): ep0out: Transfer Complete irq/17-dwc3-2578 [001] d..1 58.737412: dwc3_ep0: ep0out: Transfer Complete: state 'Status Phase' irq/17-dwc3-2578 [001] d..1 58.737412: dwc3_ep0: Status Phase irq/17-dwc3-2578 [001] d..1 58.737412: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c42 (hLcs:SC:status3) irq/17-dwc3-2578 [001] d..1 58.737413: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 8 ctrl 00000c23 (HLcs:SC:setup) irq/17-dwc3-2578 [001] d..1 58.737416: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.737501: dwc3_event: event (0000c040): ep0out: Transfer Complete irq/17-dwc3-2578 [001] d..1 58.737502: dwc3_ep0: ep0out: Transfer Complete: state 'Setup Phase' irq/17-dwc3-2578 [001] d..1 58.737502: dwc3_ep0: Setup Phase irq/17-dwc3-2578 [001] d..1 58.737502: dwc3_ctrl_req: bRequestType 80 bRequest 06 wValue 0200 wIndex 0000 wLength 9 irq/17-dwc3-2578 [001] d..1 58.737502: dwc3_ep0: Forwarding to gadget driver irq/17-dwc3-2578 [001] d..1 58.737504: dwc3_ep0: queueing request ffff88016c03ad80 to ep0out length 9 state 'Setup Phase' irq/17-dwc3-2578 [001] d..1 58.737505: dwc3_prepare_trb: ep0in: 0/0 trb ffff880084c02000 buf 0000000080260000 size 9 ctrl 00000c53 (HLcs:SC:data) irq/17-dwc3-2578 [001] d..1 58.737514: dwc3_gadget_ep_cmd: ep0in: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.737516: dwc3_event: event (000010c2): ep0in: Transfer Not Ready (Not Active) irq/17-dwc3-2578 [001] d..1 58.737516: dwc3_ep0: ep0in: Transfer Not Ready (Not Active): state 'Data Phase' irq/17-dwc3-2578 [001] d..1 58.737517: dwc3_ep0: Control Data irq/17-dwc3-2578 [001] d..1 58.737589: dwc3_event: event (0000c042): ep0in: Transfer Complete irq/17-dwc3-2578 [001] d..1 58.737589: dwc3_ep0: ep0in: Transfer Complete: state 'Data Phase' irq/17-dwc3-2578 [001] d..1 58.737590: dwc3_ep0: Data Phase irq/17-dwc3-2578 [001] d..1 58.737590: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000080260000 size 0 ctrl 00000c52 (hLcs:SC:data) irq/17-dwc3-2578 [001] d..1 58.737590: dwc3_gadget_giveback: ep0out: req ffff88016c03ad80 length 9/9 zsI ==> 0 irq/17-dwc3-2578 [001] d..1 58.737591: dwc3_event: event (000020c0): ep0out: Transfer Not Ready (Not Active) irq/17-dwc3-2578 [001] d..1 58.737591: dwc3_ep0: ep0out: Transfer Not Ready (Not Active): state 'Data Phase' irq/17-dwc3-2578 [001] d..1 58.737591: dwc3_ep0: Control Status irq/17-dwc3-2578 [001] d..1 58.737592: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c43 (HLcs:SC:status3) irq/17-dwc3-2578 [001] d..1 58.737596: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.737682: dwc3_event: event (0000c040): ep0out: Transfer Complete irq/17-dwc3-2578 [001] d..1 58.737683: dwc3_ep0: ep0out: Transfer Complete: state 'Status Phase' irq/17-dwc3-2578 [001] d..1 58.737683: dwc3_ep0: Status Phase irq/17-dwc3-2578 [001] d..1 58.737683: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c42 (hLcs:SC:status3) irq/17-dwc3-2578 [001] d..1 58.737684: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 8 ctrl 00000c23 (HLcs:SC:setup) irq/17-dwc3-2578 [001] d..1 58.737688: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.737750: dwc3_event: event (0000c040): ep0out: Transfer Complete irq/17-dwc3-2578 [001] d..1 58.737751: dwc3_ep0: ep0out: Transfer Complete: state 'Setup Phase' irq/17-dwc3-2578 [001] d..1 58.737751: dwc3_ep0: Setup Phase irq/17-dwc3-2578 [001] d..1 58.737751: dwc3_ctrl_req: bRequestType 80 bRequest 06 wValue 0200 wIndex 0000 wLength 309 irq/17-dwc3-2578 [001] d..1 58.737751: dwc3_ep0: Forwarding to gadget driver irq/17-dwc3-2578 [001] d..1 58.737752: dwc3_ep0: queueing request ffff88016c03ad80 to ep0out length 309 state 'Setup Phase' irq/17-dwc3-2578 [001] d..1 58.737753: dwc3_prepare_trb: ep0in: 0/0 trb ffff880084c02000 buf 0000000080260800 size 309 ctrl 00000c53 (HLcs:SC:data) irq/17-dwc3-2578 [001] d..1 58.737763: dwc3_gadget_ep_cmd: ep0in: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.737765: dwc3_event: event (000010c2): ep0in: Transfer Not Ready (Not Active) irq/17-dwc3-2578 [001] d..1 58.737765: dwc3_ep0: ep0in: Transfer Not Ready (Not Active): state 'Data Phase' irq/17-dwc3-2578 [001] d..1 58.737766: dwc3_ep0: Control Data irq/17-dwc3-2578 [001] d..1 58.737846: dwc3_event: event (0000c042): ep0in: Transfer Complete irq/17-dwc3-2578 [001] d..1 58.737846: dwc3_ep0: ep0in: Transfer Complete: state 'Data Phase' irq/17-dwc3-2578 [001] d..1 58.737846: dwc3_ep0: Data Phase irq/17-dwc3-2578 [001] d..1 58.737846: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000080260800 size 0 ctrl 00000c52 (hLcs:SC:data) irq/17-dwc3-2578 [001] d..1 58.737847: dwc3_gadget_giveback: ep0out: req ffff88016c03ad80 length 309/309 zsI ==> 0 irq/17-dwc3-2578 [001] d..1 58.737847: dwc3_event: event (000020c0): ep0out: Transfer Not Ready (Not Active) irq/17-dwc3-2578 [001] d..1 58.737848: dwc3_ep0: ep0out: Transfer Not Ready (Not Active): state 'Data Phase' irq/17-dwc3-2578 [001] d..1 58.737848: dwc3_ep0: Control Status irq/17-dwc3-2578 [001] d..1 58.737848: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c43 (HLcs:SC:status3) irq/17-dwc3-2578 [001] d..1 58.737852: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.737917: dwc3_event: event (0000c040): ep0out: Transfer Complete irq/17-dwc3-2578 [001] d..1 58.737917: dwc3_ep0: ep0out: Transfer Complete: state 'Status Phase' irq/17-dwc3-2578 [001] d..1 58.737917: dwc3_ep0: Status Phase irq/17-dwc3-2578 [001] d..1 58.737918: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c42 (hLcs:SC:status3) irq/17-dwc3-2578 [001] d..1 58.737918: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 8 ctrl 00000c23 (HLcs:SC:setup) irq/17-dwc3-2578 [001] d..1 58.737922: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.737985: dwc3_event: event (0000c040): ep0out: Transfer Complete irq/17-dwc3-2578 [001] d..1 58.737985: dwc3_ep0: ep0out: Transfer Complete: state 'Setup Phase' irq/17-dwc3-2578 [001] d..1 58.737986: dwc3_ep0: Setup Phase irq/17-dwc3-2578 [001] d..1 58.737986: dwc3_ctrl_req: bRequestType 80 bRequest 06 wValue 0300 wIndex 0000 wLength 255 irq/17-dwc3-2578 [001] d..1 58.737986: dwc3_ep0: Forwarding to gadget driver irq/17-dwc3-2578 [001] d..1 58.737986: dwc3_ep0: queueing request ffff88016c03ad80 to ep0out length 4 state 'Setup Phase' irq/17-dwc3-2578 [001] d..1 58.737987: dwc3_prepare_trb: ep0in: 0/0 trb ffff880084c02000 buf 0000000080261000 size 4 ctrl 00000c53 (HLcs:SC:data) irq/17-dwc3-2578 [001] d..1 58.737991: dwc3_gadget_ep_cmd: ep0in: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.737993: dwc3_event: event (000010c2): ep0in: Transfer Not Ready (Not Active) irq/17-dwc3-2578 [001] d..1 58.737994: dwc3_ep0: ep0in: Transfer Not Ready (Not Active): state 'Data Phase' irq/17-dwc3-2578 [001] d..1 58.737994: dwc3_ep0: Control Data irq/17-dwc3-2578 [001] d..1 58.738069: dwc3_event: event (0000c042): ep0in: Transfer Complete irq/17-dwc3-2578 [001] d..1 58.738069: dwc3_ep0: ep0in: Transfer Complete: state 'Data Phase' irq/17-dwc3-2578 [001] d..1 58.738069: dwc3_ep0: Data Phase irq/17-dwc3-2578 [001] d..1 58.738070: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000080261000 size 0 ctrl 00000c52 (hLcs:SC:data) irq/17-dwc3-2578 [001] d..1 58.738070: dwc3_gadget_giveback: ep0out: req ffff88016c03ad80 length 4/4 ZsI ==> 0 irq/17-dwc3-2578 [001] d..1 58.738071: dwc3_event: event (000020c0): ep0out: Transfer Not Ready (Not Active) irq/17-dwc3-2578 [001] d..1 58.738071: dwc3_ep0: ep0out: Transfer Not Ready (Not Active): state 'Data Phase' irq/17-dwc3-2578 [001] d..1 58.738071: dwc3_ep0: Control Status irq/17-dwc3-2578 [001] d..1 58.738072: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c43 (HLcs:SC:status3) irq/17-dwc3-2578 [001] d..1 58.738075: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.738180: dwc3_event: event (0000c040): ep0out: Transfer Complete irq/17-dwc3-2578 [001] d..1 58.738181: dwc3_ep0: ep0out: Transfer Complete: state 'Status Phase' irq/17-dwc3-2578 [001] d..1 58.738181: dwc3_ep0: Status Phase irq/17-dwc3-2578 [001] d..1 58.738181: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c42 (hLcs:SC:status3) irq/17-dwc3-2578 [001] d..1 58.738181: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 8 ctrl 00000c23 (HLcs:SC:setup) irq/17-dwc3-2578 [001] d..1 58.738185: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.738248: dwc3_event: event (0000c040): ep0out: Transfer Complete irq/17-dwc3-2578 [001] d..1 58.738248: dwc3_ep0: ep0out: Transfer Complete: state 'Setup Phase' irq/17-dwc3-2578 [001] d..1 58.738249: dwc3_ep0: Setup Phase irq/17-dwc3-2578 [001] d..1 58.738249: dwc3_ctrl_req: bRequestType 80 bRequest 06 wValue 0302 wIndex 0409 wLength 255 irq/17-dwc3-2578 [001] d..1 58.738249: dwc3_ep0: Forwarding to gadget driver irq/17-dwc3-2578 [001] d..1 58.738250: dwc3_ep0: queueing request ffff88016c03ad80 to ep0out length 28 state 'Setup Phase' irq/17-dwc3-2578 [001] d..1 58.738251: dwc3_prepare_trb: ep0in: 0/0 trb ffff880084c02000 buf 0000000080261800 size 28 ctrl 00000c53 (HLcs:SC:data) irq/17-dwc3-2578 [001] d..1 58.738255: dwc3_gadget_ep_cmd: ep0in: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.738257: dwc3_event: event (000010c2): ep0in: Transfer Not Ready (Not Active) irq/17-dwc3-2578 [001] d..1 58.738257: dwc3_ep0: ep0in: Transfer Not Ready (Not Active): state 'Data Phase' irq/17-dwc3-2578 [001] d..1 58.738258: dwc3_ep0: Control Data irq/17-dwc3-2578 [001] d..1 58.738335: dwc3_event: event (0000c042): ep0in: Transfer Complete irq/17-dwc3-2578 [001] d..1 58.738336: dwc3_ep0: ep0in: Transfer Complete: state 'Data Phase' irq/17-dwc3-2578 [001] d..1 58.738336: dwc3_ep0: Data Phase irq/17-dwc3-2578 [001] d..1 58.738336: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000080261800 size 0 ctrl 00000c52 (hLcs:SC:data) irq/17-dwc3-2578 [001] d..1 58.738337: dwc3_gadget_giveback: ep0out: req ffff88016c03ad80 length 28/28 ZsI ==> 0 irq/17-dwc3-2578 [001] d..1 58.738337: dwc3_event: event (000020c0): ep0out: Transfer Not Ready (Not Active) irq/17-dwc3-2578 [001] d..1 58.738338: dwc3_ep0: ep0out: Transfer Not Ready (Not Active): state 'Data Phase' irq/17-dwc3-2578 [001] d..1 58.738338: dwc3_ep0: Control Status irq/17-dwc3-2578 [001] d..1 58.738338: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c43 (HLcs:SC:status3) irq/17-dwc3-2578 [001] d..1 58.738342: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.738423: dwc3_event: event (0000c040): ep0out: Transfer Complete irq/17-dwc3-2578 [001] d..1 58.738423: dwc3_ep0: ep0out: Transfer Complete: state 'Status Phase' irq/17-dwc3-2578 [001] d..1 58.738424: dwc3_ep0: Status Phase irq/17-dwc3-2578 [001] d..1 58.738424: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c42 (hLcs:SC:status3) irq/17-dwc3-2578 [001] d..1 58.738425: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 8 ctrl 00000c23 (HLcs:SC:setup) irq/17-dwc3-2578 [001] d..1 58.738428: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.738491: dwc3_event: event (0000c040): ep0out: Transfer Complete irq/17-dwc3-2578 [001] d..1 58.738491: dwc3_ep0: ep0out: Transfer Complete: state 'Setup Phase' irq/17-dwc3-2578 [001] d..1 58.738492: dwc3_ep0: Setup Phase irq/17-dwc3-2578 [001] d..1 58.738492: dwc3_ctrl_req: bRequestType 80 bRequest 06 wValue 0301 wIndex 0409 wLength 255 irq/17-dwc3-2578 [001] d..1 58.738492: dwc3_ep0: Forwarding to gadget driver irq/17-dwc3-2578 [001] d..1 58.738493: dwc3_ep0: queueing request ffff88016c03ad80 to ep0out length 34 state 'Setup Phase' irq/17-dwc3-2578 [001] d..1 58.738494: dwc3_prepare_trb: ep0in: 0/0 trb ffff880084c02000 buf 0000000080262000 size 34 ctrl 00000c53 (HLcs:SC:data) irq/17-dwc3-2578 [001] d..1 58.738498: dwc3_gadget_ep_cmd: ep0in: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.738500: dwc3_event: event (000010c2): ep0in: Transfer Not Ready (Not Active) irq/17-dwc3-2578 [001] d..1 58.738500: dwc3_ep0: ep0in: Transfer Not Ready (Not Active): state 'Data Phase' irq/17-dwc3-2578 [001] d..1 58.738501: dwc3_ep0: Control Data irq/17-dwc3-2578 [001] d..1 58.738561: dwc3_event: event (000090c2): ep0in: Transfer Not Ready (Active) irq/17-dwc3-2578 [001] d..1 58.738562: dwc3_ep0: ep0in: Transfer Not Ready (Active): state 'Data Phase' irq/17-dwc3-2578 [001] d..1 58.738562: dwc3_event: event (0000c042): ep0in: Transfer Complete irq/17-dwc3-2578 [001] d..1 58.738563: dwc3_ep0: ep0in: Transfer Complete: state 'Data Phase' irq/17-dwc3-2578 [001] d..1 58.738563: dwc3_ep0: Data Phase irq/17-dwc3-2578 [001] d..1 58.738563: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000080262000 size 0 ctrl 00000c52 (hLcs:SC:data) irq/17-dwc3-2578 [001] d..1 58.738564: dwc3_gadget_giveback: ep0out: req ffff88016c03ad80 length 34/34 ZsI ==> 0 irq/17-dwc3-2578 [001] d..1 58.738564: dwc3_event: event (000020c0): ep0out: Transfer Not Ready (Not Active) irq/17-dwc3-2578 [001] d..1 58.738564: dwc3_ep0: ep0out: Transfer Not Ready (Not Active): state 'Data Phase' irq/17-dwc3-2578 [001] d..1 58.738565: dwc3_ep0: Control Status irq/17-dwc3-2578 [001] d..1 58.738565: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c43 (HLcs:SC:status3) irq/17-dwc3-2578 [001] d..1 58.738569: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.738674: dwc3_event: event (0000c040): ep0out: Transfer Complete irq/17-dwc3-2578 [001] d..1 58.738675: dwc3_ep0: ep0out: Transfer Complete: state 'Status Phase' irq/17-dwc3-2578 [001] d..1 58.738675: dwc3_ep0: Status Phase irq/17-dwc3-2578 [001] d..1 58.738676: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c42 (hLcs:SC:status3) irq/17-dwc3-2578 [001] d..1 58.738676: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 8 ctrl 00000c23 (HLcs:SC:setup) irq/17-dwc3-2578 [001] d..1 58.738680: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.739128: dwc3_event: event (0000c040): ep0out: Transfer Complete irq/17-dwc3-2578 [001] d..1 58.739129: dwc3_ep0: ep0out: Transfer Complete: state 'Setup Phase' irq/17-dwc3-2578 [001] d..1 58.739130: dwc3_ep0: Setup Phase irq/17-dwc3-2578 [001] d..1 58.739130: dwc3_ctrl_req: bRequestType 00 bRequest 09 wValue 0001 wIndex 0000 wLength 0 irq/17-dwc3-2578 [001] d..1 58.739131: dwc3_ep0: USB_REQ_SET_CONFIGURATION irq/17-dwc3-2578 [001] d..2 58.739141: dwc3_gadget: Enabling ep1in irq/17-dwc3-2578 [001] d..2 58.739145: dwc3_gadget_ep_cmd: ep1in: cmd 'Set Endpoint Configuration' [1025] params 00020086 06070200 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.739150: dwc3_ep0: queueing request ffff88016c03ad80 to ep0out length 0 state 'Setup Phase' irq/17-dwc3-2578 [001] d..1 58.739159: dwc3_event: event (000020c2): ep0in: Transfer Not Ready (Not Active) irq/17-dwc3-2578 [001] d..1 58.739160: dwc3_ep0: ep0in: Transfer Not Ready (Not Active): state 'Setup Phase' irq/17-dwc3-2578 [001] d..1 58.739160: dwc3_ep0: Control Status irq/17-dwc3-2578 [001] d..1 58.739161: dwc3_prepare_trb: ep0in: 0/0 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c33 (HLcs:SC:status2) irq/17-dwc3-2578 [001] d..1 58.739165: dwc3_gadget_ep_cmd: ep0in: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.739241: dwc3_event: event (0000c042): ep0in: Transfer Complete irq/17-dwc3-2578 [001] d..1 58.739242: dwc3_ep0: ep0in: Transfer Complete: state 'Status Phase' irq/17-dwc3-2578 [001] d..1 58.739242: dwc3_ep0: Status Phase irq/17-dwc3-2578 [001] d..1 58.739243: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c32 (hLcs:SC:status2) irq/17-dwc3-2578 [001] d..1 58.739244: dwc3_gadget_giveback: ep0out: req ffff88016c03ad80 length 0/0 zsI ==> 0 irq/17-dwc3-2578 [001] d..1 58.739245: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 8 ctrl 00000c23 (HLcs:SC:setup) irq/17-dwc3-2578 [001] d..1 58.739248: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.739313: dwc3_event: event (0000c040): ep0out: Transfer Complete irq/17-dwc3-2578 [001] d..1 58.739314: dwc3_ep0: ep0out: Transfer Complete: state 'Setup Phase' irq/17-dwc3-2578 [001] d..1 58.739314: dwc3_ep0: Setup Phase irq/17-dwc3-2578 [001] d..1 58.739315: dwc3_ctrl_req: bRequestType 80 bRequest 06 wValue 0304 wIndex 0409 wLength 255 irq/17-dwc3-2578 [001] d..1 58.739315: dwc3_ep0: Forwarding to gadget driver irq/17-dwc3-2578 [001] d..1 58.739316: dwc3_ep0: queueing request ffff88016c03ad80 to ep0out length 12 state 'Setup Phase' irq/17-dwc3-2578 [001] d..1 58.739318: dwc3_prepare_trb: ep0in: 0/0 trb ffff880084c02000 buf 0000000080262800 size 12 ctrl 00000c53 (HLcs:SC:data) irq/17-dwc3-2578 [001] d..1 58.739326: dwc3_gadget_ep_cmd: ep0in: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.739329: dwc3_event: event (000010c2): ep0in: Transfer Not Ready (Not Active) irq/17-dwc3-2578 [001] d..1 58.739330: dwc3_ep0: ep0in: Transfer Not Ready (Not Active): state 'Data Phase' irq/17-dwc3-2578 [001] d..1 58.739330: dwc3_ep0: Control Data irq/17-dwc3-2578 [001] d..1 58.739400: dwc3_event: event (0000c042): ep0in: Transfer Complete irq/17-dwc3-2578 [001] d..1 58.739401: dwc3_ep0: ep0in: Transfer Complete: state 'Data Phase' irq/17-dwc3-2578 [001] d..1 58.739402: dwc3_ep0: Data Phase irq/17-dwc3-2578 [001] d..1 58.739402: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000080262800 size 0 ctrl 00000c52 (hLcs:SC:data) irq/17-dwc3-2578 [001] d..1 58.739403: dwc3_gadget_giveback: ep0out: req ffff88016c03ad80 length 12/12 ZsI ==> 0 irq/17-dwc3-2578 [001] d..1 58.739404: dwc3_event: event (000020c0): ep0out: Transfer Not Ready (Not Active) irq/17-dwc3-2578 [001] d..1 58.739405: dwc3_ep0: ep0out: Transfer Not Ready (Not Active): state 'Data Phase' irq/17-dwc3-2578 [001] d..1 58.739405: dwc3_ep0: Control Status irq/17-dwc3-2578 [001] d..1 58.739406: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c43 (HLcs:SC:status3) irq/17-dwc3-2578 [001] d..1 58.739412: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.739509: dwc3_event: event (0000c040): ep0out: Transfer Complete irq/17-dwc3-2578 [001] d..1 58.739510: dwc3_ep0: ep0out: Transfer Complete: state 'Status Phase' irq/17-dwc3-2578 [001] d..1 58.739511: dwc3_ep0: Status Phase irq/17-dwc3-2578 [001] d..1 58.739512: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c42 (hLcs:SC:status3) irq/17-dwc3-2578 [001] d..1 58.739512: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 8 ctrl 00000c23 (HLcs:SC:setup) irq/17-dwc3-2578 [001] d..1 58.739516: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.739660: dwc3_event: event (0000c040): ep0out: Transfer Complete irq/17-dwc3-2578 [001] d..1 58.739661: dwc3_ep0: ep0out: Transfer Complete: state 'Setup Phase' irq/17-dwc3-2578 [001] d..1 58.739661: dwc3_ep0: Setup Phase irq/17-dwc3-2578 [001] d..1 58.739662: dwc3_ctrl_req: bRequestType 80 bRequest 06 wValue 0305 wIndex 0409 wLength 255 irq/17-dwc3-2578 [001] d..1 58.739662: dwc3_ep0: Forwarding to gadget driver irq/17-dwc3-2578 [001] d..1 58.739664: dwc3_ep0: queueing request ffff88016c03ad80 to ep0out length 22 state 'Setup Phase' irq/17-dwc3-2578 [001] d..1 58.739666: dwc3_prepare_trb: ep0in: 0/0 trb ffff880084c02000 buf 0000000080263000 size 22 ctrl 00000c53 (HLcs:SC:data) irq/17-dwc3-2578 [001] d..1 58.739672: dwc3_gadget_ep_cmd: ep0in: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.739674: dwc3_event: event (000010c2): ep0in: Transfer Not Ready (Not Active) irq/17-dwc3-2578 [001] d..1 58.739675: dwc3_ep0: ep0in: Transfer Not Ready (Not Active): state 'Data Phase' irq/17-dwc3-2578 [001] d..1 58.739676: dwc3_ep0: Control Data irq/17-dwc3-2578 [001] d..1 58.739753: dwc3_event: event (0000c042): ep0in: Transfer Complete irq/17-dwc3-2578 [001] d..1 58.739754: dwc3_ep0: ep0in: Transfer Complete: state 'Data Phase' irq/17-dwc3-2578 [001] d..1 58.739754: dwc3_ep0: Data Phase irq/17-dwc3-2578 [001] d..1 58.739755: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000080263000 size 0 ctrl 00000c52 (hLcs:SC:data) irq/17-dwc3-2578 [001] d..1 58.739756: dwc3_gadget_giveback: ep0out: req ffff88016c03ad80 length 22/22 ZsI ==> 0 irq/17-dwc3-2578 [001] d..1 58.739757: dwc3_event: event (000020c0): ep0out: Transfer Not Ready (Not Active) irq/17-dwc3-2578 [001] d..1 58.739757: dwc3_ep0: ep0out: Transfer Not Ready (Not Active): state 'Data Phase' irq/17-dwc3-2578 [001] d..1 58.739758: dwc3_ep0: Control Status irq/17-dwc3-2578 [001] d..1 58.739758: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c43 (HLcs:SC:status3) irq/17-dwc3-2578 [001] d..1 58.739765: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.739863: dwc3_event: event (0000c040): ep0out: Transfer Complete irq/17-dwc3-2578 [001] d..1 58.739864: dwc3_ep0: ep0out: Transfer Complete: state 'Status Phase' irq/17-dwc3-2578 [001] d..1 58.739864: dwc3_ep0: Status Phase irq/17-dwc3-2578 [001] d..1 58.739865: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c42 (hLcs:SC:status3) irq/17-dwc3-2578 [001] d..1 58.739866: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 8 ctrl 00000c23 (HLcs:SC:setup) irq/17-dwc3-2578 [001] d..1 58.739870: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.739976: dwc3_event: event (0000c040): ep0out: Transfer Complete irq/17-dwc3-2578 [001] d..1 58.739981: dwc3_ep0: ep0out: Transfer Complete: state 'Setup Phase' irq/17-dwc3-2578 [001] d..1 58.739981: dwc3_ep0: Setup Phase irq/17-dwc3-2578 [001] d..1 58.739984: dwc3_ctrl_req: bRequestType 80 bRequest 06 wValue 0306 wIndex 0409 wLength 255 irq/17-dwc3-2578 [001] d..1 58.739986: dwc3_ep0: Forwarding to gadget driver irq/17-dwc3-2578 [001] d..1 58.739987: dwc3_ep0: queueing request ffff88016c03ad80 to ep0out length 32 state 'Setup Phase' irq/17-dwc3-2578 [001] d..1 58.739989: dwc3_prepare_trb: ep0in: 0/0 trb ffff880084c02000 buf 0000000080263800 size 32 ctrl 00000c53 (HLcs:SC:data) irq/17-dwc3-2578 [001] d..1 58.740000: dwc3_gadget_ep_cmd: ep0in: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.740002: dwc3_event: event (000010c2): ep0in: Transfer Not Ready (Not Active) irq/17-dwc3-2578 [001] d..1 58.740003: dwc3_ep0: ep0in: Transfer Not Ready (Not Active): state 'Data Phase' irq/17-dwc3-2578 [001] d..1 58.740004: dwc3_ep0: Control Data irq/17-dwc3-2578 [001] d..1 58.740066: dwc3_event: event (000090c2): ep0in: Transfer Not Ready (Active) irq/17-dwc3-2578 [001] d..1 58.740067: dwc3_ep0: ep0in: Transfer Not Ready (Active): state 'Data Phase' irq/17-dwc3-2578 [001] d..1 58.740068: dwc3_event: event (0000c042): ep0in: Transfer Complete irq/17-dwc3-2578 [001] d..1 58.740069: dwc3_ep0: ep0in: Transfer Complete: state 'Data Phase' irq/17-dwc3-2578 [001] d..1 58.740069: dwc3_ep0: Data Phase irq/17-dwc3-2578 [001] d..1 58.740070: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000080263800 size 0 ctrl 00000c52 (hLcs:SC:data) irq/17-dwc3-2578 [001] d..1 58.740071: dwc3_gadget_giveback: ep0out: req ffff88016c03ad80 length 32/32 ZsI ==> 0 irq/17-dwc3-2578 [001] d..1 58.740071: dwc3_event: event (000020c0): ep0out: Transfer Not Ready (Not Active) irq/17-dwc3-2578 [001] d..1 58.740072: dwc3_ep0: ep0out: Transfer Not Ready (Not Active): state 'Data Phase' irq/17-dwc3-2578 [001] d..1 58.740072: dwc3_ep0: Control Status irq/17-dwc3-2578 [001] d..1 58.740073: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c43 (HLcs:SC:status3) irq/17-dwc3-2578 [001] d..1 58.740077: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.740177: dwc3_event: event (0000c040): ep0out: Transfer Complete irq/17-dwc3-2578 [001] d..1 58.740178: dwc3_ep0: ep0out: Transfer Complete: state 'Status Phase' irq/17-dwc3-2578 [001] d..1 58.740179: dwc3_ep0: Status Phase irq/17-dwc3-2578 [001] d..1 58.740180: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c42 (hLcs:SC:status3) irq/17-dwc3-2578 [001] d..1 58.740180: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 8 ctrl 00000c23 (HLcs:SC:setup) irq/17-dwc3-2578 [001] d..1 58.740189: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.804470: dwc3_event: event (0000c040): ep0out: Transfer Complete irq/17-dwc3-2578 [001] d..1 58.804473: dwc3_ep0: ep0out: Transfer Complete: state 'Setup Phase' irq/17-dwc3-2578 [001] d..1 58.804475: dwc3_ep0: Setup Phase irq/17-dwc3-2578 [001] d..1 58.804475: dwc3_ctrl_req: bRequestType 01 bRequest 0b wValue 0000 wIndex 0001 wLength 0 irq/17-dwc3-2578 [001] d..1 58.804476: dwc3_ep0: Forwarding to gadget driver irq/17-dwc3-2578 [001] d..1 58.804482: dwc3_ep0: queueing request ffff88016c03ad80 to ep0out length 0 state 'Setup Phase' irq/17-dwc3-2578 [001] d..1 58.804486: dwc3_event: event (000020c2): ep0in: Transfer Not Ready (Not Active) irq/17-dwc3-2578 [001] d..1 58.804487: dwc3_ep0: ep0in: Transfer Not Ready (Not Active): state 'Setup Phase' irq/17-dwc3-2578 [001] d..1 58.804488: dwc3_ep0: Control Status irq/17-dwc3-2578 [001] d..1 58.804489: dwc3_prepare_trb: ep0in: 0/0 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c33 (HLcs:SC:status2) irq/17-dwc3-2578 [001] d..1 58.804495: dwc3_gadget_ep_cmd: ep0in: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.804583: dwc3_event: event (0000c042): ep0in: Transfer Complete irq/17-dwc3-2578 [001] d..1 58.804584: dwc3_ep0: ep0in: Transfer Complete: state 'Status Phase' irq/17-dwc3-2578 [001] d..1 58.804584: dwc3_ep0: Status Phase irq/17-dwc3-2578 [001] d..1 58.804585: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c32 (hLcs:SC:status2) irq/17-dwc3-2578 [001] d..1 58.804586: dwc3_gadget_giveback: ep0out: req ffff88016c03ad80 length 0/0 zsI ==> 0 irq/17-dwc3-2578 [001] d..1 58.804587: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 8 ctrl 00000c23 (HLcs:SC:setup) irq/17-dwc3-2578 [001] d..1 58.804596: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful irq/17-dwc3-2578 [001] d..1 58.804660: dwc3_event: event (0000c040): ep0out: Transfer Complete irq/17-dwc3-2578 [001] d..1 58.804661: dwc3_ep0: ep0out: Transfer Complete: state 'Setup Phase' irq/17-dwc3-2578 [001] d..1 58.804661: dwc3_ep0: Setup Phase irq/17-dwc3-2578 [001] d..1 58.804661: dwc3_ctrl_req: bRequestType a1 bRequest 87 wValue 0100 wIndex 0001 wLength 26 irq/17-dwc3-2578 [001] d..1 58.804663: dwc3_event: event (000010c2): ep0in: Transfer Not Ready (Not Active) irq/17-dwc3-2578 [001] d..1 58.804663: dwc3_ep0: ep0in: Transfer Not Ready (Not Active): state 'Setup Phase' irq/17-dwc3-2578 [001] d..1 58.804664: dwc3_ep0: Control Data uvc-gadget keeps printing this error message: 159 if ((ret = ioctl(dev->fd, VIDIOC_DQBUF, &buf)) < 0) { 160 printf("Unable to dequeue buffer: %s (%d).\n", strerror(errno), 161 errno); 162 return ret; 163 } Any ideas? -- balbi [-- Attachment #2: signature.asc --] [-- Type: application/pgp-signature, Size: 800 bytes --] ^ permalink raw reply [flat|nested] 19+ messages in thread
* Re: g_webcam Isoch high bandwidth transfer 2016-09-23 7:49 ` Felipe Balbi @ 2016-09-23 8:10 ` yfw 2016-09-23 8:27 ` Felipe Balbi 2016-09-26 14:02 ` Bin Liu 2016-09-26 16:03 ` Laurent Pinchart 2 siblings, 1 reply; 19+ messages in thread From: yfw @ 2016-09-23 8:10 UTC (permalink / raw) To: Felipe Balbi, Bin Liu; +Cc: linux-usb, linux-media, laurent.pinchart Hi Felipe, On 2016/9/23 15:49, Felipe Balbi wrote: > > Hi, > > Bin Liu <b-liu@ti.com> writes: >> +Fengwei Yin per his request. >> >> On Thu, Sep 22, 2016 at 10:48:40PM +0300, Felipe Balbi wrote: >>> >>> Hi, >>> >>> Bin Liu <b-liu@ti.com> writes: >>> >>> [...] >>> >>>>> Here's one that actually compiles, sorry about that. >>>> >>>> No worries, I was sleeping ;-) >>>> >>>> I will test it out early next week. Thanks. >>> >>> meanwhile, how about some instructions on how to test this out myself? >>> How are you using g_webcam and what are you running on host side? Got a >>> nice list of commands there I can use? I think I can get to bottom of >>> this much quicker if I can reproduce it locally ;-) >> >> On device side: >> - first patch g_webcam as in my first email in this thread to enable >> 640x480@30fps; >> - # modprobe g_webcam streaming_maxpacket=3072 >> - then run uvc-gadget to feed the YUV frames; >> http://git.ideasonboard.org/uvc-gadget.git > > as is, g_webcam never enumerates to the host. It's calls to > usb_function_active() and usb_function_deactivate() are unbalanced. Do > you have any other changes to g_webcam? With uvc function gadget driver, user daemon uvc-gadget must be started before connect to host. Not sure whether g_webcam has same requirement. > > Also, uvc-gadget.git doesn't compile, had to modify it a bit: > > -#include "../drivers/usb/gadget/uvc.h" > +#include "../drivers/usb/gadget/function/uvc.h" > > Also fixed a build warning: > > @@ -732,6 +732,8 @@ int main(int argc, char *argv[]) > fd_set wfds = fds; > > ret = select(dev->fd + 1, NULL, &wfds, &efds, NULL); > + if (ret < 0) > + return ret; > if (FD_ISSET(dev->fd, &efds)) > uvc_events_process(dev); > if (FD_ISSET(dev->fd, &wfds)) > > Laurent, have you tested g_webcam recently? What's the magic to get it > working? > > Here's what I get out of dmesg: > > [ 58.568380] usb 1-9: new high-speed USB device number 5 using xhci_hcd > [ 58.738680] usb 1-9: New USB device found, idVendor=1d6b, idProduct=0102 > [ 58.738683] usb 1-9: New USB device strings: Mfr=1, Product=2, SerialNumber=0 > [ 58.738685] usb 1-9: Product: Webcam gadget > [ 58.738687] usb 1-9: Manufacturer: Linux Foundation > [ 58.739133] g_webcam gadget: high-speed config #1: Video > [ 58.739138] g_webcam gadget: uvc_function_set_alt(0, 0) > [ 58.739139] g_webcam gadget: reset UVC Control > [ 58.739149] g_webcam gadget: uvc_function_set_alt(1, 0) > [ 58.804369] uvcvideo: Found UVC 1.00 device Webcam gadget (1d6b:0102) > [ 58.804479] g_webcam gadget: uvc_function_set_alt(1, 0) > [ 64.188459] uvcvideo: UVC non compliance - GET_DEF(PROBE) not supported. Enabling workaround. Looks like you connect your usb device to your usb host port on same board. Nice. The GET_DEF is handled by user daemon uvc-gadget. It may be related. Regards Yin, Fengwei > [ 69.307458] uvcvideo: Failed to query (129) UVC probe control : -110 (exp. 26). > [ 69.307459] uvcvideo: Failed to initialize the device (-5). > [ 69.307505] usbcore: registered new interface driver uvcvideo > [ 69.307506] USB Video Class driver (1.1.1) > [ 146.646012] ------------[ cut here ]------------ > [ 146.646023] WARNING: CPU: 0 PID: 2616 at drivers/usb/gadget/composite.c:371 usb_function_activate+0x77/0x80 [libcomposite] > [ 146.646024] Modules linked in: uvcvideo g_webcam usb_f_uvc videobuf2_vmalloc videobuf2_memops videobuf2_v4l2 videobuf2_core videodev libcomposite kvm_intel kvm psmouse e1000e input_leds hid_generic usbhid atkbd irqbypass evdev > [ 146.646054] CPU: 0 PID: 2616 Comm: gst-launch-1.0 Not tainted 4.8.0-rc7-next-20160922-00004-gc71031593917-dirty #20 > [ 146.646055] Hardware name: Intel Corporation Skylake Client platform/Skylake Y LPDDR3 RVP3, BIOS SKLSE2R1.R00.B097.B02.1509020030 09/02/2015 > [ 146.646058] ffffc9000769bb70 > [ 146.646059] ffffffff8132d415 > [ 146.646060] 0000000000000000 > [ 146.646061] 0000000000000000 > > [ 146.646063] ffffc9000769bbb0 > [ 146.646063] ffffffff8105ec1b > [ 146.646064] 000001730769bb90 > [ 146.646066] 00000000ffffffea > [ 146.646070] ffff88016c03a150 > [ 146.646072] 0000000000000282 ffff88016d793000 ffffc9000769befc > [ 146.646077] Call Trace: > [ 146.646086] [<ffffffff8132d415>] dump_stack+0x68/0x93 > [ 146.646090] [<ffffffff8105ec1b>] __warn+0xcb/0xf0 > [ 146.646095] [<ffffffff8105ed0d>] warn_slowpath_null+0x1d/0x20 > [ 146.646099] [<ffffffffa03f1ea7>] usb_function_activate+0x77/0x80 [libcomposite] > [ 146.646105] [<ffffffffa044a6de>] uvc_function_connect+0x1e/0x40 [usb_f_uvc] > [ 146.646110] [<ffffffffa044b2ae>] uvc_v4l2_open+0x6e/0x80 [usb_f_uvc] > [ 146.646116] [<ffffffffa04014f0>] v4l2_open+0xa0/0x100 [videodev] > [ 146.646121] [<ffffffff811a5431>] chrdev_open+0xa1/0x1d0 > [ 146.646125] [<ffffffff811a5390>] ? cdev_put+0x30/0x30 > [ 146.646129] [<ffffffff8119dd60>] do_dentry_open.isra.17+0x150/0x2e0 > [ 146.646133] [<ffffffff8119f115>] vfs_open+0x45/0x60 > [ 146.646137] [<ffffffff811af1ed>] path_openat+0x62d/0x1370 > [ 146.646141] [<ffffffff811b0094>] ? putname+0x54/0x60 > [ 146.646146] [<ffffffff811b10ce>] do_filp_open+0x7e/0xe0 > [ 146.646150] [<ffffffff81083868>] ? preempt_count_sub+0x48/0x70 > [ 146.646154] [<ffffffff816f07d6>] ? _raw_spin_unlock+0x16/0x30 > [ 146.646160] [<ffffffff811bf009>] ? __alloc_fd+0xc9/0x180 > [ 146.646164] [<ffffffff8119f4e3>] do_sys_open+0x123/0x200 > [ 146.646170] [<ffffffff8119f5de>] SyS_open+0x1e/0x20 > [ 146.646174] [<ffffffff816f0e2a>] entry_SYSCALL_64_fastpath+0x18/0xa8 > [ 146.646177] ---[ end trace 1a4f7b9817d19b04 ]--- > [ 146.646180] g_webcam gadget: UVC connect failed with -22 > [ 146.653808] usb 1-9: USB disconnect, device number 5 > [ 146.653986] g_webcam gadget: UVC disconnect failed with -110 > > > And dwc3 trace: > > # tracer: nop > # > # entries-in-buffer/entries-written: 445/445 #P:4 > # > # _-----=> irqs-off > # / _----=> need-resched > # | / _---=> hardirq/softirq > # || / _--=> preempt-depth > # ||| / delay > # TASK-PID CPU# |||| TIMESTAMP FUNCTION > # | | | |||| | | > modprobe-2560 [001] .... 35.602546: dwc3_alloc_request: ep0out: req ffff88016c03ad80 length 0/0 zsI ==> 0 > modprobe-2560 [001] .... 35.602566: dwc3_alloc_request: ep0out: req ffff88016c03acc0 length 0/0 zsI ==> 0 > modprobe-2560 [001] d..1 35.602725: dwc3_gadget: Enabling ep0out > modprobe-2560 [001] d..1 35.602730: dwc3_gadget_ep_cmd: ep0out: cmd 'Start New Configuration' [1033] params 00000000 00000000 00000000 --> status: Successful > modprobe-2560 [001] d..1 35.602829: dwc3_gadget_ep_cmd: ep0out: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful > modprobe-2560 [001] d..1 35.602920: dwc3_gadget_ep_cmd: ep0in: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful > modprobe-2560 [001] d..1 35.603012: dwc3_gadget_ep_cmd: ep1out: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful > modprobe-2560 [001] d..1 35.603104: dwc3_gadget_ep_cmd: ep1in: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful > modprobe-2560 [001] d..1 35.603195: dwc3_gadget_ep_cmd: ep2out: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful > modprobe-2560 [001] d..1 35.603286: dwc3_gadget_ep_cmd: ep2in: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful > modprobe-2560 [001] d..1 35.603378: dwc3_gadget_ep_cmd: ep3out: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful > modprobe-2560 [001] d..1 35.603470: dwc3_gadget_ep_cmd: ep3in: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful > modprobe-2560 [001] d..1 35.603561: dwc3_gadget_ep_cmd: ep4out: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful > modprobe-2560 [001] d..1 35.603652: dwc3_gadget_ep_cmd: ep4in: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful > modprobe-2560 [001] d..1 35.603744: dwc3_gadget_ep_cmd: ep5out: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful > modprobe-2560 [001] d..1 35.603836: dwc3_gadget_ep_cmd: ep5in: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful > modprobe-2560 [001] d..1 35.603927: dwc3_gadget_ep_cmd: ep6out: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful > modprobe-2560 [001] d..1 35.604018: dwc3_gadget_ep_cmd: ep6in: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful > modprobe-2560 [001] d..1 35.604110: dwc3_gadget_ep_cmd: ep7out: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful > modprobe-2560 [001] d..1 35.604202: dwc3_gadget_ep_cmd: ep7in: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful > modprobe-2560 [001] d..1 35.604294: dwc3_gadget_ep_cmd: ep8out: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful > modprobe-2560 [001] d..1 35.604386: dwc3_gadget_ep_cmd: ep8in: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful > modprobe-2560 [001] d..1 35.604477: dwc3_gadget_ep_cmd: ep9out: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful > modprobe-2560 [001] d..1 35.604568: dwc3_gadget_ep_cmd: ep9in: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful > modprobe-2560 [001] d..1 35.604660: dwc3_gadget_ep_cmd: ep10out: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful > modprobe-2560 [001] d..1 35.604751: dwc3_gadget_ep_cmd: ep10in: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful > modprobe-2560 [001] d..1 35.604843: dwc3_gadget_ep_cmd: ep11out: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful > modprobe-2560 [001] d..1 35.604934: dwc3_gadget_ep_cmd: ep11in: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful > modprobe-2560 [001] d..1 35.605026: dwc3_gadget_ep_cmd: ep12out: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful > modprobe-2560 [001] d..1 35.605117: dwc3_gadget_ep_cmd: ep12in: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful > modprobe-2560 [001] d..1 35.605209: dwc3_gadget_ep_cmd: ep13out: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful > modprobe-2560 [001] d..1 35.605301: dwc3_gadget_ep_cmd: ep13in: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful > modprobe-2560 [001] d..1 35.605392: dwc3_gadget_ep_cmd: ep14out: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful > modprobe-2560 [001] d..1 35.605483: dwc3_gadget_ep_cmd: ep14in: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful > modprobe-2560 [001] d..1 35.605575: dwc3_gadget_ep_cmd: ep15out: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful > modprobe-2560 [001] d..1 35.605667: dwc3_gadget_ep_cmd: ep15in: cmd 'Set Endpoint Transfer Resource' [1026] params 00000001 00000000 00000000 --> status: Successful > modprobe-2560 [001] d..1 35.605941: dwc3_gadget_ep_cmd: ep0out: cmd 'Set Endpoint Configuration' [1025] params 00001000 00000500 00000000 --> status: Successful > modprobe-2560 [001] d..1 35.605944: dwc3_gadget: Enabling ep0in > modprobe-2560 [001] d..1 35.606216: dwc3_gadget_ep_cmd: ep0in: cmd 'Set Endpoint Configuration' [1025] params 00001000 02000500 00000000 --> status: Successful > modprobe-2560 [001] d..1 35.606219: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 8 ctrl 00000c23 (HLcs:SC:setup) > modprobe-2560 [001] d..1 35.606222: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful > v4l_id-2582 [001] d..2 35.607976: dwc3_gadget: gadget g_webcam data soft-connect > v4l_id-2582 [001] d..2 35.608042: dwc3_gadget: gadget g_webcam data soft-disconnect > uvc-gadget-2598 [003] d..2 58.206076: dwc3_gadget: gadget g_webcam data soft-connect > irq/17-dwc3-2578 [001] d..1 58.412564: dwc3_event: event (00000101): Reset [U0] > irq/17-dwc3-2578 [001] d..1 58.469611: dwc3_event: event (00000201): Connection Done [U0] > irq/17-dwc3-2578 [001] d..1 58.469622: dwc3_gadget: Enabling ep0out > irq/17-dwc3-2578 [001] d..1 58.469626: dwc3_gadget_ep_cmd: ep0out: cmd 'Set Endpoint Configuration' [1025] params 80000200 00000500 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.469628: dwc3_gadget: Enabling ep0in > irq/17-dwc3-2578 [001] d..1 58.469632: dwc3_gadget_ep_cmd: ep0in: cmd 'Set Endpoint Configuration' [1025] params 80000200 02000500 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.568509: dwc3_event: event (0000c040): ep0out: Transfer Complete > irq/17-dwc3-2578 [001] d..1 58.568512: dwc3_ep0: ep0out: Transfer Complete: state 'Setup Phase' > irq/17-dwc3-2578 [001] d..1 58.568513: dwc3_ep0: Setup Phase > irq/17-dwc3-2578 [001] d..1 58.568514: dwc3_ctrl_req: bRequestType 80 bRequest 06 wValue 0100 wIndex 0000 wLength 64 > irq/17-dwc3-2578 [001] d..1 58.568515: dwc3_ep0: Forwarding to gadget driver > irq/17-dwc3-2578 [001] d..1 58.568518: dwc3_ep0: queueing request ffff88016c03ad80 to ep0out length 18 state 'Setup Phase' > irq/17-dwc3-2578 [001] d..1 58.568521: dwc3_prepare_trb: ep0in: 0/0 trb ffff880084c02000 buf 000000008025e000 size 18 ctrl 00000c53 (HLcs:SC:data) > irq/17-dwc3-2578 [001] d..1 58.568531: dwc3_gadget_ep_cmd: ep0in: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.568534: dwc3_event: event (000010c2): ep0in: Transfer Not Ready (Not Active) > irq/17-dwc3-2578 [001] d..1 58.568535: dwc3_ep0: ep0in: Transfer Not Ready (Not Active): state 'Data Phase' > irq/17-dwc3-2578 [001] d..1 58.568536: dwc3_ep0: Control Data > irq/17-dwc3-2578 [001] d..1 58.568641: dwc3_event: event (0000c042): ep0in: Transfer Complete > irq/17-dwc3-2578 [001] d..1 58.568642: dwc3_ep0: ep0in: Transfer Complete: state 'Data Phase' > irq/17-dwc3-2578 [001] d..1 58.568642: dwc3_ep0: Data Phase > irq/17-dwc3-2578 [001] d..1 58.568643: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 000000008025e000 size 0 ctrl 00000c52 (hLcs:SC:data) > irq/17-dwc3-2578 [001] d..1 58.568644: dwc3_gadget_giveback: ep0out: req ffff88016c03ad80 length 18/18 ZsI ==> 0 > irq/17-dwc3-2578 [001] d..1 58.568645: dwc3_event: event (000020c0): ep0out: Transfer Not Ready (Not Active) > irq/17-dwc3-2578 [001] d..1 58.568645: dwc3_ep0: ep0out: Transfer Not Ready (Not Active): state 'Data Phase' > irq/17-dwc3-2578 [001] d..1 58.568646: dwc3_ep0: Control Status > irq/17-dwc3-2578 [001] d..1 58.568646: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c43 (HLcs:SC:status3) > irq/17-dwc3-2578 [001] d..1 58.568653: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.568790: dwc3_event: event (0000c040): ep0out: Transfer Complete > irq/17-dwc3-2578 [001] d..1 58.568792: dwc3_ep0: ep0out: Transfer Complete: state 'Status Phase' > irq/17-dwc3-2578 [001] d..1 58.568793: dwc3_ep0: Status Phase > irq/17-dwc3-2578 [001] d..1 58.568793: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c42 (hLcs:SC:status3) > irq/17-dwc3-2578 [001] d..1 58.568794: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 8 ctrl 00000c23 (HLcs:SC:setup) > irq/17-dwc3-2578 [001] d..1 58.568798: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.572389: dwc3_event: event (00000101): Reset [U0] > irq/17-dwc3-2578 [001] d..1 58.625961: dwc3_event: event (00000201): Connection Done [U0] > irq/17-dwc3-2578 [001] d..1 58.625970: dwc3_gadget: Enabling ep0out > irq/17-dwc3-2578 [001] d..1 58.625975: dwc3_gadget_ep_cmd: ep0out: cmd 'Set Endpoint Configuration' [1025] params 80000200 00000500 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.625976: dwc3_gadget: Enabling ep0in > irq/17-dwc3-2578 [001] d..1 58.625980: dwc3_gadget_ep_cmd: ep0in: cmd 'Set Endpoint Configuration' [1025] params 80000200 02000500 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.724491: dwc3_event: event (0000c040): ep0out: Transfer Complete > irq/17-dwc3-2578 [001] d..1 58.724495: dwc3_ep0: ep0out: Transfer Complete: state 'Setup Phase' > irq/17-dwc3-2578 [001] d..1 58.724495: dwc3_ep0: Setup Phase > irq/17-dwc3-2578 [001] d..1 58.724496: dwc3_ctrl_req: bRequestType 00 bRequest 05 wValue 0004 wIndex 0000 wLength 0 > irq/17-dwc3-2578 [001] d..1 58.724497: dwc3_ep0: USB_REQ_SET_ADDRESS > irq/17-dwc3-2578 [001] d..1 58.724501: dwc3_event: event (000020c2): ep0in: Transfer Not Ready (Not Active) > irq/17-dwc3-2578 [001] d..1 58.724502: dwc3_ep0: ep0in: Transfer Not Ready (Not Active): state 'Setup Phase' > irq/17-dwc3-2578 [001] d..1 58.724503: dwc3_ep0: Control Status > irq/17-dwc3-2578 [001] d..1 58.724504: dwc3_prepare_trb: ep0in: 0/0 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c33 (HLcs:SC:status2) > irq/17-dwc3-2578 [001] d..1 58.724508: dwc3_gadget_ep_cmd: ep0in: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.724622: dwc3_event: event (0000c042): ep0in: Transfer Complete > irq/17-dwc3-2578 [001] d..1 58.724624: dwc3_ep0: ep0in: Transfer Complete: state 'Status Phase' > irq/17-dwc3-2578 [001] d..1 58.724625: dwc3_ep0: Status Phase > irq/17-dwc3-2578 [001] d..1 58.724625: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c32 (hLcs:SC:status2) > irq/17-dwc3-2578 [001] d..1 58.724626: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 8 ctrl 00000c23 (HLcs:SC:setup) > irq/17-dwc3-2578 [001] d..1 58.724630: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.736479: dwc3_event: event (0000c040): ep0out: Transfer Complete > irq/17-dwc3-2578 [001] d..1 58.736481: dwc3_ep0: ep0out: Transfer Complete: state 'Setup Phase' > irq/17-dwc3-2578 [001] d..1 58.736481: dwc3_ep0: Setup Phase > irq/17-dwc3-2578 [001] d..1 58.736482: dwc3_ctrl_req: bRequestType 80 bRequest 06 wValue 0100 wIndex 0000 wLength 18 > irq/17-dwc3-2578 [001] d..1 58.736482: dwc3_ep0: Forwarding to gadget driver > irq/17-dwc3-2578 [001] d..1 58.736484: dwc3_ep0: queueing request ffff88016c03ad80 to ep0out length 18 state 'Setup Phase' > irq/17-dwc3-2578 [001] d..1 58.736487: dwc3_prepare_trb: ep0in: 0/0 trb ffff880084c02000 buf 000000008025e800 size 18 ctrl 00000c53 (HLcs:SC:data) > irq/17-dwc3-2578 [001] d..1 58.736498: dwc3_gadget_ep_cmd: ep0in: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.736500: dwc3_event: event (000010c2): ep0in: Transfer Not Ready (Not Active) > irq/17-dwc3-2578 [001] d..1 58.736501: dwc3_ep0: ep0in: Transfer Not Ready (Not Active): state 'Data Phase' > irq/17-dwc3-2578 [001] d..1 58.736502: dwc3_ep0: Control Data > irq/17-dwc3-2578 [001] d..1 58.736606: dwc3_event: event (0000c042): ep0in: Transfer Complete > irq/17-dwc3-2578 [001] d..1 58.736608: dwc3_ep0: ep0in: Transfer Complete: state 'Data Phase' > irq/17-dwc3-2578 [001] d..1 58.736608: dwc3_ep0: Data Phase > irq/17-dwc3-2578 [001] d..1 58.736609: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 000000008025e800 size 0 ctrl 00000c52 (hLcs:SC:data) > irq/17-dwc3-2578 [001] d..1 58.736610: dwc3_gadget_giveback: ep0out: req ffff88016c03ad80 length 18/18 zsI ==> 0 > irq/17-dwc3-2578 [001] d..1 58.736611: dwc3_event: event (000020c0): ep0out: Transfer Not Ready (Not Active) > irq/17-dwc3-2578 [001] d..1 58.736611: dwc3_ep0: ep0out: Transfer Not Ready (Not Active): state 'Data Phase' > irq/17-dwc3-2578 [001] d..1 58.736612: dwc3_ep0: Control Status > irq/17-dwc3-2578 [001] d..1 58.736612: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c43 (HLcs:SC:status3) > irq/17-dwc3-2578 [001] d..1 58.736620: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.736750: dwc3_event: event (0000c040): ep0out: Transfer Complete > irq/17-dwc3-2578 [001] d..1 58.736751: dwc3_ep0: ep0out: Transfer Complete: state 'Status Phase' > irq/17-dwc3-2578 [001] d..1 58.736752: dwc3_ep0: Status Phase > irq/17-dwc3-2578 [001] d..1 58.736752: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c42 (hLcs:SC:status3) > irq/17-dwc3-2578 [001] d..1 58.736753: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 8 ctrl 00000c23 (HLcs:SC:setup) > irq/17-dwc3-2578 [001] d..1 58.736757: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.736851: dwc3_event: event (0000c040): ep0out: Transfer Complete > irq/17-dwc3-2578 [001] d..1 58.736853: dwc3_ep0: ep0out: Transfer Complete: state 'Setup Phase' > irq/17-dwc3-2578 [001] d..1 58.736854: dwc3_ep0: Setup Phase > irq/17-dwc3-2578 [001] d..1 58.736854: dwc3_ctrl_req: bRequestType 80 bRequest 06 wValue 0f00 wIndex 0000 wLength 5 > irq/17-dwc3-2578 [001] d..1 58.736855: dwc3_ep0: Forwarding to gadget driver > irq/17-dwc3-2578 [001] d..1 58.736856: dwc3_ep0: queueing request ffff88016c03ad80 to ep0out length 5 state 'Setup Phase' > irq/17-dwc3-2578 [001] d..1 58.736858: dwc3_prepare_trb: ep0in: 0/0 trb ffff880084c02000 buf 000000008025f000 size 5 ctrl 00000c53 (HLcs:SC:data) > irq/17-dwc3-2578 [001] d..1 58.736867: dwc3_gadget_ep_cmd: ep0in: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.736870: dwc3_event: event (000010c2): ep0in: Transfer Not Ready (Not Active) > irq/17-dwc3-2578 [001] d..1 58.736870: dwc3_ep0: ep0in: Transfer Not Ready (Not Active): state 'Data Phase' > irq/17-dwc3-2578 [001] d..1 58.736871: dwc3_ep0: Control Data > irq/17-dwc3-2578 [001] d..1 58.736979: dwc3_event: event (0000c042): ep0in: Transfer Complete > irq/17-dwc3-2578 [001] d..1 58.736980: dwc3_ep0: ep0in: Transfer Complete: state 'Data Phase' > irq/17-dwc3-2578 [001] d..1 58.736981: dwc3_ep0: Data Phase > irq/17-dwc3-2578 [001] d..1 58.736981: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 000000008025f000 size 0 ctrl 00000c52 (hLcs:SC:data) > irq/17-dwc3-2578 [001] d..1 58.736982: dwc3_gadget_giveback: ep0out: req ffff88016c03ad80 length 5/5 zsI ==> 0 > irq/17-dwc3-2578 [001] d..1 58.736983: dwc3_event: event (000020c0): ep0out: Transfer Not Ready (Not Active) > irq/17-dwc3-2578 [001] d..1 58.736983: dwc3_ep0: ep0out: Transfer Not Ready (Not Active): state 'Data Phase' > irq/17-dwc3-2578 [001] d..1 58.736984: dwc3_ep0: Control Status > irq/17-dwc3-2578 [001] d..1 58.736985: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c43 (HLcs:SC:status3) > irq/17-dwc3-2578 [001] d..1 58.736992: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.737131: dwc3_event: event (0000c040): ep0out: Transfer Complete > irq/17-dwc3-2578 [001] d..1 58.737133: dwc3_ep0: ep0out: Transfer Complete: state 'Status Phase' > irq/17-dwc3-2578 [001] d..1 58.737134: dwc3_ep0: Status Phase > irq/17-dwc3-2578 [001] d..1 58.737134: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c42 (hLcs:SC:status3) > irq/17-dwc3-2578 [001] d..1 58.737135: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 8 ctrl 00000c23 (HLcs:SC:setup) > irq/17-dwc3-2578 [001] d..1 58.737142: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.737208: dwc3_event: event (0000c040): ep0out: Transfer Complete > irq/17-dwc3-2578 [001] d..1 58.737208: dwc3_ep0: ep0out: Transfer Complete: state 'Setup Phase' > irq/17-dwc3-2578 [001] d..1 58.737209: dwc3_ep0: Setup Phase > irq/17-dwc3-2578 [001] d..1 58.737209: dwc3_ctrl_req: bRequestType 80 bRequest 06 wValue 0f00 wIndex 0000 wLength 22 > irq/17-dwc3-2578 [001] d..1 58.737210: dwc3_ep0: Forwarding to gadget driver > irq/17-dwc3-2578 [001] d..1 58.737211: dwc3_ep0: queueing request ffff88016c03ad80 to ep0out length 22 state 'Setup Phase' > irq/17-dwc3-2578 [001] d..1 58.737213: dwc3_prepare_trb: ep0in: 0/0 trb ffff880084c02000 buf 000000008025f800 size 22 ctrl 00000c53 (HLcs:SC:data) > irq/17-dwc3-2578 [001] d..1 58.737221: dwc3_gadget_ep_cmd: ep0in: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.737223: dwc3_event: event (000010c2): ep0in: Transfer Not Ready (Not Active) > irq/17-dwc3-2578 [001] d..1 58.737224: dwc3_ep0: ep0in: Transfer Not Ready (Not Active): state 'Data Phase' > irq/17-dwc3-2578 [001] d..1 58.737225: dwc3_ep0: Control Data > irq/17-dwc3-2578 [001] d..1 58.737299: dwc3_event: event (0000c042): ep0in: Transfer Complete > irq/17-dwc3-2578 [001] d..1 58.737299: dwc3_ep0: ep0in: Transfer Complete: state 'Data Phase' > irq/17-dwc3-2578 [001] d..1 58.737300: dwc3_ep0: Data Phase > irq/17-dwc3-2578 [001] d..1 58.737300: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 000000008025f800 size 0 ctrl 00000c52 (hLcs:SC:data) > irq/17-dwc3-2578 [001] d..1 58.737301: dwc3_gadget_giveback: ep0out: req ffff88016c03ad80 length 22/22 zsI ==> 0 > irq/17-dwc3-2578 [001] d..1 58.737301: dwc3_event: event (000020c0): ep0out: Transfer Not Ready (Not Active) > irq/17-dwc3-2578 [001] d..1 58.737302: dwc3_ep0: ep0out: Transfer Not Ready (Not Active): state 'Data Phase' > irq/17-dwc3-2578 [001] d..1 58.737302: dwc3_ep0: Control Status > irq/17-dwc3-2578 [001] d..1 58.737303: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c43 (HLcs:SC:status3) > irq/17-dwc3-2578 [001] d..1 58.737306: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.737411: dwc3_event: event (0000c040): ep0out: Transfer Complete > irq/17-dwc3-2578 [001] d..1 58.737412: dwc3_ep0: ep0out: Transfer Complete: state 'Status Phase' > irq/17-dwc3-2578 [001] d..1 58.737412: dwc3_ep0: Status Phase > irq/17-dwc3-2578 [001] d..1 58.737412: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c42 (hLcs:SC:status3) > irq/17-dwc3-2578 [001] d..1 58.737413: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 8 ctrl 00000c23 (HLcs:SC:setup) > irq/17-dwc3-2578 [001] d..1 58.737416: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.737501: dwc3_event: event (0000c040): ep0out: Transfer Complete > irq/17-dwc3-2578 [001] d..1 58.737502: dwc3_ep0: ep0out: Transfer Complete: state 'Setup Phase' > irq/17-dwc3-2578 [001] d..1 58.737502: dwc3_ep0: Setup Phase > irq/17-dwc3-2578 [001] d..1 58.737502: dwc3_ctrl_req: bRequestType 80 bRequest 06 wValue 0200 wIndex 0000 wLength 9 > irq/17-dwc3-2578 [001] d..1 58.737502: dwc3_ep0: Forwarding to gadget driver > irq/17-dwc3-2578 [001] d..1 58.737504: dwc3_ep0: queueing request ffff88016c03ad80 to ep0out length 9 state 'Setup Phase' > irq/17-dwc3-2578 [001] d..1 58.737505: dwc3_prepare_trb: ep0in: 0/0 trb ffff880084c02000 buf 0000000080260000 size 9 ctrl 00000c53 (HLcs:SC:data) > irq/17-dwc3-2578 [001] d..1 58.737514: dwc3_gadget_ep_cmd: ep0in: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.737516: dwc3_event: event (000010c2): ep0in: Transfer Not Ready (Not Active) > irq/17-dwc3-2578 [001] d..1 58.737516: dwc3_ep0: ep0in: Transfer Not Ready (Not Active): state 'Data Phase' > irq/17-dwc3-2578 [001] d..1 58.737517: dwc3_ep0: Control Data > irq/17-dwc3-2578 [001] d..1 58.737589: dwc3_event: event (0000c042): ep0in: Transfer Complete > irq/17-dwc3-2578 [001] d..1 58.737589: dwc3_ep0: ep0in: Transfer Complete: state 'Data Phase' > irq/17-dwc3-2578 [001] d..1 58.737590: dwc3_ep0: Data Phase > irq/17-dwc3-2578 [001] d..1 58.737590: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000080260000 size 0 ctrl 00000c52 (hLcs:SC:data) > irq/17-dwc3-2578 [001] d..1 58.737590: dwc3_gadget_giveback: ep0out: req ffff88016c03ad80 length 9/9 zsI ==> 0 > irq/17-dwc3-2578 [001] d..1 58.737591: dwc3_event: event (000020c0): ep0out: Transfer Not Ready (Not Active) > irq/17-dwc3-2578 [001] d..1 58.737591: dwc3_ep0: ep0out: Transfer Not Ready (Not Active): state 'Data Phase' > irq/17-dwc3-2578 [001] d..1 58.737591: dwc3_ep0: Control Status > irq/17-dwc3-2578 [001] d..1 58.737592: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c43 (HLcs:SC:status3) > irq/17-dwc3-2578 [001] d..1 58.737596: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.737682: dwc3_event: event (0000c040): ep0out: Transfer Complete > irq/17-dwc3-2578 [001] d..1 58.737683: dwc3_ep0: ep0out: Transfer Complete: state 'Status Phase' > irq/17-dwc3-2578 [001] d..1 58.737683: dwc3_ep0: Status Phase > irq/17-dwc3-2578 [001] d..1 58.737683: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c42 (hLcs:SC:status3) > irq/17-dwc3-2578 [001] d..1 58.737684: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 8 ctrl 00000c23 (HLcs:SC:setup) > irq/17-dwc3-2578 [001] d..1 58.737688: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.737750: dwc3_event: event (0000c040): ep0out: Transfer Complete > irq/17-dwc3-2578 [001] d..1 58.737751: dwc3_ep0: ep0out: Transfer Complete: state 'Setup Phase' > irq/17-dwc3-2578 [001] d..1 58.737751: dwc3_ep0: Setup Phase > irq/17-dwc3-2578 [001] d..1 58.737751: dwc3_ctrl_req: bRequestType 80 bRequest 06 wValue 0200 wIndex 0000 wLength 309 > irq/17-dwc3-2578 [001] d..1 58.737751: dwc3_ep0: Forwarding to gadget driver > irq/17-dwc3-2578 [001] d..1 58.737752: dwc3_ep0: queueing request ffff88016c03ad80 to ep0out length 309 state 'Setup Phase' > irq/17-dwc3-2578 [001] d..1 58.737753: dwc3_prepare_trb: ep0in: 0/0 trb ffff880084c02000 buf 0000000080260800 size 309 ctrl 00000c53 (HLcs:SC:data) > irq/17-dwc3-2578 [001] d..1 58.737763: dwc3_gadget_ep_cmd: ep0in: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.737765: dwc3_event: event (000010c2): ep0in: Transfer Not Ready (Not Active) > irq/17-dwc3-2578 [001] d..1 58.737765: dwc3_ep0: ep0in: Transfer Not Ready (Not Active): state 'Data Phase' > irq/17-dwc3-2578 [001] d..1 58.737766: dwc3_ep0: Control Data > irq/17-dwc3-2578 [001] d..1 58.737846: dwc3_event: event (0000c042): ep0in: Transfer Complete > irq/17-dwc3-2578 [001] d..1 58.737846: dwc3_ep0: ep0in: Transfer Complete: state 'Data Phase' > irq/17-dwc3-2578 [001] d..1 58.737846: dwc3_ep0: Data Phase > irq/17-dwc3-2578 [001] d..1 58.737846: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000080260800 size 0 ctrl 00000c52 (hLcs:SC:data) > irq/17-dwc3-2578 [001] d..1 58.737847: dwc3_gadget_giveback: ep0out: req ffff88016c03ad80 length 309/309 zsI ==> 0 > irq/17-dwc3-2578 [001] d..1 58.737847: dwc3_event: event (000020c0): ep0out: Transfer Not Ready (Not Active) > irq/17-dwc3-2578 [001] d..1 58.737848: dwc3_ep0: ep0out: Transfer Not Ready (Not Active): state 'Data Phase' > irq/17-dwc3-2578 [001] d..1 58.737848: dwc3_ep0: Control Status > irq/17-dwc3-2578 [001] d..1 58.737848: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c43 (HLcs:SC:status3) > irq/17-dwc3-2578 [001] d..1 58.737852: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.737917: dwc3_event: event (0000c040): ep0out: Transfer Complete > irq/17-dwc3-2578 [001] d..1 58.737917: dwc3_ep0: ep0out: Transfer Complete: state 'Status Phase' > irq/17-dwc3-2578 [001] d..1 58.737917: dwc3_ep0: Status Phase > irq/17-dwc3-2578 [001] d..1 58.737918: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c42 (hLcs:SC:status3) > irq/17-dwc3-2578 [001] d..1 58.737918: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 8 ctrl 00000c23 (HLcs:SC:setup) > irq/17-dwc3-2578 [001] d..1 58.737922: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.737985: dwc3_event: event (0000c040): ep0out: Transfer Complete > irq/17-dwc3-2578 [001] d..1 58.737985: dwc3_ep0: ep0out: Transfer Complete: state 'Setup Phase' > irq/17-dwc3-2578 [001] d..1 58.737986: dwc3_ep0: Setup Phase > irq/17-dwc3-2578 [001] d..1 58.737986: dwc3_ctrl_req: bRequestType 80 bRequest 06 wValue 0300 wIndex 0000 wLength 255 > irq/17-dwc3-2578 [001] d..1 58.737986: dwc3_ep0: Forwarding to gadget driver > irq/17-dwc3-2578 [001] d..1 58.737986: dwc3_ep0: queueing request ffff88016c03ad80 to ep0out length 4 state 'Setup Phase' > irq/17-dwc3-2578 [001] d..1 58.737987: dwc3_prepare_trb: ep0in: 0/0 trb ffff880084c02000 buf 0000000080261000 size 4 ctrl 00000c53 (HLcs:SC:data) > irq/17-dwc3-2578 [001] d..1 58.737991: dwc3_gadget_ep_cmd: ep0in: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.737993: dwc3_event: event (000010c2): ep0in: Transfer Not Ready (Not Active) > irq/17-dwc3-2578 [001] d..1 58.737994: dwc3_ep0: ep0in: Transfer Not Ready (Not Active): state 'Data Phase' > irq/17-dwc3-2578 [001] d..1 58.737994: dwc3_ep0: Control Data > irq/17-dwc3-2578 [001] d..1 58.738069: dwc3_event: event (0000c042): ep0in: Transfer Complete > irq/17-dwc3-2578 [001] d..1 58.738069: dwc3_ep0: ep0in: Transfer Complete: state 'Data Phase' > irq/17-dwc3-2578 [001] d..1 58.738069: dwc3_ep0: Data Phase > irq/17-dwc3-2578 [001] d..1 58.738070: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000080261000 size 0 ctrl 00000c52 (hLcs:SC:data) > irq/17-dwc3-2578 [001] d..1 58.738070: dwc3_gadget_giveback: ep0out: req ffff88016c03ad80 length 4/4 ZsI ==> 0 > irq/17-dwc3-2578 [001] d..1 58.738071: dwc3_event: event (000020c0): ep0out: Transfer Not Ready (Not Active) > irq/17-dwc3-2578 [001] d..1 58.738071: dwc3_ep0: ep0out: Transfer Not Ready (Not Active): state 'Data Phase' > irq/17-dwc3-2578 [001] d..1 58.738071: dwc3_ep0: Control Status > irq/17-dwc3-2578 [001] d..1 58.738072: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c43 (HLcs:SC:status3) > irq/17-dwc3-2578 [001] d..1 58.738075: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.738180: dwc3_event: event (0000c040): ep0out: Transfer Complete > irq/17-dwc3-2578 [001] d..1 58.738181: dwc3_ep0: ep0out: Transfer Complete: state 'Status Phase' > irq/17-dwc3-2578 [001] d..1 58.738181: dwc3_ep0: Status Phase > irq/17-dwc3-2578 [001] d..1 58.738181: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c42 (hLcs:SC:status3) > irq/17-dwc3-2578 [001] d..1 58.738181: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 8 ctrl 00000c23 (HLcs:SC:setup) > irq/17-dwc3-2578 [001] d..1 58.738185: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.738248: dwc3_event: event (0000c040): ep0out: Transfer Complete > irq/17-dwc3-2578 [001] d..1 58.738248: dwc3_ep0: ep0out: Transfer Complete: state 'Setup Phase' > irq/17-dwc3-2578 [001] d..1 58.738249: dwc3_ep0: Setup Phase > irq/17-dwc3-2578 [001] d..1 58.738249: dwc3_ctrl_req: bRequestType 80 bRequest 06 wValue 0302 wIndex 0409 wLength 255 > irq/17-dwc3-2578 [001] d..1 58.738249: dwc3_ep0: Forwarding to gadget driver > irq/17-dwc3-2578 [001] d..1 58.738250: dwc3_ep0: queueing request ffff88016c03ad80 to ep0out length 28 state 'Setup Phase' > irq/17-dwc3-2578 [001] d..1 58.738251: dwc3_prepare_trb: ep0in: 0/0 trb ffff880084c02000 buf 0000000080261800 size 28 ctrl 00000c53 (HLcs:SC:data) > irq/17-dwc3-2578 [001] d..1 58.738255: dwc3_gadget_ep_cmd: ep0in: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.738257: dwc3_event: event (000010c2): ep0in: Transfer Not Ready (Not Active) > irq/17-dwc3-2578 [001] d..1 58.738257: dwc3_ep0: ep0in: Transfer Not Ready (Not Active): state 'Data Phase' > irq/17-dwc3-2578 [001] d..1 58.738258: dwc3_ep0: Control Data > irq/17-dwc3-2578 [001] d..1 58.738335: dwc3_event: event (0000c042): ep0in: Transfer Complete > irq/17-dwc3-2578 [001] d..1 58.738336: dwc3_ep0: ep0in: Transfer Complete: state 'Data Phase' > irq/17-dwc3-2578 [001] d..1 58.738336: dwc3_ep0: Data Phase > irq/17-dwc3-2578 [001] d..1 58.738336: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000080261800 size 0 ctrl 00000c52 (hLcs:SC:data) > irq/17-dwc3-2578 [001] d..1 58.738337: dwc3_gadget_giveback: ep0out: req ffff88016c03ad80 length 28/28 ZsI ==> 0 > irq/17-dwc3-2578 [001] d..1 58.738337: dwc3_event: event (000020c0): ep0out: Transfer Not Ready (Not Active) > irq/17-dwc3-2578 [001] d..1 58.738338: dwc3_ep0: ep0out: Transfer Not Ready (Not Active): state 'Data Phase' > irq/17-dwc3-2578 [001] d..1 58.738338: dwc3_ep0: Control Status > irq/17-dwc3-2578 [001] d..1 58.738338: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c43 (HLcs:SC:status3) > irq/17-dwc3-2578 [001] d..1 58.738342: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.738423: dwc3_event: event (0000c040): ep0out: Transfer Complete > irq/17-dwc3-2578 [001] d..1 58.738423: dwc3_ep0: ep0out: Transfer Complete: state 'Status Phase' > irq/17-dwc3-2578 [001] d..1 58.738424: dwc3_ep0: Status Phase > irq/17-dwc3-2578 [001] d..1 58.738424: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c42 (hLcs:SC:status3) > irq/17-dwc3-2578 [001] d..1 58.738425: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 8 ctrl 00000c23 (HLcs:SC:setup) > irq/17-dwc3-2578 [001] d..1 58.738428: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.738491: dwc3_event: event (0000c040): ep0out: Transfer Complete > irq/17-dwc3-2578 [001] d..1 58.738491: dwc3_ep0: ep0out: Transfer Complete: state 'Setup Phase' > irq/17-dwc3-2578 [001] d..1 58.738492: dwc3_ep0: Setup Phase > irq/17-dwc3-2578 [001] d..1 58.738492: dwc3_ctrl_req: bRequestType 80 bRequest 06 wValue 0301 wIndex 0409 wLength 255 > irq/17-dwc3-2578 [001] d..1 58.738492: dwc3_ep0: Forwarding to gadget driver > irq/17-dwc3-2578 [001] d..1 58.738493: dwc3_ep0: queueing request ffff88016c03ad80 to ep0out length 34 state 'Setup Phase' > irq/17-dwc3-2578 [001] d..1 58.738494: dwc3_prepare_trb: ep0in: 0/0 trb ffff880084c02000 buf 0000000080262000 size 34 ctrl 00000c53 (HLcs:SC:data) > irq/17-dwc3-2578 [001] d..1 58.738498: dwc3_gadget_ep_cmd: ep0in: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.738500: dwc3_event: event (000010c2): ep0in: Transfer Not Ready (Not Active) > irq/17-dwc3-2578 [001] d..1 58.738500: dwc3_ep0: ep0in: Transfer Not Ready (Not Active): state 'Data Phase' > irq/17-dwc3-2578 [001] d..1 58.738501: dwc3_ep0: Control Data > irq/17-dwc3-2578 [001] d..1 58.738561: dwc3_event: event (000090c2): ep0in: Transfer Not Ready (Active) > irq/17-dwc3-2578 [001] d..1 58.738562: dwc3_ep0: ep0in: Transfer Not Ready (Active): state 'Data Phase' > irq/17-dwc3-2578 [001] d..1 58.738562: dwc3_event: event (0000c042): ep0in: Transfer Complete > irq/17-dwc3-2578 [001] d..1 58.738563: dwc3_ep0: ep0in: Transfer Complete: state 'Data Phase' > irq/17-dwc3-2578 [001] d..1 58.738563: dwc3_ep0: Data Phase > irq/17-dwc3-2578 [001] d..1 58.738563: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000080262000 size 0 ctrl 00000c52 (hLcs:SC:data) > irq/17-dwc3-2578 [001] d..1 58.738564: dwc3_gadget_giveback: ep0out: req ffff88016c03ad80 length 34/34 ZsI ==> 0 > irq/17-dwc3-2578 [001] d..1 58.738564: dwc3_event: event (000020c0): ep0out: Transfer Not Ready (Not Active) > irq/17-dwc3-2578 [001] d..1 58.738564: dwc3_ep0: ep0out: Transfer Not Ready (Not Active): state 'Data Phase' > irq/17-dwc3-2578 [001] d..1 58.738565: dwc3_ep0: Control Status > irq/17-dwc3-2578 [001] d..1 58.738565: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c43 (HLcs:SC:status3) > irq/17-dwc3-2578 [001] d..1 58.738569: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.738674: dwc3_event: event (0000c040): ep0out: Transfer Complete > irq/17-dwc3-2578 [001] d..1 58.738675: dwc3_ep0: ep0out: Transfer Complete: state 'Status Phase' > irq/17-dwc3-2578 [001] d..1 58.738675: dwc3_ep0: Status Phase > irq/17-dwc3-2578 [001] d..1 58.738676: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c42 (hLcs:SC:status3) > irq/17-dwc3-2578 [001] d..1 58.738676: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 8 ctrl 00000c23 (HLcs:SC:setup) > irq/17-dwc3-2578 [001] d..1 58.738680: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.739128: dwc3_event: event (0000c040): ep0out: Transfer Complete > irq/17-dwc3-2578 [001] d..1 58.739129: dwc3_ep0: ep0out: Transfer Complete: state 'Setup Phase' > irq/17-dwc3-2578 [001] d..1 58.739130: dwc3_ep0: Setup Phase > irq/17-dwc3-2578 [001] d..1 58.739130: dwc3_ctrl_req: bRequestType 00 bRequest 09 wValue 0001 wIndex 0000 wLength 0 > irq/17-dwc3-2578 [001] d..1 58.739131: dwc3_ep0: USB_REQ_SET_CONFIGURATION > irq/17-dwc3-2578 [001] d..2 58.739141: dwc3_gadget: Enabling ep1in > irq/17-dwc3-2578 [001] d..2 58.739145: dwc3_gadget_ep_cmd: ep1in: cmd 'Set Endpoint Configuration' [1025] params 00020086 06070200 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.739150: dwc3_ep0: queueing request ffff88016c03ad80 to ep0out length 0 state 'Setup Phase' > irq/17-dwc3-2578 [001] d..1 58.739159: dwc3_event: event (000020c2): ep0in: Transfer Not Ready (Not Active) > irq/17-dwc3-2578 [001] d..1 58.739160: dwc3_ep0: ep0in: Transfer Not Ready (Not Active): state 'Setup Phase' > irq/17-dwc3-2578 [001] d..1 58.739160: dwc3_ep0: Control Status > irq/17-dwc3-2578 [001] d..1 58.739161: dwc3_prepare_trb: ep0in: 0/0 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c33 (HLcs:SC:status2) > irq/17-dwc3-2578 [001] d..1 58.739165: dwc3_gadget_ep_cmd: ep0in: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.739241: dwc3_event: event (0000c042): ep0in: Transfer Complete > irq/17-dwc3-2578 [001] d..1 58.739242: dwc3_ep0: ep0in: Transfer Complete: state 'Status Phase' > irq/17-dwc3-2578 [001] d..1 58.739242: dwc3_ep0: Status Phase > irq/17-dwc3-2578 [001] d..1 58.739243: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c32 (hLcs:SC:status2) > irq/17-dwc3-2578 [001] d..1 58.739244: dwc3_gadget_giveback: ep0out: req ffff88016c03ad80 length 0/0 zsI ==> 0 > irq/17-dwc3-2578 [001] d..1 58.739245: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 8 ctrl 00000c23 (HLcs:SC:setup) > irq/17-dwc3-2578 [001] d..1 58.739248: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.739313: dwc3_event: event (0000c040): ep0out: Transfer Complete > irq/17-dwc3-2578 [001] d..1 58.739314: dwc3_ep0: ep0out: Transfer Complete: state 'Setup Phase' > irq/17-dwc3-2578 [001] d..1 58.739314: dwc3_ep0: Setup Phase > irq/17-dwc3-2578 [001] d..1 58.739315: dwc3_ctrl_req: bRequestType 80 bRequest 06 wValue 0304 wIndex 0409 wLength 255 > irq/17-dwc3-2578 [001] d..1 58.739315: dwc3_ep0: Forwarding to gadget driver > irq/17-dwc3-2578 [001] d..1 58.739316: dwc3_ep0: queueing request ffff88016c03ad80 to ep0out length 12 state 'Setup Phase' > irq/17-dwc3-2578 [001] d..1 58.739318: dwc3_prepare_trb: ep0in: 0/0 trb ffff880084c02000 buf 0000000080262800 size 12 ctrl 00000c53 (HLcs:SC:data) > irq/17-dwc3-2578 [001] d..1 58.739326: dwc3_gadget_ep_cmd: ep0in: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.739329: dwc3_event: event (000010c2): ep0in: Transfer Not Ready (Not Active) > irq/17-dwc3-2578 [001] d..1 58.739330: dwc3_ep0: ep0in: Transfer Not Ready (Not Active): state 'Data Phase' > irq/17-dwc3-2578 [001] d..1 58.739330: dwc3_ep0: Control Data > irq/17-dwc3-2578 [001] d..1 58.739400: dwc3_event: event (0000c042): ep0in: Transfer Complete > irq/17-dwc3-2578 [001] d..1 58.739401: dwc3_ep0: ep0in: Transfer Complete: state 'Data Phase' > irq/17-dwc3-2578 [001] d..1 58.739402: dwc3_ep0: Data Phase > irq/17-dwc3-2578 [001] d..1 58.739402: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000080262800 size 0 ctrl 00000c52 (hLcs:SC:data) > irq/17-dwc3-2578 [001] d..1 58.739403: dwc3_gadget_giveback: ep0out: req ffff88016c03ad80 length 12/12 ZsI ==> 0 > irq/17-dwc3-2578 [001] d..1 58.739404: dwc3_event: event (000020c0): ep0out: Transfer Not Ready (Not Active) > irq/17-dwc3-2578 [001] d..1 58.739405: dwc3_ep0: ep0out: Transfer Not Ready (Not Active): state 'Data Phase' > irq/17-dwc3-2578 [001] d..1 58.739405: dwc3_ep0: Control Status > irq/17-dwc3-2578 [001] d..1 58.739406: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c43 (HLcs:SC:status3) > irq/17-dwc3-2578 [001] d..1 58.739412: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.739509: dwc3_event: event (0000c040): ep0out: Transfer Complete > irq/17-dwc3-2578 [001] d..1 58.739510: dwc3_ep0: ep0out: Transfer Complete: state 'Status Phase' > irq/17-dwc3-2578 [001] d..1 58.739511: dwc3_ep0: Status Phase > irq/17-dwc3-2578 [001] d..1 58.739512: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c42 (hLcs:SC:status3) > irq/17-dwc3-2578 [001] d..1 58.739512: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 8 ctrl 00000c23 (HLcs:SC:setup) > irq/17-dwc3-2578 [001] d..1 58.739516: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.739660: dwc3_event: event (0000c040): ep0out: Transfer Complete > irq/17-dwc3-2578 [001] d..1 58.739661: dwc3_ep0: ep0out: Transfer Complete: state 'Setup Phase' > irq/17-dwc3-2578 [001] d..1 58.739661: dwc3_ep0: Setup Phase > irq/17-dwc3-2578 [001] d..1 58.739662: dwc3_ctrl_req: bRequestType 80 bRequest 06 wValue 0305 wIndex 0409 wLength 255 > irq/17-dwc3-2578 [001] d..1 58.739662: dwc3_ep0: Forwarding to gadget driver > irq/17-dwc3-2578 [001] d..1 58.739664: dwc3_ep0: queueing request ffff88016c03ad80 to ep0out length 22 state 'Setup Phase' > irq/17-dwc3-2578 [001] d..1 58.739666: dwc3_prepare_trb: ep0in: 0/0 trb ffff880084c02000 buf 0000000080263000 size 22 ctrl 00000c53 (HLcs:SC:data) > irq/17-dwc3-2578 [001] d..1 58.739672: dwc3_gadget_ep_cmd: ep0in: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.739674: dwc3_event: event (000010c2): ep0in: Transfer Not Ready (Not Active) > irq/17-dwc3-2578 [001] d..1 58.739675: dwc3_ep0: ep0in: Transfer Not Ready (Not Active): state 'Data Phase' > irq/17-dwc3-2578 [001] d..1 58.739676: dwc3_ep0: Control Data > irq/17-dwc3-2578 [001] d..1 58.739753: dwc3_event: event (0000c042): ep0in: Transfer Complete > irq/17-dwc3-2578 [001] d..1 58.739754: dwc3_ep0: ep0in: Transfer Complete: state 'Data Phase' > irq/17-dwc3-2578 [001] d..1 58.739754: dwc3_ep0: Data Phase > irq/17-dwc3-2578 [001] d..1 58.739755: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000080263000 size 0 ctrl 00000c52 (hLcs:SC:data) > irq/17-dwc3-2578 [001] d..1 58.739756: dwc3_gadget_giveback: ep0out: req ffff88016c03ad80 length 22/22 ZsI ==> 0 > irq/17-dwc3-2578 [001] d..1 58.739757: dwc3_event: event (000020c0): ep0out: Transfer Not Ready (Not Active) > irq/17-dwc3-2578 [001] d..1 58.739757: dwc3_ep0: ep0out: Transfer Not Ready (Not Active): state 'Data Phase' > irq/17-dwc3-2578 [001] d..1 58.739758: dwc3_ep0: Control Status > irq/17-dwc3-2578 [001] d..1 58.739758: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c43 (HLcs:SC:status3) > irq/17-dwc3-2578 [001] d..1 58.739765: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.739863: dwc3_event: event (0000c040): ep0out: Transfer Complete > irq/17-dwc3-2578 [001] d..1 58.739864: dwc3_ep0: ep0out: Transfer Complete: state 'Status Phase' > irq/17-dwc3-2578 [001] d..1 58.739864: dwc3_ep0: Status Phase > irq/17-dwc3-2578 [001] d..1 58.739865: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c42 (hLcs:SC:status3) > irq/17-dwc3-2578 [001] d..1 58.739866: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 8 ctrl 00000c23 (HLcs:SC:setup) > irq/17-dwc3-2578 [001] d..1 58.739870: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.739976: dwc3_event: event (0000c040): ep0out: Transfer Complete > irq/17-dwc3-2578 [001] d..1 58.739981: dwc3_ep0: ep0out: Transfer Complete: state 'Setup Phase' > irq/17-dwc3-2578 [001] d..1 58.739981: dwc3_ep0: Setup Phase > irq/17-dwc3-2578 [001] d..1 58.739984: dwc3_ctrl_req: bRequestType 80 bRequest 06 wValue 0306 wIndex 0409 wLength 255 > irq/17-dwc3-2578 [001] d..1 58.739986: dwc3_ep0: Forwarding to gadget driver > irq/17-dwc3-2578 [001] d..1 58.739987: dwc3_ep0: queueing request ffff88016c03ad80 to ep0out length 32 state 'Setup Phase' > irq/17-dwc3-2578 [001] d..1 58.739989: dwc3_prepare_trb: ep0in: 0/0 trb ffff880084c02000 buf 0000000080263800 size 32 ctrl 00000c53 (HLcs:SC:data) > irq/17-dwc3-2578 [001] d..1 58.740000: dwc3_gadget_ep_cmd: ep0in: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.740002: dwc3_event: event (000010c2): ep0in: Transfer Not Ready (Not Active) > irq/17-dwc3-2578 [001] d..1 58.740003: dwc3_ep0: ep0in: Transfer Not Ready (Not Active): state 'Data Phase' > irq/17-dwc3-2578 [001] d..1 58.740004: dwc3_ep0: Control Data > irq/17-dwc3-2578 [001] d..1 58.740066: dwc3_event: event (000090c2): ep0in: Transfer Not Ready (Active) > irq/17-dwc3-2578 [001] d..1 58.740067: dwc3_ep0: ep0in: Transfer Not Ready (Active): state 'Data Phase' > irq/17-dwc3-2578 [001] d..1 58.740068: dwc3_event: event (0000c042): ep0in: Transfer Complete > irq/17-dwc3-2578 [001] d..1 58.740069: dwc3_ep0: ep0in: Transfer Complete: state 'Data Phase' > irq/17-dwc3-2578 [001] d..1 58.740069: dwc3_ep0: Data Phase > irq/17-dwc3-2578 [001] d..1 58.740070: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000080263800 size 0 ctrl 00000c52 (hLcs:SC:data) > irq/17-dwc3-2578 [001] d..1 58.740071: dwc3_gadget_giveback: ep0out: req ffff88016c03ad80 length 32/32 ZsI ==> 0 > irq/17-dwc3-2578 [001] d..1 58.740071: dwc3_event: event (000020c0): ep0out: Transfer Not Ready (Not Active) > irq/17-dwc3-2578 [001] d..1 58.740072: dwc3_ep0: ep0out: Transfer Not Ready (Not Active): state 'Data Phase' > irq/17-dwc3-2578 [001] d..1 58.740072: dwc3_ep0: Control Status > irq/17-dwc3-2578 [001] d..1 58.740073: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c43 (HLcs:SC:status3) > irq/17-dwc3-2578 [001] d..1 58.740077: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.740177: dwc3_event: event (0000c040): ep0out: Transfer Complete > irq/17-dwc3-2578 [001] d..1 58.740178: dwc3_ep0: ep0out: Transfer Complete: state 'Status Phase' > irq/17-dwc3-2578 [001] d..1 58.740179: dwc3_ep0: Status Phase > irq/17-dwc3-2578 [001] d..1 58.740180: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c42 (hLcs:SC:status3) > irq/17-dwc3-2578 [001] d..1 58.740180: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 8 ctrl 00000c23 (HLcs:SC:setup) > irq/17-dwc3-2578 [001] d..1 58.740189: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.804470: dwc3_event: event (0000c040): ep0out: Transfer Complete > irq/17-dwc3-2578 [001] d..1 58.804473: dwc3_ep0: ep0out: Transfer Complete: state 'Setup Phase' > irq/17-dwc3-2578 [001] d..1 58.804475: dwc3_ep0: Setup Phase > irq/17-dwc3-2578 [001] d..1 58.804475: dwc3_ctrl_req: bRequestType 01 bRequest 0b wValue 0000 wIndex 0001 wLength 0 > irq/17-dwc3-2578 [001] d..1 58.804476: dwc3_ep0: Forwarding to gadget driver > irq/17-dwc3-2578 [001] d..1 58.804482: dwc3_ep0: queueing request ffff88016c03ad80 to ep0out length 0 state 'Setup Phase' > irq/17-dwc3-2578 [001] d..1 58.804486: dwc3_event: event (000020c2): ep0in: Transfer Not Ready (Not Active) > irq/17-dwc3-2578 [001] d..1 58.804487: dwc3_ep0: ep0in: Transfer Not Ready (Not Active): state 'Setup Phase' > irq/17-dwc3-2578 [001] d..1 58.804488: dwc3_ep0: Control Status > irq/17-dwc3-2578 [001] d..1 58.804489: dwc3_prepare_trb: ep0in: 0/0 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c33 (HLcs:SC:status2) > irq/17-dwc3-2578 [001] d..1 58.804495: dwc3_gadget_ep_cmd: ep0in: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.804583: dwc3_event: event (0000c042): ep0in: Transfer Complete > irq/17-dwc3-2578 [001] d..1 58.804584: dwc3_ep0: ep0in: Transfer Complete: state 'Status Phase' > irq/17-dwc3-2578 [001] d..1 58.804584: dwc3_ep0: Status Phase > irq/17-dwc3-2578 [001] d..1 58.804585: dwc3_complete_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 0 ctrl 00000c32 (hLcs:SC:status2) > irq/17-dwc3-2578 [001] d..1 58.804586: dwc3_gadget_giveback: ep0out: req ffff88016c03ad80 length 0/0 zsI ==> 0 > irq/17-dwc3-2578 [001] d..1 58.804587: dwc3_prepare_trb: ep0out: 0/2 trb ffff880084c02000 buf 0000000084c01000 size 8 ctrl 00000c23 (HLcs:SC:setup) > irq/17-dwc3-2578 [001] d..1 58.804596: dwc3_gadget_ep_cmd: ep0out: cmd 'Start Transfer' [1030] params 00000000 84c02000 00000000 --> status: Successful > irq/17-dwc3-2578 [001] d..1 58.804660: dwc3_event: event (0000c040): ep0out: Transfer Complete > irq/17-dwc3-2578 [001] d..1 58.804661: dwc3_ep0: ep0out: Transfer Complete: state 'Setup Phase' > irq/17-dwc3-2578 [001] d..1 58.804661: dwc3_ep0: Setup Phase > irq/17-dwc3-2578 [001] d..1 58.804661: dwc3_ctrl_req: bRequestType a1 bRequest 87 wValue 0100 wIndex 0001 wLength 26 > irq/17-dwc3-2578 [001] d..1 58.804663: dwc3_event: event (000010c2): ep0in: Transfer Not Ready (Not Active) > irq/17-dwc3-2578 [001] d..1 58.804663: dwc3_ep0: ep0in: Transfer Not Ready (Not Active): state 'Setup Phase' > irq/17-dwc3-2578 [001] d..1 58.804664: dwc3_ep0: Control Data > > uvc-gadget keeps printing this error message: > > 159 if ((ret = ioctl(dev->fd, VIDIOC_DQBUF, &buf)) < 0) { > 160 printf("Unable to dequeue buffer: %s (%d).\n", strerror(errno), > 161 errno); > 162 return ret; > 163 } > > Any ideas? > ^ permalink raw reply [flat|nested] 19+ messages in thread
* Re: g_webcam Isoch high bandwidth transfer 2016-09-23 8:10 ` yfw @ 2016-09-23 8:27 ` Felipe Balbi 2016-09-26 16:06 ` Laurent Pinchart 0 siblings, 1 reply; 19+ messages in thread From: Felipe Balbi @ 2016-09-23 8:27 UTC (permalink / raw) To: yfw, Bin Liu; +Cc: linux-usb, linux-media, laurent.pinchart [-- Attachment #1: Type: text/plain, Size: 3043 bytes --] Hi, yfw <nh26223@gmail.com> writes: >>>>>> Here's one that actually compiles, sorry about that. >>>>> >>>>> No worries, I was sleeping ;-) >>>>> >>>>> I will test it out early next week. Thanks. >>>> >>>> meanwhile, how about some instructions on how to test this out myself? >>>> How are you using g_webcam and what are you running on host side? Got a >>>> nice list of commands there I can use? I think I can get to bottom of >>>> this much quicker if I can reproduce it locally ;-) >>> >>> On device side: >>> - first patch g_webcam as in my first email in this thread to enable >>> 640x480@30fps; >>> - # modprobe g_webcam streaming_maxpacket=3072 >>> - then run uvc-gadget to feed the YUV frames; >>> http://git.ideasonboard.org/uvc-gadget.git >> >> as is, g_webcam never enumerates to the host. It's calls to >> usb_function_active() and usb_function_deactivate() are unbalanced. Do >> you have any other changes to g_webcam? > With uvc function gadget driver, user daemon uvc-gadget must be started > before connect to host. Not sure whether g_webcam has same requirement. f_uvc.c should be handling that by means for usb_function_deactivate(). I'll try keeping cable disconnected until uvc-gadget is running. >> Also, uvc-gadget.git doesn't compile, had to modify it a bit: >> >> -#include "../drivers/usb/gadget/uvc.h" >> +#include "../drivers/usb/gadget/function/uvc.h" >> >> Also fixed a build warning: >> >> @@ -732,6 +732,8 @@ int main(int argc, char *argv[]) >> fd_set wfds = fds; >> >> ret = select(dev->fd + 1, NULL, &wfds, &efds, NULL); >> + if (ret < 0) >> + return ret; >> if (FD_ISSET(dev->fd, &efds)) >> uvc_events_process(dev); >> if (FD_ISSET(dev->fd, &wfds)) >> >> Laurent, have you tested g_webcam recently? What's the magic to get it >> working? >> >> Here's what I get out of dmesg: >> >> [ 58.568380] usb 1-9: new high-speed USB device number 5 using xhci_hcd >> [ 58.738680] usb 1-9: New USB device found, idVendor=1d6b, idProduct=0102 >> [ 58.738683] usb 1-9: New USB device strings: Mfr=1, Product=2, SerialNumber=0 >> [ 58.738685] usb 1-9: Product: Webcam gadget >> [ 58.738687] usb 1-9: Manufacturer: Linux Foundation >> [ 58.739133] g_webcam gadget: high-speed config #1: Video >> [ 58.739138] g_webcam gadget: uvc_function_set_alt(0, 0) >> [ 58.739139] g_webcam gadget: reset UVC Control >> [ 58.739149] g_webcam gadget: uvc_function_set_alt(1, 0) >> [ 58.804369] uvcvideo: Found UVC 1.00 device Webcam gadget (1d6b:0102) >> [ 58.804479] g_webcam gadget: uvc_function_set_alt(1, 0) >> [ 64.188459] uvcvideo: UVC non compliance - GET_DEF(PROBE) not supported. Enabling workaround. > Looks like you connect your usb device to your usb host port on same > board. Nice. yeah, that helps. > The GET_DEF is handled by user daemon uvc-gadget. It may be related. okay. -- balbi [-- Attachment #2: signature.asc --] [-- Type: application/pgp-signature, Size: 800 bytes --] ^ permalink raw reply [flat|nested] 19+ messages in thread
* Re: g_webcam Isoch high bandwidth transfer 2016-09-23 8:27 ` Felipe Balbi @ 2016-09-26 16:06 ` Laurent Pinchart 2016-09-27 7:10 ` Felipe Balbi 0 siblings, 1 reply; 19+ messages in thread From: Laurent Pinchart @ 2016-09-26 16:06 UTC (permalink / raw) To: Felipe Balbi; +Cc: yfw, Bin Liu, linux-usb, linux-media Hi Felipe, On Friday 23 Sep 2016 11:27:26 Felipe Balbi wrote: > yfw <nh26223@gmail.com> writes: > >>>>>> Here's one that actually compiles, sorry about that. > >>>>> > >>>>> No worries, I was sleeping ;-) > >>>>> > >>>>> I will test it out early next week. Thanks. > >>>> > >>>> meanwhile, how about some instructions on how to test this out myself? > >>>> How are you using g_webcam and what are you running on host side? Got a > >>>> nice list of commands there I can use? I think I can get to bottom of > >>>> this much quicker if I can reproduce it locally ;-) > >>> > >>> On device side: > >>> - first patch g_webcam as in my first email in this thread to enable > >>> 640x480@30fps; > >>> - # modprobe g_webcam streaming_maxpacket=3072 > >>> - then run uvc-gadget to feed the YUV frames; > >>> http://git.ideasonboard.org/uvc-gadget.git > >> > >> as is, g_webcam never enumerates to the host. It's calls to > >> usb_function_active() and usb_function_deactivate() are unbalanced. Do > >> you have any other changes to g_webcam? > > > > With uvc function gadget driver, user daemon uvc-gadget must be started > > before connect to host. Not sure whether g_webcam has same requirement. > > f_uvc.c should be handling that by means for usb_function_deactivate(). > > I'll try keeping cable disconnected until uvc-gadget is running. Things might have changed since we've discussed the issue several years ago, but back then at least the musb UDC started unconditionally connected. -- Regards, Laurent Pinchart ^ permalink raw reply [flat|nested] 19+ messages in thread
* Re: g_webcam Isoch high bandwidth transfer 2016-09-26 16:06 ` Laurent Pinchart @ 2016-09-27 7:10 ` Felipe Balbi 0 siblings, 0 replies; 19+ messages in thread From: Felipe Balbi @ 2016-09-27 7:10 UTC (permalink / raw) To: Laurent Pinchart; +Cc: yfw, Bin Liu, linux-usb, linux-media [-- Attachment #1: Type: text/plain, Size: 1767 bytes --] Hi, Laurent Pinchart <laurent.pinchart@ideasonboard.com> writes: > Hi Felipe, > > On Friday 23 Sep 2016 11:27:26 Felipe Balbi wrote: >> yfw <nh26223@gmail.com> writes: >> >>>>>> Here's one that actually compiles, sorry about that. >> >>>>> >> >>>>> No worries, I was sleeping ;-) >> >>>>> >> >>>>> I will test it out early next week. Thanks. >> >>>> >> >>>> meanwhile, how about some instructions on how to test this out myself? >> >>>> How are you using g_webcam and what are you running on host side? Got a >> >>>> nice list of commands there I can use? I think I can get to bottom of >> >>>> this much quicker if I can reproduce it locally ;-) >> >>> >> >>> On device side: >> >>> - first patch g_webcam as in my first email in this thread to enable >> >>> 640x480@30fps; >> >>> - # modprobe g_webcam streaming_maxpacket=3072 >> >>> - then run uvc-gadget to feed the YUV frames; >> >>> http://git.ideasonboard.org/uvc-gadget.git >> >> >> >> as is, g_webcam never enumerates to the host. It's calls to >> >> usb_function_active() and usb_function_deactivate() are unbalanced. Do >> >> you have any other changes to g_webcam? >> > >> > With uvc function gadget driver, user daemon uvc-gadget must be started >> > before connect to host. Not sure whether g_webcam has same requirement. >> >> f_uvc.c should be handling that by means for usb_function_deactivate(). >> >> I'll try keeping cable disconnected until uvc-gadget is running. > > Things might have changed since we've discussed the issue several years ago, > but back then at least the musb UDC started unconditionally connected. That's kinda of not the case anymore. We deactivate during function registration if a certain flag is set. -- balbi [-- Attachment #2: signature.asc --] [-- Type: application/pgp-signature, Size: 800 bytes --] ^ permalink raw reply [flat|nested] 19+ messages in thread
* Re: g_webcam Isoch high bandwidth transfer 2016-09-23 7:49 ` Felipe Balbi 2016-09-23 8:10 ` yfw @ 2016-09-26 14:02 ` Bin Liu 2016-09-27 7:14 ` Felipe Balbi 2016-09-26 16:03 ` Laurent Pinchart 2 siblings, 1 reply; 19+ messages in thread From: Bin Liu @ 2016-09-26 14:02 UTC (permalink / raw) To: Felipe Balbi; +Cc: linux-usb, linux-media, nh26223, laurent.pinchart On Fri, Sep 23, 2016 at 10:49:57AM +0300, Felipe Balbi wrote: > > Hi, > > Bin Liu <b-liu@ti.com> writes: > > +Fengwei Yin per his request. > > > > On Thu, Sep 22, 2016 at 10:48:40PM +0300, Felipe Balbi wrote: > >> > >> Hi, > >> > >> Bin Liu <b-liu@ti.com> writes: > >> > >> [...] > >> > >> >> Here's one that actually compiles, sorry about that. > >> > > >> > No worries, I was sleeping ;-) > >> > > >> > I will test it out early next week. Thanks. > >> > >> meanwhile, how about some instructions on how to test this out myself? > >> How are you using g_webcam and what are you running on host side? Got a > >> nice list of commands there I can use? I think I can get to bottom of > >> this much quicker if I can reproduce it locally ;-) > > > > On device side: > > - first patch g_webcam as in my first email in this thread to enable > > 640x480@30fps; > > - # modprobe g_webcam streaming_maxpacket=3072 > > - then run uvc-gadget to feed the YUV frames; > > http://git.ideasonboard.org/uvc-gadget.git > > as is, g_webcam never enumerates to the host. It's calls to Right, on mainline kernel (I tested 4.8.0-rc7) g_webcam is broken with DWC3, g_webcam does not enumerate on the host. But it works on v4.4.21. [snip] > > uvc-gadget keeps printing this error message: > > 159 if ((ret = ioctl(dev->fd, VIDIOC_DQBUF, &buf)) < 0) { > 160 printf("Unable to dequeue buffer: %s (%d).\n", strerror(errno), > 161 errno); > 162 return ret; > 163 } I removed this printf, since it floods the console if start uvc-gadget before connect to the host. BTY, you don't have to start uvc-gadget first then connect usb cable. I keep the cable always connected. Regards, -Bin. ^ permalink raw reply [flat|nested] 19+ messages in thread
* Re: g_webcam Isoch high bandwidth transfer 2016-09-26 14:02 ` Bin Liu @ 2016-09-27 7:14 ` Felipe Balbi 0 siblings, 0 replies; 19+ messages in thread From: Felipe Balbi @ 2016-09-27 7:14 UTC (permalink / raw) To: Bin Liu; +Cc: linux-usb, linux-media, nh26223, laurent.pinchart [-- Attachment #1: Type: text/plain, Size: 2649 bytes --] Hi, Bin Liu <b-liu@ti.com> writes: > On Fri, Sep 23, 2016 at 10:49:57AM +0300, Felipe Balbi wrote: >> >> Hi, >> >> Bin Liu <b-liu@ti.com> writes: >> > +Fengwei Yin per his request. >> > >> > On Thu, Sep 22, 2016 at 10:48:40PM +0300, Felipe Balbi wrote: >> >> >> >> Hi, >> >> >> >> Bin Liu <b-liu@ti.com> writes: >> >> >> >> [...] >> >> >> >> >> Here's one that actually compiles, sorry about that. >> >> > >> >> > No worries, I was sleeping ;-) >> >> > >> >> > I will test it out early next week. Thanks. >> >> >> >> meanwhile, how about some instructions on how to test this out myself? >> >> How are you using g_webcam and what are you running on host side? Got a >> >> nice list of commands there I can use? I think I can get to bottom of >> >> this much quicker if I can reproduce it locally ;-) >> > >> > On device side: >> > - first patch g_webcam as in my first email in this thread to enable >> > 640x480@30fps; >> > - # modprobe g_webcam streaming_maxpacket=3072 >> > - then run uvc-gadget to feed the YUV frames; >> > http://git.ideasonboard.org/uvc-gadget.git >> >> as is, g_webcam never enumerates to the host. It's calls to > > Right, on mainline kernel (I tested 4.8.0-rc7) g_webcam is broken with > DWC3, g_webcam does not enumerate on the host. But it works on v4.4.21. There aren't that many changes related to g_webcam though. $ git log --oneline --no-merges v4.4..HEAD -- drivers/usb/gadget/function/f_uvc.c drivers/usb/gadget/legacy/webcam.c drivers/usb/gadget/function/uvc* 4fbac5206afd usb: gadget: uvc: Add missing call for additional setup data bd610c5aa9fc usb: gadget: uvc: Fix return value in case of error 36c0f8b32c4b [media] vb2: replace void *alloc_ctxs by struct device *alloc_devs 1ae1602de028 configfs: switch ->default groups to a linked list d6dd645eae76 [media] media: videobuf2: Move timestamp to vb2_buffer df9ecb0cad14 [media] vb2: drop v4l2_format argument from queue_setup 0aecfc1b359d usb: gadget: composite: remove redundant bcdUSB setting in legacy >> uvc-gadget keeps printing this error message: >> >> 159 if ((ret = ioctl(dev->fd, VIDIOC_DQBUF, &buf)) < 0) { >> 160 printf("Unable to dequeue buffer: %s (%d).\n", strerror(errno), >> 161 errno); >> 162 return ret; >> 163 } > > I removed this printf, since it floods the console if start uvc-gadget > before connect to the host. fair enough > BTY, you don't have to start uvc-gadget first then connect usb cable. I > keep the cable always connected. good to know. Thanks -- balbi [-- Attachment #2: signature.asc --] [-- Type: application/pgp-signature, Size: 800 bytes --] ^ permalink raw reply [flat|nested] 19+ messages in thread
* Re: g_webcam Isoch high bandwidth transfer 2016-09-23 7:49 ` Felipe Balbi 2016-09-23 8:10 ` yfw 2016-09-26 14:02 ` Bin Liu @ 2016-09-26 16:03 ` Laurent Pinchart 2 siblings, 0 replies; 19+ messages in thread From: Laurent Pinchart @ 2016-09-26 16:03 UTC (permalink / raw) To: Felipe Balbi; +Cc: Bin Liu, linux-usb, linux-media, nh26223 Hi Felipe, On Friday 23 Sep 2016 10:49:57 Felipe Balbi wrote: > Bin Liu <b-liu@ti.com> writes: > > +Fengwei Yin per his request. > > > > On Thu, Sep 22, 2016 at 10:48:40PM +0300, Felipe Balbi wrote: > >> Bin Liu <b-liu@ti.com> writes: > >> > >> [...] > >> > >>>> Here's one that actually compiles, sorry about that. > >>> > >>> No worries, I was sleeping ;-) > >>> > >>> I will test it out early next week. Thanks. > >> > >> meanwhile, how about some instructions on how to test this out myself? > >> How are you using g_webcam and what are you running on host side? Got a > >> nice list of commands there I can use? I think I can get to bottom of > >> this much quicker if I can reproduce it locally ;-) > > > > On device side: > > - first patch g_webcam as in my first email in this thread to enable > > > > 640x480@30fps; > > > > - # modprobe g_webcam streaming_maxpacket=3072 > > - then run uvc-gadget to feed the YUV frames; > > > > http://git.ideasonboard.org/uvc-gadget.git > > as is, g_webcam never enumerates to the host. It's calls to > usb_function_active() and usb_function_deactivate() are unbalanced. Do > you have any other changes to g_webcam? > > Also, uvc-gadget.git doesn't compile, had to modify it a bit: > > -#include "../drivers/usb/gadget/uvc.h" > +#include "../drivers/usb/gadget/function/uvc.h" > > Also fixed a build warning: > > @@ -732,6 +732,8 @@ int main(int argc, char *argv[]) > fd_set wfds = fds; > > ret = select(dev->fd + 1, NULL, &wfds, &efds, NULL); > + if (ret < 0) > + return ret; > if (FD_ISSET(dev->fd, &efds)) > uvc_events_process(dev); > if (FD_ISSET(dev->fd, &wfds)) > > Laurent, have you tested g_webcam recently? What's the magic to get it > working? I'm afraid not, I haven't had time to work on UVC gadget for a few years now. > Here's what I get out of dmesg: > > [ 58.568380] usb 1-9: new high-speed USB device number 5 using xhci_hcd > [ 58.738680] usb 1-9: New USB device found, idVendor=1d6b, idProduct=0102 > [ 58.738683] usb 1-9: New USB device strings: Mfr=1, Product=2, > SerialNumber=0 [ 58.738685] usb 1-9: Product: Webcam gadget > [ 58.738687] usb 1-9: Manufacturer: Linux Foundation > [ 58.739133] g_webcam gadget: high-speed config #1: Video > [ 58.739138] g_webcam gadget: uvc_function_set_alt(0, 0) > [ 58.739139] g_webcam gadget: reset UVC Control > [ 58.739149] g_webcam gadget: uvc_function_set_alt(1, 0) > [ 58.804369] uvcvideo: Found UVC 1.00 device Webcam gadget (1d6b:0102) > [ 58.804479] g_webcam gadget: uvc_function_set_alt(1, 0) > [ 64.188459] uvcvideo: UVC non compliance - GET_DEF(PROBE) not supported. > Enabling workaround. [ 69.307458] uvcvideo: Failed to query (129) UVC > probe control : -110 (exp. 26). [ 69.307459] uvcvideo: Failed to > initialize the device (-5). > [ 69.307505] usbcore: registered new interface driver uvcvideo > [ 69.307506] USB Video Class driver (1.1.1) > [ 146.646012] ------------[ cut here ]------------ > [ 146.646023] WARNING: CPU: 0 PID: 2616 at > drivers/usb/gadget/composite.c:371 usb_function_activate+0x77/0x80 > [libcomposite] [ 146.646024] Modules linked in: uvcvideo g_webcam > usb_f_uvc videobuf2_vmalloc videobuf2_memops videobuf2_v4l2 videobuf2_core > videodev libcomposite kvm_intel kvm psmouse e1000e input_leds hid_generic > usbhid atkbd irqbypass evdev [ 146.646054] CPU: 0 PID: 2616 Comm: > gst-launch-1.0 Not tainted > 4.8.0-rc7-next-20160922-00004-gc71031593917-dirty #20 [ 146.646055] > Hardware name: Intel Corporation Skylake Client platform/Skylake Y LPDDR3 > RVP3, BIOS SKLSE2R1.R00.B097.B02.1509020030 09/02/2015 [ 146.646058] > ffffc9000769bb70 > [ 146.646059] ffffffff8132d415 > [ 146.646060] 0000000000000000 > [ 146.646061] 0000000000000000 > > [ 146.646063] ffffc9000769bbb0 > [ 146.646063] ffffffff8105ec1b > [ 146.646064] 000001730769bb90 > [ 146.646066] 00000000ffffffea > [ 146.646070] ffff88016c03a150 > [ 146.646072] 0000000000000282 ffff88016d793000 ffffc9000769befc > [ 146.646077] Call Trace: > [ 146.646086] [<ffffffff8132d415>] dump_stack+0x68/0x93 > [ 146.646090] [<ffffffff8105ec1b>] __warn+0xcb/0xf0 > [ 146.646095] [<ffffffff8105ed0d>] warn_slowpath_null+0x1d/0x20 > [ 146.646099] [<ffffffffa03f1ea7>] usb_function_activate+0x77/0x80 > [libcomposite] [ 146.646105] [<ffffffffa044a6de>] > uvc_function_connect+0x1e/0x40 [usb_f_uvc] [ 146.646110] > [<ffffffffa044b2ae>] uvc_v4l2_open+0x6e/0x80 [usb_f_uvc] [ 146.646116] > [<ffffffffa04014f0>] v4l2_open+0xa0/0x100 [videodev] [ 146.646121] > [<ffffffff811a5431>] chrdev_open+0xa1/0x1d0 > [ 146.646125] [<ffffffff811a5390>] ? cdev_put+0x30/0x30 > [ 146.646129] [<ffffffff8119dd60>] do_dentry_open.isra.17+0x150/0x2e0 > [ 146.646133] [<ffffffff8119f115>] vfs_open+0x45/0x60 > [ 146.646137] [<ffffffff811af1ed>] path_openat+0x62d/0x1370 > [ 146.646141] [<ffffffff811b0094>] ? putname+0x54/0x60 > [ 146.646146] [<ffffffff811b10ce>] do_filp_open+0x7e/0xe0 > [ 146.646150] [<ffffffff81083868>] ? preempt_count_sub+0x48/0x70 > [ 146.646154] [<ffffffff816f07d6>] ? _raw_spin_unlock+0x16/0x30 > [ 146.646160] [<ffffffff811bf009>] ? __alloc_fd+0xc9/0x180 > [ 146.646164] [<ffffffff8119f4e3>] do_sys_open+0x123/0x200 > [ 146.646170] [<ffffffff8119f5de>] SyS_open+0x1e/0x20 > [ 146.646174] [<ffffffff816f0e2a>] entry_SYSCALL_64_fastpath+0x18/0xa8 > [ 146.646177] ---[ end trace 1a4f7b9817d19b04 ]--- > [ 146.646180] g_webcam gadget: UVC connect failed with -22 > [ 146.653808] usb 1-9: USB disconnect, device number 5 > [ 146.653986] g_webcam gadget: UVC disconnect failed with -110 [snip] > uvc-gadget keeps printing this error message: > > 159 if ((ret = ioctl(dev->fd, VIDIOC_DQBUF, &buf)) < 0) { > 160 printf("Unable to dequeue buffer: %s (%d).\n", > strerror(errno), 161 errno); > 162 return ret; > 163 } > > Any ideas? The UVC gadget driver uses videobuf2 for buffer management. You can raise the debug level of the videobuf2-v4l2 and videobuf2-core modules to get verbose error messages in the kernel log. -- Regards, Laurent Pinchart ^ permalink raw reply [flat|nested] 19+ messages in thread
end of thread, other threads:[~2016-09-27 7:14 UTC | newest] Thread overview: 19+ messages (download: mbox.gz follow: Atom feed -- links below jump to the message on this page -- 2016-09-20 17:04 g_webcam Isoch high bandwidth transfer Bin Liu 2016-09-21 8:01 ` Felipe Balbi 2016-09-21 13:27 ` Bin Liu 2016-09-21 14:58 ` Bin Liu 2016-09-22 7:37 ` Felipe Balbi 2016-09-22 8:08 ` Felipe Balbi 2016-09-22 10:06 ` Felipe Balbi 2016-09-22 13:33 ` Bin Liu 2016-09-22 19:48 ` Felipe Balbi 2016-09-22 20:11 ` Bin Liu 2016-09-23 0:23 ` yfw 2016-09-23 7:49 ` Felipe Balbi 2016-09-23 8:10 ` yfw 2016-09-23 8:27 ` Felipe Balbi 2016-09-26 16:06 ` Laurent Pinchart 2016-09-27 7:10 ` Felipe Balbi 2016-09-26 14:02 ` Bin Liu 2016-09-27 7:14 ` Felipe Balbi 2016-09-26 16:03 ` Laurent Pinchart
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).
![[-- Attachment #2: dwc3-g_webcam-DATA0-only-bus-trace.png --] [-- Type: image/png, Size: 71300 bytes --]](../../20160921132702.GA18578@uda0271908/2-dwc3-g_webcam-DATA0-only-bus-trace.png){kind=link}