Re: WARNING: CPU: 4 PID: 863 at include/drm/drm_crtc.h:1577 drm_helper_choose_encoder_dpms+0x88/0x90()
From: Borislav Petkov
Date: Wed Sep 23 2015 - 05:00:08 EST
On Wed, Sep 23, 2015 at 09:25:23AM +0200, Daniel Vetter wrote:
> Strange thing is that I've tested this on a radeon over here and I don't
> see this backtrace ... wut. Below diff should appease the backtraces at
> least.
Doesn't look like it.
This is what it says when suspending:
[ 42.962275] hib.sh (3269): drop_caches: 3
[ 42.967671] PM: Hibernation mode set to 'shutdown'
[ 42.979329] PM: Syncing filesystems ... done.
[ 42.993401] Freezing user space processes ... (elapsed 0.002 seconds) done.
[ 43.003632] PM: Marking nosave pages: [mem 0x00000000-0x00000fff]
[ 43.009840] PM: Marking nosave pages: [mem 0x0009e000-0x000fffff]
[ 43.015991] PM: Marking nosave pages: [mem 0xba9b8000-0xbca4dfff]
[ 43.022241] PM: Marking nosave pages: [mem 0xbca4f000-0xbcc54fff]
[ 43.028357] PM: Marking nosave pages: [mem 0xbd083000-0xbd7f3fff]
[ 43.034500] PM: Marking nosave pages: [mem 0xbd800000-0x100000fff]
[ 43.041371] PM: Basic memory bitmaps created
[ 43.045656] PM: Preallocating image memory... done (allocated 128867 pages)
[ 43.346216] PM: Allocated 515468 kbytes in 0.29 seconds (1777.47 MB/s)
[ 43.352759] Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done.
[ 43.366104] ------------[ cut here ]------------
[ 43.370746] WARNING: CPU: 4 PID: 55 at include/drm/drm_crtc.h:1577 drm_helper_choose_encoder_dpms+0x88/0x90()
[ 43.380681] Modules linked in: binfmt_misc ipv6 vfat fat fuse dm_crypt dm_mod kvm_amd kvm crc32_pclmul aesni_intel ae
s_x86_64 lrw gf128mul glue_helper ablk_helper cryptd amd64_edac_mod k10temp fam15h_power edac_core amdkfd amd_iommu_v2 r
adeon acpi_cpufreq
[ 43.403916] CPU: 4 PID: 55 Comm: kworker/u16:2 Not tainted 4.3.0-rc2+ #3
[ 43.410633] Hardware name: To be filled by O.E.M. To be filled by O.E.M./M5A97 EVO R2.0, BIOS 1503 01/16/2013
[ 43.420567] Workqueue: events_unbound async_run_entry_fn
[ 43.425919] ffffffff8194ff67 ffff88042a223b60 ffffffff812c758a 0000000000000000
[ 43.433424] ffff88042a223b98 ffffffff810534c1 ffff880429eca000 ffff880429fe9200
[ 43.440959] ffff880429de1000 0000000000000000 ffffffff819571c3 ffff88042a223ba8
[ 43.448461] Call Trace:
[ 43.450929] [<ffffffff812c758a>] dump_stack+0x4e/0x84
[ 43.456094] [<ffffffff810534c1>] warn_slowpath_common+0x91/0xd0
[ 43.462126] [<ffffffff810535ba>] warn_slowpath_null+0x1a/0x20
[ 43.467983] [<ffffffff813bdc58>] drm_helper_choose_encoder_dpms+0x88/0x90
[ 43.474884] [<ffffffff813be0b6>] drm_helper_connector_dpms+0x56/0x110
[ 43.481463] [<ffffffffa003346b>] radeon_suspend_kms+0x6b/0x380 [radeon]
[ 43.488196] [<ffffffff816c0f2b>] ? _raw_spin_unlock_irqrestore+0x4b/0x80
[ 43.495020] [<ffffffff8130fe50>] ? pci_pm_poweroff+0x100/0x100
[ 43.500976] [<ffffffffa00311ac>] radeon_pmops_freeze+0x1c/0x20 [radeon]
[ 43.507730] [<ffffffff8130feba>] pci_pm_freeze+0x6a/0x100
[ 43.513241] [<ffffffff8130fe50>] ? pci_pm_poweroff+0x100/0x100
[ 43.519187] [<ffffffff8146e7e7>] dpm_run_callback+0x77/0x2a0
[ 43.524959] [<ffffffff8146f4a4>] __device_suspend+0x104/0x2c0
[ 43.530818] [<ffffffff8146f67f>] async_suspend+0x1f/0xa0
[ 43.536242] [<ffffffff81078a06>] async_run_entry_fn+0x46/0xf0
[ 43.542127] [<ffffffff8106f548>] process_one_work+0x1f8/0x640
[ 43.547984] [<ffffffff8106f4a4>] ? process_one_work+0x154/0x640
[ 43.554019] [<ffffffff8106f9db>] worker_thread+0x4b/0x440
[ 43.559530] [<ffffffff8107e133>] ? preempt_count_sub+0xb3/0x110
[ 43.565562] [<ffffffff8106f990>] ? process_one_work+0x640/0x640
[ 43.571603] [<ffffffff81075e86>] kthread+0xf6/0x110
[ 43.576597] [<ffffffff81075d90>] ? kthread_create_on_node+0x1f0/0x1f0
[ 43.583152] [<ffffffff816c1e3f>] ret_from_fork+0x3f/0x70
[ 43.588574] [<ffffffff81075d90>] ? kthread_create_on_node+0x1f0/0x1f0
[ 43.595170] ---[ end trace aab225b93a6f1dcc ]---
[ 43.595235] ------------[ cut here ]------------
[ 43.595240] WARNING: CPU: 5 PID: 55 at include/drm/drm_crtc.h:1577 drm_helper_choose_crtc_dpms+0x91/0xa0()
[ 43.595267] Modules linked in: binfmt_misc ipv6 vfat fat fuse dm_crypt dm_mod kvm_amd kvm crc32_pclmul aesni_intel aes_x86_64 lrw gf128mul glue_helper ablk_helper cryptd amd64_edac_mod k10temp fam15h_power edac_core amdkfd amd_iommu_v2 radeon acpi_cpufreq
[ 43.595271] CPU: 5 PID: 55 Comm: kworker/u16:2 Tainted: G W 4.3.0-rc2+ #3
[ 43.595272] Hardware name: To be filled by O.E.M. To be filled by O.E.M./M5A97 EVO R2.0, BIOS 1503 01/16/2013
[ 43.595276] Workqueue: events_unbound async_run_entry_fn
[ 43.595281] ffffffff8194ff67 ffff88042a223b60 ffffffff812c758a 0000000000000000
[ 43.595286] ffff88042a223b98 ffffffff810534c1 ffff880429eca000 ffff880429de1000
[ 43.595291] ffff880429de1000 0000000000000000 0000000000000003 ffff88042a223ba8
[ 43.595293] Call Trace:
[ 43.595295] [<ffffffff812c758a>] dump_stack+0x4e/0x84
[ 43.595298] [<ffffffff810534c1>] warn_slowpath_common+0x91/0xd0
[ 43.595300] [<ffffffff810535ba>] warn_slowpath_null+0x1a/0x20
[ 43.595303] [<ffffffff813bdcf1>] drm_helper_choose_crtc_dpms+0x91/0xa0
[ 43.595315] [<ffffffffa003d860>] ? atombios_blank_crtc+0x140/0x140 [radeon]
[ 43.595322] [<ffffffff813be124>] drm_helper_connector_dpms+0xc4/0x110
[ 43.595331] [<ffffffffa003346b>] radeon_suspend_kms+0x6b/0x380 [radeon]
[ 43.595334] [<ffffffff816c0f2b>] ? _raw_spin_unlock_irqrestore+0x4b/0x80
[ 43.595337] [<ffffffff8130fe50>] ? pci_pm_poweroff+0x100/0x100
[ 43.595346] [<ffffffffa00311ac>] radeon_pmops_freeze+0x1c/0x20 [radeon]
[ 43.595349] [<ffffffff8130feba>] pci_pm_freeze+0x6a/0x100
[ 43.595351] [<ffffffff8130fe50>] ? pci_pm_poweroff+0x100/0x100
[ 43.595353] [<ffffffff8146e7e7>] dpm_run_callback+0x77/0x2a0
[ 43.595356] [<ffffffff8146f4a4>] __device_suspend+0x104/0x2c0
[ 43.595358] [<ffffffff8146f67f>] async_suspend+0x1f/0xa0
[ 43.595361] [<ffffffff81078a06>] async_run_entry_fn+0x46/0xf0
[ 43.595363] [<ffffffff8106f548>] process_one_work+0x1f8/0x640
[ 43.595366] [<ffffffff8106f4a4>] ? process_one_work+0x154/0x640
[ 43.595369] [<ffffffff8106f9db>] worker_thread+0x4b/0x440
[ 43.595373] [<ffffffff8107e133>] ? preempt_count_sub+0xb3/0x110
[ 43.595375] [<ffffffff8106f990>] ? process_one_work+0x640/0x640
[ 43.595378] [<ffffffff81075e86>] kthread+0xf6/0x110
[ 43.595382] [<ffffffff81075d90>] ? kthread_create_on_node+0x1f0/0x1f0
[ 43.595385] [<ffffffff816c1e3f>] ret_from_fork+0x3f/0x70
[ 43.595387] [<ffffffff81075d90>] ? kthread_create_on_node+0x1f0/0x1f0
[ 43.595390] ---[ end trace aab225b93a6f1dcd ]---
[ 43.611465] ------------[ cut here ]------------
[ 43.611469] WARNING: CPU: 5 PID: 55 at include/drm/drm_crtc.h:1577 drm_helper_choose_encoder_dpms+0x88/0x90()
[ 43.611494] Modules linked in: binfmt_misc ipv6 vfat fat fuse dm_crypt dm_mod kvm_amd kvm crc32_pclmul aesni_intel aes_x86_64 lrw gf128mul glue_helper ablk_helper cryptd amd64_edac_mod k10temp fam15h_power edac_core amdkfd amd_iommu_v2 radeon acpi_cpufreq
[ 43.611498] CPU: 5 PID: 55 Comm: kworker/u16:2 Tainted: G W 4.3.0-rc2+ #3
[ 43.611499] Hardware name: To be filled by O.E.M. To be filled by O.E.M./M5A97 EVO R2.0, BIOS 1503 01/16/2013
[ 43.611503] Workqueue: events_unbound async_run_entry_fn
[ 43.611508] ffffffff8194ff67 ffff88042a223b60 ffffffff812c758a 0000000000000000
[ 43.611516] ffff88042a223b98 ffffffff810534c1 ffff880429eca000 ffff880429fe9e00
[ 43.611520] ffff880429de7000 0000000000000000 ffffffff819571c3 ffff88042a223ba8
[ 43.611521] Call Trace:
[ 43.611525] [<ffffffff812c758a>] dump_stack+0x4e/0x84
[ 43.611527] [<ffffffff810534c1>] warn_slowpath_common+0x91/0xd0
[ 43.611530] [<ffffffff810535ba>] warn_slowpath_null+0x1a/0x20
[ 43.611534] [<ffffffff813bdc58>] drm_helper_choose_encoder_dpms+0x88/0x90
[ 43.611537] [<ffffffff813be0b6>] drm_helper_connector_dpms+0x56/0x110
[ 43.611547] [<ffffffffa003346b>] radeon_suspend_kms+0x6b/0x380 [radeon]
[ 43.611551] [<ffffffff816c0f2b>] ? _raw_spin_unlock_irqrestore+0x4b/0x80
[ 43.611554] [<ffffffff8130fe50>] ? pci_pm_poweroff+0x100/0x100
[ 43.611563] [<ffffffffa00311ac>] radeon_pmops_freeze+0x1c/0x20 [radeon]
[ 43.611566] [<ffffffff8130feba>] pci_pm_freeze+0x6a/0x100
[ 43.611569] [<ffffffff8130fe50>] ? pci_pm_poweroff+0x100/0x100
[ 43.611573] [<ffffffff8146e7e7>] dpm_run_callback+0x77/0x2a0
[ 43.611575] [<ffffffff8146f4a4>] __device_suspend+0x104/0x2c0
[ 43.611578] [<ffffffff8146f67f>] async_suspend+0x1f/0xa0
[ 43.611580] [<ffffffff81078a06>] async_run_entry_fn+0x46/0xf0
[ 43.611582] [<ffffffff8106f548>] process_one_work+0x1f8/0x640
[ 43.611585] [<ffffffff8106f4a4>] ? process_one_work+0x154/0x640
[ 43.611588] [<ffffffff8106f9db>] worker_thread+0x4b/0x440
[ 43.611592] [<ffffffff8107e133>] ? preempt_count_sub+0xb3/0x110
[ 43.611594] [<ffffffff8106f990>] ? process_one_work+0x640/0x640
[ 43.611599] [<ffffffff81075e86>] kthread+0xf6/0x110
[ 43.611604] [<ffffffff81075d90>] ? kthread_create_on_node+0x1f0/0x1f0
[ 43.611607] [<ffffffff816c1e3f>] ret_from_fork+0x3f/0x70
[ 43.611609] [<ffffffff81075d90>] ? kthread_create_on_node+0x1f0/0x1f0
[ 43.611612] ---[ end trace aab225b93a6f1dce ]---
[ 43.611638] ------------[ cut here ]------------
[ 43.611641] WARNING: CPU: 5 PID: 55 at include/drm/drm_crtc.h:1577 drm_helper_choose_crtc_dpms+0x91/0xa0()
[ 43.611665] Modules linked in: binfmt_misc ipv6 vfat fat fuse dm_crypt dm_mod kvm_amd kvm crc32_pclmul aesni_intel aes_x86_64 lrw gf128mul glue_helper ablk_helper cryptd amd64_edac_mod k10temp fam15h_power edac_core amdkfd amd_iommu_v2 radeon acpi_cpufreq
[ 43.611670] CPU: 5 PID: 55 Comm: kworker/u16:2 Tainted: G W 4.3.0-rc2+ #3
[ 43.611670] Hardware name: To be filled by O.E.M. To be filled by O.E.M./M5A97 EVO R2.0, BIOS 1503 01/16/2013
[ 43.611675] Workqueue: events_unbound async_run_entry_fn
[ 43.611711] ffffffff8194ff67 ffff88042a223b60 ffffffff812c758a 0000000000000000
[ 43.611716] ffff88042a223b98 ffffffff810534c1 ffff880429eca000 ffff880429de7000
[ 43.611720] ffff880429de7000 0000000000000000 0000000000000003 ffff88042a223ba8
[ 43.611721] Call Trace:
[ 43.611725] [<ffffffff812c758a>] dump_stack+0x4e/0x84
[ 43.611728] [<ffffffff810534c1>] warn_slowpath_common+0x91/0xd0
[ 43.611730] [<ffffffff810535ba>] warn_slowpath_null+0x1a/0x20
[ 43.611732] [<ffffffff813bdcf1>] drm_helper_choose_crtc_dpms+0x91/0xa0
[ 43.611742] [<ffffffffa003d860>] ? atombios_blank_crtc+0x140/0x140 [radeon]
[ 43.611747] [<ffffffff813be124>] drm_helper_connector_dpms+0xc4/0x110
[ 43.611756] [<ffffffffa003346b>] radeon_suspend_kms+0x6b/0x380 [radeon]
[ 43.611759] [<ffffffff816c0f2b>] ? _raw_spin_unlock_irqrestore+0x4b/0x80
[ 43.611761] [<ffffffff8130fe50>] ? pci_pm_poweroff+0x100/0x100
[ 43.611771] [<ffffffffa00311ac>] radeon_pmops_freeze+0x1c/0x20 [radeon]
[ 43.611774] [<ffffffff8130feba>] pci_pm_freeze+0x6a/0x100
[ 43.611776] [<ffffffff8130fe50>] ? pci_pm_poweroff+0x100/0x100
[ 43.611778] [<ffffffff8146e7e7>] dpm_run_callback+0x77/0x2a0
[ 43.611781] [<ffffffff8146f4a4>] __device_suspend+0x104/0x2c0
[ 43.611783] [<ffffffff8146f67f>] async_suspend+0x1f/0xa0
[ 43.611786] [<ffffffff81078a06>] async_run_entry_fn+0x46/0xf0
[ 43.611788] [<ffffffff8106f548>] process_one_work+0x1f8/0x640
[ 43.611790] [<ffffffff8106f4a4>] ? process_one_work+0x154/0x640
[ 43.611793] [<ffffffff8106f9db>] worker_thread+0x4b/0x440
[ 43.611797] [<ffffffff8107e133>] ? preempt_count_sub+0xb3/0x110
[ 43.611800] [<ffffffff8106f990>] ? process_one_work+0x640/0x640
[ 43.611802] [<ffffffff81075e86>] kthread+0xf6/0x110
[ 43.611807] [<ffffffff81075d90>] ? kthread_create_on_node+0x1f0/0x1f0
[ 43.611809] [<ffffffff816c1e3f>] ret_from_fork+0x3f/0x70
[ 43.611812] [<ffffffff81075d90>] ? kthread_create_on_node+0x1f0/0x1f0
[ 43.611814] ---[ end trace aab225b93a6f1dcf ]---
[ 44.409186] PM: freeze of devices complete after 1045.976 msecs
[ 44.417505] PM: late freeze of devices complete after 2.393 msecs
[ 44.427721] PM: noirq freeze of devices complete after 4.126 msecs
[ 44.433913] Disabling non-boot CPUs ...
[ 44.451184] smpboot: CPU 1 is now offline
[ 44.498597] smpboot: CPU 2 is now offline
[ 44.534426] smpboot: CPU 3 is now offline
[ 44.574909] smpboot: CPU 4 is now offline
[ 44.614270] smpboot: CPU 5 is now offline
[ 44.652566] smpboot: CPU 6 is now offline
[ 44.694825] smpboot: CPU 7 is now offline
[ 44.711829] PM: Creating hibernation image:
[ 45.179293] PM: Need to copy 138846 pages
[ 45.183311] PM: Normal pages needed: 138846 + 1024, available pages: 4029960
[ 45.898261] PM: Hibernation image created (138846 pages copied)
[ 45.100717] LVT offset 0 assigned for vector 0x400
[ 45.106190] Enabling non-boot CPUs ...
[ 45.110174] x86: Booting SMP configuration:
[ 45.114369] smpboot: Booting Node 0 Processor 1 APIC 0x11
[ 45.141886] cache: parent cpu1 should not be sleeping
[ 45.148488] CPU1 is up
[ 45.150958] smpboot: Booting Node 0 Processor 2 APIC 0x12
[ 45.178801] cache: parent cpu2 should not be sleeping
[ 45.185799] CPU2 is up
[ 45.188316] smpboot: Booting Node 0 Processor 3 APIC 0x13
[ 45.215892] cache: parent cpu3 should not be sleeping
[ 45.222959] CPU3 is up
[ 45.225467] smpboot: Booting Node 0 Processor 4 APIC 0x14
[ 45.244730] cache: parent cpu4 should not be sleeping
[ 45.250525] CPU4 is up
[ 45.252954] smpboot: Booting Node 0 Processor 5 APIC 0x15
[ 45.273487] cache: parent cpu5 should not be sleeping
[ 45.279302] CPU5 is up
[ 45.281722] smpboot: Booting Node 0 Processor 6 APIC 0x16
[ 45.309551] cache: parent cpu6 should not be sleeping
[ 45.316600] CPU6 is up
[ 45.319109] smpboot: Booting Node 0 Processor 7 APIC 0x17
[ 45.344059] cache: parent cpu7 should not be sleeping
[ 45.351114] CPU7 is up
[ 45.376664] PM: noirq thaw of devices complete after 2.185 msecs
[ 45.384992] PM: early thaw of devices complete after 2.249 msecs
[ 45.391875] rtc_cmos 00:03: System wakeup disabled by ACPI
[ 45.393086] [drm] PCIE gen 2 link speeds already enabled
[ 45.393444] serial 00:06: activated
[ 45.396643] [drm] PCIE GART of 512M enabled (table at 0x0000000000254000).
[ 45.396699] radeon 0000:01:00.0: WB enabled
[ 45.396704] radeon 0000:01:00.0: fence driver on ring 0 use gpu addr 0x0000000020000c00 and cpu addr 0xffff8804292eec00
[ 45.397110] radeon 0000:01:00.0: fence driver on ring 5 use gpu addr 0x00000000000521d0 and cpu addr 0xffffc900008121d0
[ 45.428076] [drm] ring test on 0 succeeded in 0 usecs
[ 45.510492] r8169 0000:02:00.0 eth0: link down
[ 45.602794] [drm] ring test on 5 succeeded in 1 usecs
[ 45.602803] [drm] UVD initialized successfully.
[ 45.603013] [drm] ib test on ring 0 succeeded in 0 usecs
[ 45.710859] ata5: SATA link down (SStatus 0 SControl 300)
[ 45.710907] ata6: SATA link down (SStatus 0 SControl 300)
[ 45.882925] ata1: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
[ 45.882994] ata3: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
[ 45.883059] ata2: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
[ 45.883092] ata4: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
[ 45.884972] ata1.00: supports DRM functions and may not be fully accessible
[ 45.885071] ata2.00: supports DRM functions and may not be fully accessible
[ 45.885123] ata1.00: failed to get NCQ Send/Recv Log Emask 0x1
[ 45.885218] ata2.00: failed to get NCQ Send/Recv Log Emask 0x1
[ 45.885907] ata1.00: supports DRM functions and may not be fully accessible
[ 45.886024] ata1.00: failed to get NCQ Send/Recv Log Emask 0x1
[ 45.886068] ata2.00: supports DRM functions and may not be fully accessible
[ 45.886110] ata1.00: configured for UDMA/133
[ 45.886207] ata2.00: failed to get NCQ Send/Recv Log Emask 0x1
[ 45.886417] ata2.00: configured for UDMA/133
[ 45.896091] ata4.00: configured for UDMA/133
[ 45.906938] ata3.00: configured for UDMA/133
[ 45.907075] sd 2:0:0:0: [sdc] 1220942646 4096-byte logical blocks: (4.88 TB/4.54 TiB)
[ 46.250991] [drm] ib test on ring 5 succeeded
[ 46.644971] PM: thaw of devices complete after 1253.970 msecs
[ 46.848000] usb 8-2: reset low-speed USB device number 2 using ohci-pci
[ 47.084410] r8169 0000:02:00.0 eth0: link up
[ 47.193411] PM: writing image.
[ 47.203074] PM: Using 3 thread(s) for compression.
[ 47.203074] PM: Compressing and saving image data (139118 pages)...
[ 47.220107] PM: Image saving progress: 0%
[ 47.356371] PM: Image saving progress: 10%
[ 47.444633] PM: Image saving progress: 20%
[ 47.586282] PM: Image saving progress: 30%
[ 47.676366] PM: Image saving progress: 40%
[ 47.751889] PM: Image saving progress: 50%
[ 47.838831] PM: Image saving progress: 60%
[ 47.927719] PM: Image saving progress: 70%
[ 48.020115] PM: Image saving progress: 80%
[ 48.107692] PM: Image saving progress: 90%
[ 48.193569] PM: Image saving progress: 100%
[ 48.199217] PM: Image saving done.
[ 48.203784] PM: Wrote 556472 kbytes in 0.97 seconds (573.68 MB/s)
[ 48.211456] PM: S|
[ 48.311190] kvm: exiting hardware virtualization
[ 48.321689] AMD-Vi: Event logged [IO_PAGE_FAULT device=01:00.0 domain=0x0010 address=0x0000000020001000 flags=0x0000]
[ 48.522749] sd 3:0:0:0: [sdd] Synchronizing SCSI cache
[ 48.531044] sd 3:0:0:0: [sdd] Stopping disk
[ 49.418426] sd 2:0:0:0: [sdc] Synchronizing SCSI cache
[ 49.424890] sd 2:0:0:0: [sdc] Stopping disk
[ 49.596437] sd 1:0:0:0: [sdb] Synchronizing SCSI cache
[ 49.605855] sd 1:0:0:0: [sdb] Stopping disk
[ 49.920447] sd 0:0:0:0: [sda] Synchronizing SCSI cache
[ 49.929890] sd 0:0:0:0: [sda] Stopping disk
[ 50.124196] pcieport 0000:00:04.0: System wakeup enabled by ACPI
[ 50.152897] ACPI: Preparing to enter system sleep state S5
[ 50.160275] [Firmware Bug]: ACPI: BIOS _OSI(Linux) query honored via cmdline
[ 50.170923] reboot: Power down
[ 50.176837] acpi_power_off called
Then the resume kernel starts and loads the suspended one, which bombs
out completely:
[ 5.758121] PM: Checking hibernation image partition /dev/sda1
[ 5.764067] PM: Hibernation image partition 8:1 present
[ 5.769372] PM: Looking for hibernation image.
[ 5.769846] hid-generic 0003:04B4:0101.0003: input,hidraw2: USB HID v1.00 Device [DATACOMP SteelSìÌÐÌDATA] on usb-0000
:00:12.0-2/input1
[ 5.788988] PM: Image signature found, resuming
[ 5.795952] PM: Preparing processes for restore.
[ 5.800605] Freezing user space processes ... (elapsed 0.000 seconds) done.
[ 5.807811] PM: Loading hibernation image.
[ 5.812211] PM: Marking nosave pages: [mem 0x00000000-0x00000fff]
[ 5.818339] PM: Marking nosave pages: [mem 0x0009e000-0x000fffff]
[ 5.824462] PM: Marking nosave pages: [mem 0xba9b8000-0xbca4dfff]
[ 5.830712] PM: Marking nosave pages: [mem 0xbca4f000-0xbcc54fff]
[ 5.836844] PM: Marking nosave pages: [mem 0xbd083000-0xbd7f3fff]
[ 5.843010] PM: Marking nosave pages: [mem 0xbd800000-0x100000fff]
[ 5.849924] PM: Basic memory bitmaps created
[ 5.869152] PM: Using 3 thread(s) for decompression.
[ 5.869152] PM: Loading and decompressing image data (139118 pages)...
[ 5.946421] PM: Image loading progress: 0%
[ 6.241471] PM: Image loading progress: 10%
[ 6.321625] PM: Image loading progress: 20%
[ 6.362579] random: nonblocking pool is initialized
[ 6.414363] PM: Image loading progress: 30%
[ 6.495027] PM: Image loading progress: 40%
[ 6.573551] PM: Image loading progress: 50%
[ 6.654276] PM: Image loading progress: 60%
[ 6.735344] PM: Image loading progress: 70%
[ 6.810312] PM: Image loading progress: 80%
[ 6.885237] PM: Image loading progress: 90%
[ 6.963869] PM: Image loading progress: 100%
[ 6.968292] PM: Image loading done.
[ 6.971907] PM: Read 556472 kbytes in 1.08 seconds (515.25 MB/s)
[ 6.981245] PM: Image successfully loaded
[ 7.208118] PM: quiesce of devices complete after 221.517 msecs
[ 7.215932] PM: late quiesce of devices complete after 1.806 msecs
[ 7.236424] PM: noirq quiesce of devices complete after 14.231 msecs
[ 7.242867] Disabling non-boot CPUs ...
[ 44.968602] LVT offset 0 assigned for vector 0x400
[ 44.973810] Enabling non-boot CPUs ...
[ 44.977701] x86: Booting SMP configuration:
[ 44.981885] smpboot: Booting Node 0 Processor 1 APIC 0x11
[ 45.004260] cache: parent cpu1 should not be sleeping
[ 45.010101] CPU1 is up
[ 45.012520] smpboot: Booting Node 0 Processor 2 APIC 0x12
[ 45.036083] cache: parent cpu2 should not be sleeping
[ 45.041998] CPU2 is up
[ 45.044429] smpboot: Booting Node 0 Processor 3 APIC 0x13
[ 45.064873] cache: parent cpu3 should not be sleeping
[ 45.070712] CPU3 is up
[ 45.073177] smpboot: Booting Node 0 Processor 4 APIC 0x14
[ 45.092508] cache: parent cpu4 should not be sleeping
[ 45.098293] CPU4 is up
[ 45.100772] smpboot: Booting Node 0 Processor 5 APIC 0x15
[ 45.120788] cache: parent cpu5 should not be sleeping
[ 45.126577] CPU5 is up
[ 45.128997] smpboot: Booting Node 0 Processor 6 APIC 0x16
[ 45.149043] cache: parent cpu6 should not be sleeping
[ 45.154843] CPU6 is up
[ 45.157261] smpboot: Booting Node 0 Processor 7 APIC 0x17
[ 45.177371] cache: parent cpu7 should not be sleeping
[ 45.183182] CPU7 is up
[ 45.195686] BUG: unable to handle kernel NULL pointer dereference at 0000000000000034
[ 45.203696] IP: [<ffffffff81321296>] pci_restore_msi_state+0x196/0x240
[ 45.210379] PGD 418009067 PUD 41800a067 PMD 0
[ 45.215023] Oops: 0000 [#1] PREEMPT SMP
[ 45.219132] Modules linked in: binfmt_misc ipv6 vfat fat fuse dm_crypt dm_mod kvm_amd kvm crc32_pclmul aesni_intel ae
s_x86_64 lrw gf128mul glue_helper ablk_helper cryptd amd64_edac_mod k10temp fam15h_power edac_core amdkfd amd_iommu_v2 r
adeon acpi_cpufreq
[ 45.242447] CPU: 2 PID: 804 Comm: kworker/u16:5 Tainted: G W 4.3.0-rc2+ #3
[ 45.250584] Hardware name: To be filled by O.E.M. To be filled by O.E.M./M5A97 EVO R2.0, BIOS 1503 01/16/2013
[ 45.260630] Workqueue: events_unbound async_run_entry_fn
[ 45.266105] task: ffff88042983df00 ti: ffff880428a40000 task.ti: ffff880428a40000
[ 45.273724] RIP: 0010:[<ffffffff81321296>] [<ffffffff81321296>] pci_restore_msi_state+0x196/0x240
[ 45.282840] RSP: 0018:ffff880428a43c28 EFLAGS: 00010286
[ 45.288292] RAX: 0000000000000000 RBX: ffff880429c2d000 RCX: 0000000000000000
[ 45.295564] RDX: 0000000000000001 RSI: ffffffff81304448 RDI: ffffffff816c0f2b
[ 45.302835] RBP: ffff880428a43c40 R08: 0000000000000001 R09: 0000000000522000
[ 45.310114] R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000000
[ 45.317386] R13: ffff880429c2d7b0 R14: ffff880429c2d010 R15: ffff880429c2d038
[ 45.324666] FS: 00007f653bc43700(0000) GS:ffff88042ca00000(0000) knlGS:0000000000000000
[ 45.332898] CS: 0010 DS: 0000 ES: 0000 CR0: 000000008005003b
[ 45.338784] CR2: 0000000000000034 CR3: 0000000418053000 CR4: 00000000000406e0
[ 45.346063] Stack:
[ 45.348221] 0080002c29c2d7b0 0000000000000000 ffff880429c2d000 ffff880428a43c78
[ 45.355822] ffffffff8130c141 ffff880429c2d098 ffff880429c2d000 0000000000000000
[ 45.363424] ffff88042a1216e8 ffffffff81957114 ffff880428a43c88 ffffffff8130c2b8
[ 45.371041] Call Trace:
[ 45.373642] [<ffffffff8130c141>] pci_restore_state.part.18+0xf1/0x250
[ 45.380316] [<ffffffff8130c2b8>] pci_restore_state+0x18/0x20
[ 45.386209] [<ffffffff8130f7fc>] pci_pm_restore_noirq+0x4c/0xd0
[ 45.392367] [<ffffffff8130f7b0>] ? pci_pm_freeze_noirq+0xf0/0xf0
[ 45.398611] [<ffffffff8146e7e7>] dpm_run_callback+0x77/0x2a0
[ 45.404531] [<ffffffff8146eaa3>] device_resume_noirq+0x93/0x150
[ 45.410682] [<ffffffff8146eb7d>] async_resume_noirq+0x1d/0x50
[ 45.416693] [<ffffffff81078a06>] async_run_entry_fn+0x46/0xf0
[ 45.422669] [<ffffffff8106f548>] process_one_work+0x1f8/0x640
[ 45.428648] [<ffffffff8106f4a4>] ? process_one_work+0x154/0x640
[ 45.434804] [<ffffffff8106f9db>] worker_thread+0x4b/0x440
[ 45.440435] [<ffffffff8106f990>] ? process_one_work+0x640/0x640
[ 45.446590] [<ffffffff81075e86>] kthread+0xf6/0x110
[ 45.451704] [<ffffffff81075d90>] ? kthread_create_on_node+0x1f0/0x1f0
[ 45.458376] [<ffffffff816c1e3f>] ret_from_fork+0x3f/0x70
[ 45.463923] [<ffffffff81075d90>] ? kthread_create_on_node+0x1f0/0x1f0
[ 45.470587] Code: 66 89 4d ee 0f b7 c9 e8 79 41 fe ff 48 89 df e8 d1 7a ce ff 0f b6 53 4b 8b 73 38 48 8d 4d ee 48 8b 7b 10 83 c2 02 e8 1a 31 fe ff <41> 0f b6 4c 24 34 41 8b 54 24 30 be ff ff ff ff c0 e9 04 83 e1
[ 45.490744] RIP [<ffffffff81321296>] pci_restore_msi_state+0x196/0x240
[ 45.497522] RSP <ffff880428a43c28>
[ 45.501162] CR2: 0000000000000034
[ 45.504630] ---[ end trace aab225b93a6f1dd0 ]---
[ 45.509270] BUG: unable to handle kernel paging request at ffffffffffffff98
[ 45.516436] IP: [<ffffffff81076770>] kthread_data+0x10/0x20
[ 45.522180] PGD 19e5067 PUD 19e7067 PMD 0
[ 45.526512] Oops: 0000 [#2] PREEMPT SMP
[ 45.530628] Modules linked in: binfmt_misc ipv6 vfat fat fuse dm_crypt dm_mod kvm_amd kvm crc32_pclmul aesni_intel aes_x86_64 lrw gf128mul glue_helper ablk_helper cryptd amd64_edac_mod k10temp fam15h_power edac_core amdkfd amd_iommu_v2 radeon acpi_cpufreq
[ 45.553976] CPU: 2 PID: 804 Comm: kworker/u16:5 Tainted: G D W 4.3.0-rc2+ #3
[ 45.562132] Hardware name: To be filled by O.E.M. To be filled by O.E.M./M5A97 EVO R2.0, BIOS 1503 01/16/2013
[ 45.572199] task: ffff88042983df00 ti: ffff880428a40000 task.ti: ffff880428a40000
[ 45.579856] RIP: 0010:[<ffffffff81076770>] [<ffffffff81076770>] kthread_data+0x10/0x20
[ 45.588037] RSP: 0018:ffff880428a43928 EFLAGS: 00010002
[ 45.593505] RAX: 0000000000000000 RBX: 0000000000000002 RCX: 0000000000000000
[ 45.600794] RDX: 000000012b244210 RSI: 0000000000000002 RDI: ffff88042983df00
[ 45.608083] RBP: ffff880428a43928 R08: ffff88042983df88 R09: ffff88042cbd5cb0
[ 45.615371] R10: ffff88042983df60 R11: 0000000000000000 R12: 00000000001d5c00
[ 45.622661] R13: ffff88042cbd5c18 R14: ffff88042983df00 R15: 0000000000000002
[ 45.629949] FS: 00007f653bc43700(0000) GS:ffff88042ca00000(0000) knlGS:0000000000000000
[ 45.638191] CS: 0010 DS: 0000 ES: 0000 CR0: 000000008005003b
[ 45.644094] CR2: 0000000000000028 CR3: 0000000418053000 CR4: 00000000000406e0
[ 45.651389] Stack:
[ 45.653565] ffff880428a43940 ffffffff810707a1 ffff88042cbd5c00 ffff880428a43998
[ 45.661185] ffffffff816bb6e6 ffffffff81055b9b 0000000000000000 0000000000000000
[ 45.668835] ffff88042983df00 ffff880428a44000 ffff880428a439f0 0000000000000000
[ 45.676453] Call Trace:
[ 45.679064] [<ffffffff810707a1>] wq_worker_sleeping+0x11/0x90
[ 45.685062] [<ffffffff816bb6e6>] __schedule+0x796/0xec0
[ 45.690538] [<ffffffff81055b9b>] ? do_exit+0x63b/0xac0
[ 45.695930] [<ffffffff816bbe9d>] schedule+0x3d/0x90
[ 45.701060] [<ffffffff81055c58>] do_exit+0x6f8/0xac0
[ 45.706279] [<ffffffff81007d8c>] oops_end+0x6c/0x90
[ 45.711408] [<ffffffff81045c13>] no_context+0x153/0x360
[ 45.716875] [<ffffffff81045f2b>] __bad_area_nosemaphore+0x10b/0x210
[ 45.723385] [<ffffffff812f3b77>] ? debug_smp_processor_id+0x17/0x20
[ 45.729894] [<ffffffff81046043>] bad_area_nosemaphore+0x13/0x20
[ 45.736055] [<ffffffff81046487>] __do_page_fault+0x1e7/0x360
[ 45.741958] [<ffffffff81000f70>] ? trace_hardirqs_off_thunk+0x17/0x19
[ 45.748640] [<ffffffff8104663c>] do_page_fault+0xc/0x10
[ 45.754099] [<ffffffff816c38af>] page_fault+0x1f/0x30
[ 45.759386] [<ffffffff81304448>] ? pci_bus_read_config_word+0x98/0xa0
[ 45.766058] [<ffffffff816c0f2b>] ? _raw_spin_unlock_irqrestore+0x4b/0x80
[ 45.772992] [<ffffffff81321296>] ? pci_restore_msi_state+0x196/0x240
[ 45.779581] [<ffffffff81321296>] ? pci_restore_msi_state+0x196/0x240
[ 45.786165] [<ffffffff8130c141>] pci_restore_state.part.18+0xf1/0x250
[ 45.792840] [<ffffffff8130c2b8>] pci_restore_state+0x18/0x20
[ 45.798732] [<ffffffff8130f7fc>] pci_pm_restore_noirq+0x4c/0xd0
[ 45.804886] [<ffffffff8130f7b0>] ? pci_pm_freeze_noirq+0xf0/0xf0
[ 45.811127] [<ffffffff8146e7e7>] dpm_run_callback+0x77/0x2a0
[ 45.817019] [<ffffffff8146eaa3>] device_resume_noirq+0x93/0x150
[ 45.823173] [<ffffffff8146eb7d>] async_resume_noirq+0x1d/0x50
[ 45.829153] [<ffffffff81078a06>] async_run_entry_fn+0x46/0xf0
[ 45.835132] [<ffffffff8106f548>] process_one_work+0x1f8/0x640
[ 45.841104] [<ffffffff8106f4a4>] ? process_one_work+0x154/0x640
[ 45.847248] [<ffffffff8106f9db>] worker_thread+0x4b/0x440
[ 45.852873] [<ffffffff8106f990>] ? process_one_work+0x640/0x640
[ 45.859018] [<ffffffff81075e86>] kthread+0xf6/0x110
[ 45.864124] [<ffffffff81075d90>] ? kthread_create_on_node+0x1f0/0x1f0
[ 45.870796] [<ffffffff816c1e3f>] ret_from_fork+0x3f/0x70
[ 45.876333] [<ffffffff81075d90>] ? kthread_create_on_node+0x1f0/0x1f0
[ 45.882998] Code: 60 74 0a 48 89 df e8 10 a8 64 00 eb d3 48 8b 53 48 eb b1 e8 33 cb fd ff 0f 1f 00 0f 1f 44 00 00 48 8b 87 f8 03 00 00 55 48 89 e5 <48> 8b 40 98 5d c3 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 44 00 00
[ 45.903148] RIP [<ffffffff81076770>] kthread_data+0x10/0x20
[ 45.908972] RSP <ffff880428a43928>
[ 45.912612] CR2: ffffffffffffff98
[ 45.916079] ---[ end trace aab225b93a6f1dd1 ]---
[ 45.920697] Fixing recursive fault but reboot is needed!
[ 45.926002] BUG: scheduling while atomic: kworker/u16:5/804/0x00000004
[ 45.932529] INFO: lockdep is turned off.
[ 45.936453] Modules linked in: binfmt_misc ipv6 vfat fat fuse dm_crypt dm_mod kvm_amd kvm crc32_pclmul aesni_intel aes_x86_64 lrw gf128mul glue_helper ablk_helper cryptd amd64_edac_mod k10temp fam15h_power edac_core amdkfd amd_iommu_v2 radeon acpi_cpufreq
[ 45.959455] irq event stamp: 2072
[ 45.962766] hardirqs last enabled at (2071): [<ffffffff816c0f45>] _raw_spin_unlock_irqrestore+0x65/0x80
[ 45.972248] hardirqs last disabled at (2072): [<ffffffff816c3a80>] error_entry+0x60/0xb0
[ 45.980342] softirqs last enabled at (1792): [<ffffffff81058547>] __do_softirq+0x3a7/0x480
[ 45.988705] softirqs last disabled at (1765): [<ffffffff81058798>] irq_exit+0x88/0xb0
[ 45.996539] Preemption disabled at:[<ffffffff81007d8c>] oops_end+0x6c/0x90
[ 46.003420]
[ 46.004913] CPU: 2 PID: 804 Comm: kworker/u16:5 Tainted: G D W 4.3.0-rc2+ #3
[ 46.012911] Hardware name: To be filled by O.E.M. To be filled by O.E.M./M5A97 EVO R2.0, BIOS 1503 01/16/2013
[ 46.022823] 00000000001d5c00 ffff880428a43628 ffffffff812c758a ffff88042983df00
[ 46.030280] ffff880428a43640 ffffffff8107d528 ffff88042cbd5c00 ffff880428a43698
[ 46.037740] ffffffff816bb84f ffff880428a436b0 ffffffff81126b16 0000000000000008
[ 46.045193] Call Trace:
[ 46.047641] [<ffffffff812c758a>] dump_stack+0x4e/0x84
[ 46.052779] [<ffffffff8107d528>] __schedule_bug+0x68/0xc0
[ 46.058264] [<ffffffff816bb84f>] __schedule+0x8ff/0xec0
[ 46.063569] [<ffffffff81126b16>] ? printk+0x48/0x50
[ 46.068535] [<ffffffff816bbe9d>] schedule+0x3d/0x90
[ 46.073500] [<ffffffff81055e38>] do_exit+0x8d8/0xac0
[ 46.078580] [<ffffffff810b6d75>] ? kmsg_dump+0x135/0x180
[ 46.083978] [<ffffffff810b6c62>] ? kmsg_dump+0x22/0x180
[ 46.089291] [<ffffffff81007d8c>] oops_end+0x6c/0x90
[ 46.094257] [<ffffffff81045c13>] no_context+0x153/0x360
[ 46.099571] [<ffffffff812d47a4>] ? delay_tsc+0x94/0xc0
[ 46.104796] [<ffffffff81045f2b>] __bad_area_nosemaphore+0x10b/0x210
[ 46.111149] [<ffffffff81046043>] bad_area_nosemaphore+0x13/0x20
[ 46.117154] [<ffffffff81046487>] __do_page_fault+0x1e7/0x360
[ 46.122901] [<ffffffff81000f70>] ? trace_hardirqs_off_thunk+0x17/0x19
[ 46.129427] [<ffffffff8104663c>] do_page_fault+0xc/0x10
[ 46.134740] [<ffffffff816c38af>] page_fault+0x1f/0x30
[ 46.139879] [<ffffffff81076770>] ? kthread_data+0x10/0x20
[ 46.145364] [<ffffffff810707a1>] wq_worker_sleeping+0x11/0x90
[ 46.151197] [<ffffffff816bb6e6>] __schedule+0x796/0xec0
[ 46.156510] [<ffffffff81055b9b>] ? do_exit+0x63b/0xac0
[ 46.161736] [<ffffffff816bbe9d>] schedule+0x3d/0x90
[ 46.166702] [<ffffffff81055c58>] do_exit+0x6f8/0xac0
[ 46.171754] [<ffffffff81007d8c>] oops_end+0x6c/0x90
[ 46.176721] [<ffffffff81045c13>] no_context+0x153/0x360
[ 46.182033] [<ffffffff81045f2b>] __bad_area_nosemaphore+0x10b/0x210
[ 46.188385] [<ffffffff812f3b77>] ? debug_smp_processor_id+0x17/0x20
[ 46.194730] [<ffffffff81046043>] bad_area_nosemaphore+0x13/0x20
[ 46.200736] [<ffffffff81046487>] __do_page_fault+0x1e7/0x360
[ 46.206481] [<ffffffff81000f70>] ? trace_hardirqs_off_thunk+0x17/0x19
[ 46.213008] [<ffffffff8104663c>] do_page_fault+0xc/0x10
[ 46.218320] [<ffffffff816c38af>] page_fault+0x1f/0x30
[ 46.223461] [<ffffffff81304448>] ? pci_bus_read_config_word+0x98/0xa0
[ 46.229986] [<ffffffff816c0f2b>] ? _raw_spin_unlock_irqrestore+0x4b/0x80
[ 46.236772] [<ffffffff81321296>] ? pci_restore_msi_state+0x196/0x240
[ 46.243212] [<ffffffff81321296>] ? pci_restore_msi_state+0x196/0x240
[ 46.249649] [<ffffffff8130c141>] pci_restore_state.part.18+0xf1/0x250
[ 46.256177] [<ffffffff8130c2b8>] pci_restore_state+0x18/0x20
[ 46.261922] [<ffffffff8130f7fc>] pci_pm_restore_noirq+0x4c/0xd0
[ 46.267928] [<ffffffff8130f7b0>] ? pci_pm_freeze_noirq+0xf0/0xf0
[ 46.274022] [<ffffffff8146e7e7>] dpm_run_callback+0x77/0x2a0
[ 46.279768] [<ffffffff8146eaa3>] device_resume_noirq+0x93/0x150
[ 46.285773] [<ffffffff8146eb7d>] async_resume_noirq+0x1d/0x50
[ 46.291606] [<ffffffff81078a06>] async_run_entry_fn+0x46/0xf0
[ 46.297439] [<ffffffff8106f548>] process_one_work+0x1f8/0x640
[ 46.303271] [<ffffffff8106f4a4>] ? process_one_work+0x154/0x640
[ 46.309278] [<ffffffff8106f9db>] worker_thread+0x4b/0x440
[ 46.314762] [<ffffffff8106f990>] ? process_one_work+0x640/0x640
[ 46.320761] [<ffffffff81075e86>] kthread+0xf6/0x110
[ 46.325726] [<ffffffff81075d90>] ? kthread_create_on_node+0x1f0/0x1f0
[ 46.332251] [<ffffffff816c1e3f>] ret_from_fork+0x3f/0x70
[ 46.337644] [<ffffffff81075d90>] ? kthread_create_on_node+0x1f0/0x1f0
Thanks.
--
Regards/Gruss,
Boris.
ECO tip #101: Trim your mails when you reply.
--
To unsubscribe from this list: send the line "unsubscribe linux-kernel" in
the body of a message to majordomo@xxxxxxxxxxxxxxx
More majordomo info at http://vger.kernel.org/majordomo-info.html
Please read the FAQ at http://www.tux.org/lkml/