Arch Linux

habbbe

Member

Registered: 2013-05-07

Posts: 1

[Solved] Second disk unreadable after suspend. Preventing suspends.

Hello everyone!

I have been running Arch on my Macbook Pro mid 2010 for a few weeks now, and everything
has been working great. However, yesterday, after I decided to put a secondary disk drive into the
superdrive (optical media reader/writer) slot via an optibay adapter, I ran into a problem.

After I boot the system, I can suspend without any problems whatsoever, but when I try to wake the
computer it freezes for about 30-40 seconds (compared to about 3-4 seconds before the addition of the new
drive) before being usable again.

When the system is up and running again, the second disk is unreadable. For example, if I try to mount it, I get:

mount: /dev/sdb2: can't read superblock

Also, when I try to suspend the computer again after waking it up, it immediately resumes, preventing it from
suspending.

Additional info:

The wiki for Macbook Pro didn't help me with this particular problem.

My main drive is an SSD, while the second (problematic) is a mechanical drive.

The secondary drive is a bootable OS X (hfs+) drive.

After a resume of the kind described above, the disk must be repaired by OS X to become usable again
(disk errors seems to be present).

The log from dmesg:

[  241.828203] PM: Syncing filesystems ... done.
[  241.847250] PM: Preparing system for mem sleep
[  243.825500] Freezing user space processes ... (elapsed 0.01 seconds) done.
[  243.836761] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
[  243.850171] PM: Entering mem sleep
[  243.850328] Suspending console(s) (use no_console_suspend to debug)
[  243.851541] sd 1:0:0:0: [sdb] Synchronizing SCSI cache
[  243.851653] sd 0:0:0:0: [sda] Synchronizing SCSI cache
[  243.851772] sd 0:0:0:0: [sda] Stopping disk
[  243.870412] cfg80211: Calling CRDA for country: GB
[  244.003429] ACPI: Cannot transition to non-D0 state from D3
[  245.813795] sd 1:0:0:0: [sdb] Stopping disk
[  246.223496] ACPI: Cannot transition to non-D0 state from D3
[  246.223585] PM: suspend of devices complete after 2372.684 msecs
[  246.224417] PM: late suspend of devices complete after 0.827 msecs
[  246.224958] ehci-pci 0000:00:06.1: System wakeup enabled by ACPI
[  246.236695] ACPI: Cannot transition to non-D0 state from D3
[  246.236776] ohci_hcd 0000:00:06.0: System wakeup enabled by ACPI
[  246.250014] ACPI: Cannot transition to non-D0 state from D3
[  246.250090] ehci-pci 0000:00:04.1: System wakeup enabled by ACPI
[  246.263348] ACPI: Cannot transition to non-D0 state from D3
[  246.263421] ohci_hcd 0000:00:04.0: System wakeup enabled by ACPI
[  246.276679] ACPI: Cannot transition to non-D0 state from D3
[  246.277465] PM: noirq suspend of devices complete after 53.042 msecs
[  246.278485] ACPI: Preparing to enter system sleep state S3
[  246.303430] PM: Saving platform NVS memory
[  246.318087] Disabling non-boot CPUs ...
[  246.420034] smpboot: CPU 1 is now offline
[  246.420842] Extended CMOS year: 2000
[  246.420842] ACPI: Low-level resume complete
[  246.420842] PM: Restoring platform NVS memory
[  246.420842] Extended CMOS year: 2000
[  246.420842] Enabling non-boot CPUs ...
[  246.425259] smpboot: Booting Node 0 Processor 1 APIC 0x1
[  246.436726] CPU1 is up
[  246.439955] ACPI: Waking up from system sleep state S3
[  246.691288] ohci_hcd 0000:00:04.0: power state changed by ACPI to D0
[  246.703431] ohci_hcd 0000:00:04.0: System wakeup disabled by ACPI
[  246.703502] ehci-pci 0000:00:04.1: power state changed by ACPI to D0
[  246.716764] ehci-pci 0000:00:04.1: System wakeup disabled by ACPI
[  246.716838] ohci_hcd 0000:00:06.0: power state changed by ACPI to D0
[  246.730090] ohci_hcd 0000:00:06.0: System wakeup disabled by ACPI
[  246.730151] ehci-pci 0000:00:06.1: power state changed by ACPI to D0
[  246.743430] ehci-pci 0000:00:06.1: System wakeup disabled by ACPI
[  246.743501] snd_hda_intel 0000:00:08.0: power state changed by ACPI to D0
[  246.756824] pata_acpi 0000:00:0a.0: power state changed by ACPI to D0
[  246.770505] pcieport 0000:00:15.0: power state changed by ACPI to D0
[  246.797556] PM: noirq resume of devices complete after 107.380 msecs
[  246.798049] PM: early resume of devices complete after 0.393 msecs
[  246.798171] ohci_hcd 0000:00:04.0: setting latency timer to 64
[  246.798205] ehci-pci 0000:00:04.1: setting latency timer to 64
[  246.798246] ohci_hcd 0000:00:06.0: setting latency timer to 64
[  246.798266] ehci-pci 0000:00:06.1: setting latency timer to 64
[  246.798283] snd_hda_intel 0000:00:08.0: setting latency timer to 64
[  246.798360] pata_acpi 0000:00:0a.0: setting latency timer to 64
[  246.798438] pci 0000:00:17.0: setting latency timer to 64
[  246.851987] firewire_ohci 0000:01:00.0: irq 43 for MSI/MSI-X
[  247.117048] ata1.00: ACPI cmd ef/03:46:00:00:00:a0 (SET FEATURES) filtered out
[  247.123855] ata1.00: configured for UDMA/133
[  247.316861] sd 0:0:0:0: [sda] Starting disk
[  248.076908] firewire_core 0000:01:00.0: rediscovered device fw0
[  252.290174] ata2: link is slow to respond, please be patient (ready=0)
[  257.143516] ata2: SRST failed (errno=-16)
[  262.310182] ata2: link is slow to respond, please be patient (ready=0)
[  267.163517] ata2: SRST failed (errno=-16)
[  272.330169] ata2: link is slow to respond, please be patient (ready=0)
[  302.196833] ata2: SRST failed (errno=-16)
[  307.203500] ata2: SRST failed (errno=-16)
[  307.214365] ata2: reset failed, giving up
[  307.214369] ata2.00: disabled
[  307.214506] sd 1:0:0:0: [sdb] Starting disk
[  307.214601] sd 1:0:0:0: [sdb] START_STOP FAILED
[  307.214606] sd 1:0:0:0: [sdb]  
[  307.214609] Result: hostbyte=0x04 driverbyte=0x00
[  307.214654] dpm_run_callback(): scsi_bus_resume+0x0/0x40 [scsi_mod] returns 262144
[  307.214667] PM: Device 1:0:0:0 failed to resume async: error 262144
[  307.215783] PM: resume of devices complete after 60417.728 msecs
[  307.232015] PM: Finishing wakeup.
[  307.232020] Restarting tasks ... done.
[  307.248480] video LNXVIDEO:00: Restoring backlight state
[  307.391016] ERROR @wl_notify_scan_status : Scan complete while device not scanning
[  308.973630] ERROR @wl_notify_scan_status : Scan complete while device not scanning
[  308.990369] tg3 0000:03:00.0: irq 44 for MSI/MSI-X
[  309.770152] IPv6: ADDRCONF(NETDEV_UP): enp3s0: link is not ready
[  317.403819] tg3 0000:03:00.0: irq 44 for MSI/MSI-X
[  318.172238] IPv6: ADDRCONF(NETDEV_UP): enp3s0: link is not ready
[  320.351956] INFO @__wl_cfg80211_scan : system busy : scan for "" canceled

Any ideas?

Thanks.

UPDATE:

I tried to run arch from the installation medium, and while booted into the installation environment the disk functioned as expeced, i.e. it
spun down on suspend, and up on resume, and no disk errors. When booted into the actual system, the disk never starts to spin up after
a resume. Could there be default settings on the live usb that I am missing on my system that fixes the problem? I hope this sheds some
light on the problem.

UPDATE #2:

I managed to solve the problem by switching places of the drives.
I now have the SSD in the optibay slot, and the HDD in the main slot, and somehow, the system
can resume correctly with this setup.

Last edited by habbbe (2013-05-09 14:19:37)