Re: usb2 and usb3 ports drop samples while recording from airspy to /dev/null

2014-12-18 Thread Udo van den Heuvel
On 2014-12-18 17:10, Alan Stern wrote:
> On Thu, 18 Dec 2014, Udo van den Heuvel wrote:
>> In fact the airspy samples at 20 MSPS with 2 bytes per sample, but the
>> host converts that to the I/Q pairs at 10 MSPS, with 2 bytes for each I
>> and Q. (I was explained in #airspy)
> 
> I don't know what "#airspy" is.

An IRC channel at freenode.

> If the airspy sends 20 million samples per second to the host and each
> sample is 2 bytes, then the host would have to receive 40 MB/s of data
> from the airspy.  As I mentioned before, the usbmon trace showed that 
> the actual transfer rate was about 24 MB/s.

That is weird or an issue or what?

> 40 MB/s is a little beyond the limit of what most EHCI host controllers
> are able to handle, although an xHCI host controller ought to be able
> to do it.

The device is usb2.


I will try other ports and also recording to a plain harddisk. (not raid
or encrypted)

Udo
--
To unsubscribe from this list: send the line "unsubscribe linux-usb" in
the body of a message to majord...@vger.kernel.org
More majordomo info at  http://vger.kernel.org/majordomo-info.html


Re: usb2 and usb3 ports drop samples while recording from airspy to /dev/null

2014-12-18 Thread Udo van den Heuvel
On 2014-12-18 16:23, Alan Stern wrote:
>>> The bug report says there should be 10 M samples per second.  How many
>>> bytes are in a sample?  2?
>>
>> I and Q samples are two bytes each.
> 
> What is an I sample?  What is a Q sample?  

I and Q samples describe the radio signal received by the airspy.

> Are there any samples that 
> aren't two bytes?

No that I am aware.

> You need to keep in mind that the people reading this mailing list know
> a lot about USB but don't know anything about Airspy devices.

In fact the airspy samples at 20 MSPS with 2 bytes per sample, but the
host converts that to the I/Q pairs at 10 MSPS, with 2 bytes for each I
and Q. (I was explained in #airspy)

Udo


--
To unsubscribe from this list: send the line "unsubscribe linux-usb" in
the body of a message to majord...@vger.kernel.org
More majordomo info at  http://vger.kernel.org/majordomo-info.html


Re: usb2 and usb3 ports drop samples while recording from airspy to /dev/null

2014-12-17 Thread Udo van den Heuvel
On 2014-12-17 18:25, Alan Stern wrote:
>> Please let me know what info I should add to help find the root cause.
> 
> What are we supposed to see?  The lsusb output in the bug report lists 
> a bunch of devices, but it's not clear which one is the airspy.

Perhaps bus 4, device 10?


Udo
--
To unsubscribe from this list: send the line "unsubscribe linux-usb" in
the body of a message to majord...@vger.kernel.org
More majordomo info at  http://vger.kernel.org/majordomo-info.html


Re: usb2 and usb3 ports drop samples while recording from airspy to /dev/null

2014-12-17 Thread Udo van den Heuvel
On 2014-12-17 18:25, Alan Stern wrote:
> On Sat, 13 Dec 2014, Udo van den Heuvel wrote:
> What are we supposed to see?  The lsusb output in the bug report lists 
> a bunch of devices, but it's not clear which one is the airspy.

I did not program the tools. But the other devices are keyboard, webcam
and some USB erupters.


> The bug report says there should be 10 M samples per second.  How many
> bytes are in a sample?  2?

I and Q samples are two bytes each.

> Now, maybe the transfer isn't just raw data.  Protocol overhead would 
> reduce the total throughput.  But since I don't know what the protocol 
> is, all I can tell you is the raw data rate.

I'll ask some usbmon folks to comment.

Kind regards,
Udo

--
To unsubscribe from this list: send the line "unsubscribe linux-usb" in
the body of a message to majord...@vger.kernel.org
More majordomo info at  http://vger.kernel.org/majordomo-info.html


usb2 and usb3 ports drop samples while recording from airspy to /dev/null

2014-12-13 Thread Udo van den Heuvel
Hello,

I noticed an usb related issue when recording from my airspy device;
so I created a bug in the bugzilla:
https://bugzilla.kernel.org/show_bug.cgi?id=89671

Please let me know what info I should add to help find the root cause.

Kind regards,
Udo
--
To unsubscribe from this list: send the line "unsubscribe linux-usb" in
the body of a message to majord...@vger.kernel.org
More majordomo info at  http://vger.kernel.org/majordomo-info.html


Re: 3.15.6 USB issue with pwc cam

2014-09-11 Thread Udo van den Heuvel
On 2014-08-14 15:23, Mathias Nyman wrote:
> The error:
> [53009.847233] xhci_hcd :02:00.0: ERROR: unexpected command completion 
> code 0x11.
> 
> Means we got a parameter error, one of the values the xhci driver sends to 
> the controller
> in the configure endpoint command is invalid.

Are my recent additions to
https://bugzilla.kernel.org/show_bug.cgi?id=70531 for kernel 3.16.2 related?

Kind regards,
Udo

--
To unsubscribe from this list: send the line "unsubscribe linux-usb" in
the body of a message to majord...@vger.kernel.org
More majordomo info at  http://vger.kernel.org/majordomo-info.html


Re: 3.15.6 USB issue with pwc cam

2014-08-12 Thread Udo van den Heuvel
On 2014-08-12 17:07, Hans de Goede wrote:
> for you. Might be fixed by this commit:
> https://git.kernel.org/cgit/linux/kernel/git/gregkh/usb.git/commit/drivers/usb/host?h=usb-next&id=3213b151387df0b95f4eada104f68eb1c1409cb3

That commit already appears to be in my kernel tree.

Kind regards,
Udo

--
To unsubscribe from this list: send the line "unsubscribe linux-usb" in
the body of a message to majord...@vger.kernel.org
More majordomo info at  http://vger.kernel.org/majordomo-info.html


Re: 3.15.6 USB issue with pwc cam

2014-08-12 Thread Udo van den Heuvel
On 2014-08-12 18:27, Hans Verkuil wrote:
> It was a bit confusing, but he has two problems: one pwc, one (the warning) 
> for
> uvc.

Indeed.
Do I need to provide additional info to help find the root cause(s)?

Kind regards,
Udo

--
To unsubscribe from this list: send the line "unsubscribe linux-usb" in
the body of a message to majord...@vger.kernel.org
More majordomo info at  http://vger.kernel.org/majordomo-info.html


Re: 3.15.6 USB issue with pwc cam

2014-08-12 Thread Udo van den Heuvel
On 2014-08-12 17:07, Hans de Goede wrote:
> lspci -nn

# lspci -nn
00:00.0 Host bridge [0600]: Advanced Micro Devices, Inc. [AMD] Family
15h (Models 10h-1fh) Processor Root Complex [1022:1410]
00:00.2 IOMMU [0806]: Advanced Micro Devices, Inc. [AMD] Family 15h
(Models 10h-1fh) I/O Memory Management Unit [1022:1419]
00:01.0 VGA compatible controller [0300]: Advanced Micro Devices, Inc.
[AMD/ATI] Trinity [Radeon HD 7660D] [1002:9901]
00:01.1 Audio device [0403]: Advanced Micro Devices, Inc. [AMD/ATI]
Trinity HDMI Audio Controller [1002:9902]
00:04.0 PCI bridge [0604]: Advanced Micro Devices, Inc. [AMD] Family 15h
(Models 10h-1fh) Processor Root Port [1022:1414]
00:07.0 PCI bridge [0604]: Advanced Micro Devices, Inc. [AMD] Family 15h
(Models 10h-1fh) Processor Root Port [1022:1417]
00:10.0 USB controller [0c03]: Advanced Micro Devices, Inc. [AMD] FCH
USB XHCI Controller [1022:7812] (rev 03)
00:10.1 USB controller [0c03]: Advanced Micro Devices, Inc. [AMD] FCH
USB XHCI Controller [1022:7812] (rev 03)
00:11.0 SATA controller [0106]: Advanced Micro Devices, Inc. [AMD] FCH
SATA Controller [AHCI mode] [1022:7801] (rev 40)
00:12.0 USB controller [0c03]: Advanced Micro Devices, Inc. [AMD] FCH
USB OHCI Controller [1022:7807] (rev 11)
00:12.2 USB controller [0c03]: Advanced Micro Devices, Inc. [AMD] FCH
USB EHCI Controller [1022:7808] (rev 11)
00:13.0 USB controller [0c03]: Advanced Micro Devices, Inc. [AMD] FCH
USB OHCI Controller [1022:7807] (rev 11)
00:13.2 USB controller [0c03]: Advanced Micro Devices, Inc. [AMD] FCH
USB EHCI Controller [1022:7808] (rev 11)
00:14.0 SMBus [0c05]: Advanced Micro Devices, Inc. [AMD] FCH SMBus
Controller [1022:780b] (rev 14)
00:14.2 Audio device [0403]: Advanced Micro Devices, Inc. [AMD] FCH
Azalia Controller [1022:780d] (rev 01)
00:14.3 ISA bridge [0601]: Advanced Micro Devices, Inc. [AMD] FCH LPC
Bridge [1022:780e] (rev 11)
00:14.4 PCI bridge [0604]: Advanced Micro Devices, Inc. [AMD] FCH PCI
Bridge [1022:780f] (rev 40)
00:14.5 USB controller [0c03]: Advanced Micro Devices, Inc. [AMD] FCH
USB OHCI Controller [1022:7809] (rev 11)
00:18.0 Host bridge [0600]: Advanced Micro Devices, Inc. [AMD] Family
15h (Models 10h-1fh) Processor Function 0 [1022:1400]
00:18.1 Host bridge [0600]: Advanced Micro Devices, Inc. [AMD] Family
15h (Models 10h-1fh) Processor Function 1 [1022:1401]
00:18.2 Host bridge [0600]: Advanced Micro Devices, Inc. [AMD] Family
15h (Models 10h-1fh) Processor Function 2 [1022:1402]
00:18.3 Host bridge [0600]: Advanced Micro Devices, Inc. [AMD] Family
15h (Models 10h-1fh) Processor Function 3 [1022:1403]
00:18.4 Host bridge [0600]: Advanced Micro Devices, Inc. [AMD] Family
15h (Models 10h-1fh) Processor Function 4 [1022:1404]
00:18.5 Host bridge [0600]: Advanced Micro Devices, Inc. [AMD] Family
15h (Models 10h-1fh) Processor Function 5 [1022:1405]
01:00.0 Ethernet controller [0200]: Realtek Semiconductor Co., Ltd.
RTL8111/8168/8411 PCI Express Gigabit Ethernet Controller [10ec:8168]
(rev 06)
02:00.0 USB controller [0c03]: Etron Technology, Inc. EJ168 USB 3.0 Host
Controller [1b6f:7023] (rev 01)
03:06.0 Serial controller [0700]: MosChip Semiconductor Technology Ltd.
PCI 9835 Multi-I/O Controller [9710:9835] (rev 01)


I'll try to see if I can make the commit work.

Udo
--
To unsubscribe from this list: send the line "unsubscribe linux-usb" in
the body of a message to majord...@vger.kernel.org
More majordomo info at  http://vger.kernel.org/majordomo-info.html


Re: 3.15.8 USB issue with uvc cam

2014-08-08 Thread Udo van den Heuvel
On 2014-08-08 13:24, Udo van den Heuvel wrote:
> unexpected command
> completion code 0x11

Is bug https://bugzilla.kernel.org/show_bug.cgi?id=70531 relevant here?

Kind regards,
Udo
--
To unsubscribe from this list: send the line "unsubscribe linux-usb" in
the body of a message to majord...@vger.kernel.org
More majordomo info at  http://vger.kernel.org/majordomo-info.html


Re: 3.15.8 USB issue with uvc cam

2014-08-08 Thread Udo van den Heuvel
Hello,

The Logitech C615 works OK if moved away from a USB3 port into a
non-USB3 port.
So it appears a USB3 issue.
Is 'xhci_hcd :02:00.0: ERROR: unexpected command
completion code 0x11' a possible root cause?

My board has:

# lspci
00:00.0 Host bridge: Advanced Micro Devices, Inc. [AMD] Family 15h
(Models 10h-1fh) Processor Root Complex
00:00.2 IOMMU: Advanced Micro Devices, Inc. [AMD] Family 15h (Models
10h-1fh) I/O Memory Management Unit
00:01.0 VGA compatible controller: Advanced Micro Devices, Inc.
[AMD/ATI] Trinity [Radeon HD 7660D]
00:01.1 Audio device: Advanced Micro Devices, Inc. [AMD/ATI] Trinity
HDMI Audio Controller
00:04.0 PCI bridge: Advanced Micro Devices, Inc. [AMD] Family 15h
(Models 10h-1fh) Processor Root Port
00:07.0 PCI bridge: Advanced Micro Devices, Inc. [AMD] Family 15h
(Models 10h-1fh) Processor Root Port
00:10.0 USB controller: Advanced Micro Devices, Inc. [AMD] FCH USB XHCI
Controller (rev 03)
00:10.1 USB controller: Advanced Micro Devices, Inc. [AMD] FCH USB XHCI
Controller (rev 03)
00:11.0 SATA controller: Advanced Micro Devices, Inc. [AMD] FCH SATA
Controller [AHCI mode] (rev 40)
00:12.0 USB controller: Advanced Micro Devices, Inc. [AMD] FCH USB OHCI
Controller (rev 11)
00:12.2 USB controller: Advanced Micro Devices, Inc. [AMD] FCH USB EHCI
Controller (rev 11)
00:13.0 USB controller: Advanced Micro Devices, Inc. [AMD] FCH USB OHCI
Controller (rev 11)
00:13.2 USB controller: Advanced Micro Devices, Inc. [AMD] FCH USB EHCI
Controller (rev 11)
00:14.0 SMBus: Advanced Micro Devices, Inc. [AMD] FCH SMBus Controller
(rev 14)
00:14.2 Audio device: Advanced Micro Devices, Inc. [AMD] FCH Azalia
Controller (rev 01)
00:14.3 ISA bridge: Advanced Micro Devices, Inc. [AMD] FCH LPC Bridge
(rev 11)
00:14.4 PCI bridge: Advanced Micro Devices, Inc. [AMD] FCH PCI Bridge
(rev 40)
00:14.5 USB controller: Advanced Micro Devices, Inc. [AMD] FCH USB OHCI
Controller (rev 11)
00:18.0 Host bridge: Advanced Micro Devices, Inc. [AMD] Family 15h
(Models 10h-1fh) Processor Function 0
00:18.1 Host bridge: Advanced Micro Devices, Inc. [AMD] Family 15h
(Models 10h-1fh) Processor Function 1
00:18.2 Host bridge: Advanced Micro Devices, Inc. [AMD] Family 15h
(Models 10h-1fh) Processor Function 2
00:18.3 Host bridge: Advanced Micro Devices, Inc. [AMD] Family 15h
(Models 10h-1fh) Processor Function 3
00:18.4 Host bridge: Advanced Micro Devices, Inc. [AMD] Family 15h
(Models 10h-1fh) Processor Function 4
00:18.5 Host bridge: Advanced Micro Devices, Inc. [AMD] Family 15h
(Models 10h-1fh) Processor Function 5
01:00.0 Ethernet controller: Realtek Semiconductor Co., Ltd.
RTL8111/8168/8411 PCI Express Gigabit Ethernet Controller (rev 06)
02:00.0 USB controller: Etron Technology, Inc. EJ168 USB 3.0 Host
Controller (rev 01)
03:06.0 Serial controller: MosChip Semiconductor Technology Ltd. PCI
9835 Multi-I/O Controller (rev 01)


And the Etron EJ168 is the only USB3 provider here?
How can we fix this issue?

Kind regards,
Udo


On 2014-08-08 05:42, Udo van den Heuvel wrote:
> Hello,
> 
> I get WARNINGs when trying to use a Logitech C615 cam.
> See attachment for full dmesg of errors but excerpt below:
> 
> [80346.835015] xhci_hcd :02:00.0: ERROR: unexpected command
> completion code 0x11.
> [80346.835027] usb 6-2: Not enough bandwidth for altsetting 11
> [80346.835137] [ cut here ]
> [80346.835155] WARNING: CPU: 3 PID: 20594 at
> drivers/media/v4l2-core/videobuf2-core.c:2011
> __vb2_queue_cancel+0x102/0x170 [videobuf2_core]()
> [80346.835158] Modules linked in: uvcvideo cdc_acm bnep bluetooth fuse
> edac_core cpufreq_userspace ipt_REJECT nf_conntrack_netbios_ns
> nf_conntrack_broadcast iptable_filter ip6t_REJECT ipt_MASQUERADE
> xt_tcpudp nf_conntrack_ipv6 iptable_nat nf_defrag_ipv6 nf_conntrack_ipv4
> nf_defrag_ipv4 nf_nat_ipv4 nf_nat xt_conntrack nf_conntrack ip_tables
> ip6table_filter ip6_tables x_tables eeprom it87 hwmon_vid ext2
> snd_usb_audio snd_usbmidi_lib snd_hwdep snd_rawmidi ppdev pwc
> videobuf2_vmalloc videobuf2_memops kvm_amd kvm v4l2_common
> videobuf2_core snd_hda_codec_realtek snd_hda_codec_generic videodev
> snd_hda_intel snd_hda_controller cp210x snd_hda_codec usbserial snd_seq
> snd_seq_device microcode snd_pcm parport_serial parport_pc parport
> snd_timer k10temp snd evdev i2c_piix4 button acpi_cpufreq nfsd
> auth_rpcgss oid_registry
> [80346.835218]  nfs_acl lockd sunrpc binfmt_misc autofs4 hid_generic
> usbhid ohci_pci ehci_pci ehci_hcd ohci_hcd radeon sr_mod cdrom fbcon
> bitblit cfbfillrect softcursor cfbimgblt cfbcopyarea font i2c_algo_bit
> xhci_hcd backlight drm_kms_helper ttm drm fb fbdev
> [80346.835250] CPU: 3 PID: 20594 Comm: skype Tainted: GW
> 3.15.8 #6
> [80346.835254] Hardware name: Gigabyte Technology Co., Ltd. To be filled
> by O.E.M./F2A85X-UP4, BIOS F5a 04/30/2013
> [80346.835257]   79d580f4 814

Re: 3.15.6 USB issue with pwc cam

2014-08-07 Thread Udo van den Heuvel
On 2014-08-04 11:17, Laurent Pinchart wrote:
> (CC'ing Hans de Goede, the pwc maintainer, and the linux-media mailing list)
> 
> On Saturday 02 August 2014 15:10:01 Udo van den Heuvel wrote:
>> Hello,
>>
>> I moved a PWC webcam to a USB3 port, and this happened:

I get similar stuff when trying to use a Logitech C615 cam.
See attachment for full dmesg of errors but excerpt below:

[80346.835015] xhci_hcd :02:00.0: ERROR: unexpected command
completion code 0x11.
[80346.835027] usb 6-2: Not enough bandwidth for altsetting 11
[80346.835137] [ cut here ]
[80346.835155] WARNING: CPU: 3 PID: 20594 at
drivers/media/v4l2-core/videobuf2-core.c:2011
__vb2_queue_cancel+0x102/0x170 [videobuf2_core]()
[80346.835158] Modules linked in: uvcvideo cdc_acm bnep bluetooth fuse
edac_core cpufreq_userspace ipt_REJECT nf_conntrack_netbios_ns
nf_conntrack_broadcast iptable_filter ip6t_REJECT ipt_MASQUERADE
xt_tcpudp nf_conntrack_ipv6 iptable_nat nf_defrag_ipv6 nf_conntrack_ipv4
nf_defrag_ipv4 nf_nat_ipv4 nf_nat xt_conntrack nf_conntrack ip_tables
ip6table_filter ip6_tables x_tables eeprom it87 hwmon_vid ext2
snd_usb_audio snd_usbmidi_lib snd_hwdep snd_rawmidi ppdev pwc
videobuf2_vmalloc videobuf2_memops kvm_amd kvm v4l2_common
videobuf2_core snd_hda_codec_realtek snd_hda_codec_generic videodev
snd_hda_intel snd_hda_controller cp210x snd_hda_codec usbserial snd_seq
snd_seq_device microcode snd_pcm parport_serial parport_pc parport
snd_timer k10temp snd evdev i2c_piix4 button acpi_cpufreq nfsd
auth_rpcgss oid_registry
[80346.835218]  nfs_acl lockd sunrpc binfmt_misc autofs4 hid_generic
usbhid ohci_pci ehci_pci ehci_hcd ohci_hcd radeon sr_mod cdrom fbcon
bitblit cfbfillrect softcursor cfbimgblt cfbcopyarea font i2c_algo_bit
xhci_hcd backlight drm_kms_helper ttm drm fb fbdev
[80346.835250] CPU: 3 PID: 20594 Comm: skype Tainted: GW
3.15.8 #6
[80346.835254] Hardware name: Gigabyte Technology Co., Ltd. To be filled
by O.E.M./F2A85X-UP4, BIOS F5a 04/30/2013
[80346.835257]   79d580f4 814f2373

[80346.835262]  81069fe1  88040ec532e8

[80346.835267]  88040ec530d8 8803f0c46f00 a041d832
88040ec530d8
[80346.835272] Call Trace:
[80346.835283]  [] ? dump_stack+0x4a/0x75
[80346.835289]  [] ? warn_slowpath_common+0x81/0xb0
[80346.835299]  [] ? __vb2_queue_cancel+0x102/0x170
[videobuf2_core]
[80346.835307]  [] ? vb2_internal_streamoff+0x1d/0x50
[videobuf2_core]
[80346.835314]  [] ? uvc_queue_enable+0x75/0xb0 [uvcvideo]
[80346.835321]  [] ? uvc_video_enable+0x141/0x1a0
[uvcvideo]
[80346.835327]  [] ? uvc_v4l2_do_ioctl+0xd6f/0x1580
[uvcvideo]
[80346.835339]  [] ? video_usercopy+0x1f0/0x490 [videodev]
[80346.835345]  [] ?
uvc_v4l2_set_streamparm.isra.12+0x1c0/0x1c0 [uvcvideo]
[80346.835352]  [] ? preempt_count_add+0x3f/0x90
[80346.835356]  [] ? _raw_spin_lock+0xe/0x30
[80346.835360]  [] ? _raw_spin_unlock+0xd/0x30
[80346.835367]  [] ? __pte_alloc+0xce/0x170
[80346.835376]  [] ? v4l2_ioctl+0x11f/0x160 [videodev]
[80346.835386]  [] ? do_video_ioctl+0x246/0x1330
[videodev]
[80346.835392]  [] ? mmap_region+0x15a/0x5a0
[80346.835402]  [] ? v4l2_compat_ioctl32+0x82/0xb8
[videodev]
[80346.835408]  [] ? compat_SyS_ioctl+0x132/0x1120
[80346.835414]  [] ? vm_mmap_pgoff+0xe3/0x120
[80346.835421]  [] ? cstar_dispatch+0x7/0x1a
[80346.835424] ---[ end trace 44e3d272b6c91a71 ]---
[80346.835427] [ cut here ]


What is wrong here?

Kind regards,
Udo

[80346.835015] xhci_hcd :02:00.0: ERROR: unexpected command completion code 
0x11.
[80346.835027] usb 6-2: Not enough bandwidth for altsetting 11
[80346.835137] [ cut here ]
[80346.835155] WARNING: CPU: 3 PID: 20594 at 
drivers/media/v4l2-core/videobuf2-core.c:2011 __vb2_queue_cancel+0x102/0x170 
[videobuf2_core]()
[80346.835158] Modules linked in: uvcvideo cdc_acm bnep bluetooth fuse 
edac_core cpufreq_userspace ipt_REJECT nf_conntrack_netbios_ns 
nf_conntrack_broadcast iptable_filter ip6t_REJECT ipt_MASQUERADE xt_tcpudp 
nf_conntrack_ipv6 iptable_nat nf_defrag_ipv6 nf_conntrack_ipv4 nf_defrag_ipv4 
nf_nat_ipv4 nf_nat xt_conntrack nf_conntrack ip_tables ip6table_filter 
ip6_tables x_tables eeprom it87 hwmon_vid ext2 snd_usb_audio snd_usbmidi_lib 
snd_hwdep snd_rawmidi ppdev pwc videobuf2_vmalloc videobuf2_memops kvm_amd kvm 
v4l2_common videobuf2_core snd_hda_codec_realtek snd_hda_codec_generic videodev 
snd_hda_intel snd_hda_controller cp210x snd_hda_codec usbserial snd_seq 
snd_seq_device microcode snd_pcm parport_serial parport_pc parport snd_timer 
k10temp snd evdev i2c_piix4 button acpi_cpufreq nfsd auth_rpcgss oid_registry
[80346.835218]  nfs_acl lockd sunrpc binfmt_misc autofs4 hid_generic usbhid 
ohci_pci ehci_pci ehci_hcd ohci_hcd radeon sr_mod cdrom fbcon bitblit 
cfbfillrect softcursor cfbimgblt cfbcopyarea font i2c_algo_bit xhci_hcd 
backlight drm_kms_helper ttm drm fb fbdev

3.15.6 USB issue with pwc cam

2014-08-02 Thread Udo van den Heuvel
Hello,

I moved a PWC webcam to a USB3 port, and this happened:

[53008.911811] usb 5-2: new full-speed USB device number 2 using xhci_hcd
[53009.213504] usb 5-2: New USB device found, idVendor=0471, idProduct=0311
[53009.213514] usb 5-2: New USB device strings: Mfr=0, Product=0,
SerialNumber=1
[53009.213519] usb 5-2: SerialNumber: 0169A500
[53009.215547] pwc: Philips PCVC740K (ToUCam Pro)/PCVC840 (ToUCam II)
USB webcam detected.
[53009.846698] pwc: Registered as video0.
[53009.846814] input: PWC snapshot button as
/devices/pci:00/:00:07.0/:02:00.0/usb5/5-2/input/input7
[53009.847233] xhci_hcd :02:00.0: ERROR: unexpected command
completion code 0x11.
[53009.847242] usb 5-2: Not enough bandwidth for altsetting 1
[53009.847275] xhci_hcd :02:00.0: ERROR: unexpected command
completion code 0x11.
[53009.847285] usb 5-2: Not enough bandwidth for altsetting 2
[53009.847317] xhci_hcd :02:00.0: ERROR: unexpected command
completion code 0x11.
[53009.847323] usb 5-2: Not enough bandwidth for altsetting 3
[53009.847355] xhci_hcd :02:00.0: ERROR: unexpected command
completion code 0x11.
[53009.847360] usb 5-2: Not enough bandwidth for altsetting 4
[53010.004876] xhci_hcd :02:00.0: ERROR: unexpected command
completion code 0x11.
[53010.004890] usb 5-2: Not enough bandwidth for altsetting 1
[53010.004896] usb 5-2: 2:1: usb_set_interface failed (-22)
[53010.004960] xhci_hcd :02:00.0: ERROR: unexpected command
completion code 0x11.
[53010.004988] usb 5-2: Not enough bandwidth for altsetting 1
[53010.004992] usb 5-2: 2:1: usb_set_interface failed (-22)
[53010.005066] xhci_hcd :02:00.0: ERROR: unexpected command
completion code 0x11.
[53010.005075] usb 5-2: Not enough bandwidth for altsetting 1
[53010.005079] usb 5-2: 2:1: usb_set_interface failed (-22)
[53010.005530] xhci_hcd :02:00.0: ERROR: unexpected command
completion code 0x11.
[53010.005540] usb 5-2: Not enough bandwidth for altsetting 1
[53010.005544] usb 5-2: 2:1: usb_set_interface failed (-22)
[53010.006438] xhci_hcd :02:00.0: ERROR: unexpected command
completion code 0x11.
[53010.006446] usb 5-2: Not enough bandwidth for altsetting 1
[53010.006450] usb 5-2: 2:1: usb_set_interface failed (-22)
[53010.007453] xhci_hcd :02:00.0: ERROR: unexpected command
completion code 0x11.
[53010.007461] usb 5-2: Not enough bandwidth for altsetting 1
[53010.007465] usb 5-2: 2:1: usb_set_interface failed (-22)
[53010.007567] xhci_hcd :02:00.0: ERROR: unexpected command
completion code 0x11.
[53010.007574] usb 5-2: Not enough bandwidth for altsetting 1
[53010.007578] usb 5-2: 2:1: usb_set_interface failed (-22)
[53010.007681] xhci_hcd :02:00.0: ERROR: unexpected command
completion code 0x11.
[53010.007689] usb 5-2: Not enough bandwidth for altsetting 1
[53010.007695] usb 5-2: 2:1: usb_set_interface failed (-22)
[53010.008126] xhci_hcd :02:00.0: ERROR: unexpected command
completion code 0x11.
[53010.008135] usb 5-2: Not enough bandwidth for altsetting 1
[53010.008140] usb 5-2: 2:1: usb_set_interface failed (-22)
[53010.008798] xhci_hcd :02:00.0: ERROR: unexpected command
completion code 0x11.
[53010.008808] usb 5-2: Not enough bandwidth for altsetting 1
[53010.008812] usb 5-2: 2:1: usb_set_interface failed (-22)
[53010.009576] xhci_hcd :02:00.0: ERROR: unexpected command
completion code 0x11.
[53010.009583] usb 5-2: Not enough bandwidth for altsetting 1
[53010.009588] usb 5-2: 2:1: usb_set_interface failed (-22)
[53010.009680] xhci_hcd :02:00.0: ERROR: unexpected command
completion code 0x11.
[53010.009689] usb 5-2: Not enough bandwidth for altsetting 1
[53010.009697] usb 5-2: 2:1: usb_set_interface failed (-22)
[53010.009978] xhci_hcd :02:00.0: ERROR: unexpected command
completion code 0x11.
[53010.009986] usb 5-2: Not enough bandwidth for altsetting 1
[53010.009990] usb 5-2: 2:1: usb_set_interface failed (-22)
[53010.010705] xhci_hcd :02:00.0: ERROR: unexpected command
completion code 0x11.
[53010.010716] usb 5-2: Not enough bandwidth for altsetting 1
[53010.010725] usb 5-2: 2:1: usb_set_interface failed (-22)
[53010.011350] xhci_hcd :02:00.0: ERROR: unexpected command
completion code 0x11.
[53010.011360] usb 5-2: Not enough bandwidth for altsetting 1
[53010.011366] usb 5-2: 2:1: usb_set_interface failed (-22)
[53010.012643] xhci_hcd :02:00.0: ERROR: unexpected command
completion code 0x11.
[53010.012655] usb 5-2: Not enough bandwidth for altsetting 1
[53010.012660] usb 5-2: 2:1: usb_set_interface failed (-22)
[53010.012758] xhci_hcd :02:00.0: ERROR: unexpected command
completion code 0x11.
[53010.012766] usb 5-2: Not enough bandwidth for altsetting 1
[53010.012771] usb 5-2: 2:1: usb_set_interface failed (-22)
[53010.013017] xhci_hcd :02:00.0: ERROR: unexpected command
completion code 0x11.
[53010.013025] usb 5-2: Not enough bandwidth for altsetting 1
[53010.013031] usb 5-2: 2:1: usb_set_interface failed (-22)
[53010.013793] xhci_hcd :02:00.0: ERROR: unexpected command
co

Re: xhci_hcd debugging status, please?

2014-01-04 Thread Udo van den Heuvel
On 2013-12-17 22:08, Sarah Sharp wrote:
> A simple fix is to turn off CONFIG_USB_DEBUG.  That's what causes the
> xHCI dynamic debugging to be enabled by default.

3.12.6 with CONFIG_USB_DEBUG turned off fixes the xhci_hcd debugging.

Thanks,
Udo

--
To unsubscribe from this list: send the line "unsubscribe linux-usb" in
the body of a message to majord...@vger.kernel.org
More majordomo info at  http://vger.kernel.org/majordomo-info.html


Re: xhci_hcd debugging status, please?

2013-12-13 Thread Udo van den Heuvel
On 2013-12-10 16:03, Oliver Neukum wrote:
>> Thanks, but some of the messages look quite hardcoded.
>> Is there a patch to get rid of them?
> 
> More patches concerning dynamic debugging are in the queue for 3.14
> It looks like on your system it is by default switched on. You
> can switch it off at boot time in the kernel command line as documented
> in Documentation/dynamic-debug-howto.txt

Default debugging is a bit unusual.
Can we please change this so that my dmesg is left at peace by default?
(unless really needed...)

Kind regards,
Udo

--
To unsubscribe from this list: send the line "unsubscribe linux-usb" in
the body of a message to majord...@vger.kernel.org
More majordomo info at  http://vger.kernel.org/majordomo-info.html


Re: xhci_hcd debugging status, please?

2013-12-09 Thread Udo van den Heuvel
On 2013-12-09 08:53, Oliver Neukum wrote:
> You have XHCI debugging on. This is most likely a side effect
> of teh switch to dynamic debugging in 3.12. But this should be
> discussed on linux-usb.

Thanks, but some of the messages look quite hardcoded.
Is there a patch to get rid of them?


Kind regards,
Udo

--
To unsubscribe from this list: send the line "unsubscribe linux-usb" in
the body of a message to majord...@vger.kernel.org
More majordomo info at  http://vger.kernel.org/majordomo-info.html


Re: 3.4.4: disabling irq

2013-08-29 Thread Udo van den Heuvel
On 2013-08-28 21:37, Alan Stern wrote:
>>> No, if you unload the ohci-hcd driver then the webcam won't be used.  
>>> Are you certain that merely stopping the daemon program will prevent 
>>> the problem?
>>
>> Quite certain but retesting can confirm that.
> 
> Maybe without activity, the OHCI controller goes into suspend.  You can 
> prevent it by doing:
> 
>   echo on >/sys/bus/pci/devices/:00:13.1/usb?/power/control

/sys/bus/pci/devices/:00:13.0 has a file irq containing 18.
subdirectory usb8 under there has no power/control subdir/file.
Is this a configuration issue or kernel version difference?

> By the way, since you switched to the new computer, are there any 
> devices attached to this USB bus other than the webcam?

The wired mouse (logitech M-BD58) is connected via usb.

> Also, at one point you had a second webcam attached to a different OHCI
> controller, as well as a Bluetooth device and a USB-serial device.  
> Are they still present?

Nope. Presently not connected.

I'll have some hubs this weekend to play with.

Udo

--
To unsubscribe from this list: send the line "unsubscribe linux-usb" in
the body of a message to majord...@vger.kernel.org
More majordomo info at  http://vger.kernel.org/majordomo-info.html


Re: 3.4.4: disabling irq

2013-08-28 Thread Udo van den Heuvel
On 2013-08-27 19:43, Alan Stern wrote:
>>>   rmmod ohci-pci
>>>   modprobe dummy-irq irq=18
>>>
>>> and see if the IRQ line gets disabled after that.
>>
>> Can I actually use that irq/ports that way? (as with no usage the
>> problem does not occur)
> 
> No, if you unload the ohci-hcd driver then the webcam won't be used.  
> Are you certain that merely stopping the daemon program will prevent 
> the problem?

Quite certain but retesting can confirm that.

>> No ohci_pci, is that a problem?
> 
> Sorry, for 3.10 it should be ohci_hcd.  In 3.11 it changed to ohci_pci.

3.10.9 is the latest here.

> Have you tried getting a USB-2 hub and plugging the webcam into it?  
> That will make a good test: You'll be able to use the webcam without 
> it affecting the ohci-hcd driver.

Not yet but I'll have hubs to test with soon.

> As a second test, you can try plugging everything _except_ the webcam 
> into the hub.

To see if the webcam itself is a factor. I see.

>> FWIW: on these boards (same type, BIOS, etc) I also see the issue
>> described at http://marc.info/?l=linux-kernel&m=137749729105329&w=2.
>> Any correlation?
> 
> Not that I can see.

This afternoon I found a 3.8.10 kernel with the disabled irq 18 and some
^@^@^@ characters on teh console.
After I did:

service motion stop
rmmod pwc
echo :00:13.0 >/sys/bus/pci/drivers/ohci_hcd/unbind
echo :00:13.0 >/sys/bus/pci/drivers/ohci_hcd/bind
modprobe pwc
service motion start

the ^@^@^@ appeared to stop.
I'll try to watch /proc/interrupts to see if the ^@^@ correlate with
i8042 interrupts.

Kind regards,
Udo
--
To unsubscribe from this list: send the line "unsubscribe linux-usb" in
the body of a message to majord...@vger.kernel.org
More majordomo info at  http://vger.kernel.org/majordomo-info.html


Re: 3.4.4: disabling irq

2013-08-27 Thread Udo van den Heuvel
Hello Alan,

On 2013-08-23 21:33, Alan Stern wrote:
>> Well, I replaced the motherboard by one of the same type and same BIOS
>> version.
>> And the problem is still here.
>>
>>> kernel:[ 3013.199945] Disabling IRQ #18
>>
>> So what can we conclude?
>> Kernel bug?
>> Hardware bug?
>> Something else?
> 
> Any of the above.  On the new hardware, is it still true that 
> /proc/interrupts shows IRQ 18 being used by ohci_hcd:usb1, 2, 3, and 
> nothing else?

$ cat /proc/interrupts |grep 18:
 104556  35248  IR-IO-APIC-fasteoi   ohci_hcd:usb5, ohci_hcd:usb8,
ohci_hcd:usb9

> Suppose you don't use the webcam, or better yet, unplug it (so that it 
> can't possibly be used without your knowledge).  If you do, does the 
> IRQ still get disabled?

If I simply stop the `motion` daemon I did not see the errors in the past.
Replacing the pwc webcam did not help.

> By the way, you aren't still running a 3.4 kernel are you?  

We move up with the releases so yes we have 3.10 kernels.

> Assuming
> you are using 3.10 or later, here's something else you can do.  Turn on
> CONFIG_DUMMY_IRQ in the kernel config.  Then do
> 
>   rmmod ohci-pci
>   modprobe dummy-irq irq=18
> 
> and see if the IRQ line gets disabled after that.

Can I actually use that irq/ports that way? (as with no usage the
problem does not occur)
Also:

$ lsmod|grep pci
ehci_pci   12432  0
ehci_hcd   56916  1 ehci_pci

No ohci_pci, is that a problem?

FWIW: on these boards (same type, BIOS, etc) I also see the issue
described at http://marc.info/?l=linux-kernel&m=137749729105329&w=2.
Any correlation?

Kind regards,
Udo


--
To unsubscribe from this list: send the line "unsubscribe linux-usb" in
the body of a message to majord...@vger.kernel.org
More majordomo info at  http://vger.kernel.org/majordomo-info.html


Re: 3.4.4: disabling irq

2013-08-23 Thread Udo van den Heuvel
On 2013-01-26 19:48, Alan Stern wrote:
>> Please explain.
> 
> I can't.  I don't know what's going on with your systems.  But nobody 
> else seems to be experiencing this problem.

Well, I replaced the motherboard by one of the same type and same BIOS
version.
And the problem is still here.

> kernel:[ 3013.199945] Disabling IRQ #18

So what can we conclude?
Kernel bug?
Hardware bug?
Something else?

Kind regards,
Udo



--
To unsubscribe from this list: send the line "unsubscribe linux-usb" in
the body of a message to majord...@vger.kernel.org
More majordomo info at  http://vger.kernel.org/majordomo-info.html


Re: 3.8.4: ohci question

2013-03-28 Thread Udo van den Heuvel
On 2013-03-28 15:35, Alan Stern wrote:
>>> When my dmesg gives me a growing number of lines like the one below,
>>> what is going on?
>>>
>>>  ohci_hcd :00:12.0: urb 88023025c500 path 2 ep1in 6c16 cc 6
>>> --> status -71
>>>
>>> Please let me know!
> 
> -71 errors indicate a low-level problem on the USB bus.  Generally it
> means that the device isn't sending any packets.  Maybe the device's
> firmware has crashed or maybe it has been disconnected.

Could it be due to a defect in the mainboard?
Or the device connected to that port?

Kind regards,
Udo

--
To unsubscribe from this list: send the line "unsubscribe linux-usb" in
the body of a message to majord...@vger.kernel.org
More majordomo info at  http://vger.kernel.org/majordomo-info.html


Re: 3.4.4: disabling irq

2013-01-26 Thread Udo van den Heuvel
On 2013-01-26 15:56, Alan Stern wrote:
> That SF bit in the intrstatus register is the one causing the problem,
> I think.  It is not set in the intrenable register, so the controller
> shouldn't issue any IRQs.  But it does, nonetheless.  Turning off SF
> apparently doesn't help -- the controller turns it on again a
> millisecond later anyway.
> 
> So it looks like there's nothing we can do about this.  It's just bad 
> hardware.  Sorry.

So why was this problem introduced on my old hardware after running for
years without this issue?
This new hardware is just 2-3 months old or so should not have grown
extra 'features'.
Please explain.

Kind regards,
Udo
--
To unsubscribe from this list: send the line "unsubscribe linux-usb" in
the body of a message to majord...@vger.kernel.org
More majordomo info at  http://vger.kernel.org/majordomo-info.html


Re: 3.4.4: disabling irq

2013-01-26 Thread Udo van den Heuvel
On 2013-01-25 19:06, Alan Stern wrote:
> On Fri, 25 Jan 2013, Alan Stern wrote:
> 
>> This isn't a software problem.  I don't know of any way to fix it or
>> work around it in the driver.  The only thing to do is stop using that
>> controller.
> 
> Spoke too soon.  Try this patch; maybe it will help.  (You'll have to 
> remove the debugging patch first.)

Did so.
Reloaded the ohci module, problem did not go away.
In the dmesg below you can see messages of reloading ohci modules, the
issue, then some pwc frame errors and then the restarting of the stuff.

[236793.480518] ohci_hcd :00:12.0: GetStatus roothub.portstatus [1]
= 0x00010301 CSC LSDA PPS CCS
[236793.480527] hub 1-0:1.0: port 2, status 0301, change 0001, 1.5 Mb/s
[236793.608085] hub 1-0:1.0: debounce: port 2: total 100ms stable 100ms
status 0x301
[236793.679770] ohci_hcd :00:12.0: GetStatus roothub.portstatus [1]
= 0x00100303 PRSC LSDA PPS PES CCS
[236793.735595] usb 1-2: new low-speed USB device number 2 using ohci_hcd
[236793.807504] ohci_hcd :00:12.0: GetStatus roothub.portstatus [1]
= 0x00100303 PRSC LSDA PPS PES CCS
[236793.891176] usb 1-2: skipped 1 descriptor after interface
[236793.893035] usb 1-2: default language 0x0409
[236793.899048] usb 1-2: udev 2, busnum 1, minor = 1
[236793.899058] usb 1-2: New USB device found, idVendor=046d, idProduct=c00c
[236793.899064] usb 1-2: New USB device strings: Mfr=1, Product=2,
SerialNumber=0
[236793.899069] usb 1-2: Product: USB Mouse
[236793.899073] usb 1-2: Manufacturer: Logitech
[236793.902798] usb 1-2: usb_probe_device
[236793.902806] usb 1-2: configuration #1 chosen from 1 choice
[236793.904007] usb 1-2: adding 1-2:1.0 (config #1, interface 0)
[236793.906553] usbhid 1-2:1.0: usb_probe_interface
[236793.906558] usbhid 1-2:1.0: usb_probe_interface - got id
[236793.922957] input: Logitech USB Mouse as
/devices/pci:00/:00:12.0/usb1/1-2/1-2:1.0/input/input8
[236793.930894] hid-generic 0003:046D:C00C.0002: input: USB HID v1.10
Mouse [Logitech USB Mouse] on usb-:00:12.0-2/input0
[236793.930946] hub 5-0:1.0: state 7 ports 2 chg  evt 
[236793.930953] hub 2-0:1.0: state 7 ports 5 chg  evt 0010
[236793.930966] ohci_hcd :00:13.0: GetStatus roothub.portstatus [3]
= 0x00010101 CSC PPS CCS
[236793.930975] hub 2-0:1.0: port 4, status 0101, change 0001, 12 Mb/s
[236794.058797] hub 2-0:1.0: debounce: port 4: total 100ms stable 100ms
status 0x101
[236794.130186] ohci_hcd :00:13.0: GetStatus roothub.portstatus [3]
= 0x00100103 PRSC PPS PES CCS
[236794.186027] usb 2-4: new full-speed USB device number 2 using ohci_hcd
[236794.257768] ohci_hcd :00:13.0: GetStatus roothub.portstatus [3]
= 0x00100103 PRSC PPS PES CCS
[236794.333430] usb 2-4: ep0 maxpacket = 8
[236794.432125] usb 2-4: skipped 4 descriptors after interface
[236794.432134] usb 2-4: skipped 2 descriptors after interface
[236794.432140] usb 2-4: skipped 1 descriptor after endpoint
[236794.432146] usb 2-4: skipped 2 descriptors after interface
[236794.432150] usb 2-4: skipped 1 descriptor after endpoint
[236794.432155] usb 2-4: skipped 2 descriptors after interface
[236794.432160] usb 2-4: skipped 1 descriptor after endpoint
[236794.432165] usb 2-4: skipped 2 descriptors after interface
[236794.432170] usb 2-4: skipped 1 descriptor after endpoint
[236794.435090] usb 2-4: default language 0x0409
[236794.457034] usb 2-4: udev 2, busnum 2, minor = 129
[236794.457045] usb 2-4: New USB device found, idVendor=0471, idProduct=0311
[236794.457050] usb 2-4: New USB device strings: Mfr=0, Product=0,
SerialNumber=1
[236794.457056] usb 2-4: SerialNumber: 0169A500
[236794.457314] usb 2-4: usb_probe_device
[236794.457321] usb 2-4: configuration #1 chosen from 1 choice
[236794.459031] usb 2-4: adding 2-4:1.0 (config #1, interface 0)
[236794.459723] Philips webcam 2-4:1.0: usb_probe_interface
[236794.459730] Philips webcam 2-4:1.0: usb_probe_interface - got id
[236794.459735] pwc: Philips PCVC740K (ToUCam Pro)/PCVC840 (ToUCam II)
USB webcam detected.
[236795.067186] pwc: Registered as video0.
[236795.067353] input: PWC snapshot button as
/devices/pci:00/:00:13.0/usb2/2-4/input/input9
[236795.067510] usb 2-4: adding 2-4:1.1 (config #1, interface 1)
[236795.067645] snd-usb-audio 2-4:1.1: usb_probe_interface
[236795.067656] snd-usb-audio 2-4:1.1: usb_probe_interface - got id
[236795.130472] usb 2-4: adding 2-4:1.2 (config #1, interface 2)
[236795.130732] hub 4-0:1.0: state 7 ports 5 chg  evt 0010
[236795.130747] ehci_hcd :00:13.2: GetStatus port:4 status 003002 0
 ACK POWER OWNER sig=se0 CSC
[236795.130758] hub 4-0:1.0: port 4, status 0100, change 0001, 12 Mb/s
[236795.258571] hub 4-0:1.0: debounce: port 4: total 100ms stable 100ms
status 0x100
[236795.258584] hub 1-0:1.0: state 7 ports 5 chg  evt 0004
[236795.258601] hub 2-0:1.0: state 7 ports 5 chg  evt 0010
[244306.358532] irq 18: nobody cared (try booting with the "irqpoll" option)
[244306.358536] Pid: 27585, comm: irq/18-ohci_hcd Not tainted 3.6

Re: 3.4.4: disabling irq

2013-01-25 Thread Udo van den Heuvel
On 2013-01-02 17:46, Alan Stern wrote:
> Or else leave those devices unplugged entirely -- use a network login 
> instead of the USB keyboard and mouse.

When the motion service is off, i.e. the USB webcam isnt used,  the
issue does not happen.

On the other hand:

If it is on, within a few days I see stuff like:

Jan 25 03:08:26 s kernel: [128427.542235] irq 18: nobody cared (try
booting with the "irqpoll" option)
Jan 25 03:08:26 s kernel: [128427.542239] Pid: 1279, comm:
irq/18-ohci_hcd Not tainted 3.6.11 #22
Jan 25 03:08:26 s kernel: [128427.542240] Call Trace:
Jan 25 03:08:26 s kernel: [128427.542246]  [] ?
__report_bad_irq+0x36/0xd0
Jan 25 03:08:26 s kernel: [128427.542248]  [] ?
note_interrupt+0x1c9/0x220
Jan 25 03:08:26 s kernel: [128427.542250]  [] ?
irq_thread_fn+0x40/0x40
Jan 25 03:08:26 s kernel: [128427.542252]  [] ?
irq_thread+0x145/0x180
Jan 25 03:08:26 s kernel: [128427.542255]  [] ?
__wake_up_common+0x4c/0x80
Jan 25 03:08:26 s kernel: [128427.542257]  [] ?
irq_finalize_oneshot+0x100/0x100
Jan 25 03:08:26 s kernel: [128427.542259]  [] ?
wake_threads_waitq+0x50/0x50
Jan 25 03:08:26 s kernel: [128427.542261]  [] ?
kthread+0x85/0x90
Jan 25 03:08:26 s kernel: [128427.542265]  [] ?
kernel_thread_helper+0x4/0x10
Jan 25 03:08:26 s kernel: [128427.542267]  [] ?
kthread_freezable_should_stop+0x50/0x50
Jan 25 03:08:26 s kernel: [128427.542275]  [] ?
gs_change+0xb/0xb
Jan 25 03:08:26 s kernel: [128427.542276] handlers:
Jan 25 03:08:26 s kernel: [128427.542278] []
irq_default_primary_handler threaded [] usb_hcd_irq
Jan 25 03:08:26 s kernel: [128427.542283] []
irq_default_primary_handler threaded [] usb_hcd_irq
Jan 25 03:08:26 s kernel: [128427.542286] []
irq_default_primary_handler threaded [] usb_hcd_irq
Jan 25 03:08:26 s kernel: [128427.542288] Disabling IRQ #18


[133970.593390] pwc: Iso frame 4 has error -18
[133970.593392] pwc: Iso frame 5 has error -18
[133970.593394] pwc: Iso frame 6 has error -18
[133970.593396] pwc: Iso frame 7 has error -114
[133970.593398] pwc: Iso frame 8 has error -18
[133970.593399] pwc: Iso frame 9 has error -18

And when I restart everything:

[133971.011352] usbcore: deregistering interface driver Philips webcam
[133971.056287] ohci_hcd :00:13.0: remove, state 1
[133971.056296] ohci_hcd :00:13.0: roothub graceful disconnect
[133971.056303] usb usb2: USB disconnect, device number 1
[133971.056307] usb 2-4: USB disconnect, device number 2
[133971.056310] usb 2-4: unregistering device
[133971.056314] usb 2-4: unregistering interface 2-4:1.0
[133971.056480] usb 2-4: unregistering interface 2-4:1.1
[133971.056951] usb 2-4: unregistering interface 2-4:1.2
[133971.057053] usb 2-4: usb_disable_device nuking all URBs
[133971.058693] usb usb2: unregistering device
[133971.058702] usb usb2: unregistering interface 2-0:1.0
[133971.058744] ohci_hcd :00:13.0: shutdown urb 8802342b7e00
ep1in-intr
[133971.060699] usb usb2: usb_disable_device nuking all URBs
[133971.061051] ohci_hcd :00:13.0: OHCI controller state
[133971.061059] ohci_hcd :00:13.0: OHCI 1.0, NO legacy support
registers, rh state running
[133971.061066] ohci_hcd :00:13.0: control 0x083 HCFS=operational CBSR=3
[133971.061071] ohci_hcd :00:13.0: cmdstatus 0x0 SOC=0
[133971.061077] ohci_hcd :00:13.0: intrstatus 0x0024 FNO SF
[133971.061082] ohci_hcd :00:13.0: intrenable 0x805a MIE RHSC UE
RD WDH
[133971.061088] ohci_hcd :00:13.0: ed_controlhead 4000
[133971.061095] ohci_hcd :00:13.0: hcca frame #86d9
[133971.061101] ohci_hcd :00:13.0: roothub.a 02001205 POTPGT=2 NOCP
NPS NDP=5(5)
[133971.061106] ohci_hcd :00:13.0: roothub.b  PPCM= DR=
[133971.06] ohci_hcd :00:13.0: roothub.status 8000 DRWE
[133971.061116] ohci_hcd :00:13.0: roothub.portstatus [0] 0x0100 PPS
[133971.061121] ohci_hcd :00:13.0: roothub.portstatus [1] 0x0100 PPS
[133971.061126] ohci_hcd :00:13.0: roothub.portstatus [2] 0x0100 PPS
[133971.061131] ohci_hcd :00:13.0: roothub.portstatus [3] 0x0103
PPS PES CCS
[133971.061136] ohci_hcd :00:13.0: roothub.portstatus [4] 0x0100 PPS
[133971.061188] ohci_hcd :00:13.0: USB bus 2 deregistered
[133971.061449] ohci_hcd :00:13.0: OHCI Host Controller
[133971.061459] ohci_hcd :00:13.0: new USB bus registered, assigned
bus number 2
[133971.061490] ohci_hcd :00:13.0: created debug files
[133971.061494] ohci_hcd :00:13.0: supports USB remote wakeup
[133971.061549] ohci_hcd :00:13.0: irq 18, io mem 0xfeb4e000
[133971.115480] hub 4-0:1.0: state 7 ports 5 chg  evt 0010
[133971.115500] ehci_hcd :00:13.2: GetStatus port:4 status 001803 0
 ACK POWER sig=j CSC CONNECT
[133971.115514] hub 4-0:1.0: port 4, status 0501, change 0001, 480 Mb/s
[133971.119435] ohci_hcd :00:13.0: OHCI controller state
[133971.119442] ohci_hcd :00:13.0: OHCI 1.0, NO legacy support
registers, rh state running
[133971.119449] ohci_hcd :00:13.0: control 0x083 HCFS=operational CBSR=3
[

Re: 3.4.4: disabling irq

2013-01-02 Thread Udo van den Heuvel
On 2013-01-02 17:46, Alan Stern wrote:
>> Can it be the webcam?
>> I can interchange it with another one of same type.
> 
> If it's a USB webcam then it can't created unwanted IRQs.  But you 
> certainly should try removing it to see if that makes any difference.  

Stopping the motion service helps in not generating activity from the
webcam. (motion uses the webcam to see if stuff happens in the camera's
view)

>> I'll see if I can find a hub.
> 
> Or else leave those devices unplugged entirely -- use a network login 
> instead of the USB keyboard and mouse.

Mouse is usb. Keyboard is PS/2.
This is my main workstation, will have to use the console.

Udo
--
To unsubscribe from this list: send the line "unsubscribe linux-usb" in
the body of a message to majord...@vger.kernel.org
More majordomo info at  http://vger.kernel.org/majordomo-info.html


Re: 3.4.4: disabling irq

2013-01-02 Thread Udo van den Heuvel
On 2013-01-02 16:55, Alan Stern wrote:
> I don't understand.  How can there be nothing more?  Above you showed
> an "irq 18: nobody cared" message that appeared at 8:51 on Jan 1.  It
> certainly ought to be in the dmesg log as of 9:00.

dmesg can only hold a certain amount of data.
The pwc errors take a lot of space per second.

> Also, I asked you to turn on CONFIG_PRINTK_TIME.  Without that, there's 
> no way for me to tell when those IRQ: messages appear in relation to 
> the "nobody cared".

I did not reboot yet but I'll see if I can add the PRINTK option.

> In the end, this comes down to two possibilities.  Either the OHCI 
> controller is malfunctioning 

Seen on two mainboards. This one is quite new.

> or else some other piece of 
> hardware/software is.  

Can it be the webcam?
I can interchange it with another one of same type.

> I suppose you could try unplugging all your low-speed and full-speed 
> devices from the OHCI controller.  (Get a high-speed hub and plug them 
> into it instead.)  Then the controller hardware should be totally 
> quiescent.  If the unwanted IRQs still occur then it seems likely that 
> the controller is not the cause -- although this isn't an airtight 
> proof.

I'll see if I can find a hub.

Udo

--
To unsubscribe from this list: send the line "unsubscribe linux-usb" in
the body of a message to majord...@vger.kernel.org
More majordomo info at  http://vger.kernel.org/majordomo-info.html


Re: 3.4.4: disabling irq

2013-01-01 Thread Udo van den Heuvel
On 2012-12-31 18:24, Alan Stern wrote:
> Can you provide the entire output?  Two lines isn't enough.

It just happened again. Messages in edited form:

Jan  1 07:23:46 bobo dbus[3106]: [system] Rejected send message, 2
matched rules; type="method_return", sender=":1.1" (uid=0 pid=3076
comm="/usr/lib/systemd/systemd-logind ") interface="(unset)"
member="(unset)" error name="(unset)" requested_reply="0"
destination=":1.34" (uid=500 pid=4183 comm="gnome-session ")
Jan  1 08:51:21 bobo kernel: irq 18: nobody cared (try booting with the
"irqpoll" option)
Jan  1 08:51:21 bobo kernel: Pid: 22652, comm: irq/18-ohci_hcd Not
tainted 3.6.11 #19
Jan  1 08:51:21 bobo kernel: Call Trace:
Jan  1 08:51:21 bobo kernel: [] ?
__report_bad_irq+0x36/0xd0
Jan  1 08:51:21 bobo kernel: [] ?
note_interrupt+0x1c9/0x220
Jan  1 08:51:21 bobo kernel: [] ? irq_thread_fn+0x40/0x40
Jan  1 08:51:21 bobo kernel: [] ? irq_thread+0x145/0x180
Jan  1 08:51:21 bobo kernel: [] ?
__wake_up_common+0x4c/0x80
Jan  1 08:51:21 bobo kernel: [] ?
irq_finalize_oneshot+0x100/0x100
Jan  1 08:51:21 bobo kernel: [] ?
wake_threads_waitq+0x50/0x50
Jan  1 08:51:21 bobo kernel: [] ? kthread+0x85/0x90
Jan  1 08:51:21 bobo kernel: [] ?
kernel_thread_helper+0x4/0x10
Jan  1 08:51:21 bobo kernel: [] ?
kthread_freezable_should_stop+0x50/0x50
Jan  1 08:51:21 bobo kernel: [] ? gs_change+0xb/0xb
Jan  1 08:51:21 bobo kernel: handlers:
Jan  1 08:51:21 bobo kernel: []
irq_default_primary_handler threaded [] usb_hcd_irq
Jan  1 08:51:21 bobo kernel: []
irq_default_primary_handler threaded [] usb_hcd_irq
Jan  1 08:51:21 bobo kernel: []
irq_default_primary_handler threaded [] usb_hcd_irq
Jan  1 08:51:21 bobo kernel: Disabling IRQ #18
Jan  1 08:51:22 bobo kernel: pwc: Iso frame 0 has error -18
Jan  1 08:51:22 bobo kernel: pwc: Iso frame 1 has error -18
Jan  1 08:51:22 bobo kernel: pwc: Iso frame 2 has error -18
Jan  1 08:51:22 bobo kernel: pwc: Iso frame 3 has error -18
Jan  1 08:51:22 bobo kernel: pwc: Iso frame 4 has error -114
Jan  1 08:51:22 bobo kernel: pwc: Iso frame 5 has error -18
Jan  1 08:51:22 bobo kernel: pwc: Iso frame 6 has error -18
Jan  1 08:51:22 bobo kernel: pwc: Iso frame 7 has error -18
Jan  1 08:51:22 bobo kernel: pwc: Iso frame 8 has error -18
Jan  1 08:51:22 bobo kernel: pwc: Iso frame 9 has error -18
Jan  1 08:51:22 bobo kernel: pwc: Iso frame 0 has error -18
Jan  1 08:51:22 bobo kernel: pwc: Iso frame 1 has error -18
Jan  1 08:51:22 bobo kernel: pwc: Iso frame 2 has error -18
Jan  1 08:51:22 bobo kernel: pwc: Iso frame 3 has error -18
Jan  1 08:51:22 bobo kernel: pwc: Iso frame 4 has error -18
Jan  1 08:51:22 bobo kernel: pwc: Iso frame 5 has error -18
Jan  1 08:51:22 bobo kernel: pwc: Iso frame 6 has error -114
Jan  1 08:51:22 bobo kernel: pwc: Iso frame 7 has error -18
Jan  1 08:51:22 bobo kernel: pwc: Iso frame 8 has error -18
Jan  1 08:51:22 bobo kernel: pwc: Iso frame 9 has error -18
()
Jan  1 08:51:33 bobo kernel: pwc: Iso frame 5 has error -18
Jan  1 08:51:33 bobo kernel: pwc: Iso frame 6 has error -18
Jan  1 08:51:33 bobo kernel: pwc: Iso frame 7 has error -18
Jan  1 08:51:33 bobo kernel: pwc: Iso frame 8 has error -18
Jan  1 08:51:33 bobo kernel: pwc: Iso frame 9 has error -18
Jan  1 08:51:34 bobo systemd[1]: motion.service: main process exited,
code=killed, status=9
Jan  1 08:51:34 bobo systemd[1]: Unit motion.service entered failed state.
Jan  1 08:51:34 bobo kernel: usbcore: deregistering interface driver
Philips webcam
Jan  1 08:51:34 bobo kernel: ohci_hcd :00:13.0: remove, state 1
Jan  1 08:51:34 bobo kernel: usb usb2: USB disconnect, device number 1
Jan  1 08:51:34 bobo kernel: usb 2-4: USB disconnect, device number 2
Jan  1 08:51:34 bobo kernel: ohci_hcd :00:13.0: USB bus 2 deregistered
Jan  1 08:51:34 bobo kernel: ohci_hcd :00:13.0: OHCI Host Controller
Jan  1 08:51:34 bobo kernel: ohci_hcd :00:13.0: new USB bus
registered, assigned bus number 2
Jan  1 08:51:34 bobo kernel: ohci_hcd :00:13.0: irq 18, io mem
0xfeb4e000
Jan  1 08:51:34 bobo kernel: usb usb2: New USB device found,
idVendor=1d6b, idProduct=0001
Jan  1 08:51:34 bobo kernel: usb usb2: New USB device strings: Mfr=3,
Product=2, SerialNumber=1
Jan  1 08:51:34 bobo kernel: usb usb2: Product: OHCI Host Controller
Jan  1 08:51:34 bobo kernel: usb usb2: Manufacturer: Linux 3.6.11 ohci_hcd
Jan  1 08:51:34 bobo kernel: usb usb2: SerialNumber: :00:13.0
Jan  1 08:51:34 bobo kernel: hub 2-0:1.0: USB hub found
Jan  1 08:51:34 bobo kernel: hub 2-0:1.0: 5 ports detected
Jan  1 08:51:34 bobo udevd[1580]: RUN+="socket:..." support will be
removed from a future udev release. Please remove it from:
/etc/udev/rules.d/90-hal.rules:2 and use libudev to subscribe to events.
Jan  1 08:51:34 bobo kernel: usbcore: registered new interface driver
Philips webcam
Jan  1 08:51:34 bobo motion: [0] [NTC] [ALL] conf_load: Processing
thread 0 - config file /etc/motion/motion.conf
Jan  1 08:51:34 bobo motion: [0] [NTC] [ALL] motion_startup: Motion
3.3.0 Started
Jan  1 08:51:34 bobo m

Re: 3.4.4: disabling irq

2012-12-31 Thread Udo van den Heuvel
Hello Alan,

On 2012-12-31 18:24, Alan Stern wrote:
>> The patch works OK for the first few times:
>>
>> ohci_hcd :00:13.0: last IRQ repeated 22 times
>> ohci_hcd :00:13.0: IRQ: 24 805a
> 
> Can you provide the entire output?  Two lines isn't enough.

It's just the normal bootup, then the two usb lines, and then nothing
more related until the irq problem occurs.
Then there's loads of pwc frame errors until I find out and correct the
situation a bit.

>> The irq issue still occurs. How can we fix this?
> Does the IRQ problem occur immediately after the last line from the 
> patch? 

Nope.
The lines are printed after bootup and then it can take hours.

Kind regards,
Udo
--
To unsubscribe from this list: send the line "unsubscribe linux-usb" in
the body of a message to majord...@vger.kernel.org
More majordomo info at  http://vger.kernel.org/majordomo-info.html


Re: 3.4.4: disabling irq

2012-12-01 Thread Udo van den Heuvel
On 2012-11-19 17:41, Alan Stern wrote:
> On Sat, 17 Nov 2012, Udo van den Heuvel wrote:
>> How to proceed next?
> 
> Firstly, what does /proc/interrupts say?
> 
> Secondly, try building a kernel with the patch below and 
> CONFIG_USB_DEBUG enabled.  Let's see what the dmesg log says when the 
> problem occurs.

Message from syslogd@a at Dec  1 09:46:01 ...
 kernel:Disabling IRQ #18
^C
[root@a mesa]# cat /sys/kernel/debug/usb/ohci/*/registers
bus pci, device :00:12.0
OHCI Host Controller
ohci_hcd
OHCI 1.0, NO legacy support registers, rh state running
control 0x08f HCFS=operational IE PLE CBSR=3
cmdstatus 0x0 SOC=0
intrstatus 0x0024 FNO SF
intrenable 0x805a MIE RHSC UE RD WDH
ed_controlhead 4000
hcca frame 0xa078
fmintvl 0xa7782edf FIT FSMPS=0xa778 FI=0x2edf
fmremaining 0x80001c56 FRT FR=0x1c56
periodicstart 0x2a2f
lsthresh 0x0628
hub poll timer off
roothub.a 02001205 POTPGT=2 NOCP NPS NDP=5(5)
roothub.b  PPCM= DR=
roothub.status 8000 DRWE
roothub.portstatus [0] 0x0100 PPS
roothub.portstatus [1] 0x0303 LSDA PPS PES CCS
roothub.portstatus [2] 0x0100 PPS
roothub.portstatus [3] 0x0100 PPS
roothub.portstatus [4] 0x0100 PPS
bus pci, device :00:13.0
OHCI Host Controller
ohci_hcd
OHCI 1.0, NO legacy support registers, rh state running
control 0x08f HCFS=operational IE PLE CBSR=3
cmdstatus 0x0 SOC=0
intrstatus 0x0026 FNO SF WDH
intrenable 0x805a MIE RHSC UE RD WDH
ed_controlhead 00092000
hcca frame 0xa2ab
fmintvl 0xa7782edf FIT FSMPS=0xa778 FI=0x2edf
fmremaining 0x8000184a FRT FR=0x184a
periodicstart 0x2a2f
lsthresh 0x0628
hub poll timer off
roothub.a 02001205 POTPGT=2 NOCP NPS NDP=5(5)
roothub.b  PPCM= DR=
roothub.status 8000 DRWE
roothub.portstatus [0] 0x0100 PPS
roothub.portstatus [1] 0x0100 PPS
roothub.portstatus [2] 0x0100 PPS
roothub.portstatus [3] 0x0103 PPS PES CCS
roothub.portstatus [4] 0x0100 PPS
bus pci, device :00:14.5
OHCI Host Controller
ohci_hcd
OHCI 1.0, NO legacy support registers, rh state running
control 0x083 HCFS=operational CBSR=3
cmdstatus 0x0 SOC=0
intrstatus 0x0024 FNO SF
intrenable 0x805a MIE RHSC UE RD WDH
hcca frame 0xa000
fmintvl 0xa7782edf FIT FSMPS=0xa778 FI=0x2edf
fmremaining 0x800014da FRT FR=0x14da
periodicstart 0x2a2f
lsthresh 0x0628
hub poll timer off
roothub.a 02001202 POTPGT=2 NOCP NPS NDP=2(2)
roothub.b  PPCM= DR=
roothub.status 8000 DRWE
roothub.portstatus [0] 0x0100 PPS
roothub.portstatus [1] 0x0100 PPS
[root@a mesa]# cat /sys/kernel/debug/usb/devices

T:  Bus=02 Lev=00 Prnt=00 Port=00 Cnt=00 Dev#=  1 Spd=12   MxCh= 5
B:  Alloc=757/900 us (84%), #Int=  0, #Iso=  3
D:  Ver= 1.10 Cls=09(hub  ) Sub=00 Prot=00 MxPS=64 #Cfgs=  1
P:  Vendor=1d6b ProdID=0001 Rev= 3.06
S:  Manufacturer=Linux 3.6.7 ohci_hcd
S:  Product=OHCI Host Controller
S:  SerialNumber=:00:13.0
C:* #Ifs= 1 Cfg#= 1 Atr=e0 MxPwr=  0mA
I:* If#= 0 Alt= 0 #EPs= 1 Cls=09(hub  ) Sub=00 Prot=00 Driver=hub
E:  Ad=81(I) Atr=03(Int.) MxPS=   2 Ivl=255ms

T:  Bus=02 Lev=01 Prnt=01 Port=03 Cnt=01 Dev#=  2 Spd=12   MxCh= 0
D:  Ver= 1.10 Cls=00(>ifc ) Sub=00 Prot=00 MxPS= 8 #Cfgs=  1
P:  Vendor=0471 ProdID=0311 Rev= 0.03
S:  SerialNumber=0169A500
C:* #Ifs= 3 Cfg#= 1 Atr=a0 MxPwr=500mA
I:  If#= 0 Alt= 0 #EPs= 2 Cls=ff(vend.) Sub=00 Prot=00 Driver=Philips webcam
E:  Ad=82(I) Atr=03(Int.) MxPS=   1 Ivl=32ms
E:  Ad=85(I) Atr=01(Isoc) MxPS=   0 Ivl=1ms
I:  If#= 0 Alt= 1 #EPs= 2 Cls=ff(vend.) Sub=00 Prot=00 Driver=Philips webcam
E:  Ad=82(I) Atr=03(Int.) MxPS=   1 Ivl=32ms
E:  Ad=85(I) Atr=01(Isoc) MxPS= 196 Ivl=1ms
I:  If#= 0 Alt= 2 #EPs= 2 Cls=ff(vend.) Sub=00 Prot=00 Driver=Philips webcam
E:  Ad=82(I) Atr=03(Int.) MxPS=   1 Ivl=32ms
E:  Ad=85(I) Atr=01(Isoc) MxPS= 292 Ivl=1ms
I:  If#= 0 Alt= 3 #EPs= 2 Cls=ff(vend.) Sub=00 Prot=00 Driver=Philips webcam
E:  Ad=82(I) Atr=03(Int.) MxPS=   1 Ivl=32ms
E:  Ad=85(I) Atr=01(Isoc) MxPS= 448 Ivl=1ms
I:  If#= 0 Alt= 4 #EPs= 2 Cls=ff(vend.) Sub=00 Prot=00 Driver=Philips webcam
E:  Ad=82(I) Atr=03(Int.) MxPS=   1 Ivl=32ms
E:  Ad=85(I) Atr=01(Isoc) MxPS= 592 Ivl=1ms
I:  If#= 0 Alt= 5 #EPs= 2 Cls=ff(vend.) Sub=00 Prot=00 Driver=Philips webcam
E:  Ad=82(I) Atr=03(Int.) MxPS=   1 Ivl=32ms
E:  Ad=85(I) Atr=01(Isoc) MxPS= 704 Ivl=1ms
I:  If#= 0 Alt= 6 #EPs= 2 Cls=ff(vend.) Sub=00 Prot=00 Driver=Philips webcam
E:  Ad=82(I) Atr=03(Int.) MxPS=   1 Ivl=32ms
E:  Ad=85(I) Atr=01(Isoc) MxPS= 776 Ivl=1ms
I:  If#= 0 Alt= 7 #EPs= 2 Cls=ff(vend.) Sub=00 Prot=00 Driver=Philips webcam
E:  Ad=82(I) Atr=03(Int.) MxPS=   1 Ivl=32ms
E:  Ad=85(I) Atr=01(Isoc) MxPS= 840 Ivl=1ms
I:  If#= 0 Alt= 8 #EPs= 2 Cls=ff(vend.) Sub=00 Prot=00 Driver=Philips webcam
E:  Ad=82(I) Atr=03(Int.) MxPS=   1 Ivl=32ms
E:  Ad=85(I) Atr=01(Isoc) MxPS= 896 Ivl=1ms
I:* If#= 0 Alt= 9 #EPs= 2 Cls=ff(vend.) Sub=00 Prot=00 Driver=Philips webcam
E:  Ad=82(I) Atr=03(Int.) MxPS=   1 Ivl=32ms
E:  Ad=85(I) Atr=01(Isoc) MxPS= 960 Ivl=1ms
I:  If#= 0 

Re: 3.4.4: disabling irq

2012-11-20 Thread Udo van den Heuvel
On 2012-11-19 17:41, Alan Stern wrote:
> Firstly, what does /proc/interrupts say?

# cat /proc/interrupts
   CPU0   CPU1   CPU2   CPU3
  0: 40  0  0  0   IO-APIC-edge  timer
  1:631640677734   IO-APIC-edge  i8042
  4:   1026976961   1098   IO-APIC-edge  serial
  9:  0  0  0  0   IO-APIC-fasteoi   acpi
 16:409403406414   IO-APIC-fasteoi
snd_hda_intel
 17:  1  1  0  2   IO-APIC-fasteoi
ehci_hcd:usb4, ehci_hcd:usb5
 18:  62356  62649  64102  67369   IO-APIC-fasteoi
ohci_hcd:usb1, ohci_hcd:usb2, ohci_hcd:usb3
 20:   5774   5762   5902   6405   IO-APIC-fasteoi   serial
 40:  0  0  0  0   PCI-MSI-edge  AMD-Vi
 43:  19483  19239  19938  20909   PCI-MSI-edge  ahci
 44:  51837  52223  53122  55971   PCI-MSI-edge  eth0
 45:  0  0  0  0   PCI-MSI-edge
xhci_hcd
 46:  0  0  0  0   PCI-MSI-edge
xhci_hcd
 47:  0  0  0  0   PCI-MSI-edge
xhci_hcd
 48:  0  0  0  0   PCI-MSI-edge
xhci_hcd
 49:  0  0  0  0   PCI-MSI-edge
xhci_hcd
 50:  0  0  0  0   PCI-MSI-edge
xhci_hcd
 51:  0  0  0  0   PCI-MSI-edge
xhci_hcd
 52:  0  0  0  0   PCI-MSI-edge
xhci_hcd
 53:  0  0  0  0   PCI-MSI-edge
xhci_hcd
 54:  0  0  0  0   PCI-MSI-edge
xhci_hcd
 55:  0  0  0  0   PCI-MSI-edge
xhci_hcd
 56: 26 24 42 31   PCI-MSI-edge
snd_hda_intel
 57:  28748  28431  29792  32594   PCI-MSI-edge  radeon
NMI:  0  0  0  0   Non-maskable interrupts
LOC: 271724 235396 273222 256476   Local timer interrupts
SPU:  0  0  0  0   Spurious interrupts
PMI:  0  0  0  0   Performance
monitoring interrupts
IWI:  0  0  0  0   IRQ work interrupts
RTR:  0  0  0  0   APIC ICR read retries
RES: 534762 574540 368898 508436   Rescheduling interrupts
CAL:  30439  42897  30212  31668   Function call interrupts
TLB:  0  0  0  0   TLB shootdowns
THR:  0  0  0  0   Threshold APIC interrupts
MCE:  0  0  0  0   Machine check exceptions
MCP:  4  4  4  4   Machine check polls
ERR:  8
MIS:  0

> Secondly, try building a kernel with the patch below and 
> CONFIG_USB_DEBUG enabled.  Let's see what the dmesg log says when the 
> problem occurs.

I just booted into 3.6.7 with the patch:

# dmesg|sort|uniq
ohci_hcd :00:12.0: IRQ: 24 805a
ohci_hcd :00:14.5: IRQ: 24 805a
#

So what does this mean?
I did not get the `disabling irq` yet.


Udo
--
To unsubscribe from this list: send the line "unsubscribe linux-usb" in
the body of a message to majord...@vger.kernel.org
More majordomo info at  http://vger.kernel.org/majordomo-info.html


Re: 3.4.4: disabling irq

2012-11-19 Thread Udo van den Heuvel
On 2012-11-19 17:41, Alan Stern wrote:
>> How to proceed next?
> 
> Firstly, what does /proc/interrupts say?

# cat /proc/interrupts
   CPU0   CPU1   CPU2   CPU3
  0: 39  0  0  0   IO-APIC-edge  timer
  1:716721730687   IO-APIC-edge  i8042
  4:   1631   1603   1713   1914   IO-APIC-edge  serial
  9:  0  0  0  0   IO-APIC-fasteoi   acpi
 16:427437443447   IO-APIC-fasteoi
snd_hda_intel
 17:  0  0  3  1   IO-APIC-fasteoi
ehci_hcd:usb4, ehci_hcd:usb5
 18: 100443 100710 103881 116011   IO-APIC-fasteoi
ohci_hcd:usb1, ohci_hcd:usb2, ohci_hcd:usb3
 20:   8049   8235   8456   9657   IO-APIC-fasteoi   serial
 40:  0  0  0  0   PCI-MSI-edge  AMD-Vi
 43:  47534  47847  49501  52187   PCI-MSI-edge  ahci
 44: 118811 119571 123111 134412   PCI-MSI-edge  eth0
 45:  0  0  0  0   PCI-MSI-edge
xhci_hcd
 46:  0  0  0  0   PCI-MSI-edge
xhci_hcd
 47:  0  0  0  0   PCI-MSI-edge
xhci_hcd
 48:  0  0  0  0   PCI-MSI-edge
xhci_hcd
 49:  0  0  0  0   PCI-MSI-edge
xhci_hcd
 50:  0  0  0  0   PCI-MSI-edge
xhci_hcd
 51:  0  0  0  0   PCI-MSI-edge
xhci_hcd
 52:  0  0  0  0   PCI-MSI-edge
xhci_hcd
 53:  0  0  0  0   PCI-MSI-edge
xhci_hcd
 54:  0  0  0  0   PCI-MSI-edge
xhci_hcd
 55:  0  0  0  0   PCI-MSI-edge
xhci_hcd
 56: 33 28 36 28   PCI-MSI-edge
snd_hda_intel
 57:  52846  53825  5  64450   PCI-MSI-edge  radeon
NMI:  0  0  0  0   Non-maskable interrupts
LOC: 381988 405614 348070 323872   Local timer interrupts
SPU:  0  0  0  0   Spurious interrupts
PMI:  0  0  0  0   Performance
monitoring interrupts
IWI:  0  0  0  0   IRQ work interrupts
RTR:  0  0  0  0   APIC ICR read retries
RES:1166893118478110890481016935   Rescheduling interrupts
CAL:  34472  32009  62610  50241   Function call interrupts
TLB:  0  0  0  0   TLB shootdowns
THR:  0  0  0  0   Threshold APIC interrupts
MCE:  0  0  0  0   Machine check exceptions
MCP:  8  8  8  8   Machine check polls
ERR:  4
MIS:  0

> Secondly, try building a kernel with the patch below and 
> CONFIG_USB_DEBUG enabled.  Let's see what the dmesg log says when the 
> problem occurs.

Will do!

Udo

--
To unsubscribe from this list: send the line "unsubscribe linux-usb" in
the body of a message to majord...@vger.kernel.org
More majordomo info at  http://vger.kernel.org/majordomo-info.html


Re: 3.4.4: disabling irq

2012-11-17 Thread Udo van den Heuvel
On 2012-07-15 20:28, Alan Stern wrote:
> Um, I think you missed the point.  The whole idea of the test is to see 
> what happens while the controller is unbound from the driver.  Binding 
> it again defeats the purpose.

The problem still happens. irq 18 is dsiabled every now and then.
This time on different, new hardware.
The motherboard is now a Gigabyte F2A85X-UP4.
Camera is the same pwc cam.

Recently I removed the USB printer that was attached to the same USB
controller.
So probably it is not a hardware issue related to board or printer.

How to proceed next?

Udo




PS: Info captured soon after one occurrence:

# cat /sys/kernel/debug/usb/ohci/*/registers
bus pci, device :00:12.0
OHCI Host Controller
ohci_hcd
OHCI 1.0, NO legacy support registers, rh state running
control 0x08f HCFS=operational IE PLE CBSR=3
cmdstatus 0x0 SOC=0
intrstatus 0x0024 FNO SF
intrenable 0x805a MIE RHSC UE RD WDH
ed_controlhead 4000
hcca frame 0x6ed9
fmintvl 0xa7782edf FIT FSMPS=0xa778 FI=0x2edf
fmremaining 0x85fa FRT FR=0x05fa
periodicstart 0x2a2f
lsthresh 0x0628
hub poll timer off
roothub.a 02001205 POTPGT=2 NOCP NPS NDP=5(5)
roothub.b  PPCM= DR=
roothub.status 8000 DRWE
roothub.portstatus [0] 0x0100 PPS
roothub.portstatus [1] 0x0303 LSDA PPS PES CCS
roothub.portstatus [2] 0x0100 PPS
roothub.portstatus [3] 0x0100 PPS
roothub.portstatus [4] 0x0100 PPS
bus pci, device :00:13.0
OHCI Host Controller
ohci_hcd
OHCI 1.0, NO legacy support registers, rh state running
control 0x08f HCFS=operational IE PLE CBSR=3
cmdstatus 0x0 SOC=0
intrstatus 0x0026 FNO SF WDH
intrenable 0x805a MIE RHSC UE RD WDH
ed_controlhead 4000
hcca frame 0x6e9d
fmintvl 0xa7782edf FIT FSMPS=0xa778 FI=0x2edf
fmremaining 0x80001fcf FRT FR=0x1fcf
periodicstart 0x2a2f
lsthresh 0x0628
hub poll timer off
roothub.a 02001205 POTPGT=2 NOCP NPS NDP=5(5)
roothub.b  PPCM= DR=
roothub.status 8000 DRWE
roothub.portstatus [0] 0x0100 PPS
roothub.portstatus [1] 0x0100 PPS
roothub.portstatus [2] 0x0100 PPS
roothub.portstatus [3] 0x0103 PPS PES CCS
roothub.portstatus [4] 0x0100 PPS
bus pci, device :00:14.5
OHCI Host Controller
ohci_hcd
OHCI 1.0, NO legacy support registers, rh state running
control 0x083 HCFS=operational CBSR=3
cmdstatus 0x0 SOC=0
intrstatus 0x0024 FNO SF
intrenable 0x805a MIE RHSC UE RD WDH
hcca frame 0x6e61
fmintvl 0xa7782edf FIT FSMPS=0xa778 FI=0x2edf
fmremaining 0x8cd8 FRT FR=0x0cd8
periodicstart 0x2a2f
lsthresh 0x0628
hub poll timer off
roothub.a 02001202 POTPGT=2 NOCP NPS NDP=2(2)
roothub.b  PPCM= DR=
roothub.status 8000 DRWE
roothub.portstatus [0] 0x0100 PPS
roothub.portstatus [1] 0x0100 PPS
# cat /sys/kernel/debug/usb/devices

T:  Bus=11 Lev=00 Prnt=00 Port=00 Cnt=00 Dev#=  1 Spd=5000 MxCh= 2
B:  Alloc=  0/800 us ( 0%), #Int=  0, #Iso=  0
D:  Ver= 3.00 Cls=09(hub  ) Sub=00 Prot=03 MxPS= 9 #Cfgs=  1
P:  Vendor=1d6b ProdID=0003 Rev= 3.06
S:  Manufacturer=Linux 3.6.6 xhci_hcd
S:  Product=xHCI Host Controller
S:  SerialNumber=:02:00.0
C:* #Ifs= 1 Cfg#= 1 Atr=e0 MxPwr=  0mA
I:* If#= 0 Alt= 0 #EPs= 1 Cls=09(hub  ) Sub=00 Prot=00 Driver=hub
E:  Ad=81(I) Atr=03(Int.) MxPS=   4 Ivl=256ms

T:  Bus=10 Lev=00 Prnt=00 Port=00 Cnt=00 Dev#=  1 Spd=480  MxCh= 2
B:  Alloc=  0/800 us ( 0%), #Int=  0, #Iso=  0
D:  Ver= 2.00 Cls=09(hub  ) Sub=00 Prot=01 MxPS=64 #Cfgs=  1
P:  Vendor=1d6b ProdID=0002 Rev= 3.06
S:  Manufacturer=Linux 3.6.6 xhci_hcd
S:  Product=xHCI Host Controller
S:  SerialNumber=:02:00.0
C:* #Ifs= 1 Cfg#= 1 Atr=e0 MxPwr=  0mA
I:* If#= 0 Alt= 0 #EPs= 1 Cls=09(hub  ) Sub=00 Prot=00 Driver=hub
E:  Ad=81(I) Atr=03(Int.) MxPS=   4 Ivl=256ms

T:  Bus=09 Lev=00 Prnt=00 Port=00 Cnt=00 Dev#=  1 Spd=5000 MxCh= 2
B:  Alloc=  0/800 us ( 0%), #Int=  0, #Iso=  0
D:  Ver= 3.00 Cls=09(hub  ) Sub=00 Prot=03 MxPS= 9 #Cfgs=  1
P:  Vendor=1d6b ProdID=0003 Rev= 3.06
S:  Manufacturer=Linux 3.6.6 xhci_hcd
S:  Product=xHCI Host Controller
S:  SerialNumber=:00:10.1
C:* #Ifs= 1 Cfg#= 1 Atr=e0 MxPwr=  0mA
I:* If#= 0 Alt= 0 #EPs= 1 Cls=09(hub  ) Sub=00 Prot=00 Driver=hub
E:  Ad=81(I) Atr=03(Int.) MxPS=   4 Ivl=256ms

T:  Bus=08 Lev=00 Prnt=00 Port=00 Cnt=00 Dev#=  1 Spd=480  MxCh= 2
B:  Alloc=  0/800 us ( 0%), #Int=  0, #Iso=  0
D:  Ver= 2.00 Cls=09(hub  ) Sub=00 Prot=01 MxPS=64 #Cfgs=  1
P:  Vendor=1d6b ProdID=0002 Rev= 3.06
S:  Manufacturer=Linux 3.6.6 xhci_hcd
S:  Product=xHCI Host Controller
S:  SerialNumber=:00:10.1
C:* #Ifs= 1 Cfg#= 1 Atr=e0 MxPwr=  0mA
I:* If#= 0 Alt= 0 #EPs= 1 Cls=09(hub  ) Sub=00 Prot=00 Driver=hub
E:  Ad=81(I) Atr=03(Int.) MxPS=   4 Ivl=256ms

T:  Bus=07 Lev=00 Prnt=00 Port=00 Cnt=00 Dev#=  1 Spd=5000 MxCh= 2
B:  Alloc=  0/800 us ( 0%), #Int=  0, #Iso=  0
D:  Ver= 3.00 Cls=09(hub  ) Sub=00 Prot=03 MxPS= 9 #Cfgs=  1
P:  Vendor=1d6b ProdID=0003 Rev= 3.06
S:  Manufacturer=Linux 3.6.6 xhci_hcd
S:  Product=xHCI Host Controller
S:  SerialNumber=:00:10.0
C:* #Ifs= 1 Cfg#= 1 At

Re: 3.4.4: disabling irq

2012-11-04 Thread Udo van den Heuvel
Well,

The issue appeared again.
irq 18 was disabled, one pwc webcam was on that irq.

This time on new hardware: Gigabyte F2A85X-UP4 with A10-5800K APU.
The box was busy with it's raid10 array, this time, by running bonnie++;
also a raid-check was in progress. (unknown at the time)

So what does this say? It appears not to be a hardware problem per se.

Anyone?

Kind regards,
Udo


--
To unsubscribe from this list: send the line "unsubscribe linux-usb" in
the body of a message to majord...@vger.kernel.org
More majordomo info at  http://vger.kernel.org/majordomo-info.html


Re: 3.4.4: disabling irq

2012-07-15 Thread Udo van den Heuvel
On 2012-07-15 17:55, Udo van den Heuvel wrote:
> After doing this I could modprobe pwc and start mrtg without problem.

Euh: s/mrtg/motion/

Udo

--
To unsubscribe from this list: send the line "unsubscribe linux-usb" in
the body of a message to majord...@vger.kernel.org
More majordomo info at  http://vger.kernel.org/majordomo-info.html


Re: 3.4.4: disabling irq

2012-07-15 Thread Udo van den Heuvel
On 2012-07-15 17:35, Alan Stern wrote:
> echo :00:13.1 >/sys/bus/pci/drivers/ohci_hcd/unbind

Afterwards I did:

> echo :00:13.1 >/sys/bus/pci/drivers/ohci_hcd/bind

And I saw:

Jul 15 17:50:30 surfplank2 kernel: ohci_hcd :00:13.1: remove, state 1
Jul 15 17:50:30 surfplank2 kernel: usb usb4: USB disconnect, device number 1
Jul 15 17:50:30 surfplank2 kernel: usb 4-3: USB disconnect, device number 2
Jul 15 17:50:30 surfplank2 kernel: ohci_hcd :00:13.1: USB bus 4
deregistered
Jul 15 17:50:37 surfplank2 kernel: ohci_hcd :00:13.1: OHCI Host
Controller
Jul 15 17:50:37 surfplank2 kernel: ohci_hcd :00:13.1: new USB bus
registered, assigned bus number 4
Jul 15 17:50:37 surfplank2 kernel: ohci_hcd :00:13.1: irq 18, io mem
0xfe02a000
Jul 15 17:50:37 surfplank2 kernel: usb usb4: New USB device found,
idVendor=1d6b, idProduct=0001
Jul 15 17:50:37 surfplank2 kernel: usb usb4: New USB device strings:
Mfr=3, Product=2, SerialNumber=1
Jul 15 17:50:37 surfplank2 kernel: usb usb4: Product: OHCI Host Controller
Jul 15 17:50:37 surfplank2 kernel: usb usb4: Manufacturer: Linux 3.4.4
ohci_hcd
Jul 15 17:50:37 surfplank2 kernel: usb usb4: SerialNumber: :00:13.1
Jul 15 17:50:37 surfplank2 kernel: hub 4-0:1.0: USB hub found
Jul 15 17:50:37 surfplank2 kernel: hub 4-0:1.0: 3 ports detected
Jul 15 17:50:37 surfplank2 kernel: usb 4-3: new full-speed USB device
number 2 using ohci_hcd
Jul 15 17:50:38 surfplank2 kernel: usb 4-3: New USB device found,
idVendor=0471, idProduct=0311
Jul 15 17:50:38 surfplank2 kernel: usb 4-3: New USB device strings:
Mfr=0, Product=0, SerialNumber=1
Jul 15 17:50:38 surfplank2 kernel: usb 4-3: SerialNumber: 0169A500
Jul 15 17:50:38 surfplank2 mtp-probe: checking bus 4, device 2:
"/sys/devices/pci:00/:00:13.1/usb4/4-3"
Jul 15 17:50:38 surfplank2 mtp-probe: bus: 4, device: 2 was not an MTP
device
Jul 15 17:50:38 surfplank2 kernel: pwc: Philips PCVC740K (ToUCam
Pro)/PCVC840 (ToUCam II) USB webcam detected.
Jul 15 17:50:39 surfplank2 kernel: pwc: Registered as video0.
Jul 15 17:50:39 surfplank2 kernel: input: PWC snapshot button as
/devices/pci:00/:00:13.0/usb3/3-2/input/input8
Jul 15 17:50:39 surfplank2 kernel: pwc: Philips PCVC740K (ToUCam
Pro)/PCVC840 (ToUCam II) USB webcam detected.
Jul 15 17:50:39 surfplank2 kernel: pwc: Registered as video1.
Jul 15 17:50:39 surfplank2 kernel: input: PWC snapshot button as
/devices/pci:00/:00:13.1/usb4/4-3/input/input9
Jul 15 17:50:39 surfplank2 kernel: usbcore: registered new interface
driver Philips webcam
Jul 15 17:50:39 surfplank2 colord[3375]: (colord:3375): Cd-WARNING **:
CdMain: failed to emit DeviceAdded: failed to register object: An object
is already exported for the interface
org.freedesktop.ColorManager.Device at
/org/freedesktop/ColorManager/devices/sysfs_0471_0311

So I have two webcams on this controller, each on a different port.
The final line is an issue that cam with Fedora 17, nobody could foresee
that one could need a colord *and* have two identical webcams too. (I do
not need colord but have two webcams to be clear)

After doing this I could modprobe pwc and start mrtg without problem.

So now I can wait for the next occurrence.

Kind regards,
Udo



--
To unsubscribe from this list: send the line "unsubscribe linux-usb" in
the body of a message to majord...@vger.kernel.org
More majordomo info at  http://vger.kernel.org/majordomo-info.html


Re: 3.4.4: disabling irq

2012-07-15 Thread Udo van den Heuvel
On 2012-07-15 16:28, Udo van den Heuvel wrote:

> After disabling:

And somewhat later:

bus pci, device :00:12.0
OHCI Host Controller
ohci_hcd
OHCI 1.0, NO legacy support registers, rh state running
control 0x083 HCFS=operational CBSR=3
cmdstatus 0x0 SOC=0
intrstatus 0x0024 FNO SF
intrenable 0x805a MIE RHSC UE RD WDH
ed_controlhead cf82
hcca frame 0x523f
fmintvl 0xa7782edf FIT FSMPS=0xa778 FI=0x2edf
fmremaining 0x80002844 FRT FR=0x2844
periodicstart 0x2a2f
lsthresh 0x0628
hub poll timer off
roothub.a 02000203 POTPGT=2 NPS NDP=3(3)
roothub.b  PPCM= DR=
roothub.status 8000 DRWE
roothub.portstatus [0] 0x0100 PPS
roothub.portstatus [1] 0x0103 PPS PES CCS
roothub.portstatus [2] 0x0100 PPS
bus pci, device :00:12.1
OHCI Host Controller
ohci_hcd
OHCI 1.0, NO legacy support registers, rh state running
control 0x083 HCFS=operational CBSR=3
cmdstatus 0x0 SOC=0
intrstatus 0x0024 FNO SF
intrenable 0x805a MIE RHSC UE RD WDH
ed_controlhead cf862050
ed_bulkhead cf8620a0
hcca frame 0x5203
fmintvl 0xa7782edf FIT FSMPS=0xa778 FI=0x2edf
fmremaining 0x80002249 FRT FR=0x2249
periodicstart 0x2a2f
lsthresh 0x0628
hub poll timer off
roothub.a 02000203 POTPGT=2 NPS NDP=3(3)
roothub.b  PPCM= DR=
roothub.status 8000 DRWE
roothub.portstatus [0] 0x0100 PPS
roothub.portstatus [1] 0x0103 PPS PES CCS
roothub.portstatus [2] 0x0100 PPS
bus pci, device :00:13.0
OHCI Host Controller
ohci_hcd
OHCI 1.0, NO legacy support registers, rh state running
control 0x0af HCFS=operational BLE IE PLE CBSR=3
cmdstatus 0x10004 SOC=1 BLF
intrstatus 0x0025 FNO SF SO
intrenable 0x805a MIE RHSC UE RD WDH
ed_controlhead cf840050
ed_bulkhead cf8400f0
ed_bulkcurrent cf8400f0
hcca frame 0x51c7
fmintvl 0xa7782edf FIT FSMPS=0xa778 FI=0x2edf
fmremaining 0x80001ec8 FRT FR=0x1ec8
periodicstart 0x2a2f
lsthresh 0x0628
hub poll timer off
roothub.a 02000203 POTPGT=2 NPS NDP=3(3)
roothub.b  PPCM= DR=
roothub.status 8000 DRWE
roothub.portstatus [0] 0x0103 PPS PES CCS
roothub.portstatus [1] 0x0103 PPS PES CCS
roothub.portstatus [2] 0x0100 PPS
bus pci, device :00:13.1
OHCI Host Controller
ohci_hcd
OHCI 1.0, NO legacy support registers, rh state running
control 0x083 HCFS=operational CBSR=3
cmdstatus 0x0 SOC=0
intrstatus 0x0024 FNO SF
intrenable 0x805a MIE RHSC UE RD WDH
ed_controlhead cf822000
hcca frame 0x517a
fmintvl 0xa7782edf FIT FSMPS=0xa778 FI=0x2edf
fmremaining 0x80002254 FRT FR=0x2254
periodicstart 0x2a2f
lsthresh 0x0628
hub poll timer off
roothub.a 02000203 POTPGT=2 NPS NDP=3(3)
roothub.b  PPCM= DR=
roothub.status 8000 DRWE
roothub.portstatus [0] 0x0100 PPS
roothub.portstatus [1] 0x0100 PPS
roothub.portstatus [2] 0x0103 PPS PES CCS
bus pci, device :00:14.5
OHCI Host Controller
ohci_hcd
OHCI 1.0, NO legacy support registers, rh state running
control 0x083 HCFS=operational CBSR=3
cmdstatus 0x0 SOC=0
intrstatus 0x0024 FNO SF
intrenable 0x805a MIE RHSC UE RD WDH
hcca frame 0x5057
fmintvl 0xa7782edf FIT FSMPS=0xa778 FI=0x2edf
fmremaining 0x80001864 FRT FR=0x1864
periodicstart 0x2a2f
lsthresh 0x0628
hub poll timer off
roothub.a 02000202 POTPGT=2 NPS NDP=2(2)
roothub.b  PPCM= DR=
roothub.status 8000 DRWE
roothub.portstatus [0] 0x0100 PPS
roothub.portstatus [1] 0x0100 PPS

T:  Bus=07 Lev=00 Prnt=00 Port=00 Cnt=00 Dev#=  1 Spd=12   MxCh= 2
B:  Alloc=  0/900 us ( 0%), #Int=  0, #Iso=  0
D:  Ver= 1.10 Cls=09(hub  ) Sub=00 Prot=00 MxPS=64 #Cfgs=  1
P:  Vendor=1d6b ProdID=0001 Rev= 3.04
S:  Manufacturer=Linux 3.4.4 ohci_hcd
S:  Product=OHCI Host Controller
S:  SerialNumber=:00:14.5
C:* #Ifs= 1 Cfg#= 1 Atr=e0 MxPwr=  0mA
I:* If#= 0 Alt= 0 #EPs= 1 Cls=09(hub  ) Sub=00 Prot=00 Driver=hub
E:  Ad=81(I) Atr=03(Int.) MxPS=   2 Ivl=255ms

T:  Bus=06 Lev=00 Prnt=00 Port=00 Cnt=00 Dev#=  1 Spd=480  MxCh= 6
B:  Alloc=  0/800 us ( 0%), #Int=  0, #Iso=  0
D:  Ver= 2.00 Cls=09(hub  ) Sub=00 Prot=00 MxPS=64 #Cfgs=  1
P:  Vendor=1d6b ProdID=0002 Rev= 3.04
S:  Manufacturer=Linux 3.4.4 ehci_hcd
S:  Product=EHCI Host Controller
S:  SerialNumber=:00:13.2
C:* #Ifs= 1 Cfg#= 1 Atr=e0 MxPwr=  0mA
I:* If#= 0 Alt= 0 #EPs= 1 Cls=09(hub  ) Sub=00 Prot=00 Driver=hub
E:  Ad=81(I) Atr=03(Int.) MxPS=   4 Ivl=256ms

T:  Bus=06 Lev=01 Prnt=01 Port=04 Cnt=01 Dev#=  4 Spd=480  MxCh= 0
D:  Ver= 2.00 Cls=02(comm.) Sub=00 Prot=00 MxPS=64 #Cfgs=  2
P:  Vendor=0525 ProdID=a4a2 Rev= 2.16
S:  Manufacturer=Linux 2.6.21-omap1/musb_hdrc
S:  Product=RNDIS/Ethernet Gadget
C:  #Ifs= 2 Cfg#= 2 Atr=e0 MxPwr=  8mA
I:  If#= 0 Alt= 0 #EPs= 1 Cls=02(comm.) Sub=02 Prot=ff Driver=
E:  Ad=82(I) Atr=03(Int.) MxPS=  16 Ivl=32ms
I:  If#= 1 Alt= 0 #EPs= 2 Cls=0a(data ) Sub=00 Prot=00 Driver=
E:  Ad=81(I) Atr=02(Bulk) MxPS= 512 Ivl=0ms
E:  Ad=01(O) Atr=02(Bulk) MxPS= 512 Ivl=0ms
C:* #Ifs= 2 Cfg#= 1 Atr=e0 MxPwr=  8mA
I:* If#= 0 Alt= 0 #EPs= 1 Cls=02(comm.) Sub=06 Prot=00 Driver=(none)
E:  Ad=82(I) 

Re: 3.4.4: disabling irq

2012-07-15 Thread Udo van den Heuvel
On 2012-07-12 16:54, Alan Stern wrote:
> On Thu, 12 Jul 2012, Udo van den Heuvel wrote:
> 
>> # cat /proc/interrupts
(...)
>>  18: 25190   18052161  21311   IO-APIC-fasteoi
>> ohci_hcd:usb5, ohci_hcd:usb6, ohci_hcd:usb7
(...)
>> So what can we conclude?

> The conclusion is that ohci-hcd is the only driver using IRQ 18.  If 
> you build a kernel with CONFIG_USB_DEBUG enabled, it will be possible 
> to see if the OHCI hardware is responsible for the IRQ problem.
> 
> When the IRQ line gets disabled again, make a copy of the
> 
>   /sys/kernel/debug/usb/ohci/*/registers
> 
> files and post them, along with a copy of 
> /sys/kernel/debug/usb/devices.

After boot:

bus pci, device :00:12.0
OHCI Host Controller
ohci_hcd
OHCI 1.0, NO legacy support registers, rh state running
control 0x083 HCFS=operational CBSR=3
cmdstatus 0x0 SOC=0
intrstatus 0x0024 FNO SF
intrenable 0x805a MIE RHSC UE RD WDH
ed_controlhead cf83f000
hcca frame 0x4771
fmintvl 0xa7782edf FIT FSMPS=0xa778 FI=0x2edf
fmremaining 0x80001f9b FRT FR=0x1f9b
periodicstart 0x2a2f
lsthresh 0x0628
hub poll timer off
roothub.a 02000203 POTPGT=2 NPS NDP=3(3)
roothub.b  PPCM= DR=
roothub.status 8000 DRWE
roothub.portstatus [0] 0x0100 PPS
roothub.portstatus [1] 0x0103 PPS PES CCS
roothub.portstatus [2] 0x0100 PPS
bus pci, device :00:12.1
OHCI Host Controller
ohci_hcd
OHCI 1.0, NO legacy support registers, rh state running
control 0x083 HCFS=operational CBSR=3
cmdstatus 0x0 SOC=0
intrstatus 0x0024 FNO SF
intrenable 0x805a MIE RHSC UE RD WDH
ed_controlhead cf809000
hcca frame 0x4735
fmintvl 0xa7782edf FIT FSMPS=0xa778 FI=0x2edf
fmremaining 0x800019d1 FRT FR=0x19d1
periodicstart 0x2a2f
lsthresh 0x0628
hub poll timer off
roothub.a 02000203 POTPGT=2 NPS NDP=3(3)
roothub.b  PPCM= DR=
roothub.status 8000 DRWE
roothub.portstatus [0] 0x0100 PPS
roothub.portstatus [1] 0x0103 PPS PES CCS
roothub.portstatus [2] 0x0100 PPS
bus pci, device :00:13.0
OHCI Host Controller
ohci_hcd
OHCI 1.0, NO legacy support registers, rh state running
control 0x0af HCFS=operational BLE IE PLE CBSR=3
cmdstatus 0x4 SOC=0 BLF
intrstatus 0x0024 FNO SF
intrenable 0x805a MIE RHSC UE RD WDH
ed_controlhead cf825050
ed_bulkhead cf8250f0
ed_bulkcurrent cf8250f0
hcca frame 0x46f5
fmintvl 0xa7782edf FIT FSMPS=0xa778 FI=0x2edf
fmremaining 0x80001642 FRT FR=0x1642
periodicstart 0x2a2f
lsthresh 0x0628
hub poll timer off
roothub.a 02000203 POTPGT=2 NPS NDP=3(3)
roothub.b  PPCM= DR=
roothub.status 8000 DRWE
roothub.portstatus [0] 0x0103 PPS PES CCS
roothub.portstatus [1] 0x0103 PPS PES CCS
roothub.portstatus [2] 0x0100 PPS
bus pci, device :00:13.1
OHCI Host Controller
ohci_hcd
OHCI 1.0, NO legacy support registers, rh state running
control 0x08f HCFS=operational IE PLE CBSR=3
cmdstatus 0x0 SOC=0
intrstatus 0x0024 FNO SF
intrenable 0x805a MIE RHSC UE RD WDH
ed_periodcurrent cf807050
ed_controlhead cf807000
donehead cf808300
hcca frame 0x46ad
fmintvl 0xa7782edf FIT FSMPS=0xa778 FI=0x2edf
fmremaining 0x80001338 FRT FR=0x1338
periodicstart 0x2a2f
lsthresh 0x0628
hub poll timer off
roothub.a 02000203 POTPGT=2 NPS NDP=3(3)
roothub.b  PPCM= DR=
roothub.status 8000 DRWE
roothub.portstatus [0] 0x0100 PPS
roothub.portstatus [1] 0x0100 PPS
roothub.portstatus [2] 0x0103 PPS PES CCS
bus pci, device :00:14.5
OHCI Host Controller
ohci_hcd
OHCI 1.0, NO legacy support registers, rh state running
control 0x083 HCFS=operational CBSR=3
cmdstatus 0x0 SOC=0
intrstatus 0x0024 FNO SF
intrenable 0x805a MIE RHSC UE RD WDH
hcca frame 0x4585
fmintvl 0xa7782edf FIT FSMPS=0xa778 FI=0x2edf
fmremaining 0x8feb FRT FR=0x0feb
periodicstart 0x2a2f
lsthresh 0x0628
hub poll timer off
roothub.a 02000202 POTPGT=2 NPS NDP=2(2)
roothub.b  PPCM= DR=
roothub.status 8000 DRWE
roothub.portstatus [0] 0x0100 PPS
roothub.portstatus [1] 0x0100 PPS

T:  Bus=07 Lev=00 Prnt=00 Port=00 Cnt=00 Dev#=  1 Spd=12   MxCh= 2
B:  Alloc=  0/900 us ( 0%), #Int=  0, #Iso=  0
D:  Ver= 1.10 Cls=09(hub  ) Sub=00 Prot=00 MxPS=64 #Cfgs=  1
P:  Vendor=1d6b ProdID=0001 Rev= 3.04
S:  Manufacturer=Linux 3.4.4 ohci_hcd
S:  Product=OHCI Host Controller
S:  SerialNumber=:00:14.5
C:* #Ifs= 1 Cfg#= 1 Atr=e0 MxPwr=  0mA
I:* If#= 0 Alt= 0 #EPs= 1 Cls=09(hub  ) Sub=00 Prot=00 Driver=hub
E:  Ad=81(I) Atr=03(Int.) MxPS=   2 Ivl=255ms

T:  Bus=06 Lev=00 Prnt=00 Port=00 Cnt=00 Dev#=  1 Spd=480  MxCh= 6
B:  Alloc=  0/800 us ( 0%), #Int=  0, #Iso=  0
D:  Ver= 2.00 Cls=09(hub  ) Sub=00 Prot=00 MxPS=64 #Cfgs=  1
P:  Vendor=1d6b ProdID=0002 Rev= 3.04
S:  Manufacturer=Linux 3.4.4 ehci_hcd
S:  Product=EHCI Host Controller
S:  SerialNumber=:00:13.2
C:* #Ifs= 1 Cfg#= 1 Atr=e0 MxPwr=  0mA
I:* If#= 0 Alt= 0 #EPs= 1 Cls=09(hub  ) Sub=00 Prot=00 Driver=hub
E:  Ad=81(I) Atr=03(Int.

Re: 3.4.4: disabling irq

2012-07-12 Thread Udo van den Heuvel
On 2012-07-12 15:43, Jan Ceuleers wrote:
> On 07/12/2012 03:23 PM, Udo van den Heuvel wrote:
>> How to list what modules/programs are using that irq?
> 
> cat /proc/interrupts

# cat /proc/interrupts
   CPU0   CPU1   CPU2   CPU3
  0: 40  0  0  0   IO-APIC-edge  timer
  1:  1  4  91884418   IO-APIC-edge  i8042
  4:  1 25 607223   1584   IO-APIC-edge  serial
  6:  0  0  8  0   IO-APIC-edge  floppy
  7:  1  0  0  0   IO-APIC-edge
parport0
  9:  0  0  0  0   IO-APIC-fasteoi   acpi
 12:  3106 980333   3914   IO-APIC-edge  i8042
 14:  0  5 169732457   IO-APIC-edge
pata_atiixp
 15:  0  0  0  0   IO-APIC-edge
pata_atiixp
 16:  0  0   3038 33   IO-APIC-fasteoi
sata_sil24, ohci_hcd:usb1, ohci_hcd:usb2, snd_hda_intel
 17:  0  4  24053119   IO-APIC-fasteoi
ehci_hcd:usb3
 18: 25190   18052161  21311   IO-APIC-fasteoi
ohci_hcd:usb5, ohci_hcd:usb6, ohci_hcd:usb7
 19:  1  9 187895487   IO-APIC-fasteoi
ehci_hcd:usb4
 20:  71353756346   8907   IO-APIC-fasteoi   serial
 22:127719   14673690  33318   IO-APIC-fasteoi   ahci
 43:115   1072   33699508  73116   PCI-MSI-edge  eth0
 44: 272523044666  11507   PCI-MSI-edge  radeon
 45:  0  0 21  0   PCI-MSI-edge
snd_hda_intel
NMI:  0  0  0  0   Non-maskable interrupts
LOC:   15971203   15548951   13031603   13145359   Local timer interrupts
SPU:  0  0  0  0   Spurious interrupts
PMI:  0  0  0  0   Performance
monitoring interrupts
IWI:  0  0  0  0   IRQ work interrupts
RTR:  0  0  0  0   APIC ICR read retries
RES:   57916374   44634814   19199377   43219640   Rescheduling interrupts
CAL:   2241   2293   2327   2196   Function call interrupts
TLB: 577983 648537 579293 635466   TLB shootdowns
THR:  0  0  0  0   Threshold APIC interrupts
MCE:  0  0  0  0   Machine check exceptions
MCP:581581581581   Machine check polls
ERR:  0
MIS:  0



So what can we conclude?

Kind regards,
Udo
--
To unsubscribe from this list: send the line "unsubscribe linux-usb" in
the body of a message to majord...@vger.kernel.org
More majordomo info at  http://vger.kernel.org/majordomo-info.html


Re: 3.4.4: disabling irq

2012-07-12 Thread Udo van den Heuvel
On 2012-07-11 17:15, Alan Stern wrote:
> On Wed, 11 Jul 2012, Udo van den Heuvel wrote:
> 
>> New occurrence:
> 
>> Any clues and/or updates?
> 
> Didn't you see the message I posted on Monday?
> 
>   http://marc.info/?l=linux-usb&m=134186054713868&w=2

Nothing changed except the kernel.
Main compononent on usb is the pwc webcam.
After the occurrence yesterday I unloaded motion and the pwc module.
But I got *another* occurrence round 20:47 hours.

How to list what modules/programs are using that irq?


Udo
--
To unsubscribe from this list: send the line "unsubscribe linux-usb" in
the body of a message to majord...@vger.kernel.org
More majordomo info at  http://vger.kernel.org/majordomo-info.html


Re: 3.4.4: disabling irq

2012-07-11 Thread Udo van den Heuvel
On 2012-07-09 15:54, Clemens Ladisch wrote:
> (forwarded to linux-usb)
> 
> Udo van den Heuvel wrote:
>>
>> One moment the box is runing OK.
>> One moment the 3.4.4 kernel decides to disable an interrupt.
>> Why?
>>
>> Jul  8 07:43:49 box3 ntpd[5067]: parse: convert_rawdcf: INCOMPLETE DATA - 
>> time code only has 1 bits
>> Jul  8 07:44:53 box3 kernel: irq 18: nobody cared (try booting with the 
>> "irqpoll" option)
>> Jul  8 07:44:53 box3 kernel: Pid: 1501, comm: irq/18-ohci_hcd Tainted: G 
>>W3.4.4 #1
>> Jul  8 07:44:53 box3 kernel: Call Trace:
>> Jul  8 07:44:53 box3 kernel: [] ? 
>> __report_bad_irq+0x36/0xd0
>> Jul  8 07:44:53 box3 kernel: [] ? 
>> note_interrupt+0x1cf/0x220
>> Jul  8 07:44:53 box3 kernel: [] ? irq_thread_fn+0x40/0x40
>> Jul  8 07:44:53 box3 kernel: [] ? irq_thread+0x13d/0x180
>> Jul  8 07:44:53 box3 kernel: [] ? 
>> wake_threads_waitq+0x50/0x50
>> Jul  8 07:44:53 box3 kernel: [] ? kthread+0x85/0x90
>> Jul  8 07:44:53 box3 kernel: [] ? 
>> kernel_thread_helper+0x4/0x10
>> Jul  8 07:44:53 box3 kernel: [] ? 
>> kthread_freezable_should_stop+0x50/0x50
>> Jul  8 07:44:53 box3 kernel: [] ? gs_change+0xb/0xb
>> Jul  8 07:44:53 box3 kernel: handlers:
>> Jul  8 07:44:53 box3 kernel: [] 
>> irq_default_primary_handler threaded [] usb_hcd_irq
>> Jul  8 07:44:53 box3 kernel: [] 
>> irq_default_primary_handler threaded [] usb_hcd_irq
>> Jul  8 07:44:53 box3 kernel: [] 
>> irq_default_primary_handler threaded [] usb_hcd_irq
>> Jul  8 07:44:53 box3 kernel: Disabling IRQ #18
>> Jul  8 07:44:53 box3 kernel: pwc: Iso frame 0 has error -114
>> Jul  8 07:44:53 box3 kernel: pwc: Iso frame 1 has error -18
>> Jul  8 07:44:53 box3 kernel: pwc: Iso frame 2 has error -18
>> Jul  8 07:44:53 box3 kernel: pwc: Iso frame 3 has error -18
>> Jul  8 07:44:53 box3 kernel: pwc: Iso frame 4 has error -18
>> Jul  8 07:44:53 box3 kernel: pwc: Iso frame 5 has error -18
>> (etc; many more of the pwc messages)

New occurrence:

Jul 11 16:45:26 box3 kernel: irq 18: nobody cared (try booting with the
"irqpoll" option)
Jul 11 16:45:26 box3 kernel: Pid: 1465, comm: irq/18-ohci_hcd Not
tainted 3.4.4 #3
Jul 11 16:45:26 box3 kernel: Call Trace:
Jul 11 16:45:26 box3 kernel: [] ?
__report_bad_irq+0x36/0xd0
Jul 11 16:45:26 box3 kernel: [] ?
note_interrupt+0x1cf/0x220
Jul 11 16:45:26 box3 kernel: [] ? irq_thread_fn+0x40/0x40
Jul 11 16:45:26 box3 kernel: [] ? irq_thread+0x13d/0x180
Jul 11 16:45:26 box3 kernel: [] ?
wake_threads_waitq+0x50/0x50
Jul 11 16:45:26 box3 kernel: [] ? kthread+0x85/0x90
Jul 11 16:45:26 box3 kernel: [] ?
kernel_thread_helper+0x4/0x10
Jul 11 16:45:26 box3 kernel: [] ?
kthread_freezable_should_stop+0x50/0x50
Jul 11 16:45:26 box3 kernel: [] ? gs_change+0xb/0xb
Jul 11 16:45:26 box3 kernel: handlers:
Jul 11 16:45:26 box3 kernel: []
irq_default_primary_handler threaded [] usb_hcd_irq
Jul 11 16:45:26 box3 kernel: []
irq_default_primary_handler threaded [] usb_hcd_irq
Jul 11 16:45:26 box3 kernel: []
irq_default_primary_handler threaded [] usb_hcd_irq
Jul 11 16:45:26 box3 kernel: Disabling IRQ #18
Jul 11 16:45:26 box3 kernel: pwc: Iso frame 0 has error -18
Jul 11 16:45:26 box3 kernel: pwc: Iso frame 1 has error -18
(etc)


Any clues and/or updates?


Udo
--
To unsubscribe from this list: send the line "unsubscribe linux-usb" in
the body of a message to majord...@vger.kernel.org
More majordomo info at  http://vger.kernel.org/majordomo-info.html


Re: 3.4.4: disabling irq

2012-07-09 Thread Udo van den Heuvel
On 2012-07-09 15:54, Clemens Ladisch wrote:
> (forwarded to linux-usb)
> 
> Udo van den Heuvel wrote:
>> Hello,
>>
>> One moment the box is runing OK.
>> One moment the 3.4.4 kernel decides to disable an interrupt.
>> Why?
>>
>> Jul  8 07:43:49 box3 ntpd[5067]: parse: convert_rawdcf: INCOMPLETE DATA - 
>> time code only has 1 bits
>> Jul  8 07:44:53 box3 kernel: irq 18: nobody cared (try booting with the 
>> "irqpoll" option)
>> Jul  8 07:44:53 box3 kernel: Pid: 1501, comm: irq/18-ohci_hcd Tainted: G 
>>W3.4.4 #1
>> Jul  8 07:44:53 box3 kernel: Call Trace:
>> Jul  8 07:44:53 box3 kernel: [] ? 
>> __report_bad_irq+0x36/0xd0
>> Jul  8 07:44:53 box3 kernel: [] ? 
>> note_interrupt+0x1cf/0x220
>> Jul  8 07:44:53 box3 kernel: [] ? irq_thread_fn+0x40/0x40
>> Jul  8 07:44:53 box3 kernel: [] ? irq_thread+0x13d/0x180
>> Jul  8 07:44:53 box3 kernel: [] ? 
>> wake_threads_waitq+0x50/0x50
>> Jul  8 07:44:53 box3 kernel: [] ? kthread+0x85/0x90
>> Jul  8 07:44:53 box3 kernel: [] ? 
>> kernel_thread_helper+0x4/0x10
>> Jul  8 07:44:53 box3 kernel: [] ? 
>> kthread_freezable_should_stop+0x50/0x50
>> Jul  8 07:44:53 box3 kernel: [] ? gs_change+0xb/0xb
>> Jul  8 07:44:53 box3 kernel: handlers:
>> Jul  8 07:44:53 box3 kernel: [] 
>> irq_default_primary_handler threaded [] usb_hcd_irq
>> Jul  8 07:44:53 box3 kernel: [] 
>> irq_default_primary_handler threaded [] usb_hcd_irq
>> Jul  8 07:44:53 box3 kernel: [] 
>> irq_default_primary_handler threaded [] usb_hcd_irq
>> Jul  8 07:44:53 box3 kernel: Disabling IRQ #18
>> Jul  8 07:44:53 box3 kernel: pwc: Iso frame 0 has error -114
>> Jul  8 07:44:53 box3 kernel: pwc: Iso frame 1 has error -18
>> Jul  8 07:44:53 box3 kernel: pwc: Iso frame 2 has error -18
>> Jul  8 07:44:53 box3 kernel: pwc: Iso frame 3 has error -18
>> Jul  8 07:44:53 box3 kernel: pwc: Iso frame 4 has error -18
>> Jul  8 07:44:53 box3 kernel: pwc: Iso frame 5 has error -18
>> (etc; many more of the pwc messages)
>>
>> Kind regards,
>> Udo
> 
> ... and, with apparently the same mainboard:

Over here:

Manufacturer: Gigabyte Technology Co., Ltd.
Product Name: GA-MA770-DS3

>> Motherboard is Gigabyte GA-990XA-UD3
>> CPU is AMD Bulldozer 6 Core version

AMD 9550 4 core in my case, i.e.: less new.
pwc driver is the main user for a webcam on USB.

>> I'll attach the 2 dmesg logs, one from 3.2 and other from 3.4,
>> hopefully someone can see what's wrong, there is a suggestion to boot
>> with irqpoll, but really wanted someone's opinion on this.

Any ideas why the IRQ stops working?

Udo

--
To unsubscribe from this list: send the line "unsubscribe linux-usb" in
the body of a message to majord...@vger.kernel.org
More majordomo info at  http://vger.kernel.org/majordomo-info.html