Bug 109723

Summary: [CI][DRMTIP] igt@gem_eio@in-flight-suspend|igt@i915_selftest@live_hangcheck - incomplete - GEM_BUG_ON(!i915_request_completed(rq))
Product: DRI Reporter: Lakshmi <lakshminarayana.vudum>
Component: DRM/IntelAssignee: Intel GFX Bugs mailing list <intel-gfx-bugs>
Status: RESOLVED WORKSFORME 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: BYT, ILK, IVB, SNB i915 features: GEM/Other

Description Lakshmi 2019-02-21 15:32:55 UTC
https://intel-gfx-ci.01.org/tree/drm-tip/drmtip_225/fi-ilk-650/igt@gem_eio@in-flight-suspend.html

<3> [57.212616] __retire_engine_request:189 GEM_BUG_ON(!i915_request_completed(rq))
<2> [57.212788] kernel BUG at drivers/gpu/drm/i915/i915_request.c:189!
<4> [57.212910] RIP: 0010:i915_request_retire+0x6fe/0xc80 [i915]
<4> [57.213095]  i915_request_retire_upto+0x11a/0x300 [i915]
<4> [57.213154]  i915_request_add+0x399/0x990 [i915]
<4> [57.213207]  i915_gem_do_execbuffer+0x100c/0x1a50 [i915]
<4> [57.213289]  ? i915_gem_execbuffer2_ioctl+0xc4/0x420 [i915]
<4> [57.213364]  ? i915_gem_execbuffer_ioctl+0x300/0x300 [i915]
<4> [57.213419]  i915_gem_execbuffer2_ioctl+0x11b/0x420 [i915]
<4> [57.213475]  ? i915_gem_execbuffer_ioctl+0x300/0x300 [i915]
<4> [57.213489]  drm_ioctl_kernel+0x83/0xf0
<4> [57.213498]  drm_ioctl+0x2f3/0x3b0
<4> [57.213546]  ? i915_gem_execbuffer_ioctl+0x300/0x300 [i915]
<0> [57.213814] i915_que-1090    1.... 26354156us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever)
<0> [57.213873] i915_que-1090    1.... 26355538us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever)
<0> [57.213933] gem_pwri-1101    1.... 32682881us : i915_gem_wait_for_idle: flags=2 (locked), timeout=9223372036854775807 (forever)
<0> [57.213993] kms_univ-1104    1.... 42747712us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever)
<0> [57.214053] kms_curs-1111    1.... 44746016us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever)
<0> [57.214113] kms_colo-1112    1.... 47625924us : i915_gem_wait_for_idle: flags=3 (locked), timeout=9223372036854775807 (forever)
<0> [57.214172] kworker/-163     1.... 47996852us : i915_gem_unpark: 
<0> [57.214227] kworker/-163     1.... 47997144us : i915_request_add: rcs0 fence 5:3
<0> [57.214283] kworker/-163     1.... 47997157us : i915_request_add: marking rcs0 as active
<0> [57.214342] kworker/-163     1d..1 47997171us : __i915_request_submit: rcs0 fence 5:3 -> global=3, current 2:2
<0> [57.214401] kworker/-163     1.... 47997215us : i915_request_add: vcs0 fence 8:3
<0> [57.214461] kworker/-163     1.... 47997216us : i915_request_add: marking vcs0 as active
<0> [57.214525] kworker/-163     1d..1 47997218us : __i915_request_submit: vcs0 fence 8:3 -> global=3, current 2:2
<0> [57.214589] kworker/-163     1.... 48287283us : i915_gem_switch_to_kernel_context: awake?=yes
<0> [57.214651] kworker/-163     1.... 48287285us : i915_gem_switch_to_kernel_context: emit barrier on rcs0
<0> [57.214714] kworker/-163     1.... 48287286us : i915_gem_unpark: 
<0> [57.214775] kworker/-163     1.... 48287400us : i915_request_add: rcs0 fence 5:593
<0> [57.214840] kworker/-163     1.... 48287413us : i915_request_add: marking rcs0 as active
<0> [57.214905] kworker/-163     1d..1 48287426us : __i915_request_submit: rcs0 fence 5:593 -> global=593, current 592:592
<0> [57.214971] kworker/-163     1.... 48287472us : i915_gem_idle_work_handler: active_requests=1 (after switch-to-kernel-context)
<0> [57.215040] kworker/-163     1.... 48287553us : i915_request_retire: rcs0 fence 5:593, global=593, current 593:593
<0> [57.215108] kworker/-163     1.... 48287555us : i915_request_retire: marking rcs0 as inactive
<0> [57.215175] kworker/-163     1.... 48287556us : i915_request_retire: __retire_engine_request(rcs0) fence 5:593, global=593, current 593:593
<0> [57.215243] kworker/-163     1.... 48287594us : i915_gem_park: 
<0> [57.215302] kworker/-163     1.... 48287749us : i915_gem_switch_to_kernel_context: awake?=yes
<0> [57.215367] kworker/-163     1.... 48287750us : i915_gem_idle_work_handler: active_requests=0 (after switch-to-kernel-context)
<0> [57.215435] kworker/-163     1.... 48287798us : __i915_gem_park: 
<0> [57.215501] CPU:2 [LOST 2837 EVENTS]
 gem_eio-1113    2.... 48370626us : i915_request_retire: vcs0 fence 8:895, global=895, current 937:937
<0> [57.215568]  gem_eio-1113    2.... 48370627us : i915_request_retire: __retire_engine_request(vcs0) fence 8:895, global=895, current 937:937
<0> [57.215631]  gem_eio-1113    2.... 48370645us : i915_request_retire: vcs0 fence 8:896, global=896, current 937:937
<0> [57.215691]  gem_eio-1113    2.... 48370646us : i915_request_retire: __retire_engine_request(vcs0) fence 8:896, global=896, current 937:937
<0> [57.215753]  gem_eio-1113    2.... 48370664us : i915_request_retire: vcs0 fence 8:897, global=897, current 937:937
<0> [57.215813]  gem_eio-1113    2.... 48370665us : i915_request_retire: __retire_engine_request(vcs0) fence 8:897, global=897, current 937:937
<0> [57.215874]  gem_eio-1113    2.... 48370684us : i915_request_retire: vcs0 fence 8:898, global=898, current 937:937
<0> [57.215935]  gem_eio-1113    2.... 48370685us : i915_request_retire: __retire_engine_request(vcs0) fence 8:898, global=898, current 937:937
<0> [57.215996]  gem_eio-1113    2.... 48370703us : i915_request_retire: vcs0 fence 8:899, global=899, current 937:937
<0> [57.216055]  gem_eio-1113    2.... 48370704us : i915_request_retire: __retire_engine_request(vcs0) fence 8:899, global=899, current 937:937
<0> [57.216117]  gem_eio-1113    2.... 48370722us : i915_request_retire: vcs0 fence 8:900, global=900, current 937:937
<0> [57.216177]  gem_eio-1113    2.... 48370723us : i915_request_retire: __retire_engine_request(vcs0) fence 8:900, global=900, current 937:937
<0> [57.216238]  gem_eio-1113    2.... 48370743us : i915_request_retire: vcs0 fence 8:901, global=901, current 937:937
<0> [57.216297]  gem_eio-1113    2.... 48370744us : i915_request_retire: __retire_engine_request(vcs0) fence 8:901, global=901, current 937:937
<0> [57.216358]  gem_eio-1113    2.... 48370751us : i915_request_retire: vcs0 fence 8:902, global=902, current 937:937
<0> [57.216418]  gem_eio-1113    2.... 48370752us : i915_request_retire: __retire_engine_request(vcs0) fence 8:902, global=902, current 937:937
<0> [57.216488]  gem_eio-1113    2.... 48370770us : i915_request_retire: vcs0 fence 8:903, global=903, current 937:937
<0> [57.216558]  gem_eio-1113    2.... 48370771us : i915_request_retire: __retire_engine_request(vcs0) fence 8:903, global=903, current 937:937
<0> [57.216625]  gem_eio-1113    2.... 48370788us : i915_request_retire: vcs0 fence 8:904, global=904, current 937:937
<0> [57.216693]  gem_eio-1113    2.... 48370790us : i915_request_retire: __retire_engine_request(vcs0) fence 8:904, global=904, current 937:937
<0> [57.216763]  gem_eio-1113    2.... 48370807us : i915_request_retire: vcs0 fence 8:905, global=905, current 937:937
<0> [57.216830]  gem_eio-1113    2.... 48370808us : i915_request_retire: __retire_engine_request(vcs0) fence 8:905, global=905, current 937:937
<0> [57.216900]  gem_eio-1113    2.... 48370826us : i915_request_retire: vcs0 fence 8:906, global=906, current 937:937
<0> [57.216969]  gem_eio-1113    2.... 48370827us : i915_request_retire: __retire_engine_request(vcs0) fence 8:906, global=906, current 937:937
<0> [57.217041]  gem_eio-1113    2.... 48370844us : i915_request_retire: vcs0 fence 8:907, global=907, current 937:937
<0> [57.217110]  gem_eio-1113    2.... 48370846us : i915_request_retire: __retire_engine_request(vcs0) fence 8:907, global=907, current 937:937
<0> [57.217181]  gem_eio-1113    2.... 48370863us : i915_request_retire: vcs0 fence 8:908, global=908, current 937:937
<0> [57.217249]  gem_eio-1113    2.... 48370864us : i915_request_retire: __retire_engine_request(vcs0) fence 8:908, global=908, current 937:937
<0> [57.217321]  gem_eio-1113    2.... 48370882us : i915_request_retire: vcs0 fence 8:909, global=909, current 937:937
<0> [57.217391]  gem_eio-1113    2.... 48370883us : i915_request_retire: __retire_engine_request(vcs0) fence 8:909, global=909, current 937:937
<0> [57.217462]  gem_eio-1113    2.... 48370901us : i915_request_retire: vcs0 fence 8:910, global=910, current 937:937
<0> [57.217532]  gem_eio-1113    2.... 48370903us : i915_request_retire: __retire_engine_request(vcs0) fence 8:910, global=910, current 937:937
<0> [57.217603]  gem_eio-1113    2.... 48370920us : i915_request_retire: vcs0 fence 8:911, global=911, current 937:937
<0> [57.217674]  gem_eio-1113    2.... 48370921us : i915_request_retire: __retire_engine_request(vcs0) fence 8:911, global=911, current 937:937
<0> [57.217745]  gem_eio-1113    2.... 48370939us : i915_request_retire: vcs0 fence 8:912, global=912, current 937:937
<0> [57.217814]  gem_eio-1113    2.... 48370940us : i915_request_retire: __retire_engine_request(vcs0) fence 8:912, global=912, current 937:937
<0> [57.217886]  gem_eio-1113    2.... 48370958us : i915_request_retire: vcs0 fence 8:913, global=913, current 937:937
<0> [57.217956]  gem_eio-1113    2.... 48370959us : i915_request_retire: __retire_engine_request(vcs0) fence 8:913, global=913, current 937:937
<0> [57.218027]  gem_eio-1113    2.... 48370977us : i915_request_retire: vcs0 fence 8:914, global=914, current 937:937
<0> [57.218096]  gem_eio-1113    2.... 48370978us : i915_request_retire: __retire_engine_request(vcs0) fence 8:914, global=914, current 937:937
<0> [57.218167]  gem_eio-1113    2.... 48370996us : i915_request_retire: vcs0 fence 8:915, global=915, current 937:937
<0> [57.218236]  gem_eio-1113    2.... 48370997us : i915_request_retire: __retire_engine_request(vcs0) fence 8:915, global=915, current 937:937
<0> [57.218307]  gem_eio-1113    2.... 48371015us : i915_request_retire: vcs0 fence 8:916, global=916, current 937:937
<0> [57.218377]  gem_eio-1113    2.... 48371016us : i915_request_retire: __retire_engine_request(vcs0) fence 8:916, global=916, current 937:937
<0> [57.218448]  gem_eio-1113    2.... 48371034us : i915_request_retire: vcs0 fence 8:917, global=917, current 937:937
<0> [57.218517]  gem_eio-1113    2.... 48371035us : i915_request_retire: __retire_engine_request(vcs0) fence 8:917, global=917, current 937:937
<0> [57.218588]  gem_eio-1113    2.... 48371053us : i915_request_retire: vcs0 fence 8:918, global=918, current 937:937
<0> [57.218657]  gem_eio-1113    2.... 48371054us : i915_request_retire: __retire_engine_request(vcs0) fence 8:918, global=918, current 937:937
<0> [57.218727]  gem_eio-1113    2.... 48371072us : i915_request_retire: vcs0 fence 8:919, global=919, current 937:937
<0> [57.218796]  gem_eio-1113    2.... 48371073us : i915_request_retire: __retire_engine_request(vcs0) fence 8:919, global=919, current 937:937
<0> [57.218867]  gem_eio-1113    2.... 48371091us : i915_request_retire: vcs0 fence 8:920, global=920, current 937:937
<0> [57.218936]  gem_eio-1113    2.... 48371092us : i915_request_retire: __retire_engine_request(vcs0) fence 8:920, global=920, current 937:937
<0> [57.219008]  gem_eio-1113    2.... 48371110us : i915_request_retire: vcs0 fence 8:921, global=921, current 937:937
<0> [57.219078]  gem_eio-1113    2.... 48371111us : i915_request_retire: __retire_engine_request(vcs0) fence 8:921, global=921, current 937:937
<0> [57.219149]  gem_eio-1113    2.... 48371129us : i915_request_retire: vcs0 fence 8:922, global=922, current 937:937
<0> [57.219218]  gem_eio-1113    2.... 48371131us : i915_request_retire: __retire_engine_request(vcs0) fence 8:922, global=922, current 937:937
<0> [57.219288]  gem_eio-1113    2.... 48371148us : i915_request_retire: vcs0 fence 8:923, global=923, current 937:937
<0> [57.219358]  gem_eio-1113    2.... 48371150us : i915_request_retire: __retire_engine_request(vcs0) fence 8:923, global=923, current 937:937
<0> [57.219428]  gem_eio-1113    2.... 48371168us : i915_request_retire: vcs0 fence 8:924, global=924, current 937:937
<0> [57.219497]  gem_eio-1113    2.... 48371169us : i915_request_retire: __retire_engine_request(vcs0) fence 8:924, global=924, current 937:937
<0> [57.219568]  gem_eio-1113    2.... 48371187us : i915_request_retire: vcs0 fence 8:925, global=925, current 937:937
<0> [57.219638]  gem_eio-1113    2.... 48371188us : i915_request_retire: __retire_engine_request(vcs0) fence 8:925, global=925, current 937:937
<0> [57.219709]  gem_eio-1113    2.... 48371206us : i915_request_retire: vcs0 fence 8:926, global=926, current 937:937
<0> [57.219775]  gem_eio-1113    2.... 48371208us : i915_request_retire: __retire_engine_request(vcs0) fence 8:926, global=926, current 937:937
<0> [57.219843]  gem_eio-1113    2.... 48371225us : i915_request_retire: vcs0 fence 8:927, global=927, current 937:937
<0> [57.219910]  gem_eio-1113    2.... 48371227us : i915_request_retire: __retire_engine_request(vcs0) fence 8:927, global=927, current 937:937
<0> [57.219980]  gem_eio-1113    2.... 48371244us : i915_request_retire: vcs0 fence 8:928, global=928, current 937:937
<0> [57.220050]  gem_eio-1113    2.... 48371246us : i915_request_retire: __retire_engine_request(vcs0) fence 8:928, global=928, current 937:937
<0> [57.220120]  gem_eio-1113    2.... 48371311us : i915_request_retire: vcs0 fence 8:929, global=929, current 937:937
<0> [57.220185]  gem_eio-1113    2.... 48371313us : i915_request_retire: __retire_engine_request(vcs0) fence 8:929, global=929, current 937:937
<0> [57.220255]  gem_eio-1113    2.... 48371345us : i915_request_retire: vcs0 fence 8:930, global=930, current 937:937
<0> [57.220321]  gem_eio-1113    2.... 48371350us : i915_request_retire: __retire_engine_request(vcs0) fence 8:930, global=930, current 937:937
<0> [57.220392]  gem_eio-1113    2.... 48371362us : i915_request_retire: vcs0 fence 8:931, global=931, current 937:937
<0> [57.220461]  gem_eio-1113    2.... 48371364us : i915_request_retire: __retire_engine_request(vcs0) fence 8:931, global=931, current 937:937
<0> [57.220531]  gem_eio-1113    2.... 48371390us : i915_request_retire: vcs0 fence 8:932, global=932, current 937:937
<0> [57.220599]  gem_eio-1113    2.... 48371392us : i915_request_retire: __retire_engine_request(vcs0) fence 8:932, global=932, current 937:937
<0> [57.220671]  gem_eio-1113    2.... 48371414us : i915_request_retire: vcs0 fence 8:933, global=933, current 937:937
<0> [57.220740]  gem_eio-1113    2.... 48371416us : i915_request_retire: __retire_engine_request(vcs0) fence 8:933, global=933, current 937:937
<0> [57.220813]  gem_eio-1113    2.... 48371423us : i915_request_retire: vcs0 fence 8:934, global=934, current 937:937
<0> [57.220882]  gem_eio-1113    2.... 48371424us : i915_request_retire: __retire_engine_request(vcs0) fence 8:934, global=934, current 937:937
<0> [57.220954]  gem_eio-1113    2.... 48371442us : i915_request_retire: vcs0 fence 8:935, global=935, current 937:937
<0> [57.221024]  gem_eio-1113    2.... 48371444us : i915_request_retire: __retire_engine_request(vcs0) fence 8:935, global=935, current 937:937
<0> [57.221095]  gem_eio-1113    2.... 48371461us : i915_request_retire: vcs0 fence 8:936, global=936, current 937:937
<0> [57.221165]  gem_eio-1113    2.... 48371463us : i915_request_retire: __retire_engine_request(vcs0) fence 8:936, global=936, current 937:937
<0> [57.221238]  gem_eio-1113    2.... 48371481us : i915_request_retire: vcs0 fence 8:937, global=937, current 937:937
<0> [57.221308]  gem_eio-1113    2.... 48371482us : i915_request_retire: marking vcs0 as inactive
<0> [57.221377]  gem_eio-1113    2.... 48371534us : i915_request_retire: __retire_engine_request(vcs0) fence 8:937, global=937, current 937:937
<0> [57.221446]  gem_eio-1113    2.... 48371535us : i915_gem_park: 
<0> [57.221506] kworker/-163     1.... 48371622us : i915_gem_switch_to_kernel_context: awake?=yes
<0> [57.221569] kworker/-163     1.... 48371624us : i915_gem_switch_to_kernel_context: emit barrier on vcs0
<0> [57.221634] kworker/-163     1.... 48371625us : i915_gem_unpark: 
<0> [57.221699] kworker/-163     1.... 48371640us : i915_request_add: vcs0 fence 8:938
<0> [57.221766] kworker/-163     1.... 48371642us : i915_request_add: marking vcs0 as active
<0> [57.221834] kworker/-163     1d..1 48371646us : __i915_request_submit: vcs0 fence 8:938 -> global=938, current 937:937
<0> [57.221902] kworker/-163     1.... 48371650us : i915_gem_idle_work_handler: active_requests=1 (after switch-to-kernel-context)
<0> [57.221974] kworker/-163     1.... 48371808us : i915_request_retire: vcs0 fence 8:938, global=938, current 938:938
<0> [57.222042] kworker/-163     1.... 48371811us : i915_request_retire: marking vcs0 as inactive
<0> [57.222110] kworker/-163     1.... 48371814us : i915_request_retire: __retire_engine_request(vcs0) fence 8:938, global=938, current 938:938
<0> [57.222179] kworker/-163     1.... 48371819us : i915_gem_park: 
<0> [57.222240] kworker/-163     1.... 48372074us : i915_gem_switch_to_kernel_context: awake?=yes
<0> [57.222306] kworker/-163     1.... 48372076us : i915_gem_idle_work_handler: active_requests=0 (after switch-to-kernel-context)
<0> [57.222372] kworker/-163     1.... 48372093us : __i915_gem_park: 
<0> [57.222438] CPU:3 [LOST 75 EVENTS]
 gem_eio-1113    3.... 48392098us : i915_request_add: rcs0 fence 5:608
<0> [57.222509]  gem_eio-1113    3d..1 48392107us : __i915_request_submit: rcs0 fence 5:608 -> global=608, current 593:593
<0> [57.222579]  gem_eio-1113    3.... 48392237us : i915_request_add: rcs0 fence 5:609
<0> [57.222648]  gem_eio-1113    3d..1 48392247us : __i915_request_submit: rcs0 fence 5:609 -> global=609, current 593:593
<0> [57.222718]  gem_eio-1113    3.... 48392386us : i915_request_add: rcs0 fence 5:610
<0> [57.222784]  gem_eio-1113    3d..1 48392393us : __i915_request_submit: rcs0 fence 5:610 -> global=610, current 593:593
<0> [57.222854]  gem_eio-1113    3.... 48392478us : i915_request_add: rcs0 fence 5:611
<0> [57.222919]  gem_eio-1113    3d..1 48392483us : __i915_request_submit: rcs0 fence 5:611 -> global=611, current 593:593
<0> [57.222990]  gem_eio-1113    3.... 48392562us : i915_request_add: rcs0 fence 5:612
<0> [57.223056]  gem_eio-1113    3d..1 48392568us : __i915_request_submit: rcs0 fence 5:612 -> global=612, current 593:593
<0> [57.223127]  gem_eio-1113    3.... 48392680us : i915_request_add: rcs0 fence 5:613
<0> [57.223195]  gem_eio-1113    3d..1 48392686us : __i915_request_submit: rcs0 fence 5:613 -> global=613, current 593:593
<0> [57.223265]  gem_eio-1113    3.... 48392766us : i915_request_add: rcs0 fence 5:614
<0> [57.223333]  gem_eio-1113    3d..1 48392771us : __i915_request_submit: rcs0 fence 5:614 -> global=614, current 593:593
<0> [57.223403]  gem_eio-1113    3.... 48392849us : i915_request_add: rcs0 fence 5:615
<0> [57.223472]  gem_eio-1113    3d..1 48392854us : __i915_request_submit: rcs0 fence 5:615 -> global=615, current 593:593
<0> [57.223541]  gem_eio-1113    3.... 48392931us : i915_request_add: rcs0 fence 5:616
<0> [57.223608]  gem_eio-1113    3d..1 48392936us : __i915_request_submit: rcs0 fence 5:616 -> global=616, current 593:593
<0> [57.223679]  gem_eio-1113    3.... 48393013us : i915_request_add: rcs0 fence 5:617
<0> [57.223746]  gem_eio-1113    3d..1 48393019us : __i915_request_submit: rcs0 fence 5:617 -> global=617, current 593:593
<0> [57.223815]  gem_eio-1113    3.... 48393094us : i915_request_add: rcs0 fence 5:618
<0> [57.223883]  gem_eio-1113    3d..1 48393100us : __i915_request_submit: rcs0 fence 5:618 -> global=618, current 593:593
<0> [57.223953]  gem_eio-1113    3.... 48393177us : i915_request_add: rcs0 fence 5:619
<0> [57.224022]  gem_eio-1113    3d..1 48393182us : __i915_request_submit: rcs0 fence 5:619 -> global=619, current 593:593
<0> [57.224094]  gem_eio-1113    3.... 48393258us : i915_request_add: rcs0 fence 5:620
<0> [57.224158]  gem_eio-1113    3d..1 48393286us : __i915_request_submit: rcs0 fence 5:620 -> global=620, current 593:593
<0> [57.224227]  gem_eio-1113    3.... 48393372us : i915_request_add: rcs0 fence 5:621
<0> [57.224294]  gem_eio-1113    3d..1 48393379us : __i915_request_submit: rcs0 fence 5:621 -> global=621, current 593:593
<0> [57.224364]  gem_eio-1113    3.... 48393456us : i915_request_add: rcs0 fence 5:622
<0> [57.224432]  gem_eio-1113    3d..1 48393461us : __i915_request_submit: rcs0 fence 5:622 -> global=622, current 593:593
<0> [57.224502]  gem_eio-1113    3.... 48393538us : i915_request_add: rcs0 fence 5:623
<0> [57.224568]  gem_eio-1113    3d..1 48393543us : __i915_request_submit: rcs0 fence 5:623 -> global=623, current 593:593
<0> [57.224638]  gem_eio-1113    3.... 48393621us : i915_request_add: rcs0 fence 5:624
<0> [57.224704]  gem_eio-1113    3d..1 48393627us : __i915_request_submit: rcs0 fence 5:624 -> global=624, current 593:593
<0> [57.224775]  gem_eio-1113    3.... 48393702us : i915_request_add: rcs0 fence 5:625
<0> [57.224842]  gem_eio-1113    3d..1 48393708us : __i915_request_submit: rcs0 fence 5:625 -> global=625, current 593:593
<0> [57.224912]  gem_eio-1113    3.... 48393796us : i915_request_add: rcs0 fence 5:626
<0> [57.224979]  gem_eio-1113    3d..1 48393802us : __i915_request_submit: rcs0 fence 5:626 -> global=626, current 593:593
<0> [57.225051]  gem_eio-1113    3.... 48393880us : i915_request_add: rcs0 fence 5:627
<0> [57.225115]  gem_eio-1113    3d..1 48393886us : __i915_request_submit: rcs0 fence 5:627 -> global=627, current 593:593
<0> [57.225183]  gem_eio-1113    3.... 48393963us : i915_request_add: rcs0 fence 5:628
<0> [57.225251]  gem_eio-1113    3d..1 48393968us : __i915_request_submit: rcs0 fence 5:628 -> global=628, current 593:593
<0> [57.225322]  gem_eio-1113    3.... 48394047us : i915_request_add: rcs0 fence 5:629
<0> [57.225389]  gem_eio-1113    3d..1 48394052us : __i915_request_submit: rcs0 fence 5:629 -> global=629, current 593:593
<0> [57.225461]  gem_eio-1113    3.... 48394132us : i915_request_add: rcs0 fence 5:630
<0> [57.225527]  gem_eio-1113    3d..1 48394138us : __i915_request_submit: rcs0 fence 5:630 -> global=630, current 593:593
<0> [57.225597]  gem_eio-1113    3.... 48394216us : i915_request_add: rcs0 fence 5:631
<0> [57.225663]  gem_eio-1113    3d..1 48394221us : __i915_request_submit: rcs0 fence 5:631 -> global=631, current 593:593
<0> [57.225733]  gem_eio-1113    3.... 48394326us : i915_request_add: rcs0 fence 5:632
<0> [57.225801]  gem_eio-1113    3d..1 48394332us : __i915_request_submit: rcs0 fence 5:632 -> global=632, current 593:593
<0> [57.225870]  gem_eio-1113    3.... 48394413us : i915_request_add: rcs0 fence 5:633
<0> [57.225937]  gem_eio-1113    3d..1 48394419us : __i915_request_submit: rcs0 fence 5:633 -> global=633, current 593:593
<0> [57.226007]  gem_eio-1113    3.... 48394497us : i915_request_add: rcs0 fence 5:634
<0> [57.226074]  gem_eio-1113    3d..1 48394502us : __i915_request_submit: rcs0 fence 5:634 -> global=634, current 593:593
<0> [57.226144]  gem_eio-1113    3.... 48394580us : i915_request_add: rcs0 fence 5:635
<0> [57.226212]  gem_eio-1113    3d..1 48394586us : __i915_request_submit: rcs0 fence 5:635 -> global=635, current 593:593
<0> [57.226281]  gem_eio-1113    3.... 48394663us : i915_request_add: rcs0 fence 5:636
<0> [57.226348]  gem_eio-1113    3d..1 48394669us : __i915_request_submit: rcs0 fence 5:636 -> global=636, current 593:593
<0> [57.226419]  gem_eio-1113    3.... 48394746us : i915_request_add: rcs0 fence 5:637
<0> [57.226486]  gem_eio-1113    3d..1 48394752us : __i915_request_submit: rcs0 fence 5:637 -> global=637, current 593:593
<0> [57.226555]  gem_eio-1113    3.... 48394830us : i915_request_add: rcs0 fence 5:638
<0> [57.226622]  gem_eio-1113    3d..1 48394836us : __i915_request_submit: rcs0 fence 5:638 -> global=638, current 593:593
<0> [57.226692]  gem_eio-1113    3.... 48394913us : i915_request_add: rcs0 fence 5:639
<0> [57.226759]  gem_eio-1113    3d..1 48394919us : __i915_request_submit: rcs0 fence 5:639 -> global=639, current 593:593
<0> [57.226829]  gem_eio-1113    3.... 48395006us : i915_request_add: rcs0 fence 5:640
<0> [57.226896]  gem_eio-1113    3d..1 48395011us : __i915_request_submit: rcs0 fence 5:640 -> global=640, current 593:593
<0> [57.226967]  gem_eio-1113    3.... 48395089us : i915_request_add: rcs0 fence 5:641
<0> [57.227037]  gem_eio-1113    3d..1 48395095us : __i915_request_submit: rcs0 fence 5:641 -> global=641, current 593:593
<0> [57.227104]  gem_eio-1113    3.... 48395173us : i915_request_add: rcs0 fence 5:642
<0> [57.227168]  gem_eio-1113    3d..1 48395178us : __i915_request_submit: rcs0 fence 5:642 -> global=642, current 593:593
<0> [57.227239]  gem_eio-1113    3.... 48395256us : i915_request_add: rcs0 fence 5:643
<0> [57.227308]  gem_eio-1113    3d..1 48395262us : __i915_request_submit: rcs0 fence 5:643 -> global=643, current 593:593
<0> [57.227377]  gem_eio-1113    3.... 48395369us : i915_request_add: rcs0 fence 5:644
<0> [57.227442]  gem_eio-1113    3d..1 48395377us : __i915_request_submit: rcs0 fence 5:644 -> global=644, current 593:593
<0> [57.227512]  gem_eio-1113    3.... 48395436us : i915_request_add: rcs0 fence 5:645
<0> [57.227580]  gem_eio-1113    3d..1 48395440us : __i915_request_submit: rcs0 fence 5:645 -> global=645, current 593:593
<0> [57.227644]  gem_eio-1113    3.... 48395497us : i915_request_add: rcs0 fence 5:646
<0> [57.227713]  gem_eio-1113    3d..1 48395501us : __i915_request_submit: rcs0 fence 5:646 -> global=646, current 593:593
<0> [57.227783]  gem_eio-1113    3.... 48395560us : i915_request_add: rcs0 fence 5:647
<0> [57.227853]  gem_eio-1113    3d..1 48395565us : __i915_request_submit: rcs0 fence 5:647 -> global=647, current 593:593
<0> [57.227926]  gem_eio-1113    3.... 48395622us : i915_request_add: rcs0 fence 5:648
<0> [57.227996]  gem_eio-1113    3d..1 48395627us : __i915_request_submit: rcs0 fence 5:648 -> global=648, current 593:593
<0> [57.228068]  gem_eio-1113    3.... 48395699us : i915_request_add: rcs0 fence 5:649
<0> [57.228136]  gem_eio-1113    3d..1 48395704us : __i915_request_submit: rcs0 fence 5:649 -> global=649, current 593:593
<0> [57.228206]  gem_eio-1113    3.... 48395760us : i915_request_add: rcs0 fence 5:650
<0> [57.228271]  gem_eio-1113    3d..1 48395765us : __i915_request_submit: rcs0 fence 5:650 -> global=650, current 593:593
<0> [57.228337]  gem_eio-1113    3.... 48395821us : i915_request_add: rcs0 fence 5:651
<0> [57.228406]  gem_eio-1113    3d..1 48395825us : __i915_request_submit: rcs0 fence 5:651 -> global=651, current 593:593
<0> [57.228477]  gem_eio-1113    3.... 48395882us : i915_request_add: rcs0 fence 5:652
<0> [57.228544]  gem_eio-1113    3d..1 48395886us : __i915_request_submit: rcs0 fence 5:652 -> global=652, current 593:593
<0> [57.228616]  gem_eio-1113    3.... 48395942us : i915_request_add: rcs0 fence 5:653
<0> [57.228684]  gem_eio-1113    3d..1 48395946us : __i915_request_submit: rcs0 fence 5:653 -> global=653, current 593:593
<0> [57.228757]  gem_eio-1113    3.... 48396003us : i915_request_add: rcs0 fence 5:654
<0> [57.228827]  gem_eio-1113    3d..1 48396007us : __i915_request_submit: rcs0 fence 5:654 -> global=654, current 593:593
<0> [57.228898]  gem_eio-1113    3.... 48396067us : i915_request_add: rcs0 fence 5:655
<0> [57.228969]  gem_eio-1113    3d..1 48396072us : __i915_request_submit: rcs0 fence 5:655 -> global=655, current 593:593
<0> [57.229041]  gem_eio-1113    3.... 48396146us : i915_request_add: rcs0 fence 5:656
<0> [57.229110]  gem_eio-1113    3d..1 48396151us : __i915_request_submit: rcs0 fence 5:656 -> global=656, current 593:593
<0> [57.229182]  gem_eio-1113    3.... 48396229us : i915_request_add: rcs0 fence 5:657
<0> [57.229251]  gem_eio-1113    3d..1 48396235us : __i915_request_submit: rcs0 fence 5:657 -> global=657, current 593:593
<0> [57.229323]  gem_eio-1113    3.... 48396347us : i915_request_add: rcs0 fence 5:658
<0> [57.229393]  gem_eio-1113    3d..1 48396353us : __i915_request_submit: rcs0 fence 5:658 -> global=658, current 593:593
<0> [57.229463]  rtcwake-1121    3.... 48640417us : i915_gem_suspend: 
<0> [57.229524]  rtcwake-1121    3.... 48640641us : i915_gem_switch_to_kernel_context: awake?=yes
<0> [57.229725]  rtcwake-1121    3.... 48640651us : i915_gem_switch_to_kernel_context: emit barrier on rcs0
<0> [57.229859]  rtcwake-1121    3.... 48640864us : i915_gem_switch_to_kernel_context: add barrier on rcs0 for 5:658
<0> [57.229930]  rtcwake-1121    3.... 48640884us : i915_request_add: rcs0 fence 5:659
<0> [57.230000]  rtcwake-1121    3d..1 48640960us : __i915_request_submit: rcs0 fence 5:659 -> global=659, current 593:593
<0> [57.230070]  rtcwake-1121    3.... 48641066us : i915_gem_wait_for_idle: flags=13 (locked), timeout=9223372036854775807 (forever)
<0> [57.230135] kworker/-249     3.... 56430221us : i915_reset: flags=15
<0> [57.230202] kworker/-249     3.... 56430229us : intel_engine_stop_cs: rcs0
<0> [57.230270] kworker/-249     3.... 56430230us : intel_engine_stop_cs: vcs0
<0> [57.230329] kworker/-249     3.... 56430537us : __i915_gem_set_wedged.part.4: start
<0> [57.230399] kworker/-249     3.... 56430538us : intel_engine_stop_cs: rcs0
<0> [57.230466] kworker/-249     3.... 56430539us : intel_engine_stop_cs: vcs0
<0> [57.230525] kworker/-249     3.... 56430540us : intel_gpu_reset: engine_mask=ffffffff
<0> [57.230586] kworker/-249     3.... 56430930us : __i915_gem_set_wedged.part.4: end
<0> [57.230655] CPU:0 [LOST 3255 EVENTS]
 rtcwake-1121    0.... 56431893us : i915_request_retire: rcs0 fence 5:621, global=621, current 621:659
<0> [57.230733]  rtcwake-1121    0.... 56431897us : i915_request_retire: __retire_engine_request(rcs0) fence 5:621, global=621, current 621:659
<0> [57.230807]  rtcwake-1121    0.... 56431905us : i915_request_retire: rcs0 fence 5:622, global=622, current 622:659
<0> [57.230878]  rtcwake-1121    0.... 56431909us : i915_request_retire: __retire_engine_request(rcs0) fence 5:622, global=622, current 622:659
<0> [57.230954]  rtcwake-1121    0.... 56431916us : i915_request_retire: rcs0 fence 5:623, global=623, current 623:659
<0> [57.231025]  rtcwake-1121    0.... 56431920us : i915_request_retire: __retire_engine_request(rcs0) fence 5:623, global=623, current 623:659
<0> [57.231099]  rtcwake-1121    0.... 56431927us : i915_request_retire: rcs0 fence 5:624, global=624, current 624:659
<0> [57.231173]  rtcwake-1121    0.... 56431931us : i915_request_retire: __retire_engine_request(rcs0) fence 5:624, global=624, current 624:659
<0> [57.231247]  rtcwake-1121    0.... 56431939us : i915_request_retire: rcs0 fence 5:625, global=625, current 625:659
<0> [57.231320]  rtcwake-1121    0.... 56431943us : i915_request_retire: __retire_engine_request(rcs0) fence 5:625, global=625, current 625:659
<0> [57.231394]  rtcwake-1121    0.... 56431950us : i915_request_retire: rcs0 fence 5:626, global=626, current 626:659
<0> [57.231466]  rtcwake-1121    0.... 56431954us : i915_request_retire: __retire_engine_request(rcs0) fence 5:626, global=626, current 626:659
<0> [57.231540]  rtcwake-1121    0.... 56431962us : i915_request_retire: rcs0 fence 5:627, global=627, current 627:659
<0> [57.231612]  rtcwake-1121    0.... 56431966us : i915_request_retire: __retire_engine_request(rcs0) fence 5:627, global=627, current 627:659
<0> [57.231686]  rtcwake-1121    0.... 56431974us : i915_request_retire: rcs0 fence 5:628, global=628, current 628:659
<0> [57.231759]  rtcwake-1121    0.... 56431978us : i915_request_retire: __retire_engine_request(rcs0) fence 5:628, global=628, current 628:659
<0> [57.231833]  rtcwake-1121    0.... 56431985us : i915_request_retire: rcs0 fence 5:629, global=629, current 629:659
<0> [57.231906]  rtcwake-1121    0.... 56431989us : i915_request_retire: __retire_engine_request(rcs0) fence 5:629, global=629, current 629:659
<0> [57.231980]  rtcwake-1121    0.... 56431996us : i915_request_retire: rcs0 fence 5:630, global=630, current 630:659
<0> [57.232053]  rtcwake-1121    0.... 56432000us : i915_request_retire: __retire_engine_request(rcs0) fence 5:630, global=630, current 630:659
<0> [57.232129]  rtcwake-1121    0.... 56432008us : i915_request_retire: rcs0 fence 5:631, global=631, current 631:659
<0> [57.232200]  rtcwake-1121    0.... 56432012us : i915_request_retire: __retire_engine_request(rcs0) fence 5:631, global=631, current 631:659
<0> [57.232276]  rtcwake-1121    0.... 56432019us : i915_request_retire: rcs0 fence 5:632, global=632, current 632:659
<0> [57.232348]  rtcwake-1121    0.... 56432023us : i915_request_retire: __retire_engine_request(rcs0) fence 5:632, global=632, current 632:659
<0> [57.232422]  rtcwake-1121    0.... 56432031us : i915_request_retire: rcs0 fence 5:633, global=633, current 633:659
<0> [57.232495]  rtcwake-1121    0.... 56432035us : i915_request_retire: __retire_engine_request(rcs0) fence 5:633, global=633, current 633:659
<0> [57.232567]  rtcwake-1121    0.... 56432042us : i915_request_retire: rcs0 fence 5:634, global=634, current 634:659
<0> [57.232639]  rtcwake-1121    0.... 56432046us : i915_request_retire: __retire_engine_request(rcs0) fence 5:634, global=634, current 634:659
<0> [57.232714]  rtcwake-1121    0.... 56432054us : i915_request_retire: rcs0 fence 5:635, global=635, current 635:659
<0> [57.232785]  rtcwake-1121    0.... 56432058us : i915_request_retire: __retire_engine_request(rcs0) fence 5:635, global=635, current 635:659
<0> [57.232860]  rtcwake-1121    0.... 56432065us : i915_request_retire: rcs0 fence 5:636, global=636, current 636:659
<0> [57.232932]  rtcwake-1121    0.... 56432069us : i915_request_retire: __retire_engine_request(rcs0) fence 5:636, global=636, current 636:659
<0> [57.233006]  rtcwake-1121    0.... 56432076us : i915_request_retire: rcs0 fence 5:637, global=637, current 637:659
<0> [57.233079]  rtcwake-1121    0.... 56432080us : i915_request_retire: __retire_engine_request(rcs0) fence 5:637, global=637, current 637:659
<0> [57.233153]  rtcwake-1121    0.... 56432088us : i915_request_retire: rcs0 fence 5:638, global=638, current 638:659
<0> [57.233225]  rtcwake-1121    0.... 56432092us : i915_request_retire: __retire_engine_request(rcs0) fence 5:638, global=638, current 638:659
<0> [57.233301]  rtcwake-1121    0.... 56432099us : i915_request_retire: rcs0 fence 5:639, global=639, current 639:659
<0> [57.233372]  rtcwake-1121    0.... 56432103us : i915_request_retire: __retire_engine_request(rcs0) fence 5:639, global=639, current 639:659
<0> [57.233447]  rtcwake-1121    0.... 56432110us : i915_request_retire: rcs0 fence 5:640, global=640, current 640:659
<0> [57.233518]  rtcwake-1121    0.... 56432115us : i915_request_retire: __retire_engine_request(rcs0) fence 5:640, global=640, current 640:659
<0> [57.233592]  rtcwake-1121    0.... 56432122us : i915_request_retire: rcs0 fence 5:641, global=641, current 641:659
<0> [57.233665]  rtcwake-1121    0.... 56432126us : i915_request_retire: __retire_engine_request(rcs0) fence 5:641, global=641, current 641:659
<0> [57.233739]  rtcwake-1121    0.... 56432133us : i915_request_retire: rcs0 fence 5:642, global=642, current 642:659
<0> [57.233811]  rtcwake-1121    0.... 56432137us : i915_request_retire: __retire_engine_request(rcs0) fence 5:642, global=642, current 642:659
<0> [57.233886]  rtcwake-1121    0.... 56432145us : i915_request_retire: rcs0 fence 5:643, global=643, current 643:659
<0> [57.233956]  rtcwake-1121    0.... 56432149us : i915_request_retire: __retire_engine_request(rcs0) fence 5:643, global=643, current 643:659
<0> [57.234031]  rtcwake-1121    0.... 56432156us : i915_request_retire: rcs0 fence 5:644, global=644, current 644:659
<0> [57.234104]  rtcwake-1121    0.... 56432160us : i915_request_retire: __retire_engine_request(rcs0) fence 5:644, global=644, current 644:659
<0> [57.234177]  rtcwake-1121    0.... 56432168us : i915_request_retire: rcs0 fence 5:645, global=645, current 645:659
<0> [57.234250]  rtcwake-1121    0.... 56432172us : i915_request_retire: __retire_engine_request(rcs0) fence 5:645, global=645, current 645:659
<0> [57.234324]  rtcwake-1121    0.... 56432179us : i915_request_retire: rcs0 fence 5:646, global=646, current 646:659
<0> [57.234397]  rtcwake-1121    0.... 56432183us : i915_request_retire: __retire_engine_request(rcs0) fence 5:646, global=646, current 646:659
<0> [57.234471]  rtcwake-1121    0.... 56432190us : i915_request_retire: rcs0 fence 5:647, global=647, current 647:659
<0> [57.234540]  rtcwake-1121    0.... 56432195us : i915_request_retire: __retire_engine_request(rcs0) fence 5:647, global=647, current 647:659
<0> [57.234614]  rtcwake-1121    0.... 56432202us : i915_request_retire: rcs0 fence 5:648, global=648, current 648:659
<0> [57.234687]  rtcwake-1121    0.... 56432206us : i915_request_retire: __retire_engine_request(rcs0) fence 5:648, global=648, current 648:659
<0> [57.234760]  rtcwake-1121    0.... 56432213us : i915_request_retire: rcs0 fence 5:649, global=649, current 649:659
<0> [57.234833]  rtcwake-1121    0.... 56432217us : i915_request_retire: __retire_engine_request(rcs0) fence 5:649, global=649, current 649:659
<0> [57.234907]  rtcwake-1121    0.... 56432225us : i915_request_retire: rcs0 fence 5:650, global=650, current 650:659
<0> [57.234984]  rtcwake-1121    0.... 56432229us : i915_request_retire: __retire_engine_request(rcs0) fence 5:650, global=650, current 650:659
<0> [57.235060]  rtcwake-1121    0.... 56432236us : i915_request_retire: rcs0 fence 5:651, global=651, current 651:659
<0> [57.235131]  rtcwake-1121    0.... 56432240us : i915_request_retire: __retire_engine_request(rcs0) fence 5:651, global=651, current 651:659
<0> [57.235206]  rtcwake-1121    0.... 56432248us : i915_request_retire: rcs0 fence 5:652, global=652, current 652:659
<0> [57.235279]  rtcwake-1121    0.... 56432252us : i915_request_retire: __retire_engine_request(rcs0) fence 5:652, global=652, current 652:659
<0> [57.235352]  rtcwake-1121    0.... 56432259us : i915_request_retire: rcs0 fence 5:653, global=653, current 653:659
<0> [57.235425]  rtcwake-1121    0.... 56432300us : i915_request_retire: __retire_engine_request(rcs0) fence 5:653, global=653, current 653:659
<0> [57.235499]  rtcwake-1121    0.... 56432308us : i915_request_retire: rcs0 fence 5:654, global=654, current 654:659
<0> [57.235571]  rtcwake-1121    0.... 56432312us : i915_request_retire: __retire_engine_request(rcs0) fence 5:654, global=654, current 654:659
<0> [57.235647]  rtcwake-1121    0.... 56432320us : i915_request_retire: rcs0 fence 5:655, global=655, current 655:659
<0> [57.235718]  rtcwake-1121    0.... 56432324us : i915_request_retire: __retire_engine_request(rcs0) fence 5:655, global=655, current 655:659
<0> [57.235793]  rtcwake-1121    0.... 56432332us : i915_request_retire: rcs0 fence 5:656, global=656, current 656:659
<0> [57.235866]  rtcwake-1121    0.... 56432336us : i915_request_retire: __retire_engine_request(rcs0) fence 5:656, global=656, current 656:659
<0> [57.235939]  rtcwake-1121    0.... 56432343us : i915_request_retire: rcs0 fence 5:657, global=657, current 657:659
<0> [57.236012]  rtcwake-1121    0.... 56432347us : i915_request_retire: __retire_engine_request(rcs0) fence 5:657, global=657, current 657:659
<0> [57.236087]  rtcwake-1121    0.... 56432355us : i915_request_retire: rcs0 fence 5:658, global=658, current 658:659
<0> [57.236158]  rtcwake-1121    0.... 56432641us : i915_request_retire: __retire_engine_request(rcs0) fence 5:658, global=658, current 658:659
<0> [57.236234]  rtcwake-1121    0.... 56432647us : i915_request_retire: rcs0 fence 5:659, global=659, current 659:659
<0> [57.236305]  rtcwake-1121    0.... 56432649us : i915_request_retire: marking rcs0 as inactive
<0> [57.236375]  rtcwake-1121    0.... 56432652us : i915_request_retire: __retire_engine_request(rcs0) fence 5:659, global=659, current 659:659
<0> [57.236448]  rtcwake-1121    0.... 56432655us : i915_gem_park: 
<0> [57.236512]  rtcwake-1121    0.... 56432888us : i915_gem_wait_for_idle: flags=12 (locked), timeout=9223372036854775807 (forever)
<0> [57.236581] kworker/-163     2.... 56533288us : i915_gem_switch_to_kernel_context: awake?=yes
<0> [57.236650] kworker/-163     2.... 56533290us : i915_gem_idle_work_handler: active_requests=0 (after switch-to-kernel-context)
<0> [57.236718] kworker/-163     2.... 56533294us : __i915_gem_park: 
<0> [57.236783] kworker/-1131    0.... 56906316us : i915_gem_sanitize: 
<0> [57.236841] kworker/-1131    0.... 56906366us : __i915_gem_unset_wedged.part.3: start
<0> [57.236908] kworker/-1131    0.... 56906371us : intel_engines_sanitize: 
<0> [57.236967] kworker/-1131    0.... 56906373us : intel_gpu_reset: engine_mask=ffffffff
<0> [57.237172] kworker/-1131    0.... 56906383us : __i915_gem_unset_wedged.part.3: end
<0> [57.237241] kworker/-1131    0.... 56906384us : intel_engines_sanitize: 
<0> [57.237299] kworker/-1131    0.... 56906384us : intel_gpu_reset: engine_mask=ffffffff
<0> [57.237512] kworker/-1165    0.... 57009628us : intel_engines_sanitize: 
<0> [57.237572] kworker/-1165    0.... 57009632us : intel_gpu_reset: engine_mask=ffffffff
<0> [57.237782] kworker/-1162    0.... 57012419us : i915_gem_sanitize: 
<0> [57.237848] kworker/-1162    0.... 57012421us : intel_engines_sanitize: 
<0> [57.237907] kworker/-1162    0.... 57012422us : intel_gpu_reset: engine_mask=ffffffff
<0> [57.238131] kworker/-1162    0.... 57013695us : i915_gem_resume: 
<0> [57.238193] kworker/-1162    0.... 57020188us : i915_gem_switch_to_kernel_context: awake?=no
<0> [57.238257] kworker/-1162    0.... 57020190us : i915_gem_switch_to_kernel_context: emit barrier on rcs0
<0> [57.238326] kworker/-1162    0.... 57020191us : i915_gem_unpark: 
<0> [57.238393] kworker/-1162    0.... 57020410us : i915_request_add: rcs0 fence 5:660
<0> [57.238459] kworker/-1162    0.... 57020424us : i915_request_add: marking rcs0 as active
<0> [57.238529] kworker/-1162    0d..1 57020440us : __i915_request_submit: rcs0 fence 5:660 -> global=660, current 593:659
<0> [57.238599] kworker/-1162    0.... 57020482us : i915_gem_switch_to_kernel_context: emit barrier on vcs0
<0> [57.238669] kworker/-1162    0.... 57020492us : i915_request_add: vcs0 fence 8:939
<0> [57.238740] kworker/-1162    0.... 57020493us : i915_request_add: marking vcs0 as active
<0> [57.238810] kworker/-1162    0d..1 57020496us : __i915_request_submit: vcs0 fence 8:939 -> global=939, current 938:938
<0> [57.238874]  gem_eio-1113    3.... 57317988us : i915_reset: flags=15
<0> [57.238942]  gem_eio-1113    3.... 57318014us : intel_engine_stop_cs: rcs0
<0> [57.239009]  gem_eio-1113    3.... 57318016us : intel_engine_stop_cs: vcs0
<0> [57.239066]  gem_eio-1113    3.... 57318019us : intel_gpu_reset: engine_mask=ffffffff
<0> [57.239279] kworker/-162     1.... 57318476us : i915_request_add: rcs0 fence 5:661
<0> [57.239349] kworker/-162     1d..1 57318486us : __i915_request_submit: rcs0 fence 5:661 -> global=661, current 660:660
<0> [57.239419] kworker/-162     1.... 57318497us : i915_request_retire_upto: rcs0 fence 5:660, global=660, current 660:660
<0> [57.239492] kworker/-162     1.... 57318499us : i915_request_retire: rcs0 fence 5:660, global=660, current 661:661
<0> [57.239564] kworker/-162     1.... 57318503us : i915_request_retire: __retire_engine_request(rcs0) fence 5:660, global=660, current 661:661
<0> [57.239636] kworker/-162     1.... 57318800us : i915_request_add: vcs0 fence 8:940
<0> [57.239706] kworker/-162     1d..1 57318808us : __i915_request_submit: vcs0 fence 8:940 -> global=940, current 939:939
<0> [57.239778] kworker/-162     1.... 57318816us : i915_request_retire_upto: vcs0 fence 8:939, global=939, current 940:940
<0> [57.239850] kworker/-162     1.... 57318818us : i915_request_retire: vcs0 fence 8:939, global=939, current 940:940
<0> [57.239923] kworker/-162     1.... 57318821us : i915_request_retire: __retire_engine_request(vcs0) fence 8:939, global=939, current 940:940
<0> [57.239987]  gem_eio-1171    0.... 57319500us : i915_reset: flags=15
<0> [57.240053]  gem_eio-1171    0.... 57319509us : intel_engine_stop_cs: rcs0
<0> [57.240121]  gem_eio-1171    0.... 57319511us : intel_engine_stop_cs: vcs0
<0> [57.240178]  gem_eio-1171    0.... 57319513us : intel_gpu_reset: engine_mask=ffffffff
<0> [57.240390]  gem_eio-1113    3.... 57319607us : i915_request_add: rcs0 fence 5:662
<0> [57.240459]  gem_eio-1113    3d..1 57319613us : __i915_request_submit: rcs0 fence 5:662 -> global=662, current 661:661
<0> [57.240531]  gem_eio-1113    3.... 57319620us : i915_request_retire_upto: rcs0 fence 5:661, global=661, current 661:661
<0> [57.240603]  gem_eio-1113    3.... 57319621us : i915_request_retire: rcs0 fence 5:661, global=661, current 661:661
<0> [57.240675]  gem_eio-1113    3.... 57319623us : i915_request_retire: __retire_engine_request(rcs0) fence 5:661, global=661, current 661:661
<0> [57.240749]  gem_eio-1113    3.... 57319785us : i915_request_retire: __retire_engine_request:189 GEM_BUG_ON(!i915_request_completed(rq))
<4> [57.241205] RIP: 0010:i915_request_retire+0x6fe/0xc80 [i915]
Comment 1 CI Bug Log 2019-02-21 15:34:35 UTC
The CI Bug Log issue associated to this bug has been updated.

### New filters associated

* ILK: igt@gem_eio@in-flight-suspend - incomplete - GEM_BUG_ON(!i915_request_completed(rq))
  - https://intel-gfx-ci.01.org/tree/drm-tip/drmtip_225/fi-ilk-650/igt@gem_eio@in-flight-suspend.html
Comment 2 Chris Wilson 2019-02-21 15:38:09 UTC
<0> [57.240531]  gem_eio-1113    3.... 57319620us : i915_request_retire_upto: rcs0 fence 5:661, global=661, current 661:661
<0> [57.240603]  gem_eio-1113    3.... 57319621us : i915_request_retire: rcs0 fence 5:661, global=661, current 661:661
<0> [57.240675]  gem_eio-1113    3.... 57319623us : i915_request_retire: __retire_engine_request(rcs0) fence 5:661, global=661, current 661:661
<0> [57.240749]  gem_eio-1113    3.... 57319785us : i915_request_retire: __retire_engine_request:189 GEM_BUG_ON(!i915_request_completed(rq))

so we are retiring this request; the seqno has been stable for over 1ms, then suddenly we bug out because it is no longer valid. Weird, weird, weird. I think we've mentioned in another bug about the concerns about gen5 breadcrumb stability, this doesn't quite feel like the same category. More like a stray write from elsewhere perhaps?
Comment 3 Chris Wilson 2019-02-26 18:07:04 UTC

*** This bug has been marked as a duplicate of bug 109720 ***
Comment 4 Chris Wilson 2019-02-26 18:08:22 UTC
Bad dupe, there's a dup somewhere out there, but it is not the same bug as affects the guc. (guc is preemption, this is screwy across reset)
Comment 5 Lakshmi 2019-03-02 22:24:20 UTC
https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_5685/fi-ilk-650/igt@i915_selftest@live_hangcheck.html

	
<3> [301.276303] __retire_engine_request:200 GEM_BUG_ON(!i915_request_completed(rq))
<2> [301.276490] kernel BUG at drivers/gpu/drm/i915/i915_request.c:200!
<4> [301.276717] RIP: 0010:i915_request_retire+0x6b8/0xc40 [i915]
<4> [301.276910]  i915_request_retire_upto+0xfb/0x2e0 [i915]
<4> [301.276980]  i915_request_add+0x3bd/0x9d0 [i915]
<0> [301.277190] CPU:3 [LOST 409765 EVENTS]
i915_sel-3848    3.... 291565923us : i915_request_add: rcs0 fence 9a3a:12050
<0> [301.277251] i915_sel-3848    3.... 291565924us : i915_request_add: marking rcs0 as active
<0> [301.277308] i915_sel-3848    3d..1 291565926us : __i915_request_submit: rcs0 fence 9a3a:12050 -> current 12049
<0> [301.277365] i915_sel-3848    3.... 291565936us : i915_request_retire_upto: rcs0 fence 9a3a:12050, current 12050
<0> [301.277423] i915_sel-3848    3.... 291565937us : i915_request_retire: rcs0 fence 9a3a:12050, current 12050
<0> [301.277480] i915_sel-3848    3.... 291565937us : i915_request_retire: marking rcs0 as inactive
<0> [301.277537] i915_sel-3848    3.... 291565940us : i915_request_retire: __retire_engine_request(rcs0) fence 9a3a:12050, current 12050
<0> [301.277594] i915_sel-3848    3.... 291565940us : i915_gem_park: 
<0> [301.277606] CPU:2 [LOST 1806368 EVENTS]
i915_sel-3874    2d..1 292216875us : 0xffffffffa01f1915: rcs0 fence 9a41:2 -> current 1
<0> [301.277621] i915_sel-3874    2.... 292216879us : 0xffffffffa01b7ce2: emit barrier on vcs0
<0> [301.277632] i915_sel-3874    2.... 292216886us : 0xffffffffa01f1c10: vcs0 fence 9a44:2
<0> [301.277644] i915_sel-3874    2.... 292216887us : 0xffffffffa01f2178: marking vcs0 as active
<0> [301.277655] i915_sel-3874    2d..1 292216889us : 0xffffffffa01f1915: vcs0 fence 9a44:2 -> current 1
<0> [301.277668] i915_sel-3874    2.... 292216893us : 0xffffffffa01d8e80: flags=2 (locked), timeout=200
<0> [301.277680] i915_sel-3874    2.... 292216902us : 0xffffffffa01ef203: vcs0 fence 9a44:2, current 2
<0> [301.277692] i915_sel-3874    2.... 292216903us : 0xffffffffa01ef934: marking vcs0 as inactive
<0> [301.277704] i915_sel-3874    2.... 292216904us : 0xffffffffa01ef4a8: __retire_engine_request(vcs0) fence 9a44:2, current 2
<0> [301.277718] i915_sel-3874    2.... 292216911us : 0xffffffffa01ef203: rcs0 fence 9a41:2, current 2
<0> [301.277729] i915_sel-3874    2.... 292216912us : 0xffffffffa01ef934: marking rcs0 as inactive
<0> [301.277741] i915_sel-3874    2.... 292216913us : 0xffffffffa01ef4a8: __retire_engine_request(rcs0) fence 9a41:2, current 2
<0> [301.277755] i915_sel-3874    2.... 292216914us : 0xffffffffa01d5130: 
<0> [301.277764] i915_sel-3874    2.... 292216921us : 0xffffffffa01d3220: 
<0> [301.277774] i915_sel-3874    2.... 292220447us : 0xffffffffa02af429: Running i915_gem_gtt_live_selftests/igt_ppgtt_alloc
<0> [301.277788] i915_sel-3874    2.... 292220462us : 0xffffffffa02af429: Running i915_gem_gtt_live_selftests/igt_ppgtt_lowlevel
<0> [301.277801] i915_sel-3874    2.... 292220475us : 0xffffffffa02af429: Running i915_gem_gtt_live_selftests/igt_ppgtt_drunk
<0> [301.277815] i915_sel-3874    2.... 292220487us : 0xffffffffa02af429: Running i915_gem_gtt_live_selftests/igt_ppgtt_walk
<0> [301.277828] i915_sel-3874    2.... 292220522us : 0xffffffffa02af429: Running i915_gem_gtt_live_selftests/igt_ppgtt_pot
<0> [301.277841] i915_sel-3874    2.... 292220536us : 0xffffffffa02af429: Running i915_gem_gtt_live_selftests/igt_ppgtt_fill
<0> [301.277854] i915_sel-3874    2.... 292220549us : 0xffffffffa02af429: Running i915_gem_gtt_live_selftests/igt_ppgtt_shrink
<0> [301.277868] i915_sel-3874    2.... 292220561us : 0xffffffffa02af429: Running i915_gem_gtt_live_selftests/igt_ppgtt_shrink_boom
<0> [301.277881] i915_sel-3874    2.... 292220574us : 0xffffffffa02af429: Running i915_gem_gtt_live_selftests/igt_ggtt_lowlevel
<0> [301.277895] i915_sel-3874    2.... 293230786us : 0xffffffffa02af429: Running i915_gem_gtt_live_selftests/igt_ggtt_drunk
<0> [301.277908] i915_sel-3874    3.... 294231621us : 0xffffffffa02af429: Running i915_gem_gtt_live_selftests/igt_ggtt_walk
<0> [301.277921] i915_sel-3874    3.... 295232532us : 0xffffffffa02af429: Running i915_gem_gtt_live_selftests/igt_ggtt_pot
<0> [301.277934] i915_sel-3874    3.... 296941206us : 0xffffffffa02af429: Running i915_gem_gtt_live_selftests/igt_ggtt_fill
<0> [301.277990] i915_sel-3901    3.... 298518316us : i915_gem_sanitize: 
<0> [301.278046] i915_sel-3901    3.... 298518320us : intel_engines_sanitize: 
<0> [301.278095] i915_sel-3901    3.... 298518321us : intel_gpu_reset: engine_mask=ffffffff
<0> [301.278151] i915_sel-3901    3.... 298538944us : i915_gem_unpark: 
<0> [301.278206] i915_sel-3901    3.... 298539446us : i915_request_add: rcs0 fence 9a48:1
<0> [301.278262] i915_sel-3901    3.... 298539524us : i915_request_add: marking rcs0 as active
<0> [301.278318] i915_sel-3901    3d..1 298539552us : __i915_request_submit: rcs0 fence 9a48:1 -> current 0
<0> [301.278375] i915_sel-3901    3.... 298539697us : i915_request_add: vcs0 fence 9a4b:1
<0> [301.278430] i915_sel-3901    3.... 298539698us : i915_request_add: marking vcs0 as active
<0> [301.278486] i915_sel-3901    3d..1 298539702us : __i915_request_submit: vcs0 fence 9a4b:1 -> current 0
<0> [301.278540] i915_sel-3901    3.... 298539708us : i915_gem_switch_to_kernel_context: awake?=yes
<0> [301.278596] i915_sel-3901    3.... 298539711us : i915_request_retire: vcs0 fence 9a4b:1, current 1
<0> [301.278652] i915_sel-3901    3.... 298539713us : i915_request_retire: marking vcs0 as inactive
<0> [301.278709] i915_sel-3901    3.... 298539714us : i915_request_retire: __retire_engine_request(vcs0) fence 9a4b:1, current 1
<0> [301.278767] i915_sel-3901    3.... 298539865us : i915_request_retire: rcs0 fence 9a48:1, current 1
<0> [301.278824] i915_sel-3901    3.... 298539866us : i915_request_retire: marking rcs0 as inactive
<0> [301.278881] i915_sel-3901    3.... 298539867us : i915_request_retire: __retire_engine_request(rcs0) fence 9a48:1, current 1
<0> [301.278937] i915_sel-3901    3.... 298539870us : i915_gem_park: 
<0> [301.278988] i915_sel-3901    3.... 298539882us : i915_gem_switch_to_kernel_context: emit barrier on rcs0
<0> [301.279043] i915_sel-3901    3.... 298539882us : i915_gem_unpark: 
<0> [301.279097] i915_sel-3901    3.... 298539894us : i915_request_add: rcs0 fence 9a48:2
<0> [301.279155] i915_sel-3901    3.... 298539895us : i915_request_add: marking rcs0 as active
<0> [301.279212] i915_sel-3901    3d..1 298539899us : __i915_request_submit: rcs0 fence 9a48:2 -> current 1
<0> [301.279266] i915_sel-3901    3.... 298539905us : i915_gem_switch_to_kernel_context: emit barrier on vcs0
<0> [301.279323] i915_sel-3901    3.... 298539915us : i915_request_add: vcs0 fence 9a4b:2
<0> [301.279378] i915_sel-3901    3.... 298539916us : i915_request_add: marking vcs0 as active
<0> [301.279435] i915_sel-3901    3d..1 298539920us : __i915_request_submit: vcs0 fence 9a4b:2 -> current 1
<0> [301.279491] i915_sel-3901    3.... 298539926us : i915_gem_wait_for_idle: flags=2 (locked), timeout=200
<0> [301.279547] i915_sel-3901    3.... 298539937us : i915_request_retire: vcs0 fence 9a4b:2, current 2
<0> [301.279604] i915_sel-3901    3.... 298539938us : i915_request_retire: marking vcs0 as inactive
<0> [301.279660] i915_sel-3901    3.... 298539939us : i915_request_retire: __retire_engine_request(vcs0) fence 9a4b:2, current 2
<0> [301.279718] i915_sel-3901    3.... 298539949us : i915_request_retire: rcs0 fence 9a48:2, current 2
<0> [301.279775] i915_sel-3901    3.... 298539950us : i915_request_retire: marking rcs0 as inactive
<0> [301.279832] i915_sel-3901    3.... 298539950us : i915_request_retire: __retire_engine_request(rcs0) fence 9a48:2, current 2
<0> [301.279888] i915_sel-3901    3.... 298539952us : i915_gem_park: 
<0> [301.279940] i915_sel-3901    3.... 298539964us : __i915_gem_park: 
<0> [301.279998] i915_sel-3901    3.... 298543442us : __i915_subtests: Running i915_gem_live_selftests/igt_gem_suspend
<0> [301.280054] i915_sel-3901    3.... 298543563us : i915_gem_unpark: 
<0> [301.280108] i915_sel-3901    3.... 298543865us : i915_request_add: rcs0 fence 9a48:3
<0> [301.280167] i915_sel-3901    3.... 298543868us : i915_request_add: marking rcs0 as active
<0> [301.280224] i915_sel-3901    3d..1 298543873us : __i915_request_submit: rcs0 fence 9a48:3 -> current 2
<0> [301.280281] i915_sel-3901    3.... 298543893us : i915_request_add: vcs0 fence 9a4b:3
<0> [301.280337] i915_sel-3901    3.... 298543895us : i915_request_add: marking vcs0 as active
<0> [301.280393] i915_sel-3901    3d..1 298543899us : __i915_request_submit: vcs0 fence 9a4b:3 -> current 2
<0> [301.280449] i915_sel-3901    3.... 298543904us : i915_gem_suspend: 
<0> [301.280500] i915_sel-3901    3.... 298543911us : i915_gem_switch_to_kernel_context: awake?=yes
<0> [301.280556] i915_sel-3901    3.... 298543914us : i915_request_retire: vcs0 fence 9a4b:3, current 3
<0> [301.280612] i915_sel-3901    3.... 298543915us : i915_request_retire: marking vcs0 as inactive
<0> [301.280669] i915_sel-3901    3.... 298543917us : i915_request_retire: __retire_engine_request(vcs0) fence 9a4b:3, current 3
<0> [301.280727] i915_sel-3901    3.... 298543933us : i915_request_retire: rcs0 fence 9a48:3, current 3
<0> [301.280783] i915_sel-3901    3.... 298543934us : i915_request_retire: marking rcs0 as inactive
<0> [301.280839] i915_sel-3901    3.... 298543935us : i915_request_retire: __retire_engine_request(rcs0) fence 9a48:3, current 3
<0> [301.280896] i915_sel-3901    3.... 298543938us : i915_gem_park: 
<0> [301.280946] i915_sel-3901    3.... 298543952us : i915_gem_switch_to_kernel_context: emit barrier on rcs0
<0> [301.281002] i915_sel-3901    3.... 298543953us : i915_gem_unpark: 
<0> [301.281056] i915_sel-3901    3.... 298543963us : i915_request_add: rcs0 fence 9a48:4
<0> [301.281111] i915_sel-3901    3.... 298543965us : i915_request_add: marking rcs0 as active
<0> [301.281177] i915_sel-3901    3d..1 298543968us : __i915_request_submit: rcs0 fence 9a48:4 -> current 3
<0> [301.281254] i915_sel-3901    3.... 298543974us : i915_gem_switch_to_kernel_context: emit barrier on vcs0
<0> [301.281336] i915_sel-3901    3.... 298543986us : i915_request_add: vcs0 fence 9a4b:4
<0> [301.281416] i915_sel-3901    3.... 298543987us : i915_request_add: marking vcs0 as active
<0> [301.281497] i915_sel-3901    3d..1 298543991us : __i915_request_submit: vcs0 fence 9a4b:4 -> current 3
<0> [301.281577] i915_sel-3901    3.... 298543996us : i915_gem_wait_for_idle: flags=13 (locked), timeout=9223372036854775807 (forever)
<0> [301.281661] i915_sel-3901    3.... 298544008us : i915_request_retire: vcs0 fence 9a4b:4, current 4
<0> [301.281742] i915_sel-3901    3.... 298544009us : i915_request_retire: marking vcs0 as inactive
<0> [301.281821] i915_sel-3901    3.... 298544010us : i915_request_retire: __retire_engine_request(vcs0) fence 9a4b:4, current 4
<0> [301.281905] i915_sel-3901    3.... 298544024us : i915_request_retire: rcs0 fence 9a48:4, current 4
<0> [301.281986] i915_sel-3901    3.... 298544025us : i915_request_retire: marking rcs0 as inactive
<0> [301.282069] i915_sel-3901    3.... 298544027us : i915_request_retire: __retire_engine_request(rcs0) fence 9a48:4, current 4
<0> [301.282149] i915_sel-3901    3.... 298544029us : i915_gem_park: 
<0> [301.282226] i915_sel-3901    3.... 298544049us : i915_gem_wait_for_idle: flags=12 (locked), timeout=9223372036854775807 (forever)
<0> [301.282304] kworker/-2431    3.... 298646743us : i915_gem_switch_to_kernel_context: awake?=yes
<0> [301.282384] kworker/-2431    3.... 298646747us : i915_gem_idle_work_handler: active_requests=0 (after switch-to-kernel-context)
<0> [301.282468] kworker/-2431    3.... 298646765us : __i915_gem_park: 
<0> [301.282544] kworker/-2431    2.... 298790593us : i915_gem_switch_to_kernel_context: awake?=yes
<0> [301.282623] kworker/-2431    2.... 298790595us : i915_gem_idle_work_handler: active_requests=0 (after switch-to-kernel-context)
<0> [301.282705] kworker/-2431    2.... 298790605us : __i915_gem_park: 
<0> [301.282780] kworker/-2431    3.... 298926559us : i915_gem_switch_to_kernel_context: awake?=yes
<0> [301.282860] kworker/-2431    3.... 298926563us : i915_gem_idle_work_handler: active_requests=0 (after switch-to-kernel-context)
<0> [301.282941] kworker/-2431    3.... 298926576us : __i915_gem_park: 
<0> [301.283019] i915_sel-3901    2.... 298927344us : i915_gem_sanitize: 
<0> [301.283098] i915_sel-3901    2.... 298927347us : intel_engines_sanitize: 
<0> [301.283170] i915_sel-3901    2.... 298927348us : intel_gpu_reset: engine_mask=ffffffff
<0> [301.283254] i915_sel-3901    2d..1 298927353us : reset_ring: rcs0 stalled? no
<0> [301.283336] i915_sel-3901    2d..1 298927354us : reset_ring: vcs0 stalled? no
<0> [301.283354] i915_sel-3926    2.... 299478228us : 0xffffffffa02af429: Running i915_gem_evict_live_selftests/igt_evict_contexts
<0> [301.283436] CPU:0 [LOST 985281 EVENTS]
i915_sel-3952    0.... 300087606us : i915_request_retire: marking vcs0 as inactive
<0> [301.283522] i915_sel-3952    0.... 300087607us : i915_request_retire: __retire_engine_request(vcs0) fence 9a59:2, current 2
<0> [301.283603] i915_sel-3952    0.... 300087619us : i915_request_retire: rcs0 fence 9a56:2, current 2
<0> [301.283684] i915_sel-3952    0.... 300087620us : i915_request_retire: marking rcs0 as inactive
<0> [301.283768] i915_sel-3952    0.... 300087621us : i915_request_retire: __retire_engine_request(rcs0) fence 9a56:2, current 2
<0> [301.283852] i915_sel-3952    0.... 300087623us : i915_gem_park: 
<0> [301.283929] i915_sel-3952    0.... 300087635us : __i915_gem_park: 
<0> [301.284007] i915_sel-3952    2.... 300133494us : i915_gem_sanitize: 
<0> [301.284088] i915_sel-3952    2.... 300133496us : intel_engines_sanitize: 
<0> [301.284161] i915_sel-3952    2.... 300133519us : intel_gpu_reset: engine_mask=ffffffff
<0> [301.284247] i915_sel-3952    2d..1 300133524us : reset_ring: rcs0 stalled? no
<0> [301.284330] i915_sel-3952    2d..1 300133525us : reset_ring: vcs0 stalled? no
<0> [301.284348] i915_sel-3978    2.... 300681040us : 0xffffffffa01e1170: 
<0> [301.284363] i915_sel-3978    2.... 300681044us : 0xffffffffa0209cf0: 
<0> [301.284379] i915_sel-3978    2.... 300681045us : 0xffffffffa01810e4: engine_mask=ffffffff
<0> [301.284397] i915_sel-3978    0.... 300708063us : 0xffffffffa02af429: Running i915_gem_context_live_selftests/igt_switch_to_kernel_context
<0> [301.284420] i915_sel-3978    0.... 300708083us : 0xffffffffa01b7ef5: Testing rcs0
<0> [301.284436] i915_sel-3978    0.... 300708085us : 0xffffffffa01d5200: 
<0> [301.284452] i915_sel-3978    0.... 300708394us : 0xffffffffa01f1c10: rcs0 fence 9a5d:3
<0> [301.284470] i915_sel-3978    0.... 300708396us : 0xffffffffa01f2178: marking rcs0 as active
<0> [301.284488] i915_sel-3978    0d..1 300708402us : 0xffffffffa01f1915: rcs0 fence 9a5d:3 -> current 2
<0> [301.284507] i915_sel-3978    0.... 300708410us : 0xffffffffa01b7c20: awake?=yes
<0> [301.284523] i915_sel-3978    0.... 300708412us : 0xffffffffa01b3489: last request for rcs0 on engine rcs0: 9a5d:3
<0> [301.284541] i915_sel-3978    0.... 300708413us : 0xffffffffa01b3987: rcs0 needs barrier for 9a5d:3
<0> [301.284557] i915_sel-3978    0.... 300708413us : 0xffffffffa01b7ce2: emit barrier on rcs0
<0> [301.284573] i915_sel-3978    0.... 300708426us : 0xffffffffa01b3489: last request for rcs0 on engine rcs0: 9a5d:3
<0> [301.284591] i915_sel-3978    0.... 300708427us : 0xffffffffa01b7d64: add barrier on rcs0 for 9a5d:3
<0> [301.284607] i915_sel-3978    0.... 300708438us : 0xffffffffa01f1c10: rcs0 fence 9a5d:4
<0> [301.284623] i915_sel-3978    0d..1 300708443us : 0xffffffffa01f1915: rcs0 fence 9a5d:4 -> current 3
<0> [301.284639] i915_sel-3978    0.... 300708450us : 0xffffffffa01f00e4: rcs0 fence 9a5d:3, current 3
<0> [301.284655] i915_sel-3978    0.... 300708452us : 0xffffffffa01ef203: rcs0 fence 9a5d:3, current 3
<0> [301.284671] i915_sel-3978    0.... 300708454us : 0xffffffffa01ef4a8: __retire_engine_request(rcs0) fence 9a5d:3, current 4
<0> [301.284690] i915_sel-3978    0.... 300708587us : 0xffffffffa01b3489: last request for rcs0 on engine rcs0: 9a5d:4
<0> [301.284708] i915_sel-3978    0.... 300708588us : 0xffffffffa01d8e80: flags=2 (locked), timeout=9223372036854775807 (forever)
<0> [301.284726] i915_sel-3978    0.... 300708601us : 0xffffffffa01ef203: rcs0 fence 9a5d:4, current 4
<0> [301.284742] i915_sel-3978    0.... 300708603us : 0xffffffffa01ef934: marking rcs0 as inactive
<0> [301.284759] i915_sel-3978    0.... 300708604us : 0xffffffffa01ef4a8: __retire_engine_request(rcs0) fence 9a5d:4, current 4
<0> [301.284776] i915_sel-3978    0.... 300708607us : 0xffffffffa01d5130: 
<0> [301.284790] i915_sel-3978    0.... 300708623us : 0xffffffffa01b7c20: awake?=yes
<0> [301.284804] i915_sel-3978    0.... 300708624us : 0xffffffffa01b7ef5: Testing vcs0
<0> [301.284818] i915_sel-3978    0.... 300708624us : 0xffffffffa01d5200: 
<0> [301.284832] i915_sel-3978    0.... 300708635us : 0xffffffffa01f1c10: vcs0 fence 9a60:3
<0> [301.284847] i915_sel-3978    0.... 300708636us : 0xffffffffa01f2178: marking vcs0 as active
<0> [301.284863] i915_sel-3978    0d..1 300708640us : 0xffffffffa01f1915: vcs0 fence 9a60:3 -> current 2
<0> [301.284880] i915_sel-3978    0.... 300708645us : 0xffffffffa01b7c20: awake?=yes
<0> [301.284894] i915_sel-3978    0.... 300708647us : 0xffffffffa01ef203: vcs0 fence 9a60:3, current 3
<0> [301.284910] i915_sel-3978    0.... 300708648us : 0xffffffffa01ef934: marking vcs0 as inactive
<0> [301.284926] i915_sel-3978    0.... 300708649us : 0xffffffffa01ef4a8: __retire_engine_request(vcs0) fence 9a60:3, current 3
<0> [301.284944] i915_sel-3978    0.... 300708651us : 0xffffffffa01d5130: 
<0> [301.284958] i915_sel-3978    0.... 300708664us : 0xffffffffa01b7ce2: emit barrier on vcs0
<0> [301.284973] i915_sel-3978    0.... 300708665us : 0xffffffffa01d5200: 
<0> [301.284986] i915_sel-3978    0.... 300708676us : 0xffffffffa01f1c10: vcs0 fence 9a60:4
<0> [301.285002] i915_sel-3978    0.... 300708677us : 0xffffffffa01f2178: marking vcs0 as active
<0> [301.285018] i915_sel-3978    0d..1 300708681us : 0xffffffffa01f1915: vcs0 fence 9a60:4 -> current 3
<0> [301.285034] i915_sel-3978    0.... 300708686us : 0xffffffffa01b3489: last request for vcs0 on engine vcs0: 9a60:4
<0> [301.285052] i915_sel-3978    0.... 300708687us : 0xffffffffa01d8e80: flags=2 (locked), timeout=9223372036854775807 (forever)
<0> [301.285071] i915_sel-3978    0.... 300708696us : 0xffffffffa01ef203: vcs0 fence 9a60:4, current 4
<0> [301.285087] i915_sel-3978    0.... 300708697us : 0xffffffffa01ef934: marking vcs0 as inactive
<0> [301.285104] i915_sel-3978    0.... 300708698us : 0xffffffffa01ef4a8: __retire_engine_request(vcs0) fence 9a60:4, current 4
<0> [301.285121] i915_sel-3978    0.... 300708700us : 0xffffffffa01d5130: 
<0> [301.285134] i915_sel-3978    0.... 300708711us : 0xffffffffa01b7c20: awake?=yes
<0> [301.285150] i915_sel-3978    0.... 300708712us : 0xffffffffa01b7ef5: Testing all
<0> [301.285165] i915_sel-3978    0.... 300708712us : 0xffffffffa01d5200: 
<0> [301.285178] i915_sel-3978    0.... 300708723us : 0xffffffffa01f1c10: rcs0 fence 9a5d:5
<0> [301.285193] i915_sel-3978    0.... 300708725us : 0xffffffffa01f2178: marking rcs0 as active
<0> [301.285210] i915_sel-3978    0d..1 300708729us : 0xffffffffa01f1915: rcs0 fence 9a5d:5 -> current 4
<0> [301.285226] i915_sel-3978    0.... 300708745us : 0xffffffffa01f1c10: vcs0 fence 9a60:5
<0> [301.285241] i915_sel-3978    0.... 300708746us : 0xffffffffa01f2178: marking vcs0 as active
<0> [301.285257] i915_sel-3978    0d..1 300708750us : 0xffffffffa01f1915: vcs0 fence 9a60:5 -> current 4
<0> [301.285273] i915_sel-3978    0.... 300708754us : 0xffffffffa01b7c20: awake?=yes
<0> [301.285288] i915_sel-3978    0.... 300708756us : 0xffffffffa01ef203: vcs0 fence 9a60:5, current 5
<0> [301.285304] i915_sel-3978    0.... 300708757us : 0xffffffffa01ef934: marking vcs0 as inactive
<0> [301.285320] i915_sel-3978    0.... 300708758us : 0xffffffffa01ef4a8: __retire_engine_request(vcs0) fence 9a60:5, current 5
<0> [301.285338] i915_sel-3978    0.... 300708771us : 0xffffffffa01ef203: rcs0 fence 9a5d:5, current 5
<0> [301.285354] i915_sel-3978    0.... 300708772us : 0xffffffffa01ef934: marking rcs0 as inactive
<0> [301.285371] i915_sel-3978    0.... 300708773us : 0xffffffffa01ef4a8: __retire_engine_request(rcs0) fence 9a5d:5, current 5
<0> [301.285389] i915_sel-3978    0.... 300708775us : 0xffffffffa01d5130: 
<0> [301.285402] i915_sel-3978    0.... 300708786us : 0xffffffffa01b7ce2: emit barrier on rcs0
<0> [301.285417] i915_sel-3978    0.... 300708787us : 0xffffffffa01d5200: 
<0> [301.285431] i915_sel-3978    0.... 300708798us : 0xffffffffa01f1c10: rcs0 fence 9a5d:6
<0> [301.285446] i915_sel-3978    0.... 300708800us : 0xffffffffa01f2178: marking rcs0 as active
<0> [301.285462] i915_sel-3978    0d..1 300708803us : 0xffffffffa01f1915: rcs0 fence 9a5d:6 -> current 5
<0> [301.285478] i915_sel-3978    0.... 300708808us : 0xffffffffa01b7ce2: emit barrier on vcs0
<0> [301.285494] i915_sel-3978    0.... 300708820us : 0xffffffffa01f1c10: vcs0 fence 9a60:6
<0> [301.285509] i915_sel-3978    0.... 300708821us : 0xffffffffa01f2178: marking vcs0 as active
<0> [301.285525] i915_sel-3978    0d..1 300708824us : 0xffffffffa01f1915: vcs0 fence 9a60:6 -> current 5
<0> [301.285542] i915_sel-3978    0.... 300708830us : 0xffffffffa01b3489: last request for rcs0 on engine rcs0: 9a5d:6
<0> [301.285560] i915_sel-3978    0.... 300708830us : 0xffffffffa01b3489: last request for vcs0 on engine vcs0: 9a60:6
<0> [301.285578] i915_sel-3978    0.... 300708831us : 0xffffffffa01d8e80: flags=2 (locked), timeout=9223372036854775807 (forever)
<0> [301.285596] i915_sel-3978    0.... 300708841us : 0xffffffffa01ef203: vcs0 fence 9a60:6, current 6
<0> [301.285612] i915_sel-3978    0.... 300708842us : 0xffffffffa01ef934: marking vcs0 as inactive
<0> [301.285629] i915_sel-3978    0.... 300708843us : 0xffffffffa01ef4a8: __retire_engine_request(vcs0) fence 9a60:6, current 6
<0> [301.285648] i915_sel-3978    0.... 300708856us : 0xffffffffa01ef203: rcs0 fence 9a5d:6, current 6
<0> [301.285664] i915_sel-3978    0.... 300708857us : 0xffffffffa01ef934: marking rcs0 as inactive
<0> [301.285680] i915_sel-3978    0.... 300708858us : 0xffffffffa01ef4a8: __retire_engine_request(rcs0) fence 9a5d:6, current 6
<0> [301.285697] i915_sel-3978    0.... 300708860us : 0xffffffffa01d5130: 
<0> [301.285711] i915_sel-3978    0.... 300708872us : 0xffffffffa01b7c20: awake?=yes
<0> [301.285726] i915_sel-3978    0.... 300708873us : 0xffffffffa01b7c20: awake?=yes
<0> [301.285741] i915_sel-3978    0.... 300708874us : 0xffffffffa01d8e80: flags=2 (locked), timeout=200
<0> [301.285757] i915_sel-3978    0.... 300708926us : 0xffffffffa02af429: Running i915_gem_context_live_selftests/live_nop_switch
<0> [301.285776] i915_sel-3978    0.... 300708939us : 0xffffffffa02af429: Running i915_gem_context_live_selftests/igt_ctx_exec
<0> [301.285794] i915_sel-3978    0.... 300708952us : 0xffffffffa02af429: Running i915_gem_context_live_selftests/igt_ctx_readonly
<0> [301.285813] i915_sel-3978    0.... 300709045us : 0xffffffffa01d8e80: flags=3 (locked), timeout=9223372036854775807 (forever)
<0> [301.285831] i915_sel-3978    0.... 300709070us : 0xffffffffa01b7c20: awake?=yes
<0> [301.285846] i915_sel-3978    0.... 300709071us : 0xffffffffa01d8e80: flags=2 (locked), timeout=200
<0> [301.285862] i915_sel-3978    0.... 300709214us : 0xffffffffa02af429: Running i915_gem_context_live_selftests/igt_ctx_sseu
<0> [301.285880] i915_sel-3978    0.... 300709227us : 0xffffffffa02af429: Running i915_gem_context_live_selftests/igt_vm_isolation
<0> [301.285944] i915_sel-3978    3.... 300816034us : 0xffffffffa01e1170: 
<0> [301.285956] i915_sel-3978    3.... 300816037us : 0xffffffffa0209cf0: 
<0> [301.285969] i915_sel-3978    3.... 300816038us : 0xffffffffa01810e4: engine_mask=ffffffff
<0> [301.285984] i915_sel-3978    3d..1 300816043us : 0xffffffffa021b1e4: rcs0 stalled? no
<0> [301.285999] i915_sel-3978    3d..1 300816043us : 0xffffffffa021b1e4: vcs0 stalled? no
<0> [301.286067] i915_sel-4004    3.... 301352762us : i915_gem_sanitize: 
<0> [301.286138] i915_sel-4004    3.... 301352766us : intel_engines_sanitize: 
<0> [301.286202] i915_sel-4004    3.... 301352767us : intel_gpu_reset: engine_mask=ffffffff
<0> [301.286272] i915_sel-4004    2.... 301373093us : i915_gem_unpark: 
<0> [301.286342] i915_sel-4004    2.... 301373623us : i915_request_add: rcs0 fence 9a64:1
<0> [301.286412] i915_sel-4004    2.... 301373688us : i915_request_add: marking rcs0 as active
<0> [301.286484] i915_sel-4004    2d..1 301373717us : __i915_request_submit: rcs0 fence 9a64:1 -> current 0
<0> [301.286557] i915_sel-4004    2.... 301373867us : i915_request_add: vcs0 fence 9a67:1
<0> [301.286628] i915_sel-4004    2.... 301373869us : i915_request_add: marking vcs0 as active
<0> [301.286701] i915_sel-4004    2d..1 301373873us : __i915_request_submit: vcs0 fence 9a67:1 -> current 0
<0> [301.286769] i915_sel-4004    2.... 301373879us : i915_gem_switch_to_kernel_context: awake?=yes
<0> [301.286841] i915_sel-4004    2.... 301373881us : i915_request_retire: vcs0 fence 9a67:1, current 1
<0> [301.286913] i915_sel-4004    2.... 301373883us : i915_request_retire: marking vcs0 as inactive
<0> [301.286985] i915_sel-4004    2.... 301373885us : i915_request_retire: __retire_engine_request(vcs0) fence 9a67:1, current 1
<0> [301.287060] i915_sel-4004    2.... 301374042us : i915_request_retire: rcs0 fence 9a64:1, current 1
<0> [301.287132] i915_sel-4004    2.... 301374043us : i915_request_retire: marking rcs0 as inactive
<0> [301.287205] i915_sel-4004    2.... 301374044us : i915_request_retire: __retire_engine_request(rcs0) fence 9a64:1, current 1
<0> [301.287276] i915_sel-4004    2.... 301374046us : i915_gem_park: 
<0> [301.287341] i915_sel-4004    2.... 301374059us : i915_gem_switch_to_kernel_context: emit barrier on rcs0
<0> [301.287410] i915_sel-4004    2.... 301374060us : i915_gem_unpark: 
<0> [301.287477] i915_sel-4004    2.... 301374072us : i915_request_add: rcs0 fence 9a64:2
<0> [301.287545] i915_sel-4004    2.... 301374073us : i915_request_add: marking rcs0 as active
<0> [301.287615] i915_sel-4004    2d..1 301374077us : __i915_request_submit: rcs0 fence 9a64:2 -> current 1
<0> [301.287684] i915_sel-4004    2.... 301374084us : i915_gem_switch_to_kernel_context: emit barrier on vcs0
<0> [301.287754] i915_sel-4004    2.... 301374095us : i915_request_add: vcs0 fence 9a67:2
<0> [301.287824] i915_sel-4004    2.... 301374096us : i915_request_add: marking vcs0 as active
<0> [301.287896] i915_sel-4004    2d..1 301374100us : __i915_request_submit: vcs0 fence 9a67:2 -> current 1
<0> [301.287965] i915_sel-4004    2.... 301374107us : i915_gem_wait_for_idle: flags=2 (locked), timeout=200
<0> [301.288036] i915_sel-4004    2.... 301374120us : i915_request_retire: vcs0 fence 9a67:2, current 2
<0> [301.288106] i915_sel-4004    2.... 301374121us : i915_request_retire: marking vcs0 as inactive
<0> [301.288177] i915_sel-4004    2.... 301374122us : i915_request_retire: __retire_engine_request(vcs0) fence 9a67:2, current 2
<0> [301.288252] i915_sel-4004    2.... 301374135us : i915_request_retire: rcs0 fence 9a64:2, current 2
<0> [301.288324] i915_sel-4004    2.... 301374136us : i915_request_retire: marking rcs0 as inactive
<0> [301.288394] i915_sel-4004    2.... 301374137us : i915_request_retire: __retire_engine_request(rcs0) fence 9a64:2, current 2
<0> [301.288465] i915_sel-4004    2.... 301374139us : i915_gem_park: 
<0> [301.288529] i915_sel-4004    2.... 301374151us : __i915_gem_park: 
<0> [301.288602] i915_sel-4004    2.... 301378910us : __i915_subtests: Running intel_hangcheck_live_selftests/igt_global_reset
<0> [301.288668] i915_sel-4004    2.... 301378913us : i915_reset: flags=15
<0> [301.288737] i915_sel-4004    2.... 301378915us : intel_engine_stop_cs: rcs0
<0> [301.288807] i915_sel-4004    2.... 301378917us : intel_engine_stop_cs: vcs0
<0> [301.288870] i915_sel-4004    2.... 301378919us : intel_gpu_reset: engine_mask=ffffffff
<0> [301.288943] i915_sel-4004    2d..1 301378924us : reset_ring: rcs0 stalled? yes
<0> [301.289014] i915_sel-4004    2d..1 301378926us : reset_ring: vcs0 stalled? yes
<0> [301.289081] kworker/-2431    2.... 301379668us : i915_gem_unpark: 
<0> [301.289150] kworker/-2431    2.... 301380254us : i915_request_add: rcs0 fence 9a64:3
<0> [301.289219] kworker/-2431    2.... 301380307us : i915_request_add: marking rcs0 as active
<0> [301.289289] kworker/-2431    2d..1 301380330us : __i915_request_submit: rcs0 fence 9a64:3 -> current 2
<0> [301.289360] kworker/-2431    2.... 301380412us : i915_request_add: vcs0 fence 9a67:3
<0> [301.289429] kworker/-2431    2.... 301380413us : i915_request_add: marking vcs0 as active
<0> [301.289563] kworker/-2431    2d..1 301380418us : __i915_request_submit: vcs0 fence 9a67:3 -> current 2
<0> [301.289637] CPU:1 [LOST 779637 EVENTS]
i915_sel-4004    1.... 301382844us : i915_request_retire: __retire_engine_request(rcs0) fence 9a64:16, current 16
<0> [301.289714] i915_sel-4004    1.... 301382867us : i915_request_add: rcs0 fence 9a64:18
<0> [301.289783] i915_sel-4004    1d..1 301382872us : __i915_request_submit: rcs0 fence 9a64:18 -> current 17
<0> [301.289856] i915_sel-4004    1.... 301382878us : i915_request_retire_upto: rcs0 fence 9a64:17, current 17
<0> [301.289928] i915_sel-4004    1.... 301382880us : i915_request_retire: rcs0 fence 9a64:17, current 17
<0> [301.290000] i915_sel-4004    1.... 301382881us : i915_request_retire: __retire_engine_request(rcs0) fence 9a64:17, current 17
<0> [301.290073] i915_sel-4004    1.... 301382905us : i915_request_add: rcs0 fence 9a64:19
<0> [301.290143] i915_sel-4004    1d..1 301382910us : __i915_request_submit: rcs0 fence 9a64:19 -> current 18
<0> [301.290217] i915_sel-4004    1.... 301382916us : i915_request_retire_upto: rcs0 fence 9a64:18, current 18
<0> [301.290288] i915_sel-4004    1.... 301382918us : i915_request_retire: rcs0 fence 9a64:18, current 18
<0> [301.290358] i915_sel-4004    1.... 301382919us : i915_request_retire: __retire_engine_request(rcs0) fence 9a64:18, current 18
<0> [301.290431] i915_sel-4004    1.... 301382943us : i915_request_add: rcs0 fence 9a64:20
<0> [301.290501] i915_sel-4004    1d..1 301382948us : __i915_request_submit: rcs0 fence 9a64:20 -> current 19
<0> [301.290573] i915_sel-4004    1.... 301382954us : i915_request_retire_upto: rcs0 fence 9a64:19, current 19
<0> [301.290644] i915_sel-4004    1.... 301382955us : i915_request_retire: rcs0 fence 9a64:19, current 19
<0> [301.290715] i915_sel-4004    1.... 301382957us : i915_request_retire: __retire_engine_request(rcs0) fence 9a64:19, current 19
<0> [301.290788] i915_sel-4004    1.... 301382980us : i915_request_add: rcs0 fence 9a64:21
<0> [301.290857] i915_sel-4004    1d..1 301382986us : __i915_request_submit: rcs0 fence 9a64:21 -> current 20
<0> [301.290928] i915_sel-4004    1.... 301382992us : i915_request_retire_upto: rcs0 fence 9a64:20, current 20
<0> [301.290999] i915_sel-4004    1.... 301382993us : i915_request_retire: rcs0 fence 9a64:20, current 20
<0> [301.291070] i915_sel-4004    1.... 301382995us : i915_request_retire: __retire_engine_request(rcs0) fence 9a64:20, current 20
<0> [301.291144] i915_sel-4004    1.... 301383018us : i915_request_add: vcs0 fence 9a67:6
<0> [301.291214] i915_sel-4004    1.... 301383020us : i915_request_add: marking vcs0 as active
<0> [301.291284] i915_sel-4004    1d..1 301383024us : __i915_request_submit: vcs0 fence 9a67:6 -> current 5
<0> [301.291356] i915_sel-4004    1.... 301383041us : i915_request_add: vcs0 fence 9a67:7
<0> [301.291427] i915_sel-4004    1d..1 301383046us : __i915_request_submit: vcs0 fence 9a67:7 -> current 6
<0> [301.291500] i915_sel-4004    1.... 301383052us : i915_request_retire_upto: vcs0 fence 9a67:6, current 7
<0> [301.291572] i915_sel-4004    1.... 301383053us : i915_request_retire: vcs0 fence 9a67:6, current 7
<0> [301.291645] i915_sel-4004    1.... 301383055us : i915_request_retire: __retire_engine_request(vcs0) fence 9a67:6, current 7
<0> [301.291719] i915_sel-4004    1.... 301383078us : i915_request_add: vcs0 fence 9a67:8
<0> [301.291791] i915_sel-4004    1d..1 301383083us : __i915_request_submit: vcs0 fence 9a67:8 -> current 7
<0> [301.291864] i915_sel-4004    1.... 301383089us : i915_request_retire_upto: vcs0 fence 9a67:7, current 8
<0> [301.291937] i915_sel-4004    1.... 301383091us : i915_request_retire: vcs0 fence 9a67:7, current 8
<0> [301.292009] i915_sel-4004    1.... 301383092us : i915_request_retire: __retire_engine_request(vcs0) fence 9a67:7, current 8
<0> [301.292084] i915_sel-4004    1.... 301383115us : i915_request_add: vcs0 fence 9a67:9
<0> [301.292155] i915_sel-4004    1d..1 301383121us : __i915_request_submit: vcs0 fence 9a67:9 -> current 8
<0> [301.292229] i915_sel-4004    1.... 301383126us : i915_request_retire_upto: vcs0 fence 9a67:8, current 9
<0> [301.292299] i915_sel-4004    1.... 301383128us : i915_request_retire: vcs0 fence 9a67:8, current 9
<0> [301.292372] i915_sel-4004    1.... 301383129us : i915_request_retire: __retire_engine_request(vcs0) fence 9a67:8, current 9
<0> [301.292444] i915_sel-4004    1.... 301383152us : i915_request_add: vcs0 fence 9a67:10
<0> [301.292515] i915_sel-4004    1d..1 301383158us : __i915_request_submit: vcs0 fence 9a67:10 -> current 9
<0> [301.292587] i915_sel-4004    1.... 301383164us : i915_request_retire_upto: vcs0 fence 9a67:9, current 10
<0> [301.292659] i915_sel-4004    1.... 301383165us : i915_request_retire: vcs0 fence 9a67:9, current 10
<0> [301.292732] i915_sel-4004    1.... 301383167us : i915_request_retire: __retire_engine_request(vcs0) fence 9a67:9, current 10
<0> [301.292806] i915_sel-4004    1.... 301383190us : i915_request_add: vcs0 fence 9a67:11
<0> [301.292878] i915_sel-4004    1d..1 301383195us : __i915_request_submit: vcs0 fence 9a67:11 -> current 10
<0> [301.292949] i915_sel-4004    1.... 301383201us : i915_request_retire_upto: vcs0 fence 9a67:10, current 11
<0> [301.293021] i915_sel-4004    1.... 301383202us : i915_request_retire: vcs0 fence 9a67:10, current 11
<0> [301.293094] i915_sel-4004    1.... 301383204us : i915_request_retire: __retire_engine_request(vcs0) fence 9a67:10, current 11
<0> [301.293168] i915_sel-4004    1.... 301383227us : i915_request_add: vcs0 fence 9a67:12
<0> [301.293241] i915_sel-4004    1d..1 301383232us : __i915_request_submit: vcs0 fence 9a67:12 -> current 11
<0> [301.293309] i915_sel-4004    1.... 301383238us : i915_request_retire_upto: vcs0 fence 9a67:11, current 12
<0> [301.293378] i915_sel-4004    1.... 301383239us : i915_request_retire: vcs0 fence 9a67:11, current 12
<0> [301.293446] i915_sel-4004    1.... 301383241us : i915_request_retire: __retire_engine_request(vcs0) fence 9a67:11, current 12
<0> [301.293517] i915_sel-4004    1.... 301383264us : i915_request_add: vcs0 fence 9a67:13
<0> [301.293589] i915_sel-4004    1d..1 301383269us : __i915_request_submit: vcs0 fence 9a67:13 -> current 12
<0> [301.293662] i915_sel-4004    1.... 301383275us : i915_request_retire_upto: vcs0 fence 9a67:12, current 13
<0> [301.293734] i915_sel-4004    1.... 301383276us : i915_request_retire: vcs0 fence 9a67:12, current 13
<0> [301.293807] i915_sel-4004    1.... 301383278us : i915_request_retire: __retire_engine_request(vcs0) fence 9a67:12, current 13
<0> [301.293881] i915_sel-4004    1.... 301383301us : i915_request_add: vcs0 fence 9a67:14
<0> [301.293952] i915_sel-4004    1d..1 301383306us : __i915_request_submit: vcs0 fence 9a67:14 -> current 13
<0> [301.294023] i915_sel-4004    1.... 301383312us : i915_request_retire_upto: vcs0 fence 9a67:13, current 14
<0> [301.294094] i915_sel-4004    1.... 301383313us : i915_request_retire: vcs0 fence 9a67:13, current 14
<0> [301.294166] i915_sel-4004    1.... 301383315us : i915_request_retire: __retire_engine_request(vcs0) fence 9a67:13, current 14
<0> [301.294239] i915_sel-4004    1.... 301383338us : i915_request_add: vcs0 fence 9a67:15
<0> [301.294308] i915_sel-4004    1d..1 301383343us : __i915_request_submit: vcs0 fence 9a67:15 -> current 14
<0> [301.294379] i915_sel-4004    1.... 301383350us : i915_request_retire_upto: vcs0 fence 9a67:14, current 15
<0> [301.294452] i915_sel-4004    1.... 301383351us : i915_request_retire: vcs0 fence 9a67:14, current 15
<0> [301.294524] i915_sel-4004    1.... 301383353us : i915_request_retire: __retire_engine_request(vcs0) fence 9a67:14, current 15
<0> [301.294598] i915_sel-4004    1.... 301383376us : i915_request_add: vcs0 fence 9a67:16
<0> [301.294668] i915_sel-4004    1d..1 301383381us : __i915_request_submit: vcs0 fence 9a67:16 -> current 15
<0> [301.294739] i915_sel-4004    1.... 301383387us : i915_request_retire_upto: vcs0 fence 9a67:15, current 16
<0> [301.294810] i915_sel-4004    1.... 301383388us : i915_request_retire: vcs0 fence 9a67:15, current 16
<0> [301.294880] i915_sel-4004    1.... 301383390us : i915_request_retire: __retire_engine_request(vcs0) fence 9a67:15, current 16
<0> [301.294954] i915_sel-4004    1.... 301383413us : i915_request_add: vcs0 fence 9a67:17
<0> [301.295025] i915_sel-4004    1d..1 301383418us : __i915_request_submit: vcs0 fence 9a67:17 -> current 16
<0> [301.295098] i915_sel-4004    1.... 301383424us : i915_request_retire_upto: vcs0 fence 9a67:16, current 17
<0> [301.295171] i915_sel-4004    1.... 301383426us : i915_request_retire: vcs0 fence 9a67:16, current 17
<0> [301.295245] i915_sel-4004    1.... 301383427us : i915_request_retire: __retire_engine_request(vcs0) fence 9a67:16, current 17
<0> [301.295320] i915_sel-4004    1.... 301383450us : i915_request_add: vcs0 fence 9a67:18
<0> [301.295391] i915_sel-4004    1d..1 301383455us : __i915_request_submit: vcs0 fence 9a67:18 -> current 17
<0> [301.295464] i915_sel-4004    1.... 301383461us : i915_request_retire_upto: vcs0 fence 9a67:17, current 18
<0> [301.295537] i915_sel-4004    1.... 301383463us : i915_request_retire: vcs0 fence 9a67:17, current 18
<0> [301.295610] i915_sel-4004    1.... 301383464us : i915_request_retire: __retire_engine_request(vcs0) fence 9a67:17, current 18
<0> [301.295684] i915_sel-4004    1.... 301383488us : i915_request_add: vcs0 fence 9a67:19
<0> [301.295756] i915_sel-4004    1d..1 301383493us : __i915_request_submit: vcs0 fence 9a67:19 -> current 18
<0> [301.295828] i915_sel-4004    1.... 301383513us : i915_request_retire_upto: vcs0 fence 9a67:18, current 19
<0> [301.295902] i915_sel-4004    1.... 301383515us : i915_request_retire: vcs0 fence 9a67:18, current 19
<0> [301.295975] i915_sel-4004    1.... 301383516us : i915_request_retire: __retire_engine_request(vcs0) fence 9a67:18, current 19
<0> [301.296050] i915_sel-4004    1.... 301383540us : i915_request_add: vcs0 fence 9a67:20
<0> [301.296121] i915_sel-4004    1d..1 301383545us : __i915_request_submit: vcs0 fence 9a67:20 -> current 19
<0> [301.296193] i915_sel-4004    1.... 301383551us : i915_request_retire_upto: vcs0 fence 9a67:19, current 20
<0> [301.296267] i915_sel-4004    1.... 301383552us : i915_request_retire: vcs0 fence 9a67:19, current 20
<0> [301.296339] i915_sel-4004    1.... 301383554us : i915_request_retire: __retire_engine_request(vcs0) fence 9a67:19, current 20
<0> [301.296413] i915_sel-4004    1.... 301383577us : i915_request_add: vcs0 fence 9a67:21
<0> [301.296482] i915_sel-4004    1d..1 301383582us : __i915_request_submit: vcs0 fence 9a67:21 -> current 20
<0> [301.296555] i915_sel-4004    1.... 301383588us : i915_request_retire_upto: vcs0 fence 9a67:20, current 21
<0> [301.296626] i915_sel-4004    1.... 301383590us : i915_request_retire: vcs0 fence 9a67:20, current 21
<0> [301.296698] i915_sel-4004    1.... 301383591us : i915_request_retire: __retire_engine_request(vcs0) fence 9a67:20, current 21
<0> [301.296765] i915_sel-4004    1.... 301383604us : i915_reset: flags=15
<0> [301.296835] i915_sel-4004    1.... 301383604us : intel_engine_stop_cs: rcs0
<0> [301.296904] i915_sel-4004    1.... 301383606us : intel_engine_stop_cs: vcs0
<0> [301.296967] i915_sel-4004    1.... 301383607us : intel_gpu_reset: engine_mask=ffffffff
<0> [301.297038] i915_sel-4004    1d..1 301383612us : reset_ring: rcs0 stalled? yes
<0> [301.297111] i915_sel-4004    1d..1 301383614us : reset_ring: vcs0 stalled? yes
<0> [301.297181] kworker/-2431    2.... 301383620us : i915_request_add: rcs0 fence 9a64:22
<0> [301.297250] kworker/-2431    2d..1 301383626us : __i915_request_submit: rcs0 fence 9a64:22 -> current 21
<0> [301.297321] kworker/-2431    2.... 301383634us : i915_request_retire_upto: rcs0 fence 9a64:21, current 21
<0> [301.297391] kworker/-2431    2.... 301383635us : i915_request_retire: rcs0 fence 9a64:21, current 21
<0> [301.297462] kworker/-2431    2.... 301383637us : i915_request_retire: __retire_engine_request(rcs0) fence 9a64:21, current 1
<0> [301.297536] kworker/-2431    2.... 301383823us : i915_request_retire: __retire_engine_request:200 GEM_BUG_ON(!i915_request_completed(rq))
<4> [301.297659] RIP: 0010:i915_request_retire+0x6b8/0xc40 [i915]


This failure is part of this bug?
Comment 6 CI Bug Log 2019-03-02 22:25:32 UTC
A CI Bug Log filter associated to this bug has been updated:

{- ILK: igt@gem_eio@in-flight-suspend - incomplete - GEM_BUG_ON(!i915_request_completed(rq)) -}
{+ ILK: igt@gem_eio@in-flight-suspend|igt@i915_selftest@live_hangcheck - incomplete - GEM_BUG_ON(!i915_request_completed(rq)) +}

New failures caught by the filter:

* https://intel-gfx-ci.01.org/tree/drm-tip/CI_DRM_5685/fi-ilk-650/igt@i915_selftest@live_hangcheck.html
Comment 7 CI Bug Log 2019-03-06 16:20:20 UTC
A CI Bug Log filter associated to this bug has been updated:

{- ILK: igt@gem_eio@in-flight-suspend|igt@i915_selftest@live_hangcheck - incomplete - GEM_BUG_ON(!i915_request_completed(rq)) -}
{+ ILK: igt@gem_eio@in-flight-suspend / igt@i915_selftest@live_hangcheck / igt@gem_mmap_gtt@hang - incomplete - GEM_BUG_ON(!i915_request_completed(rq)) +}

 No new failures caught with the new filter
Comment 8 Martin Peres 2019-03-06 16:20:53 UTC
(In reply to CI Bug Log from comment #7)
> A CI Bug Log filter associated to this bug has been updated:
> 
> {- ILK: igt@gem_eio@in-flight-suspend|igt@i915_selftest@live_hangcheck -
> incomplete - GEM_BUG_ON(!i915_request_completed(rq)) -}
> {+ ILK: igt@gem_eio@in-flight-suspend / igt@i915_selftest@live_hangcheck /
> igt@gem_mmap_gtt@hang - incomplete - GEM_BUG_ON(!i915_request_completed(rq))
> +}
> 
>  No new failures caught with the new filter

https://intel-gfx-ci.01.org/tree/drm-tip/drmtip_234/fi-ilk-650/igt@gem_mmap_gtt@hang.html

https://intel-gfx-ci.01.org/tree/drm-tip/drmtip_230/fi-ilk-650/igt@gem_mmap_gtt@hang.html
Comment 9 CI Bug Log 2019-03-08 13:30:15 UTC
The CI Bug Log issue associated to this bug has been updated.

### New filters associated

* BYT IVB: igt@gem_eio@reset-stress - incomplete - GEM_BUG_ON(!i915_request_completed(request)) (No new failures associated)
Comment 10 CI Bug Log 2019-04-26 08:05:54 UTC
A CI Bug Log filter associated to this bug has been updated:

{- BYT IVB: igt@gem_eio@reset-stress - incomplete - GEM_BUG_ON(!i915_request_completed(request)) -}
{+ BYT IVB: igt@gem_eio@reset-stress - incomplete - GEM_BUG_ON(!i915_request_completed(request)) +}

New failures caught by the filter:

  * https://intel-gfx-ci.01.org/tree/drm-tip/drmtip_259/fi-snb-2520m/igt@gem_eio@reset-stress.html
Comment 11 CI Bug Log 2019-04-29 12:55:11 UTC
A CI Bug Log filter associated to this bug has been updated:

{- BYT IVB: igt@gem_eio@reset-stress - incomplete - GEM_BUG_ON(!i915_request_completed(request)) -}
{+ SNB BYT IVB: igt@gem_eio@reset-stress - incomplete - GEM_BUG_ON(!i915_request_completed(request)) +}


  No new failures caught with the new filter
Comment 12 Francesco Balestrieri 2019-07-23 08:53:26 UTC
Last seen 2 months / 899 runs ago. Occurrence before that oscillated around weekly, closing.

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.