Oct 28 16:41:58 Sweden sudo[11114]: pam_unix(sudo:session): session closed for user root
Oct 28 16:42:05 Sweden polkitd(authority=local)[373]: Registered Authentication Agent for unix-process:11138:28757249 (system bus name :1.322 [/usr/bin/pkttyagent --notify-fd 5 --f
Oct 28 16:42:05 Sweden systemd[1]: Starting Sleep.
Oct 28 16:42:05 Sweden systemd[1]: Reached target Sleep.
Oct 28 16:42:05 Sweden systemd[1]: Starting Suspend...
Oct 28 16:42:05 Sweden polkitd(authority=local)[373]: Unregistered Authentication Agent for unix-process:11138:28757249 (system bus name :1.322, object path /org/freedesktop/Policy
Oct 28 16:42:05 Sweden systemd-sleep[11142]: /usr/lib/systemd/system-sleep/notify-upower.sh exited with exit status 1.
Oct 28 16:42:05 Sweden kernel: usbcore: deregistering interface driver uas
Oct 28 16:42:05 Sweden systemd-sleep[11142]: Suspending system...
Oct 28 16:42:06 Sweden kernel: PM: Syncing filesystems ... done.
Oct 28 16:42:06 Sweden kernel: PM: Preparing system for mem sleep
Oct 28 16:43:13 Sweden kernel: Freezing user space processes ... (elapsed 0.01 seconds) done.
Oct 28 16:43:13 Sweden kernel: Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
Oct 28 16:43:13 Sweden NetworkManager[323]: <info> (eth0): carrier now OFF (device state 100, deferring action for 4 seconds)
Oct 28 16:43:13 Sweden NetworkManager[323]: <info> (eth0): carrier now ON (device state 100)
Oct 28 16:43:13 Sweden kernel: PM: Entering mem sleep
Oct 28 16:43:13 Sweden kernel: Suspending console(s) (use no_console_suspend to debug)
Oct 28 16:43:13 Sweden kernel: sd 1:0:0:0: [sda] Synchronizing SCSI cache
Oct 28 16:43:13 Sweden kernel: parport_pc 00:0a: disabled
Oct 28 16:43:13 Sweden systemd-sleep[11142]: System resumed.
Oct 28 16:43:13 Sweden kernel: serial 00:09: disabled
Oct 28 16:43:13 Sweden kernel: serial 00:09: wake-up capability disabled by ACPI
Oct 28 16:43:13 Sweden kernel: ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
Oct 28 16:43:13 Sweden kernel: ata2.00: failed command: FLUSH CACHE EXT
Oct 28 16:43:13 Sweden kernel: ata2.00: cmd ea/00:00:00:00:00/00:00:00:00:00/a0 tag 0
res 40/00:00:00:4f:c2/00:00:00:00:00/00 Emask 0x4 (timeout)
Oct 28 16:43:13 Sweden kernel: ata2.00: status: { DRDY }
Oct 28 16:43:13 Sweden kernel: ata2: hard resetting link
Oct 28 16:43:13 Sweden kernel: ata2: nv: skipping hardreset on occupied port
Oct 28 16:43:13 Sweden kernel: ata2: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
Oct 28 16:43:13 Sweden kernel: ata2.00: configured for UDMA/133
Oct 28 16:43:13 Sweden kernel: ata2.00: retrying FLUSH 0xea Emask 0x4
Oct 28 16:43:13 Sweden kernel: ata2.00: device reported invalid CHS sector 0
Oct 28 16:43:13 Sweden kernel: ata2: EH complete
Oct 28 16:43:13 Sweden kernel: sd 1:0:0:0: [sda] Stopping disk
Oct 28 16:43:13 Sweden kernel: PM: suspend of devices complete after 61959.739 msecs
Oct 28 16:43:13 Sweden kernel: PM: late suspend of devices complete after 0.347 msecs
Oct 28 16:43:13 Sweden kernel: pci 0000:00:10.0: wake-up capability enabled by ACPI
Oct 28 16:43:13 Sweden kernel: ehci_hcd 0000:00:0b.1: wake-up capability enabled by ACPI
Oct 28 16:43:13 Sweden kernel: ohci_hcd 0000:00:0b.0: wake-up capability enabled by ACPI
Oct 28 16:43:13 Sweden kernel: PM: noirq suspend of devices complete after 39.915 msecs
Oct 28 16:43:13 Sweden kernel: ACPI: Preparing to enter system sleep state S3
Oct 28 16:43:13 Sweden kernel: PM: Saving platform NVS memory
Oct 28 16:43:13 Sweden kernel: Disabling non-boot CPUs ...
Oct 28 16:43:13 Sweden kernel: smpboot: CPU 1 is now offline
Oct 28 16:43:13 Sweden kernel: Extended CMOS year: 2000
Oct 28 16:43:13 Sweden kernel: ACPI: Low-level resume complete
Oct 28 16:43:13 Sweden kernel: PM: Restoring platform NVS memory
Oct 28 16:43:13 Sweden kernel: PCI-DMA: Resuming GART IOMMU
Oct 28 16:43:13 Sweden kernel: PCI-DMA: Restoring GART aperture settings
Oct 28 16:43:13 Sweden kernel: Extended CMOS year: 2000
Oct 28 16:43:13 Sweden kernel: Enabling non-boot CPUs ...
Oct 28 16:43:13 Sweden kernel: smpboot: Booting Node 0 Processor 1 APIC 0x1
Oct 28 16:43:13 Sweden kernel: CPU1 is up
Oct 28 16:43:13 Sweden kernel: ACPI: Waking up from system sleep state S3
Oct 28 16:43:13 Sweden kernel: pci 0000:00:00.0: Found disabled HT MSI Mapping
Oct 28 16:43:13 Sweden kernel: pci 0000:00:00.0: Enabling HT MSI Mapping
Oct 28 16:43:13 Sweden kernel: pci 0000:00:00.0: Found enabled HT MSI Mapping
Oct 28 16:43:13 Sweden kernel: pci 0000:00:00.0: Found enabled HT MSI Mapping
Oct 28 16:43:13 Sweden kernel: pci 0000:00:00.0: Found enabled HT MSI Mapping
Oct 28 16:43:13 Sweden kernel: ohci_hcd 0000:00:0b.0: wake-up capability disabled by ACPI
Oct 28 16:43:13 Sweden kernel: ehci_hcd 0000:00:0b.1: wake-up capability disabled by ACPI
Oct 28 16:43:13 Sweden kernel: pci 0000:00:09.0: Found disabled HT MSI Mapping
Oct 28 16:43:13 Sweden kernel: sata_nv 0000:00:0e.0: Enabling HT MSI Mapping
Oct 28 16:43:13 Sweden kernel: pci 0000:00:09.0: Found disabled HT MSI Mapping
Oct 28 16:43:13 Sweden kernel: sata_nv 0000:00:0f.0: Enabling HT MSI Mapping
Oct 28 16:43:13 Sweden kernel: pci 0000:00:09.0: Found disabled HT MSI Mapping
Oct 28 16:43:13 Sweden kernel: snd_hda_intel 0000:00:10.1: Enabling HT MSI Mapping
Oct 28 16:43:13 Sweden kernel: PM: noirq resume of devices complete after 152.918 msecs
Oct 28 16:43:13 Sweden kernel: PM: early resume of devices complete after 0.116 msecs
Oct 28 16:43:13 Sweden kernel: ohci_hcd 0000:00:0b.0: setting latency timer to 64
Oct 28 16:43:13 Sweden kernel: ehci_hcd 0000:00:0b.1: setting latency timer to 64
Oct 28 16:43:13 Sweden kernel: pata_acpi 0000:00:0d.0: setting latency timer to 64
Oct 28 16:43:13 Sweden kernel: sata_nv 0000:00:0e.0: setting latency timer to 64
Oct 28 16:43:13 Sweden kernel: sata_nv 0000:00:0f.0: setting latency timer to 64
Oct 28 16:43:13 Sweden kernel: pci 0000:00:10.0: setting latency timer to 64
Oct 28 16:43:13 Sweden kernel: snd_hda_intel 0000:00:10.1: setting latency timer to 64
Oct 28 16:43:13 Sweden kernel: serial 00:09: activated
Oct 28 16:43:13 Sweden kernel: parport_pc 00:0a: activated
Oct 28 16:43:13 Sweden kernel: Extended CMOS year: 2000
Oct 28 16:43:13 Sweden kernel: pci 0000:00:10.0: wake-up capability disabled by ACPI
Oct 28 16:43:13 Sweden kernel: r8169 0000:04:09.0: eth0: link down
Oct 28 16:43:13 Sweden kernel: ata5.00: ACPI cmd ef/03:44:00:00:00:a0 (SET FEATURES) filtered out
Oct 28 16:43:13 Sweden kernel: ata5.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out
Oct 28 16:43:13 Sweden kernel: ata5.00: configured for UDMA/66
Oct 28 16:43:13 Sweden kernel: usb 2-3: reset low-speed USB device number 2 using ohci_hcd
Oct 28 16:43:13 Sweden kernel: ata3: SATA link down (SStatus 0 SControl 300)
Oct 28 16:43:13 Sweden kernel: ata1: SATA link down (SStatus 0 SControl 300)
Oct 28 16:43:13 Sweden kernel: ata4: SATA link down (SStatus 0 SControl 300)
Oct 28 16:43:13 Sweden kernel: r8169 0000:04:09.0: eth0: link up
Oct 28 16:43:13 Sweden kernel: ata2: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
Oct 28 16:43:13 Sweden kernel: ata2.00: ACPI cmd ef/03:46:00:00:00:a0 (SET FEATURES) filtered out
Oct 28 16:43:13 Sweden kernel: ata2.00: configured for UDMA/133
Oct 28 16:43:13 Sweden kernel: sd 1:0:0:0: [sda] Starting disk
Oct 28 16:43:13 Sweden kernel:
Oct 28 16:43:13 Sweden kernel: floppy driver state
Oct 28 16:43:13 Sweden kernel: -------------------
Oct 28 16:43:13 Sweden kernel: now=4319669676 last interrupt=4294877474 diff=24792202 last called handler=reset_interrupt [floppy]
Oct 28 16:43:13 Sweden kernel: timeout_message=lock fdc
Oct 28 16:43:13 Sweden kernel: last output bytes:
Oct 28 16:43:13 Sweden kernel: 8 90 4294877469
Oct 28 16:43:13 Sweden kernel: 8 90 4294877469
Oct 28 16:43:13 Sweden kernel: 8 90 4294877469
Oct 28 16:43:13 Sweden kernel: 8 80 4294877473
Oct 28 16:43:13 Sweden kernel: 8 90 4294877473
Oct 28 16:43:13 Sweden kernel: 8 90 4294877473
Oct 28 16:43:13 Sweden kernel: 8 80 4294877473
Oct 28 16:43:13 Sweden kernel: e 80 4294877474
Oct 28 16:43:13 Sweden kernel: 13 90 4294877474
Oct 28 16:43:13 Sweden kernel: 0 90 4294877474
Oct 28 16:43:13 Sweden kernel: 1a 90 4294877474
Oct 28 16:43:13 Sweden kernel: 0 90 4294877474
Oct 28 16:43:13 Sweden kernel: 12 90 4294877474
Oct 28 16:43:13 Sweden kernel: 0 90 4294877474
Oct 28 16:43:13 Sweden kernel: 14 90 4294877474
Oct 28 16:43:13 Sweden kernel: 18 90 4294877474
Oct 28 16:43:13 Sweden kernel: 8 80 4294877474
Oct 28 16:43:13 Sweden kernel: 8 80 4294877474
Oct 28 16:43:13 Sweden kernel: 8 80 4294877474
Oct 28 16:43:13 Sweden kernel: 8 80 4294877474
Oct 28 16:43:13 Sweden kernel: last result at 4294877474
Oct 28 16:43:13 Sweden kernel: last redo_fd_request at 4319591564
Oct 28 16:43:13 Sweden kernel: status=0
Oct 28 16:43:13 Sweden kernel: fdc_busy=1
Oct 28 16:43:13 Sweden kernel: do_floppy=reset_interrupt [floppy]
Oct 28 16:43:13 Sweden kernel: snd_hda_intel 0000:00:10.1: Enabling HT MSI Mapping
Oct 28 16:43:13 Sweden kernel: PM: noirq resume of devices complete after 152.918 msecs
Oct 28 16:42:05 Sweden systemd[1]: Reached target Sleep.
Oct 28 16:42:05 Sweden systemd[1]: Starting Suspend...
Oct 28 16:42:05 Sweden polkitd(authority=local)[373]: Unregistered Authentication Agent for unix-process:11138:28757249 (system bus name :1.322, object path /org/freedesktop/Policy
Oct 28 16:42:05 Sweden systemd-sleep[11142]: /usr/lib/systemd/system-sleep/notify-upower.sh exited with exit status 1.
Oct 28 16:42:05 Sweden kernel: usbcore: deregistering interface driver uas
Oct 28 16:42:05 Sweden systemd-sleep[11142]: Suspending system...
Oct 28 16:42:06 Sweden kernel: PM: Syncing filesystems ... done.
Oct 28 16:42:06 Sweden kernel: PM: Preparing system for mem sleep
Oct 28 16:43:13 Sweden kernel: Freezing user space processes ... (elapsed 0.01 seconds) done.
Oct 28 16:43:13 Sweden kernel: Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
Oct 28 16:43:13 Sweden NetworkManager[323]: <info> (eth0): carrier now OFF (device state 100, deferring action for 4 seconds)
Oct 28 16:43:13 Sweden NetworkManager[323]: <info> (eth0): carrier now ON (device state 100)
Oct 28 16:43:13 Sweden kernel: PM: Entering mem sleep
Oct 28 16:43:13 Sweden kernel: Suspending console(s) (use no_console_suspend to debug)
Oct 28 16:43:13 Sweden kernel: sd 1:0:0:0: [sda] Synchronizing SCSI cache
Oct 28 16:43:13 Sweden kernel: parport_pc 00:0a: disabled
Oct 28 16:43:13 Sweden systemd-sleep[11142]: System resumed.
Oct 28 16:43:13 Sweden kernel: serial 00:09: disabled
Oct 28 16:43:13 Sweden kernel: serial 00:09: wake-up capability disabled by ACPI
Oct 28 16:43:13 Sweden kernel: ata2.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
Oct 28 16:43:13 Sweden kernel: ata2.00: failed command: FLUSH CACHE EXT
Oct 28 16:43:13 Sweden kernel: ata2.00: cmd ea/00:00:00:00:00/00:00:00:00:00/a0 tag 0
res 40/00:00:00:4f:c2/00:00:00:00:00/00 Emask 0x4 (timeout)
Oct 28 16:43:13 Sweden kernel: ata2.00: status: { DRDY }
Oct 28 16:43:13 Sweden kernel: ata2: hard resetting link
Oct 28 16:43:13 Sweden kernel: ata2: nv: skipping hardreset on occupied port
Ah, it looks like it fails to remove usbcore because it is in use...
check:
lsmod | grep usbcore
The last column is the list of modules that depend on usbcore. I guess you will just have to reload all of those.
]]>add some echo commands and check the output of
journalctl -b -u systemd-suspend
to see if the script is actually run.
edit: you also want to try "modprobe -r" instead of "rmmod", not sure what the difference is.
]]>#!/bin/sh
case $1/$2 in
pre/*)
rmmod usbcore
rmmod ehci_hd
;;
post/*)
modprobe usbcore
modprobe ehci_hd
;;
esac
something like this should work:
#!/bin/sh
case $1/$2 in
pre/*)
rmmod <module>
;;
post/*)
modprobe <module>
;;
esac
note that this is not a fix but a crappy workaround for a kernel bug.
]]>/etc/pm/config.d/modules
add this line
SUSPEND_MODULES="ehci_hd usbcore"