Attachment 83053 Details for Bug 42162 – Suspend/resume log with kernel 3.10.3 (patched)

Suspend/resume log with kernel 3.10.3 (patched)

susplog2 (text/plain), 14.25 KB, created by Johan Brannlund on 2013-07-26 19:51:33 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Johan Brannlund

Created: 2013-07-26 19:51:33 UTC

Size: 14.25 KB

patch

obsolete

>Jul 26 15:43:09 mars kernel: [   66.546193] Freezing user space processes ... (elapsed 0.01 seconds) done.
>Jul 26 15:43:09 mars kernel: [   66.561365] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
>Jul 26 15:43:09 mars kernel: [   66.577496] Suspending console(s) (use no_console_suspend to debug)
>Jul 26 15:43:09 mars kernel: [   66.578055] sd 0:0:0:0: [sda] Synchronizing SCSI cache
>Jul 26 15:43:09 mars kernel: [   66.579756] sd 0:0:0:0: [sda] Stopping disk
>Jul 26 15:43:09 mars kernel: [   66.667976] i8042 aux 00:07: System wakeup disabled by ACPI
>Jul 26 15:43:09 mars kernel: [   66.668004] i8042 kbd 00:06: System wakeup enabled by ACPI
>Jul 26 15:43:09 mars kernel: [   67.725627] PM: suspend of devices complete after 1147.633 msecs
>Jul 26 15:43:09 mars kernel: [   67.725885] PM: late suspend of devices complete after 0.253 msecs
>Jul 26 15:43:09 mars kernel: [   67.727151] pcieport 0000:00:06.0: System wakeup enabled by ACPI
>Jul 26 15:43:09 mars kernel: [   67.741653] ehci-pci 0000:00:16.2: System wakeup enabled by ACPI
>Jul 26 15:43:09 mars kernel: [   67.757672] ehci-pci 0000:00:13.2: System wakeup enabled by ACPI
>Jul 26 15:43:09 mars kernel: [   67.773507] ohci_hcd 0000:00:13.0: System wakeup enabled by ACPI
>Jul 26 15:43:09 mars kernel: [   67.773540] ehci-pci 0000:00:12.2: System wakeup enabled by ACPI
>Jul 26 15:43:09 mars kernel: [   67.789511] ohci_hcd 0000:00:12.0: System wakeup enabled by ACPI
>Jul 26 15:43:09 mars kernel: [   67.789633] PM: noirq suspend of devices complete after 63.728 msecs
>Jul 26 15:43:09 mars kernel: [   67.789695] ACPI: Preparing to enter system sleep state S3
>Jul 26 15:43:09 mars kernel: [   67.795677] PM: Saving platform NVS memory
>Jul 26 15:43:09 mars kernel: [   67.799856] Disabling non-boot CPUs ...
>Jul 26 15:43:09 mars kernel: [   67.800315] Broke affinity for irq 18
>Jul 26 15:43:09 mars kernel: [   67.801376] smpboot: CPU 1 is now offline
>Jul 26 15:43:09 mars kernel: [   67.905465] smpboot: CPU 2 is now offline
>Jul 26 15:43:09 mars kernel: [   67.907127] smpboot: CPU 3 is now offline
>Jul 26 15:43:09 mars kernel: [   67.907903] ACPI: Low-level resume complete
>Jul 26 15:43:09 mars kernel: [   67.907949] PM: Restoring platform NVS memory
>Jul 26 15:43:09 mars kernel: [   67.909661] PCI-DMA: Resuming GART IOMMU
>Jul 26 15:43:09 mars kernel: [   67.909662] PCI-DMA: Restoring GART aperture settings
>Jul 26 15:43:09 mars kernel: [   67.909927] microcode: CPU0: new patch_level=0x010000c8
>Jul 26 15:43:09 mars kernel: [   67.909956] Enabling non-boot CPUs ...
>Jul 26 15:43:09 mars kernel: [   67.909999] smpboot: Booting Node 0 Processor 1 APIC 0x1
>Jul 26 15:43:09 mars kernel: [   67.920971] [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
>Jul 26 15:43:09 mars kernel: [   67.920973] perf: IBS APIC setup failed on cpu #1
>Jul 26 15:43:09 mars kernel: [   67.923154] process: Switch to broadcast mode on CPU1
>Jul 26 15:43:09 mars kernel: [   67.923417] microcode: CPU1: new patch_level=0x010000c8
>Jul 26 15:43:09 mars kernel: [   67.923423] CPU1 is up
>Jul 26 15:43:09 mars kernel: [   67.923442] smpboot: Booting Node 0 Processor 2 APIC 0x2
>Jul 26 15:43:09 mars kernel: [   67.923679] ------------[ cut here ]------------
>Jul 26 15:43:09 mars kernel: [   67.923689] WARNING: at kernel/time/tick-broadcast.c:640 tick_broadcast_oneshot_control+0x180/0x190()
>Jul 26 15:43:09 mars kernel: [   67.923725] Modules linked in: dm_crypt(F) joydev(F) hp_wmi(F) sparse_keymap(F) snd_hda_codec_hdmi(F) kvm_amd(F) kvm(F) microcode(F) snd_hda_codec_idt(F) psmouse(F) snd_hda_intel(F) uvcvideo(F) snd_hda_codec(F) edac_core(F) k10temp(F) videobuf2_core(F) edac_mce_amd(F) serio_raw(F) snd_hwdep(F) videodev(F) videobuf2_vmalloc(F) videobuf2_memops(F) snd_seq_midi(F) snd_pcm(F) sp5100_tco(F) snd_rawmidi(F) i2c_piix4(F) snd_seq_midi_event(F) snd_seq(F) snd_timer(F) snd_seq_device(F) hp_accel(F) lis3lv02d(F) snd(F) input_polldev(F) mac_hid(F) soundcore(F) bnep(F) snd_page_alloc(F) rfcomm(F) shpchp(F) bluetooth(F) parport_pc(F) ppdev(F) lp(F) parport(F) nfsd(F) nfs_acl(F) auth_rpcgss(F) nfs(F) fscache(F) lockd(F) binfmt_misc(F) sunrpc(F) ahci(F) libahci(F) video(F) wmi(F) radeon(F) r8169(F) ttm(F) drm_kms_helper(F) drm(F) i2c_algo_bit(F)
>Jul 26 15:43:09 mars kernel: [   67.923730] CPU: 1 PID: 0 Comm: swapper/1 Tainted: GF            3.10.3backlight #1
>Jul 26 15:43:09 mars kernel: [   67.923731] Hardware name: Hewlett-Packard HP Pavilion dv6 Notebook PC/1440, BIOS F.14 09/10/2010
>Jul 26 15:43:09 mars kernel: [   67.923735]  0000000000000009 ffff880196c43d08 ffffffff816ad8b9 ffff880196c43d48
>Jul 26 15:43:09 mars kernel: [   67.923738]  ffffffff81043950 ffff880196c43d38 0000000000000001 0000000000000004
>Jul 26 15:43:09 mars kernel: [   67.923740]  ffff88019fc8cdc0 0000000000000002 ffffffff81c1f000 ffff880196c43d58
>Jul 26 15:43:09 mars kernel: [   67.923741] Call Trace:
>Jul 26 15:43:09 mars kernel: [   67.923747]  [<ffffffff816ad8b9>] dump_stack+0x19/0x1b
>Jul 26 15:43:09 mars kernel: [   67.923751]  [<ffffffff81043950>] warn_slowpath_common+0x70/0xa0
>Jul 26 15:43:09 mars kernel: [   67.923754]  [<ffffffff8104399a>] warn_slowpath_null+0x1a/0x20
>Jul 26 15:43:09 mars kernel: [   67.923757]  [<ffffffff8109e900>] tick_broadcast_oneshot_control+0x180/0x190
>Jul 26 15:43:09 mars kernel: [   67.923759]  [<ffffffff8109dcad>] tick_notify+0x33d/0x450
>Jul 26 15:43:09 mars kernel: [   67.923762]  [<ffffffff816b7dfd>] notifier_call_chain+0x4d/0x70
>Jul 26 15:43:09 mars kernel: [   67.923766]  [<ffffffff8106ee7e>] __raw_notifier_call_chain+0xe/0x10
>Jul 26 15:43:09 mars kernel: [   67.923768]  [<ffffffff8106ee96>] raw_notifier_call_chain+0x16/0x20
>Jul 26 15:43:09 mars kernel: [   67.923771]  [<ffffffff8109d177>] clockevents_notify+0x37/0x1a0
>Jul 26 15:43:09 mars kernel: [   67.923774]  [<ffffffff8100a9e4>] amd_e400_idle+0x44/0xf0
>Jul 26 15:43:09 mars kernel: [   67.923777]  [<ffffffff8100b12e>] arch_cpu_idle+0x1e/0x30
>Jul 26 15:43:09 mars kernel: [   67.923780]  [<ffffffff810952c0>] cpu_startup_entry+0xd0/0x250
>Jul 26 15:43:09 mars kernel: [   67.923783]  [<ffffffff8169e9bf>] start_secondary+0x1e1/0x1e8
>Jul 26 15:43:09 mars kernel: [   67.923784] ---[ end trace 33f7e702dbac90e2 ]---
>Jul 26 15:43:09 mars kernel: [   67.934404] [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
>Jul 26 15:43:09 mars kernel: [   67.934406] perf: IBS APIC setup failed on cpu #2
>Jul 26 15:43:09 mars kernel: [   67.936584] process: Switch to broadcast mode on CPU2
>Jul 26 15:43:09 mars kernel: [   67.936773] microcode: CPU2: new patch_level=0x010000c8
>Jul 26 15:43:09 mars kernel: [   67.936778] CPU2 is up
>Jul 26 15:43:09 mars kernel: [   67.936794] smpboot: Booting Node 0 Processor 3 APIC 0x3
>Jul 26 15:43:09 mars kernel: [   67.947757] [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
>Jul 26 15:43:09 mars kernel: [   67.947759] perf: IBS APIC setup failed on cpu #3
>Jul 26 15:43:09 mars kernel: [   67.949902] process: Switch to broadcast mode on CPU3
>Jul 26 15:43:09 mars kernel: [   67.950089] microcode: CPU3: new patch_level=0x010000c8
>Jul 26 15:43:09 mars kernel: [   67.950093] CPU3 is up
>Jul 26 15:43:09 mars kernel: [   67.953045] ACPI: Waking up from system sleep state S3
>Jul 26 15:43:09 mars kernel: [   67.963574] ohci_hcd 0000:00:12.0: System wakeup disabled by ACPI
>Jul 26 15:43:09 mars kernel: [   67.975792] ehci-pci 0000:00:12.2: System wakeup disabled by ACPI
>Jul 26 15:43:09 mars kernel: [   67.975822] ohci_hcd 0000:00:13.0: System wakeup disabled by ACPI
>Jul 26 15:43:09 mars kernel: [   67.991806] ehci-pci 0000:00:13.2: System wakeup disabled by ACPI
>Jul 26 15:43:09 mars kernel: [   68.023818] ehci-pci 0000:00:16.2: System wakeup disabled by ACPI
>Jul 26 15:43:09 mars kernel: [   68.095816] pci_raw_set_power_state: 48 callbacks suppressed
>Jul 26 15:43:09 mars kernel: [   68.095821] radeon 0000:02:00.0: Refused to change power state, currently in D3
>Jul 26 15:43:09 mars kernel: [   68.167806] snd_hda_intel 0000:02:00.1: Refused to change power state, currently in D3
>Jul 26 15:43:09 mars kernel: [   68.183989] PM: noirq resume of devices complete after 220.550 msecs
>Jul 26 15:43:09 mars kernel: [   68.184173] PM: early resume of devices complete after 0.151 msecs
>Jul 26 15:43:09 mars kernel: [   68.190873] pcieport 0000:00:06.0: System wakeup disabled by ACPI
>Jul 26 15:43:09 mars kernel: [   68.193882] [drm] PCIE GART of 512M enabled (table at 0x00000000C0040000).
>Jul 26 15:43:09 mars kernel: [   68.194025] radeon 0000:01:05.0: WB enabled
>Jul 26 15:43:09 mars kernel: [   68.194029] radeon 0000:01:05.0: fence driver on ring 0 use gpu addr 0x00000000a0000c00 and cpu addr 0xffff880192223c00
>Jul 26 15:43:09 mars kernel: [   68.194031] radeon 0000:01:05.0: fence driver on ring 3 use gpu addr 0x00000000a0000c0c and cpu addr 0xffff880192223c0c
>Jul 26 15:43:09 mars kernel: [   68.194319] radeon 0000:01:05.0: setting latency timer to 64
>Jul 26 15:43:09 mars kernel: [   68.226204] [drm] ring test on 0 succeeded in 0 usecs
>Jul 26 15:43:09 mars kernel: [   68.226262] [drm] ring test on 3 succeeded in 1 usecs
>Jul 26 15:43:09 mars kernel: [   68.226282] [drm] ib test on ring 0 succeeded in 0 usecs
>Jul 26 15:43:09 mars kernel: [   68.226311] [drm] ib test on ring 3 succeeded in 1 usecs
>Jul 26 15:43:09 mars kernel: [   68.248398] i8042 kbd 00:06: System wakeup disabled by ACPI
>Jul 26 15:43:09 mars kernel: [   68.268094] r8169 0000:04:00.0 eth0: link down
>Jul 26 15:43:09 mars kernel: [   68.435874] usb 1-3: reset high-speed USB device number 2 using ehci-pci
>Jul 26 15:43:09 mars kernel: [   68.507900] ata4: SATA link down (SStatus 0 SControl 300)
>Jul 26 15:43:09 mars kernel: [   68.679873] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
>Jul 26 15:43:09 mars kernel: [   68.684790] ata2: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
>Jul 26 15:43:09 mars kernel: [   68.696556] ata1.00: configured for UDMA/133
>Jul 26 15:43:09 mars kernel: [   68.703347] ata2.00: configured for UDMA/100
>Jul 26 15:43:09 mars kernel: [   68.703877] usb 6-1: reset full-speed USB device number 2 using ohci_hcd
>Jul 26 15:43:09 mars kernel: [   68.711963] sd 0:0:0:0: [sda] Starting disk
>Jul 26 15:43:09 mars kernel: [   77.576829] PM: resume of devices complete after 9390.496 msecs
>Jul 26 15:43:09 mars acpid: client 1218[0:0] has disconnected
>Jul 26 15:43:09 mars rtkit-daemon[1653]: The canary thread is apparently starving. Taking action.
>Jul 26 15:43:09 mars rtkit-daemon[1653]: Demoting known real-time threads.
>Jul 26 15:43:09 mars rtkit-daemon[1653]: Successfully demoted thread 1963 of process 1946 (n/a).
>Jul 26 15:43:09 mars rtkit-daemon[1653]: Successfully demoted thread 1962 of process 1946 (n/a).
>Jul 26 15:43:09 mars rtkit-daemon[1653]: Successfully demoted thread 1952 of process 1946 (n/a).
>Jul 26 15:43:09 mars rtkit-daemon[1653]: Successfully demoted thread 1946 of process 1946 (n/a).
>Jul 26 15:43:09 mars rtkit-daemon[1653]: Demoted 4 threads.
>Jul 26 15:43:09 mars kernel: [   77.577750] Restarting tasks ... done.
>Jul 26 15:43:09 mars kernel: [   77.598954] video LNXVIDEO:00: Restoring backlight state
>Jul 26 15:43:09 mars kernel: [   77.601495] video LNXVIDEO:01: Restoring backlight state
>Jul 26 15:43:09 mars acpid: client connected from 1218[0:0]
>Jul 26 15:43:09 mars acpid: 1 client rule loaded
>Jul 26 15:43:09 mars anacron[2874]: Anacron 2.3 started on 2013-07-26
>Jul 26 15:43:09 mars anacron[2874]: Normal exit (0 jobs run)
>Jul 26 15:43:09 mars anacron[2928]: Anacron 2.3 started on 2013-07-26
>Jul 26 15:43:09 mars anacron[2928]: Normal exit (0 jobs run)
>Jul 26 15:43:14 mars kernel: [   82.634976] [drm:atom_op_jump] *ERROR* atombios stuck in loop for more than 5secs aborting
>Jul 26 15:43:14 mars kernel: [   82.634986] [drm:atom_execute_table_locked] *ERROR* atombios stuck executing CC40 (len 62, WS 0, PS 0) @ 0xCC5C
>Jul 26 15:43:19 mars kernel: [   87.640124] [drm:atom_op_jump] *ERROR* atombios stuck in loop for more than 5secs aborting
>Jul 26 15:43:19 mars kernel: [   87.640134] [drm:atom_execute_table_locked] *ERROR* atombios stuck executing CC40 (len 62, WS 0, PS 0) @ 0xCC5C
>Jul 26 15:43:19 mars kernel: [   87.640138] [drm:atom_execute_table_locked] *ERROR* atombios stuck executing C306 (len 854, WS 0, PS 0) @ 0xC363
>Jul 26 15:43:24 mars kernel: [   92.665276] [drm:atom_op_jump] *ERROR* atombios stuck in loop for more than 5secs aborting
>Jul 26 15:43:24 mars kernel: [   92.665285] [drm:atom_execute_table_locked] *ERROR* atombios stuck executing D0AE (len 72, WS 0, PS 0) @ 0xD0DD
>Jul 26 15:43:29 mars kernel: [   97.670422] [drm:atom_op_jump] *ERROR* atombios stuck in loop for more than 5secs aborting
>Jul 26 15:43:29 mars kernel: [   97.670432] [drm:atom_execute_table_locked] *ERROR* atombios stuck executing CC40 (len 62, WS 0, PS 0) @ 0xCC5C
>Jul 26 15:43:34 mars kernel: [  102.675571] [drm:atom_op_jump] *ERROR* atombios stuck in loop for more than 5secs aborting
>Jul 26 15:43:34 mars kernel: [  102.675582] [drm:atom_execute_table_locked] *ERROR* atombios stuck executing CC40 (len 62, WS 0, PS 0) @ 0xCC5C
>Jul 26 15:43:39 mars kernel: [  107.680730] [drm:atom_op_jump] *ERROR* atombios stuck in loop for more than 5secs aborting
>Jul 26 15:43:39 mars kernel: [  107.680740] [drm:atom_execute_table_locked] *ERROR* atombios stuck executing CC40 (len 62, WS 0, PS 0) @ 0xCC5C
>Jul 26 15:43:44 mars kernel: [  112.685867] [drm:atom_op_jump] *ERROR* atombios stuck in loop for more than 5secs aborting
>Jul 26 15:43:44 mars kernel: [  112.685877] [drm:atom_execute_table_locked] *ERROR* atombios stuck executing CC40 (len 62, WS 0, PS 0) @ 0xCC5C
>Jul 26 15:43:49 mars kernel: [  117.691013] [drm:atom_op_jump] *ERROR* atombios stuck in loop for more than 5secs aborting
>Jul 26 15:43:49 mars kernel: [  117.691023] [drm:atom_execute_table_locked] *ERROR* atombios stuck executing CC40 (len 62, WS 0, PS 0) @ 0xCC5C
>Jul 26 15:43:54 mars kernel: [  122.696161] [drm:atom_op_jump] *ERROR* atombios stuck in loop for more than 5secs aborting
>Jul 26 15:43:54 mars kernel: [  122.696170] [drm:atom_execute_table_locked] *ERROR* atombios stuck executing CC40 (len 62, WS 0, PS 0) @ 0xCC5C
>Jul 26 15:43:59 mars kernel: [  127.701322] [drm:atom_op_jump] *ERROR* atombios stuck in loop for more than 5secs aborting
>Jul 26 15:43:59 mars kernel: [  127.701331] [drm:atom_execute_table_locked] *ERROR* atombios stuck executing CC40 (len 62, WS 0, PS 0) @ 0xCC5C

Actions: View

Attachments on bug 42162: 52691 | 52692 | 52694 | 52695 | 72514 | 82375 | 83053 | 83689 | 83693 | 95513

Use of freedesktop.org services, including Bugzilla, is subject to our Code of Conduct. How we collect and use information is described in our Privacy Policy.