Mailing Lists: Apple Mailing Lists

Image of Mac OS face in stamp
 
[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index]

Re: Could a PCI card cause a USB reset?



Just got the USB logger working - this is what happens when the camera gets initialised (at level 3):

133.727 [3] AppleUSBOHCI[0x2369000] RootHub Status Change Interrupt on bus 9
133.728 [3] AppleUSBHubPort [0x242df00]::DefaultEnableChangeHandler: port 1 disabled. Device driver should reset itself port
133.728 [3] AppleUSBOHCI[0x2369000] RootHub Status Change Interrupt on bus 9
133.746 [3] IOUSBHIDDriver[0x2498900]::InterruptReadHandler kIOReturnNotResponding error
133.746 [3] IOUSBHIDDriver[0x2498900]::InterruptReadHandler Checking to see if HID device is still connected
133.747 [3] IOUSBHIDDriver[0x27fbd00]::InterruptReadHandler kIOReturnNotResponding error
133.747 [3] IOUSBHIDDriver[0x27fbd00]::InterruptReadHandler Checking to see if HID device is still connected
133.749 [3] IOUSBHIDDriver[0x2498a00]::InterruptReadHandler kIOReturnNotResponding error
133.749 [3] IOUSBHIDDriver[0x2498a00]::InterruptReadHandler Checking to see if HID device is still connected
133.751 [3] AppleUSBOHCI[0x2369000]:ControlPacketHandler error 0xe00002ed occured on endpoint (0). todo = 0x60 (Clearing stall)
133.751 [2] AppleUSBOHCI[0x2369000]::ControlPacketHandler, returning status of e00002ed
133.752 [3] AppleUSBHub[0x2418000]::GetPortStatus, error (e00002ed) returned from DoDeviceRequest
133.752 [3] AppleUSBOHCI[0x2369000]:ControlPacketHandler error 0xe00002ed occured on endpoint (0). todo = 0x60 (Clearing stall)
133.752 [2] AppleUSBOHCI[0x2369000]::ControlPacketHandler, returning status of e00002ed
133.753 [3] AppleUSBHub[0x2418000]::GetPortStatus, error (e00002ed) returned from DoDeviceRequest
133.754 [3] AppleUSBOHCI[0x2369000]:ControlPacketHandler error 0xe00002ed occured on endpoint (0). todo = 0x60 (Clearing stall)
133.754 [2] AppleUSBOHCI[0x2369000]::ControlPacketHandler, returning status of e00002ed
133.754 [3] AppleUSBHub[0x2418000]::GetPortStatus, error (e00002ed) returned from DoDeviceRequest
133.770 [3] IOUSBHIDDriver[0x2498900]::InterruptReadHandler kIOReturnNotResponding error
133.771 [3] IOUSBHIDDriver[0x27fbd00]::InterruptReadHandler kIOReturnNotResponding error
133.773 [3] IOUSBHIDDriver[0x2498a00]::InterruptReadHandler kIOReturnNotResponding error
133.793 [3] AppleUSBHub[0x2418000]::InterruptReadHandler error kIOReturnNotResponding
133.793 [3] AppleUSBHub[0x2418000]::InterruptReadHandler Checking to see if hub is still connected
133.797 [3] AppleUSBHub[0x2418000]::CheckForDeadHub - Still connected. Resetting port
133.797 [3] AppleUSBHub[0x2418000]::willTerminate isInactive = 0
133.799 [3] AppleUSBHubPort[0x2496f00]::willTerminate
133.799 [3] AppleUSBHubPort[0x2496300]::willTerminate
133.799 [3] AppleUSBHubPort[0x2496100]::willTerminate
133.799 [3] AppleUSBHubPort[0x2496f00]::RemoveDevice start (Kensington USB/PS2 Wheel Mouse)
133.800 [3] AppleUSBHubPort[0x2496300]::RemoveDevice start (Keyspan USA-28X)
133.800 [3] AppleUSBHubPort[0x2496100]::RemoveDevice start (Apple Extended USB Keyboard)
133.806 [3] Hub in Apple Extended USB Keyboard[0x247da00] calling messageClients (kIOUSBMessageHubResetPort)
133.806 [3] IOUSBHIDDriver[0x27fbd00]::willTerminate isInactive = 1
133.808 [3] IOUSBHIDDriver[0x27fbd00]::didTerminate isInactive = 1, outstandingIO = 0
133.810 [3] IOUSBInterface[0x2807800]::close returns
133.811 [3] IOUSBHIDDriver[0x2498a00]::willTerminate isInactive = 1
133.813 [3] IOUSBHIDDriver[0x2498900]::willTerminate isInactive = 1
133.815 [3] IOUSBHIDDriver[0x2498900]::didTerminate isInactive = 1, outstandingIO = 0
133.817 [3] IOUSBInterface[0x24ef400]::close returns
133.817 [3] IOUSBHIDDriver[0x2498a00]::didTerminate isInactive = 1, outstandingIO = 0
133.820 [3] IOUSBInterface[0x2502300]::close returns
133.907 [3] AppleUSBOHCI[0x2369000] RootHub Status Change Interrupt on bus 9
133.907 [3] AppleUSBOHCI[0x2369000] RootHub Status Change Interrupt on bus 9
133.913 [3] IOUSBDeviceUserClient[0x2a93600]::DeviceReqIn err: 0xe0004061
133.913 [3] IOUSBDeviceUserClient[0x2a93600]::DeviceReqIn - returning err e0004061
133.913 [3] IOUSBDeviceUserClient[0x2a93600]::DeviceReqIn err: 0xe0004061
133.913 [3] IOUSBDeviceUserClient[0x2a93600]::DeviceReqIn - returning err e0004061
133.973 [3] Hub in Apple Extended USB Keyboard[0x247da00] calling messageClients (kIOUSBMessagePortHasBeenReset (1))
133.973 [3] AppleUSBHub[0x2418000] Received kIOUSBMessagePortHasBeenReset -- reconfiguring hub
133.975 [3] IOUSBInterface[0x2807200]::close returns
133.981 [3] AppleUSBHub[0x2418000]::ConfigureHub Setting kUSBFeatureDeviceRemoteWakeup for Hub device (0x247da00)
133.983 [3] +IOUSBInterface[0x2a93300]::handleOpen (device Hub in Apple Extended USB Keyboard)
133.983 [3] AppleUSBOHCI[0x2369000]: UIMCreateInterruptEndpoint endpoint does NOT exist
133.983 [3] -IOUSBInterface[0x2a93300]::handleOpen (device Hub in Apple Extended USB Keyboard): successful
133.983 [3] -IOUSBInterface[0x2a93300]::open returns 1
133.983 [3] AppleUSBHub[0x2418000] Hub attached - Bus powered
133.983 [1] [0x2418000] (Reset) USB Generic Hub @ 2 (0x9100000)
133.983 [3] -AppleUSBHub[0x2418000] Received kIOUSBMessagePortHasBeenReset -- finishded reconfiguring hub
134.171 [2] AppleUSBOHCI[0x2369000]::CreateDevice - releasing pend on address 3
134.228 [3] +IOUSBInterface[0x2478000]::handleOpen (device Apple Extended USB Keyboard)
134.228 [3] AppleUSBOHCI[0x2369000]: UIMCreateInterruptEndpoint endpoint does NOT exist
134.228 [3] -IOUSBInterface[0x2478000]::handleOpen (device Apple Extended USB Keyboard): successful
134.228 [3] -IOUSBInterface[0x2478000]::open returns 1
134.264 [3] AppleUSBOHCI[0x2369000]:ControlPacketHandler error 0xe000404f occured on endpoint (0). todo = 0x0 (Clearing stall)
134.265 [2] AppleUSBOHCI[0x2369000]::ControlPacketHandler, returning status of e000404f
134.265 [3] IOUSBHIDDriver[0x2a93600]:::SetProtocol returned error 0xe000404f
134.265 [1] [0x2a93600]::start - USB HID Interface #0 of device Apple Extended USB Keyboard @ 3 (0x9130000)
134.290 [3] +IOUSBInterface[0x2807700]::handleOpen (device Apple Extended USB Keyboard)
134.290 [3] AppleUSBOHCI[0x2369000]: UIMCreateInterruptEndpoint endpoint does NOT exist
134.290 [3] -IOUSBInterface[0x2807700]::handleOpen (device Apple Extended USB Keyboard): successful
134.290 [3] -IOUSBInterface[0x2807700]::open returns 1
134.299 [3] IOUSBInterface[0x2478000]::close returns
134.318 [2] AppleUSBOHCI[0x2369000]::CreateDevice - releasing pend on address 4
134.326 [1] [0x24ef700]::start - USB HID Interface #1 of device Apple Extended USB Keyboard @ 3 (0x9130000)
134.326 [3] IOUSBCompositeDriver[0x223ce80] Setting kUSBFeatureDeviceRemoteWakeup for device: Apple Extended USB Keyboard
134.354 [3] IOUSBCompositeDriver[0x223ce80]::start USB Generic Composite @ 3
134.365 [3] IOUSBInterface[0x2807700]::close returns
134.448 [3] IOUSBInterface[0x2807700]::close returns
134.463 [3] IOUSBInterface[0x2478000]::close returns
134.491 [3] AppleUSBOHCI[0x2369000]:ControlPacketHandler error 0xe00002ed occured on endpoint (0). todo = 0x60 (Clearing stall)
134.491 [2] AppleUSBOHCI[0x2369000]::ControlPacketHandler, returning status of e00002ed
134.495 [1] IOUSBVendorSpecificDevice[0x27fbf00]: Error (0xe00002ed) getting device config descriptor
134.495 [3] AppleUSBOHCI[0x2369000]:ControlPacketHandler error 0xe00002ed occured on endpoint (0). todo = 0x60 (Clearing stall)
134.496 [2] AppleUSBOHCI[0x2369000]::ControlPacketHandler, returning status of e00002ed
134.498 [1] IOUSBVendorSpecificDevice[0x27fbf00]: Error (0xe00002ed) getting device config descriptor
134.498 [1] IOUSBVendorSpecificDevice [0x27fbf00]::GetFullConfigurationDescriptor - Error (e00002ed) getting first 9 bytes of config descriptor
134.498 [3] IOUSBDeviceUserClient[0x2807d00]::GetConfigDescriptor - returning err e00002f0
134.599 [3] AppleUSBHubPort[0x2a93200]::RemoveDevice start (IOUSBVendorSpecificDevice)
134.690 [2] AppleUSBOHCI[0x2369000]::CreateDevice - releasing pend on address 4
134.746 [3] +IOUSBInterface[0x2a93100]::handleOpen (device Kensington USB/PS2 Wheel Mouse)
134.746 [3] AppleUSBOHCI[0x2369000]: UIMCreateInterruptEndpoint endpoint does NOT exist
134.746 [3] -IOUSBInterface[0x2a93100]::handleOpen (device Kensington USB/PS2 Wheel Mouse): successful
134.746 [3] -IOUSBInterface[0x2a93100]::open returns 1
134.777 [1] [0x2503e00]::start - USB HID Interface #0 of device Kensington USB/PS2 Wheel Mouse @ 4 (0x9110000)
134.777 [3] IOUSBCompositeDriver[0x222e300] Setting kUSBFeatureDeviceRemoteWakeup for device: Kensington USB/PS2 Wheel Mouse
134.777 [3] IOUSBCompositeDriver[0x222e300]::start USB Generic Composite @ 4
134.784 [3] IOUSBInterface[0x2a93100]::close returns
134.901 [3] IOUSBInterface[0x2a93100]::close returns
135.237 [2] AppleUSBOHCI[0x2369000]::CreateDevice - releasing pend on address 5
135.294 [3] +IOUSBInterface[0x2807d00]::handleOpen (device Keyspan USA-28X)
135.294 [3] AppleUSBOHCI[0x2369000]: UIMCreateInterruptEndpoint endpoint does NOT exist
135.295 [3] AppleUSBOHCI[0x2369000]: UIMCreateInterruptEndpoint endpoint does NOT exist
135.295 [3] AppleUSBOHCI[0x2369000]: UIMCreateInterruptEndpoint endpoint does NOT exist
135.295 [3] AppleUSBOHCI[0x2369000]: UIMCreateInterruptEndpoint endpoint does NOT exist
135.295 [3] AppleUSBOHCI[0x2369000]: UIMCreateInterruptEndpoint endpoint does NOT exist
135.295 [3] -IOUSBInterface[0x2807d00]::handleOpen (device Keyspan USA-28X): successful
135.295 [3] -IOUSBInterface[0x2807d00]::open returns 1
135.323 [3] IOUSBInterface[0x2807d00]::close returns
135.517 [3] IOUSBInterface[0x2807d00]::close returns


Any idea what could cause this series of events?

Cheers,

Steve.

On 26 Sep 2005, at 21:37, Steve Baxter wrote:

Hi David,

This only occurs on a G4/500, my G5 works fine in this configuration. The G4/500 fails in both 10.3.9 and 10.4.0. system.log includes these messages:

Sep 22 03:34:32 localhost kernel:
RoperTucsonPCI::=========================>Timeout Occurred!!!!!
Sep 22 03:34:32 localhost kernel:
RoperTucsonPCI::=========================>Timeout Occurred!!!!!
Sep 22 03:34:32 localhost kernel: USBF:	180.827	[0x1b7ba00] (Reset)
USB Generic Hub @ 2 (0x9100000)

This suggests to me that the camera card (made by Roper) is timing out, a USB reset then occurs almost immediately afterwards.

The odd thing is that the PCI card works fine with a different (much slower) camera. I'm wondering whether the developers of the Roper PCI driver are doing something odd to try and recover from this timeout they've logged, which is in turn affecting the USB host controller.

Anyway, thanks for your comments - I've passed this to the card manufacturer now (though the solution for the customer may be just to buy a G5)!

Cheers,

Steve.

On 26 Sep 2005, at 20:58, David Ferguson wrote:

You will need some good tools to get to the bottom of this type of problem. Could an errant PCI device affect annother PCI device? -- sure. Is that happening here? -- the only way to know will be with a PCI bus analyzer.

First, you may want to install logging versions of the IOUSBFamily -- use the logging tab of USB Prober to look at the USB log -- Also, check both the system and console logs for messages from the relevant drivers.

I would contact the necessary vendors and see if they can provide versions of their drivers to help you debug/analyze this problem.

What is the host you are using? Does this problem occur with all machines, or just some configurations?

David Ferguson
Apple Computer

At 8:13 PM +0100 9/26/05, Steve Baxter wrote:
Hi,

We have a strange problem where initialising a PCI-based scientific digital camera is causing writes to a USB serial adapter (Keyspan) to hang our software. We are slightly stuck in the middle of this (not having access to the driver source code of either the PCI card or USB device), but my suspicion is that the PCI driver is causing a USB reset, which is in turn getting the Keyspan adapter into a strange state behind the back of the Keyspan driver.

Does anyone know if a PCI device driver could cause a USB device to stop working in this way? I guess that the USB controller is a device on the PCI bus, but is there any way in which a PCI driver could affect devices other than the ones they are supposed to be controlling?

Cheers,

Steve.

Stephen Baxter
Software Development Manager
Improvision
email@hidden
+44-2476-692229


_______________________________________________ Do not post admin requests to the list. They will be ignored. Usb mailing list (email@hidden) Help/Unsubscribe/Update your Subscription: http://lists.apple.com/mailman/options/usb/email@hidden

This email sent to email@hidden

_______________________________________________ Do not post admin requests to the list. They will be ignored. Usb mailing list (email@hidden) Help/Unsubscribe/Update your Subscription: http://lists.apple.com/mailman/options/usb/email@hidden

This email sent to email@hidden

Stephen Baxter Software Development Manager Improvision email@hidden +44-2476-692229


_______________________________________________ Do not post admin requests to the list. They will be ignored. Usb mailing list (email@hidden) Help/Unsubscribe/Update your Subscription: http://lists.apple.com/mailman/options/usb/email@hidden

This email sent to email@hidden

Stephen Baxter Software Development Manager Improvision email@hidden +44-2476-692229


_______________________________________________ Do not post admin requests to the list. They will be ignored. Usb mailing list (email@hidden) Help/Unsubscribe/Update your Subscription: http://lists.apple.com/mailman/options/usb/email@hidden

This email sent to email@hidden
References: 
 >Could a PCI card cause a USB reset? (From: Steve Baxter <email@hidden>)
 >Re: Could a PCI card cause a USB reset? (From: David Ferguson <email@hidden>)
 >Re: Could a PCI card cause a USB reset? (From: Steve Baxter <email@hidden>)



Visit the Apple Store online or at retail locations.
1-800-MY-APPLE

Contact Apple | Terms of Use | Privacy Policy

Copyright © 2007 Apple Inc. All rights reserved.