Re: [alsa-devel] [PATCH 0/6] snd-usb endpoint rework, version 6
Happy New Year!
That being said, I've tested a kernel without Daniel's patch set. It doesn't work either. The error messages are only slightly different:
Jan 1 11:52:31 weasel mtp-probe: checking bus 1, device 4: "/sys/devices/pci0000:00/0000:00:1a.7/usb1/1-1" Jan 1 11:52:31 weasel mtp-probe: bus: 1, device: 4 was not an MTP device Jan 1 11:52:31 weasel kernel: [ 161.880773] usbcore: registered new interface driver snd-usb-audio Jan 1 11:52:34 weasel kernel: [ 164.284980] cannot submit datapipe for urb 0, error -28: not enough bandwidth
So, It's not related to Daniel's rework. But nevertheless, something's broken...
So I've had a chance to do some testing. I can reliably generate then following trace with daniels patch on 3.2-rt10
[ 188.561901] ------------[ cut here ]------------ [ 188.561908] WARNING: at fs/proc/generic.c:586 proc_register+0x181/0x1c7() [ 188.561909] Hardware name: HP Compaq 6910p [ 188.561911] proc_dir_entry 'card1/pcm0p' already registered [ 188.561912] Modules linked in: snd_usb_audio snd_usbmidi_lib snd_seq_dummy acpi_cpufreq mperf cpufreq_userspace cpufreq_stats cpufreq_conservative cpufreq_powersave ppdev lp parport microcode binfmt_misc uinput fuse nfsd exportfs nfs lockd fscache auth_rpcgss nfs_acl sunrpc ext2 firewire_sbp2 loop btusb bluetooth snd_hda_codec_analog arc4 iwl4965 iwl_legacy i915 mac80211 uhci_hcd snd_hda_intel snd_hda_codec ehci_hcd drm_kms_helper snd_hwdep drm snd_pcm_oss snd_mixer_oss snd_pcm snd_seq_midi cfg80211 snd_rawmidi snd_seq_midi_event snd_seq usbcore sr_mod mmc_block snd_timer tpm_infineon pata_pcmcia snd_seq_device firewire_ohci snd sdhci_pci i2c_algo_bit irda cdrom sdhci joydev pcmcia tpm_tis ata_generic ata_piix hp_wmi firewire_core i2c_core yenta_socket pcmcia_rsrc iTCO_wdt mmc_core battery pcmcia_core sparse_keymap ac power_supply rfkill pcspkr soundcore tpm tpm_bios wmi iTCO_vendor_support evdev crc_itu_t crc_ccitt psmouse processor container video usb_common snd_page_alloc serio_raw button ext3 jbd mbcache sha256_generic aes_x86_64 aes_generic cbc dm_crypt dm_mod sd_mod crc_t10dif ahci libahci libata scsi_mod fan thermal thermal_sys [ 188.561979] Pid: 621, comm: khubd Not tainted 3.2.0-rt10-00255-g530565d #5 [ 188.561980] Call Trace: [ 188.561986] [<ffffffff81036273>] ? warn_slowpath_common+0x78/0x8c [ 188.561989] [<ffffffff8103631f>] ? warn_slowpath_fmt+0x45/0x4a [ 188.561993] [<ffffffff8102df06>] ? get_parent_ip+0x9/0x1b [ 188.561995] [<ffffffff81123ac5>] ? proc_register+0x181/0x1c7 [ 188.561997] [<ffffffff81123e2c>] ? create_proc_entry+0x6e/0x85 [ 188.562020] [<ffffffffa0237c18>] ? snd_info_register+0x35/0xbd [snd] [ 188.562026] [<ffffffffa02cdf89>] ? snd_pcm_new_stream+0xd6/0x417 [snd_pcm] [ 188.562031] [<ffffffffa05b69e3>] ? snd_usb_add_audio_stream+0xd5/0x21c [snd_usb_audio] [ 188.562035] [<ffffffffa05b6fd3>] ? snd_usb_parse_audio_interface+0x4a9/0x556 [snd_usb_audio] [ 188.562039] [<ffffffffa05ae276>] ? snd_usb_create_stream+0xed/0x126 [snd_usb_audio] [ 188.562043] [<ffffffffa05aea74>] ? usb_audio_probe+0x61d/0x72d [snd_usb_audio] [ 188.562057] [<ffffffffa028c6e3>] ? usb_probe_interface+0xf8/0x163 [usbcore] [ 188.562062] [<ffffffff812170f1>] ? driver_probe_device+0xa8/0x138 [ 188.562064] [<ffffffff812171f0>] ? __driver_attach+0x6f/0x6f [ 188.562066] [<ffffffff81216120>] ? bus_for_each_drv+0x4a/0x7e [ 188.562069] [<ffffffff81217012>] ? device_attach+0x6f/0x8f [ 188.562071] [<ffffffff8121692c>] ? bus_probe_device+0x1f/0x37 [ 188.562073] [<ffffffff8121520a>] ? device_add+0x3d4/0x577 [ 188.562076] [<ffffffff8102df06>] ? get_parent_ip+0x9/0x1b [ 188.562078] [<ffffffff81030bf0>] ? migrate_enable+0x150/0x16a [ 188.562085] [<ffffffffa028b2b0>] ? usb_set_configuration+0x53f/0x594 [usbcore] [ 188.562088] [<ffffffff811304e6>] ? sysfs_do_create_link+0x149/0x194 [ 188.562094] [<ffffffffa029231a>] ? generic_probe+0x45/0x73 [usbcore] [ 188.562097] [<ffffffff812170f1>] ? driver_probe_device+0xa8/0x138 [ 188.562099] [<ffffffff812171f0>] ? __driver_attach+0x6f/0x6f [ 188.562101] [<ffffffff81216120>] ? bus_for_each_drv+0x4a/0x7e [ 188.562104] [<ffffffff81217012>] ? device_attach+0x6f/0x8f [ 188.562106] [<ffffffff8121692c>] ? bus_probe_device+0x1f/0x37 [ 188.562108] [<ffffffff8121520a>] ? device_add+0x3d4/0x577 [ 188.562110] [<ffffffff81214793>] ? dev_printk+0x48/0x4d [ 188.562116] [<ffffffffa0285188>] ? usb_new_device+0x124/0x198 [usbcore] [ 188.562122] [<ffffffffa02861eb>] ? hub_thread+0x964/0xe54 [usbcore] [ 188.562124] [<ffffffff8102abf4>] ? hrtick_start_fair+0x1a/0x15b [ 188.562127] [<ffffffff8102000a>] ? kern_addr_valid+0x5/0x93 [ 188.562131] [<ffffffff8131adb9>] ? __schedule+0x531/0x548 [ 188.562135] [<ffffffff8104ff82>] ? __init_waitqueue_head+0x39/0x39 [ 188.562140] [<ffffffffa0285887>] ? usb_remote_wakeup+0x2f/0x2f [usbcore] [ 188.562142] [<ffffffff8104f8b8>] ? kthread+0x78/0x80 [ 188.562145] [<ffffffff8102df06>] ? get_parent_ip+0x9/0x1b [ 188.562148] [<ffffffff81310000>] ? init_amd+0x112/0x3e4 [ 188.562151] [<ffffffff81322d74>] ? kernel_thread_helper+0x4/0x10 [ 188.562154] [<ffffffff8104f840>] ? __init_kthread_worker+0x41/0x41 [ 188.562156] [<ffffffff81322d70>] ? gs_change+0x13/0x13 [ 188.562161] ---[ end trace 0000000000000002 ]---
Grant
oh steps to reproduce remove logitech headset
Additionally there seems to be an issue with correctly detecting the number of audio channels.
the logitech is only showing up as a mono output device with the new streaming code.
Grant.
Hi Grant et al,
Again sorry for catching up so late on this.
On 16.01.2012 21:26, Grant Diffey wrote:
So I've had a chance to do some testing. I can reliably generate then following trace with daniels patch on 3.2-rt10
[ 188.561901] ------------[ cut here ]------------ [ 188.561908] WARNING: at fs/proc/generic.c:586 proc_register+0x181/0x1c7() [ 188.561909] Hardware name: HP Compaq 6910p [ 188.561911] proc_dir_entry 'card1/pcm0p' already registered
There might have been a race condition in the shutdown path which I fixed.
Could you repeat the tests you did some months ago and report whether you still see this issue? I would also appreciate test input from other people. Any kind of USB device is good to track these issues.
Regarding the difference in reported channel numbers, I can't really point my finger to any specific line. It really puzzles me, as my patch set leaves the detection of interfaces and the registration of pcm streams untouched. It would help to know whether there is any difference in the output of "aplay -l" with and without my patches applied.
To test the new set of patches, please start off with a 3.4.0 vanilla kernel and then either
git pull git://github.com/zonque/linux.git usb-audio
or manually apply the combined patch from https://gist.github.com/1168715
I hope to *finally* get this topic finished in this round, but I need the some helpers for testing :)
Daniel
[ 188.561912] Modules linked in: snd_usb_audio snd_usbmidi_lib snd_seq_dummy acpi_cpufreq mperf cpufreq_userspace cpufreq_stats cpufreq_conservative cpufreq_powersave ppdev lp parport microcode binfmt_misc uinput fuse nfsd exportfs nfs lockd fscache auth_rpcgss nfs_acl sunrpc ext2 firewire_sbp2 loop btusb bluetooth snd_hda_codec_analog arc4 iwl4965 iwl_legacy i915 mac80211 uhci_hcd snd_hda_intel snd_hda_codec ehci_hcd drm_kms_helper snd_hwdep drm snd_pcm_oss snd_mixer_oss snd_pcm snd_seq_midi cfg80211 snd_rawmidi snd_seq_midi_event snd_seq usbcore sr_mod mmc_block snd_timer tpm_infineon pata_pcmcia snd_seq_device firewire_ohci snd sdhci_pci i2c_algo_bit irda cdrom sdhci joydev pcmcia tpm_tis ata_generic ata_piix hp_wmi firewire_core i2c_core yenta_socket pcmcia_rsrc iTCO_wdt mmc_core battery pcmcia_core sparse_keymap ac power_supply rfkill pcspkr soundcore tpm tpm_bios wmi iTCO_vendor_support evdev crc_itu_t crc_ccitt psmouse processor container video usb_common snd_page_alloc serio_raw button ext3 jbd mbcache sha256_generic aes_x86_64 aes_generic cbc dm_crypt dm_mod sd_mod crc_t10dif ahci libahci libata scsi_mod fan thermal thermal_sys [ 188.561979] Pid: 621, comm: khubd Not tainted 3.2.0-rt10-00255-g530565d #5 [ 188.561980] Call Trace: [ 188.561986] [<ffffffff81036273>] ? warn_slowpath_common+0x78/0x8c [ 188.561989] [<ffffffff8103631f>] ? warn_slowpath_fmt+0x45/0x4a [ 188.561993] [<ffffffff8102df06>] ? get_parent_ip+0x9/0x1b [ 188.561995] [<ffffffff81123ac5>] ? proc_register+0x181/0x1c7 [ 188.561997] [<ffffffff81123e2c>] ? create_proc_entry+0x6e/0x85 [ 188.562020] [<ffffffffa0237c18>] ? snd_info_register+0x35/0xbd [snd] [ 188.562026] [<ffffffffa02cdf89>] ? snd_pcm_new_stream+0xd6/0x417 [snd_pcm] [ 188.562031] [<ffffffffa05b69e3>] ? snd_usb_add_audio_stream+0xd5/0x21c [snd_usb_audio] [ 188.562035] [<ffffffffa05b6fd3>] ? snd_usb_parse_audio_interface+0x4a9/0x556 [snd_usb_audio] [ 188.562039] [<ffffffffa05ae276>] ? snd_usb_create_stream+0xed/0x126 [snd_usb_audio] [ 188.562043] [<ffffffffa05aea74>] ? usb_audio_probe+0x61d/0x72d [snd_usb_audio] [ 188.562057] [<ffffffffa028c6e3>] ? usb_probe_interface+0xf8/0x163 [usbcore] [ 188.562062] [<ffffffff812170f1>] ? driver_probe_device+0xa8/0x138 [ 188.562064] [<ffffffff812171f0>] ? __driver_attach+0x6f/0x6f [ 188.562066] [<ffffffff81216120>] ? bus_for_each_drv+0x4a/0x7e [ 188.562069] [<ffffffff81217012>] ? device_attach+0x6f/0x8f [ 188.562071] [<ffffffff8121692c>] ? bus_probe_device+0x1f/0x37 [ 188.562073] [<ffffffff8121520a>] ? device_add+0x3d4/0x577 [ 188.562076] [<ffffffff8102df06>] ? get_parent_ip+0x9/0x1b [ 188.562078] [<ffffffff81030bf0>] ? migrate_enable+0x150/0x16a [ 188.562085] [<ffffffffa028b2b0>] ? usb_set_configuration+0x53f/0x594 [usbcore] [ 188.562088] [<ffffffff811304e6>] ? sysfs_do_create_link+0x149/0x194 [ 188.562094] [<ffffffffa029231a>] ? generic_probe+0x45/0x73 [usbcore] [ 188.562097] [<ffffffff812170f1>] ? driver_probe_device+0xa8/0x138 [ 188.562099] [<ffffffff812171f0>] ? __driver_attach+0x6f/0x6f [ 188.562101] [<ffffffff81216120>] ? bus_for_each_drv+0x4a/0x7e [ 188.562104] [<ffffffff81217012>] ? device_attach+0x6f/0x8f [ 188.562106] [<ffffffff8121692c>] ? bus_probe_device+0x1f/0x37 [ 188.562108] [<ffffffff8121520a>] ? device_add+0x3d4/0x577 [ 188.562110] [<ffffffff81214793>] ? dev_printk+0x48/0x4d [ 188.562116] [<ffffffffa0285188>] ? usb_new_device+0x124/0x198 [usbcore] [ 188.562122] [<ffffffffa02861eb>] ? hub_thread+0x964/0xe54 [usbcore] [ 188.562124] [<ffffffff8102abf4>] ? hrtick_start_fair+0x1a/0x15b [ 188.562127] [<ffffffff8102000a>] ? kern_addr_valid+0x5/0x93 [ 188.562131] [<ffffffff8131adb9>] ? __schedule+0x531/0x548 [ 188.562135] [<ffffffff8104ff82>] ? __init_waitqueue_head+0x39/0x39 [ 188.562140] [<ffffffffa0285887>] ? usb_remote_wakeup+0x2f/0x2f [usbcore] [ 188.562142] [<ffffffff8104f8b8>] ? kthread+0x78/0x80 [ 188.562145] [<ffffffff8102df06>] ? get_parent_ip+0x9/0x1b [ 188.562148] [<ffffffff81310000>] ? init_amd+0x112/0x3e4 [ 188.562151] [<ffffffff81322d74>] ? kernel_thread_helper+0x4/0x10 [ 188.562154] [<ffffffff8104f840>] ? __init_kthread_worker+0x41/0x41 [ 188.562156] [<ffffffff81322d70>] ? gs_change+0x13/0x13 [ 188.562161] ---[ end trace 0000000000000002 ]---
Grant
On Tue, Apr 10, 2012 at 5:21 AM, Daniel Mack zonque@gmail.com wrote:
Hi Grant et al,
Again sorry for catching up so late on this.
On 16.01.2012 21:26, Grant Diffey wrote:
So I've had a chance to do some testing. I can reliably generate then following trace with daniels patch on 3.2-rt10
[ 188.561901] ------------[ cut here ]------------ [ 188.561908] WARNING: at fs/proc/generic.c:586
proc_register+0x181/0x1c7()
[ 188.561909] Hardware name: HP Compaq 6910p [ 188.561911] proc_dir_entry 'card1/pcm0p' already registered
There might have been a race condition in the shutdown path which I fixed.
Could you repeat the tests you did some months ago and report whether you still see this issue? I would also appreciate test input from other people. Any kind of USB device is good to track these issues.
Regarding the difference in reported channel numbers, I can't really point my finger to any specific line. It really puzzles me, as my patch set leaves the detection of interfaces and the registration of pcm streams untouched. It would help to know whether there is any difference in the output of "aplay -l" with and without my patches applied.
To test the new set of patches, please start off with a 3.4.0 vanilla kernel and then either
git pull git://github.com/zonque/linux.git usb-audio
or manually apply the combined patch from https://gist.github.com/1168715
I hope to *finally* get this topic finished in this round, but I need the some helpers for testing :)
Daniel
So this seems to be good it solves the clicking problem for me generating sine wave's
I need to do some further testing. which is unlikely to happen this morning.
Grant.
Hi,
this time I can get the device to work. It produces clickless playback at higher latencies. But trying to run JACK @44.1kHz with 128 frames/period (i.e. -p 128) I can reliably reproduce a kernel oops which either completely freezes my system or at least blocks keyboard an mouse. Here it is:
Apr 10 20:25:43 weasel kernel: [ 164.243214] usbcore: registered new interface driver snd-usb-audio Apr 10 20:27:00 weasel kernel: [ 240.453704] BUG: unable to handle kernel paging request at 00100104 Apr 10 20:27:00 weasel kernel: [ 240.457673] IP: [<f90a7409>] queue_pending_output_urbs+0x89/0x130 [snd_usb_audio] Apr 10 20:27:00 weasel kernel: [ 240.457673] *pde = 00000000 Apr 10 20:27:00 weasel kernel: [ 240.457673] Oops: 0002 [#1] SMP Apr 10 20:27:00 weasel kernel: [ 240.457673] Modules linked in: snd_usb_audio snd_usbmidi_lib snd_seq_dummy rfcomm bnep parport_pc dm_crypt ppdev binfmt_misc snd_hda_c odec_hdmi snd_hda_codec_realtek snd_hda_intel snd_hda_codec snd_hwdep snd_pcm snd_seq_midi snd_rawmidi snd_seq_midi_event snd_seq joydev coretemp snd_timer snd_seq_devi ce uvcvideo hid_multitouch videobuf2_core snd microcode videodev videobuf2_vmalloc videobuf2_memops btusb soundcore bluetooth snd_page_alloc psmouse serio_raw lp parpor t usbhid hid atl1c ahci libahci i915 drm_kms_helper drm wmi i2c_algo_bit video Apr 10 20:27:00 weasel kernel: [ 240.457673] Apr 10 20:27:00 weasel kernel: [ 240.457673] Pid: 0, comm: swapper/0 Not tainted 3.4.0-rc2-daniel+ #2 Acer Aspire 1420P/JM12-MS Apr 10 20:27:00 weasel kernel: [ 240.457673] EIP: 0060:[<f90a7409>] EFLAGS: 00010002 CPU: 0 Apr 10 20:27:00 weasel kernel: [ 240.457673] EIP is at queue_pending_output_urbs+0x89/0x130 [snd_usb_audio] Apr 10 20:27:00 weasel kernel: [ 240.457673] EAX: 00200200 EBX: edb08000 ECX: edb097ac EDX: edb08028 Apr 10 20:27:00 weasel kernel: [ 240.457673] ESI: edb082c0 EDI: 00100100 EBP: f380be64 ESP: f380be3c Apr 10 20:27:00 weasel kernel: [ 240.457673] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068 Apr 10 20:27:00 weasel kernel: [ 240.457673] CR0: 8005003b CR2: 00100104 CR3: 018af000 CR4: 000407d0 Apr 10 20:27:00 weasel kernel: [ 240.457673] DR0: 00000000 DR1: 00000000 DR2: 00000000 DR3: 00000000 Apr 10 20:27:00 weasel kernel: [ 240.457673] DR6: ffff0ff0 DR7: 00000400 Apr 10 20:27:00 weasel kernel: [ 240.457673] Process swapper/0 (pid: 0, ti=f380a000 task=c1794020 task.ti=c1788000) Apr 10 20:27:00 weasel kernel: [ 240.457673] Stack: Apr 10 20:27:00 weasel kernel: [ 240.457673] f380be44 f380be4c c105dfd2 f380be50 00000096 edb0a9b4 edb0a950 edeb5f08 Apr 10 20:27:00 weasel kernel: [ 240.457673] edb0c2c8 edb097ac f380be94 f90a86bf edb0c2c8 f7007300 f7007300 edeb5e00 Apr 10 20:27:00 weasel kernel: [ 240.457673] 00000092 edb0a9b4 edb08000 edb0c000 edb0c2c8 edeb5e00 f380beb8 f90a882d Apr 10 20:27:00 weasel kernel: [ 240.457673] Call Trace: Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c105dfd2>] ? resched_task+0x22/0x70 Apr 10 20:27:00 weasel kernel: [ 240.457673] [<f90a86bf>] snd_usb_handle_sync_urb+0x1ef/0x260 [snd_usb_audio] Apr 10 20:27:00 weasel kernel: [ 240.457673] [<f90a882d>] snd_complete_urb+0xfd/0x200 [snd_usb_audio] Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c13dec0d>] usb_hcd_giveback_urb+0x4d/0xc0 Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c1551f6d>] ? _raw_spin_lock+0xd/0x10 Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c13f3571>] ehci_urb_done+0xc1/0xf0 Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c13f4afc>] ehci_work+0x8ec/0xa10 Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c13f4ea1>] ehci_irq+0x221/0x250 Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c1080cb3>] ? tick_do_periodic_broadcast+0x33/0x40 Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c13de3b2>] usb_hcd_irq+0x32/0x50
Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c10ad52c>] handle_irq_event_percpu+0x4c/0x210 Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c155219d>] ? _raw_spin_lock_irqsave+0x2d/0x40 Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c10ad72b>] handle_irq_event+0x3b/0x60 Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c10aff20>] ? unmask_irq+0x30/0x30 Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c10aff6e>] handle_fasteoi_irq+0x4e/0xd0 Apr 10 20:27:00 weasel kernel: [ 240.457673] <IRQ> Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c1559432>] ? do_IRQ+0x42/0xc0 Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c10084f8>] ? sched_clock+0x8/0x10 Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c1062e8b>] ? sched_clock_local+0xcb/0x1c0 Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c1559370>] ? common_interrupt+0x30/0x38 Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c10600d8>] ? rt_mutex_setprio+0x98/0x200 Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c131b5d6>] ? arch_local_irq_enable+0x5/0xb Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c131c30f>] ? acpi_idle_enter_bm+0x228/0x268 Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c143b785>] ? cpuidle_enter+0x15/0x20 Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c143bd1c>] ? cpuidle_idle_call+0x9c/0x260 Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c100a10a>] ? cpu_idle+0xaa/0xe0 Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c152e135>] ? rest_init+0x5d/0x68 Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c17f976c>] ? start_kernel+0x367/0x36d Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c17f9186>] ? loglevel+0x2b/0x2b Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c17f9078>] ? i386_start_kernel+0x78/0x7d Apr 10 20:27:00 weasel kernel: [ 240.457673] Code: 00 83 c0 01 8d 8c 13 28 15 00 00 89 c2 c1 fa 1f c1 ea 1d 01 d0 83 e0 07 29 d0 89 83 48 29 00 00 8b 46 04 8d 96 68 fd ff ff 8b 3e <89> 47 04 89 38 c7 06 00 01 10 00 c7 46 04 00 02 20 00 8b 81 80 Apr 10 20:27:00 weasel kernel: [ 240.457673] EIP: [<f90a7409>] queue_pending_output_urbs+0x89/0x130 [snd_usb_audio] SS:ESP 0068:f380be3c Apr 10 20:27:00 weasel kernel: [ 240.457673] CR2: 0000000000100104
After this messageand only ahter this oops I'm getting lots of ACPI errors:
Apr 10 20:27:06 weasel kernel: [ 247.021871] ACPI Exception: AE_TIME, Returned by Handler for [EmbeddedControl] (20120320/evregion-501) Apr 10 20:27:06 weasel kernel: [ 247.024423] ACPI Error: Method parse/execution failed [_SB_.BAT1._BST] (Node f382b2d0), AE_TIME (20120320/psparse-536) Apr 10 20:27:06 weasel kernel: [ 247.025805] ACPI Exception: AE_TIME, Evaluating _BST (20120320/battery-455) Apr 10 20:27:07 weasel kernel: [ 248.178058] ACPI Exception: AE_TIME, Returned by Handler for [EmbeddedControl] (20120320/evregion-501) Apr 10 20:27:07 weasel kernel: [ 248.180657] ACPI Error: Method parse/execution failed [_SB_.BAT1._BST] (Node f382b2d0), AE_TIME (20120320/psparse-536) Apr 10 20:27:07 weasel kernel: [ 248.182039] ACPI Exception: AE_TIME, Evaluating _BST (20120320/battery-455)
Any ideas?
Regards,
Felix
Hi,
On 10.04.2012 20:52, Felix Homann wrote:
this time I can get the device to work. It produces clickless playback at higher latencies. But trying to run JACK @44.1kHz with 128 frames/period (i.e. -p 128) I can reliably reproduce a kernel oops which either completely freezes my system or at least blocks keyboard an mouse. Here it is:
Good catch, thanks! I was able to trigger that one too, and fixed it. Just refreshed my tree and the combined patch (gist). Could you give it another shot?
Thanks, Daniel
Apr 10 20:25:43 weasel kernel: [ 164.243214] usbcore: registered new interface driver snd-usb-audio Apr 10 20:27:00 weasel kernel: [ 240.453704] BUG: unable to handle kernel paging request at 00100104 Apr 10 20:27:00 weasel kernel: [ 240.457673] IP: [<f90a7409>] queue_pending_output_urbs+0x89/0x130 [snd_usb_audio] Apr 10 20:27:00 weasel kernel: [ 240.457673] *pde = 00000000 Apr 10 20:27:00 weasel kernel: [ 240.457673] Oops: 0002 [#1] SMP Apr 10 20:27:00 weasel kernel: [ 240.457673] Modules linked in: snd_usb_audio snd_usbmidi_lib snd_seq_dummy rfcomm bnep parport_pc dm_crypt ppdev binfmt_misc snd_hda_c odec_hdmi snd_hda_codec_realtek snd_hda_intel snd_hda_codec snd_hwdep snd_pcm snd_seq_midi snd_rawmidi snd_seq_midi_event snd_seq joydev coretemp snd_timer snd_seq_devi ce uvcvideo hid_multitouch videobuf2_core snd microcode videodev videobuf2_vmalloc videobuf2_memops btusb soundcore bluetooth snd_page_alloc psmouse serio_raw lp parpor t usbhid hid atl1c ahci libahci i915 drm_kms_helper drm wmi i2c_algo_bit video Apr 10 20:27:00 weasel kernel: [ 240.457673] Apr 10 20:27:00 weasel kernel: [ 240.457673] Pid: 0, comm: swapper/0 Not tainted 3.4.0-rc2-daniel+ #2 Acer Aspire 1420P/JM12-MS Apr 10 20:27:00 weasel kernel: [ 240.457673] EIP: 0060:[<f90a7409>] EFLAGS: 00010002 CPU: 0 Apr 10 20:27:00 weasel kernel: [ 240.457673] EIP is at queue_pending_output_urbs+0x89/0x130 [snd_usb_audio] Apr 10 20:27:00 weasel kernel: [ 240.457673] EAX: 00200200 EBX: edb08000 ECX: edb097ac EDX: edb08028 Apr 10 20:27:00 weasel kernel: [ 240.457673] ESI: edb082c0 EDI: 00100100 EBP: f380be64 ESP: f380be3c Apr 10 20:27:00 weasel kernel: [ 240.457673] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068 Apr 10 20:27:00 weasel kernel: [ 240.457673] CR0: 8005003b CR2: 00100104 CR3: 018af000 CR4: 000407d0 Apr 10 20:27:00 weasel kernel: [ 240.457673] DR0: 00000000 DR1: 00000000 DR2: 00000000 DR3: 00000000 Apr 10 20:27:00 weasel kernel: [ 240.457673] DR6: ffff0ff0 DR7: 00000400 Apr 10 20:27:00 weasel kernel: [ 240.457673] Process swapper/0 (pid: 0, ti=f380a000 task=c1794020 task.ti=c1788000) Apr 10 20:27:00 weasel kernel: [ 240.457673] Stack: Apr 10 20:27:00 weasel kernel: [ 240.457673] f380be44 f380be4c c105dfd2 f380be50 00000096 edb0a9b4 edb0a950 edeb5f08 Apr 10 20:27:00 weasel kernel: [ 240.457673] edb0c2c8 edb097ac f380be94 f90a86bf edb0c2c8 f7007300 f7007300 edeb5e00 Apr 10 20:27:00 weasel kernel: [ 240.457673] 00000092 edb0a9b4 edb08000 edb0c000 edb0c2c8 edeb5e00 f380beb8 f90a882d Apr 10 20:27:00 weasel kernel: [ 240.457673] Call Trace: Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c105dfd2>] ? resched_task+0x22/0x70 Apr 10 20:27:00 weasel kernel: [ 240.457673] [<f90a86bf>] snd_usb_handle_sync_urb+0x1ef/0x260 [snd_usb_audio] Apr 10 20:27:00 weasel kernel: [ 240.457673] [<f90a882d>] snd_complete_urb+0xfd/0x200 [snd_usb_audio] Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c13dec0d>] usb_hcd_giveback_urb+0x4d/0xc0 Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c1551f6d>] ? _raw_spin_lock+0xd/0x10 Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c13f3571>] ehci_urb_done+0xc1/0xf0 Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c13f4afc>] ehci_work+0x8ec/0xa10 Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c13f4ea1>] ehci_irq+0x221/0x250 Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c1080cb3>] ? tick_do_periodic_broadcast+0x33/0x40 Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c13de3b2>] usb_hcd_irq+0x32/0x50
Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c10ad52c>] handle_irq_event_percpu+0x4c/0x210 Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c155219d>] ? _raw_spin_lock_irqsave+0x2d/0x40 Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c10ad72b>] handle_irq_event+0x3b/0x60 Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c10aff20>] ? unmask_irq+0x30/0x30 Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c10aff6e>] handle_fasteoi_irq+0x4e/0xd0 Apr 10 20:27:00 weasel kernel: [ 240.457673] <IRQ> Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c1559432>] ? do_IRQ+0x42/0xc0 Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c10084f8>] ? sched_clock+0x8/0x10 Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c1062e8b>] ? sched_clock_local+0xcb/0x1c0 Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c1559370>] ? common_interrupt+0x30/0x38 Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c10600d8>] ? rt_mutex_setprio+0x98/0x200 Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c131b5d6>] ? arch_local_irq_enable+0x5/0xb Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c131c30f>] ? acpi_idle_enter_bm+0x228/0x268 Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c143b785>] ? cpuidle_enter+0x15/0x20 Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c143bd1c>] ? cpuidle_idle_call+0x9c/0x260 Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c100a10a>] ? cpu_idle+0xaa/0xe0 Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c152e135>] ? rest_init+0x5d/0x68 Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c17f976c>] ? start_kernel+0x367/0x36d Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c17f9186>] ? loglevel+0x2b/0x2b Apr 10 20:27:00 weasel kernel: [ 240.457673] [<c17f9078>] ? i386_start_kernel+0x78/0x7d Apr 10 20:27:00 weasel kernel: [ 240.457673] Code: 00 83 c0 01 8d 8c 13 28 15 00 00 89 c2 c1 fa 1f c1 ea 1d 01 d0 83 e0 07 29 d0 89 83 48 29 00 00 8b 46 04 8d 96 68 fd ff ff 8b 3e <89> 47 04 89 38 c7 06 00 01 10 00 c7 46 04 00 02 20 00 8b 81 80 Apr 10 20:27:00 weasel kernel: [ 240.457673] EIP: [<f90a7409>] queue_pending_output_urbs+0x89/0x130 [snd_usb_audio] SS:ESP 0068:f380be3c Apr 10 20:27:00 weasel kernel: [ 240.457673] CR2: 0000000000100104
After this messageand only ahter this oops I'm getting lots of ACPI errors:
Apr 10 20:27:06 weasel kernel: [ 247.021871] ACPI Exception: AE_TIME, Returned by Handler for [EmbeddedControl] (20120320/evregion-501) Apr 10 20:27:06 weasel kernel: [ 247.024423] ACPI Error: Method parse/execution failed [_SB_.BAT1._BST] (Node f382b2d0), AE_TIME (20120320/psparse-536) Apr 10 20:27:06 weasel kernel: [ 247.025805] ACPI Exception: AE_TIME, Evaluating _BST (20120320/battery-455) Apr 10 20:27:07 weasel kernel: [ 248.178058] ACPI Exception: AE_TIME, Returned by Handler for [EmbeddedControl] (20120320/evregion-501) Apr 10 20:27:07 weasel kernel: [ 248.180657] ACPI Error: Method parse/execution failed [_SB_.BAT1._BST] (Node f382b2d0), AE_TIME (20120320/psparse-536) Apr 10 20:27:07 weasel kernel: [ 248.182039] ACPI Exception: AE_TIME, Evaluating _BST (20120320/battery-455)
Any ideas?
Regards,
Felix
Hi,
2012/4/11 Daniel Mack zonque@gmail.com:
Just refreshed my tree and the combined patch (gist). Could you give it another shot?
I've just tested the new version and have not found any issues. Great work! Thank you very much!
BTW, didn't you have a patch for switching to an external clock source on the FTUs? Maybe it would be useful for me to clean up the dirty hack I've got somewhere for the effects controls. (Don't hurry, it will take me a couple of weeks anyway due to time constraints)
Regards,
Felix
On 12.04.2012 11:05, Felix Homann wrote:
Hi,
2012/4/11 Daniel Mack zonque@gmail.com:
Just refreshed my tree and the combined patch (gist). Could you give it another shot?
I've just tested the new version and have not found any issues. Great work! Thank you very much!
Good news indeed. As Grant is also signalling green light, I'll post version 7 of the patch series now.
BTW, didn't you have a patch for switching to an external clock source on the FTUs? Maybe it would be useful for me to clean up the dirty hack I've got somewhere for the effects controls. (Don't hurry, it will take me a couple of weeks anyway due to time constraints)
Can't find it right now. But that should be comparatively easy to do in a subsequent patch.
Thanks, Daniel
On Mon, Jan 2, 2012 at 4:09 AM, Felix Homann linuxaudio@showlabor.dewrote:
Happy New Year!
That being said, I've tested a kernel without Daniel's patch set. It doesn't work either. The error messages are only slightly different:
Jan 1 11:52:31 weasel mtp-probe: checking bus 1, device 4: "/sys/devices/pci0000:00/0000:00:1a.7/usb1/1-1" Jan 1 11:52:31 weasel mtp-probe: bus: 1, device: 4 was not an MTP device Jan 1 11:52:31 weasel kernel: [ 161.880773] usbcore: registered new interface driver snd-usb-audio Jan 1 11:52:34 weasel kernel: [ 164.284980] cannot submit datapipe for urb 0, error -28: not enough bandwidth
So, It's not related to Daniel's rework. But nevertheless, something's broken...
are you sure it's connected to an EHCI (usb2) controller?
Grant.
participants (3)
-
Daniel Mack -
Felix Homann -
Grant Diffey