Attachment 5649 Details for Bug 14676 – dmesg entries for period spanning hibernation and restoring.

dmesg entries for period spanning hibernation and restoring.

dmesg-hibernate (text/plain), 8.52 KB, created by w unruh on 2014-11-28 03:03:32 CET

(hide)

Description:

Filename:

MIME Type:

Creator: w unruh

Created: 2014-11-28 03:03:32 CET

Size: 8.52 KB

patch

obsolete

>[   92.165801] EXT3-fs (dm-0): mounted filesystem with ordered data mode
>[ 2551.912721] ip_tables: (C) 2000-2006 Netfilter Core Team
>[ 3261.170585] ata1.00: configured for UDMA/100
>[ 3261.170590] ata1: EH complete
>[ 3261.538205] EXT4-fs (sda5): re-mounted. Opts: acl,commit=0
>[ 3261.615780] EXT4-fs (sda7): re-mounted. Opts: commit=0
>[ 3261.749794] EXT4-fs (sda8): re-mounted. Opts: acl,commit=0
>[ 3261.763120] EXT4-fs (sda9): re-mounted. Opts: commit=0
>[ 3266.877005] Syncing filesystems ... done.
>[ 3266.919033] Freezing user space processes ... (elapsed 0.001 seconds) done.
>[ 3266.920526] PM: Marking nosave pages: [mem 0x0009e000-0x000fffff]
>[ 3266.920529] PM: Marking nosave pages: [mem 0x20000000-0x201fffff]
>[ 3266.920535] PM: Basic memory bitmaps created
>[ 3267.483805] PM: Preallocating image memory... done (allocated 712632 pages)
>[ 3267.918938] PM: Allocated 2850528 kbytes in 0.43 seconds (6629.13 MB/s)
>[ 3267.918940] Freezing remaining freezable tasks ... (elapsed 0.048 seconds) done.
>[ 3267.967251] Suspending console(s) (use no_console_suspend to debug)
>[ 3267.967274] wlp3s0: deauthenticating from d0:72:dc:2c:5c:2f by local choice (reason=3)
>[ 3267.991984] cfg80211: Calling CRDA to update world regulatory domain
>[ 3268.242800] PM: freeze of devices complete after 275.236 msecs
>[ 3268.242913] PM: late freeze of devices complete after 0.111 msecs
>[ 3268.243812] PM: noirq freeze of devices complete after 0.896 msecs
>[ 3268.243991] ACPI: Preparing to enter system sleep state S4
>[ 3268.267437] PM: Saving platform NVS memory
>[ 3268.267845] Disabling non-boot CPUs ...
>[ 3268.268040] Cannot set affinity for irq 0
>[ 3268.269121] kvm: disabling virtualization on CPU1
>[ 3268.269139] smpboot: CPU 1 is now offline
>[ 3268.270730] kvm: disabling virtualization on CPU2
>[ 3268.270736] smpboot: CPU 2 is now offline
>[ 3268.271316] Broke affinity for irq 44
>[ 3268.272375] kvm: disabling virtualization on CPU3
>[ 3268.272387] smpboot: CPU 3 is now offline
>[ 3268.272731] PM: Creating hibernation image:
>[ 3268.324615] PM: Need to copy 144383 pages
>[ 3268.324617] PM: Normal pages needed: 41562 + 1024, available pages: 167677
>[ 3268.273436] PM: Restoring platform NVS memory
>[ 3268.274186] microcode: CPU0 sig=0x206a7, pf=0x10, revision=0x29
>[ 3268.274212] Enabling non-boot CPUs ...
>[ 3268.274269] x86: Booting SMP configuration:
>[ 3268.274270] smpboot: Booting Node 0 Processor 1 APIC 0x2
>[ 3268.284480] Initializing CPU#1
>[ 3268.285290] Leaving ESR disabled.
>[ 3268.285338] kvm: enabling virtualization on CPU1
>[ 3268.287580] Intel pstate controlling: cpu 1
>[ 3268.287626] microcode: CPU1 sig=0x206a7, pf=0x10, revision=0x15
>[ 3268.288152] microcode: CPU1 updated to revision 0x29, date = 2013-06-12
>[ 3268.288161] CPU1 is up
>[ 3268.288180] smpboot: Booting Node 0 Processor 2 APIC 0x1
>[ 3268.298548] Initializing CPU#2
>[ 3268.299300] Leaving ESR disabled.
>[ 3268.299355] kvm: enabling virtualization on CPU2
>[ 3268.301634] Intel pstate controlling: cpu 2
>[ 3268.301687] microcode: CPU2 sig=0x206a7, pf=0x10, revision=0x15
>[ 3268.302011] microcode: CPU2 updated to revision 0x29, date = 2013-06-12
>[ 3268.302017] CPU2 is up
>[ 3268.302041] smpboot: Booting Node 0 Processor 3 APIC 0x3
>[ 3268.312437] Initializing CPU#3
>[ 3268.313162] Leaving ESR disabled.
>[ 3268.313215] kvm: enabling virtualization on CPU3
>[ 3268.315515] Intel pstate controlling: cpu 3
>[ 3268.315566] microcode: CPU3 sig=0x206a7, pf=0x10, revision=0x29
>[ 3268.315572] CPU3 is up
>[ 3268.318716] ACPI: Waking up from system sleep state S4
>[ 3268.543275] INT3403 INT3403:00: Unsupported event [0x91]
>[ 3268.594324] INT3403 INT3403:01: Unsupported event [0x91]
>[ 3268.638374] INT3403 INT3403:02: Unsupported event [0x91]
>[ 3268.690427] INT3403 INT3403:03: Unsupported event [0x91]
>[ 3268.768841] PM: noirq restore of devices complete after 33.398 msecs
>[ 3268.768975] PM: early restore of devices complete after 0.084 msecs
>[ 3268.799955] mei_me 0000:00:16.0: irq 51 for MSI/MSI-X
>[ 3268.799963] e1000e 0000:00:19.0: irq 52 for MSI/MSI-X
>[ 3268.800038] usb usb1: root hub lost power or was reset
>[ 3268.800595] snd_hda_intel 0000:00:1b.0: irq 54 for MSI/MSI-X
>[ 3268.800824] usb usb3: root hub lost power or was reset
>[ 3268.801324] usb usb2: root hub lost power or was reset
>[ 3268.801325] usb usb4: root hub lost power or was reset
>[ 3268.803182] iwlwifi 0000:03:00.0: RF_KILL bit toggled to enable radio.
>[ 3268.803954] ehci-pci 0000:00:1a.0: cache line size of 64 is not supported
>[ 3268.804741] ehci-pci 0000:00:1d.0: cache line size of 64 is not supported
>[ 3268.819974] xhci_hcd 0000:02:00.0: irq 46 for MSI/MSI-X
>[ 3268.819981] xhci_hcd 0000:02:00.0: irq 47 for MSI/MSI-X
>[ 3268.819987] xhci_hcd 0000:02:00.0: irq 48 for MSI/MSI-X
>[ 3268.819994] xhci_hcd 0000:02:00.0: irq 49 for MSI/MSI-X
>[ 3268.820000] xhci_hcd 0000:02:00.0: irq 50 for MSI/MSI-X
>[ 3268.824702] [drm] Wrong MCH_SSKPD value: 0x17050407
>[ 3268.824703] [drm] This can cause pipe underruns and display issues.
>[ 3268.824703] [drm] Please upgrade your BIOS to fix this.
>[ 3268.901573] pciehp 0000:00:1c.4:pcie04: Device 0000:0d:00.0 already exists at 0000:0d:00, cannot hot-add
>[ 3268.901575] pciehp 0000:00:1c.4:pcie04: Cannot add device at 0000:0d:00
>[ 3268.956703] tpm_tis 00:09: TPM is disabled/deactivated (0x7)
>[ 3269.118861] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
>[ 3269.119500] ata1.00: ACPI cmd ef/10:06:00:00:00:00 (SET FEATURES) succeeded
>[ 3269.119502] ata1.00: ACPI cmd f5/00:00:00:00:00:00 (SECURITY FREEZE LOCK) filtered out
>[ 3269.124929] usb 3-1: reset high-speed USB device number 2 using ehci-pci
>[ 3269.125867] ata2: SATA link down (SStatus 4 SControl 300)
>[ 3269.165571] ata1.00: ACPI cmd ef/10:06:00:00:00:00 (SET FEATURES) succeeded
>[ 3269.165573] ata1.00: ACPI cmd f5/00:00:00:00:00:00 (SECURITY FREEZE LOCK) filtered out
>[ 3269.166437] ata1.00: configured for UDMA/100
>[ 3269.176987] sd 0:0:0:0: [sda] Starting disk
>[ 3269.341184] usb 1-1: reset high-speed USB device number 2 using ehci-pci
>[ 3269.359211] iwlwifi 0000:03:00.0: L1 Disabled; Enabling L0S
>[ 3269.359313] iwlwifi 0000:03:00.0: Radio type=0x1-0x2-0x0
>[ 3269.732794] usb 1-1.1: reset high-speed USB device number 3 using ehci-pci
>[ 3269.821170] PM: restore of devices complete after 1020.154 msecs
>[ 3269.821446] xhci_hcd 0000:02:00.0: no hotplug settings from platform
>[ 3269.821472] iwlwifi 0000:03:00.0: no hotplug settings from platform
>[ 3269.821628] pci_bus 0000:09: busn_res: can not insert [bus 09-ff] under [bus 04-0c] (conflicts with (null) [bus 04-0c])
>[ 3269.821633] pci_bus 0000:09: busn_res: [bus 09-ff] end is updated to 0c
>[ 3269.821640] pci_bus 0000:09: Allocating resources
>[ 3269.821643] yenta_cardbus 0000:04:00.0: CardBus bridge to [bus 09-0c]
>[ 3269.821645] yenta_cardbus 0000:04:00.0:   bridge window [io  0x8000-0x80ff]
>[ 3269.821651] yenta_cardbus 0000:04:00.0:   bridge window [io  0x8400-0x84ff]
>[ 3269.821657] yenta_cardbus 0000:04:00.0:   bridge window [mem 0xf5800000-0xf6bfffff pref]
>[ 3269.821662] yenta_cardbus 0000:04:00.0:   bridge window [mem 0xf7000000-0xf73fffff]
>[ 3269.834140] Restarting kernel threads ... done.
>[ 3269.834326] PM: Basic memory bitmaps freed
>[ 3269.834328] Restarting tasks ... done.
>[ 3269.938721] [drm] Enabling RC6 states: RC6 on, RC6p off, RC6pp off
>[ 3270.567172] video LNXVIDEO:00: Restoring backlight state
>[ 3272.046283] cfg80211: World regulatory domain updated:
>[ 3272.046287] cfg80211:  DFS Master region: unset
>[ 3272.046288] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp)
>[ 3272.046289] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm)
>[ 3272.046291] cfg80211:   (2457000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm)
>[ 3272.046291] cfg80211:   (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm)
>[ 3272.046292] cfg80211:   (5170000 KHz - 5250000 KHz @ 80000 KHz), (N/A, 2000 mBm)
>[ 3272.046293] cfg80211:   (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm)
>[ 3272.046294] cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm)
>[ 3272.046392] cfg80211: Calling CRDA for country: CA
>[ 3272.047966] cfg80211: Regulatory domain changed to country: CA
>[ 3272.047969] cfg80211:  DFS Master region: unset
>[ 3272.047970] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp)
>[ 3272.047971] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 3000 mBm)
>[ 3272.047973] cfg80211:   (5170000 KHz - 5250000 KHz @ 80000 KHz), (N/A, 1700 mBm)
>[ 3272.047974] cfg80211:   (5250000 KHz - 5330000 KHz @ 80000 KHz), (N/A, 2400 mBm)
>[ 3272.047975] cfg80211:   (5490000 KHz - 5730000 KHz @ 80000 KHz), (N/A, 2400 mBm)
>[ 3272.047976] cfg80211:   (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 3000 mBm)

[   92.165801] EXT3-fs (dm-0): mounted filesystem with ordered data mode
[ 2551.912721] ip_tables: (C) 2000-2006 Netfilter Core Team
[ 3261.170585] ata1.00: configured for UDMA/100
[ 3261.170590] ata1: EH complete
[ 3261.538205] EXT4-fs (sda5): re-mounted. Opts: acl,commit=0
[ 3261.615780] EXT4-fs (sda7): re-mounted. Opts: commit=0
[ 3261.749794] EXT4-fs (sda8): re-mounted. Opts: acl,commit=0
[ 3261.763120] EXT4-fs (sda9): re-mounted. Opts: commit=0
[ 3266.877005] Syncing filesystems ... done.
[ 3266.919033] Freezing user space processes ... (elapsed 0.001 seconds) done.
[ 3266.920526] PM: Marking nosave pages: [mem 0x0009e000-0x000fffff]
[ 3266.920529] PM: Marking nosave pages: [mem 0x20000000-0x201fffff]
[ 3266.920535] PM: Basic memory bitmaps created
[ 3267.483805] PM: Preallocating image memory... done (allocated 712632 pages)
[ 3267.918938] PM: Allocated 2850528 kbytes in 0.43 seconds (6629.13 MB/s)
[ 3267.918940] Freezing remaining freezable tasks ... (elapsed 0.048 seconds) done.
[ 3267.967251] Suspending console(s) (use no_console_suspend to debug)
[ 3267.967274] wlp3s0: deauthenticating from d0:72:dc:2c:5c:2f by local choice (reason=3)
[ 3267.991984] cfg80211: Calling CRDA to update world regulatory domain
[ 3268.242800] PM: freeze of devices complete after 275.236 msecs
[ 3268.242913] PM: late freeze of devices complete after 0.111 msecs
[ 3268.243812] PM: noirq freeze of devices complete after 0.896 msecs
[ 3268.243991] ACPI: Preparing to enter system sleep state S4
[ 3268.267437] PM: Saving platform NVS memory
[ 3268.267845] Disabling non-boot CPUs ...
[ 3268.268040] Cannot set affinity for irq 0
[ 3268.269121] kvm: disabling virtualization on CPU1
[ 3268.269139] smpboot: CPU 1 is now offline
[ 3268.270730] kvm: disabling virtualization on CPU2
[ 3268.270736] smpboot: CPU 2 is now offline
[ 3268.271316] Broke affinity for irq 44
[ 3268.272375] kvm: disabling virtualization on CPU3
[ 3268.272387] smpboot: CPU 3 is now offline
[ 3268.272731] PM: Creating hibernation image:
[ 3268.324615] PM: Need to copy 144383 pages
[ 3268.324617] PM: Normal pages needed: 41562 + 1024, available pages: 167677
[ 3268.273436] PM: Restoring platform NVS memory
[ 3268.274186] microcode: CPU0 sig=0x206a7, pf=0x10, revision=0x29
[ 3268.274212] Enabling non-boot CPUs ...
[ 3268.274269] x86: Booting SMP configuration:
[ 3268.274270] smpboot: Booting Node 0 Processor 1 APIC 0x2
[ 3268.284480] Initializing CPU#1
[ 3268.285290] Leaving ESR disabled.
[ 3268.285338] kvm: enabling virtualization on CPU1
[ 3268.287580] Intel pstate controlling: cpu 1
[ 3268.287626] microcode: CPU1 sig=0x206a7, pf=0x10, revision=0x15
[ 3268.288152] microcode: CPU1 updated to revision 0x29, date = 2013-06-12
[ 3268.288161] CPU1 is up
[ 3268.288180] smpboot: Booting Node 0 Processor 2 APIC 0x1
[ 3268.298548] Initializing CPU#2
[ 3268.299300] Leaving ESR disabled.
[ 3268.299355] kvm: enabling virtualization on CPU2
[ 3268.301634] Intel pstate controlling: cpu 2
[ 3268.301687] microcode: CPU2 sig=0x206a7, pf=0x10, revision=0x15
[ 3268.302011] microcode: CPU2 updated to revision 0x29, date = 2013-06-12
[ 3268.302017] CPU2 is up
[ 3268.302041] smpboot: Booting Node 0 Processor 3 APIC 0x3
[ 3268.312437] Initializing CPU#3
[ 3268.313162] Leaving ESR disabled.
[ 3268.313215] kvm: enabling virtualization on CPU3
[ 3268.315515] Intel pstate controlling: cpu 3
[ 3268.315566] microcode: CPU3 sig=0x206a7, pf=0x10, revision=0x29
[ 3268.315572] CPU3 is up
[ 3268.318716] ACPI: Waking up from system sleep state S4
[ 3268.543275] INT3403 INT3403:00: Unsupported event [0x91]
[ 3268.594324] INT3403 INT3403:01: Unsupported event [0x91]
[ 3268.638374] INT3403 INT3403:02: Unsupported event [0x91]
[ 3268.690427] INT3403 INT3403:03: Unsupported event [0x91]
[ 3268.768841] PM: noirq restore of devices complete after 33.398 msecs
[ 3268.768975] PM: early restore of devices complete after 0.084 msecs
[ 3268.799955] mei_me 0000:00:16.0: irq 51 for MSI/MSI-X
[ 3268.799963] e1000e 0000:00:19.0: irq 52 for MSI/MSI-X
[ 3268.800038] usb usb1: root hub lost power or was reset
[ 3268.800595] snd_hda_intel 0000:00:1b.0: irq 54 for MSI/MSI-X
[ 3268.800824] usb usb3: root hub lost power or was reset
[ 3268.801324] usb usb2: root hub lost power or was reset
[ 3268.801325] usb usb4: root hub lost power or was reset
[ 3268.803182] iwlwifi 0000:03:00.0: RF_KILL bit toggled to enable radio.
[ 3268.803954] ehci-pci 0000:00:1a.0: cache line size of 64 is not supported
[ 3268.804741] ehci-pci 0000:00:1d.0: cache line size of 64 is not supported
[ 3268.819974] xhci_hcd 0000:02:00.0: irq 46 for MSI/MSI-X
[ 3268.819981] xhci_hcd 0000:02:00.0: irq 47 for MSI/MSI-X
[ 3268.819987] xhci_hcd 0000:02:00.0: irq 48 for MSI/MSI-X
[ 3268.819994] xhci_hcd 0000:02:00.0: irq 49 for MSI/MSI-X
[ 3268.820000] xhci_hcd 0000:02:00.0: irq 50 for MSI/MSI-X
[ 3268.824702] [drm] Wrong MCH_SSKPD value: 0x17050407
[ 3268.824703] [drm] This can cause pipe underruns and display issues.
[ 3268.824703] [drm] Please upgrade your BIOS to fix this.
[ 3268.901573] pciehp 0000:00:1c.4:pcie04: Device 0000:0d:00.0 already exists at 0000:0d:00, cannot hot-add
[ 3268.901575] pciehp 0000:00:1c.4:pcie04: Cannot add device at 0000:0d:00
[ 3268.956703] tpm_tis 00:09: TPM is disabled/deactivated (0x7)
[ 3269.118861] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
[ 3269.119500] ata1.00: ACPI cmd ef/10:06:00:00:00:00 (SET FEATURES) succeeded
[ 3269.119502] ata1.00: ACPI cmd f5/00:00:00:00:00:00 (SECURITY FREEZE LOCK) filtered out
[ 3269.124929] usb 3-1: reset high-speed USB device number 2 using ehci-pci
[ 3269.125867] ata2: SATA link down (SStatus 4 SControl 300)
[ 3269.165571] ata1.00: ACPI cmd ef/10:06:00:00:00:00 (SET FEATURES) succeeded
[ 3269.165573] ata1.00: ACPI cmd f5/00:00:00:00:00:00 (SECURITY FREEZE LOCK) filtered out
[ 3269.166437] ata1.00: configured for UDMA/100
[ 3269.176987] sd 0:0:0:0: [sda] Starting disk
[ 3269.341184] usb 1-1: reset high-speed USB device number 2 using ehci-pci
[ 3269.359211] iwlwifi 0000:03:00.0: L1 Disabled; Enabling L0S
[ 3269.359313] iwlwifi 0000:03:00.0: Radio type=0x1-0x2-0x0
[ 3269.732794] usb 1-1.1: reset high-speed USB device number 3 using ehci-pci
[ 3269.821170] PM: restore of devices complete after 1020.154 msecs
[ 3269.821446] xhci_hcd 0000:02:00.0: no hotplug settings from platform
[ 3269.821472] iwlwifi 0000:03:00.0: no hotplug settings from platform
[ 3269.821628] pci_bus 0000:09: busn_res: can not insert [bus 09-ff] under [bus 04-0c] (conflicts with (null) [bus 04-0c])
[ 3269.821633] pci_bus 0000:09: busn_res: [bus 09-ff] end is updated to 0c
[ 3269.821640] pci_bus 0000:09: Allocating resources
[ 3269.821643] yenta_cardbus 0000:04:00.0: CardBus bridge to [bus 09-0c]
[ 3269.821645] yenta_cardbus 0000:04:00.0:   bridge window [io  0x8000-0x80ff]
[ 3269.821651] yenta_cardbus 0000:04:00.0:   bridge window [io  0x8400-0x84ff]
[ 3269.821657] yenta_cardbus 0000:04:00.0:   bridge window [mem 0xf5800000-0xf6bfffff pref]
[ 3269.821662] yenta_cardbus 0000:04:00.0:   bridge window [mem 0xf7000000-0xf73fffff]
[ 3269.834140] Restarting kernel threads ... done.
[ 3269.834326] PM: Basic memory bitmaps freed
[ 3269.834328] Restarting tasks ... done.
[ 3269.938721] [drm] Enabling RC6 states: RC6 on, RC6p off, RC6pp off
[ 3270.567172] video LNXVIDEO:00: Restoring backlight state
[ 3272.046283] cfg80211: World regulatory domain updated:
[ 3272.046287] cfg80211:  DFS Master region: unset
[ 3272.046288] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp)
[ 3272.046289] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 2000 mBm)
[ 3272.046291] cfg80211:   (2457000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm)
[ 3272.046291] cfg80211:   (2474000 KHz - 2494000 KHz @ 20000 KHz), (N/A, 2000 mBm)
[ 3272.046292] cfg80211:   (5170000 KHz - 5250000 KHz @ 80000 KHz), (N/A, 2000 mBm)
[ 3272.046293] cfg80211:   (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 2000 mBm)
[ 3272.046294] cfg80211:   (57240000 KHz - 63720000 KHz @ 2160000 KHz), (N/A, 0 mBm)
[ 3272.046392] cfg80211: Calling CRDA for country: CA
[ 3272.047966] cfg80211: Regulatory domain changed to country: CA
[ 3272.047969] cfg80211:  DFS Master region: unset
[ 3272.047970] cfg80211:   (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp)
[ 3272.047971] cfg80211:   (2402000 KHz - 2472000 KHz @ 40000 KHz), (N/A, 3000 mBm)
[ 3272.047973] cfg80211:   (5170000 KHz - 5250000 KHz @ 80000 KHz), (N/A, 1700 mBm)
[ 3272.047974] cfg80211:   (5250000 KHz - 5330000 KHz @ 80000 KHz), (N/A, 2400 mBm)
[ 3272.047975] cfg80211:   (5490000 KHz - 5730000 KHz @ 80000 KHz), (N/A, 2400 mBm)
[ 3272.047976] cfg80211:   (5735000 KHz - 5835000 KHz @ 80000 KHz), (N/A, 3000 mBm)

Actions: View

Attachments on bug 14676: 5649 | 5650