Initialization stalls out

panevain commented 4 years ago

Hey,

In v1.1 of the project, our initialization of a webcam always "blue screens" and fails to load the webcam's image. Please let me know what supporting documentation I need to submit to help solve this issue.

Windwoes commented 4 years ago

@Matthew1231A Sorry to hear that! A couple questions:

Are you just using the unmodified webcam example program?
What phone are you using?
Are you using a powered USB hub?
What webcam are you using?
What version of the SDK are you using?
Does SDK's Vuforia webcam sample work?
What resolution are you trying to run the webcam at?
Does the EasyOpenCV internal camera example work?

NoahAndrews commented 4 years ago

@Matthew1231A this may be your issue (workarounds are listed): https://ftcforum.usfirst.org/forum/ftc-technology/74722-bug-in-v5-2-that-breaks-support-for-web-cameras

Windwoes commented 4 years ago

@NoahAndrews yeah I was wondering the same, which is why I asked if the Vuforia webcam sample worked.

panevain commented 4 years ago

@FROGbots-4634 the Vuforia webcam sample works correctly without the workaround. I don't have the hardware with me, but I will try the workaround on Wednesday.

And to answer your questions: We are using Moto G5's Yes, we have a powered USB hub and yes, it has 5V at 2A Logitech C270 webcam FTC 5.2 SDK Yes, the Vuforia SDK works We are running at 320x240 The EasyOpenCV internal camera works

mtbbiker commented 4 years ago

@FROGbots-4634 we have a similar issue, We use a C910 Webcam. The Vuforia example works (Actually we have used it successfully in Rover Ruckus). We would like to try OpenCV as alternative. Also we tried the internal camera examples and they work perfectly. Did we miss some configuration or calibration. We did tried different resolution settings

Windwoes commented 4 years ago

@mtbbiker can you check and see if applying the workaround Noah mentioned makes a difference?

Windwoes commented 4 years ago

@Matthew1231A I just tested the EasyOpenCV webcam sample on a Moto G5 Plus running Android 7.0 with a Logitech C920 webcam without a powered USB hub using the stock SDK 5.2 and it ran flawlessly with and without the 64-bit workaround. (The Vuforia webcam sample also worked without the workaround which is a hrrmmmmm, but in any case, it worked).

haifengchicago commented 4 years ago

Same issue here. We have Moto G2 with Logitech C270 with a power USB hub. Vuforia works, but the EasyOpenCV webcam is bluescreen. I did the workaround, still no use.

NoahAndrews commented 4 years ago

Can those of you having this problem try using the library with SDK 5.1?

Windwoes commented 4 years ago

Also, could someone please send a pre-built APK that's known to have the issue on your end?

NoahAndrews commented 4 years ago

I can't reproduce on a Control Hub with the workaround in place, with a C270 camera

Windwoes commented 4 years ago

In addition to the "known bad" APK mentioned earlier, could someone please provide the logs from this encounter?

mtbbiker commented 4 years ago

@mtbbiker can you check and see if applying the workaround Noah mentioned makes a difference?

No Luck with the work around

NoahAndrews commented 4 years ago

@mtbbiker Can you provide a log file and/or the known bad APK?

mtbbiker commented 4 years ago

@mtbbiker Can you provide a log file and/or the known bad APK?

I'll sent you the log, I am not too sure what you mean with the "bad" APK.

Windwoes commented 4 years ago

@mtbbiker "bad APK" as in an APK that you've verified has the issue that you generated doing Build --> Build Bundles / APK --> Build APK in Android Studio.

mtbbiker commented 4 years ago

@FROGbots-4634 a lengthy log, I can see a few errors (Hope this will provide some clue)

V/Robocol: received command: CMD_SET_MATCH_NUMBER(12607) 0
    received command: CMD_INIT_OP_MODE(12608) WebcamExample
I/RobotCore: ******************** START - OPMODE WebcamExample ********************
I/RobotCore: Attempting to switch to op mode WebcamExample
D/STMicroVL53L0X:: Checking to see if it's really a VL53L0X sensor...
D/STMicroVL53L0X:: Reg 0xC0 = ee (should be 0xEE)
D/STMicroVL53L0X:: Reg 0xC1 = aa (should be 0xAA)
    Reg 0xC2 = 10 (should be 0x10)
D/STMicroVL53L0X:: Reg 0x51 = 0 (should be 0x0099)
D/STMicroVL53L0X:: Reg 0x61 = 0 (should be 0x0000)
D/STMicroVL53L0X:: initial sig rate lim (MCPS) 0,250000
D/STMicroVL53L0X:: adjusted sig rate lim (MCPS) 0,250000
V/ThreadPool: container(0x0e7419b0: LinearOpMode) added id=2392 TID=0 count=1
V/RobotCore: thread: 'LinearOpMode main' starting...
D/CameraManager: doOpenCamera()...
V/Robocol: sending CMD_NOTIFY_INIT_OP_MODE(2855), attempt: 0
D/CameraManager: requesting permission for camera: Webcam(9828DE4F)
D/WebcamNameImpl: requesting permission for /dev/bus/usb/001/004
V/WebcamNameImpl: asyncRequestUsbPermission()...
D/WebcamNameImpl: permission already available for /dev/bus/usb/001/004
V/ThreadPool: container(0x05210305: default threadpool) added id=2393 TID=0 count=1
D/OpenCvViewport: CheckState(): user requested that we deactivate
    CheckState(): already deactivated
V/WebcamNameImpl: ...asyncRequestUsbPermission()
D/ContinuationSynchronizer: awaiting(camera open)...
D/WebcamNameImpl: permission for /dev/bus/usb/001/004=true
D/CameraManager: permission granted for camera: Webcam(9828DE4F)
    asyncOpenCamera(Webcam(9828DE4F))...
    asyncOpenWebcam(Webcam(9828DE4F))...
V/UsbResiliantWebcam: construct(0x0ef920dc)
D/UsbResiliantWebcam: openAssumingPermission()...
D/UvcContext: usb device is *not* UVC compatible, /dev/bus/usb/001/005
    found webcam: usbPath=/dev/bus/usb/001/004 vid=1133 pid=2093 serial=9828DE4F product=HD Pro Webcam C920
D/Uvc: [jni_context.cpp:195] Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcContext_nativeCreateUvcDevice()...
V/Uvc: API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcContext_nativeCreateUvcDevice: enter...
D/libusb: [210.105822] [0000798d] libusb: debug [op_create] op_create: szUsbPath=/dev/bus/usb/001/004 szSysfsDir=1-1.2
D/Uvc: [device.cpp:613] uvc_create_uvc_device()...
    [libuvc/libuvc_internal.h:354] uvc_device::uvc_device()...
    [libuvc/libuvc_internal.h:383] acquired vid=1133 & pid=2093
    [libuvc/libuvc_internal.h:354] ...uvc_device::uvc_device()
    [device.cpp:613] ...uvc_create_uvc_device() rc=0
V/Uvc: API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcContext_nativeCreateUvcDevice: ...exit
D/Uvc: [jni_context.cpp:195] ...Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcContext_nativeCreateUvcDevice()
V/UvcDevice: construct(pointer=0x9bdfa200|null)
D/Uvc: [jni_device.cpp:108] Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDevice_nativeGetLibUsbDevice()...
    [jni_device.cpp:108] ...Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDevice_nativeGetLibUsbDevice()
V/LibUsbDevice: construct(pointer=0x95f4fe00)
D/UvcDevice: open()...
D/Uvc: [jni_device.cpp:50] Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDevice_nativeSetUsbDeviceInfo()...
    [jni_device.cpp:50] ...Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDevice_nativeSetUsbDeviceInfo()
    [jni_device.cpp:241] Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDevice_nativeOpenDeviceHandle()...
V/Uvc: API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDevice_nativeOpenDeviceHandle: enter...
D/Uvc: [device.cpp:279] uvc_open()...
    [libuvc/libuvc_internal.h:364] uvc_device::open()...
D/libusb: [210.172326] [0000798d] libusb: debug [op_open] op_open: szUsbPath=/dev/bus/usb/001/004
D/Uvc: [libuvc/libuvc_internal.h:364] ...uvc_device::open() rc=0
    [device.cpp:295] calling libusb_reset_device()...
D/Uvc: [device.cpp:303] ...libusb_reset_device() called
    [device.cpp:311] libusb_open() = 0
    [libuvc/libuvc_internal.h:735] uvc_device_handle::uvc_device_handle()...
    [libuvc/libuvc_internal.h:735] ...uvc_device_handle::uvc_device_handle()
    [device.cpp:386] uvc_get_device_info()...
D/libusb: [210.591676] [0000798d] libusb: debug [op_get_config_descriptor] op_get_config_descriptor: config_index=0
    [210.591735] [0000798d] libusb: debug [op_get_config_descriptor] op_get_config_descriptor: config_index=0
D/Uvc: [device.cpp:986] uvc_scan_control()...
    [device.cpp:1041] uvc_parse_vc_header()...
    [device.cpp:1284] uvc_scan_streaming()...
    [device.cpp:1340] uvc_parse_vs_input_header()...
    [device.cpp:1340] ...uvc_parse_vs_input_header() rc=0
    [device.cpp:1389] uvc_parse_vs_format_uncompressed()...
    [device.cpp:1389] ...uvc_parse_vs_format_uncompressed() rc=0
V/Uvc: [device.cpp:1630] unsupported descriptor subtype: 13 UVC_VS_COLORFORMAT
D/Uvc: [device.cpp:1419] uvc_parse_vs_frame_format()...
D/Uvc: [device.cpp:1419] ...uvc_parse_vs_frame_format() rc=0
V/Uvc: [device.cpp:1630] unsupported descriptor subtype: 13 UVC_VS_COLORFORMAT
D/Uvc: [device.cpp:1449] uvc_parse_vs_format_mjpeg()...
    [device.cpp:1449] ...uvc_parse_vs_format_mjpeg() rc=0
V/Uvc: [device.cpp:1630] unsupported descriptor subtype: 13 UVC_VS_COLORFORMAT
D/Uvc: [device.cpp:1284] ...uvc_scan_streaming() rc=0
    [device.cpp:1041] ...uvc_parse_vc_header() rc=0
    [device.cpp:1083] uvc_parse_vc_input_terminal()...
    [device.cpp:1083] ...uvc_parse_vc_input_terminal() rc=0
    [device.cpp:1156] uvc_parse_vc_processing_unit()...
    [device.cpp:1156] ...uvc_parse_vc_processing_unit() rc=0
    [device.cpp:986] ...uvc_scan_control() rc=0
    [device.cpp:386] ...uvc_get_device_info() rc=0
    [device.cpp:326] claiming control interface 0
    [libuvc/libuvc_internal.h:773] uvc_device_handle::claimInterface(idx=0)...
D/UvcDevice: claimInterface(0)
    claimInterface(0) succeeded
D/Uvc: [libuvc/libuvc_internal.h:786] claimInterface(0) succeeded
    [libuvc/libuvc_internal.h:773] ...uvc_device_handle::claimInterface() rc=0
    [device.cpp:279] ...uvc_open() rc=0
V/Uvc: API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDevice_nativeOpenDeviceHandle: ...exit
D/Uvc: [jni_device.cpp:241] ...Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDevice_nativeOpenDeviceHandle()
V/UvcDeviceHandle: construct(pointer=0xb477d660)
V/CameraImpl: construct(0x0906e8ba)
D/UsbResiliantWebcam.InterveningStateCallback: onOpened() camera=CameraImpl(UvcDeviceHandle(pointer=0xb477d660|UvcDevice(/dev/bus/usb/001/004)))...
D/UsbResiliantWebcam: changeDelegatedCamera(null->CameraImpl(UvcDeviceHandle(pointer=0xb477d660|UvcDevice(/dev/bus/usb/001/004))))...
D/UvcApiFocusControl: isModeSupported(Auto)...
    ...isModeSupported(Auto): false
    isModeSupported(ContinuousAuto)...
    ...isModeSupported(ContinuousAuto): true
    isModeSupported(Macro)...
    ...isModeSupported(Macro): false
    isModeSupported(Infinity)...
    ...isModeSupported(Infinity): false
    isModeSupported(Fixed)...
    ...isModeSupported(Fixed): true
    isFocusLengthSupported...
    ...isFocusLengthSupported: true
    getMinFocusLength()...
D/UvcApiFocusControl: ...getMinFocusLength(): 0.0
D/UvcApiFocusControl: getMaxFocusLength()...
    ...getMaxFocusLength(): 250.0
    getFocusLength()...
D/UvcDeviceHandle: [jni_devicehandle.cpp:525] focusLength=0
D/UvcApiFocusControl: ...getFocusLength(): 0.0
D/CachingExposureControl: onCameraChanged(null->CameraImpl(UvcDeviceHandle(pointer=0xb477d660|UvcDevice(/dev/bus/usb/001/004))))...
D/UvcApiExposureControl: isModeSupported(Auto)...
D/UvcApiExposureControl: ...isModeSupported(Auto): false
    isModeSupported(ContinuousAuto)...
    ...isModeSupported(ContinuousAuto): false
    isModeSupported(Manual)...
    ...isModeSupported(Manual): true
    isModeSupported(ShutterPriority)...
    ...isModeSupported(ShutterPriority): false
    isModeSupported(AperturePriority)...
    ...isModeSupported(AperturePriority): true
    isExposureSupported()...
    ...isExposureSupported(): true
    getMinExposure(NANOSECONDS)...
D/Uvc: [jni_devicehandle.cpp:373] Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDeviceHandle_nativeGetMinExposure()...
    [jni_devicehandle.cpp:373] ...Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDeviceHandle_nativeGetMinExposure()
D/UvcApiExposureControl: ...getMinExposure(NANOSECONDS): 300000
    getMaxExposure(NANOSECONDS)...
D/UvcApiExposureControl: ...getMaxExposure(NANOSECONDS): 204700000
    getMode()...
D/Uvc: [jni_devicehandle.cpp:221] Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDeviceHandle_nativeGetVuforiaExposureMode()...
    [jni_devicehandle.cpp:221] ...Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDeviceHandle_nativeGetVuforiaExposureMode()
D/UvcApiExposureControl: ...getMode(): AperturePriority
D/CachingExposureControl: ...onCameraChanged(null->CameraImpl(UvcDeviceHandle(pointer=0xb477d660|UvcDevice(/dev/bus/usb/001/004))))
D/UsbResiliantWebcam: ...changeDelegatedCamera(null->CameraImpl(UvcDeviceHandle(pointer=0xb477d660|UvcDevice(/dev/bus/usb/001/004))))
    openSelfAndReport()...
V/CameraImpl: construct(0x0cb5f36b)
V/ThreadPool: container(0x05210305: default threadpool) added id=2394 TID=0 count=2
D/UsbResiliantWebcam: ...openSelfAndReport()
D/UsbResiliantWebcam.InterveningStateCallback: ...onOpened() camera=CameraImpl(UvcDeviceHandle(pointer=0xb477d660|UvcDevice(/dev/bus/usb/001/004)))
D/UvcDevice: ...open()
D/UsbResiliantWebcam: ...openAssumingPermission()
D/CameraManager: camera reports opened: CameraImpl(UsbResiliantWebcam(Webcam(9828DE4F)))
D/ContinuationSynchronizer: finish("camera reports opened: Webcam(9828DE4F)": CameraImpl(UsbResiliantWebcam(Webcam(9828DE4F))))...
    ...finish("camera reports opened: Webcam(9828DE4F)": CameraImpl(UsbResiliantWebcam(Webcam(9828DE4F))))
D/ContinuationSynchronizer: ...awaiting(camera open)
D/CameraManager: ...asyncOpenWebcam(Webcam(9828DE4F))
    ...asyncOpenCamera(Webcam(9828DE4F))
D/CameraManager: ...doOpenCamera()
D/UvcContext: usb device is *not* UVC compatible, /dev/bus/usb/001/005
    found webcam: usbPath=/dev/bus/usb/001/004 vid=1133 pid=2093 serial=9828DE4F product=HD Pro Webcam C920
D/Uvc: [jni_context.cpp:195] Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcContext_nativeCreateUvcDevice()...
V/Uvc: API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcContext_nativeCreateUvcDevice: enter...
D/libusb: [210.645101] [0000798c] libusb: debug [op_create] op_create: szUsbPath=/dev/bus/usb/001/004 szSysfsDir=1-1.2
D/Uvc: [device.cpp:613] uvc_create_uvc_device()...
    [libuvc/libuvc_internal.h:354] uvc_device::uvc_device()...
    [libuvc/libuvc_internal.h:383] acquired vid=1133 & pid=2093
    [libuvc/libuvc_internal.h:354] ...uvc_device::uvc_device()
    [device.cpp:613] ...uvc_create_uvc_device() rc=0
V/Uvc: API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcContext_nativeCreateUvcDevice: ...exit
D/Uvc: [jni_context.cpp:195] ...Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcContext_nativeCreateUvcDevice()
V/UvcDevice: construct(pointer=0x9bdfa0e8|null)
D/Uvc: [jni_device.cpp:108] Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDevice_nativeGetLibUsbDevice()...
    [jni_device.cpp:108] ...Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDevice_nativeGetLibUsbDevice()
V/LibUsbDevice: construct(pointer=0x95f4fe00)
V/UvcApiCameraCharacteristicsBuilder: construct(0x0ea14b61)
D/Uvc: [jni_device.cpp:297] Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDevice_nativeGetDeviceInfo()...
V/Uvc: API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDevice_nativeGetDeviceInfo: enter...
D/Uvc: [device.cpp:386] uvc_get_device_info()...
D/libusb: [210.650082] [0000798c] libusb: debug [op_get_config_descriptor] op_get_config_descriptor: config_index=0
    [210.650271] [0000798c] libusb: debug [op_get_config_descriptor] op_get_config_descriptor: config_index=0
D/Uvc: [device.cpp:986] uvc_scan_control()...
    [device.cpp:1041] uvc_parse_vc_header()...
    [device.cpp:1284] uvc_scan_streaming()...
    [device.cpp:1340] uvc_parse_vs_input_header()...
    [device.cpp:1340] ...uvc_parse_vs_input_header() rc=0
    [device.cpp:1389] uvc_parse_vs_format_uncompressed()...
    [device.cpp:1389] ...uvc_parse_vs_format_uncompressed() rc=0
V/Uvc: [device.cpp:1630] unsupported descriptor subtype: 13 UVC_VS_COLORFORMAT
D/Uvc: [device.cpp:1419] uvc_parse_vs_frame_format()...
    [device.cpp:1419] ...uvc_parse_vs_frame_format() rc=0
V/Uvc: [device.cpp:1630] unsupported descriptor subtype: 13 UVC_VS_COLORFORMAT
D/Uvc: [device.cpp:1449] uvc_parse_vs_format_mjpeg()...
    [device.cpp:1449] ...uvc_parse_vs_format_mjpeg() rc=0
V/Uvc: [device.cpp:1630] unsupported descriptor subtype: 13 UVC_VS_COLORFORMAT
D/Uvc: [device.cpp:1284] ...uvc_scan_streaming() rc=0
    [device.cpp:1041] ...uvc_parse_vc_header() rc=0
    [device.cpp:1083] uvc_parse_vc_input_terminal()...
    [device.cpp:1083] ...uvc_parse_vc_input_terminal() rc=0
    [device.cpp:1156] uvc_parse_vc_processing_unit()...
    [device.cpp:1156] ...uvc_parse_vc_processing_unit() rc=0
    [device.cpp:986] ...uvc_scan_control() rc=0
    [device.cpp:386] ...uvc_get_device_info() rc=0
V/Uvc: API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDevice_nativeGetDeviceInfo: ...exit
D/Uvc: [jni_device.cpp:297] ...Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDevice_nativeGetDeviceInfo()
V/UvcDeviceInfo: construct(pointer=0x9be21550)
V/UvcStreamingInterface: construct(pointer=0x9c17f0e0)
V/UvcStreamingInterface: destroy(pointer=0x9c17f0e0)
V/UvcDeviceInfo: destroy(pointer=0x9be21550)
D/Uvc: [jni_deviceinfo.cpp:63] Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDeviceInfo_nativeFreeDeviceInfo()...
V/Uvc: API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDeviceInfo_nativeFreeDeviceInfo: enter...
D/Uvc: [device.cpp:433] uvc_free_device_info()...
    [device.cpp:433] ...uvc_free_device_info()
V/Uvc: API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDeviceInfo_nativeFreeDeviceInfo: ...exit
D/Uvc: [jni_deviceinfo.cpp:63] ...Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDeviceInfo_nativeFreeDeviceInfo()
V/UvcApiCameraCharacteristicsBuilder: destroy(hash=0x0ea14b61)
V/UvcDevice: destroy(pointer=0x9bdfa0e8|/dev/bus/usb/001/004)
D/Uvc: [jni_device.cpp:126] Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDevice_nativeReleaseRefDevice()...
V/Uvc: API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDevice_nativeReleaseRefDevice: enter...
D/Uvc: [device.cpp:882] uvc_unref_device()...
    [device.cpp:882] ...uvc_unref_device()
V/Uvc: API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDevice_nativeReleaseRefDevice: ...exit
D/Uvc: [jni_device.cpp:126] ...Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDevice_nativeReleaseRefDevice()
V/LibUsbDevice: destroy(pointer=0x95f4fe00)
D/Uvc: [jni_libusb_device.cpp:64] Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_LibUsbDevice_nativeReleaseRefDevice()...
    [jni_libusb_device.cpp:64] ...Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_LibUsbDevice_nativeReleaseRefDevice()
D/OpenCvViewport: CheckState(): user requested that we activate
    CheckState(): activating viewport
D/UsbResiliantWebcam: createCaptureSession()...
V/DelCaptureSession: construct(0x0daad686)
D/UsbResiliantWebcam|DelCaptureSession: onCameraChange(null->CameraImpl(UvcDeviceHandle(pointer=0xb477d660|UvcDevice(/dev/bus/usb/001/004))))...
D/OpenCvViewportRenderThread: I am alive!
D/UsbResiliantWebcam|DelCaptureSession: ...onCameraChange(null->CameraImpl(UvcDeviceHandle(pointer=0xb477d660|UvcDevice(/dev/bus/usb/001/004))))
D/CachingExposureControl: onCameraChanged(CameraImpl(UvcDeviceHandle(pointer=0xb477d660|UvcDevice(/dev/bus/usb/001/004)))->CameraImpl(UvcDeviceHandle(pointer=0xb477d660|UvcDevice(/dev/bus/usb/001/004))))...
    ...onCameraChanged(CameraImpl(UvcDeviceHandle(pointer=0xb477d660|UvcDevice(/dev/bus/usb/001/004)))->CameraImpl(UvcDeviceHandle(pointer=0xb477d660|UvcDevice(/dev/bus/usb/001/004))))
D/UsbResiliantWebcam: ...createCaptureSession()
D/UsbResiliantWebcam|DelCaptureSession: startCapture()...
V/DelCaptureSequence: construct(0x00be5b47)
D/UsbResiliantWebcam|DelCaptureSequence: onCameraChange(null->CameraImpl(UvcDeviceHandle(pointer=0xb477d660|UvcDevice(/dev/bus/usb/001/004))))...
    pauseStreaming(Stopped)...
    ...pauseStreaming(Stopped)
    resumeStreaming(Stopped)...
    ...resumeStreaming(Stopped)
    ...onCameraChange(null->CameraImpl(UvcDeviceHandle(pointer=0xb477d660|UvcDevice(/dev/bus/usb/001/004))))
    startStreaming(Stopped)...
    doStreaming()...
V/UvcApiCaptureSession: construct(0x00c6af74)
D/UsbResiliantWebcam|DelCaptureSession: camera session is configured: Webcam(9828DE4F)
V/UvcApiCameraCaptureSequence: construct(0x05c63c9d)
D/UvcDeviceHandle: getStreamControl(320x240 30)...
V/UvcStreamCtrl: construct(0x0a4dd512)
D/Uvc: [jni_devicehandle.cpp:115] Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDeviceHandle_nativeGetStreamControlFormatSize()...
V/Uvc: API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDeviceHandle_nativeGetStreamControlFormatSize: enter...
D/Uvc: [stream.cpp:375] uvc_get_stream_ctrl_format_size()...
    [libuvc/libuvc_internal.h:773] uvc_device_handle::claimInterface(idx=1)...
D/UvcDevice: claimInterface(1)
    claimInterface(1) succeeded
D/Uvc: [libuvc/libuvc_internal.h:786] claimInterface(1) succeeded
    [libuvc/libuvc_internal.h:773] ...uvc_device_handle::claimInterface() rc=0
D/UvcStream: [stream.cpp:414] 320x240 30fps
D/Uvc: [stream.cpp:164] uvc_query_stream_ctrl()...
    [stream.cpp:164] ...uvc_query_stream_ctrl() rc=0
    [libuvc/libuvc_internal.h:796] uvc_device_handle::releaseInterface()...
D/UvcDevice: releaseInterface(1)
    releaseInterface(1) succeeded
D/Uvc: [libuvc/libuvc_internal.h:796] ...uvc_device_handle::releaseInterface() rc=0
    [stream.cpp:484] uvc_probe_stream_ctrl()...
    [libuvc/libuvc_internal.h:773] uvc_device_handle::claimInterface(idx=1)...
D/UvcDevice: claimInterface(1)
    claimInterface(1) succeeded
D/Uvc: [libuvc/libuvc_internal.h:786] claimInterface(1) succeeded
    [libuvc/libuvc_internal.h:773] ...uvc_device_handle::claimInterface() rc=0
    [stream.cpp:164] uvc_query_stream_ctrl()...
    [stream.cpp:164] ...uvc_query_stream_ctrl() rc=0
    [stream.cpp:164] uvc_query_stream_ctrl()...
    [stream.cpp:164] ...uvc_query_stream_ctrl() rc=0
    [stream.cpp:484] ...uvc_probe_stream_ctrl() rc=0
    [stream.cpp:375] ...uvc_get_stream_ctrl_format_size() rc=0
V/Uvc: API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDeviceHandle_nativeGetStreamControlFormatSize: ...exit
D/Uvc: [jni_devicehandle.cpp:115] ...Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDeviceHandle_nativeGetStreamControlFormatSize()
D/UvcDeviceHandle: ...getStreamControl(320x240 30)
D/Uvc: [jni_streamcontrol.cpp:101] Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcStreamCtrl_nativeOpen()...
V/Uvc: API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcStreamCtrl_nativeOpen: enter...
D/Uvc: [devicehandle.cpp:46] uvc_device_handle::openStreamControl()...
    [streamhandle.cpp:58] uvc_stream_handle::claimInterface()...
    [libuvc/libuvc_internal.h:773] uvc_device_handle::claimInterface(idx=1)...
D/UvcDevice: claimInterface(1)
    claimInterface(1) succeeded
D/Uvc: [libuvc/libuvc_internal.h:786] claimInterface(1) succeeded
    [libuvc/libuvc_internal.h:773] ...uvc_device_handle::claimInterface() rc=0
    [streamhandle.cpp:58] ...uvc_stream_handle::claimInterface() rc=0
    [stream.cpp:164] uvc_query_stream_ctrl()...
    [stream.cpp:164] ...uvc_query_stream_ctrl() rc=0
    [devicehandle.cpp:46] ...uvc_device_handle::openStreamControl() rc=0
V/Uvc: API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcStreamCtrl_nativeOpen: ...exit
D/Uvc: [jni_streamcontrol.cpp:101] ...Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcStreamCtrl_nativeOpen()
V/UvcStreamHandle: construct(pointer=0x94f42460)
D/Uvc: [jni_streamhandle.cpp:184] Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcStreamHandle_nativeStopStreaming()...
V/Uvc: API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcStreamHandle_nativeStopStreaming: enter...
D/Uvc: [stream.cpp:1467] uvc_stream_stop()...
    [stream.cpp:1467] ...uvc_stream_stop() rc=0
V/Uvc: API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcStreamHandle_nativeStopStreaming: ...exit
D/Uvc: [jni_streamhandle.cpp:184] ...Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcStreamHandle_nativeStopStreaming()
V/UvcFrameCallback: construct(0x07fb64e3)
V/UvcFrameCallbackData: construct(pointer=0x941c27b0)
V/Uvc: API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcStreamHandle_nativeStartStreaming: enter...
D/Uvc: [stream.cpp:931] uvc_stream_start_bandwidth()...
    [stream.cpp:1126] uvc_stream_handle::startIsochronousStreaming()...
    [libuvc/libuvc_internal.h:828] uvc_device_handle::setInterfaceAltSetting(setInterfaceAltSetting(intf=1 alt=5))...
D/UvcDevice: setInterfaceAltSetting(1,5)
D/UvcDevice: setInterfaceAltSetting(1,5) succeeded
D/Uvc: [libuvc/libuvc_internal.h:828] ...uvc_device_handle::setInterfaceAltSetting() rc=0
    [stream.cpp:1126] ...uvc_stream_handle::startIsochronousStreaming() rc=0
D/Uvc: [stream.cpp:1154] uvc_stream_handle::startUserCallbackThread()...
D/UvcStream: [stream.cpp:1218] User Callback thread started
D/Uvc: [stream.cpp:1154] ...uvc_stream_handle::startUserCallbackThread() rc=0
    [stream.cpp:1174] uvc_stream_handle::submitTransfers()...
D/UvcStream: [stream.cpp:690] this is the UVC processTransfer() stream processing thread
D/Uvc: [stream.cpp:1174] ...uvc_stream_handle::submitTransfers() rc=0
    [stream.cpp:931] ...uvc_stream_start_bandwidth() rc=0
D/UvcStreamHandle: [jni_streamhandle.cpp:150] successfully started streaming
V/Uvc: API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcStreamHandle_nativeStartStreaming: ...exit
V/UvcStreamCtrl: destroy(pointer=0x94215540)
D/UsbResiliantWebcam|DelCaptureSequence: ...doStreaming()
    ...startStreaming(Stopped)
D/UsbResiliantWebcam|DelCaptureSession: ...startCapture()
I/System.out: OpenCvWebcam: onConfigured
I/System.out: OpenCvWebcam: streaming started
V/Robocol: sending CMD_STREAM_CHANGE(2867), attempt: 0
D/UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26)
E/rsC++: Couldn't initialize dispatch table
E/UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0
E/UvcFrame: [jni_frame.cpp:226] renderScript creation failed
D/UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26)
E/rsC++: Couldn't initialize dispatch table
E/UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0
E/UvcFrame: [jni_frame.cpp:226] renderScript creation failed
D/UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26)
E/rsC++: Couldn't initialize dispatch table
E/UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0
E/UvcFrame: [jni_frame.cpp:226] renderScript creation failed
D/UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26)
E/rsC++: Couldn't initialize dispatch table
E/UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0
E/UvcFrame: [jni_frame.cpp:226] renderScript creation failed
D/UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26)
E/rsC++: Couldn't initialize dispatch table
E/UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0
E/UvcFrame: [jni_frame.cpp:226] renderScript creation failed
D/UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26)
E/rsC++: Couldn't initialize dispatch table
E/UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0
E/UvcFrame: [jni_frame.cpp:226] renderScript creation failed
D/UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26)
E/rsC++: Couldn't initialize dispatch table
E/UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0
E/UvcFrame: [jni_frame.cpp:226] renderScript creation failed
D/UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26)
E/rsC++: Couldn't initialize dispatch table
E/UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0
E/UvcFrame: [jni_frame.cpp:226] renderScript creation failed
D/UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26)
E/rsC++: Couldn't initialize dispatch table
E/UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0
E/UvcFrame: [jni_frame.cpp:226] renderScript creation failed
D/UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26)
E/rsC++: Couldn't initialize dispatch table
E/UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0
E/UvcFrame: [jni_frame.cpp:226] renderScript creation failed
D/UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26)
E/rsC++: Couldn't initialize dispatch table
E/UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0
E/UvcFrame: [jni_frame.cpp:226] renderScript creation failed
D/UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26)
E/rsC++: Couldn't initialize dispatch table
E/UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0
E/UvcFrame: [jni_frame.cpp:226] renderScript creation failed
D/UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26)
E/rsC++: Couldn't initialize dispatch table
E/UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0
E/UvcFrame: [jni_frame.cpp:226] renderScript creation failed
D/UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26)
E/rsC++: Couldn't initialize dispatch table
E/UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0
E/UvcFrame: [jni_frame.cpp:226] renderScript creation failed
D/UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26)
E/rsC++: Couldn't initialize dispatch table
E/UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0
E/UvcFrame: [jni_frame.cpp:226] renderScript creation failed
D/UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26)
E/rsC++: Couldn't initialize dispatch table
E/UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0
E/UvcFrame: [jni_frame.cpp:226] renderScript creation failed
D/UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26)
E/rsC++: Couldn't initialize dispatch table
E/UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0
E/UvcFrame: [jni_frame.cpp:226] renderScript creation failed
D/UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26)
E/rsC++: Couldn't initialize dispatch table
E/UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0
E/UvcFrame: [jni_frame.cpp:226] renderScript creation failed
D/UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26)
E/rsC++: Couldn't initialize dispatch table
E/UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0
E/UvcFrame: [jni_frame.cpp:226] renderScript creation failed
D/UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26)
E/rsC++: Couldn't initialize dispatch table
E/UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0
E/UvcFrame: [jni_frame.cpp:226] renderScript creation failed
D/UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26)
E/rsC++: Couldn't initialize dispatch table
E/UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0
E/UvcFrame: [jni_frame.cpp:226] renderScript creation failed
D/UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26)
E/rsC++: Couldn't initialize dispatch table
E/UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0
E/UvcFrame: [jni_frame.cpp:226] renderScript creation failed
D/UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26)
E/rsC++: Couldn't initialize dispatch table
E/UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0
E/UvcFrame: [jni_frame.cpp:226] renderScript creation failed
D/UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26)
E/rsC++: Couldn't initialize dispatch table
E/UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0
E/UvcFrame: [jni_frame.cpp:226] renderScript creation failed
D/UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26)
E/rsC++: Couldn't initialize dispatch table
E/UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0
E/UvcFrame: [jni_frame.cpp:226] renderScript creation failed
D/UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26)
E/rsC++: Couldn't initialize dispatch table
E/UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0
E/UvcFrame: [jni_frame.cpp:226] renderScript creation failed
D/UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26)
E/rsC++: Couldn't initialize dispatch table
E/UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0
E/UvcFrame: [jni_frame.cpp:226] renderScript creation failed
D/UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26)
E/rsC++: Couldn't initialize dispatch table
E/UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0
E/UvcFrame: [jni_frame.cpp:226] renderScript creation failed
D/UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26)
E/rsC++: Couldn't initialize dispatch table
E/UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0
E/UvcFrame: [jni_frame.cpp:226] renderScript creation failed
D/UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26)
E/rsC++: Couldn't initialize dispatch table
E/UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0
E/UvcFrame: [jni_frame.cpp:226] renderScript creation failed
D/UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26)
E/rsC++: Couldn't initialize dispatch table
E/UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0
E/UvcFrame: [jni_frame.cpp:226] renderScript creation failed
D/UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26)
E/rsC++: Couldn't initialize dispatch table
E/UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0
E/UvcFrame: [jni_frame.cpp:226] renderScript creation failed
V/Robocol: received command: CMD_INIT_OP_MODE(12670) $Stop$Robot$
I/RobotCore: ******************** STOP - OPMODE /storage/emulated/0/FIRST/matchlogs/Match-0-WebcamExample.txt ********************
V/RobotCore: thread: ...terminating 'LinearOpMode main'
I/RobotCore: saving match logcat to /storage/emulated/0/FIRST/matchlogs/Match-0-WebcamExample.txt
    logging command line: exec logcat -d -T '10-8 21:54:30.000' -f /storage/emulated/0/FIRST/matchlogs/Match-0-WebcamExample.txt -n4 -v threadtime UsbRequestJNI:S UsbRequest:S art:W ThreadPool:W System:W ExtendedExtractor:W OMXClient:W MediaPlayer:W dalvikvm:W  *:V
V/ThreadPool: executive service user linear op mode(0x0e7419b0) is terminated
V/ThreadPool: container(0x0e7419b0: LinearOpMode) removed id=2392 TID=31116 count=1
I/RobotCore: Attempting to switch to op mode $Stop$Robot$
V/Robocol: sending CMD_STREAM_CHANGE(2915), attempt: 0
D/OpenCvViewport: CheckState(): user requested that we deactivate
    CheckState(): deactivating viewport
W/System.err: java.lang.InterruptedException
        at java.lang.Object.wait(Native Method)
        at org.firstinspires.ftc.robotcore.internal.collections.EvictingBlockingQueue.take(EvictingBlockingQueue.java:143)
        at org.openftc.easyopencv.OpenCvViewport$RenderThread.run(OpenCvViewport.java:395)
D/OpenCvViewportRenderThread: About to exit
D/OpenCvViewport: CheckState(): user requested that we deactivate
    CheckState(): already deactivated
D/UsbResiliantWebcam|DelCaptureSession: stopCapture()...
D/UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26)
E/rsC++: Couldn't initialize dispatch table
E/UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0
E/UvcFrame: [jni_frame.cpp:226] renderScript creation failed
D/UsbResiliantWebcam|DelCaptureSequence: undoStreaming()...
D/UvcApiCaptureSession: stopCapture()...
D/Uvc: [jni_streamhandle.cpp:184] Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcStreamHandle_nativeStopStreaming()...
V/Uvc: API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcStreamHandle_nativeStopStreaming: enter...
D/Uvc: [stream.cpp:1467] uvc_stream_stop()...
D/UvcStream: [stream.cpp:1495] cancelling extant transfers
V/Robocol: sending CMD_NOTIFY_INIT_OP_MODE(2916), attempt: 0
D/Uvc: [stream.cpp:1424] (waitForAllTransfers(waiting for cancelled transfers))...
D/UvcStream: [stream.cpp:1438] no extant active transfers: continuing
D/Uvc: [stream.cpp:1424] ...()
    [stream.cpp:1142] uvc_stream_handle::stopIsochronousStreaming()...
    [libuvc/libuvc_internal.h:828] uvc_device_handle::setInterfaceAltSetting(setInterfaceAltSetting(intf=1 alt=0))...
D/UvcDevice: setInterfaceAltSetting(1,0)
V/Robocol: received command: CMD_RUN_OP_MODE(12677) $Stop$Robot$
V/Robocol: sending CMD_NOTIFY_RUN_OP_MODE(2923), attempt: 0
D/UvcDevice: setInterfaceAltSetting(1,0) succeeded
D/Uvc: [libuvc/libuvc_internal.h:828] ...uvc_device_handle::setInterfaceAltSetting() rc=0
    [stream.cpp:1142] ...uvc_stream_handle::stopIsochronousStreaming() rc=0
D/UvcStream: [stream.cpp:1511] awakening user thread
    [stream.cpp:1520] waiting for user callback thread to finish
I/RobotCore: Done running exec logcat -d -T '10-8 21:54:30.000' -f /storage/emulated/0/FIRST/matchlogs/Match-0-WebcamExample.txt -n4 -v threadtime UsbRequestJNI:S UsbRequest:S art:W ThreadPool:W System:W ExtendedExtractor:W OMXClient:W MediaPlayer:W dalvikvm:W  *:V
    exiting match logcat for /storage/emulated/0/FIRST/matchlogs/Match-0-WebcamExample.txt
D/Uvc: [stream.cpp:1467] ...uvc_stream_stop() rc=0
V/Uvc: API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcStreamHandle_nativeStopStreaming: ...exit
D/Uvc: [jni_streamhandle.cpp:184] ...Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcStreamHandle_nativeStopStreaming()
V/UvcStreamHandle: destroy(pointer=0x94f42460)
D/Uvc: [jni_streamhandle.cpp:184] Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcStreamHandle_nativeStopStreaming()...
V/Uvc: API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcStreamHandle_nativeStopStreaming: enter...
D/Uvc: [stream.cpp:1467] uvc_stream_stop()...
    [stream.cpp:1467] ...uvc_stream_stop() rc=0
V/Uvc: API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcStreamHandle_nativeStopStreaming: ...exit
D/Uvc: [jni_streamhandle.cpp:184] ...Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcStreamHandle_nativeStopStreaming()
    [jni_streamhandle.cpp:200] Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcStreamHandle_nativeCloseStreamHandle()...
V/Uvc: API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcStreamHandle_nativeCloseStreamHandle: enter...
D/Uvc: [stream.cpp:1537] uvc_stream_close()...
    [streamhandle.cpp:45] uvc_stream_handle::~uvc_stream_handle()...
    [streamhandle.cpp:66] uvc_stream_handle::releaseInterface()...
    [libuvc/libuvc_internal.h:796] uvc_device_handle::releaseInterface()...
D/UvcDevice: releaseInterface(1)
    releaseInterface(1) succeeded
D/Uvc: [libuvc/libuvc_internal.h:796] ...uvc_device_handle::releaseInterface() rc=0
    [streamhandle.cpp:66] ...uvc_stream_handle::releaseInterface()
    [streamhandle.cpp:45] ...uvc_stream_handle::~uvc_stream_handle()
    [stream.cpp:1537] ...uvc_stream_close()
V/Uvc: API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcStreamHandle_nativeCloseStreamHandle: ...exit
D/Uvc: [jni_streamhandle.cpp:200] ...Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcStreamHandle_nativeCloseStreamHandle()
V/UvcApiCameraCaptureSequence: destroy(hash=0x05c63c9d)
D/UvcApiCaptureSession: ...stopCapture()
    doClose()...
D/RobotCore: capture sequence DelegatingCaptureSequenceId(1) reports completed: lastFrame=168
D/UvcApiCaptureSession: ...doClose()
D/UsbResiliantWebcam|DelCaptureSession: camera session is closed: Webcam(9828DE4F)
V/UvcApiCaptureSession: destroy(hash=0x00c6af74)
D/UvcApiCaptureSession: destructor...
    ...destructor
D/UsbResiliantWebcam|DelCaptureSequence: ...undoStreaming()
D/RobotCore: capture sequence DelegatingCaptureSequenceId(1) reports completed: lastFrame=168
V/UsbResiliantWebcam|DelCaptureSequence: destroy(hash=0x00be5b47)
D/UsbResiliantWebcam|DelCaptureSession: ...stopCapture()
    doClose()...
    ...doClose()
V/UsbResiliantWebcam|DelCaptureSession: destroy(hash=0x0daad686)
D/UsbResiliantWebcam|DelCaptureSession: destructor()...
    ...destructor()
I/art: Background sticky concurrent mark sweep GC freed 354954(12MB) AllocSpace objects, 32(1268KB) LOS objects, 13% free, 93MB/107MB, paused 1.554ms total 139.346ms
V/CameraImpl: destroy(hash=0x0cb5f36b)
D/UsbResiliantWebcam: CameraImpl.destructor()...
    externalDestructor()...
D/CameraManager: camera reports closed: CameraImpl(UsbResiliantWebcam(Webcam(9828DE4F)))
V/CameraImpl: destroy(hash=0x0906e8ba)
D/UvcDeviceHandle: CameraImpl.destructor()...
    externalDestructor()...
D/UsbResiliantWebcam: changeDelegatedCamera(CameraImpl(UvcDeviceHandle(pointer=0xb477d660|UvcDevice(/dev/bus/usb/001/004)))->null)...
D/CachingExposureControl: onCameraChanged(CameraImpl(UvcDeviceHandle(pointer=0xb477d660|UvcDevice(/dev/bus/usb/001/004)))->null)...
    ...onCameraChanged(CameraImpl(UvcDeviceHandle(pointer=0xb477d660|UvcDevice(/dev/bus/usb/001/004)))->null)
D/UsbResiliantWebcam: ...changeDelegatedCamera(CameraImpl(UvcDeviceHandle(pointer=0xb477d660|UvcDevice(/dev/bus/usb/001/004)))->null)
D/UvcDeviceHandle: ...externalDestructor()
V/UvcDeviceHandle: destroy(pointer=0xb477d660)
D/UvcDeviceHandle: destructor...
D/Uvc: [jni_devicehandle.cpp:87] Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDeviceHandle_nativeReleaseRefDeviceHandle()...
V/Uvc: API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDeviceHandle_nativeReleaseRefDeviceHandle: enter...
D/Uvc: [libuvc/libuvc_internal.h:877] uvc_device_handle::~uvc_device_handle()...
    [libuvc/libuvc_internal.h:845] uvc_device_handle::deconstruct()...
    [libuvc/libuvc_internal.h:754] uvc_device_handle::stop()...
    [libuvc/libuvc_internal.h:754] ...uvc_device_handle::stop()
    [libuvc/libuvc_internal.h:870] uvc_device_handle::close()...
E/libusb: [216.240920] [00007a00] libusb: error [do_close] Device handle closed while transfer was still being processed, but the device is still connected as far as we know
    [216.241176] [00007a00] libusb: error [do_close] A cancellation hasn't even been scheduled on the transfer for which the device is closing
D/Uvc: [libuvc/libuvc_internal.h:870] ...uvc_device_handle::close()
    [libuvc/libuvc_internal.h:845] ...uvc_device_handle::deconstruct()
    [device.cpp:433] uvc_free_device_info()...
    [device.cpp:433] ...uvc_free_device_info()
    [libuvc/libuvc_internal.h:877] ...uvc_device_handle::~uvc_device_handle()
V/Uvc: API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDeviceHandle_nativeReleaseRefDeviceHandle: ...exit
D/Uvc: [jni_devicehandle.cpp:87] ...Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDeviceHandle_nativeReleaseRefDeviceHandle()
V/UvcDevice: destroy(pointer=0x9bdfa200|/dev/bus/usb/001/004)
D/UsbDeviceConnectionJNI: close
D/Uvc: [jni_device.cpp:126] Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDevice_nativeReleaseRefDevice()...
V/Uvc: API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDevice_nativeReleaseRefDevice: enter...
D/Uvc: [device.cpp:882] uvc_unref_device()...
    [device.cpp:882] ...uvc_unref_device()
V/Uvc: API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDevice_nativeReleaseRefDevice: ...exit
D/Uvc: [jni_device.cpp:126] ...Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDevice_nativeReleaseRefDevice()
V/LibUsbDevice: destroy(pointer=0x95f4fe00)
D/Uvc: [jni_libusb_device.cpp:64] Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_LibUsbDevice_nativeReleaseRefDevice()...
    [jni_libusb_device.cpp:64] ...Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_LibUsbDevice_nativeReleaseRefDevice()
D/UvcDeviceHandle: ...destructor
    ...CameraImpl.destructor()
D/UsbResiliantWebcam: ...externalDestructor()
V/UsbResiliantWebcam: destroy(hash=0x0ef920dc)
D/UsbResiliantWebcam: destructor()...
    ...destructor()
    ...CameraImpl.destructor()
V/UvcFrameCallback: destroy(hash=0x07fb64e3)
V/UvcFrameCallbackData: destroy(pointer=0x941c27b0)
V/Uvc: API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcFrameCallback_nativeReleaseCallbackState: enter...
    API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcFrameCallback_nativeReleaseCallbackState: ...exit
V/ThreadPool: container(0x05210305: default threadpool) removed id=2394 TID=31129 count=2
V/ThreadPool: container(0x05210305: default threadpool) removed id=2393 TID=31117 count=1
I/art: Background partial concurrent mark sweep GC freed 376757(13MB) AllocSpace objects, 116(2MB) LOS objects, 14% free, 91MB/107MB, paused 1.420ms total 121.869ms

Windwoes commented 4 years ago

@mtbbiker can you please confirm whether you have a C920 or a C910? You said that you had a C910, however according to the log the phone seems to think it's a C920.

Windwoes commented 4 years ago

@Matthew1231A @mtbbiker @haifengchicago the logs seem to indicate that a renderscript issue is the smoking gun. There was a change to the renderscript stuff in SDK v5.2. Please test with SDK v5.1

haifengchicago commented 4 years ago

I just tested with SDK v5.1, still get a no image, just all black with the green rectangle in the middle. The phone internal camera works with EasyOpenCV. Vuforia also works with Webcam. Moto G2, Logitech C270.

mtbbiker commented 4 years ago

@mtbbiker can you please confirm whether you have a C920 or a C910? You said that you had a C910, however according to the log the phone seems to think it's a C920.

@FROGbots-4634 my bad yes its the 920 (1080p) model.

haifengchicago commented 4 years ago

Here is the log file from the SDK v5.1 run earlier. Somewhere down it does say Render script failed.

10-08 22:11:27.267 12524 12722 I RobotCore: **** START - OPMODE WebcamExample **** 10-08 22:11:27.268 12524 17442 I RobotCore: Attempting to switch to op mode WebcamExample 10-08 22:11:27.360 12524 17491 V RobotCore: thread: 'LinearOpMode main' starting... 10-08 22:11:27.377 12524 12794 V Robocol : sending CMD_NOTIFY_INIT_OP_MODE(23701), attempt: 0 10-08 22:11:27.428 12524 17491 D CameraManager: doOpenCamera()... 10-08 22:11:27.431 12524 17491 D CameraManager: requesting permission for camera: Webcam(D47A8AC0) 10-08 22:11:27.439 12524 17491 D WebcamNameImpl: requesting permission for /dev/bus/usb/001/004 10-08 22:11:27.439 12524 12524 D OpenCvViewport: CheckState(): user requested that we deactivate 10-08 22:11:27.439 12524 17491 V WebcamNameImpl: asyncRequestUsbPermission()... 10-08 22:11:27.439 12524 12524 D OpenCvViewport: CheckState(): already deactivated 10-08 22:11:27.442 12524 17491 D WebcamNameImpl: permission already available for /dev/bus/usb/001/004 10-08 22:11:27.443 12524 17491 V WebcamNameImpl: ...asyncRequestUsbPermission() 10-08 22:11:27.443 12524 17377 D WebcamNameImpl: permission for /dev/bus/usb/001/004=true 10-08 22:11:27.443 12524 17377 D CameraManager: permission granted for camera: Webcam(D47A8AC0) 10-08 22:11:27.443 12524 17491 D ContinuationSynchronizer: awaiting(camera open)... 10-08 22:11:27.447 12524 17377 D CameraManager: asyncOpenCamera(Webcam(D47A8AC0))... 10-08 22:11:27.447 12524 17377 D CameraManager: asyncOpenWebcam(Webcam(D47A8AC0))... 10-08 22:11:27.450 12524 17377 V UsbResiliantWebcam: construct(0x032919a3) 10-08 22:11:27.455 12524 17377 D UsbResiliantWebcam: openAssumingPermission()... 10-08 22:11:27.457 12524 17377 D UvcContext: found webcam: usbPath=/dev/bus/usb/001/004 vid=1133 pid=2085 serial=D47A8AC0 product=null 10-08 22:11:27.457 12524 17377 D Uvc : [jni_context.cpp:195] Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcContext_nativeCreateUvcDevice()... 10-08 22:11:27.461 12524 17377 V Uvc : API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcContext_nativeCreateUvcDevice: enter... 10-08 22:11:27.465 12524 17377 D libusb : [2526.403124] [000043e1] libusb: debug [op_create] op_create: szUsbPath=/dev/bus/usb/001/004 szSysfsDir=1-1.3 10-08 22:11:27.465 12524 17377 D libusb : [2526.406548] [000043e1] libusb: debug [initialize_device] initialize_device(szUsbPath=/dev/bus/usb/001/004 szSysfsDir=1-1.3) 10-08 22:11:27.466 12524 17377 D libusb : [2526.407164] [000043e1] libusb: debug [initialize_device] initialize_device(szUsbPath=(null) szSysfsDir=1-1) 10-08 22:11:27.466 12524 17377 E libusb : [2526.407496] [000043e1] libusb: error [initialize_device] unable to open serial number sysfs; error ignored 10-08 22:11:27.466 12524 17377 D libusb : [2526.407712] [000043e1] libusb: debug [initialize_device] initialize_device(szUsbPath=(null) szSysfsDir=usb1) 10-08 22:11:27.467 12524 17377 D Uvc : [device.cpp:613] uvc_create_uvc_device()... 10-08 22:11:27.467 12524 17377 D Uvc : [libuvc/libuvc_internal.h:354] uvc_device::uvc_device()... 10-08 22:11:27.467 12524 17377 D Uvc : [libuvc/libuvc_internal.h:383] acquired vid=1133 & pid=2085 10-08 22:11:27.467 12524 17377 D Uvc : [libuvc/libuvc_internal.h:354] ...uvc_device::uvc_device() 10-08 22:11:27.467 12524 17377 D Uvc : [device.cpp:613] ...uvc_create_uvc_device() rc=0 10-08 22:11:27.467 12524 17377 V Uvc : API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcContext_nativeCreateUvcDevice: ...exit 10-08 22:11:27.467 12524 17377 D Uvc : [jni_context.cpp:195] ...Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcContext_nativeCreateUvcDevice() 10-08 22:11:27.467 12524 17377 V UvcDevice: construct(pointer=0xb913fe38|null) 10-08 22:11:27.468 12524 17377 D Uvc : [jni_device.cpp:108] Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDevice_nativeGetLibUsbDevice()... 10-08 22:11:27.468 12524 17377 D Uvc : [jni_device.cpp:108] ...Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDevice_nativeGetLibUsbDevice() 10-08 22:11:27.468 12524 17377 V LibUsbDevice: construct(pointer=0xb8f176f8) 10-08 22:11:27.468 12524 17377 D UvcContext: usb device is not UVC compatible, /dev/bus/usb/001/003 10-08 22:11:27.470 12524 17377 D UvcDevice: open()... 10-08 22:11:27.471 12524 17377 D Uvc : [jni_device.cpp:50] Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDevice_nativeSetUsbDeviceInfo()... 10-08 22:11:27.471 12524 17377 D Uvc : [jni_device.cpp:50] ...Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDevice_nativeSetUsbDeviceInfo() 10-08 22:11:27.471 12524 17377 D Uvc : [jni_device.cpp:241] Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDevice_nativeOpenDeviceHandle()... 10-08 22:11:27.471 12524 17377 V Uvc : API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDevice_nativeOpenDeviceHandle: enter... 10-08 22:11:27.471 12524 17377 D Uvc : [device.cpp:279] uvc_open()... 10-08 22:11:27.472 12524 17377 D Uvc : [libuvc/libuvc_internal.h:364] uvc_device::open()... 10-08 22:11:27.472 12524 17377 D libusb : [2526.412849] [000043e1] libusb: debug [op_open] op_open: szUsbPath=/dev/bus/usb/001/004 10-08 22:11:27.472 12524 17377 D Uvc : [libuvc/libuvc_internal.h:364] ...uvc_device::open() rc=0 10-08 22:11:27.472 12524 17377 D Uvc : [device.cpp:295] calling libusb_reset_device()... 10-08 22:11:27.998 12524 17377 D Uvc : [device.cpp:303] ...libusb_reset_device() called 10-08 22:11:27.998 12524 17377 D Uvc : [device.cpp:311] libusb_open() = 0 10-08 22:11:27.998 12524 17377 D Uvc : [libuvc/libuvc_internal.h:735] uvc_device_handle::uvc_device_handle()... 10-08 22:11:27.998 12524 17377 D Uvc : [libuvc/libuvc_internal.h:735] ...uvc_device_handle::uvc_device_handle() 10-08 22:11:27.998 12524 17377 D Uvc : [device.cpp:386] uvc_get_device_info()... 10-08 22:11:27.998 12524 17377 D libusb : [2526.939731] [000043e1] libusb: debug [op_get_config_descriptor] op_get_config_descriptor: config_index=0 10-08 22:11:27.999 12524 17377 D libusb : [2526.939789] [000043e1] libusb: debug [op_get_config_descriptor] op_get_config_descriptor: config_index=0 10-08 22:11:27.999 12524 17377 D Uvc : [device.cpp:986] uvc_scan_control()... 10-08 22:11:27.999 12524 17377 D Uvc : [device.cpp:1041] uvc_parse_vc_header()... 10-08 22:11:27.999 12524 17377 D Uvc : [device.cpp:1284] uvc_scan_streaming()... 10-08 22:11:27.999 12524 17377 D Uvc : [device.cpp:1340] uvc_parse_vs_input_header()... 10-08 22:11:27.999 12524 17377 D Uvc : [device.cpp:1340] ...uvc_parse_vs_input_header() rc=0 10-08 22:11:27.999 12524 17377 D Uvc : [device.cpp:1389] uvc_parse_vs_format_uncompressed()... 10-08 22:11:27.999 12524 17377 D Uvc : [device.cpp:1389] ...uvc_parse_vs_format_uncompressed() rc=0 10-08 22:11:27.999 12524 17377 V Uvc : [device.cpp:1630] unsupported descriptor subtype: 13 UVC_VS_COLORFORMAT 10-08 22:11:27.999 12524 17377 D Uvc : [device.cpp:1449] uvc_parse_vs_format_mjpeg()... 10-08 22:11:27.999 12524 17377 D Uvc : [device.cpp:1449] ...uvc_parse_vs_format_mjpeg() rc=0 10-08 22:11:28.000 12524 17377 V Uvc : [device.cpp:1630] unsupported descriptor subtype: 13 UVC_VS_COLORFORMAT 10-08 22:11:28.000 12524 17377 D Uvc : [device.cpp:1284] ...uvc_scan_streaming() rc=0 10-08 22:11:28.000 12524 17377 D Uvc : [device.cpp:1041] ...uvc_parse_vc_header() rc=0 10-08 22:11:28.000 12524 17377 D Uvc : [device.cpp:1083] uvc_parse_vc_input_terminal()... 10-08 22:11:28.000 12524 17377 D Uvc : [device.cpp:1083] ...uvc_parse_vc_input_terminal() rc=0 10-08 22:11:28.000 12524 17377 D Uvc : [device.cpp:1156] uvc_parse_vc_processing_unit()... 10-08 22:11:28.000 12524 17377 D Uvc : [device.cpp:1156] ...uvc_parse_vc_processing_unit() rc=0 10-08 22:11:28.000 12524 17377 D Uvc : [device.cpp:986] ...uvc_scan_control() rc=0 10-08 22:11:28.000 12524 17377 D Uvc : [device.cpp:386] ...uvc_get_device_info() rc=0 10-08 22:11:28.000 12524 17377 D Uvc : [device.cpp:326] claiming control interface 0 10-08 22:11:28.000 12524 17377 D Uvc : [libuvc/libuvc_internal.h:773] uvc_device_handle::claimInterface(idx=0)... 10-08 22:11:28.000 12524 17377 D UvcDevice: claimInterface(0) 10-08 22:11:28.037 12524 17377 D UvcDevice: claimInterface(0) succeeded 10-08 22:11:28.037 12524 17377 D Uvc : [libuvc/libuvc_internal.h:786] claimInterface(0) succeeded 10-08 22:11:28.038 12524 17377 D Uvc : [libuvc/libuvc_internal.h:773] ...uvc_device_handle::claimInterface() rc=0 10-08 22:11:28.038 12524 17377 D Uvc : [device.cpp:279] ...uvc_open() rc=0 10-08 22:11:28.038 12524 17377 V Uvc : API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDevice_nativeOpenDeviceHandle: ...exit 10-08 22:11:28.038 12524 17377 D Uvc : [jni_device.cpp:241] ...Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDevice_nativeOpenDeviceHandle() 10-08 22:11:28.039 12524 17377 V UvcDeviceHandle: construct(pointer=0xb91ca100) 10-08 22:11:28.039 12524 17377 V CameraImpl: construct(0x0849a859) 10-08 22:11:28.040 12524 17377 D UsbResiliantWebcam.InterveningStateCallback: onOpened() camera=CameraImpl(UvcDeviceHandle(pointer=0xb91ca100|UvcDevice(/dev/bus/usb/001/004)))... 10-08 22:11:28.040 12524 17377 D UsbResiliantWebcam: changeDelegatedCamera(null->CameraImpl(UvcDeviceHandle(pointer=0xb91ca100|UvcDevice(/dev/bus/usb/001/004))))... 10-08 22:11:28.040 12524 17377 D UvcApiFocusControl: isModeSupported(Auto)... 10-08 22:11:28.042 12524 17377 D UvcApiFocusControl: ...isModeSupported(Auto): false 10-08 22:11:28.042 12524 17377 D UvcApiFocusControl: isModeSupported(ContinuousAuto)... 10-08 22:11:28.042 12524 17377 D UvcApiFocusControl: ...isModeSupported(ContinuousAuto): false 10-08 22:11:28.042 12524 17377 D UvcApiFocusControl: isModeSupported(Macro)... 10-08 22:11:28.042 12524 17377 D UvcApiFocusControl: ...isModeSupported(Macro): false 10-08 22:11:28.042 12524 17377 D UvcApiFocusControl: isModeSupported(Infinity)... 10-08 22:11:28.042 12524 17377 D UvcApiFocusControl: ...isModeSupported(Infinity): false 10-08 22:11:28.042 12524 17377 D UvcApiFocusControl: isModeSupported(Fixed)... 10-08 22:11:28.042 12524 17377 D UvcApiFocusControl: ...isModeSupported(Fixed): true 10-08 22:11:28.042 12524 17377 D UvcApiFocusControl: isFocusLengthSupported... 10-08 22:11:28.042 12524 17377 D UvcApiFocusControl: ...isFocusLengthSupported: false 10-08 22:11:28.045 12524 17377 D CachingExposureControl: onCameraChanged(null->CameraImpl(UvcDeviceHandle(pointer=0xb91ca100|UvcDevice(/dev/bus/usb/001/004))))... 10-08 22:11:28.045 12524 17377 D UvcApiExposureControl: isModeSupported(Auto)... 10-08 22:11:28.048 12524 17377 D UvcApiExposureControl: ...isModeSupported(Auto): false 10-08 22:11:28.048 12524 17377 D UvcApiExposureControl: isModeSupported(ContinuousAuto)... 10-08 22:11:28.050 12524 17377 D UvcApiExposureControl: ...isModeSupported(ContinuousAuto): false 10-08 22:11:28.050 12524 17377 D UvcApiExposureControl: isModeSupported(Manual)... 10-08 22:11:28.052 12524 17377 D UvcApiExposureControl: ...isModeSupported(Manual): true 10-08 22:11:28.052 12524 17377 D UvcApiExposureControl: isModeSupported(ShutterPriority)... 10-08 22:11:28.054 12524 17377 D UvcApiExposureControl: ...isModeSupported(ShutterPriority): false 10-08 22:11:28.054 12524 17377 D UvcApiExposureControl: isModeSupported(AperturePriority)... 10-08 22:11:28.058 12524 17377 D UvcApiExposureControl: ...isModeSupported(AperturePriority): true 10-08 22:11:28.058 12524 17377 D UvcApiExposureControl: isExposureSupported()... 10-08 22:11:28.058 12524 17377 D UvcApiExposureControl: ...isExposureSupported(): true 10-08 22:11:28.058 12524 17377 D UvcApiExposureControl: getMinExposure(NANOSECONDS)... 10-08 22:11:28.058 12524 17377 D Uvc : [jni_devicehandle.cpp:373] Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDeviceHandle_nativeGetMinExposure()... 10-08 22:11:28.061 12524 17377 D Uvc : [jni_devicehandle.cpp:373] ...Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDeviceHandle_nativeGetMinExposure() 10-08 22:11:28.061 12524 17377 D UvcApiExposureControl: ...getMinExposure(NANOSECONDS): 100000 10-08 22:11:28.061 12524 17377 D UvcApiExposureControl: getMaxExposure(NANOSECONDS)... 10-08 22:11:28.063 12524 17377 D UvcApiExposureControl: ...getMaxExposure(NANOSECONDS): 1000000000 10-08 22:11:28.063 12524 17377 D UvcApiExposureControl: getMode()... 10-08 22:11:28.063 12524 17377 D Uvc : [jni_devicehandle.cpp:221] Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDeviceHandle_nativeGetVuforiaExposureMode()... 10-08 22:11:28.065 12524 17377 D Uvc : [jni_devicehandle.cpp:221] ...Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDeviceHandle_nativeGetVuforiaExposureMode() 10-08 22:11:28.066 12524 17377 D UvcApiExposureControl: ...getMode(): AperturePriority 10-08 22:11:28.068 12524 17377 D CachingExposureControl: ...onCameraChanged(null->CameraImpl(UvcDeviceHandle(pointer=0xb91ca100|UvcDevice(/dev/bus/usb/001/004)))) 10-08 22:11:28.068 12524 17377 D UsbResiliantWebcam: ...changeDelegatedCamera(null->CameraImpl(UvcDeviceHandle(pointer=0xb91ca100|UvcDevice(/dev/bus/usb/001/004)))) 10-08 22:11:28.068 12524 17377 D UsbResiliantWebcam: openSelfAndReport()... 10-08 22:11:28.068 12524 17377 V CameraImpl: construct(0x067dfc1e) 10-08 22:11:28.068 12524 17377 D UsbResiliantWebcam: ...openSelfAndReport() 10-08 22:11:28.068 12524 17377 D UsbResiliantWebcam.InterveningStateCallback: ...onOpened() camera=CameraImpl(UvcDeviceHandle(pointer=0xb91ca100|UvcDevice(/dev/bus/usb/001/004))) 10-08 22:11:28.069 12524 17377 D UvcDevice: ...open() 10-08 22:11:28.069 12524 17377 D UsbResiliantWebcam: ...openAssumingPermission() 10-08 22:11:28.069 12524 17377 D CameraManager: ...asyncOpenWebcam(Webcam(D47A8AC0)) 10-08 22:11:28.069 12524 17377 D CameraManager: ...asyncOpenCamera(Webcam(D47A8AC0)) 10-08 22:11:28.073 12524 17428 D CameraManager: camera reports opened: CameraImpl(UsbResiliantWebcam(Webcam(D47A8AC0))) 10-08 22:11:28.073 12524 17428 D ContinuationSynchronizer: finish("camera reports opened: Webcam(D47A8AC0)": CameraImpl(UsbResiliantWebcam(Webcam(D47A8AC0))))... 10-08 22:11:28.074 12524 17428 D ContinuationSynchronizer: ...finish("camera reports opened: Webcam(D47A8AC0)": CameraImpl(UsbResiliantWebcam(Webcam(D47A8AC0)))) 10-08 22:11:28.074 12524 17491 D ContinuationSynchronizer: ...awaiting(camera open) 10-08 22:11:28.074 12524 17491 D CameraManager: ...doOpenCamera() 10-08 22:11:28.076 12524 17491 D UvcContext: found webcam: usbPath=/dev/bus/usb/001/004 vid=1133 pid=2085 serial=D47A8AC0 product=null 10-08 22:11:28.076 12524 17491 D Uvc : [jni_context.cpp:195] Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcContext_nativeCreateUvcDevice()... 10-08 22:11:28.076 12524 17491 V Uvc : API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcContext_nativeCreateUvcDevice: enter... 10-08 22:11:28.077 12524 17491 D libusb : [2527.018148] [00004453] libusb: debug [op_create] op_create: szUsbPath=/dev/bus/usb/001/004 szSysfsDir=1-1.3 10-08 22:11:28.077 12524 17491 D Uvc : [device.cpp:613] uvc_create_uvc_device()... 10-08 22:11:28.077 12524 17491 D Uvc : [libuvc/libuvc_internal.h:354] uvc_device::uvc_device()... 10-08 22:11:28.077 12524 17491 D Uvc : [libuvc/libuvc_internal.h:383] acquired vid=1133 & pid=2085 10-08 22:11:28.077 12524 17491 D Uvc : [libuvc/libuvc_internal.h:354] ...uvc_device::uvc_device() 10-08 22:11:28.077 12524 17491 D Uvc : [device.cpp:613] ...uvc_create_uvc_device() rc=0 10-08 22:11:28.077 12524 17491 V Uvc : API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcContext_nativeCreateUvcDevice: ...exit 10-08 22:11:28.077 12524 17491 D Uvc : [jni_context.cpp:195] ...Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcContext_nativeCreateUvcDevice() 10-08 22:11:28.077 12524 17491 V UvcDevice: construct(pointer=0xb9029228|null) 10-08 22:11:28.077 12524 17491 D Uvc : [jni_device.cpp:108] Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDevice_nativeGetLibUsbDevice()... 10-08 22:11:28.077 12524 17491 D Uvc : [jni_device.cpp:108] ...Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDevice_nativeGetLibUsbDevice() 10-08 22:11:28.077 12524 17491 V LibUsbDevice: construct(pointer=0xb8f176f8) 10-08 22:11:28.078 12524 17491 D UvcContext: usb device is not UVC compatible, /dev/bus/usb/001/003 10-08 22:11:28.078 12524 17491 V UvcApiCameraCharacteristicsBuilder: construct(0x03a9acff) 10-08 22:11:28.078 12524 17491 D Uvc : [jni_device.cpp:297] Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDevice_nativeGetDeviceInfo()... 10-08 22:11:28.078 12524 17491 V Uvc : API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDevice_nativeGetDeviceInfo: enter... 10-08 22:11:28.078 12524 17491 D Uvc : [device.cpp:386] uvc_get_device_info()... 10-08 22:11:28.078 12524 17491 D libusb : [2527.019652] [00004453] libusb: debug [op_get_config_descriptor] op_get_config_descriptor: config_index=0 10-08 22:11:28.078 12524 17491 D libusb : [2527.019701] [00004453] libusb: debug [op_get_config_descriptor] op_get_config_descriptor: config_index=0 10-08 22:11:28.078 12524 17491 D Uvc : [device.cpp:986] uvc_scan_control()... 10-08 22:11:28.079 12524 17491 D Uvc : [device.cpp:1041] uvc_parse_vc_header()... 10-08 22:11:28.079 12524 17491 D Uvc : [device.cpp:1284] uvc_scan_streaming()... 10-08 22:11:28.079 12524 17491 D Uvc : [device.cpp:1340] uvc_parse_vs_input_header()... 10-08 22:11:28.079 12524 17491 D Uvc : [device.cpp:1340] ...uvc_parse_vs_input_header() rc=0 10-08 22:11:28.079 12524 17491 D Uvc : [device.cpp:1389] uvc_parse_vs_format_uncompressed()... 10-08 22:11:28.079 12524 17491 D Uvc : [device.cpp:1389] ...uvc_parse_vs_format_uncompressed() rc=0 10-08 22:11:28.079 12524 17491 V Uvc : [device.cpp:1630] unsupported descriptor subtype: 13 UVC_VS_COLORFORMAT 10-08 22:11:28.079 12524 17491 D Uvc : [device.cpp:1449] uvc_parse_vs_format_mjpeg()... 10-08 22:11:28.079 12524 17491 D Uvc : [device.cpp:1449] ...uvc_parse_vs_format_mjpeg() rc=0 10-08 22:11:28.079 12524 17491 V Uvc : [device.cpp:1630] unsupported descriptor subtype: 13 UVC_VS_COLORFORMAT 10-08 22:11:28.079 12524 17491 D Uvc : [device.cpp:1284] ...uvc_scan_streaming() rc=0 10-08 22:11:28.080 12524 17491 D Uvc : [device.cpp:1041] ...uvc_parse_vc_header() rc=0 10-08 22:11:28.080 12524 17491 D Uvc : [device.cpp:1083] uvc_parse_vc_input_terminal()... 10-08 22:11:28.080 12524 17491 D Uvc : [device.cpp:1083] ...uvc_parse_vc_input_terminal() rc=0 10-08 22:11:28.080 12524 17491 D Uvc : [device.cpp:1156] uvc_parse_vc_processing_unit()... 10-08 22:11:28.080 12524 17491 D Uvc : [device.cpp:1156] ...uvc_parse_vc_processing_unit() rc=0 10-08 22:11:28.080 12524 17491 D Uvc : [device.cpp:986] ...uvc_scan_control() rc=0 10-08 22:11:28.080 12524 17491 D Uvc : [device.cpp:386] ...uvc_get_device_info() rc=0 10-08 22:11:28.080 12524 17491 V Uvc : API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDevice_nativeGetDeviceInfo: ...exit 10-08 22:11:28.080 12524 17491 D Uvc : [jni_device.cpp:297] ...Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDevice_nativeGetDeviceInfo() 10-08 22:11:28.080 12524 17491 V UvcDeviceInfo: construct(pointer=0xb91f2068) 10-08 22:11:28.081 12524 17491 V UvcStreamingInterface: construct(pointer=0xb90293c8) 10-08 22:11:28.116 12524 17491 V UvcStreamingInterface: destroy(pointer=0xb90293c8) 10-08 22:11:28.116 12524 17491 V UvcDeviceInfo: destroy(pointer=0xb91f2068) 10-08 22:11:28.116 12524 17491 D Uvc : [jni_deviceinfo.cpp:63] Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDeviceInfo_nativeFreeDeviceInfo()... 10-08 22:11:28.116 12524 17491 V Uvc : API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDeviceInfo_nativeFreeDeviceInfo: enter... 10-08 22:11:28.116 12524 17491 D Uvc : [device.cpp:433] uvc_free_device_info()... 10-08 22:11:28.117 12524 17491 D Uvc : [device.cpp:433] ...uvc_free_device_info() 10-08 22:11:28.117 12524 17491 V Uvc : API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDeviceInfo_nativeFreeDeviceInfo: ...exit 10-08 22:11:28.117 12524 17491 D Uvc : [jni_deviceinfo.cpp:63] ...Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDeviceInfo_nativeFreeDeviceInfo() 10-08 22:11:28.117 12524 17491 V UvcApiCameraCharacteristicsBuilder: destroy(hash=0x03a9acff) 10-08 22:11:28.117 12524 17491 V UvcDevice: destroy(pointer=0xb9029228|/dev/bus/usb/001/004) 10-08 22:11:28.117 12524 17491 D Uvc : [jni_device.cpp:126] Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDevice_nativeReleaseRefDevice()... 10-08 22:11:28.117 12524 17491 V Uvc : API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDevice_nativeReleaseRefDevice: enter... 10-08 22:11:28.117 12524 17491 D Uvc : [device.cpp:882] uvc_unref_device()... 10-08 22:11:28.117 12524 17491 D Uvc : [device.cpp:882] ...uvc_unref_device() 10-08 22:11:28.117 12524 17491 V Uvc : API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDevice_nativeReleaseRefDevice: ...exit 10-08 22:11:28.117 12524 17491 D Uvc : [jni_device.cpp:126] ...Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDevice_nativeReleaseRefDevice() 10-08 22:11:28.117 12524 17491 V LibUsbDevice: destroy(pointer=0xb8f176f8) 10-08 22:11:28.117 12524 17491 D Uvc : [jni_libusb_device.cpp:64] Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_LibUsbDevice_nativeReleaseRefDevice()... 10-08 22:11:28.117 12524 17491 D Uvc : [jni_libusb_device.cpp:64] ...Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_LibUsbDevice_nativeReleaseRefDevice() 10-08 22:11:28.120 12524 17491 D OpenCvViewport: CheckState(): user requested that we activate 10-08 22:11:28.120 12524 17491 D OpenCvViewport: CheckState(): activating viewport 10-08 22:11:28.121 12524 17491 D UsbResiliantWebcam: createCaptureSession()... 10-08 22:11:28.121 12524 17491 V DelCaptureSession: construct(0x0e2e8acc) 10-08 22:11:28.122 12524 17503 D OpenCvViewportRenderThread: I am alive! 10-08 22:11:28.123 12524 17491 D UsbResiliantWebcam|DelCaptureSession: onCameraChange(null->CameraImpl(UvcDeviceHandle(pointer=0xb91ca100|UvcDevice(/dev/bus/usb/001/004))))... 10-08 22:11:28.123 12524 17491 D UsbResiliantWebcam|DelCaptureSession: ...onCameraChange(null->CameraImpl(UvcDeviceHandle(pointer=0xb91ca100|UvcDevice(/dev/bus/usb/001/004)))) 10-08 22:11:28.124 12524 17491 D CachingExposureControl: onCameraChanged(CameraImpl(UvcDeviceHandle(pointer=0xb91ca100|UvcDevice(/dev/bus/usb/001/004)))->CameraImpl(UvcDeviceHandle(pointer=0xb91ca100|UvcDevice(/dev/bus/usb/001/004))))... 10-08 22:11:28.124 12524 17491 D CachingExposureControl: ...onCameraChanged(CameraImpl(UvcDeviceHandle(pointer=0xb91ca100|UvcDevice(/dev/bus/usb/001/004)))->CameraImpl(UvcDeviceHandle(pointer=0xb91ca100|UvcDevice(/dev/bus/usb/001/004)))) 10-08 22:11:28.124 12524 17491 D UsbResiliantWebcam: ...createCaptureSession() 10-08 22:11:28.125 12524 17504 D UsbResiliantWebcam|DelCaptureSession: startCapture()... 10-08 22:11:28.125 12524 17504 V DelCaptureSequence: construct(0x0189bc2a) 10-08 22:11:28.126 12524 17504 D UsbResiliantWebcam|DelCaptureSequence: onCameraChange(null->CameraImpl(UvcDeviceHandle(pointer=0xb91ca100|UvcDevice(/dev/bus/usb/001/004))))... 10-08 22:11:28.126 12524 17504 D UsbResiliantWebcam|DelCaptureSequence: pauseStreaming(Stopped)... 10-08 22:11:28.126 12524 17504 D UsbResiliantWebcam|DelCaptureSequence: ...pauseStreaming(Stopped) 10-08 22:11:28.126 12524 17504 D UsbResiliantWebcam|DelCaptureSequence: resumeStreaming(Stopped)... 10-08 22:11:28.126 12524 17504 D UsbResiliantWebcam|DelCaptureSequence: ...resumeStreaming(Stopped) 10-08 22:11:28.126 12524 17504 D UsbResiliantWebcam|DelCaptureSequence: ...onCameraChange(null->CameraImpl(UvcDeviceHandle(pointer=0xb91ca100|UvcDevice(/dev/bus/usb/001/004)))) 10-08 22:11:28.127 12524 17504 D UsbResiliantWebcam|DelCaptureSequence: startStreaming(Stopped)... 10-08 22:11:28.127 12524 17504 D UsbResiliantWebcam|DelCaptureSequence: doStreaming()... 10-08 22:11:28.127 12524 17504 V UvcApiCaptureSession: construct(0x01761a1b) 10-08 22:11:28.131 12524 17428 D UsbResiliantWebcam|DelCaptureSession: camera session is configured: Webcam(D47A8AC0) 10-08 22:11:28.132 12524 17504 V UvcApiCameraCaptureSequence: construct(0x071f87b8) 10-08 22:11:28.132 12524 17504 D UvcDeviceHandle: getStreamControl(320x240 30)... 10-08 22:11:28.133 12524 17504 V UvcStreamCtrl: construct(0x04170991) 10-08 22:11:28.133 12524 17504 D Uvc : [jni_devicehandle.cpp:115] Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDeviceHandle_nativeGetStreamControlFormatSize()... 10-08 22:11:28.133 12524 17504 V Uvc : API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDeviceHandle_nativeGetStreamControlFormatSize: enter... 10-08 22:11:28.133 12524 17504 D Uvc : [stream.cpp:375] uvc_get_stream_ctrl_format_size()... 10-08 22:11:28.133 12524 17504 D Uvc : [libuvc/libuvc_internal.h:773] uvc_device_handle::claimInterface(idx=1)... 10-08 22:11:28.133 12524 17504 D UvcDevice: claimInterface(1) 10-08 22:11:28.134 12524 17504 D UvcDevice: claimInterface(1) succeeded 10-08 22:11:28.134 12524 17504 D Uvc : [libuvc/libuvc_internal.h:786] claimInterface(1) succeeded 10-08 22:11:28.134 12524 17504 D Uvc : [libuvc/libuvc_internal.h:773] ...uvc_device_handle::claimInterface() rc=0 10-08 22:11:28.134 12524 17504 D UvcStream: [stream.cpp:414] 320x240 30fps 10-08 22:11:28.134 12524 17504 D Uvc : [stream.cpp:164] uvc_query_stream_ctrl()... 10-08 22:11:28.137 12524 17504 D Uvc : [stream.cpp:164] ...uvc_query_stream_ctrl() rc=0 10-08 22:11:28.138 12524 17504 D Uvc : [libuvc/libuvc_internal.h:796] uvc_device_handle::releaseInterface()... 10-08 22:11:28.138 12524 17504 D UvcDevice: releaseInterface(1) 10-08 22:11:28.138 12524 17504 D UvcDevice: releaseInterface(1) succeeded 10-08 22:11:28.138 12524 17504 D Uvc : [libuvc/libuvc_internal.h:796] ...uvc_device_handle::releaseInterface() rc=0 10-08 22:11:28.138 12524 17504 D Uvc : [stream.cpp:484] uvc_probe_stream_ctrl()... 10-08 22:11:28.138 12524 17504 D Uvc : [libuvc/libuvc_internal.h:773] uvc_device_handle::claimInterface(idx=1)... 10-08 22:11:28.138 12524 17504 D UvcDevice: claimInterface(1) 10-08 22:11:28.138 12524 17504 D UvcDevice: claimInterface(1) succeeded 10-08 22:11:28.138 12524 17504 D Uvc : [libuvc/libuvc_internal.h:786] claimInterface(1) succeeded 10-08 22:11:28.138 12524 17504 D Uvc : [libuvc/libuvc_internal.h:773] ...uvc_device_handle::claimInterface() rc=0 10-08 22:11:28.138 12524 17504 D Uvc : [stream.cpp:164] uvc_query_stream_ctrl()... 10-08 22:11:28.144 12524 17504 D Uvc : [stream.cpp:164] ...uvc_query_stream_ctrl() rc=0 10-08 22:11:28.144 12524 17504 D Uvc : [stream.cpp:164] uvc_query_stream_ctrl()... 10-08 22:11:28.148 12524 17504 D Uvc : [stream.cpp:164] ...uvc_query_stream_ctrl() rc=0 10-08 22:11:28.148 12524 17504 D Uvc : [stream.cpp:484] ...uvc_probe_stream_ctrl() rc=0 10-08 22:11:28.148 12524 17504 D Uvc : [stream.cpp:375] ...uvc_get_stream_ctrl_format_size() rc=0 10-08 22:11:28.148 12524 17504 V Uvc : API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDeviceHandle_nativeGetStreamControlFormatSize: ...exit 10-08 22:11:28.148 12524 17504 D Uvc : [jni_devicehandle.cpp:115] ...Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcDeviceHandle_nativeGetStreamControlFormatSize() 10-08 22:11:28.148 12524 17504 D UvcDeviceHandle: ...getStreamControl(320x240 30) 10-08 22:11:28.149 12524 17504 D Uvc : [jni_streamcontrol.cpp:101] Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcStreamCtrl_nativeOpen()... 10-08 22:11:28.149 12524 17504 V Uvc : API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcStreamCtrl_nativeOpen: enter... 10-08 22:11:28.149 12524 17504 D Uvc : [devicehandle.cpp:46] uvc_device_handle::openStreamControl()... 10-08 22:11:28.149 12524 17504 D Uvc : [streamhandle.cpp:58] uvc_stream_handle::claimInterface()... 10-08 22:11:28.149 12524 17504 D Uvc : [libuvc/libuvc_internal.h:773] uvc_device_handle::claimInterface(idx=1)... 10-08 22:11:28.150 12524 17504 D UvcDevice: claimInterface(1) 10-08 22:11:28.150 12524 17504 D UvcDevice: claimInterface(1) succeeded 10-08 22:11:28.150 12524 17504 D Uvc : [libuvc/libuvc_internal.h:786] claimInterface(1) succeeded 10-08 22:11:28.150 12524 17504 D Uvc : [libuvc/libuvc_internal.h:773] ...uvc_device_handle::claimInterface() rc=0 10-08 22:11:28.150 12524 17504 D Uvc : [streamhandle.cpp:58] ...uvc_stream_handle::claimInterface() rc=0 10-08 22:11:28.150 12524 17504 D Uvc : [stream.cpp:164] uvc_query_stream_ctrl()... 10-08 22:11:28.159 12524 17504 D Uvc : [stream.cpp:164] ...uvc_query_stream_ctrl() rc=0 10-08 22:11:28.159 12524 17504 D Uvc : [devicehandle.cpp:46] ...uvc_device_handle::openStreamControl() rc=0 10-08 22:11:28.159 12524 17504 V Uvc : API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcStreamCtrl_nativeOpen: ...exit 10-08 22:11:28.159 12524 17504 D Uvc : [jni_streamcontrol.cpp:101] ...Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcStreamCtrl_nativeOpen() 10-08 22:11:28.159 12524 17504 V UvcStreamHandle: construct(pointer=0xb91f3b60) 10-08 22:11:28.159 12524 17504 D Uvc : [jni_streamhandle.cpp:184] Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcStreamHandle_nativeStopStreaming()... 10-08 22:11:28.159 12524 17504 V Uvc : API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcStreamHandle_nativeStopStreaming: enter... 10-08 22:11:28.159 12524 17504 D Uvc : [stream.cpp:1467] uvc_stream_stop()... 10-08 22:11:28.159 12524 17504 D Uvc : [stream.cpp:1467] ...uvc_stream_stop() rc=0 10-08 22:11:28.159 12524 17504 V Uvc : API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcStreamHandle_nativeStopStreaming: ...exit 10-08 22:11:28.159 12524 17504 D Uvc : [jni_streamhandle.cpp:184] ...Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcStreamHandle_nativeStopStreaming() 10-08 22:11:28.160 12524 17504 V UvcFrameCallback: construct(0x09df70f6) 10-08 22:11:28.160 12524 17504 V UvcFrameCallbackData: construct(pointer=0xb9193288) 10-08 22:11:28.160 12524 17504 V Uvc : API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcStreamHandle_nativeStartStreaming: enter... 10-08 22:11:28.161 12524 17504 D Uvc : [stream.cpp:931] uvc_stream_start_bandwidth()... 10-08 22:11:28.161 12524 17504 D Uvc : [stream.cpp:1126] uvc_stream_handle::startIsochronousStreaming()... 10-08 22:11:28.161 12524 17504 D Uvc : [libuvc/libuvc_internal.h:828] uvc_device_handle::setInterfaceAltSetting(setInterfaceAltSetting(intf=1 alt=8))... 10-08 22:11:28.161 12524 17504 D UvcDevice: setInterfaceAltSetting(1,8) 10-08 22:11:28.162 12524 17504 D UvcDevice: setInterfaceAltSetting(1,8) succeeded 10-08 22:11:28.162 12524 17504 D Uvc : [libuvc/libuvc_internal.h:828] ...uvc_device_handle::setInterfaceAltSetting() rc=0 10-08 22:11:28.162 12524 17504 D Uvc : [stream.cpp:1126] ...uvc_stream_handle::startIsochronousStreaming() rc=0 10-08 22:11:28.162 12524 17504 D Uvc : [stream.cpp:1154] uvc_stream_handle::startUserCallbackThread()... 10-08 22:11:28.163 12524 17505 D UvcStream: [stream.cpp:1218] User Callback thread started 10-08 22:11:28.163 12524 17504 D Uvc : [stream.cpp:1154] ...uvc_stream_handle::startUserCallbackThread() rc=0 10-08 22:11:28.163 12524 17504 D Uvc : [stream.cpp:1174] uvc_stream_handle::submitTransfers()... 10-08 22:11:28.396 12524 17338 D UvcStream: [stream.cpp:690] this is the UVC processTransfer() stream processing thread 10-08 22:11:28.397 12524 17504 D Uvc : [stream.cpp:1174] ...uvc_stream_handle::submitTransfers() rc=0 10-08 22:11:28.397 12524 17504 D Uvc : [stream.cpp:931] ...uvc_stream_start_bandwidth() rc=0 10-08 22:11:28.397 12524 17504 D UvcStreamHandle: [jni_streamhandle.cpp:150] successfully started streaming 10-08 22:11:28.397 12524 17504 V Uvc : API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcStreamHandle_nativeStartStreaming: ...exit 10-08 22:11:28.397 12524 17504 V UvcStreamCtrl: destroy(pointer=0xb8f1edc0) 10-08 22:11:28.397 12524 17504 D UsbResiliantWebcam|DelCaptureSequence: ...doStreaming() 10-08 22:11:28.397 12524 17504 D UsbResiliantWebcam|DelCaptureSequence: ...startStreaming(Stopped) 10-08 22:11:28.397 12524 17504 D UsbResiliantWebcam|DelCaptureSession: ...startCapture() 10-08 22:11:28.398 12524 17504 I System.out: OpenCvWebcam: onConfigured 10-08 22:11:28.398 12524 17491 I System.out: OpenCvWebcam: streaming started 10-08 22:11:28.417 12524 12794 V Robocol : sending CMD_STREAM_CHANGE(23713), attempt: 0 10-08 22:11:28.769 12524 17505 D Uvc : [jni_context.cpp:157] Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcContext_nativeInitRenderScriptParameters()... 10-08 22:11:28.769 12524 17505 V Uvc : API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcContext_nativeInitRenderScriptParameters: enter... 10-08 22:11:28.769 12524 17505 V Uvc : API: Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcContext_nativeInitRenderScriptParameters: ...exit 10-08 22:11:28.769 12524 17505 D Uvc : [jni_context.cpp:157] ...Java_org_firstinspires_ftc_robotcore_internal_camera_libuvc_nativeobject_UvcContext_nativeInitRenderScriptParameters() 10-08 22:11:28.760 17505 17505 W Thread-810: type=1400 audit(0.0:5495): avc: denied { write } for uid=10128 name="property_service" dev="tmpfs" ino=6364 scontext=u:r:untrusted_app:s0:c512,c768 tcontext=u:object_r:property_socket:s0 tclass=sock_file permissive=0 10-08 22:11:28.775 12524 17505 D UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26) 10-08 22:11:28.784 12524 17505 E RS Dispatch: Couldn't initialize dispatchTab.ScriptReduce 10-08 22:11:28.785 12524 17505 V rsC++ : libRS.so init failed! 10-08 22:11:28.787 12524 17505 V rsC++ : couldn't dlopen libRSSupport.so, dlopen failed: library "libRSSupport.so" not found 10-08 22:11:28.787 12524 17505 E rsC++ : Failed to load libRS.so and libRSSupport.so 10-08 22:11:28.787 12524 17505 E rsC++ : Couldn't initialize dispatch table 10-08 22:11:28.787 12524 17505 E UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0 10-08 22:11:28.787 12524 17505 E UvcFrame: [jni_frame.cpp:226] renderScript creation failed 10-08 22:11:28.863 12524 17505 D UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26) 10-08 22:11:28.863 12524 17505 E rsC++ : Couldn't initialize dispatch table 10-08 22:11:28.863 12524 17505 E UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0 10-08 22:11:28.863 12524 17505 E UvcFrame: [jni_frame.cpp:226] renderScript creation failed 10-08 22:11:28.914 12524 17505 D UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26) 10-08 22:11:28.914 12524 17505 E rsC++ : Couldn't initialize dispatch table 10-08 22:11:28.914 12524 17505 E UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0 10-08 22:11:28.914 12524 17505 E UvcFrame: [jni_frame.cpp:226] renderScript creation failed 10-08 22:11:28.963 12524 17505 D UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26) 10-08 22:11:28.963 12524 17505 E rsC++ : Couldn't initialize dispatch table 10-08 22:11:28.963 12524 17505 E UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0 10-08 22:11:28.963 12524 17505 E UvcFrame: [jni_frame.cpp:226] renderScript creation failed 10-08 22:11:29.014 12524 17505 D UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26) 10-08 22:11:29.014 12524 17505 E rsC++ : Couldn't initialize dispatch table 10-08 22:11:29.014 12524 17505 E UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0 10-08 22:11:29.014 12524 17505 E UvcFrame: [jni_frame.cpp:226] renderScript creation failed 10-08 22:11:29.062 12524 17505 D UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26) 10-08 22:11:29.063 12524 17505 E rsC++ : Couldn't initialize dispatch table 10-08 22:11:29.063 12524 17505 E UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0 10-08 22:11:29.063 12524 17505 E UvcFrame: [jni_frame.cpp:226] renderScript creation failed 10-08 22:11:29.114 12524 17505 D UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26) 10-08 22:11:29.114 12524 17505 E rsC++ : Couldn't initialize dispatch table 10-08 22:11:29.115 12524 17505 E UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0 10-08 22:11:29.115 12524 17505 E UvcFrame: [jni_frame.cpp:226] renderScript creation failed 10-08 22:11:29.162 12524 17505 D UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26) 10-08 22:11:29.162 12524 17505 E rsC++ : Couldn't initialize dispatch table 10-08 22:11:29.162 12524 17505 E UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0 10-08 22:11:29.162 12524 17505 E UvcFrame: [jni_frame.cpp:226] renderScript creation failed 10-08 22:11:29.215 12524 17505 D UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26) 10-08 22:11:29.215 12524 17505 E rsC++ : Couldn't initialize dispatch table 10-08 22:11:29.215 12524 17505 E UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0 10-08 22:11:29.215 12524 17505 E UvcFrame: [jni_frame.cpp:226] renderScript creation failed 10-08 22:11:29.262 12524 17505 D UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26) 10-08 22:11:29.262 12524 17505 E rsC++ : Couldn't initialize dispatch table 10-08 22:11:29.263 12524 17505 E UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0 10-08 22:11:29.263 12524 17505 E UvcFrame: [jni_frame.cpp:226] renderScript creation failed 10-08 22:11:29.314 12524 17505 D UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26) 10-08 22:11:29.314 12524 17505 E rsC++ : Couldn't initialize dispatch table 10-08 22:11:29.314 12524 17505 E UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0 10-08 22:11:29.315 12524 17505 E UvcFrame: [jni_frame.cpp:226] renderScript creation failed 10-08 22:11:29.363 12524 17505 D UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26) 10-08 22:11:29.363 12524 17505 E rsC++ : Couldn't initialize dispatch table 10-08 22:11:29.363 12524 17505 E UvcContext: [jni_context.cpp:141] renderScript initialization failed: err=0 10-08 22:11:29.363 12524 17505 E UvcFrame: [jni_frame.cpp:226] renderScript creation failed 10-08 22:11:29.414 12524 17505 D UvcContext: [jni_context.cpp:133] creating renderScript(/data/user/0/com.qualcomm.ftcrobotcontroller/cache/org.firstinspires.ftc.renderscript.cache,0x00000000,26) 10-08 22:11:29.414 12524 17505 E rsC++ : Couldn't initialize dispatch table

Windwoes commented 4 years ago

@haifengchicago what is the output if you run adb shell getprop debug.rs.forcecompat?

Windwoes commented 4 years ago

@Matthew1231A @haifengchicago @mtbbiker a HOTFIX 1.2 release has been pushed which works around an SDK bug that prevented the initialization of RenderScript on some devices, which resulted in failure to properly forward the webcam frames to the user pipeline. To upgrade, simply change the line in your gradle file to

implementation 'org.openftc:easyopencv:1.2'

haifengchicago commented 4 years ago

@FROGbots-4634 Great, confirm that HOTFIX 1.2 addressed the issue. You guys rocks! This helps us a lot because this is much simpler than taking a frame from Vuforia (and with water mark).

mtbbiker commented 4 years ago

@Matthew1231A @haifengchicago @mtbbiker a HOTFIX 1.2 release has been pushed which works around an SDK bug that prevented the initialization of RenderScript on some devices, which resulted in failure to properly forward the webcam frames to the user pipeline. To upgrade, simply change the line in your gradle file to
implementation 'org.openftc:easyopencv:1.2'

@FROGbots-4634 I can confirm that the work-around also fix our problem! Thank you for the help !

OpenFTC / EasyOpenCV

Initialization stalls out #1