• State Resolved
  • Locked Locked
  • Replies 16 replies
  • Subscribers 98 subscribers
  • Views 5931 views
  • Users 0 members are here
Support feedback
Options
Options
Related

This thread has been locked.

If you have a related question, please click the "Ask a related question" button in the top right corner. The newly created question will be automatically linked to this question.

Linux/AM5728: USB3 camera failure

Manu Chen
Prodigy 210 points
Part Number: AM5728


Tool/software: Linux

Hello experts,

With AM5728 EVM over sdk 04.01.00.06, we have one USB 3 camera and the other of USB 2.

The former is running into problem as following (both logs attached). 

Please advice.

Thanks.


*************************************************************** USB 3.0 ***************************************************************

_____ _____ _ _
| _ |___ ___ ___ ___ | _ |___ ___ |_|___ ___| |_
| | _| .'| . | . | | __| _| . | | | -_| _| _|
|__|__|_| |__,|_ |___| |__| |_| |___|_| |___|___|_|
|___| |___|

Arago Project http://arago-project.org am57xx-evm ttyS2

Arago 2017.06 am57xx-evm ttyS2

am57xx-evm login: root
root@am57xx-evm:~# [ 26.086154] omap_hwmod: mmu1_dsp1: _wait_target_disable failed
[ 26.099213] omap_hwmod: mmu0_dsp1: _wait_target_disable failed
[ 26.112340] omap_hwmod: mmu1_dsp2: _wait_target_disable failed
[ 26.125409] omap_hwmod: mmu0_dsp2: _wait_target_disable failed
[ 29.809575] usb 2-1.1: new SuperSpeed USB device number 3 using xhci-hcd
[ 29.929685] uvcvideo: Found UVC 1.00 device HDMI to U3 capture (1e4e:701f)
[ 30.021985] uvcvideo: UVC non compliance - GET_DEF(PROBE) not supported. Enabling workaround.
[ 30.030932] uvcvideo 2-1.1:1.0: Entity type for entity Extension 4 was not initialized!
[ 30.038981] uvcvideo 2-1.1:1.0: Entity type for entity Processing 3 was not initialized!
[ 30.047315] uvcvideo 2-1.1:1.0: Entity type for entity Camera 1 was not initialized!
[ 30.056734] usbcore: registered new interface driver uvcvideo
[ 30.062563] USB Video Class driver (1.1.1)
[ 30.096449] usbcore: registered new interface driver snd-usb-audio
[ 34.439601] usb 2-1.1: USB disconnect, device number 3
[ 34.769574] usb 2-1.1: new SuperSpeed USB device number 4 using xhci-hcd
[ 34.805903] uvcvideo: Found UVC 1.00 device HDMI to U3 capture (1e4e:701f)
[ 34.826758] uvcvideo: UVC non compliance - GET_DEF(PROBE) not supported. Enabling workaround.
[ 34.835974] uvcvideo 2-1.1:1.0: Entity type for entity Extension 4 was not initialized!
[ 34.846317] uvcvideo 2-1.1:1.0: Entity type for entity Processing 3 was not initialized!
[ 34.855865] uvcvideo 2-1.1:1.0: Entity type for entity Camera 1 was not initialized!
[ 36.188958] usb 2-1.1: USB disconnect, device number 4
[ 36.769577] usb 2-1.1: new SuperSpeed USB device number 5 using xhci-hcd
[ 36.805988] uvcvideo: Found UVC 1.00 device HDMI to U3 capture (1e4e:701f)
[ 36.828789] uvcvideo: UVC non compliance - GET_DEF(PROBE) not supported. Enabling workaround.
[ 36.837972] uvcvideo 2-1.1:1.0: Entity type for entity Extension 4 was not initialized!
[ 36.846359] uvcvideo 2-1.1:1.0: Entity type for entity Processing 3 was not initialized!
[ 36.855596] uvcvideo 2-1.1:1.0: Entity type for entity Camera 1 was not initialized!
root
-sh: root: command not found
root@am57xx-evm:~# gst-launch-1.0 v4l2src device=/dev/video1 io-mode=2 ! 'video/x-raw, format=(string)YUY2, width=(int)1920, height=(int)1080' ! fakesink -v -e
[ 78.789653] usb 2-1.1: reset SuperSpeed USB device number 5 using xhci-hcd
Setting pipeline to PAUSED ...
Pipeline is live and does not need PREROLL ...
Setting pipeline to PLAYING ...
New clock: GstSystemClock
/GstPipeline:pipeline0/GstV4l2Src:v4l2src0.GstPad:src: caps = "video/x-raw\,\ format\=\(string\)YUY2\,\ width\=\(int\)1920\,\ height\=\(int\)1080\,\ pixel-aspect-ratio\=\(fraction\)1/1\,\ interlace-mode\=\(string\)progressive\,\ colorimetry\=\(string\)2:4:7:1\,\ framerate\=\(fraction\)60/1"
/GstPipeline:pipeline0/GstCapsFilter:capsfilter0.GstPad:src: caps = "video/x-raw\,\ format\=\(string\)YUY2\,\ width\=\(int\)1920\,\ height\=\(int\)1080\,\ pixel-aspect-ratio\=\(fraction\)1/1\,\ interlace-mode\=\(string\[ 79.205888] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 1
[ 79.216555] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe4fc720 trb-start 00000000fe4fd330 trb-end 00000000fe4fd330 seg-start 00000000fe4fd000 seg-end 00000000fe4fdff0
[ 79.232709] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 1
[ 79.243367] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe4fc740 trb-start 00000000fe4fd330 trb-end 00000000fe4fd330 seg-start 00000000fe4fd000 seg-end 00000000fe4fdff0
[ 79.259519] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
[ 79.270263] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe4fc750 trb-start 00000000fe4fd330 trb-end 00000000fe4fd330 seg-start 00000000fe4fd000 seg-end 00000000fe4fdff0
[ 79.286413] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
[ 79.297157] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe4fc770 trb-start 00000000fe4fd330 trb-end 00000000fe4fd330 seg-start 00000000fe4fd000 seg-end 00000000fe4fdff0
[ 79.313306] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
[ 79.324050] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe4fc780 trb-start 00000000fe4fd330 trb-end 00000000fe4fd330 seg-start 00000000fe4fd000 seg-end 00000000fe4fdff0
[ 79.340200] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
[ 79.350943] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe4fc7a0 trb-start 00000000fe4fd330 trb-end 00000000fe4fd330 seg-start 00000000fe4fd000 seg-end 00000000fe4fdff0
[ 79.367092] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
[ 79.377835] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe4fc7b0 trb-start 00000000fe4fd330 trb-end 00000000fe4fd330 seg-start 00000000fe4fd000 seg-end 00000000fe4fdff0
[ 79.393985] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
[ 79.404728] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe4fc7d0 trb-start 00000000fe4fd330 trb-end 00000000fe4fd330 seg-start 00000000fe4fd000 seg-end 00000000fe4fdff0
[ 79.420878] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
[ 79.431621] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe4fc7e0 trb-start 00000000fe4fd330 trb-end 00000000fe4fd330 seg-start 00000000fe4fd000 seg-end 00000000fe4fdff0
[ 79.447770] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 1
[ 79.458427] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe4fc7f0 trb-start 00000000fe4fd330 trb-end 00000000fe4fd330 seg-start 00000000fe4fd000 seg-end 00000000fe4fdff0
[ 79.474577] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
[ 79.485320] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe4fc800 trb-start 00000000fe4fd330 trb-end 00000000fe4fd330 seg-start 00000000fe4fd000 seg-end 00000000fe4fdff0
[ 79.501469] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
[ 79.512211] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe4fc820 trb-start 00000000fe4fd330 trb-end 00000000fe4fd330 seg-start 00000000fe4fd000 seg-end 00000000fe4fdff0
[ 79.528360] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
[ 79.539102] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe4fc830 trb-start 00000000fe4fd330 trb-end 00000000fe4fd330 seg-start 00000000fe4fd000 seg-end 00000000fe4fdff0
[ 79.555251] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
[ 79.565994] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe4fc850 trb-start 00000000fe4fd330 trb-end 00000000fe4fd330 seg-start 00000000fe4fd000 seg-end 00000000fe4fdff0
[ 79.582144] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
[ 79.592886] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe4fc860 trb-start 00000000fe4fd330 trb-end 00000000fe4fd330 seg-start 00000000fe4fd000 seg-end 00000000fe4fdff0
[ 79.609036] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
[ 79.619779] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe4fc880 trb-start 00000000fe4fd330 trb-end 00000000fe4fd330 seg-start 00000000fe4fd000 seg-end 00000000fe4fdff0
[ 79.635929] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
[ 79.646671] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe4fc890 trb-start 00000000fe4fd330 trb-end 00000000fe4fd330 seg-start 00000000fe4fd000 seg-end 00000000fe4fdff0
[ 79.662820] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
[ 79.673562] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe4fc8a0 trb-start 00000000fe4fd330 trb-end 00000000fe4fd330 seg-start 00000000fe4fd000 seg-end 00000000fe4fdff0
[ 79.689712] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
[ 79.700454] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe4fc8b0 trb-start 00000000fe4fd330 trb-end 00000000fe4fd330 seg-start 00000000fe4fd000 seg-end 00000000fe4fdff0
[ 79.716603] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 1
[ 79.727258] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe4fc8c0 trb-start 00000000fe4fd330 trb-end 00000000fe4fd330 seg-start 00000000fe4fd000 seg-end 00000000fe4fdff0
[ 79.743408] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
[ 79.754150] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe4fc8d0 trb-start 00000000fe4fd330 trb-end 00000000fe4fd330 seg-start 00000000fe4fd000 seg-end 00000000fe4fdff0
[ 79.770299] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
[ 79.781041] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe4fc8e0 trb-start 00000000fe4fd330 trb-end 00000000fe4fd330 seg-start 00000000fe4fd000 seg-end 00000000fe4fdff0
[ 79.797235] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 1
[ 79.807898] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe4fc8f0 trb-start 00000000fe4fd330 trb-end 00000000fe4fd330 seg-start 00000000fe4fd000 seg-end 00000000fe4fdff0
)progressive\,\ colorimetry\=\(string\)2:4:7:1\,\ framerate\=\(fraction\)60/1"
/GstPipeline:pipeline0/GstFakeSink:fakesink0.GstPad:sink: caps = "video/x-raw\,\ format\=\(string\)YUY2\,\ width\=\(int\)1920\,\ height\=\(int\)1080\,\ pixel-aspect-ratio\=\(fraction\)1/1\,\ interlace-mode\=\(string\)progressive\,\ colorimetry\=\(string\)2:4:7:1\,\ framerate\=\(fraction\)60/1"
/GstPipeline:pipeline0/GstCapsFilter:capsfilter0.GstPad:sink: caps = "video/x-raw\,\ format\=\(string\)YUY2\,\ width\=\(int\)1920\,\ height\=\(int\)1080\,\ pixel-aspect-ratio\=\(fraction\)1/1\,\ interlace-mode\=\(string\)progressive\,\ colorimetry\=\(string\)2:4:7:1\,\ framerate\=\(fraction\)60/1"
[ 80.364945] usb 2-1.1: USB disconnect, device number 5
ERROR: from element /GstPipeline:pipeline0/GstV4l2Src:v4l2src0: Could not read from resource.
Additional debug info:
../../../gst-plugins-good-1.8.3/sys/v4l2/gstv4l2bufferpool.c(1054): gst_v4l2_buffer_pool_poll (): /GstPipeline:pipeline0/GstV4l2Src:v4l2src0:
poll error 1: Invalid argument (22)
EOS on shutdown enabled -- waiting for EOS after Error
Waiting for EOS...
ERROR: from element /GstPipeline:pipeline0/GstV4l2Src:v4l2src0: Failed to allocate a buffer
Additional debug info:
../../../gst-plugins-good-1.8.3/sys/v4l2/gstv4l2src.c(884): gst_v4l2src_create (): /GstPipeline:pipeline0/GstV4l2Src:v4l2src0
ERROR: from element /GstPipeline:pipeline0/GstV4l2Src:v4l2src0: Internal data flow error.
Additional debug info:
../../../../gstreamer-1.8.3/libs/gst/base/gstbasesrc.c(2948): gst_base_src_loop (): /GstPipeline:pipeline0/GstV4l2Src:v4l2src0:
streaming task paused, reason error (-5)
[ 80.939576] usb 2-1.1: new SuperSpeed USB device number 6 using xhci-hcd
[ 80.975945] uvcvideo: Found UVC 1.00 device HDMI to U3 capture (1e4e:701f)
[ 80.989761] uvcvideo: UVC non compliance - GET_DEF(PROBE) not supported. Enabling workaround.
[ 80.998731] uvcvideo 2-1.1:1.0: Entity type for entity Extension 4 was not initialized!
[ 81.006986] uvcvideo 2-1.1:1.0: Entity type for entity Processing 3 was not initialized!
[ 81.015335] uvcvideo 2-1.1:1.0: Entity type for entity Camera 1 was not initialized!

*************************************************************** USB 2.0 ***************************************************************
[ OK ] Started Print notice about GPLv3 packages.
[ OK ] Started gdbserverproxy.service.
Starting matrix-gui-2.0.service...
[ OK ] Started matrix-gui-2.0.service.
Starting thermal-zone-init.service...
[ OK ] Started thermal-zone-init.service.
[ OK ] Reached target Multi-User System.
Starting Update UTMP about System Runlevel Changes...
[ OK ] Started Update UTMP about System Runlevel Changes.

_____ _____ _ _
| _ |___ ___ ___ ___ | _ |___ ___ |_|___ ___| |_
| | _| .'| . | . | | __| _| . | | | -_| _| _|
|__|__|_| |__,|_ |___| |__| |_| |___|_| |___|___|_|
|___| |___|

Arago Project http://arago-project.org am57xx-evm ttyS2

Arago 2017.06 am57xx-evm ttyS2

am57xx-evm login: root[ 26.106890] omap_hwmod: mmu1_dsp1: _wait_target_disable failed
[ 26.119947] omap_hwmod: mmu0_dsp1: _wait_target_disable failed
[ 26.133365] omap_hwmod: mmu1_dsp2: _wait_target_disable failed
[ 26.146451] omap_hwmod: mmu0_dsp2: _wait_target_disable failed

root@am57xx-evm:~# ls
tibt uvc
root@am57xx-evm:~# gst-launch-1.0 v4l2src device=/dev/video1 io-mode=2 ! 'video/x-raw, format=(string)YUY2, width=(int)1280, height=(int)720' ! fakesink -v -e
[ 40.733137] usb 1-1.3: reset high-speed USB device number 3 using xhci-hcd
Setting pipeline to PAUSED ...
Pipeline is live and does not need PREROLL ...
Setting pipeline to PLAYING ...
New clock: GstSystemClock
/GstPipeline:pipeline0/GstV4l2Src:v4l2src0.GstPad:src: caps = "video/x-raw\,\ format\=\(string\)YUY2\,\ width\=\(int\)1280\,\ height\=\(int\)720\,\ pixel-aspect-ratio\=\(fraction\)1/1\,\ interlace-mode\=\(string\)progressive\,\ colorimetry\=\(string\)2:4:7:1\,\ framerate\=\(fraction\)10/1"
/GstPipeline:pipeline0/GstCapsFilter:capsfilter0.GstPad:src: caps = "video/x-raw\,\ format\=\(string\)YUY2\,\ width\=\(int\)1280\,\ height\=\(int\)720\,\ pixel-aspect-ratio\=\(fraction\)1/1\,\ interlace-mode\=\(string\)progressive\,\ colorimetry\=\(string\)2:4:7:1\,\ framerate\=\(fraction\)10/1"
/GstPipeline:pipeline0/GstFakeSink:fakesink0.GstPad:sink: caps = "video/x-raw\,\ format\=\(string\)YUY2\,\ width\=\(int\)1280\,\ height\=\(int\)720\,\ pixel-aspect-ratio\=\(fraction\)1/1\,\ interlace-mode\=\(string\)progressive\,\ colorimetry\=\(string\)2:4:7:1\,\ framerate\=\(fraction\)10/1"
/GstPipeline:pipeline0/GstCapsFilter:capsfilter0.GstPad:sink: caps = "video/x-raw\,\ format\=\(string\)YUY2\,\ width\=\(int\)1280\,\ height\=\(int\)720\,\ pixel-aspect-ratio\=\(fraction\)1/1\,\ interlace-mode\=\(string\)progressive\,\ colorimetry\=\(string\)2:4:7:1\,\ framerate\=\(fraction\)10/1"

  • 0
    TI__Guru**** 393215 points
    The software team have been notified. They will respond here.
  • 0
    TI__Guru**** 173041 points
    Manu,

    We don't have any USB3.0 UVC camera tested on AM57x, so haven't seen any log messages similar to your log.

    But have you tested your USB3 camera on a Linux PC with the same kernel version as in SDK4.1.0.6? I am not sure how well the Linux kernel UVC+USB3.0 is validated in the Linux community, since there is not many USB3 UVC cameras on the market (I didn't find any which I am able purchase).

    I see the log showing the camera got disconnected repeatedly after enumerated, how can you run gstreamer pipeline on a camera which got disconnected? Are you sure /dev/video1 is the device node of the USB3 camera? Even if so, I don't think you can run gstreamer on it, because it got disconnected repeatedly. I would recommend you to solve the enumeration problem first, then use gstreamer.
  • 0 in reply to Bin Liu
    Prodigy 210 points

    Bin,

    This is the result against ubuntu.

    By the way, have you tested any ISO superspeed device against DCW3? I know BULK works.

    Thanks,

  • 0 in reply to Manu Chen
    Prodigy 210 points

    Hi Bin,

    FYI. Almost the same error with sdk 04.02.00.09 ...

    root@am57xx-evm:~# gst-launch-1.0 v4l2src device=/dev/video1 io-mode=2 ! 'video/x-raw, format=(string)YUY2, width=(int)1920, height=(int)1080' ! fakesink -v -e
    [ 191.000265] usb 2-1.2: reset SuperSpeed USB device number 6 using xhci-hcd
    Setting pipeline to PAUSED ...
    Pipeline is live and does not need PREROLL ...
    Setting pipeline to PLAYING ...
    New clock: GstSystemClock
    /GstPipeline:pipeline0/GstV4l2Src:v4l2src0.GstPad:src: caps = "video/x-raw\,\ format\=\(string\)YUY2\,\ width\=\(int\)1920\,\ height\=\(int\)1080\,\ pixel-aspect-ratio\=\(fraction\)1/1\,\ interlace-mode\=\(string\)progressive\,\ colorimetry\=\(string\)2:4:7:1\,\ framerate\=\(fraction\)60/1"
    /GstPipeline:pipeline0/GstCapsFilter:capsfilter0.GstPad:src: caps = "video/x-raw\,\ format\=\(string\)YUY2\,\ width\=\(int\)1920\,\ height\=\(int\)1080\,\ pixel-aspect-ratio\=\(fraction\)1/1\,\ interlace-mode\=\(string\)progressive\,\ colo[ 191.350096] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 1
    [ 191.360764] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe581720 trb-start 00000000fe4ff330 trb-end 00000000fe4ff330 seg-start 00000000fe4ff000 seg-end 00000000fe4ffff0
    [ 191.376915] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 1
    [ 191.387573] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe581740 trb-start 00000000fe4ff330 trb-end 00000000fe4ff330 seg-start 00000000fe4ff000 seg-end 00000000fe4ffff0
    [ 191.403722] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
    [ 191.414464] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe581750 trb-start 00000000fe4ff330 trb-end 00000000fe4ff330 seg-start 00000000fe4ff000 seg-end 00000000fe4ffff0
    [ 191.430612] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
    [ 191.441353] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe581770 trb-start 00000000fe4ff330 trb-end 00000000fe4ff330 seg-start 00000000fe4ff000 seg-end 00000000fe4ffff0
    [ 191.457502] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
    [ 191.468243] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe581780 trb-start 00000000fe4ff330 trb-end 00000000fe4ff330 seg-start 00000000fe4ff000 seg-end 00000000fe4ffff0
    [ 191.484391] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
    [ 191.495133] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe5817a0 trb-start 00000000fe4ff330 trb-end 00000000fe4ff330 seg-start 00000000fe4ff000 seg-end 00000000fe4ffff0
    [ 191.511281] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
    [ 191.522021] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe5817b0 trb-start 00000000fe4ff330 trb-end 00000000fe4ff330 seg-start 00000000fe4ff000 seg-end 00000000fe4ffff0
    [ 191.538169] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
    [ 191.548911] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe5817d0 trb-start 00000000fe4ff330 trb-end 00000000fe4ff330 seg-start 00000000fe4ff000 seg-end 00000000fe4ffff0
    [ 191.565059] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
    [ 191.575799] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe5817e0 trb-start 00000000fe4ff330 trb-end 00000000fe4ff330 seg-start 00000000fe4ff000 seg-end 00000000fe4ffff0
    [ 191.591947] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 1
    [ 191.602601] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe5817f0 trb-start 00000000fe4ff330 trb-end 00000000fe4ff330 seg-start 00000000fe4ff000 seg-end 00000000fe4ffff0
    [ 191.618749] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
    [ 191.629489] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe581800 trb-start 00000000fe4ff330 trb-end 00000000fe4ff330 seg-start 00000000fe4ff000 seg-end 00000000fe4ffff0
    [ 191.645637] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
    [ 191.656378] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe581820 trb-start 00000000fe4ff330 trb-end 00000000fe4ff330 seg-start 00000000fe4ff000 seg-end 00000000fe4ffff0
    [ 191.672526] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
    [ 191.683268] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe581830 trb-start 00000000fe4ff330 trb-end 00000000fe4ff330 seg-start 00000000fe4ff000 seg-end 00000000fe4ffff0
    [ 191.699416] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
    [ 191.710158] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe581850 trb-start 00000000fe4ff330 trb-end 00000000fe4ff330 seg-start 00000000fe4ff000 seg-end 00000000fe4ffff0
    [ 191.726305] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
    [ 191.737046] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe581860 trb-start 00000000fe4ff330 trb-end 00000000fe4ff330 seg-start 00000000fe4ff000 seg-end 00000000fe4ffff0
    [ 191.753193] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
    [ 191.763933] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe581880 trb-start 00000000fe4ff330 trb-end 00000000fe4ff330 seg-start 00000000fe4ff000 seg-end 00000000fe4ffff0
    [ 191.780080] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
    [ 191.790821] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe581890 trb-start 00000000fe4ff330 trb-end 00000000fe4ff330 seg-start 00000000fe4ff000 seg-end 00000000fe4ffff0
    [ 191.806968] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
    [ 191.817708] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe5818a0 trb-start 00000000fe4ff330 trb-end 00000000fe4ff330 seg-start 00000000fe4ff000 seg-end 00000000fe4ffff0
    [ 191.833855] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
    [ 191.844595] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe5818c0 trb-start 00000000fe4ff330 trb-end 00000000fe4ff330 seg-start 00000000fe4ff000 seg-end 00000000fe4ffff0
    [ 191.860743] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
    [ 191.871485] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe5818d0 trb-start 00000000fe4ff330 trb-end 00000000fe4ff330 seg-start 00000000fe4ff000 seg-end 00000000fe4ffff0
    [ 191.887650] xhci-hcd xhci-hcd.1.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
    [ 191.898394] xhci-hcd xhci-hcd.1.auto: Looking for event-dma 00000000fe5818f0 trb-start 00000000fe4ff330 trb-end 00000000fe4ff330 seg-start 00000000fe4ff000 seg-end 00000000fe4ffff0
    rimetry\=\(string\)2:4:7:1\,\ framerate\=\(fraction\)60/1"
    /GstPipeline:pipeline0/GstFakeSink:fakesink0.GstPad:sink: caps = "video/x-raw\,\ format\=\(string\)YUY2\,\ width\=\(int\)1920\,\ height\=\(int\)1080\,\ pixel-aspect-ratio\=\(fraction\)1/1\,\ inter[ 191.960189] thermal thermal_zone5: failed to read out thermal zone (-121)
    lace-mode\=\(string\)progressive\,\ colorimetry\=\(string\)2:4:7:1\,\ framerate\=\(fraction\)60/1"
    /GstPipeline:pipeline0/GstCapsFilter:capsfilter0.GstPad:sink: caps = "video/x-raw\,\ format\=\(string\)YUY2\,\ width\=\(int\)1920\,\ height\=\(int\)1080\,\ pixel-aspect-ratio\=\(fraction\)1/1\,\ interlace-mode\=\(string\)progressive\,\ colorimetry\=\(string\)2:4:7:1\,\ framerate\=\(fraction\)60/1"
    [ 192.374171] usb 2-1.2: USB disconnect, device number 6
    ERROR: from element /GstPipeline:pipeline0/GstV4l2Src:v4l2src0: Could not read from resource.
    Additional debug info:
    ../../../gst-plugins-good-1.8.3/sys/v4l2/gstv4l2bufferpool.c(1054): gst_v[ 192.396780] ------------[ cut here ]------------
    4l2_buffer_pool_poll (): /GstPipeline:pipeline0/GstV4l2Src:v4l2s[ 192.402570] WARNING: CPU: 1 PID: 1325 at /oe/bld/build-CORTEX_1/arago-tmp-external-linaro-toolchain/work-shared/am57xx-evm/kernel-source/fs/sysfs/group.c:237 sysfs_remove_group+0x98/0x9c
    rc0:
    poll error 1: Invalid argument (22)
    EOS on shutdown enabl[ 192.425019] sysfs group 'power' not found for kobject 'media0'
    ed -- waiting for EOS after Error
    Waiting for EOS...
    ERROR: fr[ 192.436433] Modules linked in:om element /GstPipeline:pipeline0/GstV4l2Src:v4l2src0: Failed to snd_usb_audio allocate a buffer
    Additional debug info:
    ../../../gst-plugins snd_hwdep-good-1.8.3/sys/v4l2/gstv4l2src.c(884): gst_v4l2src_create (): / snd_usbmidi_libGstPipeline:pipeline0/GstV4l2Src:v4l2src0
    ERROR: from element / snd_rawmidiGstPipeline:pipeline0/GstV4l2Src:v4l2src0: Internal data flow er uvcvideoror.
    Additional debug info:
    ../../../../gstreamer-1.8.3/libs/g videobuf2_vmallocst/base/gstbasesrc.c(2948): gst_base_src_loop (): /GstPipeline:p bc_example(O)ipeline0/GstV4l2Src:v4l2src0:
    streaming task paused, reason err xhci_plat_hcdor (-5)
    Got EOS from element "pipeline0".
    EOS received - stopp xhci_hcding pipeline...
    Execution ended after 0:00:01.170157791
    Settin pru_rprocg pipeline to PAUSED ...
    Setting pipeline to READY ...
    Setting pruss_intc pipeline to NULL ...
    usbcore rpmsg_proto rpmsg_rpc pruss dwc3 udc_core usb_common sha512_generic sha512_arm sha256_generic sha1_generic sha1_arm_neon sha1_arm md5 cbc xfrm_user xfrm4_tunnel ipcomp xfrm_ipcomp esp4 ah4 snd_soc_simple_card af_key snd_soc_simple_card_utils xfrm_algo snd_soc_omap_hdmi_audio pvrsrvkm(O) ahci_platform libahci_platform libahci omap_aes_driver libata omap_sham pruss_soc_bus omap_wdt scsi_mod bluetooth ti_vip ti_vpe ti_sc ti_csc ti_vpdma dwc3_omap rtc_omap extcon_palmas extcon_core rtc_palmas snd_soc_tlv320aic3x omap_des pixcir_i2c_ts mt9t11x rtc_ds1307 des_generic crypto_engine omap_remoteproc virtio_rpmsg_bus rpmsg_core remoteproc sch_fq_codel uio_module_drv(O) uio gdbserverproxy(O) cryptodev(O) cmemk(O)
    [ 192.583576] CPU: 1 PID: 1325 Comm: gst-launch-1.0 Tainted: G O 4.9.59-ga75d8e9305 #2
    [ 192.592486] Hardware name: Generic DRA74X (Flattened Device Tree)
    [ 192.598602] Backtrace:
    [ 192.601074] [<c020b29c>] (dump_backtrace) from [<c020b558>] (show_stack+0x18/0x1c)
    [ 192.608677] r7:00000009 r6:600e0013 r5:00000000 r4:c1022668
    [ 192.614361] [<c020b540>] (show_stack) from [<c04cd680>] (dump_stack+0x8c/0xa0)
    [ 192.621616] [<c04cd5f4>] (dump_stack) from [<c022e3d4>] (__warn+0xec/0x104)
    [ 192.628606] r7:00000009 r6:c0baf6d8 r5:00000000 r4:d3259d58
    [ 192.634290] [<c022e2e8>] (__warn) from [<c022e42c>] (warn_slowpath_fmt+0x40/0x48)
    [ 192.641804] r9:ed98e868 r8:ed98e864 r7:ed98e86c r6:ed98e810 r5:c10366a0 r4:c0baf774
    [ 192.649581] [<c022e3f0>] (warn_slowpath_fmt) from [<c0399194>] (sysfs_remove_group+0x98/0x9c)
    [ 192.658140] r3:c0a5055c r2:c0baf774
    [ 192.661727] r4:00000000
    [ 192.664273] [<c03990fc>] (sysfs_remove_group) from [<c062d6dc>] (dpm_sysfs_remove+0x54/0x58)
    [ 192.672746] r6:ed98e808 r5:ed98e810 r4:c10366a0
    [ 192.677387] [<c062d688>] (dpm_sysfs_remove) from [<c0621760>] (device_del+0x11c/0x304)
    [ 192.685336] r7:ed98e86c r6:ed851620 r5:ed98e808 r4:ed98e868
    [ 192.691021] [<c0621644>] (device_del) from [<c06dbea0>] (media_devnode_unregister+0x3c/0x50)
    [ 192.699497] r9:ecf6e030 r8:d4f2b928 r7:d4f2b920 r6:ed98e808 r5:ed98e800 r4:c103e80c
    [ 192.707276] [<c06dbe64>] (media_devnode_unregister) from [<c06db848>] (media_device_unregister+0x12c/0x144)
    [ 192.717058] r7:d4f2b920 r6:d4f2b948 r5:d4f2b858 r4:d4f2b920
    [ 192.722761] [<c06db71c>] (media_device_unregister) from [<bf3fa328>] (uvc_delete+0x64/0x138 [uvcvideo])
    [ 192.732194] r9:ecf6e030 r8:00000000 r7:ecfc1010 r6:d4f2b800 r5:c1091318 r4:d4f2b858
    [ 192.739991] [<bf3fa2c4>] (uvc_delete [uvcvideo]) from [<bf3fa51c>] (uvc_release+0x44/0x48 [uvcvideo])
    [ 192.749250] r9:ecf6e030 r8:00000000 r7:ecfc1010 r6:d4f2ba00 r5:c1091318 r4:ecfc1100
    [ 192.757037] [<bf3fa4d8>] (uvc_release [uvcvideo]) from [<c06ddab0>] (v4l2_device_release+0xd0/0xf4)
    [ 192.766123] [<c06dd9e0>] (v4l2_device_release) from [<c0620434>] (device_release+0x34/0x98)
    [ 192.774508] r9:ecf6e030 r8:00000000 r7:ede2a710 r6:d359b380 r5:ecfc1100 r4:ecfc1108
    [ 192.782285] [<c0620400>] (device_release) from [<c04cf9f8>] (kobject_put+0x94/0xf0)
    [ 192.789972] r7:ede2a710 r6:ed4e72c0 r5:c1035f10 r4:ecfc1108
    [ 192.795656] [<c04cf964>] (kobject_put) from [<c062093c>] (put_device+0x1c/0x20)
    [ 192.802993] r6:d54c9b28 r5:ecfc1010 r4:00000000
    [ 192.807629] [<c0620920>] (put_device) from [<c06dd7d4>] (v4l2_release+0x58/0x7c)
    [ 192.815059] [<c06dd77c>] (v4l2_release) from [<c0331544>] (__fput+0x8c/0x1dc)
    [ 192.822222] r5:ecf6e030 r4:ed564300
    [ 192.825812] [<c03314b8>] (__fput) from [<c03316f4>] (____fput+0x10/0x14)
    [ 192.832540] r10:00000000 r9:d3258000 r8:00000000 r7:d42b8000 r6:d42b84e0 r5:c10527e4
    [ 192.840400] r4:d42b84c4
    [ 192.842946] [<c03316e4>] (____fput) from [<c02492a8>] (task_work_run+0xc4/0xe4)
    [ 192.850287] [<c02491e4>] (task_work_run) from [<c020aeb0>] (do_work_pending+0xbc/0xc0)
    [ 192.858237] r9:d3258000 r8:c0207d84 r7:00000006 r6:d3259fb0 r5:c0207d84 r4:d3258000
    [ 192.866015] [<c020adf4>] (do_work_pending) from [<c0207c2c>] (slow_work_pending+0xc/0x20)
    [ 192.874224] r7:00000006 r6:b6f70f18 r5:b6ab53c8 r4:0023e700
    [ 192.881201] ---[ end trace 3820a4c80f022224 ]---
    Freeing pipeline ...
    root@am57xx-evm:~# [ 193.190202] usb 2-1.2: new SuperSpeed USB device number 7 using xhci-hcd
    [ 193.226493] uvcvideo: Found UVC 1.00 device HDMI to U3 capture (1e4e:701f)
    [ 193.245488] uvcvideo: UVC non compliance - GET_DEF(PROBE) not supported. Enabling workaround.
    [ 193.254613] uvcvideo 2-1.2:1.0: Entity type for entity Extension 4 was not initialized!
    [ 193.262953] uvcvideo 2-1.2:1.0: Entity type for entity Processing 3 was not initialized!
    [ 193.272103] uvcvideo 2-1.2:1.0: Entity type for entity Camera 1 was not initialized!

  • 0 in reply to Manu Chen
    TI__Guru**** 173041 points

    Manu Chen said:
    By the way, have you tested any ISO superspeed device against DCW3? I know BULK works.

    Yes, we validated Isoch superspeed transfer in dwc3 device mode, but I don't remember I tested Isoch SS transfers in xHCI host mode, because I don't have a superspeed UVC camera.

    I guess I can connect two AM57x EVM via USB ports, to validate Isoch SS transfers. I will update once I finished the test.

  • 0 in reply to Manu Chen
    TI__Guru**** 173041 points
    I am unable to find any superspeed UVC cameras on the market to run any test. Is there any info for me to buy the camera you use? If not, I don't think there is much we can help in this case, but since AM5728 uses standard Linux xHCI driver, you could try to replicate the issue with the latest kernel from kernel.org (currently the latest version is v4.15-rc7) then you can post you issue on linux-usb@vger.kernel.org for help.
  • 0 in reply to Bin Liu
    Prodigy 210 points

    To be specific, this error happens with a U3 capture card like this https://e2e.ti.com/support/arm/sitara_arm/f/791/p/651653/2393788 

  • 0 in reply to Manu Chen
    Prodigy 210 points
    A BRIO is tested against AM5728 w/o problem yesterday. However the device in discussion works with dwc3 on upboard also. It looks a compatibility issue. Unfortunately I don't have a U3 analyzer to provide more info.
  • 0 in reply to Manu Chen
    TI__Guru**** 173041 points

    Manu Chen said:

    To be specific, this error happens with a U3 capture card like this https://e2e.ti.com/support/arm/sitara_arm/f/791/p/651653/2393788 

    It seems you posted a wrong link. It points to this thread itself.

  • 0 in reply to Manu Chen
    TI__Guru**** 173041 points

    Manu Chen said:
    A BRIO is tested against AM5728w/o problem yesterday. However the device in discussion works with dwc3 on upboard also. It looks a compatibility issue. Unfortunately I don't have a U3 analyzer to provide more info.

    As I mentioned earlier, AM5728 uses unmodified Linux xHCI driver, so if you could reproduce the problem on the latest community kernel, I think there any some xHCI driver experts in the linux-usb mailing list who can help you. You probably don't need a USB analyzer at the beginning of the debug, the xHCI and USB core drivers can generates some debug log, which might give some glue. The xHCI driver maintainers and experts can guide you to generate such logs.

    Please note that there are two symptoms in the logs you provided above, 1) usb device enumeration failed, the camera got reset repeatedly. 2) gstreamer pipeline generates usb TRB DMA errors. The two might be related, but i think we should focus on enumeration problem first.

  • 0 in reply to Bin Liu
    Prodigy 210 points

    Sorry for the previous link. It should be www.avermedia.com/.../extremecap-uvc

    There were two devices tested against 3 platforms. Among which, the upboard is of dwc3 host.

                               AM5728             upboard        Dell-NB

    -------------------------------------------------------------------------------

    HDMI UVC          fialure                 ok                  ok

    BRIO UVC           ok                      ok                   ok

    I don't actually get problem with latest community kernel with upboard or Dell-NB. But community kernel doesn't apply to AM5728-EVM...

  • 0 in reply to Manu Chen
    TI__Guru**** 173041 points

    The community kernel boots on my AM57x EVM, can you please try the .config attached below?

    am57x_config.4.15-rc6.txt

  • 0 in reply to Bin Liu
    Prodigy 210 points
    Thanks Bin.

    This is the (failure) result of 4.15-rc7 kernel against EVM. It disconnects before and after testing....

    --------------------------------------------

    | _ |___ ___ ___ ___ | _ |___ ___ |_|___ ___| |_
    | | _| .'| . | . | | __| _| . | | | -_| _| _|
    |__|__|_| |__,|_ |___| |__| |_| |___|_| |___|___|_|
    |___| |___|

    Arago Project http://arago-project.org VP2730 ttyO2

    Arago 2016.10 VP2730 ttyO2

    VP2730 login: root
    Last login: Mon Jan 1 00:02:43 UTC 2001 on ttyO2
    root@VP2730:~# uname -r
    4.15.0-rc7-00102-gcf1fb15
    root@VP2730:~# [ 40.022993] usb 2-1.2: new SuperSpeed USB device number 3 using xhci-hcd
    [ 40.058948] usb 2-1.2: New USB device found, idVendor=1e4e, idProduct=701f
    [ 40.066227] usb 2-1.2: New USB device strings: Mfr=6, Product=7, SerialNumber=3
    [ 40.073981] usb 2-1.2: Product: HDMI to U3 capture
    [ 40.079176] usb 2-1.2: Manufacturer: Video Grabber
    [ 40.084267] usb 2-1.2: SerialNumber: 20000130041415
    [ 40.304777] media: Linux media interface: v0.10
    [ 40.352750] Linux video capture interface: v2.00
    [ 40.423609] usbcore: registered new interface driver snd-usb-audio
    [ 40.430523] uvcvideo: Found UVC 1.00 device HDMI to U3 capture (1e4e:701f)
    [ 40.522662] uvcvideo: UVC non compliance - GET_DEF(PROBE) not supported. Enabling workaround.
    [ 40.532660] uvcvideo 2-1.2:1.0: Entity type for entity Extension 4 was not initialized!
    [ 40.541318] uvcvideo 2-1.2:1.0: Entity type for entity Processing 3 was not initialized!
    [ 40.549857] uvcvideo 2-1.2:1.0: Entity type for entity Camera 1 was not initialized!
    [ 40.567106] usbcore: registered new interface driver uvcvideo
    [ 40.573231] USB Video Class driver (1.1.1)
    [ 44.623134] usb 2-1.2: USB disconnect, device number 3
    [ 44.992989] usb 2-1.2: new SuperSpeed USB device number 4 using xhci-hcd
    [ 45.028859] usb 2-1.2: New USB device found, idVendor=1e4e, idProduct=701f
    [ 45.036141] usb 2-1.2: New USB device strings: Mfr=6, Product=7, SerialNumber=3
    [ 45.043869] usb 2-1.2: Product: HDMI to U3 capture
    [ 45.048903] usb 2-1.2: Manufacturer: Video Grabber
    [ 45.053991] usb 2-1.2: SerialNumber: 20000130041415
    [ 45.063202] uvcvideo: Found UVC 1.00 device HDMI to U3 capture (1e4e:701f)
    [ 45.077108] uvcvideo: UVC non compliance - GET_DEF(PROBE) not supported. Enabling workaround.
    [ 45.086934] uvcvideo 2-1.2:1.0: Entity type for entity Extension 4 was not initialized!
    [ 45.095537] uvcvideo 2-1.2:1.0: Entity type for entity Processing 3 was not initialized!
    [ 45.104089] uvcvideo 2-1.2:1.0: Entity type for entity Camera 1 was not initialized!
    [ 46.397419] usb 2-1.2: USB disconnect, device number 4
    [ 46.953006] usb 2-1.2: new SuperSpeed USB device number 5 using xhci-hcd
    [ 46.988874] usb 2-1.2: New USB device found, idVendor=1e4e, idProduct=701f
    [ 46.996158] usb 2-1.2: New USB device strings: Mfr=6, Product=7, SerialNumber=3
    [ 47.003889] usb 2-1.2: Product: HDMI to U3 capture
    [ 47.008928] usb 2-1.2: Manufacturer: Video Grabber
    [ 47.014082] usb 2-1.2: SerialNumber: 20000130041415
    [ 47.023366] uvcvideo: Found UVC 1.00 device HDMI to U3 capture (1e4e:701f)
    [ 47.045754] uvcvideo: UVC non compliance - GET_DEF(PROBE) not supported. Enabling workaround.
    [ 47.056017] uvcvideo 2-1.2:1.0: Entity type for entity Extension 4 was not initialized!
    [ 47.064483] uvcvideo 2-1.2:1.0: Entity type for entity Processing 3 was not initialized!
    [ 47.073021] uvcvideo 2-1.2:1.0: Entity type for entity Camera 1 was not initialized!
    sink -v -e-1.0 v4l2src device=/dev/video0 io-mode=2 ! 'video/x-raw, format=(string)YUY2, width=(int)1920, height=(int)1080' ! fake
    [ 61.133795] usb 2-1.2: reset SuperSpeed USB device number 5 using xhci-hcd
    Setting pipeline to PAUSED ...
    Pipeline is live and does not need PREROLL ...
    Setting pipeline to PLAYING ...
    New clock: GstSystemClock
    /GstPipeline:pipeline0/GstV4l2Src:v4l2src0.GstPad:src: caps = "video/x-raw\,\ format\=\(string\)YUY2\,\ width\=\(int\)1920\,\ height\=\(int\)1080\,\ pixel-aspect-ratio\=\(fraction\)1/1\,\ interlace-mode\=\(string\)progressive\,\ colorimetry\=\(string\)1:4:7:1\,\ framerate\=\(fraction\)60/1"
    /GstPipeline:pipeline0/GstCapsFilter:capsfilter0.GstPad:src: caps = "video/x-raw\,\ format\=\(string\)YUY2\,\ width\=\(int\)1920\,\ height\=\(int\)1080\,\ pixel-aspect-ratio\=\(fraction\)1/1\,\ interlace-mode\=\(string\)progressive\,\ colorimetry\=\(string\)1:4:7:1\,\ framerate\=\(fraction\)60/1"
    /GstPipeline:pipeline0/GstFakeSink:fakesink0.GstPad:sink: caps = "video/x-raw\,\ format\=\(string\)YUY2\,\ width\=\(int\)1920\,\ height\=\(int\)1080\,\ pixel-aspect-ratio\=\(fraction\)1/1\,\ interlace-mode\=\(string\)progressive\,\ colorime[ 61.376790] xhci-hcd xhci-hcd.0.auto: ERROR unknown event type 37
    [ 61.409790] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 1
    [ 61.420925] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000fe8b8720 trb-start 00000000fe8b7330 trb-end 00000000fe8b7330 seg-start 00000000fe8b7000 seg-end 00000000fe8b7ff0
    [ 61.437790] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 1
    [ 61.448920] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000fe8b8740 trb-start 00000000fe8b7330 trb-end 00000000fe8b7330 seg-start 00000000fe8b7000 seg-end 00000000fe8b7ff0
    [ 61.465785] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
    [ 61.477003] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000fe8b8750 trb-start 00000000fe8b7330 trb-end 00000000fe8b7330 seg-start 00000000fe8b7000 seg-end 00000000fe8b7ff0
    [ 61.493869] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
    [ 61.505087] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000fe8b8770 trb-start 00000000fe8b7330 trb-end 00000000fe8b7330 seg-start 00000000fe8b7000 seg-end 00000000fe8b7ff0
    [ 61.521953] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
    [ 61.533182] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000fe8b8780 trb-start 00000000fe8b7330 trb-end 00000000fe8b7330 seg-start 00000000fe8b7000 seg-end 00000000fe8b7ff0
    [ 61.550046] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
    [ 61.561272] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000fe8b87a0 trb-start 00000000fe8b7330 trb-end 00000000fe8b7330 seg-start 00000000fe8b7000 seg-end 00000000fe8b7ff0
    [ 61.578144] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
    [ 61.589370] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000fe8b87b0 trb-start 00000000fe8b7330 trb-end 00000000fe8b7330 seg-start 00000000fe8b7000 seg-end 00000000fe8b7ff0
    [ 61.606235] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
    [ 61.617451] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000fe8b87d0 trb-start 00000000fe8b7330 trb-end 00000000fe8b7330 seg-start 00000000fe8b7000 seg-end 00000000fe8b7ff0
    [ 61.634315] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
    [ 61.645538] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000fe8b87e0 trb-start 00000000fe8b7330 trb-end 00000000fe8b7330 seg-start 00000000fe8b7000 seg-end 00000000fe8b7ff0
    [ 61.662398] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 1
    [ 61.673527] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000fe8b87f0 trb-start 00000000fe8b7330 trb-end 00000000fe8b7330 seg-start 00000000fe8b7000 seg-end 00000000fe8b7ff0
    [ 61.690391] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
    [ 61.701606] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000fe8b8800 trb-start 00000000fe8b7330 trb-end 00000000fe8b7330 seg-start 00000000fe8b7000 seg-end 00000000fe8b7ff0
    [ 61.718476] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
    [ 61.729693] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000fe8b8820 trb-start 00000000fe8b7330 trb-end 00000000fe8b7330 seg-start 00000000fe8b7000 seg-end 00000000fe8b7ff0
    [ 61.746552] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
    [ 61.757769] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000fe8b8830 trb-start 00000000fe8b7330 trb-end 00000000fe8b7330 seg-start 00000000fe8b7000 seg-end 00000000fe8b7ff0
    [ 61.774623] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
    [ 61.785847] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000fe8b8850 trb-start 00000000fe8b7330 trb-end 00000000fe8b7330 seg-start 00000000fe8b7000 seg-end 00000000fe8b7ff0
    [ 61.802708] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
    [ 61.813920] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000fe8b8860 trb-start 00000000fe8b7330 trb-end 00000000fe8b7330 seg-start 00000000fe8b7000 seg-end 00000000fe8b7ff0
    [ 61.830777] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
    [ 61.841999] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000fe8b8880 trb-start 00000000fe8b7330 trb-end 00000000fe8b7330 seg-start 00000000fe8b7000 seg-end 00000000fe8b7ff0
    [ 61.858862] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
    [ 61.870085] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000fe8b8890 trb-start 00000000fe8b7330 trb-end 00000000fe8b7330 seg-start 00000000fe8b7000 seg-end 00000000fe8b7ff0
    [ 61.886948] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
    [ 61.898170] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000fe8b88a0 trb-start 00000000fe8b7330 trb-end 00000000fe8b7330 seg-start 00000000fe8b7000 seg-end 00000000fe8b7ff0
    [ 61.915028] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
    [ 61.926243] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000fe8b88c0 trb-start 00000000fe8b7330 trb-end 00000000fe8b7330 seg-start 00000000fe8b7000 seg-end 00000000fe8b7ff0
    [ 61.943108] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
    [ 61.954318] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000fe8b88d0 trb-start 00000000fe8b7330 trb-end 00000000fe8b7330 seg-start 00000000fe8b7000 seg-end 00000000fe8b7ff0
    [ 61.971190] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
    [ 61.982415] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000fe8b88f0 trb-start 00000000fe8b7330 trb-end 00000000fe8b7330 seg-start 00000000fe8b7000 seg-end 00000000fe8b7ff0
    [ 61.999275] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
    [ 62.010500] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000fe8b8900 trb-start 00000000fe8b7330 trb-end 00000000fe8b7330 seg-start 00000000fe8b7000 seg-end 00000000fe8b7ff0
    [ 62.027359] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
    [ 62.038574] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000fe8b8920 trb-start 00000000fe8b7330 trb-end 00000000fe8b7330 seg-start 00000000fe8b7000 seg-end 00000000fe8b7ff0
    [ 62.055445] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
    [ 62.066657] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000fe8b8930 trb-start 00000000fe8b7330 trb-end 00000000fe8b7330 seg-start 00000000fe8b7000 seg-end 00000000fe8b7ff0
    [ 62.083521] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
    [ 62.094739] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000fe8b8950 trb-start 00000000fe8b7330 trb-end 00000000fe8b7330 seg-start 00000000fe8b7000 seg-end 00000000fe8b7ff0
    [ 62.111594] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
    [ 62.122811] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000fe8b8960 trb-start 00000000fe8b7330 trb-end 00000000fe8b7330 seg-start 00000000fe8b7000 seg-end 00000000fe8b7ff0
    [ 62.139676] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 1
    [ 62.150802] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000fe8b8970 trb-start 00000000fe8b7330 trb-end 00000000fe8b7330 seg-start 00000000fe8b7000 seg-end 00000000fe8b7ff0
    [ 62.167673] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
    [ 62.178898] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000fe8b8980 trb-start 00000000fe8b7330 trb-end 00000000fe8b7330 seg-start 00000000fe8b7000 seg-end 00000000fe8b7ff0
    [ 62.195760] xhci-hcd xhci-hcd.0.auto: ERROR unknown event type 37
    [ 62.202218] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 13
    [ 62.213441] xhci-hcd xhci-hcd.0.auto: Looking for event-dma 00000000fe8b89a0 trb-start 00000000fe8b7330 trb-end 00000000fe8b7330 seg-start 00000000fe8b7000 seg-end 00000000fe8b7ff0
    [ 62.253412] xhci-hcd xhci-hcd.0.auto: ERROR unknown event type 37
    try\=\(string\)1:4:7:1\,\ framerate\=\(fraction\)60/1"
    /GstPipeline:pipeline0/GstCapsFilter:capsfilter0.GstPad:sink: caps = "video/x-raw\,\ format\=\(string\)YUY2\,\ width\=\(int\)1920\,\ height\=\(int\)1080\,\ pixel-aspect-ratio\=\(fraction\)1/1\,\ interlace-mode\=\(string\)progressive\,\ colorimetry\=\(string\)1:4:7:1\,\ framerate\=\(fraction\)60/1"
    [ 62.637368] usb 2-1.2: USB disconnect, device number 5
    ERROR: from element /GstPipeline:pipeline0/GstV4l2Src:v4l2src0: Could not read from resource.
    Additional debug info:
    ../../../gst-plugins-good-1.6.3/sys/v4l2/gstv4l2bufferpool.c(1055): gst_v4l2_buffer_pool_poll (): /GstPipeline:pipeline0/GstV4l2Src:v4l2src0:
    poll error 1: Invalid argument (22)
    EOS on shutdown enabled -- waiting for EOS after Error
    Waiting for EOS...
    ERROR: from element /GstPipeline:pipeline0/GstV4l2Src:v4l2src0: Failed to allocate a buffer
    Additional debug info:
    ../../../gst-plugins-good-1.6.3/sys/v4l2/gstv4l2src.c(848): gst_v4l2src_create (): /GstPipeline:pipeline0/GstV4l2Src:v4l2src0
    ERROR: from element /GstPipeline:pipeline0/GstV4l2Src:v4l2src0: Internal data flow error.
    Additional debug info:
    ../../../../gstreamer-1.6.3/libs/gst/base/gstbasesrc.c(2943): gst_base_src_loop (): /GstPipeline:pipeline0/GstV4l2Src:v4l2src0:
    streaming task paused, reason error (-5)
    Got EOS from element "pipeline0".
    EOS received - stopping pipeline...
    Execution ended after 0:00:01.416189334
    Setting pipeline to PAUSED ...
    Setting pipeline to READY ...
    Setting pipeline to NULL ...
    Freeing pipeline ...
    root@VP2730:~# [ 63.213004] usb 2-1.2: new SuperSpeed USB device number 6 using xhci-hcd
    [ 63.249000] usb 2-1.2: New USB device found, idVendor=1e4e, idProduct=701f
    [ 63.256269] usb 2-1.2: New USB device strings: Mfr=6, Product=7, SerialNumber=3
    [ 63.264007] usb 2-1.2: Product: HDMI to U3 capture
    [ 63.269067] usb 2-1.2: Manufacturer: Video Grabber
    [ 63.274167] usb 2-1.2: SerialNumber: 20000130041415
    [ 63.285444] uvcvideo: Found UVC 1.00 device HDMI to U3 capture (1e4e:701f)
    [ 63.297189] uvcvideo: UVC non compliance - GET_DEF(PROBE) not supported. Enabling workaround.
    [ 63.306791] uvcvideo 2-1.2:1.0: Entity type for entity Extension 4 was not initialized!
    [ 63.315288] uvcvideo 2-1.2:1.0: Entity type for entity Processing 3 was not initialized!
    [ 63.323845] uvcvideo 2-1.2:1.0: Entity type for entity Camera 1 was not initialized!
  • 0 in reply to Manu Chen
    TI__Guru**** 173041 points

    Manu Chen said:
    This is the (failure) result of 4.15-rc7 kernel against EVM. It disconnects before and after testing....

    Thanks for the testing.

    I just wanted to get clarification - the disconnect and re-enumeration before testing just happened automatically without you do anything to the usb dongle, right? And if you don't start the testing, will the dongle get disconnected and re-enumerated repeatedly forever?

  • 0 in reply to Bin Liu
    Prodigy 210 points
    Hi Bin,

    It disconnect once upon device installation before test starts. Not continuously re-disconnecting. Occasionally disconnection doesn't happen.

    Thanks.
  • 0 in reply to Manu Chen
    TI__Guru**** 173041 points

    Manu,

    I purchased the ExtremeCap UVC device and am able to replicate the issue which is similar to yours. I got the following message in the kernel log.

    [ 54.426473] xhci-hcd xhci-hcd.0.auto: ERROR Transfer event TRB DMA ptr not part of current TD ep_index 18 comp_code 1

    But when I add 'vmalloc=512M' in the kernel boot args, this message goes away.

    I am not a gstreamer expert, but I guess streaming 1920x1080@60fps YUV video requires much more data buffer which kernel doesn't provide by default. So you have to tune the kernel to ensure your application gets enough buffer.

    Please note that

    1. The gstreamer pipeline you provided directly stream the uvc video to fakesink in which case vmalloc pool affects the behavior, but I guess your project does some kind of video processing, then the pipeline is different. The video buffer might not come from vmalloc pool, could be from CMA or other DMA pool. You have to understand the pipeline your use on how the data buffers are allocated and how much is needed, so that you know where in the kernel to tune the buffer pool.

    2. 1920x1080@60fps YUV stream requires about 240Mbps data bandwidth on USB super-speed bus, which AM57x USB cannot achieve.