I took some more time at this issue today.
What I've found out:
When the chipset crashes, it's only the TUSB firmware that crashes, the
data is still coming in to it on its UART lines(I checked by tapping
into those, and everything was fine).
The problem actually does not appear with the usbser.sys windows driver
under windows, and some deeper inspection revealed that even when no one
was actually reading the COM port under windows, windows was still
receiving urbs. I have attached two logs with urbs snooped under windows
for when one starts reading on the com port, and when one actually
closes the com port.
I am not sure how relevant it is to the issue, but my linux pcap traces
didn't indicate receiving any urbs at all once the last reader closed
down. It is as if cdc_acm refused to receive urbs once closed, and that
caused the chipset's firmware to crash.
Does this make any sense?
- Paul-Kenji
[898066 ms] UsbSnoop - MyInternalIOCTLCompletion(b1e71126) : fido=00000000, Irp=81d0fc10, Context=81d3e480, IRQL=2
[898066 ms] <<< URB 2757 coming back <<<
-- URB_FUNCTION_BULK_OR_INTERRUPT_TRANSFER:
PipeHandle = 81e0e4ac [endpoint 0x00000083]
TransferFlags = 00000003 (USBD_TRANSFER_DIRECTION_IN, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00000001
TransferBuffer = 81fa8004
TransferBufferMDL = 822475b0
00000000: 4e
UrbLink = 00000000
[898066 ms] UsbSnoop - FilterDispatchAny(b1e70fd2) : IRP_MJ_INTERNAL_DEVICE_CONTROL
[898067 ms] UsbSnoop - FdoHookDispatchInternalIoctl(b1e711ea) : fdo=81d3de18, Irp=81d0fc10, IRQL=2
[898067 ms] >>> URB 2758 going down >>>
-- URB_FUNCTION_BULK_OR_INTERRUPT_TRANSFER:
PipeHandle = 81e0e4ac [endpoint 0x00000083]
TransferFlags = 00000003 (USBD_TRANSFER_DIRECTION_IN, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00001000
TransferBuffer = 81fa8004
TransferBufferMDL = 00000000
UrbLink = 00000000
[898395 ms] UsbSnoop - MyInternalIOCTLCompletion(b1e71126) : fido=00000000, Irp=81d0fc10, Context=81d3e480, IRQL=2
[898395 ms] <<< URB 2758 coming back <<<
-- URB_FUNCTION_BULK_OR_INTERRUPT_TRANSFER:
PipeHandle = 81e0e4ac [endpoint 0x00000083]
TransferFlags = 00000003 (USBD_TRANSFER_DIRECTION_IN, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00000001
TransferBuffer = 81fa8004
TransferBufferMDL = 822475b0
00000000: 4e
UrbLink = 00000000
[898395 ms] UsbSnoop - FilterDispatchAny(b1e70fd2) : IRP_MJ_INTERNAL_DEVICE_CONTROL
[898395 ms] UsbSnoop - FdoHookDispatchInternalIoctl(b1e711ea) : fdo=81d3de18, Irp=81d0fc10, IRQL=2
[898395 ms] >>> URB 2759 going down >>>
-- URB_FUNCTION_BULK_OR_INTERRUPT_TRANSFER:
PipeHandle = 81e0e4ac [endpoint 0x00000083]
TransferFlags = 00000003 (USBD_TRANSFER_DIRECTION_IN, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00001000
TransferBuffer = 81fa8004
TransferBufferMDL = 00000000
UrbLink = 00000000
[898724 ms] UsbSnoop - MyInternalIOCTLCompletion(b1e71126) : fido=00000000, Irp=81d0fc10, Context=81d3e480, IRQL=2
[898724 ms] <<< URB 2759 coming back <<<
-- URB_FUNCTION_BULK_OR_INTERRUPT_TRANSFER:
PipeHandle = 81e0e4ac [endpoint 0x00000083]
TransferFlags = 00000003 (USBD_TRANSFER_DIRECTION_IN, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00000001
TransferBuffer = 81fa8004
TransferBufferMDL = 822475b0
00000000: 4e
UrbLink = 00000000
[898724 ms] UsbSnoop - FilterDispatchAny(b1e70fd2) : IRP_MJ_INTERNAL_DEVICE_CONTROL
[898724 ms] UsbSnoop - FdoHookDispatchInternalIoctl(b1e711ea) : fdo=81d3de18, Irp=81d0fc10, IRQL=2
[898724 ms] >>> URB 2760 going down >>>
-- URB_FUNCTION_BULK_OR_INTERRUPT_TRANSFER:
PipeHandle = 81e0e4ac [endpoint 0x00000083]
TransferFlags = 00000003 (USBD_TRANSFER_DIRECTION_IN, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00001000
TransferBuffer = 81fa8004
TransferBufferMDL = 00000000
UrbLink = 00000000
[899051 ms] UsbSnoop - MyInternalIOCTLCompletion(b1e71126) : fido=00000000, Irp=81d0fc10, Context=81d3e480, IRQL=2
[899051 ms] <<< URB 2760 coming back <<<
-- URB_FUNCTION_BULK_OR_INTERRUPT_TRANSFER:
PipeHandle = 81e0e4ac [endpoint 0x00000083]
TransferFlags = 00000003 (USBD_TRANSFER_DIRECTION_IN, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00000001
TransferBuffer = 81fa8004
TransferBufferMDL = 822475b0
00000000: 4e
UrbLink = 00000000
[899051 ms] UsbSnoop - FilterDispatchAny(b1e70fd2) : IRP_MJ_INTERNAL_DEVICE_CONTROL
[899051 ms] UsbSnoop - FdoHookDispatchInternalIoctl(b1e711ea) : fdo=81d3de18, Irp=81d0fc10, IRQL=2
[899051 ms] >>> URB 2761 going down >>>
-- URB_FUNCTION_BULK_OR_INTERRUPT_TRANSFER:
PipeHandle = 81e0e4ac [endpoint 0x00000083]
TransferFlags = 00000003 (USBD_TRANSFER_DIRECTION_IN, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00001000
TransferBuffer = 81fa8004
TransferBufferMDL = 00000000
UrbLink = 00000000
[899379 ms] UsbSnoop - MyInternalIOCTLCompletion(b1e71126) : fido=00000000, Irp=81d0fc10, Context=81d3e480, IRQL=2
[899379 ms] <<< URB 2761 coming back <<<
-- URB_FUNCTION_BULK_OR_INTERRUPT_TRANSFER:
PipeHandle = 81e0e4ac [endpoint 0x00000083]
TransferFlags = 00000003 (USBD_TRANSFER_DIRECTION_IN, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00000001
TransferBuffer = 81fa8004
TransferBufferMDL = 822475b0
00000000: 4e
UrbLink = 00000000
[899379 ms] UsbSnoop - FilterDispatchAny(b1e70fd2) : IRP_MJ_INTERNAL_DEVICE_CONTROL
[899379 ms] UsbSnoop - FdoHookDispatchInternalIoctl(b1e711ea) : fdo=81d3de18, Irp=81d0fc10, IRQL=2
[899379 ms] >>> URB 2762 going down >>>
-- URB_FUNCTION_BULK_OR_INTERRUPT_TRANSFER:
PipeHandle = 81e0e4ac [endpoint 0x00000083]
TransferFlags = 00000003 (USBD_TRANSFER_DIRECTION_IN, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00001000
TransferBuffer = 81fa8004
TransferBufferMDL = 00000000
UrbLink = 00000000
[899709 ms] UsbSnoop - MyInternalIOCTLCompletion(b1e71126) : fido=00000000, Irp=81d0fc10, Context=81d3e480, IRQL=2
[899709 ms] <<< URB 2762 coming back <<<
-- URB_FUNCTION_BULK_OR_INTERRUPT_TRANSFER:
PipeHandle = 81e0e4ac [endpoint 0x00000083]
TransferFlags = 00000003 (USBD_TRANSFER_DIRECTION_IN, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00000001
TransferBuffer = 81fa8004
TransferBufferMDL = 822475b0
00000000: 4e
UrbLink = 00000000
[899709 ms] UsbSnoop - FilterDispatchAny(b1e70fd2) : IRP_MJ_INTERNAL_DEVICE_CONTROL
[899709 ms] UsbSnoop - FdoHookDispatchInternalIoctl(b1e711ea) : fdo=81d3de18, Irp=81d0fc10, IRQL=2
[899709 ms] >>> URB 2763 going down >>>
-- URB_FUNCTION_BULK_OR_INTERRUPT_TRANSFER:
PipeHandle = 81e0e4ac [endpoint 0x00000083]
TransferFlags = 00000003 (USBD_TRANSFER_DIRECTION_IN, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00001000
TransferBuffer = 81fa8004
TransferBufferMDL = 00000000
UrbLink = 00000000
[900037 ms] UsbSnoop - MyInternalIOCTLCompletion(b1e71126) : fido=00000000, Irp=81d0fc10, Context=81d3e480, IRQL=2
[900037 ms] <<< URB 2763 coming back <<<
-- URB_FUNCTION_BULK_OR_INTERRUPT_TRANSFER:
PipeHandle = 81e0e4ac [endpoint 0x00000083]
TransferFlags = 00000003 (USBD_TRANSFER_DIRECTION_IN, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00000001
TransferBuffer = 81fa8004
TransferBufferMDL = 822475b0
00000000: 4e
UrbLink = 00000000
[900037 ms] UsbSnoop - FilterDispatchAny(b1e70fd2) : IRP_MJ_INTERNAL_DEVICE_CONTROL
[900037 ms] UsbSnoop - FdoHookDispatchInternalIoctl(b1e711ea) : fdo=81d3de18, Irp=81d0fc10, IRQL=2
[900037 ms] >>> URB 2764 going down >>>
-- URB_FUNCTION_BULK_OR_INTERRUPT_TRANSFER:
PipeHandle = 81e0e4ac [endpoint 0x00000083]
TransferFlags = 00000003 (USBD_TRANSFER_DIRECTION_IN, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00001000
TransferBuffer = 81fa8004
TransferBufferMDL = 00000000
UrbLink = 00000000
[900106 ms] UsbSnoop - FilterDispatchAny(b1e70fd2) : IRP_MJ_INTERNAL_DEVICE_CONTROL
[900106 ms] UsbSnoop - FdoHookDispatchInternalIoctl(b1e711ea) : fdo=81d3de18, Irp=82201008, IRQL=0
[900106 ms] >>> URB 2765 going down >>>
-- URB_FUNCTION_CLASS_INTERFACE:
TransferFlags = 00000000 (USBD_TRANSFER_DIRECTION_OUT, ~USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00000000
TransferBuffer = 00000000
TransferBufferMDL = 00000000
no data supplied
UrbLink = 00000000
RequestTypeReservedBits = 00000000
Request = 00000022
Value = 00000002
Index = 00000000
[900110 ms] UsbSnoop - MyInternalIOCTLCompletion(b1e71126) : fido=00000000, Irp=82201008, Context=81f46560, IRQL=2
[900110 ms] <<< URB 2765 coming back <<<
-- URB_FUNCTION_CONTROL_TRANSFER:
PipeHandle = 821d8138
TransferFlags = 0000000a (USBD_TRANSFER_DIRECTION_OUT, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00000000
TransferBuffer = 00000000
TransferBufferMDL = 00000000
UrbLink = 00000000
SetupPacket =
00000000: 21 22 02 00 00 00 00 00
[900365 ms] UsbSnoop - MyInternalIOCTLCompletion(b1e71126) : fido=00000000, Irp=81d0fc10, Context=81d3e480, IRQL=2
[900365 ms] <<< URB 2764 coming back <<<
-- URB_FUNCTION_BULK_OR_INTERRUPT_TRANSFER:
PipeHandle = 81e0e4ac [endpoint 0x00000083]
TransferFlags = 00000003 (USBD_TRANSFER_DIRECTION_IN, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00000001
TransferBuffer = 81fa8004
TransferBufferMDL = 822475b0
00000000: 4e
UrbLink = 00000000
[900365 ms] UsbSnoop - FilterDispatchAny(b1e70fd2) : IRP_MJ_INTERNAL_DEVICE_CONTROL
[900365 ms] UsbSnoop - FdoHookDispatchInternalIoctl(b1e711ea) : fdo=81d3de18, Irp=81d0fc10, IRQL=2
[900365 ms] >>> URB 2766 going down >>>
-- URB_FUNCTION_BULK_OR_INTERRUPT_TRANSFER:
PipeHandle = 81e0e4ac [endpoint 0x00000083]
TransferFlags = 00000003 (USBD_TRANSFER_DIRECTION_IN, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00001000
TransferBuffer = 81fa8004
TransferBufferMDL = 00000000
UrbLink = 00000000
[900693 ms] UsbSnoop - MyInternalIOCTLCompletion(b1e71126) : fido=00000000, Irp=81d0fc10, Context=81d3e480, IRQL=2
[900693 ms] <<< URB 2766 coming back <<<
-- URB_FUNCTION_BULK_OR_INTERRUPT_TRANSFER:
PipeHandle = 81e0e4ac [endpoint 0x00000083]
TransferFlags = 00000003 (USBD_TRANSFER_DIRECTION_IN, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00000001
TransferBuffer = 81fa8004
TransferBufferMDL = 822475b0
00000000: 4e
UrbLink = 00000000
[900693 ms] UsbSnoop - FilterDispatchAny(b1e70fd2) : IRP_MJ_INTERNAL_DEVICE_CONTROL
[900693 ms] UsbSnoop - FdoHookDispatchInternalIoctl(b1e711ea) : fdo=81d3de18, Irp=81d0fc10, IRQL=2
[900693 ms] >>> URB 2767 going down >>>
-- URB_FUNCTION_BULK_OR_INTERRUPT_TRANSFER:
PipeHandle = 81e0e4ac [endpoint 0x00000083]
TransferFlags = 00000003 (USBD_TRANSFER_DIRECTION_IN, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00001000
TransferBuffer = 81fa8004
TransferBufferMDL = 00000000
UrbLink = 00000000
[950934 ms] UsbSnoop - MyInternalIOCTLCompletion(b1e71126) : fido=00000000, Irp=81d0fc10, Context=81d3e480, IRQL=2
[950934 ms] <<< URB 2919 coming back <<<
-- URB_FUNCTION_BULK_OR_INTERRUPT_TRANSFER:
PipeHandle = 81e0e4ac [endpoint 0x00000083]
TransferFlags = 00000003 (USBD_TRANSFER_DIRECTION_IN, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00000001
TransferBuffer = 81fa8004
TransferBufferMDL = 81d43588
00000000: 4e
UrbLink = 00000000
[950934 ms] UsbSnoop - FilterDispatchAny(b1e70fd2) : IRP_MJ_INTERNAL_DEVICE_CONTROL
[950934 ms] UsbSnoop - FdoHookDispatchInternalIoctl(b1e711ea) : fdo=81d3de18, Irp=81d0fc10, IRQL=2
[950934 ms] >>> URB 2920 going down >>>
-- URB_FUNCTION_BULK_OR_INTERRUPT_TRANSFER:
PipeHandle = 81e0e4ac [endpoint 0x00000083]
TransferFlags = 00000003 (USBD_TRANSFER_DIRECTION_IN, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00001000
TransferBuffer = 81fa8004
TransferBufferMDL = 00000000
UrbLink = 00000000
[951262 ms] UsbSnoop - MyInternalIOCTLCompletion(b1e71126) : fido=00000000, Irp=81d0fc10, Context=81d3e480, IRQL=2
[951262 ms] <<< URB 2920 coming back <<<
-- URB_FUNCTION_BULK_OR_INTERRUPT_TRANSFER:
PipeHandle = 81e0e4ac [endpoint 0x00000083]
TransferFlags = 00000003 (USBD_TRANSFER_DIRECTION_IN, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00000001
TransferBuffer = 81fa8004
TransferBufferMDL = 81d43588
00000000: 4e
UrbLink = 00000000
[951262 ms] UsbSnoop - FilterDispatchAny(b1e70fd2) : IRP_MJ_INTERNAL_DEVICE_CONTROL
[951262 ms] UsbSnoop - FdoHookDispatchInternalIoctl(b1e711ea) : fdo=81d3de18, Irp=81d0fc10, IRQL=2
[951262 ms] >>> URB 2921 going down >>>
-- URB_FUNCTION_BULK_OR_INTERRUPT_TRANSFER:
PipeHandle = 81e0e4ac [endpoint 0x00000083]
TransferFlags = 00000003 (USBD_TRANSFER_DIRECTION_IN, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00001000
TransferBuffer = 81fa8004
TransferBufferMDL = 00000000
UrbLink = 00000000
[951591 ms] UsbSnoop - MyInternalIOCTLCompletion(b1e71126) : fido=00000000, Irp=81d0fc10, Context=81d3e480, IRQL=2
[951591 ms] <<< URB 2921 coming back <<<
-- URB_FUNCTION_BULK_OR_INTERRUPT_TRANSFER:
PipeHandle = 81e0e4ac [endpoint 0x00000083]
TransferFlags = 00000003 (USBD_TRANSFER_DIRECTION_IN, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00000001
TransferBuffer = 81fa8004
TransferBufferMDL = 81d43588
00000000: 4e
UrbLink = 00000000
[951591 ms] UsbSnoop - FilterDispatchAny(b1e70fd2) : IRP_MJ_INTERNAL_DEVICE_CONTROL
[951591 ms] UsbSnoop - FdoHookDispatchInternalIoctl(b1e711ea) : fdo=81d3de18, Irp=81d0fc10, IRQL=2
[951591 ms] >>> URB 2922 going down >>>
-- URB_FUNCTION_BULK_OR_INTERRUPT_TRANSFER:
PipeHandle = 81e0e4ac [endpoint 0x00000083]
TransferFlags = 00000003 (USBD_TRANSFER_DIRECTION_IN, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00001000
TransferBuffer = 81fa8004
TransferBufferMDL = 00000000
UrbLink = 00000000
[951781 ms] UsbSnoop - FilterDispatchAny(b1e70fd2) : IRP_MJ_INTERNAL_DEVICE_CONTROL
[951781 ms] UsbSnoop - FdoHookDispatchInternalIoctl(b1e711ea) : fdo=81d3de18, Irp=822d49b8, IRQL=0
[951781 ms] >>> URB 2923 going down >>>
-- URB_FUNCTION_CLASS_INTERFACE:
TransferFlags = 00000001 (USBD_TRANSFER_DIRECTION_IN, ~USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00000007
TransferBuffer = b22b3be4
TransferBufferMDL = 00000000
UrbLink = 00000000
RequestTypeReservedBits = 00000000
Request = 00000021
Value = 00000000
Index = 00000000
[951785 ms] UsbSnoop - MyInternalIOCTLCompletion(b1e71126) : fido=00000000, Irp=822d49b8, Context=81f46560, IRQL=2
[951785 ms] <<< URB 2923 coming back <<<
-- URB_FUNCTION_CONTROL_TRANSFER:
PipeHandle = 821d8138
TransferFlags = 0000000b (USBD_TRANSFER_DIRECTION_IN, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00000007
TransferBuffer = b22b3be4
TransferBufferMDL = 81ebaa48
00000000: 60 09 00 00 00 00 08
UrbLink = 00000000
SetupPacket =
00000000: a1 21 00 00 00 00 07 00
[951785 ms] UsbSnoop - FilterDispatchAny(b1e70fd2) : IRP_MJ_INTERNAL_DEVICE_CONTROL
[951785 ms] UsbSnoop - FdoHookDispatchInternalIoctl(b1e711ea) : fdo=81d3de18, Irp=822d49b8, IRQL=0
[951785 ms] >>> URB 2924 going down >>>
-- URB_FUNCTION_CLASS_INTERFACE:
TransferFlags = 00000001 (USBD_TRANSFER_DIRECTION_IN, ~USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00000007
TransferBuffer = b22b3be4
TransferBufferMDL = 00000000
UrbLink = 00000000
RequestTypeReservedBits = 00000000
Request = 00000021
Value = 00000000
Index = 00000000
[951790 ms] UsbSnoop - MyInternalIOCTLCompletion(b1e71126) : fido=00000000, Irp=822d49b8, Context=81f46560, IRQL=2
[951790 ms] <<< URB 2924 coming back <<<
-- URB_FUNCTION_CONTROL_TRANSFER:
PipeHandle = 821d8138
TransferFlags = 0000000b (USBD_TRANSFER_DIRECTION_IN, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00000007
TransferBuffer = b22b3be4
TransferBufferMDL = 81ebaa48
00000000: 60 09 00 00 00 00 08
UrbLink = 00000000
SetupPacket =
00000000: a1 21 00 00 00 00 07 00
[951790 ms] UsbSnoop - FilterDispatchAny(b1e70fd2) : IRP_MJ_INTERNAL_DEVICE_CONTROL
[951790 ms] UsbSnoop - FdoHookDispatchInternalIoctl(b1e711ea) : fdo=81d3de18, Irp=822d49b8, IRQL=0
[951790 ms] >>> URB 2925 going down >>>
-- URB_FUNCTION_CLASS_INTERFACE:
TransferFlags = 00000001 (USBD_TRANSFER_DIRECTION_IN, ~USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00000007
TransferBuffer = b22b3be4
TransferBufferMDL = 00000000
UrbLink = 00000000
RequestTypeReservedBits = 00000000
Request = 00000021
Value = 00000000
Index = 00000000
[951795 ms] UsbSnoop - MyInternalIOCTLCompletion(b1e71126) : fido=00000000, Irp=822d49b8, Context=81f46560, IRQL=2
[951795 ms] <<< URB 2925 coming back <<<
-- URB_FUNCTION_CONTROL_TRANSFER:
PipeHandle = 821d8138
TransferFlags = 0000000b (USBD_TRANSFER_DIRECTION_IN, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00000007
TransferBuffer = b22b3be4
TransferBufferMDL = 81ebaa48
00000000: 60 09 00 00 00 00 08
UrbLink = 00000000
SetupPacket =
00000000: a1 21 00 00 00 00 07 00
[951795 ms] UsbSnoop - FilterDispatchAny(b1e70fd2) : IRP_MJ_INTERNAL_DEVICE_CONTROL
[951795 ms] UsbSnoop - FdoHookDispatchInternalIoctl(b1e711ea) : fdo=81d3de18, Irp=822d49b8, IRQL=0
[951795 ms] >>> URB 2926 going down >>>
-- URB_FUNCTION_CLASS_INTERFACE:
TransferFlags = 00000001 (USBD_TRANSFER_DIRECTION_IN, ~USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00000007
TransferBuffer = b22b3be4
TransferBufferMDL = 00000000
UrbLink = 00000000
RequestTypeReservedBits = 00000000
Request = 00000021
Value = 00000000
Index = 00000000
[951800 ms] UsbSnoop - MyInternalIOCTLCompletion(b1e71126) : fido=00000000, Irp=822d49b8, Context=81f46560, IRQL=2
[951800 ms] <<< URB 2926 coming back <<<
-- URB_FUNCTION_CONTROL_TRANSFER:
PipeHandle = 821d8138
TransferFlags = 0000000b (USBD_TRANSFER_DIRECTION_IN, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00000007
TransferBuffer = b22b3be4
TransferBufferMDL = 81ebaa48
00000000: 60 09 00 00 00 00 08
UrbLink = 00000000
SetupPacket =
00000000: a1 21 00 00 00 00 07 00
[951800 ms] UsbSnoop - FilterDispatchAny(b1e70fd2) : IRP_MJ_INTERNAL_DEVICE_CONTROL
[951800 ms] UsbSnoop - FdoHookDispatchInternalIoctl(b1e711ea) : fdo=81d3de18, Irp=822d49b8, IRQL=0
[951800 ms] >>> URB 2927 going down >>>
-- URB_FUNCTION_CLASS_INTERFACE:
TransferFlags = 00000000 (USBD_TRANSFER_DIRECTION_OUT, ~USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00000007
TransferBuffer = b22b3be0
TransferBufferMDL = 00000000
00000000: 60 09 00 00 00 00 08
UrbLink = 00000000
RequestTypeReservedBits = 00000000
Request = 00000020
Value = 00000000
Index = 00000000
[951805 ms] UsbSnoop - MyInternalIOCTLCompletion(b1e71126) : fido=00000000, Irp=822d49b8, Context=81f46560, IRQL=2
[951805 ms] <<< URB 2927 coming back <<<
-- URB_FUNCTION_CONTROL_TRANSFER:
PipeHandle = 821d8138
TransferFlags = 0000000a (USBD_TRANSFER_DIRECTION_OUT, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00000007
TransferBuffer = b22b3be0
TransferBufferMDL = 81ebaa48
UrbLink = 00000000
SetupPacket =
00000000: 21 20 00 00 00 00 07 00
[951805 ms] UsbSnoop - FilterDispatchAny(b1e70fd2) : IRP_MJ_INTERNAL_DEVICE_CONTROL
[951805 ms] UsbSnoop - FdoHookDispatchInternalIoctl(b1e711ea) : fdo=81d3de18, Irp=822d49b8, IRQL=0
[951805 ms] >>> URB 2928 going down >>>
-- URB_FUNCTION_CLASS_INTERFACE:
TransferFlags = 00000001 (USBD_TRANSFER_DIRECTION_IN, ~USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00000007
TransferBuffer = b22b3bbc
TransferBufferMDL = 00000000
UrbLink = 00000000
RequestTypeReservedBits = 00000000
Request = 00000021
Value = 00000000
Index = 00000000
[951810 ms] UsbSnoop - MyInternalIOCTLCompletion(b1e71126) : fido=00000000, Irp=822d49b8, Context=81f46560, IRQL=2
[951810 ms] <<< URB 2928 coming back <<<
-- URB_FUNCTION_CONTROL_TRANSFER:
PipeHandle = 821d8138
TransferFlags = 0000000b (USBD_TRANSFER_DIRECTION_IN, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00000007
TransferBuffer = b22b3bbc
TransferBufferMDL = 81ebaa48
00000000: 60 09 00 00 00 00 08
UrbLink = 00000000
SetupPacket =
00000000: a1 21 00 00 00 00 07 00
[951810 ms] UsbSnoop - FilterDispatchAny(b1e70fd2) : IRP_MJ_INTERNAL_DEVICE_CONTROL
[951810 ms] UsbSnoop - FdoHookDispatchInternalIoctl(b1e711ea) : fdo=81d3de18, Irp=822d49b8, IRQL=0
[951810 ms] >>> URB 2929 going down >>>
-- URB_FUNCTION_CLASS_INTERFACE:
TransferFlags = 00000000 (USBD_TRANSFER_DIRECTION_OUT, ~USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00000000
TransferBuffer = 00000000
TransferBufferMDL = 00000000
no data supplied
UrbLink = 00000000
RequestTypeReservedBits = 00000000
Request = 00000022
Value = 00000003
Index = 00000000
[951814 ms] UsbSnoop - MyInternalIOCTLCompletion(b1e71126) : fido=00000000, Irp=822d49b8, Context=81f46560, IRQL=2
[951814 ms] <<< URB 2929 coming back <<<
-- URB_FUNCTION_CONTROL_TRANSFER:
PipeHandle = 821d8138
TransferFlags = 0000000a (USBD_TRANSFER_DIRECTION_OUT, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00000000
TransferBuffer = 00000000
TransferBufferMDL = 00000000
UrbLink = 00000000
SetupPacket =
00000000: 21 22 03 00 00 00 00 00
[951814 ms] UsbSnoop - FilterDispatchAny(b1e70fd2) : IRP_MJ_INTERNAL_DEVICE_CONTROL
[951814 ms] UsbSnoop - FdoHookDispatchInternalIoctl(b1e711ea) : fdo=81d3de18, Irp=822d49b8, IRQL=0
[951814 ms] >>> URB 2930 going down >>>
-- URB_FUNCTION_CLASS_INTERFACE:
TransferFlags = 00000000 (USBD_TRANSFER_DIRECTION_OUT, ~USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00000007
TransferBuffer = b22b3be0
TransferBufferMDL = 00000000
00000000: 60 09 00 00 00 00 08
UrbLink = 00000000
RequestTypeReservedBits = 00000000
Request = 00000020
Value = 00000000
Index = 00000000
[951819 ms] UsbSnoop - MyInternalIOCTLCompletion(b1e71126) : fido=00000000, Irp=822d49b8, Context=81f46560, IRQL=2
[951819 ms] <<< URB 2930 coming back <<<
-- URB_FUNCTION_CONTROL_TRANSFER:
PipeHandle = 821d8138
TransferFlags = 0000000a (USBD_TRANSFER_DIRECTION_OUT, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00000007
TransferBuffer = b22b3be0
TransferBufferMDL = 81ebaa48
UrbLink = 00000000
SetupPacket =
00000000: 21 20 00 00 00 00 07 00
[951819 ms] UsbSnoop - FilterDispatchAny(b1e70fd2) : IRP_MJ_INTERNAL_DEVICE_CONTROL
[951819 ms] UsbSnoop - FdoHookDispatchInternalIoctl(b1e711ea) : fdo=81d3de18, Irp=822d49b8, IRQL=0
[951819 ms] >>> URB 2931 going down >>>
-- URB_FUNCTION_CLASS_INTERFACE:
TransferFlags = 00000001 (USBD_TRANSFER_DIRECTION_IN, ~USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00000007
TransferBuffer = b22b3bbc
TransferBufferMDL = 00000000
UrbLink = 00000000
RequestTypeReservedBits = 00000000
Request = 00000021
Value = 00000000
Index = 00000000
[951824 ms] UsbSnoop - MyInternalIOCTLCompletion(b1e71126) : fido=00000000, Irp=822d49b8, Context=81f46560, IRQL=2
[951824 ms] <<< URB 2931 coming back <<<
-- URB_FUNCTION_CONTROL_TRANSFER:
PipeHandle = 821d8138
TransferFlags = 0000000b (USBD_TRANSFER_DIRECTION_IN, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00000007
TransferBuffer = b22b3bbc
TransferBufferMDL = 81ebaa48
00000000: 60 09 00 00 00 00 08
UrbLink = 00000000
SetupPacket =
00000000: a1 21 00 00 00 00 07 00
[951919 ms] UsbSnoop - MyInternalIOCTLCompletion(b1e71126) : fido=00000000, Irp=81d0fc10, Context=81d3e480, IRQL=2
[951919 ms] <<< URB 2922 coming back <<<
-- URB_FUNCTION_BULK_OR_INTERRUPT_TRANSFER:
PipeHandle = 81e0e4ac [endpoint 0x00000083]
TransferFlags = 00000003 (USBD_TRANSFER_DIRECTION_IN, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00000001
TransferBuffer = 81fa8004
TransferBufferMDL = 81d43588
00000000: 4e
UrbLink = 00000000
[951919 ms] UsbSnoop - FilterDispatchAny(b1e70fd2) : IRP_MJ_INTERNAL_DEVICE_CONTROL
[951919 ms] UsbSnoop - FdoHookDispatchInternalIoctl(b1e711ea) : fdo=81d3de18, Irp=81d0fc10, IRQL=2
[951919 ms] >>> URB 2932 going down >>>
-- URB_FUNCTION_BULK_OR_INTERRUPT_TRANSFER:
PipeHandle = 81e0e4ac [endpoint 0x00000083]
TransferFlags = 00000003 (USBD_TRANSFER_DIRECTION_IN, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00001000
TransferBuffer = 81fa8004
TransferBufferMDL = 00000000
UrbLink = 00000000
[952247 ms] UsbSnoop - MyInternalIOCTLCompletion(b1e71126) : fido=00000000, Irp=81d0fc10, Context=81d3e480, IRQL=2
[952247 ms] <<< URB 2932 coming back <<<
-- URB_FUNCTION_BULK_OR_INTERRUPT_TRANSFER:
PipeHandle = 81e0e4ac [endpoint 0x00000083]
TransferFlags = 00000003 (USBD_TRANSFER_DIRECTION_IN, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00000001
TransferBuffer = 81fa8004
TransferBufferMDL = 81d43588
00000000: 4e
UrbLink = 00000000
[952247 ms] UsbSnoop - FilterDispatchAny(b1e70fd2) : IRP_MJ_INTERNAL_DEVICE_CONTROL
[952247 ms] UsbSnoop - FdoHookDispatchInternalIoctl(b1e711ea) : fdo=81d3de18, Irp=81d0fc10, IRQL=2
[952247 ms] >>> URB 2933 going down >>>
-- URB_FUNCTION_BULK_OR_INTERRUPT_TRANSFER:
PipeHandle = 81e0e4ac [endpoint 0x00000083]
TransferFlags = 00000003 (USBD_TRANSFER_DIRECTION_IN, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00001000
TransferBuffer = 81fa8004
TransferBufferMDL = 00000000
UrbLink = 00000000
[952576 ms] UsbSnoop - MyInternalIOCTLCompletion(b1e71126) : fido=00000000, Irp=81d0fc10, Context=81d3e480, IRQL=2
[952576 ms] <<< URB 2933 coming back <<<
-- URB_FUNCTION_BULK_OR_INTERRUPT_TRANSFER:
PipeHandle = 81e0e4ac [endpoint 0x00000083]
TransferFlags = 00000003 (USBD_TRANSFER_DIRECTION_IN, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00000001
TransferBuffer = 81fa8004
TransferBufferMDL = 81d43588
00000000: 4e
UrbLink = 00000000
[952576 ms] UsbSnoop - FilterDispatchAny(b1e70fd2) : IRP_MJ_INTERNAL_DEVICE_CONTROL
[952576 ms] UsbSnoop - FdoHookDispatchInternalIoctl(b1e711ea) : fdo=81d3de18, Irp=81d0fc10, IRQL=2
[952576 ms] >>> URB 2934 going down >>>
-- URB_FUNCTION_BULK_OR_INTERRUPT_TRANSFER:
PipeHandle = 81e0e4ac [endpoint 0x00000083]
TransferFlags = 00000003 (USBD_TRANSFER_DIRECTION_IN, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00001000
TransferBuffer = 81fa8004
TransferBufferMDL = 00000000
UrbLink = 00000000
[952904 ms] UsbSnoop - MyInternalIOCTLCompletion(b1e71126) : fido=00000000, Irp=81d0fc10, Context=81d3e480, IRQL=2
[952904 ms] <<< URB 2934 coming back <<<
-- URB_FUNCTION_BULK_OR_INTERRUPT_TRANSFER:
PipeHandle = 81e0e4ac [endpoint 0x00000083]
TransferFlags = 00000003 (USBD_TRANSFER_DIRECTION_IN, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00000001
TransferBuffer = 81fa8004
TransferBufferMDL = 81d43588
00000000: 4e
UrbLink = 00000000
[952904 ms] UsbSnoop - FilterDispatchAny(b1e70fd2) : IRP_MJ_INTERNAL_DEVICE_CONTROL
[952904 ms] UsbSnoop - FdoHookDispatchInternalIoctl(b1e711ea) : fdo=81d3de18, Irp=81d0fc10, IRQL=2
[952904 ms] >>> URB 2935 going down >>>
-- URB_FUNCTION_BULK_OR_INTERRUPT_TRANSFER:
PipeHandle = 81e0e4ac [endpoint 0x00000083]
TransferFlags = 00000003 (USBD_TRANSFER_DIRECTION_IN, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00001000
TransferBuffer = 81fa8004
TransferBufferMDL = 00000000
UrbLink = 00000000
[953232 ms] UsbSnoop - MyInternalIOCTLCompletion(b1e71126) : fido=00000000, Irp=81d0fc10, Context=81d3e480, IRQL=2
[953232 ms] <<< URB 2935 coming back <<<
-- URB_FUNCTION_BULK_OR_INTERRUPT_TRANSFER:
PipeHandle = 81e0e4ac [endpoint 0x00000083]
TransferFlags = 00000003 (USBD_TRANSFER_DIRECTION_IN, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00000001
TransferBuffer = 81fa8004
TransferBufferMDL = 81d43588
00000000: 4e
UrbLink = 00000000
[953232 ms] UsbSnoop - FilterDispatchAny(b1e70fd2) : IRP_MJ_INTERNAL_DEVICE_CONTROL
[953232 ms] UsbSnoop - FdoHookDispatchInternalIoctl(b1e711ea) : fdo=81d3de18, Irp=81d0fc10, IRQL=2
[953232 ms] >>> URB 2936 going down >>>
-- URB_FUNCTION_BULK_OR_INTERRUPT_TRANSFER:
PipeHandle = 81e0e4ac [endpoint 0x00000083]
TransferFlags = 00000003 (USBD_TRANSFER_DIRECTION_IN, USBD_SHORT_TRANSFER_OK)
TransferBufferLength = 00001000
TransferBuffer = 81fa8004
TransferBufferMDL = 00000000
UrbLink = 00000000
