Oops#1 Part22
<0>[  136.121800] kms_flip-2396      4..... 110218617us : __intel_context_do_pin_ww: 0000:00:02.0 bcs0: context:2b active
<0>[  136.121904] kms_flip-2396      4..... 110219785us : intel_timeline_pin: 0000:00:02.0 timeline:2b using HWSP offset:fedc3000
<0>[  136.122009] kms_flip-2396      4..... 110220303us : __intel_context_do_pin_ww: 0000:00:02.0 bcs0: context:2b pin ring:{start:fedc4000, head:0000, tail:0000}
<0>[  136.122119] kms_flip-2396      4..... 110221425us : __i915_request_commit: 0000:00:02.0 bcs0: fence 2b:2, current 0 
<0>[  136.122227] kms_flip-2396      4D..1. 110221428us : __i915_request_submit: 0000:00:02.0 bcs0: fence 2b:2, current 0 
<0>[  136.122335] kms_flip-2396      4..... 110221475us : __i915_request_commit: 0000:00:02.0 bcs0: fence 6:7, current 6 
<0>[  136.122441] kms_flip-2396      4D..1. 110221477us : __i915_request_submit: 0000:00:02.0 bcs0: fence 6:7, current 6 
<0>[  136.122545] kms_flip-2396      4..... 110221491us : intel_rps_boost.part.0: 0000:00:02.0 boost fence:2b:2
<0>[  136.122650] kworker/-86       17..... 110223214us : i915_request_retire.part.0: 0000:00:02.0 bcs0: fence 2b:2, current 2 
<0>[  136.122754] kworker/-2342     17..... 110223318us : __intel_context_do_unpin.part.0: 0000:00:02.0 bcs0: context:2b unpin
<0>[  136.122858] kworker/-2342     17..... 110223386us : __intel_context_retire: 0000:00:02.0 bcs0: context:2b retire runtime: { total:1634620ns, avg:1634620ns }
<0>[  136.122966] kms_flip-2396      4..... 110544716us : intel_rps_mark_interactive: 0000:00:02.0 mark interactive: yes
<0>[  136.123071] kworker/-31        3..... 110827013us : i915_request_retire.part.0: 0000:00:02.0 bcs0: fence 6:4, current 7 
Oops#1 Part21
<0>[  136.123177] kworker/-31        3..... 110827019us : i915_request_retire.part.0: 0000:00:02.0 bcs0: fence 6:5, current 7 
<0>[  136.123284] kworker/-31        3..... 110827045us : i915_request_retire.part.0: 0000:00:02.0 bcs0: fence 6:6, current 7 
<0>[  136.123391] kworker/-31        3..... 110827053us : i915_request_retire.part.0: 0000:00:02.0 bcs0: fence 6:7, current 7 
<0>[  136.123495] kworker/-31        3..... 110827068us : __engine_park: 0000:00:02.0 bcs0: parked
<0>[  136.123596] kworker/-31        3..... 110827337us : __gt_park: 0000:00:02.0 
<0>[  136.123695] kms_flip-2396      3..... 111415486us : __gt_unpark: 0000:00:02.0 
<0>[  136.123795] kms_flip-2396      3..... 111415792us : intel_rps_mark_interactive: 0000:00:02.0 mark interactive: yes
<0>[  136.123898] kworker/-31        3..... 111415866us : __gt_park: 0000:00:02.0 
<0>[  136.123997] kworker/-199       5..... 111432460us : intel_rps_mark_interactive: 0000:00:02.0 mark interactive: no
<0>[  136.124021] kms_flip-2396      4...1. 111444052us : tracing_mark_write: kms_flip: finished subtest C-eDP1, SUCCESS
<0>[  136.124125] kms_flip-2396      4..... 111448098us : __gt_unpark: 0000:00:02.0 
<0>[  136.124224] kms_flip-2396      4..... 111448520us : __gt_park: 0000:00:02.0 
<0>[  136.124325] kms_flip-2396      4..... 111448669us : __gt_unpark: 0000:00:02.0 
<0>[  136.124424] kms_flip-2396      4..... 111448833us : __gt_park: 0000:00:02.0 
<0>[  136.124522] kms_flip-2396      4..... 111449505us : __gt_unpark: 0000:00:02.0 
<0>[  136.124621] kms_flip-2396      4..... 111449873us : __intel_context_do_pin_ww: 0000:00:02.0 bcs0: context:2c active
Oops#1 Part20
<0>[  136.124726] kms_flip-2396      4..... 111450723us : intel_timeline_pin: 0000:00:02.0 timeline:2c using HWSP offset:fedcd000
<0>[  136.124830] kms_flip-2396      4..... 111451088us : __engine_unpark: 0000:00:02.0 bcs0: 
<0>[  136.124931] kms_flip-2396      4..... 111451097us : __engine_unpark: 0000:00:02.0 bcs0: context:6 reset { seqno:7, *hwsp:7, ring:2f8 }
<0>[  136.125036] kms_flip-2396      4..... 111451098us : __intel_context_do_pin_ww: 0000:00:02.0 bcs0: context:2c pin ring:{start:fedce000, head:0000, tail:0000}
<0>[  136.125144] kms_flip-2396      4..... 111451114us : __intel_context_do_unpin.part.0: 0000:00:02.0 bcs0: context:2c unpin
<0>[  136.125247] kms_flip-2396      4.N... 111451184us : __intel_context_retire: 0000:00:02.0 bcs0: context:2c retire runtime: { total:0ns, avg:0ns }
<0>[  136.125357] kworker/-188       4..... 111451189us : __engine_park: 0000:00:02.0 bcs0: parked
<0>[  136.125463] kms_flip-2396      4..... 111451200us : __intel_context_do_pin_ww: 0000:00:02.0 bcs0: context:2c active
<0>[  136.125568] kms_flip-2396      4..... 111451201us : intel_timeline_pin: 0000:00:02.0 timeline:2c using HWSP offset:fedcd000
<0>[  136.125672] kms_flip-2396      4..... 111451207us : __engine_unpark: 0000:00:02.0 bcs0: 
<0>[  136.125773] kms_flip-2396      4..... 111451213us : __engine_unpark: 0000:00:02.0 bcs0: context:6 reset { seqno:7, *hwsp:7, ring:2f8 }
<0>[  136.125878] kms_flip-2396      4..... 111451213us : __intel_context_do_pin_ww: 0000:00:02.0 bcs0: context:2c pin ring:{start:fedce000, head:0000, tail:0000}
<0>[  136.125986] kms_flip-2396      4..... 111451222us : __intel_context_do_unpin.part.0: 0000:00:02.0 bcs0: context:2c unpin
Oops#1 Part19
<0>[  136.126089] kms_flip-2396      4.N... 111451292us : __intel_context_retire: 0000:00:02.0 bcs0: context:2c retire runtime: { total:0ns, avg:0ns }
<0>[  136.126196] kworker/-188       4..... 111451295us : __engine_park: 0000:00:02.0 bcs0: parked
<0>[  136.126295] kms_flip-2396      4..... 111451301us : __intel_context_do_pin_ww: 0000:00:02.0 bcs0: context:2c active
<0>[  136.126404] kms_flip-2396      4..... 111451302us : intel_timeline_pin: 0000:00:02.0 timeline:2c using HWSP offset:fedcd000
<0>[  136.126508] kms_flip-2396      4..... 111451308us : __engine_unpark: 0000:00:02.0 bcs0: 
<0>[  136.126607] kms_flip-2396      4..... 111451313us : __engine_unpark: 0000:00:02.0 bcs0: context:6 reset { seqno:7, *hwsp:7, ring:2f8 }
<0>[  136.126712] kms_flip-2396      4..... 111451314us : __intel_context_do_pin_ww: 0000:00:02.0 bcs0: context:2c pin ring:{start:fedce000, head:0000, tail:0000}
<0>[  136.126824] kms_flip-2396      4..... 111455263us : __i915_request_commit: 0000:00:02.0 bcs0: fence 2c:2, current 0 
<0>[  136.126932] kms_flip-2396      4D..1. 111455268us : __i915_request_submit: 0000:00:02.0 bcs0: fence 2c:2, current 0 
<0>[  136.127039] kms_flip-2396      4..... 111455354us : __i915_request_commit: 0000:00:02.0 bcs0: fence 6:8, current 7 
<0>[  136.127146] kms_flip-2396      4D..1. 111455356us : __i915_request_submit: 0000:00:02.0 bcs0: fence 6:8, current 7 
<0>[  136.127251] kms_flip-2396      4..... 111455379us : intel_rps_boost.part.0: 0000:00:02.0 boost fence:2c:2
<0>[  136.127362] kworker/-86       17..... 111457990us : i915_request_retire.part.0: 0000:00:02.0 bcs0: fence 2c:2, current 2 
Oops#1 Part18
<0>[  136.127466] kworker/-329       1..... 111458288us : __intel_context_do_unpin.part.0: 0000:00:02.0 bcs0: context:2c unpin
<0>[  136.127570] kworker/-329       1..... 111458357us : __intel_context_retire: 0000:00:02.0 bcs0: context:2c retire runtime: { total:1810328ns, avg:1810328ns }
<0>[  136.127677] kms_flip-2396      4..... 111467605us : __intel_context_do_pin_ww: 0000:00:02.0 bcs0: context:2d active
<0>[  136.127781] kms_flip-2396     17..... 111468863us : intel_timeline_pin: 0000:00:02.0 timeline:2d using HWSP offset:fedc3000
<0>[  136.127885] kms_flip-2396     17..... 111469547us : __intel_context_do_pin_ww: 0000:00:02.0 bcs0: context:2d pin ring:{start:fedc4000, head:0000, tail:0000}
<0>[  136.127993] kms_flip-2396     17..... 111469585us : __intel_context_do_unpin.part.0: 0000:00:02.0 bcs0: context:2d unpin
<0>[  136.128096] kms_flip-2396     17..... 111469668us : __intel_context_retire: 0000:00:02.0 bcs0: context:2d retire runtime: { total:0ns, avg:0ns }
<0>[  136.128202] kms_flip-2396     17..... 111469676us : __intel_context_do_pin_ww: 0000:00:02.0 bcs0: context:2d active
<0>[  136.128307] kms_flip-2396     17..... 111469681us : intel_timeline_pin: 0000:00:02.0 timeline:2d using HWSP offset:fedc3000
<0>[  136.128413] kms_flip-2396     17..... 111469691us : __intel_context_do_pin_ww: 0000:00:02.0 bcs0: context:2d pin ring:{start:fedc4000, head:0000, tail:0000}
<0>[  136.128520] kms_flip-2396     17..... 111469718us : __intel_context_do_unpin.part.0: 0000:00:02.0 bcs0: context:2d unpin
<0>[  136.128624] kms_flip-2396     17..... 111469799us : __intel_context_retire: 0000:00:02.0 bcs0: context:2d retire runtime: { total:0ns, avg:0ns }
Oops#1 Part17
<0>[  136.128730] kms_flip-2396     17..... 111469805us : __intel_context_do_pin_ww: 0000:00:02.0 bcs0: context:2d active
<0>[  136.128835] kms_flip-2396     17..... 111469808us : intel_timeline_pin: 0000:00:02.0 timeline:2d using HWSP offset:fedc3000
<0>[  136.128938] kms_flip-2396     17..... 111469817us : __intel_context_do_pin_ww: 0000:00:02.0 bcs0: context:2d pin ring:{start:fedc4000, head:0000, tail:0000}
<0>[  136.129050] kms_flip-2396     17..... 111471919us : __i915_request_commit: 0000:00:02.0 bcs0: fence 2d:2, current 0 
<0>[  136.129157] kms_flip-2396     17D..1. 111471924us : __i915_request_submit: 0000:00:02.0 bcs0: fence 2d:2, current 0 
<0>[  136.129264] kms_flip-2396     17..... 111472004us : __i915_request_commit: 0000:00:02.0 bcs0: fence 6:9, current 8 
<0>[  136.129370] kms_flip-2396     17D..1. 111472008us : __i915_request_submit: 0000:00:02.0 bcs0: fence 6:9, current 8 
<0>[  136.129477] kms_flip-2396     17..... 111472031us : intel_rps_boost.part.0: 0000:00:02.0 boost fence:2d:2
<0>[  136.129582] kworker/-86       17..... 111473743us : i915_request_retire.part.0: 0000:00:02.0 bcs0: fence 2d:2, current 2 
<0>[  136.129687] kworker/-329       1..... 111473848us : __intel_context_do_unpin.part.0: 0000:00:02.0 bcs0: context:2d unpin
<0>[  136.129792] kworker/-329       1..... 111473928us : __intel_context_retire: 0000:00:02.0 bcs0: context:2d retire runtime: { total:1585012ns, avg:1585012ns }
<0>[  136.129901] kms_flip-2396      3..... 111794580us : intel_rps_mark_interactive: 0000:00:02.0 mark interactive: yes
Oops#1 Part16
<0>[  136.130005] kms_flip-2396      4..... 112676267us : intel_rps_mark_interactive: 0000:00:02.0 mark interactive: yes
<0>[  136.130109] kworker/-205       1..... 112693050us : intel_rps_mark_interactive: 0000:00:02.0 mark interactive: no
<0>[  136.130134] kms_flip-2396     13...1. 112704941us : tracing_mark_write: kms_flip: finished subtest D-eDP1, SUCCESS
<0>[  136.130158] kms_flip-2396      1...1. 112709966us : tracing_mark_write: kms_flip: finished subtest bo-too-big-interruptible, SUCCESS
<0>[  136.130266] kms_flip-2396      1..... 112713579us : i915_request_retire.part.0: 0000:00:02.0 bcs0: fence 6:8, current 9 
<0>[  136.130373] kms_flip-2396      1..... 112713583us : i915_request_retire.part.0: 0000:00:02.0 bcs0: fence 6:9, current 9 
<0>[  136.130482] kms_flip-2396      1..... 112713638us : __engine_park: 0000:00:02.0 bcs0: parked
<0>[  136.130593] kworker/-987       1..... 112714202us : __gt_park: 0000:00:02.0 
<0>[  136.130697] kms_flip-2396      1..... 112805339us : intel_rps_mark_interactive: 0000:00:02.0 mark interactive: yes
<0>[  136.130800] kms_flip-2396      6..... 113866411us : intel_rps_mark_interactive: 0000:00:02.0 mark interactive: yes
<0>[  136.130904] kworker/-283       6..... 113868874us : intel_rps_mark_interactive: 0000:00:02.0 mark interactive: no
<0>[  136.131007] kms_flip-2396      6..... 113869302us : intel_rps_mark_interactive: 0000:00:02.0 mark interactive: yes
<0>[  136.131111] kworker/-283       6..... 113879997us : intel_rps_mark_interactive: 0000:00:02.0 mark interactive: no
<0>[  136.131136] syncobj_-2399      3...1. 113974328us : tracing_mark_write: syncobj_timeline: executing
Oops#1 Part15
<0>[  136.131237] syncobj_-2399     12..... 113981927us : __gt_unpark: 0000:00:02.0 
<0>[  136.131336] kworker/-660       9..... 113983658us : __gt_park: 0000:00:02.0 
<0>[  136.131434] syncobj_-2399      9..... 114002940us : __gt_unpark: 0000:00:02.0 
<0>[  136.131536] kworker/-660       9..... 114003285us : __gt_park: 0000:00:02.0 
<0>[  136.131555] syncobj_-2399      3...1. 114004988us : tracing_mark_write: syncobj_timeline: starting subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
<0>[  136.131586] syncobj_-2399      3...1. 114111939us : tracing_mark_write: syncobj_timeline: finished subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled, SUCCESS
<0>[  136.131697] syncobj_-2399      3..... 114114598us : intel_rps_mark_interactive: 0000:00:02.0 mark interactive: yes
<0>[  136.131800] kworker/-259       3..... 114126112us : intel_rps_mark_interactive: 0000:00:02.0 mark interactive: no
<0>[  136.131904] syncobj_-2399      3..... 114128070us : intel_rps_mark_interactive: 0000:00:02.0 mark interactive: yes
<0>[  136.132007] kworker/-259       3..... 114137107us : intel_rps_mark_interactive: 0000:00:02.0 mark interactive: no
<0>[  136.132110] syncobj_-2399      3..... 114138021us : intel_rps_mark_interactive: 0000:00:02.0 mark interactive: yes
<0>[  136.132213] kworker/-259       3..... 114148229us : intel_rps_mark_interactive: 0000:00:02.0 mark interactive: no
<0>[  136.132237] kms_fron-2400      3...1. 114233773us : tracing_mark_write: kms_frontbuffer_tracking: executing
<0>[  136.132339] kms_fron-2400      3..... 114241025us : __gt_unpark: 0000:00:02.0 
Oops#1 Part14
<0>[  136.132438] kworker/-31        3..... 114241707us : __gt_park: 0000:00:02.0 
<0>[  136.132539] kms_fron-2400      3..... 114262934us : __gt_unpark: 0000:00:02.0 
<0>[  136.132638] kworker/-31        3..... 114263209us : __gt_park: 0000:00:02.0 
<0>[  136.132657] kms_fron-2400      3...1. 114303453us : tracing_mark_write: kms_frontbuffer_tracking: starting subtest psr-2p-scndscrn-cur-indfb-onoff
<0>[  136.132685] kms_fron-2400      3...1. 114303643us : tracing_mark_write: kms_frontbuffer_tracking: finished subtest psr-2p-scndscrn-cur-indfb-onoff, SKIP
<0>[  136.132793] kms_fron-2400      3..... 114350348us : intel_rps_mark_interactive: 0000:00:02.0 mark interactive: yes
<0>[  136.132896] kworker/-259       3..... 114361893us : intel_rps_mark_interactive: 0000:00:02.0 mark interactive: no
<0>[  136.132999] kms_fron-2400      3..... 114363917us : intel_rps_mark_interactive: 0000:00:02.0 mark interactive: yes
<0>[  136.133102] kworker/-259       3..... 114372908us : intel_rps_mark_interactive: 0000:00:02.0 mark interactive: no
<0>[  136.133206] kms_fron-2400      3..... 114384714us : intel_rps_mark_interactive: 0000:00:02.0 mark interactive: yes
<0>[  136.133309] kworker/-259       3..... 114395168us : intel_rps_mark_interactive: 0000:00:02.0 mark interactive: no
<0>[  136.133333] kms_pm_r-2401      1...1. 114465286us : tracing_mark_write: kms_pm_rpm: executing
<0>[  136.133433] kms_pm_r-2401      6..... 114474105us : __gt_unpark: 0000:00:02.0 
<0>[  136.133535] kworker/-190       6..... 114475003us : __gt_park: 0000:00:02.0 
<0>[  136.133633] kms_pm_r-2401      7..... 114532358us : __gt_unpark: 0000:00:02.0