Bug 100420

Summary: [BDW][EXT] igt@kms_flip@vblank-vs-dpms-suspend-interruptible hard LOCKUP on cpu 3
Product: DRI Reporter: Tomi Sarvela <tomi.p.sarvela>
Component: DRM/IntelAssignee: Intel GFX Bugs mailing list <intel-gfx-bugs>
Status: CLOSED DUPLICATE QA Contact: Intel GFX Bugs mailing list <intel-gfx-bugs>
Severity: normal    
Priority: medium CC: intel-gfx-bugs
Version: DRI git   
Hardware: Other   
OS: All   
Whiteboard:
i915 platform: BDW i915 features: power/runtime PM

Description Tomi Sarvela 2017-03-27 15:15:40 UTC 
Todays DRM-Tip, kconfig close to
https://intel-gfx-ci.01.org/CI/CI_DRM_2413/kernel.config.bz2

Running IGT extended list, BDW NUC panicked in hard lockup.

Trace catched from pstore:

<7>[ 1193.617247] [drm:intel_power_well_disable [i915]] disabling display
<7>[ 1193.617312] [drm:hsw_set_power_well [i915]] Requesting to disable the power well
<7>[ 1193.617354] [drm:verify_connector_state.isra.48 [i915]] [CONNECTOR:53:DP-1]
<7>[ 1193.617387] [drm:intel_atomic_commit_tail [i915]] [CRTC:39:pipe B]
<7>[ 1193.617420] [drm:verify_single_dpll_state.isra.73 [i915]] LCPLL 810
<7>[ 1193.617450] [drm:intel_power_well_disable [i915]] disabling always-on
<6>[ 1193.672616] PM: Syncing filesystems ... done.
<7>[ 1193.673139] PM: Preparing system for sleep (mem)
<6>[ 1193.673599] Freezing user space processes ... (elapsed 0.001 seconds) done.
<6>[ 1193.675270] Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done.
<7>[ 1193.676773] PM: Suspending system (mem)
<4>[ 1193.676914] Suspending console(s) (use no_console_suspend to debug)
<5>[ 1193.679046] sd 0:0:0:0: [sda] Synchronizing SCSI cache
<5>[ 1193.679140] sd 0:0:0:0: [sda] Stopping disk
<6>[ 1193.680224] e1000e: EEE TX LPI TIMER: 00000011
<7>[ 1193.680290] [drm:intel_power_well_enable [i915]] enabling always-on
<7>[ 1193.680320] [drm:intel_power_well_enable [i915]] enabling display
<7>[ 1193.680349] [drm:hsw_set_power_well [i915]] Enabling power well
<7>[ 1193.680735] [drm:intel_atomic_check [i915]] New cdclk calculated to be logical 337500 kHz, actual 337500 kHz
<7>[ 1193.680867] [drm:intel_atomic_commit_tail [i915]] [ENCODER:47:DDI B]
<7>[ 1193.680899] [drm:intel_atomic_commit_tail [i915]] [ENCODER:52:DDI C]
<7>[ 1193.680934] [drm:intel_atomic_commit_tail [i915]] [ENCODER:54:DP-MST A]
<7>[ 1193.680963] [drm:intel_atomic_commit_tail [i915]] [ENCODER:55:DP-MST B]
<7>[ 1193.680992] [drm:intel_atomic_commit_tail [i915]] [ENCODER:56:DP-MST C]
<7>[ 1193.681021] [drm:verify_connector_state.isra.48 [i915]] [CONNECTOR:53:DP-1]
<7>[ 1193.681057] [drm:verify_single_dpll_state.isra.73 [i915]] WRPLL 1
<7>[ 1193.681090] [drm:verify_single_dpll_state.isra.73 [i915]] WRPLL 2
<7>[ 1193.681121] [drm:verify_single_dpll_state.isra.73 [i915]] SPLL
<7>[ 1193.681152] [drm:verify_single_dpll_state.isra.73 [i915]] LCPLL 810
<7>[ 1193.681179] [drm:verify_single_dpll_state.isra.73 [i915]] LCPLL 1350
<7>[ 1193.681206] [drm:verify_single_dpll_state.isra.73 [i915]] LCPLL 2700
<7>[ 1193.681243] [drm:intel_atomic_commit_tail [i915]] [CRTC:39:pipe B]
<0>[ 1211.603046] NMI watchdog: Watchdog detected hard LOCKUP on cpu 3
<4>[ 1211.603047] Modules linked in: snd_hda_intel i915 vgem snd_hda_codec_hdmi x86_pkg_temp_thermal intel_powerclamp coretemp crct10dif_pclmul crc32_pclmul snd_hda_codec_realtek snd_hda_codec_generic ghash_clmulni_intel e1000e snd_hda_codec snd_hwdep snd_hda_core snd_pcm ptp mei_me prime_numbers pps_core mei lpc_ich i2c_hid i2c_designware_platform i2c_designware_core [last unloaded: i915]
<4>[ 1211.603053] irq event stamp: 13366
<4>[ 1211.603053] hardirqs last  enabled at (13365): [<ffffffff81891a87>] _raw_spin_unlock_irq+0x27/0x50
<4>[ 1211.603053] hardirqs last disabled at (13366): [<ffffffff818918d2>] _raw_spin_lock_irq+0x12/0x50
<4>[ 1211.603054] softirqs last  enabled at (12744): [<ffffffff81085c79>] __do_softirq+0x1d9/0x4c0
<4>[ 1211.603054] softirqs last disabled at (12721): [<ffffffff810860d9>] irq_exit+0xa9/0xc0
<4>[ 1211.603054] CPU: 3 PID: 10443 Comm: kworker/u8:11 Tainted: G     U          4.11.0-rc4-CI-CI_DRM_319+ #1
<4>[ 1211.603055] Hardware name:                  /NUC5i5RYB, BIOS RYBDWi35.86A.0362.2017.0118.0940 01/18/2017
<4>[ 1211.603055] Workqueue: events_unbound async_run_entry_fn
<4>[ 1211.603056] task: ffff88024cd32740 task.stack: ffffc9000162c000
<4>[ 1211.603056] RIP: 0010:preempt_count_add+0xe/0xc0
<4>[ 1211.603056] RSP: 0018:ffffc9000162fbd8 EFLAGS: 00000082
<4>[ 1211.603057] RAX: 0000000080000001 RBX: 0000000704b96558 RCX: 0000000000000002
<4>[ 1211.603057] RDX: 0000000000000000 RSI: ffffffff81c74f2d RDI: 0000000000000001
<4>[ 1211.603057] RBP: ffffc9000162fc08 R08: 00000000bbcc90cc R09: 23c7b07100000000
<4>[ 1211.603058] R10: ffffffff827901a8 R11: ffff88024cd32740 R12: 0000000704b92baa
<4>[ 1211.603058] R13: 0000000000003ea0 R14: 0000000000000003 R15: ffffffffa00061f0
<4>[ 1211.603058] FS:  0000000000000000(0000) GS:ffff880256d80000(0000) knlGS:0000000000000000
<4>[ 1211.603058] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
<4>[ 1211.603059] CR2: 00007f90f84a5144 CR3: 0000000003e0f000 CR4: 00000000003406e0
<4>[ 1211.603059] Call Trace:
<4>[ 1211.603059]  ? delay_tsc+0x3d/0xc0
<4>[ 1211.603059]  __delay+0xa/0x10
<4>[ 1211.603060]  __const_udelay+0x31/0x40
<4>[ 1211.603060]  snd_hdac_bus_stop_cmd_io+0x96/0xe0 [snd_hda_core]
<4>[ 1211.603060]  ? azx_dev_disconnect+0x20/0x20 [snd_hda_intel]
<4>[ 1211.603061]  snd_hdac_bus_stop_chip+0xb1/0x100 [snd_hda_core]
<4>[ 1211.603061]  azx_stop_chip+0x9/0x10 [snd_hda_codec]
<4>[ 1211.603061]  azx_suspend+0x72/0x220 [snd_hda_intel]
<4>[ 1211.603061]  pci_pm_suspend+0x71/0x140
<4>[ 1211.603062]  dpm_run_callback+0x6f/0x330
<4>[ 1211.603062]  ? pci_pm_freeze+0xe0/0xe0
<4>[ 1211.603062]  __device_suspend+0xf9/0x370
<4>[ 1211.603062]  ? dpm_watchdog_set+0x60/0x60
<4>[ 1211.603063]  async_suspend+0x1a/0x90
<4>[ 1211.603063]  async_run_entry_fn+0x34/0x160
<4>[ 1211.603063]  process_one_work+0x1f4/0x6d0
<4>[ 1211.603063]  ? process_one_work+0x16e/0x6d0
<4>[ 1211.603064]  worker_thread+0x49/0x4a0
<4>[ 1211.603064]  kthread+0x107/0x140
<4>[ 1211.603064]  ? process_one_work+0x6d0/0x6d0
<4>[ 1211.603065]  ? kthread_create_on_node+0x40/0x40
<4>[ 1211.603065]  ret_from_fork+0x2e/0x40
<4>[ 1211.603065] Code: 00 48 c7 c7 8d 5d c4 81 c6 05 c3 6e db 00 01 e8 89 2e fd ff eb 96 0f 1f 80 00 00 00 00 8b 15 f2 b2 c5 01 55 65 01 3d 62 08 f6 7e <48> 89 e5 53 89 fb 85 d2 75 11 65 8b 05 51 08 f6 7e 0f b6 c0 3d 
<0>[ 1211.603074] Kernel panic - not syncing: Hard LOCKUP
<4>[ 1211.603074] CPU: 3 PID: 10443 Comm: kworker/u8:11 Tainted: G     U          4.11.0-rc4-CI-CI_DRM_319+ #1
<4>[ 1211.603074] Hardware name:                  /NUC5i5RYB, BIOS RYBDWi35.86A.0362.2017.0118.0940 01/18/2017
<4>[ 1211.603075] Workqueue: events_unbound async_run_entry_fn
<4>[ 1211.603075] Call Trace:
<4>[ 1211.603075]  <NMI>
<4>[ 1211.603076]  dump_stack+0x67/0x92
<4>[ 1211.603076]  panic+0xcf/0x205
<4>[ 1211.603076]  nmi_panic+0x34/0x40
<4>[ 1211.603076]  watchdog_overflow_callback+0xe8/0x130
<4>[ 1211.603077]  __perf_event_overflow+0x5d/0xf0
<4>[ 1211.603077]  perf_event_overflow+0x14/0x20
<4>[ 1211.603077]  intel_pmu_handle_irq+0x1f7/0x580
<4>[ 1211.603077]  perf_event_nmi_handler+0x28/0x50
<4>[ 1211.603078]  ? preempt_count_add+0xe/0xc0
<4>[ 1211.603078]  nmi_handle+0x91/0x2d0
<4>[ 1211.603078]  ? trace_raw_output_nmi_handler+0x70/0x70
<4>[ 1211.603078]  ? preempt_count_add+0xe/0xc0
<4>[ 1211.603079]  ? pci_azx_readw+0x10/0x10 [snd_hda_intel]
<4>[ 1211.603079]  default_do_nmi+0x127/0x1a0
<4>[ 1211.603079]  do_nmi+0x10c/0x150
<4>[ 1211.603079]  end_repeat_nmi+0x1a/0x1e
<4>[ 1211.603080] RIP: 0010:preempt_count_add+0xe/0xc0
<4>[ 1211.603080] RSP: 0018:ffffc9000162fbd8 EFLAGS: 00000082
<4>[ 1211.603080] RAX: 0000000080000001 RBX: 0000000704b96558 RCX: 0000000000000002
<4>[ 1211.603081] RDX: 0000000000000000 RSI: ffffffff81c74f2d RDI: 0000000000000001
<4>[ 1211.603081] RBP: ffffc9000162fc08 R08: 00000000bbcc90cc R09: 23c7b07100000000
<4>[ 1211.603081] R10: ffffffff827901a8 R11: ffff88024cd32740 R12: 0000000704b92baa
<4>[ 1211.603082] R13: 0000000000003ea0 R14: 0000000000000003 R15: ffffffffa00061f0
<4>[ 1211.603082]  ? pci_azx_readw+0x10/0x10 [snd_hda_intel]
<4>[ 1211.603082]  ? preempt_count_add+0xe/0xc0
<4>[ 1211.603082]  ? preempt_count_add+0xe/0xc0
<4>[ 1211.603083]  </NMI>
<4>[ 1211.603083]  ? delay_tsc+0x3d/0xc0
<4>[ 1211.603083]  __delay+0xa/0x10
<4>[ 1211.603083]  __const_udelay+0x31/0x40
<4>[ 1211.603084]  snd_hdac_bus_stop_cmd_io+0x96/0xe0 [snd_hda_core]
<4>[ 1211.603084]  ? azx_dev_disconnect+0x20/0x20 [snd_hda_intel]
<4>[ 1211.603084]  snd_hdac_bus_stop_chip+0xb1/0x100 [snd_hda_core]
<4>[ 1211.603084]  azx_stop_chip+0x9/0x10 [snd_hda_codec]
<4>[ 1211.603085]  azx_suspend+0x72/0x220 [snd_hda_intel]
<4>[ 1211.603085]  pci_pm_suspend+0x71/0x140
<4>[ 1211.603085]  dpm_run_callback+0x6f/0x330
<4>[ 1211.603085]  ? pci_pm_freeze+0xe0/0xe0
<4>[ 1211.603086]  __device_suspend+0xf9/0x370
<4>[ 1211.603086]  ? dpm_watchdog_set+0x60/0x60
<4>[ 1211.603086]  async_suspend+0x1a/0x90
<4>[ 1211.603086]  async_run_entry_fn+0x34/0x160
<4>[ 1211.603087]  process_one_work+0x1f4/0x6d0
<4>[ 1211.603087]  ? process_one_work+0x16e/0x6d0
<4>[ 1211.603087]  worker_thread+0x49/0x4a0
<4>[ 1211.603087]  kthread+0x107/0x140
<4>[ 1211.603088]  ? process_one_work+0x6d0/0x6d0
<4>[ 1211.603088]  ? kthread_create_on_node+0x40/0x40
<4>[ 1211.603088]  ret_from_fork+0x2e/0x40
<0>[ 1211.603112] Kernel Offset: disabled
Comment 1 Chris Wilson 2017-03-27 16:22:31 UTC 

*** This bug has been marked as a duplicate of bug 100419 ***

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.