Bug 111692 - [CI][SHARDS] igt@i915_selftest@live_gem_contexts- dmesg-warn - igt_ctx_exec failed with error -5
Summary: [CI][SHARDS] igt@i915_selftest@live_gem_contexts- dmesg-warn - igt_ctx_exec f...
Status: RESOLVED FIXED
Alias: None
Product: DRI
Classification: Unclassified
Component: DRM/Intel (show other bugs)
Version: DRI git
Hardware: Other All
: not set not set
Assignee: Intel GFX Bugs mailing list
QA Contact: Intel GFX Bugs mailing list
URL:
Whiteboard:
Keywords:
Depends on:
Blocks:
 
Reported: 2019-09-16 10:22 UTC by Lakshmi
Modified: 2019-12-05 07:14 UTC (History)
1 user (show)

See Also:
i915 platform: HSW
i915 features:

Attachments

Description Lakshmi 2019-09-16 10:22:28 UTC 
https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_6896/shard-hsw6/igt@i915_selftest@live_gem_contexts.html

Starting subtest: live_gem_contexts
(i915_selftest:10805) igt_kmod-WARNING: 0:02.0: [drm:intel_uc_init_early [i915]] enable_guc=0 (guc:no submission:no huc:no)
(i915_selftest:10805) igt_kmod-WARNING: 000:00:02.0
(i915_selftest:10805) igt_kmod-WARNING: ntel_pch_type [i915]] Found WildcatPoint PCH
(i915_selftest:10805) igt_kmod-WARNING: ntel_power_domains_init [i915]] Allowed DC state mask 00
(i915_selftest:10805) igt_kmod-WARNING: 915_ggtt_probe_hw [i915]] GGTT size = 2048M
(i915_selftest:10805) igt_kmod-WARNING: 915_ggtt_probe_hw [i915]] GMADR size = 256M
(i915_selftest:10805) igt_kmod-WARNING: 915_ggtt_probe_hw [i915]] DSM size = 512M
(i915_selftest:10805) igt_kmod-WARNING: 0:02.0: VT-d active for gfx access
(i915_selftest:10805) igt_kmod-WARNING: 000:00:02.0
(i915_selftest:10805) igt_kmod-WARNING: 0:02.0: vgaarb: deactivate vga console
(i915_selftest:10805) igt_kmod-WARNING: 000:00:02.0
(i915_selftest:10805) igt_kmod-WARNING: 0:02.0: DMAR active, disabling use of stolen memory
(i915_selftest:10805) igt_kmod-WARNING: 000:00:02.0
(i915_selftest:10805) igt_kmod-WARNING: ntel_gvt_init [i915]] GVT-g is disabled by kernel params
(i915_selftest:10805) igt_kmod-WARNING: ntel_opregion_setup [i915]] graphic opregion physical addr: 0xbd7f3018
(i915_selftest:10805) igt_kmod-WARNING: ntel_opregion_setup [i915]] ACPI OpRegion version 2.0.0
(i915_selftest:10805) igt_kmod-WARNING: ntel_opregion_setup [i915]] Public ACPI methods supported
(i915_selftest:10805) igt_kmod-WARNING: ntel_opregion_setup [i915]] SWSCI supported
(i915_selftest:10805) igt_kmod-WARNING: ntel_opregion_setup [i915]] SWSCI GBDA callbacks 00000cb3, SBCB callbacks 00700483
(i915_selftest:10805) igt_kmod-WARNING: ntel_opregion_setup [i915]] ASLE supported
(i915_selftest:10805) igt_kmod-WARNING: ntel_opregion_setup [i915]] ASLE extension supported
(i915_selftest:10805) igt_kmod-WARNING: ntel_opregion_setup [i915]] Found valid VBT in ACPI OpRegion (Mailbox #4)
(i915_selftest:10805) igt_kmod-WARNING: ntel_bios_init [i915]] Skipping VBT init due to disabled display.
(i915_selftest:10805) igt_kmod-WARNING: ntel_dsm_detect [i915]] no _DSM method for intel device
(i915_selftest:10805) igt_kmod-WARNING: 915_driver_probe [i915]] rawclk rate: 125000 kHz
(i915_selftest:10805) igt_kmod-WARNING: ntel_power_well_enable [i915]] enabling always-on
(i915_selftest:10805) igt_kmod-WARNING: ntel_power_well_enable [i915]] enabling display
(i915_selftest:10805) igt_kmod-WARNING: ntel_fbc_init [i915]] Sanitized enable_fbc value: 0
(i915_selftest:10805) igt_kmod-WARNING: ntel_print_wm_latency [i915]] Primary WM0 latency 20 (2.0 usec)
(i915_selftest:10805) igt_kmod-WARNING: ntel_print_wm_latency [i915]] Primary WM1 latency 4 (2.0 usec)
(i915_selftest:10805) igt_kmod-WARNING: ntel_print_wm_latency [i915]] Primary WM2 latency 36 (18.0 usec)
(i915_selftest:10805) igt_kmod-WARNING: ntel_print_wm_latency [i915]] Primary WM3 latency 90 (45.0 usec)
(i915_selftest:10805) igt_kmod-WARNING: ntel_print_wm_latency [i915]] Primary WM4 latency 160 (80.0 usec)
(i915_selftest:10805) igt_kmod-WARNING: ntel_print_wm_latency [i915]] Sprite WM0 latency 20 (2.0 usec)
(i915_selftest:10805) igt_kmod-WARNING: ntel_print_wm_latency [i915]] Sprite WM1 latency 4 (2.0 usec)
(i915_selftest:10805) igt_kmod-WARNING: ntel_print_wm_latency [i915]] Sprite WM2 latency 36 (18.0 usec)
(i915_selftest:10805) igt_kmod-WARNING: ntel_print_wm_latency [i915]] Sprite WM3 latency 90 (45.0 usec)
(i915_selftest:10805) igt_kmod-WARNING: ntel_print_wm_latency [i915]] Sprite WM4 latency 160 (80.0 usec)
(i915_selftest:10805) igt_kmod-WARNING: ntel_print_wm_latency [i915]] Cursor WM0 latency 20 (2.0 usec)
(i915_selftest:10805) igt_kmod-WARNING: ntel_print_wm_latency [i915]] Cursor WM1 latency 4 (2.0 usec)
(i915_selftest:10805) igt_kmod-WARNING: ntel_print_wm_latency [i915]] Cursor WM2 latency 36 (18.0 usec)
(i915_selftest:10805) igt_kmod-WARNING: ntel_print_wm_latency [i915]] Cursor WM3 latency 90 (45.0 usec)
(i915_selftest:10805) igt_kmod-WARNING: ntel_print_wm_latency [i915]] Cursor WM4 latency 160 (80.0 usec)
(i915_selftest:10805) igt_kmod-WARNING: ntel_modeset_init [i915]] 0 display pipe available.
(i915_selftest:10805) igt_kmod-WARNING: ntel_dump_cdclk_state [i915]] Current CDCLK 540000 kHz, VCO 0 kHz, ref 0 kHz, bypass 0 kHz, voltage level 0
(i915_selftest:10805) igt_kmod-WARNING: ntel_update_max_cdclk [i915]] Max CD clock rate: 540000 kHz
(i915_selftest:10805) igt_kmod-WARNING: ntel_modeset_init [i915]] Max dotclock rate: 540000 kHz
(i915_selftest:10805) igt_kmod-WARNING: ntel_modeset_setup_hw_state [i915]] WRPLL 1 hw state readout: crtc_mask 0x00000000, on 0
(i915_selftest:10805) igt_kmod-WARNING: ntel_modeset_setup_hw_state [i915]] WRPLL 2 hw state readout: crtc_mask 0x00000000, on 0
(i915_selftest:10805) igt_kmod-WARNING: ntel_modeset_setup_hw_state [i915]] SPLL hw state readout: crtc_mask 0x00000000, on 0
(i915_selftest:10805) igt_kmod-WARNING: ntel_modeset_setup_hw_state [i915]] LCPLL 810 hw state readout: crtc_mask 0x00000000, on 1
(i915_selftest:10805) igt_kmod-WARNING: ntel_modeset_setup_hw_state [i915]] LCPLL 1350 hw state readout: crtc_mask 0x00000000, on 1
(i915_selftest:10805) igt_kmod-WARNING: ntel_modeset_setup_hw_state [i915]] LCPLL 2700 hw state readout: crtc_mask 0x00000000, on 1
(i915_selftest:10805) igt_kmod-WARNING: ntel_modeset_setup_hw_state [i915]] LCPLL 810 enabled but not in use, disabling
(i915_selftest:10805) igt_kmod-WARNING: ntel_modeset_setup_hw_state [i915]] LCPLL 1350 enabled but not in use, disabling
(i915_selftest:10805) igt_kmod-WARNING: ntel_modeset_setup_hw_state [i915]] LCPLL 2700 enabled but not in use, disabling
(i915_selftest:10805) igt_kmod-WARNING: 915_init_ggtt [i915]] clearing unused GTT space: [1000, 80000000]
(i915_selftest:10805) igt_kmod-WARNING: 915_gem_contexts_init [i915]] logical context support initialized
(i915_selftest:10805) igt_kmod-WARNING: andybridge_pcode_read [i915]] warning: pcode (read from mbox 1a) mailbox access failed for intel_init_gt_powersave [i915]: -6
(i915_selftest:10805) igt_kmod-WARNING: ntel_init_gt_powersave [i915]] Overclocking supported, max: 1250MHz, overclock: 1300MHz
(i915_selftest:10805) igt_kmod-WARNING: andybridge_pcode_read [i915]] warning: pcode (read from mbox 5) mailbox access failed for intel_enable_gt_powersave [i915]: -6
(i915_selftest:10805) igt_kmod-WARNING: ntel_engines_driver_register [i915]] renamed rcs'0 to rcs0
(i915_selftest:10805) igt_kmod-WARNING: ntel_engines_driver_register [i915]] renamed bcs'0 to bcs0
(i915_selftest:10805) igt_kmod-WARNING: ntel_engines_driver_register [i915]] renamed vcs'0 to vcs0
(i915_selftest:10805) igt_kmod-WARNING: ntel_engines_driver_register [i915]] renamed vecs'0 to vecs0
(i915_selftest:10805) igt_kmod-WARNING: 0:02.0 on minor 0
(i915_selftest:10805) igt_kmod-WARNING: ntel_power_well_disable [i915]] disabling display
(i915_selftest:10805) igt_kmod-WARNING: ntel_power_well_disable [i915]] disabling always-on
(i915_selftest:10805) igt_kmod-WARNING: pciid=0x0412 rev=0x06 platform=HASWELL (subplatform=0x0) gen=7
(i915_selftest:10805) igt_kmod-WARNING: is_mobile: no
(i915_selftest:10805) igt_kmod-WARNING: is_lp: no
(i915_selftest:10805) igt_kmod-WARNING: require_force_probe: no
(i915_selftest:10805) igt_kmod-WARNING: has_64bit_reloc: no
(i915_selftest:10805) igt_kmod-WARNING: gpu_reset_clobbers_display: no
(i915_selftest:10805) igt_kmod-WARNING: has_reset_engine: no
(i915_selftest:10805) igt_kmod-WARNING: has_fpga_dbg: yes
(i915_selftest:10805) igt_kmod-WARNING: has_global_mocs: no
(i915_selftest:10805) igt_kmod-WARNING: has_gt_uc: no
(i915_selftest:10805) igt_kmod-WARNING: has_l3_dpf: yes
(i915_selftest:10805) igt_kmod-WARNING: has_llc: yes
(i915_selftest:10805) igt_kmod-WARNING: has_logical_ring_contexts: no
(i915_selftest:10805) igt_kmod-WARNING: has_logical_ring_elsq: no
(i915_selftest:10805) igt_kmod-WARNING: has_logical_ring_preemption: no
(i915_selftest:10805) igt_kmod-WARNING: has_pooled_eu: no
(i915_selftest:10805) igt_kmod-WARNING: has_rc6: yes
(i915_selftest:10805) igt_kmod-WARNING: has_rc6p: no
(i915_selftest:10805) igt_kmod-WARNING: has_rps: yes
(i915_selftest:10805) igt_kmod-WARNING: has_runtime_pm: yes
(i915_selftest:10805) igt_kmod-WARNING: has_snoop: no
(i915_selftest:10805) igt_kmod-WARNING: has_coherent_ggtt: yes
(i915_selftest:10805) igt_kmod-WARNING: unfenced_needs_alignment: no
(i915_selftest:10805) igt_kmod-WARNING: hws_needs_physical: no
(i915_selftest:10805) igt_kmod-WARNING: cursor_needs_physical: no
(i915_selftest:10805) igt_kmod-WARNING: has_csr: no
(i915_selftest:10805) igt_kmod-WARNING: has_ddi: yes
(i915_selftest:10805) igt_kmod-WARNING: has_dp_mst: yes
(i915_selftest:10805) igt_kmod-WARNING: has_fbc: no
(i915_selftest:10805) igt_kmod-WARNING: has_gmch: no
(i915_selftest:10805) igt_kmod-WARNING: has_hotplug: yes
(i915_selftest:10805) igt_kmod-WARNING: has_ipc: no
(i915_selftest:10805) igt_kmod-WARNING: has_modular_fia: no
(i915_selftest:10805) igt_kmod-WARNING: has_overlay: no
(i915_selftest:10805) igt_kmod-WARNING: has_psr: yes
(i915_selftest:10805) igt_kmod-WARNING: overlay_needs_physical: no
(i915_selftest:10805) igt_kmod-WARNING: supports_tv: no
(i915_selftest:10805) igt_kmod-WARNING: slice total: 1, mask=0001
(i915_selftest:10805) igt_kmod-WARNING: subslice total: 2
(i915_selftest:10805) igt_kmod-WARNING: slice0: 2 subslices, mask=00000003
(i915_selftest:10805) igt_kmod-WARNING: EU total: 20
(i915_selftest:10805) igt_kmod-WARNING: EU per subslice: 10
(i915_selftest:10805) igt_kmod-WARNING: has slice power gating: no
(i915_selftest:10805) igt_kmod-WARNING: has subslice power gating: no
(i915_selftest:10805) igt_kmod-WARNING: has EU power gating: no
(i915_selftest:10805) igt_kmod-WARNING: CS timestamp frequency: 12500 kHz
(i915_selftest:10805) igt_kmod-WARNING: Performing live selftests with st_random_seed=0x99d0e294 st_timeout=1000
(i915_selftest:10805) igt_kmod-WARNING: Running gem_contexts
(i915_selftest:10805) igt_kmod-WARNING: Running i915_gem_context_live_selftests/live_nop_switch
(i915_selftest:10805) igt_kmod-WARNING: ntel_power_well_enable [i915]] enabling always-on
(i915_selftest:10805) igt_kmod-WARNING: ntel_power_well_disable [i915]] disabling always-on
(i915_selftest:10805) igt_kmod-WARNING: 1 = 211262ns, 630 = 26428ns
(i915_selftest:10805) igt_kmod-WARNING: ntel_power_well_enable [i915]] enabling always-on
(i915_selftest:10805) igt_kmod-WARNING: ntel_power_well_disable [i915]] disabling always-on
(i915_selftest:10805) igt_kmod-WARNING: 1 = 3368539ns, 772 = 22585ns
(i915_selftest:10805) igt_kmod-WARNING: ntel_power_well_enable [i915]] enabling always-on
(i915_selftest:10805) igt_kmod-WARNING: ntel_power_well_disable [i915]] disabling always-on
(i915_selftest:10805) igt_kmod-WARNING: 1 = 3613403ns, 786 = 21525ns
(i915_selftest:10805) igt_kmod-WARNING: ntel_power_well_enable [i915]] enabling always-on
(i915_selftest:10805) igt_kmod-WARNING: ntel_power_well_disable [i915]] disabling always-on
(i915_selftest:10805) igt_kmod-WARNING: 1 = 3298591ns, 756 = 26931ns
(i915_selftest:10805) igt_kmod-WARNING: Running i915_gem_context_live_selftests/igt_ctx_exec
(i915_selftest:10805) igt_kmod-WARNING: ntel_power_well_enable [i915]] enabling always-on
(i915_selftest:10805) igt_kmod-WARNING: 6016 ms ago
(i915_selftest:10805) igt_kmod-WARNING: 0 (global 0)
(i915_selftest:10805) igt_kmod-WARNING: 6de*  prio=2147483647 @ 7894ms: [i915]
(i915_selftest:10805) igt_kmod-WARNING:  0x7fff7000
(i915_selftest:10805) igt_kmod-WARNING:   0x00002828
(i915_selftest:10805) igt_kmod-WARNING:   0x000031d0
(i915_selftest:10805) igt_kmod-WARNING:   0x000031d0
(i915_selftest:10805) igt_kmod-WARNING:  0x000018a0
(i915_selftest:10805) igt_kmod-WARNING:   0x7fffe100
(i915_selftest:10805) igt_kmod-WARNING:  0x00002000
(i915_selftest:10805) igt_kmod-WARNING: 0x415f810d
(i915_selftest:10805) igt_kmod-WARNING: 0x7fff7000
(i915_selftest:10805) igt_kmod-WARNING:  0x00002840
(i915_selftest:10805) igt_kmod-WARNING:  0x000031d0
(i915_selftest:10805) igt_kmod-WARNING:   0x00003001
(i915_selftest:10805) igt_kmod-WARNING:  0x00004000
(i915_selftest:10805) igt_kmod-WARNING: ffffffde
(i915_selftest:10805) igt_kmod-WARNING:  0x00000000_34a02840
(i915_selftest:10805) igt_kmod-WARNING: 0x00000000_415f7004
(i915_selftest:10805) igt_kmod-WARNING: 0x00000000_7fff99d8
(i915_selftest:10805) igt_kmod-WARNING: 0x00000000
(i915_selftest:10805) igt_kmod-WARNING: 0x780c0000
(i915_selftest:10805) igt_kmod-WARNING: 0x7fde0000
(i915_selftest:10805) igt_kmod-WARNING: 0x00000000
(i915_selftest:10805) igt_kmod-WARNING: 0xffffffff
(i915_selftest:10805) igt_kmod-WARNING: 6de*  prio=2147483647 @ 7894ms: [i915]
(i915_selftest:10805) igt_kmod-WARNING: 6df  @ 7891ms: [i915]
(i915_selftest:10805) igt_kmod-WARNING: 6e0-  @ 7891ms: [i915]
(i915_selftest:10805) igt_kmod-WARNING: 6e1  @ 7891ms: [i915]
(i915_selftest:10805) igt_kmod-WARNING: 6e2  @ 7891ms: [i915]
(i915_selftest:10805) igt_kmod-WARNING: 6e3  @ 7891ms: [i915]
(i915_selftest:10805) igt_kmod-WARNING: 6e4  @ 7891ms: [i915]
(i915_selftest:10805) igt_kmod-WARNING: 6e9  @ 7890ms: [i915]
(i915_selftest:10805) igt_kmod-WARNING: 6e0] @ 7892ms
(i915_selftest:10805) igt_kmod-WARNING: 0:02.0: GPU HANG: ecode 7:1:0x87c3ffff, in  [0], hang on rcs0
(i915_selftest:10805) igt_kmod-WARNING: 000:00:02.0
(i915_selftest:10805) igt_kmod-WARNING: ntel_gt_reset_global [i915]] resetting chip
(i915_selftest:10805) igt_kmod-WARNING: 0:02.0: Resetting chip for hang on rcs0
(i915_selftest:10805) igt_kmod-WARNING: 000:00:02.0
(i915_selftest:10805) igt_kmod-WARNING: ntel_power_well_disable [i915]] disabling always-on
(i915_selftest:10805) igt_kmod-WARNING: GPU was reset 1 times!
(i915_selftest:10805) igt_kmod-WARNING: igt_ctx_exec failed with error -5
(i915_selftest:10805) igt_kmod-WARNING: ntel_power_well_enable [i915]] enabling always-on
(i915_selftest:10805) igt_kmod-WARNING: ntel_power_well_enable [i915]] enabling display
(i915_selftest:10805) igt_kmod-WARNING: probe of 0000:00:02.0 failed with error -5
(i915_selftest:10805) igt_kmod-CRITICAL: Test assertion failure function igt_kselftest_execute, file ../lib/igt_kmod.c:532:
(i915_selftest:10805) igt_kmod-CRITICAL: Failed assertion: err == 0
(i915_selftest:10805) igt_kmod-CRITICAL: kselftest "i915 igt__29__live_gem_contexts=1 live_selftests=-1 disable_display=1 st_filter=" failed: Input/output error [5]
Subtest live_gem_contexts failed.
**** DEBUG ****
(i915_selftest:10805) igt_kmod-WARNING: 0:02.0: [drm:intel_uc_init_early [i915]] enable_guc=0 (guc:no submission:no huc:no)
(i915_selftest:10805) igt_kmod-WARNING: 000:00:02.0
(i915_selftest:10805) igt_kmod-WARNING: ntel_pch_type [i915]] Found WildcatPoint PCH
(i915_selftest:10805) igt_kmod-WARNING: ntel_power_domains_init [i915]] Allowed DC state mask 00
(i915_selftest:10805) igt_kmod-WARNING: 915_ggtt_probe_hw [i915]] GGTT size = 2048M
(i915_selftest:10805) igt_kmod-WARNING: 915_ggtt_probe_hw [i915]] GMADR size = 256M
(i915_selftest:10805) igt_kmod-WARNING: 915_ggtt_probe_hw [i915]] DSM size = 512M
(i915_selftest:10805) igt_kmod-WARNING: 0:02.0: VT-d active for gfx access
(i915_selftest:10805) igt_kmod-WARNING: 000:00:02.0
(i915_selftest:10805) igt_kmod-WARNING: 0:02.0: vgaarb: deactivate vga console
(i915_selftest:10805) igt_kmod-WARNING: 000:00:02.0
(i915_selftest:10805) igt_kmod-WARNING: 0:02.0: DMAR active, disabling use of stolen memory
(i915_selftest:10805) igt_kmod-WARNING: 000:00:02.0
(i915_selftest:10805) igt_kmod-WARNING: ntel_gvt_init [i915]] GVT-g is disabled by kernel params
(i915_selftest:10805) igt_kmod-WARNING: ntel_opregion_setup [i915]] graphic opregion physical addr: 0xbd7f3018
(i915_selftest:10805) igt_kmod-WARNING: ntel_opregion_setup [i915]] ACPI OpRegion version 2.0.0
(i915_selftest:10805) igt_kmod-WARNING: ntel_opregion_setup [i915]] Public ACPI methods supported
(i915_selftest:10805) igt_kmod-WARNING: ntel_opregion_setup [i915]] SWSCI supported
(i915_selftest:10805) igt_kmod-WARNING: ntel_opregion_setup [i915]] SWSCI GBDA callbacks 00000cb3, SBCB callbacks 00700483
(i915_selftest:10805) igt_kmod-WARNING: ntel_opregion_setup [i915]] ASLE supported
(i915_selftest:10805) igt_kmod-WARNING: ntel_opregion_setup [i915]] ASLE extension supported
(i915_selftest:10805) igt_kmod-WARNING: ntel_opregion_setup [i915]] Found valid VBT in ACPI OpRegion (Mailbox #4)
(i915_selftest:10805) igt_kmod-WARNING: ntel_bios_init [i915]] Skipping VBT init due to disabled display.
(i915_selftest:10805) igt_kmod-WARNING: ntel_dsm_detect [i915]] no _DSM method for intel device
(i915_selftest:10805) igt_kmod-WARNING: 915_driver_probe [i915]] rawclk rate: 125000 kHz
(i915_selftest:10805) igt_kmod-WARNING: ntel_power_well_enable [i915]] enabling always-on
(i915_selftest:10805) igt_kmod-WARNING: ntel_power_well_enable [i915]] enabling display
(i915_selftest:10805) igt_kmod-WARNING: ntel_fbc_init [i915]] Sanitized enable_fbc value: 0
(i915_selftest:10805) igt_kmod-WARNING: ntel_print_wm_latency [i915]] Primary WM0 latency 20 (2.0 usec)
(i915_selftest:10805) igt_kmod-WARNING: ntel_print_wm_latency [i915]] Primary WM1 latency 4 (2.0 usec)
(i915_selftest:10805) igt_kmod-WARNING: ntel_print_wm_latency [i915]] Primary WM2 latency 36 (18.0 usec)
(i915_selftest:10805) igt_kmod-WARNING: ntel_print_wm_latency [i915]] Primary WM3 latency 90 (45.0 usec)
(i915_selftest:10805) igt_kmod-WARNING: ntel_print_wm_latency [i915]] Primary WM4 latency 160 (80.0 usec)
(i915_selftest:10805) igt_kmod-WARNING: ntel_print_wm_latency [i915]] Sprite WM0 latency 20 (2.0 usec)
(i915_selftest:10805) igt_kmod-WARNING: ntel_print_wm_latency [i915]] Sprite WM1 latency 4 (2.0 usec)
(i915_selftest:10805) igt_kmod-WARNING: ntel_print_wm_latency [i915]] Sprite WM2 latency 36 (18.0 usec)
(i915_selftest:10805) igt_kmod-WARNING: ntel_print_wm_latency [i915]] Sprite WM3 latency 90 (45.0 usec)
(i915_selftest:10805) igt_kmod-WARNING: ntel_print_wm_latency [i915]] Sprite WM4 latency 160 (80.0 usec)
(i915_selftest:10805) igt_kmod-WARNING: ntel_print_wm_latency [i915]] Cursor WM0 latency 20 (2.0 usec)
(i915_selftest:10805) igt_kmod-WARNING: ntel_print_wm_latency [i915]] Cursor WM1 latency 4 (2.0 usec)
(i915_selftest:10805) igt_kmod-WARNING: ntel_print_wm_latency [i915]] Cursor WM2 latency 36 (18.0 usec)
(i915_selftest:10805) igt_kmod-WARNING: ntel_print_wm_latency [i915]] Cursor WM3 latency 90 (45.0 usec)
(i915_selftest:10805) igt_kmod-WARNING: ntel_print_wm_latency [i915]] Cursor WM4 latency 160 (80.0 usec)
(i915_selftest:10805) igt_kmod-WARNING: ntel_modeset_init [i915]] 0 display pipe available.
(i915_selftest:10805) igt_kmod-WARNING: ntel_dump_cdclk_state [i915]] Current CDCLK 540000 kHz, VCO 0 kHz, ref 0 kHz, bypass 0 kHz, voltage level 0
(i915_selftest:10805) igt_kmod-WARNING: ntel_update_max_cdclk [i915]] Max CD clock rate: 540000 kHz
(i915_selftest:10805) igt_kmod-WARNING: ntel_modeset_init [i915]] Max dotclock rate: 540000 kHz
(i915_selftest:10805) igt_kmod-WARNING: ntel_modeset_setup_hw_state [i915]] WRPLL 1 hw state readout: crtc_mask 0x00000000, on 0
(i915_selftest:10805) igt_kmod-WARNING: ntel_modeset_setup_hw_state [i915]] WRPLL 2 hw state readout: crtc_mask 0x00000000, on 0
(i915_selftest:10805) igt_kmod-WARNING: ntel_modeset_setup_hw_state [i915]] SPLL hw state readout: crtc_mask 0x00000000, on 0
(i915_selftest:10805) igt_kmod-WARNING: ntel_modeset_setup_hw_state [i915]] LCPLL 810 hw state readout: crtc_mask 0x00000000, on 1
(i915_selftest:10805) igt_kmod-WARNING: ntel_modeset_setup_hw_state [i915]] LCPLL 1350 hw state readout: crtc_mask 0x00000000, on 1
(i915_selftest:10805) igt_kmod-WARNING: ntel_modeset_setup_hw_state [i915]] LCPLL 2700 hw state readout: crtc_mask 0x00000000, on 1
(i915_selftest:10805) igt_kmod-WARNING: ntel_modeset_setup_hw_state [i915]] LCPLL 810 enabled but not in use, disabling
(i915_selftest:10805) igt_kmod-WARNING: ntel_modeset_setup_hw_state [i915]] LCPLL 1350 enabled but not in use, disabling
(i915_selftest:10805) igt_kmod-WARNING: ntel_modeset_setup_hw_state [i915]] LCPLL 2700 enabled but not in use, disabling
(i915_selftest:10805) igt_kmod-WARNING: 915_init_ggtt [i915]] clearing unused GTT space: [1000, 80000000]
(i915_selftest:10805) igt_kmod-WARNING: 915_gem_contexts_init [i915]] logical context support initialized
(i915_selftest:10805) igt_kmod-WARNING: andybridge_pcode_read [i915]] warning: pcode (read from mbox 1a) mailbox access failed for intel_init_gt_powersave [i915]: -6
(i915_selftest:10805) igt_kmod-WARNING: ntel_init_gt_powersave [i915]] Overclocking supported, max: 1250MHz, overclock: 1300MHz
(i915_selftest:10805) igt_kmod-WARNING: andybridge_pcode_read [i915]] warning: pcode (read from mbox 5) mailbox access failed for intel_enable_gt_powersave [i915]: -6
(i915_selftest:10805) igt_kmod-WARNING: ntel_engines_driver_register [i915]] renamed rcs'0 to rcs0
(i915_selftest:10805) igt_kmod-WARNING: ntel_engines_driver_register [i915]] renamed bcs'0 to bcs0
(i915_selftest:10805) igt_kmod-WARNING: ntel_engines_driver_register [i915]] renamed vcs'0 to vcs0
(i915_selftest:10805) igt_kmod-WARNING: ntel_engines_driver_register [i915]] renamed vecs'0 to vecs0
(i915_selftest:10805) igt_kmod-WARNING: 0:02.0 on minor 0
(i915_selftest:10805) igt_kmod-WARNING: ntel_power_well_disable [i915]] disabling display
(i915_selftest:10805) igt_kmod-WARNING: ntel_power_well_disable [i915]] disabling always-on
(i915_selftest:10805) igt_kmod-WARNING: pciid=0x0412 rev=0x06 platform=HASWELL (subplatform=0x0) gen=7
(i915_selftest:10805) igt_kmod-WARNING: is_mobile: no
(i915_selftest:10805) igt_kmod-WARNING: is_lp: no
(i915_selftest:10805) igt_kmod-WARNING: require_force_probe: no
(i915_selftest:10805) igt_kmod-WARNING: has_64bit_reloc: no
(i915_selftest:10805) igt_kmod-WARNING: gpu_reset_clobbers_display: no
(i915_selftest:10805) igt_kmod-WARNING: has_reset_engine: no
(i915_selftest:10805) igt_kmod-WARNING: has_fpga_dbg: yes
(i915_selftest:10805) igt_kmod-WARNING: has_global_mocs: no
(i915_selftest:10805) igt_kmod-WARNING: has_gt_uc: no
(i915_selftest:10805) igt_kmod-WARNING: has_l3_dpf: yes
(i915_selftest:10805) igt_kmod-WARNING: has_llc: yes
(i915_selftest:10805) igt_kmod-WARNING: has_logical_ring_contexts: no
(i915_selftest:10805) igt_kmod-WARNING: has_logical_ring_elsq: no
(i915_selftest:10805) igt_kmod-WARNING: has_logical_ring_preemption: no
(i915_selftest:10805) igt_kmod-WARNING: has_pooled_eu: no
(i915_selftest:10805) igt_kmod-WARNING: has_rc6: yes
(i915_selftest:10805) igt_kmod-WARNING: has_rc6p: no
(i915_selftest:10805) igt_kmod-WARNING: has_rps: yes
(i915_selftest:10805) igt_kmod-WARNING: has_runtime_pm: yes
(i915_selftest:10805) igt_kmod-WARNING: has_snoop: no
(i915_selftest:10805) igt_kmod-WARNING: has_coherent_ggtt: yes
(i915_selftest:10805) igt_kmod-WARNING: unfenced_needs_alignment: no
(i915_selftest:10805) igt_kmod-WARNING: hws_needs_physical: no
(i915_selftest:10805) igt_kmod-WARNING: cursor_needs_physical: no
(i915_selftest:10805) igt_kmod-WARNING: has_csr: no
(i915_selftest:10805) igt_kmod-WARNING: has_ddi: yes
(i915_selftest:10805) igt_kmod-WARNING: has_dp_mst: yes
(i915_selftest:10805) igt_kmod-WARNING: has_fbc: no
(i915_selftest:10805) igt_kmod-WARNING: has_gmch: no
(i915_selftest:10805) igt_kmod-WARNING: has_hotplug: yes
(i915_selftest:10805) igt_kmod-WARNING: has_ipc: no
(i915_selftest:10805) igt_kmod-WARNING: has_modular_fia: no
(i915_selftest:10805) igt_kmod-WARNING: has_overlay: no
(i915_selftest:10805) igt_kmod-WARNING: has_psr: yes
(i915_selftest:10805) igt_kmod-WARNING: overlay_needs_physical: no
(i915_selftest:10805) igt_kmod-WARNING: supports_tv: no
(i915_selftest:10805) igt_kmod-WARNING: slice total: 1, mask=0001
(i915_selftest:10805) igt_kmod-WARNING: subslice total: 2
(i915_selftest:10805) igt_kmod-WARNING: slice0: 2 subslices, mask=00000003
(i915_selftest:10805) igt_kmod-WARNING: EU total: 20
(i915_selftest:10805) igt_kmod-WARNING: EU per subslice: 10
(i915_selftest:10805) igt_kmod-WARNING: has slice power gating: no
(i915_selftest:10805) igt_kmod-WARNING: has subslice power gating: no
(i915_selftest:10805) igt_kmod-WARNING: has EU power gating: no
(i915_selftest:10805) igt_kmod-WARNING: CS timestamp frequency: 12500 kHz
(i915_selftest:10805) igt_kmod-WARNING: Performing live selftests with st_random_seed=0x99d0e294 st_timeout=1000
(i915_selftest:10805) igt_kmod-WARNING: Running gem_contexts
(i915_selftest:10805) igt_kmod-WARNING: Running i915_gem_context_live_selftests/live_nop_switch
(i915_selftest:10805) igt_kmod-WARNING: ntel_power_well_enable [i915]] enabling always-on
(i915_selftest:10805) igt_kmod-WARNING: ntel_power_well_disable [i915]] disabling always-on
(i915_selftest:10805) igt_kmod-WARNING: 1 = 211262ns, 630 = 26428ns
(i915_selftest:10805) igt_kmod-WARNING: ntel_power_well_enable [i915]] enabling always-on
(i915_selftest:10805) igt_kmod-WARNING: ntel_power_well_disable [i915]] disabling always-on
(i915_selftest:10805) igt_kmod-WARNING: 1 = 3368539ns, 772 = 22585ns
(i915_selftest:10805) igt_kmod-WARNING: ntel_power_well_enable [i915]] enabling always-on
(i915_selftest:10805) igt_kmod-WARNING: ntel_power_well_disable [i915]] disabling always-on
(i915_selftest:10805) igt_kmod-WARNING: 1 = 3613403ns, 786 = 21525ns
(i915_selftest:10805) igt_kmod-WARNING: ntel_power_well_enable [i915]] enabling always-on
(i915_selftest:10805) igt_kmod-WARNING: ntel_power_well_disable [i915]] disabling always-on
(i915_selftest:10805) igt_kmod-WARNING: 1 = 3298591ns, 756 = 26931ns
(i915_selftest:10805) igt_kmod-WARNING: Running i915_gem_context_live_selftests/igt_ctx_exec
(i915_selftest:10805) igt_kmod-WARNING: ntel_power_well_enable [i915]] enabling always-on
(i915_selftest:10805) igt_kmod-WARNING: 6016 ms ago
(i915_selftest:10805) igt_kmod-WARNING: 0 (global 0)
(i915_selftest:10805) igt_kmod-WARNING: 6de*  prio=2147483647 @ 7894ms: [i915]
(i915_selftest:10805) igt_kmod-WARNING:  0x7fff7000
(i915_selftest:10805) igt_kmod-WARNING:   0x00002828
(i915_selftest:10805) igt_kmod-WARNING:   0x000031d0
(i915_selftest:10805) igt_kmod-WARNING:   0x000031d0
(i915_selftest:10805) igt_kmod-WARNING:  0x000018a0
(i915_selftest:10805) igt_kmod-WARNING:   0x7fffe100
(i915_selftest:10805) igt_kmod-WARNING:  0x00002000
(i915_selftest:10805) igt_kmod-WARNING: 0x415f810d
(i915_selftest:10805) igt_kmod-WARNING: 0x7fff7000
(i915_selftest:10805) igt_kmod-WARNING:  0x00002840
(i915_selftest:10805) igt_kmod-WARNING:  0x000031d0
(i915_selftest:10805) igt_kmod-WARNING:   0x00003001
(i915_selftest:10805) igt_kmod-WARNING:  0x00004000
(i915_selftest:10805) igt_kmod-WARNING: ffffffde
(i915_selftest:10805) igt_kmod-WARNING:  0x00000000_34a02840
(i915_selftest:10805) igt_kmod-WARNING: 0x00000000_415f7004
(i915_selftest:10805) igt_kmod-WARNING: 0x00000000_7fff99d8
(i915_selftest:10805) igt_kmod-WARNING: 0x00000000
(i915_selftest:10805) igt_kmod-WARNING: 0x780c0000
(i915_selftest:10805) igt_kmod-WARNING: 0x7fde0000
(i915_selftest:10805) igt_kmod-WARNING: 0x00000000
(i915_selftest:10805) igt_kmod-WARNING: 0xffffffff
(i915_selftest:10805) igt_kmod-WARNING: 6de*  prio=2147483647 @ 7894ms: [i915]
(i915_selftest:10805) igt_kmod-WARNING: 6df  @ 7891ms: [i915]
(i915_selftest:10805) igt_kmod-WARNING: 6e0-  @ 7891ms: [i915]
(i915_selftest:10805) igt_kmod-WARNING: 6e1  @ 7891ms: [i915]
(i915_selftest:10805) igt_kmod-WARNING: 6e2  @ 7891ms: [i915]
(i915_selftest:10805) igt_kmod-WARNING: 6e3  @ 7891ms: [i915]
(i915_selftest:10805) igt_kmod-WARNING: 6e4  @ 7891ms: [i915]
(i915_selftest:10805) igt_kmod-WARNING: 6e9  @ 7890ms: [i915]
(i915_selftest:10805) igt_kmod-WARNING: 6e0] @ 7892ms
(i915_selftest:10805) igt_kmod-WARNING: 0:02.0: GPU HANG: ecode 7:1:0x87c3ffff, in  [0], hang on rcs0
(i915_selftest:10805) igt_kmod-WARNING: 000:00:02.0
(i915_selftest:10805) igt_kmod-WARNING: ntel_gt_reset_global [i915]] resetting chip
(i915_selftest:10805) igt_kmod-WARNING: 0:02.0: Resetting chip for hang on rcs0
(i915_selftest:10805) igt_kmod-WARNING: 000:00:02.0
(i915_selftest:10805) igt_kmod-WARNING: ntel_power_well_disable [i915]] disabling always-on
(i915_selftest:10805) igt_kmod-WARNING: GPU was reset 1 times!
(i915_selftest:10805) igt_kmod-WARNING: igt_ctx_exec failed with error -5
(i915_selftest:10805) igt_kmod-WARNING: ntel_power_well_enable [i915]] enabling always-on
(i915_selftest:10805) igt_kmod-WARNING: ntel_power_well_enable [i915]] enabling display
(i915_selftest:10805) igt_kmod-WARNING: probe of 0000:00:02.0 failed with error -5
(i915_selftest:10805) igt_kmod-CRITICAL: Test assertion failure function igt_kselftest_execute, file ../lib/igt_kmod.c:532:
(i915_selftest:10805) igt_kmod-CRITICAL: Failed assertion: err == 0
(i915_selftest:10805) igt_kmod-CRITICAL: kselftest "i915 igt__29__live_gem_contexts=1 live_selftests=-1 disable_display=1 st_filter=" failed: Input/output error [5]
(i915_selftest:10805) igt_core-INFO: Stack trace:
(i915_selftest:10805) igt_core-INFO:   #0 ../lib/igt_core.c:1674 __igt_fail_assert()
(i915_selftest:10805) igt_core-INFO:   #1 ../lib/igt_kmod.c:535 igt_kselftest_execute()
(i915_selftest:10805) igt_core-INFO:   #2 [main+0x30]
****  END  ****
Subtest live_gem_contexts: FAIL (12.969s)
Comment 2 Chris Wilson 2019-09-16 10:36:05 UTC 
Failed context restore, similar to

                        *cs++ = MI_LOAD_REGISTER_IMM(num_engines);
                        for_each_engine(signaller, i915, id) {
                                if (signaller == engine)
                                        continue;

                                *cs++ = i915_mmio_reg_offset(
                                           RING_PSMI_CTL(signaller->mmio_base));
                                *cs++ = _MASKED_BIT_ENABLE(
                                                GEN6_PSMI_SLEEP_MSG_DISABLE);
                        }

which is only supposed to affect hsw-gt1.
Comment 3 Chris Wilson 2019-09-16 10:40:29 UTC 
Petri says the shards use cpu: Intel(R) Core(TM) i7-4790K CPU @ 4.00GHz which is gt2 and is reflected in the lack of the w/a in the ringbuffer. We could just enable the w/a for all Haswell to be on the safe side.
Comment 4 Chris Wilson 2019-09-18 11:05:02 UTC 
I'm betting on it being a resurgence of the PSMI issue,

commit 56c05de6bd773b96deca379370965c49042b5fbf (HEAD -> drm-intel-next-queued, drm-intel/drm-intel-next-queued)
Author: Chris Wilson <chris@chris-wilson.co.uk>
Date:   Tue Sep 17 20:47:46 2019 +0100

    drm/i915: Extend Haswell GT1 PSMI workaround to all
    
    A few times in CI, we have detected a GPU hang on our Haswell GT2
    systems with the characteristic IPEHR of 0x780c0000. When the PSMI w/a
    was first introducted, it was applied to all Haswell, but later on we
    found an erratum that supposedly restricted the issue to GT1 and so
    constrained it only be applied on GT1. That may have been a mistake...
    
    Bugzilla: https://bugs.freedesktop.org/show_bug.cgi?id=111692
    Fixes: 167bc759e823 ("drm/i915: Restrict PSMI context load w/a to Haswell GT1")
    References: 2c550183476d ("drm/i915: Disable PSMI sleep messages on all rings around context switches")
    Signed-off-by: Chris Wilson <chris@chris-wilson.co.uk>
    Cc: Mika Kuoppala <mika.kuoppala@linux.intel.com>
    Acked-by: Mika Kuoppala <mika.kuoppala@linux.intel.com>
    Link: https://patchwork.freedesktop.org/patch/msgid/20190917194746.26710-1-chris@chris-wilson.co.uk

One interesting thought though was perhaps it is related to timing changes from iommu.
Comment 5 CI Bug Log 2019-12-05 07:14:57 UTC 
A CI Bug Log filter associated to this bug has been updated:

{- HSW: igt@i915_selftest@live_gem_contexts- dmesg-warn - igt_ctx_exec failed with error -5 -}
{+ BYT HSW: igt@i915_selftest@live_gem_contexts- dmesg-warn - igt_ctx_exec failed with error -5 +}

New failures caught by the filter:

  * https://intel-gfx-ci.01.org/tree/drm-tip/IGT_5324/fi-byt-n2820/igt@i915_selftest@live_gem_contexts.html
  * https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_7481/fi-byt-j1900/igt@i915_selftest@live_gem_contexts.html
  * https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_7482/fi-byt-squawks/igt@i915_selftest@live_gem_contexts.html
  * https://intel-gfx-ci.01.org/tree/drm-tip/IGT_5330/fi-byt-clapper/igt@i915_selftest@live_gem_contexts.html

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.