Re: Asus eeepc 1008HA suspend issue and mac80211 suspend corner case

["Luis R. Rodriguez" <lrodriguez@atheros.com>]

On Mon, Dec 21, 2009 at 08:39:17PM -0800, Sujith Manoharan wrote:
> Luis Rodriguez wrote:
> > That log can be found here:
> >
> > http://bombadil.infradead.org/~mcgrof/logs/2.6.31-with-2.6.32-wireless/irq-disabled.txt
> 
> Thanks for the log.
> It's a bug in ath9k, related to PowerSave.
> 
> Can you test this patch ?
> 
> diff --git a/drivers/net/wireless/ath/ath9k/main.c b/drivers/net/wireless/ath/ath9k/main.c
> index 3f5b887..419c382 100644
> --- a/drivers/net/wireless/ath/ath9k/main.c
> +++ b/drivers/net/wireless/ath/ath9k/main.c
> @@ -2504,6 +2504,9 @@ static void ath9k_stop(struct ieee80211_hw *hw)
>                 return; /* another wiphy still in use */
>         }
> 
> +       /* Ensure HW is awake when we try to shut it down. */
> +       ath9k_ps_wakeup(sc);
> +
>         if (ah->btcoex_hw.enabled) {
>                 ath9k_hw_btcoex_disable(ah);
>                 if (ah->btcoex_hw.scheme == ATH_BTCOEX_CFG_3WIRE)
> @@ -2524,8 +2527,10 @@ static void ath9k_stop(struct ieee80211_hw *hw)
>         /* disable HAL and put h/w to sleep */
>         ath9k_hw_disable(ah);
>         ath9k_hw_configpcipowersave(ah, 1, 1);
> -       ath9k_setpower(sc, ATH9K_PM_FULL_SLEEP);
> +       ath9k_ps_restore(sc);
> 
> +       /* Finally, put the chip in FULL SLEEP mode */
> +       ath9k_setpower(sc, ATH9K_PM_FULL_SLEEP);
>         sc->sc_flags |= SC_OP_INVALID;
> 
>         mutex_unlock(&sc->mutex);


Thanks for the patch, doesn't cure it though. Below is the log
with debug=0xa00 (CONFIG | PS), you can see some successes prior to
the failure.

[   89.314013] PM: Syncing filesystems ... done.
[   89.316956] PM: Preparing system for mem sleep
[   89.476090] Freezing user space processes ... (elapsed 0.00 seconds) done.
[   89.477287] Freezing remaining freezable tasks ... (elapsed 0.00 seconds) done.
[   89.477402] PM: Entering mem sleep
[   89.477423] Suspending console(s) (use no_console_suspend to debug)
[   89.481334] Tx BA session stop requested for 00:22:6b:56:fd:e8 tid 0
[   89.481350] Stopping Tx BA session for 00:22:6b:56:fd:e8 tid 0
[   89.481385] Rx BA session stop requested for 00:22:6b:56:fd:e8 tid 0
[   89.481403] Tx BA session stop requested for 00:22:6b:56:fd:e8 tid 6
[   89.481412] Stopping Tx BA session for 00:22:6b:56:fd:e8 tid 6
[   89.481435] ath9k: Detach Interface
[   89.483686] ath9k: Driver halt
[   89.506171] sd 0:0:0:0: [sda] Synchronizing SCSI cache
[   89.506558] sd 0:0:0:0: [sda] Stopping disk
[   90.428257] ath9k 0000:01:00.0: PCI INT A disabled
[   90.452700] ACPI handle has no context!
[   90.452714] atl1c 0000:02:00.0: PME# disabled
[   90.452727] atl1c 0000:02:00.0: PCI INT A disabled
[   90.452737] ACPI handle has no context!
[   90.496318] ata6: port disabled. ignoring.
[   90.496393] ata_piix 0000:00:1f.1: PCI INT A disabled
[   90.496411] ehci_hcd 0000:00:1d.7: PCI INT A disabled
[   90.496423] uhci_hcd 0000:00:1d.3: PCI INT D disabled
[   90.496435] uhci_hcd 0000:00:1d.2: PCI INT C disabled
[   90.496445] uhci_hcd 0000:00:1d.1: PCI INT B disabled
[   90.496456] uhci_hcd 0000:00:1d.0: PCI INT A disabled
[   90.513762] i915 0000:00:02.0: PCI INT A disabled
[   90.524494] ehci_hcd 0000:00:1d.7: PME# disabled
[   90.535424] ACPI: Preparing to enter system sleep state S3
[   90.623765] Disabling non-boot CPUs ...
[   90.626106] CPU 1 is now offline
[   90.626112] SMP alternatives: switching to UP code
[   90.630152] CPU1 is down
[   90.630175] x86 PAT enabled: cpu 0, old 0x7040600070406, new 0x7010600070106
[   90.630175] Back to C!
[   90.630175] Enabling non-boot CPUs ...
[   90.630175] SMP alternatives: switching to SMP code
[   90.633737] Booting processor 1 APIC 0x1 ip 0x6000
[   90.629500] Initializing CPU#1
[   90.629500] Calibrating delay using timer specific routine.. 3331.28 BogoMIPS (lpj=1665643)
[   90.629500] CPU: L1 I cache: 32K, L1 D cache: 24K
[   90.629500] CPU: L2 cache: 512K
[   90.629500] CPU: Physical Processor ID: 0
[   90.629500] CPU: Processor Core ID: 0
[   90.629500] mce: CPU supports 5 MCE banks
[   90.629500] x86 PAT enabled: cpu 1, old 0x7040600070406, new 0x7010600070106
[   90.704950] CPU1: Intel(R) Atom(TM) CPU N280   @ 1.66GHz stepping 02
[   90.705036] Switched to high resolution mode on CPU 1
[   90.709037] CPU1 is up
[   90.709043] ACPI: Waking up from system sleep state S3
[   91.068418] pcieport-driver 0000:00:1c.0: restoring config space at offset 0x7 (was 0xf0, writing 0x200000f0)
[   91.068437] pcieport-driver 0000:00:1c.0: restoring config space at offset 0x1 (was 0x100104, writing 0x100504)
[   91.068516] pcieport-driver 0000:00:1c.1: restoring config space at offset 0x1 (was 0x100107, writing 0x100507)
[   91.068584] pcieport-driver 0000:00:1c.2: restoring config space at offset 0x7 (was 0xf0, writing 0x200000f0)
[   91.068601] pcieport-driver 0000:00:1c.2: restoring config space at offset 0x1 (was 0x100106, writing 0x100506)
[   91.068668] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001)
[   91.068707] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001)
[   91.068746] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001)
[   91.068784] uhci_hcd 0000:00:1d.3: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001)
[   91.068832] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x1 (was 0x2900106, writing 0x2900102)
[   91.068854] ehci_hcd 0000:00:1d.7: PME# disabled
[   91.069022] ahci 0000:00:1f.2: restoring config space at offset 0x1 (was 0x2b00007, writing 0x2b00407)
[   91.427502] i915 0000:00:02.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[   91.427511] i915 0000:00:02.0: setting latency timer to 64
[   91.489057] [drm] LVDS-8: set mode 1024x600 e
[   91.509264] pci 0000:00:02.1: PME# disabled
[   91.509276] pci 0000:00:1b.0: PME# disabled
[   91.509306] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 23 (level, low) -> IRQ 23
[   91.509317] uhci_hcd 0000:00:1d.0: setting latency timer to 64
[   91.509345] usb usb2: root hub lost power or was reset
[   91.509371] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 22 (level, low) -> IRQ 22
[   91.509381] uhci_hcd 0000:00:1d.1: setting latency timer to 64
[   91.509407] usb usb3: root hub lost power or was reset
[   91.509431] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 21 (level, low) -> IRQ 21
[   91.509441] uhci_hcd 0000:00:1d.2: setting latency timer to 64
[   91.509467] usb usb4: root hub lost power or was reset
[   91.509491] uhci_hcd 0000:00:1d.3: PCI INT D -> GSI 20 (level, low) -> IRQ 20
[   91.509500] uhci_hcd 0000:00:1d.3: setting latency timer to 64
[   91.509527] usb usb5: root hub lost power or was reset
[   91.509564] ehci_hcd 0000:00:1d.7: PME# disabled
[   91.509572] ehci_hcd 0000:00:1d.7: PCI INT A -> GSI 23 (level, low) -> IRQ 23
[   91.509582] ehci_hcd 0000:00:1d.7: setting latency timer to 64
[   91.509616] pci 0000:00:1e.0: setting latency timer to 64
[   91.509632] ata_piix 0000:00:1f.1: PCI INT A -> GSI 18 (level, low) -> IRQ 18
[   91.509640] ata_piix 0000:00:1f.1: setting latency timer to 64
[   91.511298] ata6: port disabled. ignoring.
[   91.511330] ahci 0000:00:1f.2: setting latency timer to 64
[   91.511406] atl1c 0000:02:00.0: PME# disabled
[   91.511417] atl1c 0000:02:00.0: PME# disabled
[   91.574708] atl1c 0000:02:00.0: irq 28 for MSI/MSI-X
[   91.574790] ath9k 0000:01:00.0: PCI INT A -> GSI 18 (level, low) -> IRQ 18
[   91.817141] ata3: SATA link down (SStatus 0 SControl 300)
[   91.970144] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
[   91.972350] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 filtered out
[   91.975267] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 filtered out
[   91.975693] ata1.00: configured for UDMA/133
[   91.986140] ata1: exception Emask 0x10 SAct 0x0 SErr 0x0 action 0xf t4
[   91.986149] ata1: irq_stat 0x00000040, connection status changed
[   91.986168] ata1: hard resetting link
[   92.047230] sd 0:0:0:0: [sda] Starting disk
[   92.709167] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
[   92.798901] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 filtered out
[   92.801624] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 filtered out
[   92.802079] ata1.00: configured for UDMA/133
[   92.802092] ata1: EH complete
[   92.960162] usb 1-8: reset high speed USB device using ehci_hcd and address 3
[   93.241146] usb 5-1: reset full speed USB device using uhci_hcd and address 2
[   93.956141] ath9k: Starting driver with initial channel: 2437 MHz
[   93.970209] ath9k: Attach a VIF of type: 2
[   93.970243] ath9k: Set channel: 2437 MHz
[   93.970248] ath9k: tx chmask: 1, rx chmask: 1
[   93.970372] ath9k: (2437 MHz) -> (2437 MHz), chanwidth: 1
[   93.979039] ath9k: Set HW RX filter: 0x607
[   93.979046] ath9k: RX filter 0x0 bssid 00:22:6b:56:fd:e8 aid 0x0
[   93.979052] ath9k: BSS Changed PREAMBLE 1
[   93.979056] ath9k: BSS Changed CTS PROT 0
[   93.979060] ath9k: BSS Changed ASSOC 1
[   93.979063] ath9k: Bss Info ASSOC 1, bssid: 00:22:6b:56:fd:e8
[   93.981491] PM: Finishing wakeup.
[   93.981496] Restarting tasks ... done.
[   93.989532] Open BA session requested for 00:22:6b:56:fd:e8 tid 0
[   93.989575] activated addBA response timer on tid 0
[   93.991477] Rx A-MPDU request on tid 0 result 0
[   93.992306] switched off addBA timer for tid 0 
[   93.992314] Aggregation is on for tid 0 
[   94.194880] ath9k: Reconfigure Beacon timers based on timestamp from the AP
[  104.540982] PM: Syncing filesystems ... done.
[  104.767013] PM: Preparing system for mem sleep
[  104.913718] Freezing user space processes ... (elapsed 0.00 seconds) done.
[  104.915436] Freezing remaining freezable tasks ... (elapsed 0.00 seconds) done.
[  104.915545] PM: Entering mem sleep
[  104.915568] Suspending console(s) (use no_console_suspend to debug)
[  104.920338] Tx BA session stop requested for 00:22:6b:56:fd:e8 tid 0
[  104.920354] Stopping Tx BA session for 00:22:6b:56:fd:e8 tid 0
[  104.920390] Rx BA session stop requested for 00:22:6b:56:fd:e8 tid 0
[  104.920477] ath9k: Detach Interface
[  104.922778] ath9k: Driver halt
[  104.946162] sd 0:0:0:0: [sda] Synchronizing SCSI cache
[  104.946594] sd 0:0:0:0: [sda] Stopping disk
[  105.863851] ath9k 0000:01:00.0: PCI INT A disabled
[  105.887700] ACPI handle has no context!
[  105.887714] atl1c 0000:02:00.0: PME# disabled
[  105.887724] ACPI handle has no context!
[  105.931316] ata6: port disabled. ignoring.
[  105.931391] ata_piix 0000:00:1f.1: PCI INT A disabled
[  105.931409] ehci_hcd 0000:00:1d.7: PCI INT A disabled
[  105.931422] uhci_hcd 0000:00:1d.3: PCI INT D disabled
[  105.931433] uhci_hcd 0000:00:1d.2: PCI INT C disabled
[  105.931444] uhci_hcd 0000:00:1d.1: PCI INT B disabled
[  105.931454] uhci_hcd 0000:00:1d.0: PCI INT A disabled
[  105.947618] i915 0000:00:02.0: PCI INT A disabled
[  105.958499] ehci_hcd 0000:00:1d.7: PME# disabled
[  105.969427] ACPI: Preparing to enter system sleep state S3
[  106.057766] Disabling non-boot CPUs ...
[  106.060109] CPU 1 is now offline
[  106.060114] SMP alternatives: switching to UP code
[  106.064092] CPU1 is down
[  106.064115] x86 PAT enabled: cpu 0, old 0x7040600070406, new 0x7010600070106
[  106.064115] Back to C!
[  106.064115] Enabling non-boot CPUs ...
[  106.064115] SMP alternatives: switching to SMP code
[  106.067695] Booting processor 1 APIC 0x1 ip 0x6000
[  106.063466] Initializing CPU#1
[  106.063466] Calibrating delay using timer specific routine.. 3331.28 BogoMIPS (lpj=1665640)
[  106.063466] CPU: L1 I cache: 32K, L1 D cache: 24K
[  106.063466] CPU: L2 cache: 512K
[  106.063466] CPU: Physical Processor ID: 0
[  106.063466] CPU: Processor Core ID: 0
[  106.063466] mce: CPU supports 5 MCE banks
[  106.063466] x86 PAT enabled: cpu 1, old 0x7040600070406, new 0x7010600070106
[  106.138940] CPU1: Intel(R) Atom(TM) CPU N280   @ 1.66GHz stepping 02
[  106.139028] Switched to high resolution mode on CPU 1
[  106.143036] CPU1 is up
[  106.143042] ACPI: Waking up from system sleep state S3
[  106.503519] pcieport-driver 0000:00:1c.0: restoring config space at offset 0x1 (was 0x100104, writing 0x100504)
[  106.503607] pcieport-driver 0000:00:1c.1: restoring config space at offset 0x1 (was 0x100107, writing 0x100507)
[  106.503691] pcieport-driver 0000:00:1c.2: restoring config space at offset 0x1 (was 0x100106, writing 0x100506)
[  106.503765] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001)
[  106.503809] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001)
[  106.503852] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001)
[  106.503895] uhci_hcd 0000:00:1d.3: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001)
[  106.503948] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x1 (was 0x2900106, writing 0x2900102)
[  106.503973] ehci_hcd 0000:00:1d.7: PME# disabled
[  106.504158] ahci 0000:00:1f.2: restoring config space at offset 0x1 (was 0x2b00007, writing 0x2b00407)
[  106.866491] i915 0000:00:02.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[  106.866500] i915 0000:00:02.0: setting latency timer to 64
[  106.928044] [drm] LVDS-8: set mode 1024x600 e
[  106.948245] pci 0000:00:02.1: PME# disabled
[  106.948259] pci 0000:00:1b.0: PME# disabled
[  106.948291] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 23 (level, low) -> IRQ 23
[  106.948303] uhci_hcd 0000:00:1d.0: setting latency timer to 64
[  106.948331] usb usb2: root hub lost power or was reset
[  106.948358] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 22 (level, low) -> IRQ 22
[  106.948367] uhci_hcd 0000:00:1d.1: setting latency timer to 64
[  106.948394] usb usb3: root hub lost power or was reset
[  106.948418] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 21 (level, low) -> IRQ 21
[  106.948428] uhci_hcd 0000:00:1d.2: setting latency timer to 64
[  106.948454] usb usb4: root hub lost power or was reset
[  106.948478] uhci_hcd 0000:00:1d.3: PCI INT D -> GSI 20 (level, low) -> IRQ 20
[  106.948487] uhci_hcd 0000:00:1d.3: setting latency timer to 64
[  106.948514] usb usb5: root hub lost power or was reset
[  106.948552] ehci_hcd 0000:00:1d.7: PME# disabled
[  106.948561] ehci_hcd 0000:00:1d.7: PCI INT A -> GSI 23 (level, low) -> IRQ 23
[  106.948570] ehci_hcd 0000:00:1d.7: setting latency timer to 64
[  106.948604] pci 0000:00:1e.0: setting latency timer to 64
[  106.948620] ata_piix 0000:00:1f.1: PCI INT A -> GSI 18 (level, low) -> IRQ 18
[  106.948628] ata_piix 0000:00:1f.1: setting latency timer to 64
[  106.950291] ata6: port disabled. ignoring.
[  106.950322] ahci 0000:00:1f.2: setting latency timer to 64
[  106.950400] atl1c 0000:02:00.0: PME# disabled
[  106.950410] atl1c 0000:02:00.0: PME# disabled
[  107.013705] atl1c 0000:02:00.0: irq 28 for MSI/MSI-X
[  107.013790] ath9k 0000:01:00.0: PCI INT A -> GSI 18 (level, low) -> IRQ 18
[  107.256171] ata3: SATA link down (SStatus 0 SControl 300)
[  107.307148] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
[  107.309315] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 filtered out
[  107.312183] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 filtered out
[  107.312628] ata1.00: configured for UDMA/133
[  107.323167] ata1: exception Emask 0x10 SAct 0x0 SErr 0x0 action 0xf t4
[  107.323176] ata1: irq_stat 0x00000040, connection status changed
[  107.323195] ata1: hard resetting link
[  107.485042] sd 0:0:0:0: [sda] Starting disk
[  108.046178] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
[  108.118587] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 filtered out
[  108.121397] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 filtered out
[  108.121810] ata1.00: configured for UDMA/133
[  108.121822] ata1: EH complete
[  108.280150] usb 1-8: reset high speed USB device using ehci_hcd and address 3
[  108.560140] usb 5-1: reset full speed USB device using uhci_hcd and address 2
[  109.275204] ath9k: Starting driver with initial channel: 2437 MHz
[  109.289246] ath9k: Attach a VIF of type: 2
[  109.289299] ath9k: Set channel: 2437 MHz
[  109.289305] ath9k: tx chmask: 1, rx chmask: 1
[  109.289406] ath9k: (2437 MHz) -> (2437 MHz), chanwidth: 1
[  109.298089] ath9k: Set HW RX filter: 0x607
[  109.298096] ath9k: RX filter 0x0 bssid 00:22:6b:56:fd:e8 aid 0x0
[  109.298102] ath9k: BSS Changed PREAMBLE 1
[  109.298106] ath9k: BSS Changed CTS PROT 0
[  109.298109] ath9k: BSS Changed ASSOC 1
[  109.298113] ath9k: Bss Info ASSOC 1, bssid: 00:22:6b:56:fd:e8
[  109.300513] PM: Finishing wakeup.
[  109.300518] Restarting tasks ... done.
[  109.330297] Open BA session requested for 00:22:6b:56:fd:e8 tid 0
[  109.330341] activated addBA response timer on tid 0
[  109.335364] Rx A-MPDU request on tid 0 result 0
[  109.336199] switched off addBA timer for tid 0 
[  109.336207] Aggregation is on for tid 0 
[  109.532250] ath9k: Reconfigure Beacon timers based on timestamp from the AP
[  115.600983] PM: Syncing filesystems ... done.
[  115.603769] PM: Preparing system for mem sleep
[  115.747184] Freezing user space processes ... (elapsed 0.00 seconds) done.
[  115.748611] Freezing remaining freezable tasks ... (elapsed 0.00 seconds) done.
[  115.748728] PM: Entering mem sleep
[  115.748750] Suspending console(s) (use no_console_suspend to debug)
[  115.754153] Tx BA session stop requested for 00:22:6b:56:fd:e8 tid 0
[  115.754174] Stopping Tx BA session for 00:22:6b:56:fd:e8 tid 0
[  115.754216] Rx BA session stop requested for 00:22:6b:56:fd:e8 tid 0
[  115.754245] ath9k: Detach Interface
[  115.756642] ath9k: Driver halt
[  115.783163] sd 0:0:0:0: [sda] Synchronizing SCSI cache
[  115.783598] sd 0:0:0:0: [sda] Stopping disk
[  116.710137] ath9k 0000:01:00.0: PCI INT A disabled
[  116.734702] ACPI handle has no context!
[  116.734716] atl1c 0000:02:00.0: PME# disabled
[  116.734726] ACPI handle has no context!
[  116.778319] ata6: port disabled. ignoring.
[  116.778395] ata_piix 0000:00:1f.1: PCI INT A disabled
[  116.778413] ehci_hcd 0000:00:1d.7: PCI INT A disabled
[  116.778425] uhci_hcd 0000:00:1d.3: PCI INT D disabled
[  116.778436] uhci_hcd 0000:00:1d.2: PCI INT C disabled
[  116.778447] uhci_hcd 0000:00:1d.1: PCI INT B disabled
[  116.778458] uhci_hcd 0000:00:1d.0: PCI INT A disabled
[  116.794206] i915 0000:00:02.0: PCI INT A disabled
[  116.805495] ehci_hcd 0000:00:1d.7: PME# disabled
[  116.816424] ACPI: Preparing to enter system sleep state S3
[  116.910764] Disabling non-boot CPUs ...
[  116.913107] CPU 1 is now offline
[  116.913113] SMP alternatives: switching to UP code
[  116.917119] CPU1 is down
[  116.917142] x86 PAT enabled: cpu 0, old 0x7040600070406, new 0x7010600070106
[  116.917142] Back to C!
[  116.917142] Enabling non-boot CPUs ...
[  116.917142] SMP alternatives: switching to SMP code
[  116.920718] Booting processor 1 APIC 0x1 ip 0x6000
[  116.916492] Initializing CPU#1
[  116.916492] Calibrating delay using timer specific routine.. 3331.29 BogoMIPS (lpj=1665646)
[  116.916492] CPU: L1 I cache: 32K, L1 D cache: 24K
[  116.916492] CPU: L2 cache: 512K
[  116.916492] CPU: Physical Processor ID: 0
[  116.916492] CPU: Processor Core ID: 0
[  116.916492] mce: CPU supports 5 MCE banks
[  116.916492] x86 PAT enabled: cpu 1, old 0x7040600070406, new 0x7010600070106
[  116.991936] CPU1: Intel(R) Atom(TM) CPU N280   @ 1.66GHz stepping 02
[  116.992269] Switched to high resolution mode on CPU 1
[  116.996025] CPU1 is up
[  116.996032] ACPI: Waking up from system sleep state S3
[  117.358521] pcieport-driver 0000:00:1c.0: restoring config space at offset 0x1 (was 0x100104, writing 0x100504)
[  117.358609] pcieport-driver 0000:00:1c.1: restoring config space at offset 0x1 (was 0x100107, writing 0x100507)
[  117.358694] pcieport-driver 0000:00:1c.2: restoring config space at offset 0x1 (was 0x100106, writing 0x100506)
[  117.358767] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001)
[  117.358812] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001)
[  117.358855] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001)
[  117.358898] uhci_hcd 0000:00:1d.3: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001)
[  117.358951] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x1 (was 0x2900106, writing 0x2900102)
[  117.358976] ehci_hcd 0000:00:1d.7: PME# disabled
[  117.359162] ahci 0000:00:1f.2: restoring config space at offset 0x1 (was 0x2b00007, writing 0x2b00407)
[  117.721142] i915 0000:00:02.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[  117.721150] i915 0000:00:02.0: setting latency timer to 64
[  117.782697] [drm] LVDS-8: set mode 1024x600 e
[  117.802897] pci 0000:00:02.1: PME# disabled
[  117.802907] pci 0000:00:1b.0: PME# disabled
[  117.802934] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 23 (level, low) -> IRQ 23
[  117.802944] uhci_hcd 0000:00:1d.0: setting latency timer to 64
[  117.802973] usb usb2: root hub lost power or was reset
[  117.802998] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 22 (level, low) -> IRQ 22
[  117.803021] uhci_hcd 0000:00:1d.1: setting latency timer to 64
[  117.803048] usb usb3: root hub lost power or was reset
[  117.803073] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 21 (level, low) -> IRQ 21
[  117.803083] uhci_hcd 0000:00:1d.2: setting latency timer to 64
[  117.803109] usb usb4: root hub lost power or was reset
[  117.803133] uhci_hcd 0000:00:1d.3: PCI INT D -> GSI 20 (level, low) -> IRQ 20
[  117.803143] uhci_hcd 0000:00:1d.3: setting latency timer to 64
[  117.803169] usb usb5: root hub lost power or was reset
[  117.803207] ehci_hcd 0000:00:1d.7: PME# disabled
[  117.803215] ehci_hcd 0000:00:1d.7: PCI INT A -> GSI 23 (level, low) -> IRQ 23
[  117.803224] ehci_hcd 0000:00:1d.7: setting latency timer to 64
[  117.803264] pci 0000:00:1e.0: setting latency timer to 64
[  117.803285] ata_piix 0000:00:1f.1: PCI INT A -> GSI 18 (level, low) -> IRQ 18
[  117.803296] ata_piix 0000:00:1f.1: setting latency timer to 64
[  117.804929] ata6: port disabled. ignoring.
[  117.804956] ahci 0000:00:1f.2: setting latency timer to 64
[  117.805035] atl1c 0000:02:00.0: PME# disabled
[  117.805043] atl1c 0000:02:00.0: PME# disabled
[  117.868714] atl1c 0000:02:00.0: irq 28 for MSI/MSI-X
[  117.868799] ath9k 0000:01:00.0: PCI INT A -> GSI 18 (level, low) -> IRQ 18
[  118.110161] ata3: SATA link down (SStatus 0 SControl 300)
[  118.161152] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
[  118.165385] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 filtered out
[  118.168239] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 filtered out
[  118.168643] ata1.00: configured for UDMA/133
[  118.179174] ata1: exception Emask 0x10 SAct 0x0 SErr 0x0 action 0xf t4
[  118.179183] ata1: irq_stat 0x00400040, connection status changed
[  118.179202] ata1: hard resetting link
[  118.340197] sd 0:0:0:0: [sda] Starting disk
[  118.902173] ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
[  118.971400] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 filtered out
[  118.974183] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 filtered out
[  118.974608] ata1.00: configured for UDMA/133
[  118.974621] ata1: EH complete
[  119.133147] usb 1-8: reset high speed USB device using ehci_hcd and address 3
[  119.413139] usb 5-1: reset full speed USB device using uhci_hcd and address 2
[  120.128210] ath9k: Starting driver with initial channel: 2437 MHz
[  120.277768] ath9k: timeout (100000 us) on reg 0x7000: 0xdeadbeef & 0x00000003 != 0x00000000
[  120.277804] ath9k: Attach a VIF of type: 2
[  120.277853] ath9k: Set channel: 2437 MHz
[  120.277860] ath9k: tx chmask: 1, rx chmask: 1
[  120.277875] ath9k: Set HW RX filter: 0x2707
[  120.277883] ath9k: RX filter 0x0 bssid 00:22:6b:56:fd:e8 aid 0x0
[  120.277892] ath9k: BSS Changed PREAMBLE 1
[  120.277897] ath9k: BSS Changed CTS PROT 0
[  120.277902] ath9k: BSS Changed ASSOC 1
[  120.277906] ath9k: Bss Info ASSOC 1, bssid: 00:22:6b:56:fd:e8
[  120.280886] PM: Finishing wakeup.
[  120.280892] Restarting tasks ... done.
[  121.233472] irq 18: nobody cared (try booting with the "irqpoll" option)
[  121.233488] Pid: 2336, comm: gnome-terminal Not tainted 2.6.31.4-intel-menlow #13
[  121.233495] Call Trace:
[  121.233513]  [<c105ca3e>] __report_bad_irq+0x2e/0x6f
[  121.233525]  [<c105cb74>] note_interrupt+0xf5/0x14d
[  121.233535]  [<c105d0a4>] handle_fasteoi_irq+0x7d/0x9b
[  121.233546]  [<c10048c1>] handle_irq+0x3b/0x46
[  121.233555]  [<c1004103>] do_IRQ+0x41/0x95
[  121.233564]  [<c1003189>] common_interrupt+0x29/0x30
[  121.233571] handlers:
[  121.233576] [<f89bad03>] (ath_isr+0x0/0x12f [ath9k])
[  121.233616] Disabling IRQ #18
[  134.922394] atl1c 0000:02:00.0: atl1c: eth0 NIC Link is Up<100 Mbps Full Duplex>