You are not logged in.
- Topics: Active | Unanswered
#1 2013-06-12 13:04:26
- NIRz
- Member
- Registered: 2008-05-09
- Posts: 24
snd_ctxfi failed to unload properly on suspend
I'm having a problem with my sound card when suspending the system to RAM.
The sound card is Creative Labs X-Fi XtremeMusic (PCI) using snd_ctxfi module, also using PulseAudio.
The problem is, whether I suspend using the kernel/systemd framework or using s2ram, everything is suspending as it should and also resuming, except that I have no sound.
Relevant information:
inxi -F:
System: Host: linux Kernel: 3.9.5-1-ck x86_64 (64 bit) Desktop: Awesome 3.5.1 Distro: Arch Linux
Machine: Mobo: Gigabyte model: PH67-UD3-B3 version: x.x Bios: Award version: F8 date: 03/21/2012
CPU: Quad core Intel Core i5-2500 CPU (-MCP-) cache: 6144 KB flags: (lm nx sse sse2 sse3 sse4_1 sse4_2 ssse3 vmx)
Clock Speeds: 1: 3531.00 MHz 2: 3399.00 MHz 3: 3399.00 MHz 4: 1650.00 MHz
Graphics: Card: NVIDIA GF114 [GeForce GTX 560 Ti] X.org: 1.14.1 driver: nvidia tty size: 232x62 Advanced Data: N/A for root
Audio: Card-1: NVIDIA GF114 HDMI Audio Controller Sound: ALSA ver: k3.9.5-1-ck
Card-2: Creative Labs SB X-Fi driver: snd_ctxfi
Card-3: Logitech HD Webcam C510 driver: USB Audio
Network: Card: Realtek RTL8111/8168 PCI Express Gigabit Ethernet controller driver: r8169
IF: eth0 state: up speed: 1000 Mbps duplex: full mac: 1c:6f:65:ab:fd:15
Drives: HDD Total Size: 1640.3GB (73.8% used) 1: id: /dev/sdb model: WDC_WD6400AAKS size: 640.1GB
2: id: /dev/sda model: WDC_WD1002FAEX size: 1000.2GB
Partition: ID: / size: 47G used: 31G (70%) fs: ext4
Sensors: System Temperatures: cpu: 34.0C mobo: 25.0C gpu: 44C
Fan Speeds (in rpm): cpu: 1834 fan-2: 0 fan-3: 0 fan-4: 0
Info: Processes: 143 Uptime: 26 min Memory: 1017.4/16013.2MB Client: Shell (zsh) inxi: 1.9.7 lsmod:
Module Size Used by
sg 25434 0
fuse 70505 11
joydev 9695 0
hid_generic 1153 0
snd_usb_audio 112441 0
uvcvideo 71769 0
videobuf2_vmalloc 3304 1 uvcvideo
videobuf2_memops 2143 1 videobuf2_vmalloc
videobuf2_core 26453 1 uvcvideo
usbhid 40956 0
snd_usbmidi_lib 18931 1 snd_usb_audio
videodev 102297 2 uvcvideo,videobuf2_core
snd_hwdep 6300 1 snd_usb_audio
snd_rawmidi 18582 1 snd_usbmidi_lib
hid 87411 2 hid_generic,usbhid
snd_seq_device 5180 1 snd_rawmidi
media 10309 2 uvcvideo,videodev
intel_powerclamp 8738 0
kvm_intel 125381 0
kvm 388216 1 kvm_intel
crc32_pclmul 2987 0
crc32c_intel 14249 0
ghash_clmulni_intel 4469 0
aesni_intel 45417 0
aes_x86_64 7399 1 aesni_intel
xts 3007 1 aesni_intel
lrw 3565 1 aesni_intel
gf128mul 6018 2 lrw,xts
ablk_helper 1972 1 aesni_intel
cryptd 8537 3 ghash_clmulni_intel,aesni_intel,ablk_helper
nvidia 9379389 41
iTCO_wdt 5407 0
gpio_ich 4536 0
iTCO_vendor_support 1929 1 iTCO_wdt
evdev 9912 8
sr_mod 14770 0
snd_ctxfi 95560 0
cdrom 34784 1 sr_mod
snd_pcm 75452 2 snd_usb_audio,snd_ctxfi
snd_page_alloc 7298 2 snd_ctxfi,snd_pcm
snd_timer 18527 1 snd_pcm
snd 58765 8 snd_usb_audio,snd_ctxfi,snd_hwdep,snd_timer,snd_pcm,snd_rawmidi,snd_usbmidi_lib,snd_seq_device
ehci_pci 4120 0
soundcore 5418 1 snd
ehci_hcd 46479 1 ehci_pci
drm 228742 2 nvidia
shpchp 25649 0
microcode 13204 0
i2c_i801 11269 0
r8169 55879 0
serio_raw 5041 0
pci_hotplug 22642 1 shpchp
lpc_ich 12849 0
mii 4059 1 r8169
usbcore 176867 6 snd_usb_audio,uvcvideo,snd_usbmidi_lib,ehci_hcd,ehci_pci,usbhid
i2c_core 22351 4 drm,i2c_i801,nvidia,videodev
mei 57982 0
usb_common 954 1 usbcore
mperf 1235 0
button 4669 0
processor 27555 0
it87 28791 0
hwmon_vid 3260 1 it87
coretemp 6102 0
nfs 144007 0
lockd 75173 1 nfs
sunrpc 219800 2 nfs,lockd
fscache 58286 1 nfs
uvesafb 21873 1
ext4 485284 1
crc16 1359 1 ext4
mbcache 5930 1 ext4
jbd2 85048 1 ext4
sd_mod 30762 7
ata_piix 24888 0
ahci 22696 6
libahci 21201 1 ahci
libata 167729 3 ahci,libahci,ata_piix
scsi_mod 129340 4 sg,libata,sd_mod,sr_mod/etc/pm/config.d/modules:
SUSPEND_MODULES="snd_ctxfi"
SLEEP_MODULE="uswsusp"Note: I also tried without the SUSPEND_MODULES parameter and tried also using kernel backend in SLEEP_MODULE according to the pm-utils wiki.
pm-suspend.log: (using the above /etc/pm/config.d/modules)
Initial commandline parameters:
Wed Jun 12 14:52:13 IDT 2013: Running hooks for suspend.
Running hook /usr/lib/pm-utils/sleep.d/00logging suspend suspend:
Linux linux 3.9.5-1-ck #1 SMP PREEMPT Fri Jun 7 20:01:34 EDT 2013 x86_64 GNU/Linux
Module Size Used by
sg 25434 0
fuse 70505 11
joydev 9695 0
hid_generic 1153 0
snd_usb_audio 112441 0
uvcvideo 71769 0
videobuf2_vmalloc 3304 1 uvcvideo
videobuf2_memops 2143 1 videobuf2_vmalloc
videobuf2_core 26453 1 uvcvideo
usbhid 40956 0
snd_usbmidi_lib 18931 1 snd_usb_audio
videodev 102297 2 uvcvideo,videobuf2_core
snd_hwdep 6300 1 snd_usb_audio
snd_rawmidi 18582 1 snd_usbmidi_lib
hid 87411 2 hid_generic,usbhid
snd_seq_device 5180 1 snd_rawmidi
media 10309 2 uvcvideo,videodev
intel_powerclamp 8738 0
kvm_intel 125381 0
kvm 388216 1 kvm_intel
crc32_pclmul 2987 0
crc32c_intel 14249 0
ghash_clmulni_intel 4469 0
aesni_intel 45417 0
aes_x86_64 7399 1 aesni_intel
xts 3007 1 aesni_intel
lrw 3565 1 aesni_intel
gf128mul 6018 2 lrw,xts
ablk_helper 1972 1 aesni_intel
cryptd 8537 3 ghash_clmulni_intel,aesni_intel,ablk_helper
nvidia 9379389 41
iTCO_wdt 5407 0
gpio_ich 4536 0
iTCO_vendor_support 1929 1 iTCO_wdt
evdev 9912 8
sr_mod 14770 0
snd_ctxfi 95560 1
cdrom 34784 1 sr_mod
snd_pcm 75452 2 snd_usb_audio,snd_ctxfi
snd_page_alloc 7298 2 snd_ctxfi,snd_pcm
snd_timer 18527 1 snd_pcm
snd 58765 10 snd_usb_audio,snd_ctxfi,snd_hwdep,snd_timer,snd_pcm,snd_rawmidi,snd_usbmidi_lib,snd_seq_device
ehci_pci 4120 0
soundcore 5418 1 snd
ehci_hcd 46479 1 ehci_pci
drm 228742 2 nvidia
shpchp 25649 0
microcode 13204 0
i2c_i801 11269 0
r8169 55879 0
serio_raw 5041 0
pci_hotplug 22642 1 shpchp
lpc_ich 12849 0
mii 4059 1 r8169
usbcore 176867 6 snd_usb_audio,uvcvideo,snd_usbmidi_lib,ehci_hcd,ehci_pci,usbhid
i2c_core 22351 4 drm,i2c_i801,nvidia,videodev
mei 57982 0
usb_common 954 1 usbcore
mperf 1235 0
button 4669 0
processor 27555 0
it87 28791 0
hwmon_vid 3260 1 it87
coretemp 6102 0
nfs 144007 0
lockd 75173 1 nfs
sunrpc 219800 2 nfs,lockd
fscache 58286 1 nfs
uvesafb 21873 1
ext4 485284 1
crc16 1359 1 ext4
mbcache 5930 1 ext4
jbd2 85048 1 ext4
sd_mod 30762 7
ata_piix 24888 0
ahci 22696 6
libahci 21201 1 ahci
libata 167729 3 ahci,libahci,ata_piix
scsi_mod 129340 4 sg,libata,sd_mod,sr_mod
total used free shared buffers cached
Mem: 16397488 3004516 13392972 0 139604 1777804
-/+ buffers/cache: 1087108 15310380
Swap: 0 0 0
/usr/lib/pm-utils/sleep.d/00logging suspend suspend: success.
Running hook /usr/lib/pm-utils/sleep.d/00powersave suspend suspend:
/usr/lib/pm-utils/sleep.d/00powersave suspend suspend: success.
Running hook /usr/lib/pm-utils/sleep.d/01grub suspend suspend:
/usr/lib/pm-utils/sleep.d/01grub suspend suspend: success.
Running hook /usr/lib/pm-utils/sleep.d/49bluetooth suspend suspend:
/usr/lib/pm-utils/sleep.d/49bluetooth suspend suspend: success.
Running hook /usr/lib/pm-utils/sleep.d/75modules suspend suspend:
Unloading kernel module snd_ctxfi...modprobe: FATAL: Module snd_ctxfi is in use.
/usr/lib/pm-utils/functions: line 89: log: command not found
Failed.
/usr/lib/pm-utils/sleep.d/75modules suspend suspend: success.
Running hook /usr/lib/pm-utils/sleep.d/90clock suspend suspend:
/usr/lib/pm-utils/sleep.d/90clock suspend suspend: success.
Running hook /usr/lib/pm-utils/sleep.d/94cpufreq suspend suspend:
/usr/lib/pm-utils/sleep.d/94cpufreq suspend suspend: success.
Running hook /usr/lib/pm-utils/sleep.d/95led suspend suspend:
/usr/lib/pm-utils/sleep.d/95led suspend suspend: success.
Running hook /usr/lib/pm-utils/sleep.d/95packagekit suspend suspend:
/usr/lib/pm-utils/sleep.d/95packagekit suspend suspend: success.
Running hook /usr/lib/pm-utils/sleep.d/98video-quirk-db-handler suspend suspend:
nVidia binary video drive detected, not using quirks.
/usr/lib/pm-utils/sleep.d/98video-quirk-db-handler suspend suspend: success.
Running hook /usr/lib/pm-utils/sleep.d/99video suspend suspend:
/usr/lib/pm-utils/sleep.d/99video suspend suspend: success.
Wed Jun 12 14:52:13 IDT 2013: performing suspend
switching from vt1 to vt1... succeeded
fbcon fb0 state 1
fbcon fb0 state 0
switching back to vt1... succeeded
Wed Jun 12 14:52:33 IDT 2013: Awake.
Wed Jun 12 14:52:33 IDT 2013: Running hooks for resume
Running hook /usr/lib/pm-utils/sleep.d/99video resume suspend:
/usr/lib/pm-utils/sleep.d/99video resume suspend: success.
Running hook /usr/lib/pm-utils/sleep.d/98video-quirk-db-handler resume suspend:
/usr/lib/pm-utils/sleep.d/98video-quirk-db-handler resume suspend: success.
Running hook /usr/lib/pm-utils/sleep.d/95packagekit resume suspend:
/usr/lib/pm-utils/sleep.d/95packagekit resume suspend: success.
Running hook /usr/lib/pm-utils/sleep.d/95led resume suspend:
/usr/lib/pm-utils/sleep.d/95led resume suspend: success.
Running hook /usr/lib/pm-utils/sleep.d/94cpufreq resume suspend:
/usr/lib/pm-utils/sleep.d/94cpufreq resume suspend: success.
Running hook /usr/lib/pm-utils/sleep.d/90clock resume suspend:
/usr/lib/pm-utils/sleep.d/90clock resume suspend: success.
Running hook /usr/lib/pm-utils/sleep.d/75modules resume suspend:
Reloaded unloaded modules.
/usr/lib/pm-utils/sleep.d/75modules resume suspend: success.
Running hook /usr/lib/pm-utils/sleep.d/49bluetooth resume suspend:
/usr/lib/pm-utils/sleep.d/49bluetooth resume suspend: success.
Running hook /usr/lib/pm-utils/sleep.d/01grub resume suspend:
/usr/lib/pm-utils/sleep.d/01grub resume suspend: success.
Running hook /usr/lib/pm-utils/sleep.d/00powersave resume suspend:
/usr/lib/pm-utils/sleep.d/00powersave resume suspend: success.
Running hook /usr/lib/pm-utils/sleep.d/00logging resume suspend:
/usr/lib/pm-utils/sleep.d/00logging resume suspend: success.
Wed Jun 12 14:52:34 IDT 2013: Finished.journalctl:
Jun 12 14:52:33 linux kernel: Freezing user space processes ... (elapsed 0.01 seconds) done.
Jun 12 14:52:33 linux kernel: Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
Jun 12 14:52:33 linux rtkit-daemon[2582]: The canary thread is apparently starving. Taking action.
Jun 12 14:52:33 linux rtkit-daemon[2582]: Demoting known real-time threads.
Jun 12 14:52:33 linux rtkit-daemon[2582]: Successfully demoted thread 2581 of process 2581 (/usr/bin/pulseaudio).
Jun 12 14:52:33 linux rtkit-daemon[2582]: Demoted 1 threads.
Jun 12 14:52:33 linux kernel: PM: Entering mem sleep
Jun 12 14:52:33 linux kernel: Suspending console(s) (use no_console_suspend to debug)
Jun 12 14:52:33 linux systemd[1]: Time has been changed
Jun 12 14:52:33 linux kernel: sd 1:0:0:0: [sdb] Synchronizing SCSI cache
Jun 12 14:52:33 linux kernel: sd 0:0:0:0: [sda] Synchronizing SCSI cache
Jun 12 14:52:33 linux kernel: sd 0:0:0:0: [sda] Stopping disk
Jun 12 14:52:33 linux kernel: serial 00:06: disabled
Jun 12 14:52:33 linux kernel: serial 00:06: System wakeup disabled by ACPI
Jun 12 14:52:33 linux kernel: sd 1:0:0:0: [sdb] Stopping disk
Jun 12 14:52:33 linux kernel: mei 0000:00:16.0: suspend
Jun 12 14:52:33 linux kernel: PM: suspend of devices complete after 1056.770 msecs
Jun 12 14:52:33 linux kernel: PM: late suspend of devices complete after 0.206 msecs
Jun 12 14:52:33 linux kernel: pcieport 0000:00:1c.2: System wakeup enabled by ACPI
Jun 12 14:52:33 linux kernel: ehci-pci 0000:00:1d.0: System wakeup enabled by ACPI
Jun 12 14:52:33 linux kernel: ehci-pci 0000:00:1a.0: System wakeup enabled by ACPI
Jun 12 14:52:33 linux kernel: PM: noirq suspend of devices complete after 43.769 msecs
Jun 12 14:52:33 linux kernel: ACPI: Preparing to enter system sleep state S3
Jun 12 14:52:33 linux kernel: PM: Saving platform NVS memory
Jun 12 14:52:33 linux kernel: Disabling non-boot CPUs ...
Jun 12 14:52:33 linux kernel: smpboot: CPU 1 is now offline
Jun 12 14:52:33 linux kernel: smpboot: CPU 2 is now offline
Jun 12 14:52:33 linux kernel: smpboot: CPU 3 is now offline
Jun 12 14:52:33 linux kernel: ACPI: Low-level resume complete
Jun 12 14:52:33 linux kernel: PM: Restoring platform NVS memory
Jun 12 14:52:33 linux kernel: Enabling non-boot CPUs ...
Jun 12 14:52:33 linux kernel: smpboot: Booting Node 0 Processor 1 APIC 0x2
Jun 12 14:52:33 linux kernel: Intel pstate controlling: cpu 1
Jun 12 14:52:33 linux kernel: CPU1 is up
Jun 12 14:52:33 linux kernel: smpboot: Booting Node 0 Processor 2 APIC 0x4
Jun 12 14:52:33 linux kernel: Intel pstate controlling: cpu 2
Jun 12 14:52:33 linux kernel: CPU2 is up
Jun 12 14:52:33 linux kernel: smpboot: Booting Node 0 Processor 3 APIC 0x6
Jun 12 14:52:33 linux kernel: Intel pstate controlling: cpu 3
Jun 12 14:52:33 linux kernel: CPU3 is up
Jun 12 14:52:33 linux kernel: ACPI: Waking up from system sleep state S3
Jun 12 14:52:33 linux kernel: ehci-pci 0000:00:1a.0: System wakeup disabled by ACPI
Jun 12 14:52:33 linux kernel: ehci-pci 0000:00:1d.0: System wakeup disabled by ACPI
Jun 12 14:52:33 linux kernel: snd_ctxfi 0000:05:00.0: Refused to change power state, currently in D3
Jun 12 14:52:33 linux kernel: PM: noirq resume of devices complete after 125.992 msecs
Jun 12 14:52:33 linux kernel: PM: early resume of devices complete after 0.092 msecs
Jun 12 14:52:33 linux kernel: pci 0000:00:1e.0: setting latency timer to 64
Jun 12 14:52:33 linux kernel: ahci 0000:00:1f.2: setting latency timer to 64
Jun 12 14:52:33 linux kernel: pcieport 0000:00:1c.2: System wakeup disabled by ACPI
Jun 12 14:52:33 linux kernel: ehci-pci 0000:00:1a.0: setting latency timer to 64
Jun 12 14:52:33 linux kernel: usb usb1: root hub lost power or was reset
Jun 12 14:52:33 linux kernel: ehci-pci 0000:00:1d.0: setting latency timer to 64
Jun 12 14:52:33 linux kernel: usb usb2: root hub lost power or was reset
Jun 12 14:52:33 linux kernel: mei 0000:00:16.0: irq 42 for MSI/MSI-X
Jun 12 14:52:33 linux kernel: ehci-pci 0000:00:1a.0: cache line size of 4 is not supported
Jun 12 14:52:33 linux kernel: ehci-pci 0000:00:1d.0: cache line size of 4 is not supported
Jun 12 14:52:33 linux kernel: serial 00:06: activated
Jun 12 14:52:33 linux kernel: snd_ctxfi 0000:05:00.0: enabling device (0000 -> 0003)
Jun 12 14:52:33 linux kernel: snd_ctxfi 0000:05:00.0: setting latency timer to 64
Jun 12 14:52:33 linux kernel: r8169 0000:03:00.0 eth0: link down
Jun 12 14:52:33 linux kernel: PLL initialization failed!!!
Jun 12 14:52:33 linux kernel: ctxfi: pci_enable_device failed, disabling device
Jun 12 14:52:33 linux kernel: dpm_run_callback(): pci_pm_resume+0x0/0xb0 returns -16
Jun 12 14:52:33 linux kernel: PM: Device 0000:05:00.0 failed to resume async: error -16
Jun 12 14:52:33 linux kernel: usb 1-1: reset high-speed USB device number 2 using ehci-pci
Jun 12 14:52:33 linux kernel: ata5: SATA link down (SStatus 0 SControl 300)
Jun 12 14:52:33 linux kernel: ata3: SATA link down (SStatus 0 SControl 300)
Jun 12 14:52:33 linux kernel: ata6: SATA link down (SStatus 0 SControl 300)
Jun 12 14:52:33 linux kernel: ata4: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
Jun 12 14:52:33 linux kernel: ata4.00: configured for UDMA/100
Jun 12 14:52:33 linux kernel: usb 2-1: reset high-speed USB device number 2 using ehci-pci
Jun 12 14:52:33 linux kernel: usb 1-1.4: reset high-speed USB device number 3 using ehci-pci
Jun 12 14:52:33 linux kernel: usb 1-1.5: reset high-speed USB device number 4 using ehci-pci
Jun 12 14:52:33 linux kernel: usb 2-1.1: reset full-speed USB device number 3 using ehci-pci
Jun 12 14:52:33 linux kernel: snd-usb-audio 1-1.5:1.0: no reset_resume for driver snd-usb-audio?
Jun 12 14:52:33 linux kernel: snd-usb-audio 1-1.5:1.1: no reset_resume for driver snd-usb-audio?
Jun 12 14:52:33 linux kernel: r8169 0000:03:00.0 eth0: link up
Jun 12 14:52:33 linux kernel: ata1: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
Jun 12 14:52:33 linux kernel: ata1.00: configured for UDMA/133
Jun 12 14:52:33 linux kernel: sd 0:0:0:0: [sda] Starting disk
Jun 12 14:52:33 linux kernel: ata2: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
Jun 12 14:52:33 linux kernel: ata2.00: configured for UDMA/133
Jun 12 14:52:33 linux kernel: sd 1:0:0:0: [sdb] Starting disk
Jun 12 14:52:33 linux kernel: PM: resume of devices complete after 7710.951 msecs
Jun 12 14:52:33 linux kernel: set resolution quirk: cval->res = 384
Jun 12 14:52:33 linux kernel: PM: Finishing wakeup.
Jun 12 14:52:33 linux kernel: Restarting tasks ... done.Now after the machine resumes, snd_ctxfi is loaded according to lsmod, but the card doesn't show up on alsamixer and I have no sound.
So I tried:
pulseaudio -k # it is configured to NOT auto restart (verified with ps)
sudo modprobe -r snd_ctxfi # unloaded according to lsmod
sudo pm-suspendNothing is using the card right now, everything is closed except urxvt and now I get this:
pm-suspend.log:
Wed Jun 12 15:22:46 IDT 2013: Running hooks for suspend.
Running hook /usr/lib/pm-utils/sleep.d/00logging suspend suspend:
Linux linux 3.9.5-1-ck #1 SMP PREEMPT Fri Jun 7 20:01:34 EDT 2013 x86_64 GNU/Linux
Module Size Used by
fuse 70505 11
joydev 9695 0
hid_generic 1153 0
snd_usb_audio 112441 0
uvcvideo 71769 0
videobuf2_vmalloc 3304 1 uvcvideo
videobuf2_memops 2143 1 videobuf2_vmalloc
videobuf2_core 26453 1 uvcvideo
snd_usbmidi_lib 18931 1 snd_usb_audio
snd_hwdep 6300 1 snd_usb_audio
videodev 102297 2 uvcvideo,videobuf2_core
snd_rawmidi 18582 1 snd_usbmidi_lib
usbhid 40956 0
hid 87411 2 hid_generic,usbhid
snd_seq_device 5180 1 snd_rawmidi
media 10309 2 uvcvideo,videodev
intel_powerclamp 8738 0
kvm_intel 125381 0
kvm 388216 1 kvm_intel
crc32_pclmul 2987 0
crc32c_intel 14249 0
ghash_clmulni_intel 4469 0
aesni_intel 45417 0
aes_x86_64 7399 1 aesni_intel
xts 3007 1 aesni_intel
lrw 3565 1 aesni_intel
gf128mul 6018 2 lrw,xts
ablk_helper 1972 1 aesni_intel
cryptd 8537 3 ghash_clmulni_intel,aesni_intel,ablk_helper
snd_pcm 75452 1 snd_usb_audio
snd_page_alloc 7298 1 snd_pcm
snd_timer 18527 1 snd_pcm
snd 58765 7 snd_usb_audio,snd_hwdep,snd_timer,snd_pcm,snd_rawmidi,snd_usbmidi_lib,snd_seq_device
soundcore 5418 1 snd
iTCO_wdt 5407 0
gpio_ich 4536 0
iTCO_vendor_support 1929 1 iTCO_wdt
nvidia 9379389 41
evdev 9912 8
microcode 13204 0
sr_mod 14770 0
cdrom 34784 1 sr_mod
serio_raw 5041 0
i2c_i801 11269 0
ehci_pci 4120 0
ehci_hcd 46479 1 ehci_pci
shpchp 25649 0
lpc_ich 12849 0
pci_hotplug 22642 1 shpchp
drm 228742 2 nvidia
r8169 55879 0
usbcore 176867 6 snd_usb_audio,uvcvideo,snd_usbmidi_lib,ehci_hcd,ehci_pci,usbhid
mii 4059 1 r8169
i2c_core 22351 4 drm,i2c_i801,nvidia,videodev
mei 57982 0
usb_common 954 1 usbcore
mperf 1235 0
button 4669 0
processor 27555 0
it87 28791 0
hwmon_vid 3260 1 it87
coretemp 6102 0
nfs 144007 0
lockd 75173 1 nfs
sunrpc 219800 2 nfs,lockd
fscache 58286 1 nfs
uvesafb 21873 1
ext4 485284 1
crc16 1359 1 ext4
mbcache 5930 1 ext4
jbd2 85048 1 ext4
sd_mod 30762 7
ata_piix 24888 0
ahci 22696 6
libahci 21201 1 ahci
libata 167729 3 ahci,libahci,ata_piix
scsi_mod 129340 3 libata,sd_mod,sr_mod
total used free shared buffers cached
Mem: 16397488 2317716 14079772 0 129136 1636884
-/+ buffers/cache: 551696 15845792
Swap: 0 0 0
/usr/lib/pm-utils/sleep.d/00logging suspend suspend: success.
Running hook /usr/lib/pm-utils/sleep.d/00powersave suspend suspend:
/usr/lib/pm-utils/sleep.d/00powersave suspend suspend: success.
Running hook /usr/lib/pm-utils/sleep.d/01grub suspend suspend:
/usr/lib/pm-utils/sleep.d/01grub suspend suspend: success.
Running hook /usr/lib/pm-utils/sleep.d/49bluetooth suspend suspend:
/usr/lib/pm-utils/sleep.d/49bluetooth suspend suspend: success.
Running hook /usr/lib/pm-utils/sleep.d/75modules suspend suspend:
Unloading kernel module snd_ctxfi...Done.
/usr/lib/pm-utils/sleep.d/75modules suspend suspend: success.
Running hook /usr/lib/pm-utils/sleep.d/90clock suspend suspend:
/usr/lib/pm-utils/sleep.d/90clock suspend suspend: success.
Running hook /usr/lib/pm-utils/sleep.d/94cpufreq suspend suspend:
/usr/lib/pm-utils/sleep.d/94cpufreq suspend suspend: success.
Running hook /usr/lib/pm-utils/sleep.d/95led suspend suspend:
/usr/lib/pm-utils/sleep.d/95led suspend suspend: success.
Running hook /usr/lib/pm-utils/sleep.d/95packagekit suspend suspend:
/usr/lib/pm-utils/sleep.d/95packagekit suspend suspend: success.
Running hook /usr/lib/pm-utils/sleep.d/98video-quirk-db-handler suspend suspend:
nVidia binary video drive detected, not using quirks.
/usr/lib/pm-utils/sleep.d/98video-quirk-db-handler suspend suspend: success.
Running hook /usr/lib/pm-utils/sleep.d/99video suspend suspend:
kernel.acpi_video_flags = 0
/usr/lib/pm-utils/sleep.d/99video suspend suspend: success.
Wed Jun 12 15:22:47 IDT 2013: performing suspend
Wed Jun 12 15:23:09 IDT 2013: Awake.
Wed Jun 12 15:23:09 IDT 2013: Running hooks for resume
Running hook /usr/lib/pm-utils/sleep.d/99video resume suspend:
/usr/lib/pm-utils/sleep.d/99video resume suspend: success.
Running hook /usr/lib/pm-utils/sleep.d/98video-quirk-db-handler resume suspend:
/usr/lib/pm-utils/sleep.d/98video-quirk-db-handler resume suspend: success.
Running hook /usr/lib/pm-utils/sleep.d/95packagekit resume suspend:
/usr/lib/pm-utils/sleep.d/95packagekit resume suspend: success.
Running hook /usr/lib/pm-utils/sleep.d/95led resume suspend:
/usr/lib/pm-utils/sleep.d/95led resume suspend: success.
Running hook /usr/lib/pm-utils/sleep.d/94cpufreq resume suspend:
/usr/lib/pm-utils/sleep.d/94cpufreq resume suspend: success.
Running hook /usr/lib/pm-utils/sleep.d/90clock resume suspend:
/usr/lib/pm-utils/sleep.d/90clock resume suspend: success.
Running hook /usr/lib/pm-utils/sleep.d/75modules resume suspend:
Reloaded unloaded modules.
/usr/lib/pm-utils/sleep.d/75modules resume suspend: success.
Running hook /usr/lib/pm-utils/sleep.d/49bluetooth resume suspend:
/usr/lib/pm-utils/sleep.d/49bluetooth resume suspend: success.
Running hook /usr/lib/pm-utils/sleep.d/01grub resume suspend:
/usr/lib/pm-utils/sleep.d/01grub resume suspend: success.
Running hook /usr/lib/pm-utils/sleep.d/00powersave resume suspend:
/usr/lib/pm-utils/sleep.d/00powersave resume suspend: success.
Running hook /usr/lib/pm-utils/sleep.d/00logging resume suspend:
/usr/lib/pm-utils/sleep.d/00logging resume suspend: success.
Wed Jun 12 15:23:10 IDT 2013: Finished.journalctl: (notice the part when I "modprobe snd_ctxfi")
Jun 12 15:23:09 linux kernel: PM: Entering mem sleep
Jun 12 15:23:09 linux kernel: Suspending console(s) (use no_console_suspend to debug)
Jun 12 15:23:09 linux kernel: sd 1:0:0:0: [sdb] Synchronizing SCSI cache
Jun 12 15:23:09 linux kernel: sd 0:0:0:0: [sda] Synchronizing SCSI cache
Jun 12 15:23:09 linux kernel: sd 1:0:0:0: [sdb] Stopping disk
Jun 12 15:23:09 linux kernel: serial 00:06: disabled
Jun 12 15:23:09 linux kernel: serial 00:06: System wakeup disabled by ACPI
Jun 12 15:23:09 linux kernel: mei 0000:00:16.0: suspend
Jun 12 15:23:09 linux kernel: sd 0:0:0:0: [sda] Stopping disk
Jun 12 15:23:09 linux kernel: PM: suspend of devices complete after 1037.769 msecs
Jun 12 15:23:09 linux kernel: PM: late suspend of devices complete after 0.192 msecs
Jun 12 15:23:09 linux kernel: pcieport 0000:00:1c.2: System wakeup enabled by ACPI
Jun 12 15:23:09 linux kernel: ehci-pci 0000:00:1d.0: System wakeup enabled by ACPI
Jun 12 15:23:09 linux kernel: ehci-pci 0000:00:1a.0: System wakeup enabled by ACPI
Jun 12 15:23:09 linux kernel: PM: noirq suspend of devices complete after 43.778 msecs
Jun 12 15:23:09 linux kernel: ACPI: Preparing to enter system sleep state S3
Jun 12 15:23:09 linux kernel: PM: Saving platform NVS memory
Jun 12 15:23:09 linux kernel: Disabling non-boot CPUs ...
Jun 12 15:23:09 linux kernel: smpboot: CPU 1 is now offline
Jun 12 15:23:09 linux kernel: smpboot: CPU 2 is now offline
Jun 12 15:23:09 linux kernel: smpboot: CPU 3 is now offline
Jun 12 15:23:09 linux kernel: ACPI: Low-level resume complete
Jun 12 15:23:09 linux kernel: PM: Restoring platform NVS memory
Jun 12 15:23:09 linux kernel: Enabling non-boot CPUs ...
Jun 12 15:23:09 linux kernel: smpboot: Booting Node 0 Processor 1 APIC 0x2
Jun 12 15:23:09 linux kernel: Intel pstate controlling: cpu 1
Jun 12 15:23:09 linux kernel: CPU1 is up
Jun 12 15:23:09 linux kernel: smpboot: Booting Node 0 Processor 2 APIC 0x4
Jun 12 15:23:09 linux kernel: Intel pstate controlling: cpu 2
Jun 12 15:23:09 linux kernel: CPU2 is up
Jun 12 15:23:09 linux kernel: smpboot: Booting Node 0 Processor 3 APIC 0x6
Jun 12 15:23:09 linux kernel: Intel pstate controlling: cpu 3
Jun 12 15:23:09 linux kernel: CPU3 is up
Jun 12 15:23:09 linux kernel: ACPI: Waking up from system sleep state S3
Jun 12 15:23:09 linux kernel: ehci-pci 0000:00:1a.0: System wakeup disabled by ACPI
Jun 12 15:23:09 linux kernel: ehci-pci 0000:00:1d.0: System wakeup disabled by ACPI
Jun 12 15:23:09 linux kernel: pci 0000:05:00.0: Refused to change power state, currently in D3
Jun 12 15:23:09 linux kernel: PM: noirq resume of devices complete after 115.407 msecs
Jun 12 15:23:09 linux kernel: PM: early resume of devices complete after 0.090 msecs
Jun 12 15:23:09 linux kernel: pci 0000:00:1e.0: setting latency timer to 64
Jun 12 15:23:09 linux kernel: ahci 0000:00:1f.2: setting latency timer to 64
Jun 12 15:23:09 linux kernel: pcieport 0000:00:1c.2: System wakeup disabled by ACPI
Jun 12 15:23:09 linux kernel: ehci-pci 0000:00:1a.0: setting latency timer to 64
Jun 12 15:23:09 linux kernel: usb usb1: root hub lost power or was reset
Jun 12 15:23:09 linux kernel: ehci-pci 0000:00:1d.0: setting latency timer to 64
Jun 12 15:23:09 linux kernel: usb usb2: root hub lost power or was reset
Jun 12 15:23:09 linux kernel: mei 0000:00:16.0: irq 42 for MSI/MSI-X
Jun 12 15:23:09 linux kernel: ehci-pci 0000:00:1a.0: cache line size of 4 is not supported
Jun 12 15:23:09 linux kernel: ehci-pci 0000:00:1d.0: cache line size of 4 is not supported
Jun 12 15:23:09 linux kernel: serial 00:06: activated
Jun 12 15:23:09 linux kernel: r8169 0000:03:00.0 eth0: link down
Jun 12 15:23:09 linux kernel: usb 1-1: reset high-speed USB device number 2 using ehci-pci
Jun 12 15:23:09 linux kernel: ata5: SATA link down (SStatus 0 SControl 300)
Jun 12 15:23:09 linux kernel: ata6: SATA link down (SStatus 0 SControl 300)
Jun 12 15:23:09 linux kernel: ata3: SATA link down (SStatus 0 SControl 300)
Jun 12 15:23:09 linux kernel: ata4: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
Jun 12 15:23:09 linux kernel: ata4.00: configured for UDMA/100
Jun 12 15:23:09 linux kernel: usb 2-1: reset high-speed USB device number 2 using ehci-pci
Jun 12 15:23:09 linux kernel: usb 1-1.4: reset high-speed USB device number 3 using ehci-pci
Jun 12 15:23:09 linux kernel: usb 1-1.5: reset high-speed USB device number 4 using ehci-pci
Jun 12 15:23:09 linux kernel: usb 2-1.1: reset full-speed USB device number 3 using ehci-pci
Jun 12 15:23:09 linux kernel: snd-usb-audio 1-1.5:1.0: no reset_resume for driver snd-usb-audio?
Jun 12 15:23:09 linux kernel: snd-usb-audio 1-1.5:1.1: no reset_resume for driver snd-usb-audio?
Jun 12 15:23:09 linux kernel: r8169 0000:03:00.0 eth0: link up
Jun 12 15:23:09 linux kernel: ata1: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
Jun 12 15:23:09 linux kernel: ata1.00: configured for UDMA/133
Jun 12 15:23:09 linux kernel: sd 0:0:0:0: [sda] Starting disk
Jun 12 15:23:09 linux kernel: ata2: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
Jun 12 15:23:09 linux kernel: ata2.00: configured for UDMA/133
Jun 12 15:23:09 linux kernel: sd 1:0:0:0: [sdb] Starting disk
Jun 12 15:23:09 linux kernel: PM: resume of devices complete after 7714.277 msecs
Jun 12 15:23:09 linux kernel: set resolution quirk: cval->res = 384
Jun 12 15:23:09 linux kernel: PM: Finishing wakeup.
Jun 12 15:23:09 linux kernel: Restarting tasks ... done.
Jun 12 15:23:10 linux dbus-daemon[311]: dbus[311]: [system] Activating service name='org.freedesktop.PackageKit' (using servicehelper)
Jun 12 15:23:10 linux dbus[311]: [system] Activating service name='org.freedesktop.PackageKit' (using servicehelper)
Jun 12 15:23:10 linux dbus-daemon[311]: dbus[311]: [system] Activating via systemd: service name='org.freedesktop.NetworkManager' unit='dbus-org.freedesktop.NetworkManager.service'
Jun 12 15:23:10 linux dbus-daemon[311]: dbus[311]: [system] Activation via systemd failed for unit 'dbus-org.freedesktop.NetworkManager.service': Unit dbus-org.freedesktop.NetworkManager.service failed to load: No such file or directory. See system logs and 'systemctl status dbus-org.freedesktop.NetworkManager.service' for details.
Jun 12 15:23:10 linux dbus[311]: [system] Activating via systemd: service name='org.freedesktop.NetworkManager' unit='dbus-org.freedesktop.NetworkManager.service'
Jun 12 15:23:10 linux dbus[311]: [system] Activation via systemd failed for unit 'dbus-org.freedesktop.NetworkManager.service': Unit dbus-org.freedesktop.NetworkManager.service failed to load: No such file or directory. See system logs and 'systemctl status dbus-org.freedesktop.NetworkManager.service' for details.
Jun 12 15:23:10 linux dbus-daemon[311]: (packagekitd:9509): GLib-GObject-WARNING **: invalid (NULL) pointer instance
Jun 12 15:23:10 linux dbus-daemon[311]: (packagekitd:9509): GLib-GObject-CRITICAL **: g_signal_connect_data: assertion `G_TYPE_CHECK_INSTANCE (instance)' failed
Jun 12 15:23:10 linux dbus-daemon[311]: dbus[311]: [system] Activating via systemd: service name='org.freedesktop.ConsoleKit' unit='console-kit-daemon.service'
Jun 12 15:23:10 linux dbus[311]: [system] Activating via systemd: service name='org.freedesktop.ConsoleKit' unit='console-kit-daemon.service'
Jun 12 15:23:10 linux systemd[1]: Starting Console Manager...
Jun 12 15:23:10 linux console-kit-daemon[9535]: missing action
Jun 12 15:23:10 linux dbus-daemon[311]: dbus[311]: [system] Successfully activated service 'org.freedesktop.ConsoleKit'
Jun 12 15:23:10 linux dbus[311]: [system] Successfully activated service 'org.freedesktop.ConsoleKit'
Jun 12 15:23:10 linux systemd[1]: Started Console Manager.
Jun 12 15:23:10 linux udisks-daemon[2490]: **** /proc/self/mountinfo changed
Jun 12 15:23:10 linux kernel: EXT4-fs (sda4): re-mounted. Opts: user_xattr,barrier=0,commit=0
Jun 12 15:23:10 linux dbus-daemon[311]: dbus[311]: [system] Successfully activated service 'org.freedesktop.PackageKit'
Jun 12 15:23:10 linux dbus[311]: [system] Successfully activated service 'org.freedesktop.PackageKit'
Jun 12 15:23:10 linux sudo[9219]: pam_unix(sudo:session): session closed for user root
Jun 12 15:23:30 linux sudo[11943]: nir : TTY=pts/0 ; PWD=/home/nir ; USER=root ; COMMAND=/usr/bin/modprobe snd_ctxfi
Jun 12 15:23:30 linux sudo[11943]: pam_unix(sudo:session): session opened for user root by nir(uid=0)
Jun 12 15:23:30 linux kernel: snd_ctxfi 0000:05:00.0: enabling device (0000 -> 0003)
Jun 12 15:23:30 linux kernel: snd_ctxfi 0000:05:00.0: setting latency timer to 64
Jun 12 15:23:30 linux sudo[11943]: pam_unix(sudo:session): session closed for user root
Jun 12 15:23:30 linux kernel: PLL initialization failed!!!
Jun 12 15:23:30 linux kernel: ctxfi: Something wrong!!!
Jun 12 15:23:30 linux kernel: snd_ctxfi: probe of 0000:05:00.0 failed with error -16
Jun 12 15:23:36 linux rtkit-daemon[2585]: Recovering from system lockup, not allowing further RT threads.
Jun 12 15:23:36 linux rtkit-daemon[2585]: Recovering from system lockup, not allowing further RT threads.
Jun 12 15:23:36 linux rtkit-daemon[2585]: Recovering from system lockup, not allowing further RT threads.
Jun 12 15:23:36 linux rtkit-daemon[2585]: Recovering from system lockup, not allowing further RT threads.
Jun 12 15:23:36 linux rtkit-daemon[2585]: Recovering from system lockup, not allowing further RT threads.
Jun 12 15:23:36 linux rtkit-daemon[2585]: Recovering from system lockup, not allowing further RT threads.
Jun 12 15:23:36 linux rtkit-daemon[2585]: Recovering from system lockup, not allowing further RT threads.
Jun 12 15:23:36 linux rtkit-daemon[2585]: Recovering from system lockup, not allowing further RT threads.
Jun 12 15:23:36 linux rtkit-daemon[2585]: Recovering from system lockup, not allowing further RT threads.
Jun 12 15:23:36 linux rtkit-daemon[2585]: Recovering from system lockup, not allowing further RT threads.
Jun 12 15:23:36 linux rtkit-daemon[2585]: Recovering from system lockup, not allowing further RT threads.
Jun 12 15:23:36 linux dbus-daemon[311]: dbus[311]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service'
Jun 12 15:23:36 linux dbus[311]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service'
Jun 12 15:23:36 linux dbus[311]: [system] Activation via systemd failed for unit 'dbus-org.bluez.service': Unit dbus-org.bluez.service failed to load: No such file or directory. See system logs and 'systemctl status dbus-org.bluez.service' for details.
Jun 12 15:23:36 linux dbus-daemon[311]: dbus[311]: [system] Activation via systemd failed for unit 'dbus-org.bluez.service': Unit dbus-org.bluez.service failed to load: No such file or directory. See system logs and 'systemctl status dbus-org.bluez.service' for details.
Jun 12 15:23:36 linux pulseaudio[11984]: [pulseaudio] sink.c: Default and alternate sample rates are the same.
Jun 12 15:23:36 linux pulseaudio[11984]: [pulseaudio] bluetooth-util.c: org.bluez.Manager.GetProperties() failed: org.freedesktop.systemd1.LoadFailed: Unit dbus-org.bluez.service failed to load: No such file or directory. See system logs and 'systemctl status dbus-org.bluez.service' for details.
Jun 12 15:28:11 linux dbus-daemon[311]: (packagekitd:9509): GLib-GObject-CRITICAL **: g_object_unref: assertion `G_IS_OBJECT (object)' failed
Jun 12 15:29:13 linux sudo[14034]: nir : TTY=pts/0 ; PWD=/home/nir ; USER=root ; COMMAND=/usr/bin/suAnd still, no sound until I reboot the machine.
I've been googling for hours with no luck. Also, tried it on Ubuntu-13.04 with latest updates, with the same result.
Note: I rebooted the machine between every suspend attempt.
Any help would be much appreciated, thanks guys.
Offline
#2 2013-10-19 10:36:12
- kulpae
- Member
- From: Bremen
- Registered: 2010-02-06
- Posts: 34
Re: snd_ctxfi failed to unload properly on suspend
I'm experiencing the same issues with my X-Fi Titanium: No sound card after wakeup. And I also have this message:
ctxfi: pci_enable_device failed, disabling deviceI saw you removed the kernel module with
NIRz wrote:
sudo modprobe -r snd_ctxfi
so I did it as well, then it disappeared from lsmod as expected.
Then I added the module back and the card returned!
$ sudo modprobe snd_ctxfi
$ sudo aplay -l
**** List of PLAYBACK Hardware Devices ****
card 0: XFi [Creative X-Fi], device 0: ctxfi [Front/WaveIn]
Subdevices: 256/256
Subdevice #0: subdevice #0
[...]
Subdevice #255: subdevice #255
card 0: XFi [Creative X-Fi], device 1: ctxfi [Surround]
Subdevices: 256/256
Subdevice #0: subdevice #0
[...]
Subdevice #255: subdevice #255
card 0: XFi [Creative X-Fi], device 2: ctxfi [Center/LFE]
Subdevices: 256/256
Subdevice #0: subdevice #0
[...]
Subdevice #255: subdevice #255
card 0: XFi [Creative X-Fi], device 3: ctxfi [Side]
Subdevices: 256/256
Subdevice #0: subdevice #0
[...]
Subdevice #255: subdevice #255
card 0: XFi [Creative X-Fi], device 4: ctxfi [IEC958 Non-audio]
Subdevices: 1/1
Subdevice #0: subdevice #0
card 1: HDMI [HDA ATI HDMI], device 3: HDMI 0 [HDMI 0]
Subdevices: 1/1
Subdevice #0: subdevice #0Maybe you already fixed it, then this post is for other people having the same issue 
Offline