igt@i915_selftest@live@hangcheck - incomplete - *ERROR* engine 'bcs0' resumed still in error: 00000001
https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_12463/fi-ehl-2/igt@i915_selftest@live@hangcheck.html
Dmesg:
<6> [407.984038] rcs0: Completed 165 active resets
<3> [408.033384] i915 0000:00:02.0: [drm] *ERROR* engine 'bcs0' resumed still in error: 00000001
<3> [409.035704] __igt_reset_engine: Failed to start request 34, at 32
<6> [409.035717] i915 0000:00:02.0: [drm] bcs0
<6> [409.035722] i915 0000:00:02.0: [drm] Awake? 3
<6> [409.035724] i915 0000:00:02.0: [drm] Barriers?: no
<6> [409.035727] i915 0000:00:02.0: [drm] Latency: 106us
<6> [409.035731] i915 0000:00:02.0: [drm] Runtime: 1301ms
<6> [409.035734] i915 0000:00:02.0: [drm] Forcewake: 0 domains, 0 active
<6> [409.035737] i915 0000:00:02.0: [drm] Reset count: 655 (global 74)
<6> [409.035739] i915 0000:00:02.0: [drm] Properties:
<6> [409.035741] i915 0000:00:02.0: [drm] heartbeat_interval_ms: 0 [default 2500]
<6> [409.035744] i915 0000:00:02.0: [drm] max_busywait_duration_ns: 8000 [default 8000]
<6> [409.035747] i915 0000:00:02.0: [drm] preempt_timeout_ms: 10 [default 640]
<6> [409.035749] i915 0000:00:02.0: [drm] stop_timeout_ms: 100 [default 100]
<6> [409.035751] i915 0000:00:02.0: [drm] timeslice_duration_ms: 5 [default 1]
<6> [409.035755] i915 0000:00:02.0: [drm] Requests:
<6> [409.035830] i915 0000:00:02.0: [drm] On hold?: 0
<6> [409.035832] i915 0000:00:02.0: [drm] MMIO base: 0x00022000
<6> [409.036273] i915 0000:00:02.0: [drm] EL_STAT_HI: 0x00000000
<6> [409.036279] i915 0000:00:02.0: [drm] EL_STAT_LO: 0x00018001
<6> [409.036285] i915 0000:00:02.0: [drm] RING_START: 0x00089000
<6> [409.036290] i915 0000:00:02.0: [drm] RING_HEAD: 0x00000bb0
<6> [409.036295] i915 0000:00:02.0: [drm] RING_TAIL: 0x00000bb0
<6> [409.036304] i915 0000:00:02.0: [drm] RING_CTL: 0x00003000
<6> [409.036313] i915 0000:00:02.0: [drm] RING_MODE: 0x00000200 [idle]
<6> [409.037092] i915 0000:00:02.0: [drm] RING_IMR: 0x00000000
<6> [409.037128] i915 0000:00:02.0: [drm] RING_ESR: 0x00000000
<6> [409.037134] i915 0000:00:02.0: [drm] RING_EMR: 0xfffffffe
<6> [409.037139] i915 0000:00:02.0: [drm] RING_EIR: 0x00000000
<6> [409.037148] i915 0000:00:02.0: [drm] ACTHD: 0x00000000_00000bb0
<6> [409.037156] i915 0000:00:02.0: [drm] BBADDR: 0x00000000_00000000
<6> [409.037164] i915 0000:00:02.0: [drm] DMA_FADDR: 0x00000000_00000000
<6> [409.037170] i915 0000:00:02.0: [drm] IPEIR: 0x00000000
<6> [409.037175] i915 0000:00:02.0: [drm] IPEHR: 0x00000000
<6> [409.037177] i915 0000:00:02.0: [drm] Execlist tasklet queued? no (enabled), preempt? inactive, timeslice? inactive
<6> [409.037957] i915 0000:00:02.0: [drm] Execlist status: 0x00018001 00000000; CSB read:11, write:11, entries:12
<6> [409.037967] i915 0000:00:02.0: [drm] Pending[0]: ccid:60000020, rq: E d514:50!+ prio=0 @ 1006ms: signaled
<6> [409.037977] i915 0000:00:02.0: [drm] Queue priority hint: 0
<6> [409.037981] i915 0000:00:02.0: [drm] R d514:52 prio=0 @ 1004ms:
<6> [409.037985] i915 0000:00:02.0: [drm] HWSP:
<6> [409.037989] i915 0000:00:02.0: [drm] [0000] 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a
<6> [409.037992] i915 0000:00:02.0: [drm] *
<6> [409.037995] i915 0000:00:02.0: [drm] [0040] ffffffff ffffffff ffffffff ffffffff ffffffff ffffffff ffffffff ffffffff
<6> [409.037998] i915 0000:00:02.0: [drm] *
<6> [409.038001] i915 0000:00:02.0: [drm] [00a0] 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 0000000b
<6> [409.038004] i915 0000:00:02.0: [drm] [00c0] 5a5a5a5a 5a5a5a5a 00000000 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a
<6> [409.038007] i915 0000:00:02.0: [drm] [00e0] 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a
<6> [409.038011] i915 0000:00:02.0: [drm] [0100] 00000050 00000000 00000000 00000000 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a
<6> [409.038014] i915 0000:00:02.0: [drm] [0120] 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a 5a5a5a5a
<6> [409.038016] i915 0000:00:02.0: [drm] *
<6> [409.038024] i915 0000:00:02.0: [drm] Idle? no
<6> [409.038028] i915 0000:00:02.0: [drm] IRQ: disabled
<6> [409.038031] bcs0: Completed 25 active resets
<0> [418.462136] i915_sel-5416 1b.... 405636098us : intel_engine_cancel_stop_cs: 0000:00:02.0 vecs0:
<0> [418.462208] i915_sel-5416 1b.... 405636099us : execlists_reset_finish: 0000:00:02.0 vecs0: depth->0
<0> [418.462286] i915_sel-5416 1b.... 405636120us : __intel_engine_reset_bh: 0000:00:02.0 vecs0: flags=100000
<0> [418.462359] i915_sel-5416 1b.... 405636230us : execlists_reset_prepare: 0000:00:02.0 vecs0: depth<-0
<0> [418.462431] i915_sel-5416 1b.... 405636230us : intel_engine_stop_cs: 0000:00:02.0 vecs0:
<0> [418.462508] i915_sel-5416 1b.... 405636953us : __intel_gt_reset: 0000:00:02.0 engine_mask=40000
<0> [418.462581] i915_sel-5416 1b.... 405636968us : execlists_reset_rewind: 0000:00:02.0 vecs0:
<0> [418.462698] i915_sel-5416 1b.... 405636993us : active_context.part.37: 0000:00:02.0 vecs0: ccid:0 not found
<0> [418.462770] i915_sel-5416 1b.... 405638657us : intel_engine_cancel_stop_cs: 0000:00:02.0 vecs0:
<0> [418.462842] i915_sel-5416 1b.... 405638658us : execlists_reset_finish: 0000:00:02.0 vecs0: depth->0
<0> [418.462920] i915_sel-5416 1b.... 405638693us : __intel_engine_reset_bh: 0000:00:02.0 vecs0: flags=100000
<0> [418.462992] i915_sel-5416 1b.... 405638789us : execlists_reset_prepare: 0000:00:02.0 vecs0: depth<-0
<0> [418.463064] i915_sel-5416 1b.... 405638789us : intel_engine_stop_cs: 0000:00:02.0 vecs0:
<0> [418.463141] i915_sel-5416 1b.... 405639538us : __intel_gt_reset: 0000:00:02.0 engine_mask=40000
<0> [418.463214] i915_sel-5416 1b.... 405639554us : execlists_reset_rewind: 0000:00:02.0 vecs0:
<0> [418.463286] i915_sel-5416 1b.... 405639563us : active_context.part.37: 0000:00:02.0 vecs0: ccid:0 not found
<0> [418.463358] i915_sel-5416 1b.... 405640395us : intel_engine_cancel_stop_cs: 0000:00:02.0 vecs0:
<0> [418.463430] i915_sel-5416 1b.... 405640396us : execlists_reset_finish: 0000:00:02.0 vecs0: depth->0
<0> [418.463507] i915_sel-5416 1b.... 405640418us : __intel_engine_reset_bh: 0000:00:02.0 vecs0: flags=100000
<0> [418.463580] i915_sel-5416 1b.... 405640533us : execlists_reset_prepare: 0000:00:02.0 vecs0: depth<-0
<0> [418.463684] i915_sel-5416 1b.... 405640533us : intel_engine_stop_cs: 0000:00:02.0 vecs0:
<0> [418.463770] i915_sel-5416 1b.... 405641250us : __intel_gt_reset: 0000:00:02.0 engine_mask=40000
<0> [418.463851] i915_sel-5416 1b.... 405641265us : execlists_reset_rewind: 0000:00:02.0 vecs0:
<0> [418.463931] i915_sel-5416 1b.... 405641275us : active_context.part.37: 0000:00:02.0 vecs0: ccid:0 not found
<0> [418.464011] i915_sel-5416 1b.... 405642099us : intel_engine_cancel_stop_cs: 0000:00:02.0 vecs0:
<0> [418.464091] i915_sel-5416 1b.... 405642100us : execlists_reset_finish: 0000:00:02.0 vecs0: depth->0
<0> [418.464177] i915_sel-5416 1b.... 405642124us : __intel_engine_reset_bh: 0000:00:02.0 vecs0: flags=100000
<0> [418.464258] i915_sel-5416 1b.... 405642232us : execlists_reset_prepare: 0000:00:02.0 vecs0: depth<-0
<0> [418.464338] i915_sel-5416 1b.... 405642232us : intel_engine_stop_cs: 0000:00:02.0 vecs0:
<0> [418.464424] i915_sel-5416 1b.... 405642956us : __intel_gt_reset: 0000:00:02.0 engine_mask=40000
<0> [418.464505] i915_sel-5416 1b.... 405642972us : execlists_reset_rewind: 0000:00:02.0 vecs0:
<0> [418.464585] i915_sel-5416 1b.... 405642997us : active_context.part.37: 0000:00:02.0 vecs0: ccid:0 not found
<0> [418.464679] i915_sel-5416 1b.... 405644645us : intel_engine_cancel_stop_cs: 0000:00:02.0 vecs0:
<0> [418.464752] i915_sel-5416 1b.... 405644646us : execlists_reset_finish: 0000:00:02.0 vecs0: depth->0
<0> [418.464829] i915_sel-5416 1b.... 405644667us : __intel_engine_reset_bh: 0000:00:02.0 vecs0: flags=100000
<0> [418.464901] i915_sel-5416 1b.... 405644787us : execlists_reset_prepare: 0000:00:02.0 vecs0: depth<-0
<0> [418.464974] i915_sel-5416 1b.... 405644787us : intel_engine_stop_cs: 0000:00:02.0 vecs0:
<0> [418.465051] i915_sel-5416 1b.... 405645532us : __intel_gt_reset: 0000:00:02.0 engine_mask=40000
<0> [418.465124] i915_sel-5416 1b.... 405645548us : execlists_reset_rewind: 0000:00:02.0 vecs0:
<0> [418.465196] i915_sel-5416 1b.... 405645557us : active_context.part.37: 0000:00:02.0 vecs0: ccid:0 not found
<0> [418.465268] i915_sel-5416 1b.... 405646388us : intel_engine_cancel_stop_cs: 0000:00:02.0 vecs0:
<0> [418.465340] i915_sel-5416 1b.... 405646389us : execlists_reset_finish: 0000:00:02.0 vecs0: depth->0
<0> [418.465417] i915_sel-5416 1b.... 405646410us : __intel_engine_reset_bh: 0000:00:02.0 vecs0: flags=100000
<0> [418.465490] i915_sel-5416 1b.... 405646535us : execlists_reset_prepare: 0000:00:02.0 vecs0: depth<-0
<0> [418.465562] i915_sel-5416 1b.... 405646535us : intel_engine_stop_cs: 0000:00:02.0 vecs0:
<0> [418.465659] i915_sel-5416 1b.... 405647253us : __intel_gt_reset: 0000:00:02.0 engine_mask=40000
<0> [418.465749] i915_sel-5416 1b.... 405647269us : execlists_reset_rewind: 0000:00:02.0 vecs0:
<0> [418.465821] i915_sel-5416 1b.... 405647278us : active_context.part.37: 0000:00:02.0 vecs0: ccid:0 not found
<0> [418.465893] i915_sel-5416 1bN... 405648113us : intel_engine_cancel_stop_cs: 0000:00:02.0 vecs0:
<0> [418.465966] i915_sel-5416 1bN... 405648113us : execlists_reset_finish: 0000:00:02.0 vecs0: depth->0
<0> [418.466043] i915_sel-5416 1b.... 405648137us : __intel_engine_reset_bh: 0000:00:02.0 vecs0: flags=100000
<0> [418.466115] i915_sel-5416 1b.... 405648249us : execlists_reset_prepare: 0000:00:02.0 vecs0: depth<-0
<0> [418.466187] i915_sel-5416 1b.... 405648249us : intel_engine_stop_cs: 0000:00:02.0 vecs0:
<0> [418.466264] i915_sel-5416 1b.... 405648980us : __intel_gt_reset: 0000:00:02.0 engine_mask=40000
<0> [418.466337] i915_sel-5416 1b.... 405649012us : execlists_reset_rewind: 0000:00:02.0 vecs0:
<0> [418.466409] i915_sel-5416 1b.... 405649021us : active_context.part.37: 0000:00:02.0 vecs0: ccid:0 not found
<0> [418.466481] i915_sel-5416 1b.... 405650688us : intel_engine_cancel_stop_cs: 0000:00:02.0 vecs0:
<0> [418.466553] i915_sel-5416 1b.... 405650689us : execlists_reset_finish: 0000:00:02.0 vecs0: depth->0
<0> [418.466651] i915_sel-5416 1..s1. 405650714us : rps_timer: 0000:00:02.0 busy:0 [0%], max:[0, 0, 0], interval:20
<0> [418.466747] i915_sel-5416 1b.... 405650719us : __intel_engine_reset_bh: 0000:00:02.0 vecs0: flags=100000
<0> [418.466819] i915_sel-5416 1b.... 405650874us : execlists_reset_prepare: 0000:00:02.0 vecs0: depth<-0
<0> [418.466891] i915_sel-5416 1b.... 405650874us : intel_engine_stop_cs: 0000:00:02.0 vecs0: