https://bugs.freedesktop.org/show_bug.cgi?id=42162

--- Comment #21 from Johan Brannlund freedesktop-bugs@nullinfinity.org --- Comment on attachment 83689 --> https://bugs.freedesktop.org/attachment.cgi?id=83689 3.11-rc3 suspend/resume, both cards powered up before suspend

Aug 6 00:14:53 mars kernel: [ 143.123335] PM: Syncing filesystems ... done. Aug 6 00:15:18 mars kernel: [ 143.265460] Freezing user space processes ... (elapsed 0.001 seconds) done. Aug 6 00:15:18 mars kernel: [ 143.267108] Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done. Aug 6 00:15:18 mars kernel: [ 143.268729] Suspending console(s) (use no_console_suspend to debug) Aug 6 00:15:18 mars kernel: [ 143.269239] brcmsmac bcma0:0: brcmsmac: brcms_ops_bss_info_changed: disassociated Aug 6 00:15:18 mars kernel: [ 143.269245] brcmsmac bcma0:0: brcms_ops_bss_info_changed: arp filtering: 1 addresses (implement) Aug 6 00:15:18 mars kernel: [ 143.269247] brcmsmac bcma0:0: brcms_ops_bss_info_changed: qos enabled: false (implement) Aug 6 00:15:18 mars kernel: [ 143.297269] sd 0:0:0:0: [sda] Synchronizing SCSI cache Aug 6 00:15:18 mars kernel: [ 143.297339] cfg80211: Calling CRDA to update world regulatory domain Aug 6 00:15:18 mars kernel: [ 143.297341] sd 0:0:0:0: [sda] Stopping disk Aug 6 00:15:18 mars kernel: [ 143.387143] i8042 aux 00:07: System wakeup disabled by ACPI Aug 6 00:15:18 mars kernel: [ 143.387217] i8042 kbd 00:06: System wakeup enabled by ACPI Aug 6 00:15:18 mars kernel: [ 144.703766] PM: suspend of devices complete after 1434.453 msecs Aug 6 00:15:18 mars kernel: [ 144.704050] PM: late suspend of devices complete after 0.279 msecs Aug 6 00:15:18 mars kernel: [ 144.705302] pcieport 0000:00:06.0: System wakeup enabled by ACPI Aug 6 00:15:18 mars kernel: [ 144.735807] ehci-pci 0000:00:16.2: System wakeup enabled by ACPI Aug 6 00:15:18 mars kernel: [ 144.751774] ehci-pci 0000:00:13.2: System wakeup enabled by ACPI Aug 6 00:15:18 mars kernel: [ 144.767674] ohci-pci 0000:00:13.0: System wakeup enabled by ACPI Aug 6 00:15:18 mars kernel: [ 144.767707] ehci-pci 0000:00:12.2: System wakeup enabled by ACPI Aug 6 00:15:18 mars kernel: [ 144.783677] ohci-pci 0000:00:12.0: System wakeup enabled by ACPI Aug 6 00:15:18 mars kernel: [ 144.783802] PM: noirq suspend of devices complete after 79.730 msecs Aug 6 00:15:18 mars kernel: [ 144.783866] ACPI: Preparing to enter system sleep state S3 Aug 6 00:15:18 mars kernel: [ 144.793732] PM: Saving platform NVS memory Aug 6 00:15:18 mars kernel: [ 144.798121] Disabling non-boot CPUs ... Aug 6 00:15:18 mars kernel: [ 144.798530] Broke affinity for irq 19 Aug 6 00:15:18 mars kernel: [ 144.799604] smpboot: CPU 1 is now offline Aug 6 00:15:18 mars kernel: [ 144.903635] smpboot: CPU 2 is now offline Aug 6 00:15:18 mars kernel: [ 144.904260] Broke affinity for irq 17 Aug 6 00:15:18 mars kernel: [ 145.007704] smpboot: CPU 3 is now offline Aug 6 00:15:18 mars kernel: [ 145.008505] ACPI: Low-level resume complete Aug 6 00:15:18 mars kernel: [ 145.008555] PM: Restoring platform NVS memory Aug 6 00:15:18 mars kernel: [ 145.010313] PCI-DMA: Resuming GART IOMMU Aug 6 00:15:18 mars kernel: [ 145.010314] PCI-DMA: Restoring GART aperture settings Aug 6 00:15:18 mars kernel: [ 145.010614] Enabling non-boot CPUs ... Aug 6 00:15:18 mars kernel: [ 145.010663] smpboot: Booting Node 0 Processor 1 APIC 0x1 Aug 6 00:15:18 mars kernel: [ 145.021636] [Firmware Bug]: cpu 1, try to use APIC500 (LVT offset 0) for vector 0x400, but the register is already in use for vector 0xf9 on another cpu Aug 6 00:15:18 mars kernel: [ 145.021638] perf: IBS APIC setup failed on cpu #1 Aug 6 00:15:18 mars kernel: [ 145.023788] process: Switch to broadcast mode on CPU1 Aug 6 00:15:18 mars kernel: [ 145.024075] CPU1 is up Aug 6 00:15:18 mars kernel: [ 145.024094] smpboot: Booting Node 0 Processor 2 APIC 0x2 Aug 6 00:15:18 mars kernel: [ 145.035062] [Firmware Bug]: cpu 2, try to use APIC500 (LVT offset 0) for vector 0x400, but the register is already in use for vector 0xf9 on another cpu Aug 6 00:15:18 mars kernel: [ 145.035064] perf: IBS APIC setup failed on cpu #2 Aug 6 00:15:18 mars kernel: [ 145.037208] process: Switch to broadcast mode on CPU2 Aug 6 00:15:18 mars kernel: [ 145.037422] CPU2 is up Aug 6 00:15:18 mars kernel: [ 145.037440] smpboot: Booting Node 0 Processor 3 APIC 0x3 Aug 6 00:15:18 mars kernel: [ 145.037956] ------------[ cut here ]------------ Aug 6 00:15:18 mars kernel: [ 145.037967] WARNING: CPU: 2 PID: 0 at /home/apw/COD/linux/kernel/time/tick-broadcast.c:667 tick_broadcast_oneshot_control+0x18c/0x1a0() Aug 6 00:15:18 mars kernel: [ 145.038014] Modules linked in: arc4 brcmsmac cordic brcmutil b43 mac80211 cfg80211 joydev ssb hp_wmi sparse_keymap snd_hda_codec_hdmi snd_hda_codec_idt snd_seq_midi snd_hda_intel dm_multipath snd_hda_codec snd_seq_midi_event scsi_dh snd_hwdep snd_pcm snd_rawmidi psmouse uvcvideo edac_core edac_mce_amd k10temp videobuf2_vmalloc sp5100_tco videobuf2_memops serio_raw videobuf2_core videodev snd_page_alloc i2c_piix4 snd_seq snd_seq_device snd_timer bcma snd hp_accel lis3lv02d input_polldev soundcore shpchp parport_pc bnep rfcomm ppdev mac_hid bluetooth lp parport binfmt_misc btrfs xor zlib_deflate raid6_pq libcrc32c dm_mirror dm_region_hash dm_log radeon r8169 i2c_algo_bit video ttm drm_kms_helper mii drm ahci libahci wmi Aug 6 00:15:18 mars kernel: [ 145.038017] CPU: 2 PID: 0 Comm: swapper/2 Not tainted 3.11.0-031100rc3-generic #201307290035 Aug 6 00:15:18 mars kernel: [ 145.038018] Hardware name: Hewlett-Packard HP Pavilion dv6 Notebook PC/1440, BIOS F.14 09/10/2010 Aug 6 00:15:18 mars kernel: [ 145.038022] 000000000000029b ffff880196c91da8 ffffffff8171e4fb ffffffff81c380e8 Aug 6 00:15:18 mars kernel: [ 145.038024] 0000000000000000 ffff880196c91de8 ffffffff8106532c 0000000000000000 Aug 6 00:15:18 mars kernel: [ 145.038026] 0000000000000002 0000000000000086 ffffffff81c25780 ffff88019fd0dcc0 Aug 6 00:15:18 mars kernel: [ 145.038027] Call Trace: Aug 6 00:15:18 mars kernel: [ 145.038033] [<ffffffff8171e4fb>] dump_stack+0x46/0x58 Aug 6 00:15:18 mars kernel: [ 145.038036] [<ffffffff8106532c>] warn_slowpath_common+0x8c/0xc0 Aug 6 00:15:18 mars kernel: [ 145.038038] [<ffffffff8106537a>] warn_slowpath_null+0x1a/0x20 Aug 6 00:15:18 mars kernel: [ 145.038041] [<ffffffff810c4afc>] tick_broadcast_oneshot_control+0x18c/0x1a0 Aug 6 00:15:18 mars kernel: [ 145.038044] [<ffffffff810c2fa8>] clockevents_notify+0x1c8/0x200 Aug 6 00:15:18 mars kernel: [ 145.038047] [<ffffffff8101c905>] amd_e400_idle+0x75/0x100 Aug 6 00:15:18 mars kernel: [ 145.038050] [<ffffffff8101d066>] arch_cpu_idle+0x26/0x30 Aug 6 00:15:18 mars kernel: [ 145.038053] [<ffffffff810ba5fe>] cpu_idle_loop+0x7e/0x250 Aug 6 00:15:18 mars kernel: [ 145.038055] [<ffffffff810ba83b>] cpu_startup_entry+0x6b/0x70 Aug 6 00:15:18 mars kernel: [ 145.038059] [<ffffffff81041fb8>] start_secondary+0xc8/0xd0 Aug 6 00:15:18 mars kernel: [ 145.038061] ---[ end trace 8e8458fd39f3bee8 ]--- Aug 6 00:15:18 mars kernel: [ 145.048405] [Firmware Bug]: cpu 3, try to use APIC500 (LVT offset 0) for vector 0x400, but the register is already in use for vector 0xf9 on another cpu Aug 6 00:15:18 mars kernel: [ 145.048407] perf: IBS APIC setup failed on cpu #3 Aug 6 00:15:18 mars kernel: [ 145.050583] process: Switch to broadcast mode on CPU3 Aug 6 00:15:18 mars kernel: [ 145.050818] CPU3 is up Aug 6 00:15:18 mars kernel: [ 145.052350] ACPI: Waking up from system sleep state S3 Aug 6 00:15:18 mars kernel: [ 145.062962] ohci-pci 0000:00:12.0: System wakeup disabled by ACPI Aug 6 00:15:18 mars kernel: [ 145.078070] ehci-pci 0000:00:12.2: System wakeup disabled by ACPI Aug 6 00:15:18 mars kernel: [ 145.078102] ohci-pci 0000:00:13.0: System wakeup disabled by ACPI Aug 6 00:15:18 mars kernel: [ 145.094073] ehci-pci 0000:00:13.2: System wakeup disabled by ACPI Aug 6 00:15:18 mars kernel: [ 145.126080] ehci-pci 0000:00:16.2: System wakeup disabled by ACPI Aug 6 00:15:18 mars kernel: [ 145.206232] PM: noirq resume of devices complete after 143.426 msecs Aug 6 00:15:18 mars kernel: [ 145.206454] PM: early resume of devices complete after 0.158 msecs Aug 6 00:15:18 mars kernel: [ 145.212236] snd_hda_intel 0000:02:00.1: irq 44 for MSI/MSI-X Aug 6 00:15:18 mars kernel: [ 145.213099] pcieport 0000:00:06.0: System wakeup disabled by ACPI Aug 6 00:15:18 mars kernel: [ 145.220381] [drm] PCIE GART of 512M enabled (table at 0x00000000C0040000). Aug 6 00:15:18 mars kernel: [ 145.220535] radeon 0000:01:05.0: WB enabled Aug 6 00:15:18 mars kernel: [ 145.220538] radeon 0000:01:05.0: fence driver on ring 0 use gpu addr 0x00000000a0000c00 and cpu addr 0xffff88018faabc00 Aug 6 00:15:18 mars kernel: [ 145.220540] radeon 0000:01:05.0: fence driver on ring 3 use gpu addr 0x00000000a0000c0c and cpu addr 0xffff88018faabc0c Aug 6 00:15:18 mars kernel: [ 145.220839] radeon 0000:01:05.0: setting latency timer to 64 Aug 6 00:15:18 mars kernel: [ 145.252689] [drm] ring test on 0 succeeded in 0 usecs Aug 6 00:15:18 mars kernel: [ 145.252747] [drm] ring test on 3 succeeded in 1 usecs Aug 6 00:15:18 mars kernel: [ 145.252782] [drm] ib test on ring 0 succeeded in 0 usecs Aug 6 00:15:18 mars kernel: [ 145.252800] [drm] ib test on ring 3 succeeded in 1 usecs Aug 6 00:15:18 mars kernel: [ 145.254635] switching from power state: Aug 6 00:15:18 mars kernel: [ 145.254638] ui class: none Aug 6 00:15:18 mars kernel: [ 145.254639] internal class: boot Aug 6 00:15:18 mars kernel: [ 145.254640] caps: Aug 6 00:15:18 mars kernel: [ 145.254642] uvd vclk: 0 dclk: 0 Aug 6 00:15:18 mars kernel: [ 145.254643] power level 0 sclk: 50000 vddc_index: 2 Aug 6 00:15:18 mars kernel: [ 145.254644] power level 1 sclk: 50000 vddc_index: 2 Aug 6 00:15:18 mars kernel: [ 145.254645] status: c b Aug 6 00:15:18 mars kernel: [ 145.254646] switching to power state: Aug 6 00:15:18 mars kernel: [ 145.254647] ui class: battery Aug 6 00:15:18 mars kernel: [ 145.254648] internal class: none Aug 6 00:15:18 mars kernel: [ 145.254648] caps: single_disp Aug 6 00:15:18 mars kernel: [ 145.254649] uvd vclk: 0 dclk: 0 Aug 6 00:15:18 mars kernel: [ 145.254650] power level 0 sclk: 20000 vddc_index: 1 Aug 6 00:15:18 mars kernel: [ 145.254650] power level 1 sclk: 20000 vddc_index: 1 Aug 6 00:15:18 mars kernel: [ 145.254651] status: r Aug 6 00:15:18 mars kernel: [ 145.274368] r8169 0000:04:00.0 eth0: link down Aug 6 00:15:18 mars kernel: [ 145.274573] i8042 kbd 00:06: System wakeup disabled by ACPI Aug 6 00:15:18 mars kernel: [ 145.290499] [drm] enabling PCIE gen 2 link speeds, disable with radeon.pcie_gen2=0 Aug 6 00:15:18 mars kernel: [ 145.290516] [drm] Loading REDWOOD Microcode Aug 6 00:15:18 mars kernel: [ 145.290527] ------------[ cut here ]------------ Aug 6 00:15:18 mars kernel: [ 145.290536] WARNING: CPU: 1 PID: 3002 at /home/apw/COD/linux/drivers/base/firmware_class.c:1082 _request_firmware+0x194/0x1b0() Aug 6 00:15:18 mars kernel: [ 145.290579] Modules linked in: arc4 brcmsmac cordic brcmutil b43 mac80211 cfg80211 joydev ssb hp_wmi sparse_keymap snd_hda_codec_hdmi snd_hda_codec_idt snd_seq_midi snd_hda_intel dm_multipath snd_hda_codec snd_seq_midi_event scsi_dh snd_hwdep snd_pcm snd_rawmidi psmouse uvcvideo edac_core edac_mce_amd k10temp videobuf2_vmalloc sp5100_tco videobuf2_memops serio_raw videobuf2_core videodev snd_page_alloc i2c_piix4 snd_seq snd_seq_device snd_timer bcma snd hp_accel lis3lv02d input_polldev soundcore shpchp parport_pc bnep rfcomm ppdev mac_hid bluetooth lp parport binfmt_misc btrfs xor zlib_deflate raid6_pq libcrc32c dm_mirror dm_region_hash dm_log radeon r8169 i2c_algo_bit video ttm drm_kms_helper mii drm ahci libahci wmi Aug 6 00:15:18 mars kernel: [ 145.290583] CPU: 1 PID: 3002 Comm: kworker/u8:16 Tainted: G W 3.11.0-031100rc3-generic #201307290035 Aug 6 00:15:18 mars kernel: [ 145.290584] Hardware name: Hewlett-Packard HP Pavilion dv6 Notebook PC/1440, BIOS F.14 09/10/2010 Aug 6 00:15:18 mars kernel: [ 145.290590] Workqueue: events_unbound async_run_entry_fn Aug 6 00:15:18 mars kernel: [ 145.290593] 000000000000043a ffff88018fb9bac8 ffffffff8171e4fb 0000000000001a2a Aug 6 00:15:18 mars kernel: [ 145.290595] 0000000000000000 ffff88018fb9bb08 ffffffff8106532c ffff88018fb9bb18 Aug 6 00:15:18 mars kernel: [ 145.290597] ffff88018f2dddf0 ffff880196eef098 ffff88018fb9bbe2 0000000000003a98 Aug 6 00:15:18 mars kernel: [ 145.290598] Call Trace: Aug 6 00:15:18 mars kernel: [ 145.290603] [<ffffffff8171e4fb>] dump_stack+0x46/0x58 Aug 6 00:15:18 mars kernel: [ 145.290607] [<ffffffff8106532c>] warn_slowpath_common+0x8c/0xc0 Aug 6 00:15:18 mars kernel: [ 145.290609] [<ffffffff8106537a>] warn_slowpath_null+0x1a/0x20 Aug 6 00:15:18 mars kernel: [ 145.290611] [<ffffffff81497c44>] _request_firmware+0x194/0x1b0 Aug 6 00:15:18 mars kernel: [ 145.290616] [<ffffffff81497cff>] request_firmware+0x3f/0x60 Aug 6 00:15:18 mars kernel: [ 145.290662] [<ffffffffa013d17e>] r600_init_microcode+0x56e/0x620 [radeon] Aug 6 00:15:18 mars kernel: [ 145.290696] [<ffffffffa015ca38>] evergreen_startup+0x338/0x4d0 [radeon] Aug 6 00:15:18 mars kernel: [ 145.290726] [<ffffffffa0154711>] ? evergreen_init_golden_registers+0xe1/0x200 [radeon] Aug 6 00:15:18 mars kernel: [ 145.290756] [<ffffffffa015cf10>] evergreen_resume+0x40/0x90 [radeon] Aug 6 00:15:18 mars kernel: [ 145.290776] [<ffffffffa00f25f6>] radeon_resume_kms+0x76/0x1a0 [radeon] Aug 6 00:15:18 mars kernel: [ 145.290795] [<ffffffffa00d70cd>] radeon_pci_resume+0x1d/0x20 [radeon] Aug 6 00:15:18 mars kernel: [ 145.290799] [<ffffffff8139f8b1>] pci_legacy_resume+0x41/0x60 Aug 6 00:15:18 mars kernel: [ 145.290802] [<ffffffff813a03b8>] pci_pm_resume+0x98/0xe0 Aug 6 00:15:18 mars kernel: [ 145.290804] [<ffffffff813a0320>] ? pci_pm_thaw+0x80/0x80 Aug 6 00:15:18 mars kernel: [ 145.290807] [<ffffffff8148f139>] dpm_run_callback+0x39/0x60 Aug 6 00:15:18 mars kernel: [ 145.290810] [<ffffffff8148f429>] device_resume+0xa9/0x190 Aug 6 00:15:18 mars kernel: [ 145.290812] [<ffffffff8148f531>] async_resume+0x21/0x50 Aug 6 00:15:18 mars kernel: [ 145.290815] [<ffffffff81093d9b>] async_run_entry_fn+0x3b/0x140 Aug 6 00:15:18 mars kernel: [ 145.290817] [<ffffffff810849a0>] process_one_work+0x170/0x4a0 Aug 6 00:15:18 mars kernel: [ 145.290820] [<ffffffff81085a61>] worker_thread+0x121/0x390 Aug 6 00:15:18 mars kernel: [ 145.290822] [<ffffffff81085940>] ? manage_workers.isra.20+0x170/0x170 Aug 6 00:15:18 mars kernel: [ 145.290825] [<ffffffff8108c8d0>] kthread+0xc0/0xd0 Aug 6 00:15:18 mars kernel: [ 145.290828] [<ffffffff8108c810>] ? flush_kthread_worker+0xb0/0xb0 Aug 6 00:15:18 mars kernel: [ 145.290830] [<ffffffff81732eec>] ret_from_fork+0x7c/0xb0 Aug 6 00:15:18 mars kernel: [ 145.290833] [<ffffffff8108c810>] ? flush_kthread_worker+0xb0/0xb0 Aug 6 00:15:18 mars kernel: [ 145.290835] ---[ end trace 8e8458fd39f3bee9 ]--- Aug 6 00:15:18 mars kernel: [ 145.290838] radeon 0000:02:00.0: firmware: radeon/REDWOOD_smc.bin will not be loaded Aug 6 00:15:18 mars kernel: [ 145.290841] r600_cp: Failed to load firmware "radeon/REDWOOD_smc.bin" Aug 6 00:15:18 mars kernel: [ 145.290843] [drm:evergreen_startup] *ERROR* Failed to load firmware! Aug 6 00:15:18 mars kernel: [ 145.290844] [drm:evergreen_resume] *ERROR* evergreen startup failed on resume Aug 6 00:15:18 mars kernel: [ 145.291183] [drm:cypress_dpm_enable] *ERROR* rv770_upload_firmware failed Aug 6 00:15:18 mars kernel: [ 145.291184] [drm:radeon_pm_resume_dpm] *ERROR* radeon: dpm resume failed Aug 6 00:15:18 mars kernel: [ 145.434108] usb 6-1: reset full-speed USB device number 2 using ohci-pci Aug 6 00:15:18 mars kernel: [ 145.534146] ata4: SATA link down (SStatus 0 SControl 300) Aug 6 00:15:18 mars kernel: [ 145.706273] usb 1-3: reset high-speed USB device number 2 using ehci-pci Aug 6 00:15:18 mars kernel: [ 145.706279] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300) Aug 6 00:15:18 mars kernel: [ 145.710161] ata2: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Aug 6 00:15:18 mars kernel: [ 145.726931] ata1.00: configured for UDMA/133 Aug 6 00:15:18 mars kernel: [ 145.728941] ata2.00: configured for UDMA/100 Aug 6 00:15:18 mars kernel: [ 145.746865] sd 0:0:0:0: [sda] Starting disk Aug 6 00:15:18 mars kernel: [ 154.646773] PM: resume of devices complete after 9438.155 msecs Aug 6 00:15:18 mars rtkit-daemon[1849]: The canary thread is apparently starving. Taking action. Aug 6 00:15:18 mars rtkit-daemon[1849]: Demoting known real-time threads. Aug 6 00:15:18 mars rtkit-daemon[1849]: Successfully demoted thread 1854 of process 1846 (n/a). Aug 6 00:15:18 mars rtkit-daemon[1849]: Successfully demoted thread 1853 of process 1846 (n/a). Aug 6 00:15:18 mars rtkit-daemon[1849]: Successfully demoted thread 1852 of process 1846 (n/a). Aug 6 00:15:18 mars rtkit-daemon[1849]: Successfully demoted thread 1846 of process 1846 (n/a). Aug 6 00:15:18 mars rtkit-daemon[1849]: Demoted 4 threads. Aug 6 00:15:18 mars acpid: client 1333[0:0] has disconnected Aug 6 00:15:18 mars kernel: [ 154.655659] Restarting tasks ... done. Aug 6 00:15:18 mars kernel: [ 154.677972] video LNXVIDEO:00: Restoring backlight state Aug 6 00:15:18 mars kernel: [ 154.679920] video LNXVIDEO:01: Restoring backlight state Aug 6 00:15:18 mars acpid: client connected from 1333[0:0] Aug 6 00:15:18 mars acpid: 1 client rule loaded Aug 6 00:15:18 mars anacron[3134]: Anacron 2.3 started on 2013-08-06 Aug 6 00:15:18 mars anacron[3134]: Will run job `cron.daily' in 5 min. Aug 6 00:15:18 mars anacron[3134]: Jobs will be executed sequentially Aug 6 00:15:24 mars acpid: client 1333[0:0] has disconnected Aug 6 00:15:24 mars acpid: client connected from 1333[0:0] Aug 6 00:15:24 mars acpid: 1 client rule loaded