Bug 102365 - [BAT] unchecked MSR access error: (RD|WR)MSR from/to 0x1b0 at rIP: 0xffffffff81030a4f (init_intel_energy_perf)
Summary: [BAT] unchecked MSR access error: (RD|WR)MSR from/to 0x1b0 at rIP: 0xffffffff...
Status: RESOLVED MOVED
Alias: None
Product: DRI
Classification: Unclassified
Component: DRM/Intel (show other bugs)
Version: XOrg git
Hardware: Other All
: medium normal
Assignee: Intel GFX Bugs mailing list
QA Contact: Intel GFX Bugs mailing list
URL:
Whiteboard: ReadyForDev
Keywords:
: 103073 (view as bug list)
Depends on:
Blocks:
 
Reported: 2017-08-23 09:23 UTC by Martin Peres
Modified: 2019-11-29 17:25 UTC (History)
2 users (show)

See Also:
i915 platform: SNB
i915 features: power/Other


Attachments

Description Martin Peres 2017-08-23 09:23:24 UTC
On CI_DRM_2992, the machine shard-snb3 generaed the following error while running igt@kms_flip@vblank-vs-suspend:

[  280.969486] unchecked MSR access error: RDMSR from 0x1b0 at rIP: 0xffffffff81030a4f (init_intel_energy_perf.part.3+0xf/0xb0)
[  280.969488] Call Trace:
[  280.969492]  intel_bsp_resume+0x1a/0x20
[  280.969494]  bsp_resume+0x1d/0x20
[  280.969498]  syscore_resume+0x62/0x320
[  280.969501]  suspend_devices_and_enter+0xa09/0xcd0
[  280.969506]  pm_suspend+0x574/0xa00
[  280.969509]  state_store+0x82/0xf0
[  280.969514]  kobj_attr_store+0xf/0x20
[  280.969516]  sysfs_kf_write+0x45/0x60
[  280.969519]  kernfs_fop_write+0x124/0x1c0
[  280.969524]  __vfs_write+0x28/0x130
[  280.969526]  ? rcu_read_lock_sched_held+0x7a/0x90
[  280.969528]  ? rcu_sync_lockdep_assert+0x2f/0x60
[  280.969531]  ? __sb_start_write+0x10c/0x200
[  280.969535]  vfs_write+0xc8/0x1c0
[  280.969538]  SyS_write+0x49/0xb0
[  280.969542]  entry_SYSCALL_64_fastpath+0x1c/0xb1
[  280.969544] RIP: 0033:0x7fb6721ce8f0
[  280.969546] RSP: 002b:00007ffc3ac05da8 EFLAGS: 00000246 ORIG_RAX: 0000000000000001
[  280.969549] RAX: ffffffffffffffda RBX: ffffffff81489d83 RCX: 00007fb6721ce8f0
[  280.969551] RDX: 0000000000000004 RSI: 00005634312da060 RDI: 0000000000000007
[  280.969552] RBP: ffffc90001147f88 R08: 00005634312d7de0 R09: 00007fb67269f700
[  280.969554] R10: 00007fb672497b58 R11: 0000000000000246 R12: 00005634312d7d00
[  280.969555] R13: 0000000000000001 R14: 0000000000000004 R15: 0000000000000004
[  280.969559]  ? __this_cpu_preempt_check+0x13/0x20
[  280.969566] unchecked MSR access error: WRMSR to 0x1b0 (tried to write 0x0000000000000006) at rIP: 0xffffffff81030a8e (init_intel_energy_perf.part.3+0x4e/0xb0)
[  280.969567] Call Trace:
[  280.969569]  intel_bsp_resume+0x1a/0x20
[  280.969571]  bsp_resume+0x1d/0x20
[  280.969573]  syscore_resume+0x62/0x320
[  280.969576]  suspend_devices_and_enter+0xa09/0xcd0
[  280.969580]  pm_suspend+0x574/0xa00
[  280.969584]  state_store+0x82/0xf0
[  280.969587]  kobj_attr_store+0xf/0x20
[  280.969589]  sysfs_kf_write+0x45/0x60
[  280.969592]  kernfs_fop_write+0x124/0x1c0
[  280.969595]  __vfs_write+0x28/0x130
[  280.969597]  ? rcu_read_lock_sched_held+0x7a/0x90
[  280.969599]  ? rcu_sync_lockdep_assert+0x2f/0x60
[  280.969601]  ? __sb_start_write+0x10c/0x200
[  280.969605]  vfs_write+0xc8/0x1c0
[  280.969608]  SyS_write+0x49/0xb0
[  280.969612]  entry_SYSCALL_64_fastpath+0x1c/0xb1
[  280.969613] RIP: 0033:0x7fb6721ce8f0
[  280.969614] RSP: 002b:00007ffc3ac05da8 EFLAGS: 00000246 ORIG_RAX: 0000000000000001
[  280.969617] RAX: ffffffffffffffda RBX: ffffffff81489d83 RCX: 00007fb6721ce8f0
[  280.969619] RDX: 0000000000000004 RSI: 00005634312da060 RDI: 0000000000000007
[  280.969620] RBP: ffffc90001147f88 R08: 00005634312d7de0 R09: 00007fb67269f700
[  280.969621] R10: 00007fb672497b58 R11: 0000000000000246 R12: 00005634312d7d00
[  280.969623] R13: 0000000000000001 R14: 0000000000000004 R15: 0000000000000004
[  280.969626]  ? __this_cpu_preempt_check+0x13/0x20

Full logs: https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_2992/shard-snb3/igt@kms_flip@vblank-vs-suspend.html
Comment 3 Marta Löfstedt 2017-10-03 12:00:54 UTC
*** Bug 103073 has been marked as a duplicate of this bug. ***
Comment 4 krisman 2017-10-12 04:33:14 UTC
Submitted this patch to prevent the issue:

https://lkml.org/lkml/2017/10/12/3
Comment 6 Marta Löfstedt 2017-10-18 06:57:08 UTC
(In reply to krisman from comment #4)
> Submitted this patch to prevent the issue:
> 
> https://lkml.org/lkml/2017/10/12/3

Is there a kernel bug that we could track for this?
Comment 7 Marta Löfstedt 2017-11-13 09:01:48 UTC
https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_3331/shard-snb1/igt@kms_plane@plane-panning-bottom-right-suspend-pipe-a-planes.html

	

[  910.771292] Suspending console(s) (use no_console_suspend to debug)
[  910.772898] sd 0:0:0:0: [sda] Synchronizing SCSI cache
[  910.773237] sd 0:0:0:0: [sda] Stopping disk
[  911.006463]  cache: parent cpu1 should not be sleeping
[  911.010897]  cache: parent cpu2 should not be sleeping
[  911.015473]  cache: parent cpu3 should not be sleeping
[  911.020325]  cache: parent cpu4 should not be sleeping
[  911.025284]  cache: parent cpu5 should not be sleeping
[  911.030413]  cache: parent cpu6 should not be sleeping
[  911.035648]  cache: parent cpu7 should not be sleeping
[  911.076933] sd 0:0:0:0: [sda] Starting disk
[  911.496816] Suspending console(s) (use no_console_suspend to debug)
[  911.498479] sd 0:0:0:0: [sda] Synchronizing SCSI cache
[  911.498827] sd 0:0:0:0: [sda] Stopping disk
[  911.726397] unchecked MSR access error: RDMSR from 0x1b0 at rIP: 0xffffffff8102f57f (init_intel_energy_perf.part.3+0xf/0xb0)
[  911.726398] Call Trace:
[  911.726403]  intel_bsp_resume+0x1a/0x20
[  911.726405]  bsp_resume+0x1d/0x20
[  911.726408]  syscore_resume+0x62/0x320
[  911.726411]  suspend_devices_and_enter+0xa58/0xcf0
[  911.726416]  pm_suspend+0x4f0/0x9d0
[  911.726419]  state_store+0x82/0xf0
[  911.726424]  kobj_attr_store+0xf/0x20
[  911.726427]  sysfs_kf_write+0x45/0x60
[  911.726430]  kernfs_fop_write+0x124/0x1c0
[  911.726434]  __vfs_write+0x28/0x130
[  911.726437]  ? rcu_read_lock_sched_held+0x7a/0x90
[  911.726439]  ? rcu_sync_lockdep_assert+0x2f/0x60
[  911.726442]  ? __sb_start_write+0x10c/0x200
[  911.726445]  vfs_write+0xc8/0x1c0
[  911.726448]  SyS_write+0x49/0xb0
[  911.726452]  entry_SYSCALL_64_fastpath+0x1c/0xb1
[  911.726454] RIP: 0033:0x7f0183a2d8f0
[  911.726456] RSP: 002b:00007ffe6cdf01b8 EFLAGS: 00000246 ORIG_RAX: 0000000000000001
[  911.726459] RAX: ffffffffffffffda RBX: ffffffff81492083 RCX: 00007f0183a2d8f0
[  911.726461] RDX: 0000000000000004 RSI: 000055fbc61a0060 RDI: 000000000000000a
[  911.726462] RBP: ffffc90000193f88 R08: 000055fbc619dde0 R09: 00007f0183f01700
[  911.726463] R10: 00007f0183cf6b58 R11: 0000000000000246 R12: 000055fbc619dd00
[  911.726465] R13: 0000000000000001 R14: 0000000000000004 R15: 0000000000000004
[  911.726468]  ? __this_cpu_preempt_check+0x13/0x20
[  911.726475] unchecked MSR access error: WRMSR to 0x1b0 (tried to write 0x0000000000000006) at rIP: 0xffffffff8102f5be (init_intel_energy_perf.part.3+0x4e/0xb0)
[  911.726476] Call Trace:
[  911.726478]  intel_bsp_resume+0x1a/0x20
[  911.726480]  bsp_resume+0x1d/0x20
[  911.726483]  syscore_resume+0x62/0x320
[  911.726485]  suspend_devices_and_enter+0xa58/0xcf0
[  911.726490]  pm_suspend+0x4f0/0x9d0
[  911.726493]  state_store+0x82/0xf0
[  911.726497]  kobj_attr_store+0xf/0x20
[  911.726499]  sysfs_kf_write+0x45/0x60
[  911.726502]  kernfs_fop_write+0x124/0x1c0
[  911.726505]  __vfs_write+0x28/0x130
[  911.726507]  ? rcu_read_lock_sched_held+0x7a/0x90
[  911.726509]  ? rcu_sync_lockdep_assert+0x2f/0x60
[  911.726512]  ? __sb_start_write+0x10c/0x200
[  911.726515]  vfs_write+0xc8/0x1c0
[  911.726518]  SyS_write+0x49/0xb0
[  911.726522]  entry_SYSCALL_64_fastpath+0x1c/0xb1
[  911.726523] RIP: 0033:0x7f0183a2d8f0
[  911.726525] RSP: 002b:00007ffe6cdf01b8 EFLAGS: 00000246 ORIG_RAX: 0000000000000001
[  911.726527] RAX: ffffffffffffffda RBX: ffffffff81492083 RCX: 00007f0183a2d8f0
[  911.726529] RDX: 0000000000000004 RSI: 000055fbc61a0060 RDI: 000000000000000a
[  911.726530] RBP: ffffc90000193f88 R08: 000055fbc619dde0 R09: 00007f0183f01700
[  911.726532] R10: 00007f0183cf6b58 R11: 0000000000000246 R12: 000055fbc619dd00
[  911.726533] R13: 0000000000000001 R14: 0000000000000004 R15: 0000000000000004
[  911.726536]  ? __this_cpu_preempt_check+0x13/0x20
[  911.730425]  cache: parent cpu1 should not be sleeping
[  911.734915]  cache: parent cpu2 should not be sleeping
[  911.739511]  cache: parent cpu3 should not be sleeping
[  911.744369]  cache: parent cpu4 should not be sleeping
[  911.749334]  cache: parent cpu5 should not be sleeping
[  911.754512]  cache: parent cpu6 should not be sleeping
[  911.759794]  cache: parent cpu7 should not be sleeping
[  911.792018] mei_me 0000:00:16.0: less data available than length=00000003.
[  911.801258] sd 0:0:0:0: [sda] Starting disk
Comment 8 Marta Löfstedt 2017-11-15 10:08:22 UTC
https://intel-gfx-ci.01.org/tree/drm-tip/IGT_3985/fi-snb-2600/igt@kms_pipe_crc_basic@suspend-read-crc-pipe-b.html

<6>[  397.728312] ACPI: Preparing to enter system sleep state S3
<6>[  397.739749] PM: Saving platform NVS memory
<6>[  397.741156] Disabling non-boot CPUs ...
<6>[  397.755464] smpboot: CPU 1 is now offline
<6>[  397.768131] smpboot: CPU 2 is now offline
<6>[  397.784517] smpboot: CPU 3 is now offline
<6>[  397.800551] smpboot: CPU 4 is now offline
<6>[  397.816131] smpboot: CPU 5 is now offline
<6>[  397.830475] smpboot: CPU 6 is now offline
<6>[  397.843868] smpboot: CPU 7 is now offline
<6>[  397.845710] ACPI: Low-level resume complete
<6>[  397.845777] PM: Restoring platform NVS memory
<4>[  397.845869] unchecked MSR access error: RDMSR from 0x1b0 at rIP: 0xffffffff8102f58f (init_intel_energy_perf.part.3+0xf/0xb0)
<4>[  397.845871] Call Trace:
<4>[  397.845875]  intel_bsp_resume+0x1a/0x20
<4>[  397.845877]  bsp_resume+0x1d/0x20
<4>[  397.845881]  syscore_resume+0x62/0x320
<4>[  397.845884]  suspend_devices_and_enter+0xa58/0xcf0
<4>[  397.845889]  pm_suspend+0x4f0/0x9d0
<4>[  397.845892]  state_store+0x82/0xf0
<4>[  397.845897]  kobj_attr_store+0xf/0x20
<4>[  397.845900]  sysfs_kf_write+0x45/0x60
<4>[  397.845903]  kernfs_fop_write+0x124/0x1c0
<4>[  397.845907]  __vfs_write+0x28/0x130
<4>[  397.845909]  ? rcu_read_lock_sched_held+0x7a/0x90
<4>[  397.845911]  ? rcu_sync_lockdep_assert+0x2f/0x60
<4>[  397.845914]  ? __sb_start_write+0x10c/0x200
<4>[  397.845917]  vfs_write+0xc8/0x1c0
<4>[  397.845920]  SyS_write+0x49/0xb0
<4>[  397.845925]  entry_SYSCALL_64_fastpath+0x1c/0xb1
<4>[  397.845927] RIP: 0033:0x7fe584325290
<4>[  397.845929] RSP: 002b:00007ffd9e24cae8 EFLAGS: 00000246 ORIG_RAX: 0000000000000001
<4>[  397.845932] RAX: ffffffffffffffda RBX: ffffffff814920c3 RCX: 00007fe584325290
<4>[  397.845933] RDX: 0000000000000004 RSI: 000000000217b060 RDI: 000000000000000a
<4>[  397.845935] RBP: ffffc9000160bf88 R08: 0000000002178de0 R09: 00007fe5847fe700
<4>[  397.845936] R10: 0000000000000003 R11: 0000000000000246 R12: 0000000002178d00
<4>[  397.845937] R13: 0000000000000001 R14: 0000000000000004 R15: 0000000000000004
<4>[  397.845941]  ? __this_cpu_preempt_check+0x13/0x20
<4>[  397.845948] unchecked MSR access error: WRMSR to 0x1b0 (tried to write 0x0000000000000006) at rIP: 0xffffffff8102f5ce (init_intel_energy_perf.part.3+0x4e/0xb0)
<4>[  397.845949] Call Trace:
<4>[  397.845951]  intel_bsp_resume+0x1a/0x20
<4>[  397.845953]  bsp_resume+0x1d/0x20
<4>[  397.845955]  syscore_resume+0x62/0x320
<4>[  397.845958]  suspend_devices_and_enter+0xa58/0xcf0
<4>[  397.845963]  pm_suspend+0x4f0/0x9d0
<4>[  397.845966]  state_store+0x82/0xf0
<4>[  397.845969]  kobj_attr_store+0xf/0x20
<4>[  397.845972]  sysfs_kf_write+0x45/0x60
<4>[  397.845975]  kernfs_fop_write+0x124/0x1c0
<4>[  397.845978]  __vfs_write+0x28/0x130
<4>[  397.845980]  ? rcu_read_lock_sched_held+0x7a/0x90
<4>[  397.845981]  ? rcu_sync_lockdep_assert+0x2f/0x60
<4>[  397.845984]  ? __sb_start_write+0x10c/0x200
<4>[  397.845988]  vfs_write+0xc8/0x1c0
<4>[  397.845991]  SyS_write+0x49/0xb0
<4>[  397.845994]  entry_SYSCALL_64_fastpath+0x1c/0xb1
<4>[  397.845996] RIP: 0033:0x7fe584325290
<4>[  397.845997] RSP: 002b:00007ffd9e24cae8 EFLAGS: 00000246 ORIG_RAX: 0000000000000001
<4>[  397.846000] RAX: ffffffffffffffda RBX: ffffffff814920c3 RCX: 00007fe584325290
<4>[  397.846001] RDX: 0000000000000004 RSI: 000000000217b060 RDI: 000000000000000a
<4>[  397.846003] RBP: ffffc9000160bf88 R08: 0000000002178de0 R09: 00007fe5847fe700
<4>[  397.846004] R10: 0000000000000003 R11: 0000000000000246 R12: 0000000002178d00
<4>[  397.846006] R13: 0000000000000001 R14: 0000000000000004 R15: 0000000000000004
<4>[  397.846009]  ? __this_cpu_preempt_check+0x13/0x20
<6>[  397.846357] Enabling non-boot CPUs ...
Comment 9 Marta Löfstedt 2017-11-21 08:55:23 UTC
https://intel-gfx-ci.01.org/tree/drm-tip/Patchwork_7198/shard-snb2/igt@kms_flip@vblank-vs-dpms-suspend-interruptible.html

[  599.342144] Suspending console(s) (use no_console_suspend to debug)
[  599.343700] sd 0:0:0:0: [sda] Synchronizing SCSI cache
[  599.343806] sd 0:0:0:0: [sda] Stopping disk
[  599.544447] IRQ 28: no longer affine to CPU4
[  599.564396] IRQ 16: no longer affine to CPU5
[  599.585989] IRQ 26: no longer affine to CPU6
[  599.599881] IRQ 8: no longer affine to CPU7
[  599.599898] IRQ 23: no longer affine to CPU7
[  599.599908] IRQ 30: no longer affine to CPU7
[  599.607338]  cache: parent cpu1 should not be sleeping
[  599.612004]  cache: parent cpu2 should not be sleeping
[  599.616788]  cache: parent cpu3 should not be sleeping
[  599.621973]  cache: parent cpu4 should not be sleeping
[  599.627315]  cache: parent cpu5 should not be sleeping
[  599.632732]  cache: parent cpu6 should not be sleeping
[  599.638307]  cache: parent cpu7 should not be sleeping
[  599.671164] hpet1: lost 2226 rtc interrupts
[  599.682159] sd 0:0:0:0: [sda] Starting disk
[  600.050794] Suspending console(s) (use no_console_suspend to debug)
[  600.052244] sd 0:0:0:0: [sda] Synchronizing SCSI cache
[  600.052360] sd 0:0:0:0: [sda] Stopping disk
[  600.298215] unchecked MSR access error: RDMSR from 0x1b0 at rIP: 0xffffffff8102d6bb (init_intel_energy_perf.part.3+0xb/0xa0)
[  600.298217] Call Trace:
[  600.298221]  syscore_resume+0x5d/0x320
[  600.298224]  suspend_devices_and_enter+0xa43/0xcd0
[  600.298229]  pm_suspend+0x4e8/0x9d0
[  600.298232]  state_store+0x72/0xd0
[  600.298237]  kernfs_fop_write+0x110/0x1b0
[  600.298240]  __vfs_write+0x23/0x130
[  600.298243]  ? rcu_read_lock_sched_held+0x74/0x80
[  600.298245]  ? rcu_sync_lockdep_assert+0x2a/0x50
[  600.298247]  ? __sb_start_write+0xde/0x1f0
[  600.298249]  ? __sb_start_write+0xf8/0x1f0
[  600.298252]  vfs_write+0xc2/0x1b0
[  600.298255]  SyS_write+0x45/0xb0
[  600.298259]  entry_SYSCALL_64_fastpath+0x1c/0xb1
[  600.298261] RIP: 0033:0x7f0f234e58f0
[  600.298263] RSP: 002b:00007ffcb586a3a8 EFLAGS: 00000246 ORIG_RAX: 0000000000000001
[  600.298266] RAX: ffffffffffffffda RBX: ffffc90000c27ff0 RCX: 00007f0f234e58f0
[  600.298267] RDX: 0000000000000004 RSI: 0000556989270060 RDI: 0000000000000008
[  600.298268] RBP: 0000000000000004 R08: 000055698926dde0 R09: 00007f0f239b9700
[  600.298270] R10: 00007f0f237aeb58 R11: 0000000000000246 R12: 0000000000000046
[  600.298271] R13: 00007f0f237aeb58 R14: 000000000000270f R15: 0000000000001010
[  600.298279] unchecked MSR access error: WRMSR to 0x1b0 (tried to write 0x0000000000000006) at rIP: 0xffffffff8102d6fa (init_intel_energy_perf.part.3+0x4a/0xa0)
[  600.298280] Call Trace:
[  600.298283]  syscore_resume+0x5d/0x320
[  600.298285]  suspend_devices_and_enter+0xa43/0xcd0
[  600.298289]  pm_suspend+0x4e8/0x9d0
[  600.298292]  state_store+0x72/0xd0
[  600.298296]  kernfs_fop_write+0x110/0x1b0
[  600.298299]  __vfs_write+0x23/0x130
[  600.298301]  ? rcu_read_lock_sched_held+0x74/0x80
[  600.298302]  ? rcu_sync_lockdep_assert+0x2a/0x50
[  600.298304]  ? __sb_start_write+0xde/0x1f0
[  600.298306]  ? __sb_start_write+0xf8/0x1f0
[  600.298309]  vfs_write+0xc2/0x1b0
[  600.298312]  SyS_write+0x45/0xb0
[  600.298315]  entry_SYSCALL_64_fastpath+0x1c/0xb1
[  600.298317] RIP: 0033:0x7f0f234e58f0
[  600.298318] RSP: 002b:00007ffcb586a3a8 EFLAGS: 00000246 ORIG_RAX: 0000000000000001
[  600.298321] RAX: ffffffffffffffda RBX: ffffc90000c27ff0 RCX: 00007f0f234e58f0
[  600.298322] RDX: 0000000000000004 RSI: 0000556989270060 RDI: 0000000000000008
[  600.298323] RBP: 0000000000000004 R08: 000055698926dde0 R09: 00007f0f239b9700
[  600.298325] R10: 00007f0f237aeb58 R11: 0000000000000246 R12: 0000000000000046
[  600.298326] R13: 00007f0f237aeb58 R14: 000000000000270f R15: 0000000000001010
[  600.302152]  cache: parent cpu1 should not be sleeping
[  600.306859]  cache: parent cpu2 should not be sleeping
[  600.311725]  cache: parent cpu3 should not be sleeping
[  600.316866]  cache: parent cpu4 should not be sleeping
[  600.322191]  cache: parent cpu5 should not be sleeping
[  600.327620]  cache: parent cpu6 should not be sleeping
[  600.333180]  cache: parent cpu7 should not be sleeping
[  600.375675] sd 0:0:0:0: [sda] Starting disk
[  600.735596] Suspending console(s) (use no_console_suspend to debug)
[  600.737162] sd 0:0:0:0: [sda] Synchronizing SCSI cache
[  600.737278] sd 0:0:0:0: [sda] Stopping disk
[  600.976800]  cache: parent cpu1 should not be sleeping
[  600.981465]  cache: parent cpu2 should not be sleeping
[  600.986277]  cache: parent cpu3 should not be sleeping
[  600.991423]  cache: parent cpu4 should not be sleeping
[  600.996664]  cache: parent cpu5 should not be sleeping
[  601.002122]  cache: parent cpu6 should not be sleeping
[  601.007667]  cache: parent cpu7 should not be sleeping
[  601.051670] sd 0:0:0:0: [sda] Starting disk
[  601.404288] Suspending console(s) (use no_console_suspend to debug)
[  601.405979] sd 0:0:0:0: [sda] Synchronizing SCSI cache
[  601.406174] sd 0:0:0:0: [sda] Stopping disk
[  601.643639]  cache: parent cpu1 should not be sleeping
[  601.648402]  cache: parent cpu2 should not be sleeping
[  601.653790]  cache: parent cpu3 should not be sleeping
[  601.659241]  cache: parent cpu4 should not be sleeping
[  601.664602]  cache: parent cpu5 should not be sleeping
[  601.670021]  cache: parent cpu6 should not be sleeping
[  601.675606]  cache: parent cpu7 should not be sleeping
[  601.720095] sd 0:0:0:0: [sda] Starting disk
Comment 10 Marta Löfstedt 2017-12-04 07:08:38 UTC
https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_3431/shard-snb2/igt@kms_cursor_crc@cursor-64x64-suspend.html

[  838.719211] Suspending console(s) (use no_console_suspend to debug)
[  838.729293] sd 0:0:0:0: [sda] Synchronizing SCSI cache
[  838.729518] sd 0:0:0:0: [sda] Stopping disk
[  838.991445] unchecked MSR access error: RDMSR from 0x1b0 at rIP: 0xffffffff8102c4a6 (init_intel_energy_perf.part.3+0x6/0xa0)
[  838.991446] Call Trace:
[  838.991450]  syscore_resume+0x58/0x310
[  838.991454]  suspend_devices_and_enter+0xa37/0xcc0
[  838.991461]  pm_suspend+0x4e3/0x9d0
[  838.991465]  state_store+0x6d/0xd0
[  838.991470]  kernfs_fop_write+0x10b/0x1a0
[  838.991476]  __vfs_write+0x1e/0x130
[  838.991479]  ? rcu_read_lock_sched_held+0x6f/0x80
[  838.991481]  ? rcu_sync_lockdep_assert+0x25/0x50
[  838.991483]  ? __sb_start_write+0xd5/0x1f0
[  838.991485]  ? __sb_start_write+0xef/0x1f0
[  838.991490]  vfs_write+0xc0/0x1b0
[  838.991494]  SyS_write+0x40/0xa0
[  838.991499]  entry_SYSCALL_64_fastpath+0x1c/0x89
[  838.991501] RIP: 0033:0x7f8b6bdbf8f0
[  838.991502] RSP: 002b:00007ffe3c486fb8 EFLAGS: 00000246 ORIG_RAX: 0000000000000001
[  838.991505] RAX: ffffffffffffffda RBX: 0000556b1369f050 RCX: 00007f8b6bdbf8f0
[  838.991507] RDX: 0000000000000004 RSI: 0000556b1369f060 RDI: 000000000000000a
[  838.991508] RBP: 00007f8b6c088b00 R08: 0000556b1369cde0 R09: 00007f8b6c293700
[  838.991510] R10: 00007f8b6c088b58 R11: 0000000000000246 R12: 00007f8b6c088b58
[  838.991511] R13: 00007f8b6c088b58 R14: 000000000000270f R15: 0000000000001010
[  838.991523] unchecked MSR access error: WRMSR to 0x1b0 (tried to write 0x0000000000000006) at rIP: 0xffffffff8102c4e5 (init_intel_energy_perf.part.3+0x45/0xa0)
[  838.991524] Call Trace:
[  838.991526]  syscore_resume+0x58/0x310
[  838.991529]  suspend_devices_and_enter+0xa37/0xcc0
[  838.991535]  pm_suspend+0x4e3/0x9d0
[  838.991540]  state_store+0x6d/0xd0
[  838.991544]  kernfs_fop_write+0x10b/0x1a0
[  838.991549]  __vfs_write+0x1e/0x130
[  838.991551]  ? rcu_read_lock_sched_held+0x6f/0x80
[  838.991553]  ? rcu_sync_lockdep_assert+0x25/0x50
[  838.991555]  ? __sb_start_write+0xd5/0x1f0
[  838.991556]  ? __sb_start_write+0xef/0x1f0
[  838.991561]  vfs_write+0xc0/0x1b0
[  838.991565]  SyS_write+0x40/0xa0
[  838.991569]  entry_SYSCALL_64_fastpath+0x1c/0x89
[  838.991571] RIP: 0033:0x7f8b6bdbf8f0
[  838.991572] RSP: 002b:00007ffe3c486fb8 EFLAGS: 00000246 ORIG_RAX: 0000000000000001
[  838.991575] RAX: ffffffffffffffda RBX: 0000556b1369f050 RCX: 00007f8b6bdbf8f0
[  838.991577] RDX: 0000000000000004 RSI: 0000556b1369f060 RDI: 000000000000000a
[  838.991578] RBP: 00007f8b6c088b00 R08: 0000556b1369cde0 R09: 00007f8b6c293700
[  838.991579] R10: 00007f8b6c088b58 R11: 0000000000000246 R12: 00007f8b6c088b58
[  838.991581] R13: 00007f8b6c088b58 R14: 000000000000270f R15: 0000000000001010
[  838.995744]  cache: parent cpu1 should not be sleeping
[  839.000469]  cache: parent cpu2 should not be sleeping
[  839.005338]  cache: parent cpu3 should not be sleeping
[  839.010527]  cache: parent cpu4 should not be sleeping
[  839.015875]  cache: parent cpu5 should not be sleeping
[  839.021373]  cache: parent cpu6 should not be sleeping
[  839.027001]  cache: parent cpu7 should not be sleeping
[  839.071500] sd 0:0:0:0: [sda] Starting disk
[  839.435290] Suspending console(s) (use no_console_suspend to debug)
[  839.455154] sd 0:0:0:0: [sda] Synchronizing SCSI cache
[  839.455376] sd 0:0:0:0: [sda] Stopping disk
[  839.752308]  cache: parent cpu1 should not be sleeping
[  839.757091]  cache: parent cpu2 should not be sleeping
[  839.761962]  cache: parent cpu3 should not be sleeping
[  839.767115]  cache: parent cpu4 should not be sleeping
[  839.772364]  cache: parent cpu5 should not be sleeping
[  839.777800]  cache: parent cpu6 should not be sleeping
[  839.783264]  cache: parent cpu7 should not be sleeping
[  839.820082] mei_me 0000:00:16.0: less data available than length=00000000.
[  839.829315] sd 0:0:0:0: [sda] Starting disk
Comment 11 Marta Löfstedt 2017-12-04 11:54:00 UTC
https://intel-gfx-ci.01.org/tree/drm-tip/IGTPW_577/fi-snb-2600/igt@kms_pipe_crc_basic@suspend-read-crc-pipe-a.html

[  383.360064] IRQ 23: no longer affine to CPU7
[  383.363199] unchecked MSR access error: RDMSR from 0x1b0 at rIP: 0xffffffff8102c4a6 (init_intel_energy_perf.part.3+0x6/0xa0)
[  383.363201] Call Trace:
[  383.363205]  syscore_resume+0x58/0x310
[  383.363209]  suspend_devices_and_enter+0xa37/0xcc0
[  383.363215]  pm_suspend+0x4e3/0x9d0
[  383.363220]  state_store+0x6d/0xd0
[  383.363225]  kernfs_fop_write+0x10b/0x1a0
[  383.363230]  __vfs_write+0x1e/0x130
[  383.363234]  ? rcu_read_lock_sched_held+0x6f/0x80
[  383.363235]  ? rcu_sync_lockdep_assert+0x25/0x50
[  383.363238]  ? __sb_start_write+0xd5/0x1f0
[  383.363239]  ? __sb_start_write+0xef/0x1f0
[  383.363244]  vfs_write+0xc0/0x1b0
[  383.363248]  SyS_write+0x40/0xa0
[  383.363253]  entry_SYSCALL_64_fastpath+0x1c/0x89
[  383.363255] RIP: 0033:0x7f8c86637290
[  383.363257] RSP: 002b:00007ffd77508b38 EFLAGS: 00000246 ORIG_RAX: 0000000000000001
[  383.363260] RAX: ffffffffffffffda RBX: 00007f8c86904b20 RCX: 00007f8c86637290
[  383.363261] RDX: 0000000000000004 RSI: 0000000001922060 RDI: 000000000000000a
[  383.363263] RBP: 0000000000001011 R08: 000000000191fde0 R09: 00007f8c86b10700
[  383.363264] R10: 0000000000000003 R11: 0000000000000246 R12: 00007f8c86904b78
[  383.363266] R13: 00007f8c86904b78 R14: 000000000000270f R15: 00007f8c86904b78
[  383.363277] unchecked MSR access error: WRMSR to 0x1b0 (tried to write 0x0000000000000006) at rIP: 0xffffffff8102c4e5 (init_intel_energy_perf.part.3+0x45/0xa0)
[  383.363278] Call Trace:
[  383.363280]  syscore_resume+0x58/0x310
[  383.363283]  suspend_devices_and_enter+0xa37/0xcc0
[  383.363290]  pm_suspend+0x4e3/0x9d0
[  383.363294]  state_store+0x6d/0xd0
[  383.363298]  kernfs_fop_write+0x10b/0x1a0
[  383.363303]  __vfs_write+0x1e/0x130
[  383.363306]  ? rcu_read_lock_sched_held+0x6f/0x80
[  383.363307]  ? rcu_sync_lockdep_assert+0x25/0x50
[  383.363309]  ? __sb_start_write+0xd5/0x1f0
[  383.363311]  ? __sb_start_write+0xef/0x1f0
[  383.363316]  vfs_write+0xc0/0x1b0
[  383.363320]  SyS_write+0x40/0xa0
[  383.363324]  entry_SYSCALL_64_fastpath+0x1c/0x89
[  383.363325] RIP: 0033:0x7f8c86637290
[  383.363326] RSP: 002b:00007ffd77508b38 EFLAGS: 00000246 ORIG_RAX: 0000000000000001
[  383.363329] RAX: ffffffffffffffda RBX: 00007f8c86904b20 RCX: 00007f8c86637290
[  383.363331] RDX: 0000000000000004 RSI: 0000000001922060 RDI: 000000000000000a
[  383.363332] RBP: 0000000000001011 R08: 000000000191fde0 R09: 00007f8c86b10700
[  383.363333] R10: 0000000000000003 R11: 0000000000000246 R12: 00007f8c86904b78
[  383.363335] R13: 00007f8c86904b78 R14: 000000000000270f R15: 00007f8c86904b78
[  383.367323]  cache: parent cpu1 should not be sleeping
[  383.372081]  cache: parent cpu2 should not be sleeping
[  383.377028]  cache: parent cpu3 should not be sleeping
[  383.382281]  cache: parent cpu4 should not be sleeping
[  383.387633]  cache: parent cpu5 should not be sleeping
[  383.393155]  cache: parent cpu6 should not be sleeping
[  383.398855]  cache: parent cpu7 should not be sleeping
[  383.437815] hpet1: lost 8368 rtc interrupts
[  383.450747] sd 0:0:0:0: [sda] Starting disk
Comment 12 Marta Löfstedt 2017-12-05 07:13:06 UTC
https://intel-gfx-ci.01.org/tree/drm-tip/IGT_4036/shard-snb1/igt@kms_flip@vblank-vs-modeset-suspend.html

[  101.147381] IRQ 30: no longer affine to CPU7
[  101.150605] unchecked MSR access error: RDMSR from 0x1b0 at rIP: 0xffffffff8102c4a6 (init_intel_energy_perf.part.3+0x6/0xa0)
[  101.150606] Call Trace:
[  101.150610]  syscore_resume+0x58/0x310
[  101.150614]  suspend_devices_and_enter+0xa37/0xcc0
[  101.150621]  pm_suspend+0x4e3/0x9d0
[  101.150625]  state_store+0x6d/0xd0
[  101.150630]  kernfs_fop_write+0x10b/0x1a0
[  101.150636]  __vfs_write+0x1e/0x130
[  101.150639]  ? rcu_read_lock_sched_held+0x6f/0x80
[  101.150641]  ? rcu_sync_lockdep_assert+0x25/0x50
[  101.150643]  ? __sb_start_write+0xd5/0x1f0
[  101.150645]  ? __sb_start_write+0xef/0x1f0
[  101.150649]  vfs_write+0xc0/0x1b0
[  101.150654]  SyS_write+0x40/0xa0
[  101.150658]  entry_SYSCALL_64_fastpath+0x1c/0x89
[  101.150661] RIP: 0033:0x7f40ef8868f0
[  101.150662] RSP: 002b:00007fff40738268 EFLAGS: 00000246 ORIG_RAX: 0000000000000001
[  101.150665] RAX: ffffffffffffffda RBX: 0000558484060050 RCX: 00007f40ef8868f0
[  101.150667] RDX: 0000000000000004 RSI: 0000558484060060 RDI: 0000000000000008
[  101.150668] RBP: 00007f40efb4fb00 R08: 000055848405dde0 R09: 00007f40efd5a700
[  101.150669] R10: 00007f40efb4fb58 R11: 0000000000000246 R12: 00007f40efb4fb58
[  101.150671] R13: 00007f40efb4fb58 R14: 000000000000270f R15: 0000000000001010
[  101.150682] unchecked MSR access error: WRMSR to 0x1b0 (tried to write 0x0000000000000006) at rIP: 0xffffffff8102c4e5 (init_intel_energy_perf.part.3+0x45/0xa0)
[  101.150684] Call Trace:
[  101.150686]  syscore_resume+0x58/0x310
[  101.150689]  suspend_devices_and_enter+0xa37/0xcc0
[  101.150695]  pm_suspend+0x4e3/0x9d0
[  101.150699]  state_store+0x6d/0xd0
[  101.150704]  kernfs_fop_write+0x10b/0x1a0
[  101.150708]  __vfs_write+0x1e/0x130
[  101.150711]  ? rcu_read_lock_sched_held+0x6f/0x80
[  101.150713]  ? rcu_sync_lockdep_assert+0x25/0x50
[  101.150715]  ? __sb_start_write+0xd5/0x1f0
[  101.150716]  ? __sb_start_write+0xef/0x1f0
[  101.150721]  vfs_write+0xc0/0x1b0
[  101.150725]  SyS_write+0x40/0xa0
[  101.150729]  entry_SYSCALL_64_fastpath+0x1c/0x89
[  101.150731] RIP: 0033:0x7f40ef8868f0
[  101.150732] RSP: 002b:00007fff40738268 EFLAGS: 00000246 ORIG_RAX: 0000000000000001
[  101.150735] RAX: ffffffffffffffda RBX: 0000558484060050 RCX: 00007f40ef8868f0
[  101.150736] RDX: 0000000000000004 RSI: 0000558484060060 RDI: 0000000000000008
[  101.150737] RBP: 00007f40efb4fb00 R08: 000055848405dde0 R09: 00007f40efd5a700
[  101.150739] R10: 00007f40efb4fb58 R11: 0000000000000246 R12: 00007f40efb4fb58
[  101.150740] R13: 00007f40efb4fb58 R14: 000000000000270f R15: 0000000000001010
[  101.155864]  cache: parent cpu1 should not be sleeping
Comment 14 Marta Löfstedt 2018-02-06 06:33:30 UTC
https://intel-gfx-ci.01.org/tree/drm-tip/IGT_4221/shard-snb3/igt@drv_suspend@debugfs-reader.html

	

[  151.478226] Suspending console(s) (use no_console_suspend to debug)
[  151.490025] sd 0:0:0:0: [sda] Synchronizing SCSI cache
[  151.499070] sd 0:0:0:0: [sda] Stopping disk
[  151.663093] IRQ 25: no longer affine to CPU4
[  151.663101] IRQ 28: no longer affine to CPU4
[  151.683370] IRQ 16: no longer affine to CPU5
[  151.683379] IRQ 24: no longer affine to CPU5
[  151.702812] IRQ 26: no longer affine to CPU6
[  151.714970] IRQ 8: no longer affine to CPU7
[  151.714980] IRQ 9: no longer affine to CPU7
[  151.714993] IRQ 23: no longer affine to CPU7
[  151.715002] IRQ 30: no longer affine to CPU7
[  151.718586] unchecked MSR access error: RDMSR from 0x1b0 at rIP: 0xffffffff8102e236 (init_intel_energy_perf.part.3+0x6/0xa0)
[  151.718588] Call Trace:
[  151.718592]  syscore_resume+0x58/0x310
[  151.718596]  suspend_devices_and_enter+0xa37/0xcc0
[  151.718603]  pm_suspend+0x4e3/0x9d0
[  151.718607]  state_store+0x6d/0xd0
[  151.718612]  kernfs_fop_write+0x10b/0x1a0
[  151.718617]  __vfs_write+0x1e/0x130
[  151.718620]  ? rcu_read_lock_sched_held+0x6f/0x80
[  151.718622]  ? rcu_sync_lockdep_assert+0x25/0x50
[  151.718624]  ? __sb_start_write+0xd9/0x1f0
[  151.718626]  ? __sb_start_write+0xf3/0x1f0
[  151.718630]  vfs_write+0xbd/0x1b0
[  151.718634]  SyS_write+0x40/0xa0
[  151.718639]  entry_SYSCALL_64_fastpath+0x22/0x8f
[  151.718641] RIP: 0033:0x7f2bda7da8f0
[  151.718643] RSP: 002b:00007ffce2542e88 EFLAGS: 00000246
[  151.718654] unchecked MSR access error: WRMSR to 0x1b0 (tried to write 0x0000000000000006) at rIP: 0xffffffff8102e275 (init_intel_energy_perf.part.3+0x45/0xa0)
[  151.718656] Call Trace:
[  151.718658]  syscore_resume+0x58/0x310
[  151.718661]  suspend_devices_and_enter+0xa37/0xcc0
[  151.718667]  pm_suspend+0x4e3/0x9d0
[  151.718672]  state_store+0x6d/0xd0
[  151.718676]  kernfs_fop_write+0x10b/0x1a0
[  151.718680]  __vfs_write+0x1e/0x130
[  151.718683]  ? rcu_read_lock_sched_held+0x6f/0x80
[  151.718684]  ? rcu_sync_lockdep_assert+0x25/0x50
[  151.718687]  ? __sb_start_write+0xd9/0x1f0
[  151.718688]  ? __sb_start_write+0xf3/0x1f0
[  151.718693]  vfs_write+0xbd/0x1b0
[  151.718696]  SyS_write+0x40/0xa0
[  151.718700]  entry_SYSCALL_64_fastpath+0x22/0x8f
[  151.718702] RIP: 0033:0x7f2bda7da8f0
[  151.718703] RSP: 002b:00007ffce2542e88 EFLAGS: 00000246
[  151.723616]  cache: parent cpu1 should not be sleeping
[  151.728928]  cache: parent cpu2 should not be sleeping
[  151.733745]  cache: parent cpu3 should not be sleeping
[  151.738708]  cache: parent cpu4 should not be sleeping
[  151.743899]  cache: parent cpu5 should not be sleeping
[  151.749264]  cache: parent cpu6 should not be sleeping
[  151.754852]  cache: parent cpu7 should not be sleeping
[  151.793387] hpet1: lost 9499 rtc interrupts
[  151.806201] sd 0:0:0:0: [sda] Starting disk
Comment 15 Marta Löfstedt 2018-03-06 06:37:54 UTC
back on cibuglog due to:
https://intel-gfx-ci.01.org/tree/drm-tip/IGT_4328/fi-snb-2600/igt@gem_exec_suspend@basic-s3.html

	

[  193.911275] Setting dangerous option reset - tainting kernel
[  194.285020] Suspending console(s) (use no_console_suspend to debug)
[  194.296204] sd 0:0:0:0: [sda] Synchronizing SCSI cache
[  194.296424] sd 0:0:0:0: [sda] Stopping disk
[  194.462046] IRQ 16: no longer affine to CPU4
[  194.475834] IRQ 26: no longer affine to CPU5
[  194.492047] IRQ 23: no longer affine to CPU6
[  194.499894] IRQ 8: no longer affine to CPU7
[  194.499900] IRQ 9: no longer affine to CPU7
[  194.499908] IRQ 24: no longer affine to CPU7
[  194.502714] unchecked MSR access error: RDMSR from 0x1b0 at rIP: 0xffffffff8102e166 (init_intel_energy_perf.part.3+0x6/0xa0)
[  194.502716] Call Trace:
[  194.502721]  syscore_resume+0x58/0x310
[  194.502726]  suspend_devices_and_enter+0xa37/0xcc0
[  194.502733]  pm_suspend+0x4e3/0x9d0
[  194.502738]  state_store+0x6d/0xd0
[  194.502743]  kernfs_fop_write+0xfe/0x180
[  194.502748]  __vfs_write+0x1e/0x130
[  194.502752]  ? rcu_read_lock_sched_held+0x6f/0x80
[  194.502754]  ? rcu_sync_lockdep_assert+0x25/0x50
[  194.502757]  ? __sb_start_write+0xd9/0x1f0
[  194.502759]  ? __sb_start_write+0xf3/0x1f0
[  194.502764]  vfs_write+0xbd/0x1b0
[  194.502768]  SyS_write+0x40/0xa0
[  194.502773]  do_syscall_64+0x65/0x1a0
[  194.502778]  entry_SYSCALL_64_after_hwframe+0x42/0xb7
[  194.502780] RIP: 0033:0x7fd859de9290
[  194.502782] RSP: 002b:00007ffd8f6656d8 EFLAGS: 00000246 ORIG_RAX: 0000000000000001
[  194.502786] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007fd859de9290
[  194.502787] RDX: 0000000000000004 RSI: 0000000001b78060 RDI: 0000000000000008
[  194.502789] RBP: 0000000001b78060 R08: 0000000001b75df0 R09: 00007fd85a2c2700
[  194.502790] R10: 0000000000000003 R11: 0000000000000246 R12: 0000000000000004
[  194.502792] R13: 0000000000000001 R14: 0000000001b75d10 R15: 00007ffd8f667c11
[  194.502804] unchecked MSR access error: WRMSR to 0x1b0 (tried to write 0x0000000000000006) at rIP: 0xffffffff8102e1a5 (init_intel_energy_perf.part.3+0x45/0xa0)
[  194.502805] Call Trace:
[  194.502808]  syscore_resume+0x58/0x310
[  194.502812]  suspend_devices_and_enter+0xa37/0xcc0
[  194.502819]  pm_suspend+0x4e3/0x9d0
[  194.502823]  state_store+0x6d/0xd0
[  194.502827]  kernfs_fop_write+0xfe/0x180
[  194.502832]  __vfs_write+0x1e/0x130
[  194.502835]  ? rcu_read_lock_sched_held+0x6f/0x80
[  194.502837]  ? rcu_sync_lockdep_assert+0x25/0x50
[  194.502840]  ? __sb_start_write+0xd9/0x1f0
[  194.502842]  ? __sb_start_write+0xf3/0x1f0
[  194.502847]  vfs_write+0xbd/0x1b0
[  194.502851]  SyS_write+0x40/0xa0
[  194.502855]  do_syscall_64+0x65/0x1a0
[  194.502859]  entry_SYSCALL_64_after_hwframe+0x42/0xb7
[  194.502860] RIP: 0033:0x7fd859de9290
[  194.502862] RSP: 002b:00007ffd8f6656d8 EFLAGS: 00000246 ORIG_RAX: 0000000000000001
[  194.502865] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007fd859de9290
[  194.502867] RDX: 0000000000000004 RSI: 0000000001b78060 RDI: 0000000000000008
[  194.502868] RBP: 0000000001b78060 R08: 0000000001b75df0 R09: 00007fd85a2c2700
[  194.502870] R10: 0000000000000003 R11: 0000000000000246 R12: 0000000000000004
[  194.502871] R13: 0000000000000001 R14: 0000000001b75d10 R15: 00007ffd8f667c11
[  194.507649]  cache: parent cpu1 should not be sleeping
[  194.512962]  cache: parent cpu2 should not be sleeping
[  194.518015]  cache: parent cpu3 should not be sleeping
[  194.523122]  cache: parent cpu4 should not be sleeping
[  194.528219]  cache: parent cpu5 should not be sleeping
[  194.533532]  cache: parent cpu6 should not be sleeping
[  194.539032]  cache: parent cpu7 should not be sleeping
[  194.576750] hpet1: lost 6759 rtc interrupts
[  194.588392] sd 0:0:0:0: [sda] Starting disk
[  195.154420] Setting dangerous option reset - tainting kernel
Comment 17 Marta Löfstedt 2018-03-28 05:53:08 UTC
https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_3992/shard-snb5/igt@kms_cursor_crc@cursor-128x128-suspend.html

[  134.511579] unchecked MSR access error: RDMSR from 0x1b0 at rIP: 0xffffffff8102e236 (init_intel_energy_perf.part.3+0x6/0xa0)
[  134.511580] Call Trace:
[  134.511584]  syscore_resume+0x58/0x310
[  134.511589]  suspend_devices_and_enter+0xa37/0xcc0
[  134.511596]  pm_suspend+0x4e3/0x9d0
[  134.511601]  state_store+0x6d/0xd0
[  134.511606]  kernfs_fop_write+0xfe/0x180
[  134.511611]  __vfs_write+0x1e/0x130
[  134.511615]  ? rcu_read_lock_sched_held+0x6f/0x80
[  134.511617]  ? rcu_sync_lockdep_assert+0x25/0x50
[  134.511620]  ? __sb_start_write+0xd9/0x1f0
[  134.511622]  ? __sb_start_write+0xf3/0x1f0
[  134.511627]  vfs_write+0xbd/0x1b0
[  134.511631]  SyS_write+0x40/0xa0
[  134.511636]  do_syscall_64+0x65/0x1a0
[  134.511639]  entry_SYSCALL_64_after_hwframe+0x42/0xb7
[  134.511642] RIP: 0033:0x7fb049bdf154
[  134.511643] RSP: 002b:00007ffd579d9dc8 EFLAGS: 00000246 ORIG_RAX: 0000000000000001
[  134.511647] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007fb049bdf154
[  134.511648] RDX: 0000000000000004 RSI: 00005567d7ca75b0 RDI: 000000000000000a
[  134.511650] RBP: 00005567d7ca75b0 R08: 00005567d7ca45e0 R09: 00007fb04a0ce540
[  134.511652] R10: 00005567d7ca2010 R11: 0000000000000246 R12: 00005567d7ca4500
[  134.511653] R13: 0000000000000004 R14: 00007fb049eb72a0 R15: 00007fb049eb6760
[  134.511665] unchecked MSR access error: WRMSR to 0x1b0 (tried to write 0x0000000000000006) at rIP: 0xffffffff8102e275 (init_intel_energy_perf.part.3+0x45/0xa0)
[  134.511666] Call Trace:
[  134.511669]  syscore_resume+0x58/0x310
[  134.511672]  suspend_devices_and_enter+0xa37/0xcc0
[  134.511679]  pm_suspend+0x4e3/0x9d0
[  134.511683]  state_store+0x6d/0xd0
[  134.511688]  kernfs_fop_write+0xfe/0x180
[  134.511692]  __vfs_write+0x1e/0x130
[  134.511695]  ? rcu_read_lock_sched_held+0x6f/0x80
[  134.511697]  ? rcu_sync_lockdep_assert+0x25/0x50
[  134.511700]  ? __sb_start_write+0xd9/0x1f0
[  134.511702]  ? __sb_start_write+0xf3/0x1f0
[  134.511707]  vfs_write+0xbd/0x1b0
[  134.511711]  SyS_write+0x40/0xa0
[  134.511715]  do_syscall_64+0x65/0x1a0
[  134.511718]  entry_SYSCALL_64_after_hwframe+0x42/0xb7
[  134.511720] RIP: 0033:0x7fb049bdf154
[  134.511721] RSP: 002b:00007ffd579d9dc8 EFLAGS: 00000246 ORIG_RAX: 0000000000000001
[  134.511724] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007fb049bdf154
[  134.511726] RDX: 0000000000000004 RSI: 00005567d7ca75b0 RDI: 000000000000000a
[  134.511727] RBP: 00005567d7ca75b0 R08: 00005567d7ca45e0 R09: 00007fb04a0ce540
[  134.511729] R10: 00005567d7ca2010 R11: 0000000000000246 R12: 00005567d7ca4500
[  134.511731] R13: 0000000000000004 R14: 00007fb049eb72a0 R15: 00007fb049eb6760
Comment 19 Marta Löfstedt 2018-04-12 08:35:32 UTC
https://intel-gfx-ci.01.org/tree/drm-tip/drmtip_17/fi-snb-2600/igt@gem_softpin@noreloc-s3.html

<6>[   62.328024] PM: Restoring platform NVS memory
<4>[   62.328111] unchecked MSR access error: RDMSR from 0x1b0 at rIP: 0xffffffffb202f986 (init_intel_energy_perf.part.3+0x6/0xa0)
<4>[   62.328113] Call Trace:
<4>[   62.328117]  syscore_resume+0x58/0x310
<4>[   62.328121]  suspend_devices_and_enter+0xa6b/0xcf0
<4>[   62.328128]  pm_suspend+0x4fc/0x9e0
<4>[   62.328134]  state_store+0x6d/0xd0
<4>[   62.328140]  kernfs_fop_write+0xfe/0x180
<4>[   62.328145]  __vfs_write+0x2e/0x150
<4>[   62.328150]  ? rcu_read_lock_sched_held+0x6f/0x80
<4>[   62.328152]  ? rcu_sync_lockdep_assert+0x25/0x50
<4>[   62.328155]  ? __sb_start_write+0xd9/0x1f0
<4>[   62.328157]  ? __sb_start_write+0xf3/0x1f0
<4>[   62.328162]  vfs_write+0xbd/0x1b0
<4>[   62.328166]  SyS_write+0x50/0xc0
<4>[   62.328168]  ? do_syscall_64+0x19/0x1a0
<4>[   62.328172]  do_syscall_64+0x65/0x1a0
<4>[   62.328177]  entry_SYSCALL_64_after_hwframe+0x42/0xb7
<4>[   62.328179] RIP: 0033:0x7f70d8eeb154
<4>[   62.328181] RSP: 002b:00007ffd18d5e9d8 EFLAGS: 00000246 ORIG_RAX: 0000000000000001
<4>[   62.328185] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007f70d8eeb154
<4>[   62.328186] RDX: 0000000000000004 RSI: 00005640bab8e5b0 RDI: 0000000000000008
<4>[   62.328188] RBP: 00005640bab8e5b0 R08: 00005640bab8b5e0 R09: 00007f70d93d3540
<4>[   62.328190] R10: 00005640bab89010 R11: 0000000000000246 R12: 00005640bab8b500
<4>[   62.328191] R13: 0000000000000004 R14: 00007f70d91c32a0 R15: 00007f70d91c2760
<4>[   62.328203] unchecked MSR access error: WRMSR to 0x1b0 (tried to write 0x0000000000000006) at rIP: 0xffffffffb202f9c5 (init_intel_energy_perf.part.3+0x45/0xa0)
<4>[   62.328204] Call Trace:
<4>[   62.328207]  syscore_resume+0x58/0x310
<4>[   62.328210]  suspend_devices_and_enter+0xa6b/0xcf0
<4>[   62.328217]  pm_suspend+0x4fc/0x9e0
<4>[   62.328222]  state_store+0x6d/0xd0
<4>[   62.328227]  kernfs_fop_write+0xfe/0x180
<4>[   62.328231]  __vfs_write+0x2e/0x150
<4>[   62.328235]  ? rcu_read_lock_sched_held+0x6f/0x80
<4>[   62.328237]  ? rcu_sync_lockdep_assert+0x25/0x50
<4>[   62.328240]  ? __sb_start_write+0xd9/0x1f0
<4>[   62.328241]  ? __sb_start_write+0xf3/0x1f0
<4>[   62.328247]  vfs_write+0xbd/0x1b0
<4>[   62.328251]  SyS_write+0x50/0xc0
<4>[   62.328253]  ? do_syscall_64+0x19/0x1a0
<4>[   62.328257]  do_syscall_64+0x65/0x1a0
<4>[   62.328261]  entry_SYSCALL_64_after_hwframe+0x42/0xb7
<4>[   62.328262] RIP: 0033:0x7f70d8eeb154
<4>[   62.328264] RSP: 002b:00007ffd18d5e9d8 EFLAGS: 00000246 ORIG_RAX: 0000000000000001
<4>[   62.328267] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 00007f70d8eeb154
<4>[   62.328268] RDX: 0000000000000004 RSI: 00005640bab8e5b0 RDI: 0000000000000008
<4>[   62.328270] RBP: 00005640bab8e5b0 R08: 00005640bab8b5e0 R09: 00007f70d93d3540
<4>[   62.328272] R10: 00005640bab89010 R11: 0000000000000246 R12: 00005640bab8b500
<4>[   62.328273] R13: 0000000000000004 R14: 00007f70d91c32a0 R15: 00007f70d91c2760
Comment 20 Martin Peres 2018-10-19 11:37:33 UTC
Krisman is not working on this anymore. Removing him.
Comment 21 CI Bug Log 2019-02-07 11:08:55 UTC
A CI Bug Log filter associated to this bug has been updated:

{- SNB: igt@*(s3|suspend)* - unchecked MSR access error: RDMSR from 0x1b0 -}
{+ SNB: igt@*(s3|suspend)* - unchecked MSR access error: RDMSR from 0x1b0 +}

New failures caught by the filter:

* https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_5554/shard-snb6/igt@kms_flip@flip-vs-suspend.html
Comment 22 CI Bug Log 2019-06-19 11:27:17 UTC
A CI Bug Log filter associated to this bug has been updated:

{- SNB: igt@*(s3|suspend)* - unchecked MSR access error: RDMSR from 0x1b0 -}
{+ SNB: igt@*(s3|suspend)* - unchecked MSR access error: RDMSR from 0x1b0 +}

New failures caught by the filter:

  * https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_6294/shard-snb1/igt@kms_cursor_crc@pipe-a-cursor-suspend.html
Comment 23 Martin Peres 2019-11-29 17:25:39 UTC
-- GitLab Migration Automatic Message --

This bug has been migrated to freedesktop.org's GitLab instance and has been closed from further activity.

You can subscribe and participate further through the new bug through this link to our GitLab instance: https://gitlab.freedesktop.org/drm/intel/issues/42.


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.