Oops#1 Part21
<0>[  325.920190] api_inte-2243      4.l... 321796261us : __intel_context_do_pin_ww: 0000:00:02.0 bcs0: context:78 pin ring:{start:fff99000, head:0000, tail:0000}
<0>[  325.920255] api_inte-2243      4.l... 321796272us : __intel_context_do_unpin.part.0: 0000:00:02.0 bcs0: context:78 unpin
<0>[  325.920320] api_inte-2243      4.l... 321796273us : __intel_context_do_pin_ww: 0000:00:02.0 bcs0: context:78 active
<0>[  325.920385] api_inte-2243      4.l... 321796275us : __intel_context_do_pin_ww: 0000:00:02.0 bcs0: context:78 pin ring:{start:fff99000, head:0000, tail:0000}
<0>[  325.920459] kworker/-85        4..... 321797034us : rps_work: 0000:00:02.0 pm_iir:10, client_boost:no, last:-4, cur:48, min:6, max:4e
<0>[  325.920533] kworker/-85        4..... 321797035us : rps_set: 0000:00:02.0 set val:40, freq:1067, swreq:20000000
<0>[  325.920600] kworker/-85        4..... 321797039us : __engine_park: 0000:00:02.0 rcs0: parked
<0>[  325.920666] kworker/-85        4..... 321797040us : __intel_context_retire: 0000:00:02.0 rcs0: context:77 retire runtime: { total:0ns, avg:0ns }
<0>[  325.920754] api_inte-2243      4..... 321797644us : __i915_request_commit: 0000:00:02.0 bcs0: fence 78:2, current 0 
<0>[  325.920838] api_inte-2243      4d.s2. 321797651us : __i915_request_submit: 0000:00:02.0 bcs0: fence 78:2, current 0 
<0>[  325.920906] api_inte-2243      4d.s1. 321797653us : execlists_submission_tasklet: 0000:00:02.0 bcs0: context:78 schedule-in, ccid:60000020
<0>[  325.920973] api_inte-2243      4d.s1. 321797654us : trace_ports: 0000:00:02.0 bcs0: submit { ccid:60000020 78:2 prio 0 }
Oops#1 Part20
<0>[  325.921041] api_inte-2243      4..s1. 321797699us : process_csb: 0000:00:02.0 bcs0: cs-irq head=4, tail=5
<0>[  325.921107] api_inte-2243      4..s1. 321797699us : process_csb: 0000:00:02.0 bcs0: csb[5]: status=0x03ff8000:0x00008019
<0>[  325.921174] api_inte-2243      4..s1. 321797700us : trace_ports: 0000:00:02.0 bcs0: promote { ccid:60000020 78:2* prio 0 }
<0>[  325.921240] api_inte-2243      4..s1. 321797707us : process_csb: 0000:00:02.0 bcs0: cs-irq head=5, tail=6
<0>[  325.921306] api_inte-2243      4..s1. 321797707us : process_csb: 0000:00:02.0 bcs0: csb[6]: status=0x00008000:0x03ff8018
<0>[  325.921373] api_inte-2243      4..s1. 321797708us : trace_ports: 0000:00:02.0 bcs0: completed { ccid:60000020 78:2! prio 0 }
<0>[  325.921439] api_inte-2243      4..s1. 321797709us : __execlists_schedule_out: 0000:00:02.0 bcs0: context:78 schedule-out, ccid:60000020
<0>[  325.921522] kworker/-85        4..... 321797751us : i915_request_retire.part.0: 0000:00:02.0 bcs0: fence 78:2, current 2 
<0>[  325.921587] kworker/-85        4..... 321797764us : __intel_context_do_unpin.part.0: 0000:00:02.0 bcs0: context:78 unpin
<0>[  325.921662] kworker/-72        0d..2. 321797930us : intel_gt_invalidate_tlb_full.part.0: 0000:00:02.0 invalidated engines 00000002
<0>[  325.921738] api_inte-2243      4..s1. 321798027us : rps_timer: 0000:00:02.0 busy:59938 [3%], max:[59938, 0, 0], interval:2
<0>[  325.921813] kworker/-72        0d..2. 321798034us : intel_gt_invalidate_tlb_full.part.0: 0000:00:02.0 invalidated engines 00000002
<0>[  325.921886] kworker/-85        4..... 321798041us : rps_work: 0000:00:02.0 pm_iir:10, client_boost:no, last:-8, cur:40, min:6, max:4e
Oops#1 Part19
<0>[  325.921959] kworker/-85        4..... 321798042us : rps_set: 0000:00:02.0 set val:30, freq:800, swreq:18000000
<0>[  325.922034] kworker/-72        0d..2. 321798154us : intel_gt_invalidate_tlb_full.part.0: 0000:00:02.0 invalidated engines 00000002
<0>[  325.922041] api_inte-2243      4...1. 321798686us : tracing_mark_write: api_intel_bb: finished subtest misplaced-blitter, SUCCESS
<0>[  325.922125] kworker/-85        4..... 321799403us : __i915_request_commit: 0000:00:02.0 bcs0: fence 6:251, current 250 
<0>[  325.922193] kworker/-85        4..... 321799405us : __engine_park: 0000:00:02.0 bcs0: parking
<0>[  325.922276] ksoftirq-43        4d.s1. 321799427us : __i915_request_submit: 0000:00:02.0 bcs0: fence 6:251, current 250 
<0>[  325.922345] ksoftirq-43        4d.s.. 321799433us : execlists_submission_tasklet: 0000:00:02.0 bcs0: context:6 schedule-in, ccid:60000020
<0>[  325.922413] ksoftirq-43        4d.s.. 321799434us : trace_ports: 0000:00:02.0 bcs0: submit { ccid:60000020 6:251* prio 2147483646 }
<0>[  325.922479] api_inte-2243      4dlH1. 321799491us : __intel_context_retire: 0000:00:02.0 bcs0: context:78 retire runtime: { total:8216ns, avg:8216ns }
<0>[  325.922546] api_inte-2243      4.ls.. 321799498us : process_csb: 0000:00:02.0 bcs0: cs-irq head=6, tail=8
<0>[  325.922613] api_inte-2243      4.ls.. 321799499us : process_csb: 0000:00:02.0 bcs0: csb[7]: status=0x03ff8000:0x00008019
<0>[  325.922679] api_inte-2243      4.ls.. 321799499us : trace_ports: 0000:00:02.0 bcs0: promote { ccid:60000020 6:251! prio 2147483646 }
Oops#1 Part18
<0>[  325.922749] api_inte-2243      4.ls.. 321799501us : process_csb: 0000:00:02.0 bcs0: csb[8]: status=0x00008000:0x03ff8018
<0>[  325.922815] api_inte-2243      4.ls.. 321799501us : trace_ports: 0000:00:02.0 bcs0: completed { ccid:60000020 6:251! prio 2147483646 }
<0>[  325.922882] api_inte-2243      4.ls.. 321799502us : __execlists_schedule_out: 0000:00:02.0 bcs0: context:6 schedule-out, ccid:60000020
<0>[  325.922964] kworker/-85        4..... 321799506us : i915_request_retire.part.0: 0000:00:02.0 bcs0: fence 6:251, current 251 
Oops#1 Part17
<0>[  325.923031] kworker/-85        4..... 321799513us : __engine_park: 0000:00:02.0 bcs0: parked
<0>[  325.923100] kworker/-85        4..... 321799540us : __gt_park: 0000:00:02.0 
<0>[  325.923173] kworker/-85        4..... 321799546us : rps_set: 0000:00:02.0 set val:6, freq:100, swreq:3000000
<0>[  325.923247] kworker/-85        4..... 321799546us : intel_rps_park: 0000:00:02.0 park:18
<0>[  325.923320] api_inte-2243      4..... 321843801us : intel_rps_mark_interactive: 0000:00:02.0 mark interactive: yes
<0>[  325.923393] kworker/-103       4..... 321850164us : intel_rps_mark_interactive: 0000:00:02.0 mark interactive: no
Oops#1 Part16
<0>[  325.923466] api_inte-2243      4..... 321854015us : intel_rps_mark_interactive: 0000:00:02.0 mark interactive: yes
<0>[  325.923540] kworker/-103       4..... 321858884us : intel_rps_mark_interactive: 0000:00:02.0 mark interactive: no
<0>[  325.923613] api_inte-2243      0..... 321861262us : intel_rps_mark_interactive: 0000:00:02.0 mark interactive: yes
<0>[  325.923685] kworker/-150       0..... 321866843us : intel_rps_mark_interactive: 0000:00:02.0 mark interactive: no
<0>[  325.923695] kms_flip-2244      3...1. 321950827us : tracing_mark_write: kms_flip: executing
<0>[  325.923701] kms_flip-2244      3...1. 322012771us : tracing_mark_write: kms_flip: starting subtest 2x-dpms-vs-vblank-race-interruptible
Oops#1 Part15
<0>[  325.923707] kms_flip-2244      3...1. 322022187us : tracing_mark_write: kms_flip: finished subtest 2x-dpms-vs-vblank-race-interruptible, SKIP
<0>[  325.923780] kms_flip-2244      3..... 322027037us : intel_rps_mark_interactive: 0000:00:02.0 mark interactive: yes
<0>[  325.923852] kworker/-89        3..... 322033413us : intel_rps_mark_interactive: 0000:00:02.0 mark interactive: no
<0>[  325.923924] kms_flip-2244      7..... 322034933us : intel_rps_mark_interactive: 0000:00:02.0 mark interactive: yes
<0>[  325.923996] kms_flip-2244      7..... 322042577us : intel_rps_mark_interactive: 0000:00:02.0 mark interactive: yes
<0>[  325.924069] kworker/-172       7..... 322042803us : intel_rps_mark_interactive: 0000:00:02.0 mark interactive: no
<0>[  325.924140] kworker/-172       7..... 322050145us : intel_rps_mark_interactive: 0000:00:02.0 mark interactive: no
<0>[  325.924147] kms_flip-2246      1...1. 322114770us : tracing_mark_write: kms_flip: executing
<0>[  325.924152] kms_flip-2246      1...1. 322174620us : tracing_mark_write: kms_flip: starting subtest plain-flip-interruptible
<0>[  325.924223] kms_flip-2246      0..... 322287599us : intel_rps_mark_interactive: 0000:00:02.0 mark interactive: yes
<0>[  325.924290] kworker/-129       0..... 322297441us : __engine_unpark: 0000:00:02.0 vcs0: 
<0>[  325.924358] kworker/-129       0..... 322297460us : __gt_unpark: 0000:00:02.0 
Oops#1 Part14
<0>[  325.924429] kworker/-129       0..... 322297481us : intel_rps_unpark: 0000:00:02.0 unpark:18
<0>[  325.924501] kworker/-129       0..... 322297483us : rps_set: 0000:00:02.0 set val:18, freq:400, swreq:c000000
<0>[  325.924567] kworker/-129       0..... 322297546us : __engine_unpark: 0000:00:02.0 vcs0: context:7 reset { seqno:1b, *hwsp:1b, ring:d90 }
<0>[  325.924650] kworker/-129       0..... 322297577us : __i915_request_commit: 0000:00:02.0 vcs0: fence 10:4, current 3 
<0>[  325.924734] kworker/-129       0d.s2. 322297603us : __i915_request_submit: 0000:00:02.0 vcs0: fence 10:4, current 3 
Oops#1 Part13
Oops#1 Part12
Oops#1 Part11
Oops#1 Part10
Oops#1 Part9
<0>[  325.924802] kworker/-129       0d.s1. 322297614us : execlists_submission_tasklet: 0000:00:02.0 vcs0: context:10 schedule-in, ccid:20000020
<0>[  325.924869] kworker/-129       0d.s1. 322297617us : trace_ports: 0000:00:02.0 vcs0: submit { ccid:20000020 10:4* prio 1024 }
<0>[  325.924935] kworker/-72        4..s1. 322298148us : process_csb: 0000:00:02.0 vcs0: cs-irq head=4, tail=6
<0>[  325.925001] kworker/-72        4..s1. 322298149us : process_csb: 0000:00:02.0 vcs0: csb[5]: status=0x03ff8000:0x00008009
<0>[  325.925068] kworker/-72        4..s1. 322298151us : trace_ports: 0000:00:02.0 vcs0: promote { ccid:20000020 10:4! prio 1024 }