Oops#1 Part27 <0>[ 325.915821] kworker/-103 4..... 321717374us : intel_rps_mark_interactive: 0000:00:02.0 mark interactive: no <0>[ 325.915828] api_inte-2243 4...1. 321787963us : tracing_mark_write: api_intel_bb: executing <0>[ 325.915834] api_inte-2243 4...1. 321792520us : tracing_mark_write: api_intel_bb: starting subtest misplaced-blitter <0>[ 325.915903] api_inte-2243 4..... 321792705us : __gt_unpark: 0000:00:02.0 <0>[ 325.915975] api_inte-2243 4..... 321792714us : intel_rps_unpark: 0000:00:02.0 unpark:4c <0>[ 325.916047] api_inte-2243 4..... 321792715us : rps_set: 0000:00:02.0 set val:4c, freq:1267, swreq:26000000 <0>[ 325.916113] api_inte-2243 4..... 321792832us : __intel_context_do_pin_ww: 0000:00:02.0 rcs0: context:76 active <0>[ 325.916187] api_inte-2243 4..... 321792932us : intel_timeline_pin: 0000:00:02.0 timeline:76 using HWSP offset:fffce000 <0>[ 325.916254] api_inte-2243 4..... 321793064us : __engine_unpark: 0000:00:02.0 rcs0: <0>[ 325.916322] api_inte-2243 4..... 321793089us : __engine_unpark: 0000:00:02.0 rcs0: context:5 reset { seqno:1a, *hwsp:1a, ring:268 } <0>[ 325.916387] api_inte-2243 4..... 321793091us : __intel_context_do_pin_ww: 0000:00:02.0 rcs0: context:76 pin ring:{start:0086b000, head:0000, tail:0000} <0>[ 325.916452] api_inte-2243 4..... 321793674us : __intel_context_do_unpin.part.0: 0000:00:02.0 rcs0: context:76 unpin <0>[ 325.916517] api_inte-2243 4..... 321793679us : __intel_context_do_pin_ww: 0000:00:02.0 rcs0: context:76 active Oops#1 Part26 <0>[ 325.916582] api_inte-2243 4..... 321793682us : __intel_context_do_pin_ww: 0000:00:02.0 rcs0: context:76 pin ring:{start:0086b000, head:0000, tail:0000} <0>[ 325.916647] api_inte-2243 4..... 321793702us : __intel_context_do_unpin.part.0: 0000:00:02.0 rcs0: context:76 unpin Oops#1 Part25 <0>[ 325.916714] api_inte-2243 4..... 321793711us : __intel_context_do_pin_ww: 0000:00:02.0 rcs0: context:76 active <0>[ 325.916780] api_inte-2243 4..... 321793713us : __intel_context_do_pin_ww: 0000:00:02.0 rcs0: context:76 pin ring:{start:0086b000, head:0000, tail:0000} <0>[ 325.916845] api_inte-2243 4..... 321793736us : __intel_context_do_unpin.part.0: 0000:00:02.0 rcs0: context:76 unpin <0>[ 325.916919] kworker/-72 0d..2. 321793957us : intel_gt_invalidate_tlb_full.part.0: 0000:00:02.0 invalidated engines 00000001 <0>[ 325.916992] api_inte-2243 4..s1. 321794045us : rps_timer: 0000:00:02.0 busy:157912 [4%], max:[157912, 0, 0], interval:1 <0>[ 325.917057] api_inte-2243 4..... 321794454us : __intel_context_do_pin_ww: 0000:00:02.0 rcs0: context:77 active <0>[ 325.917131] api_inte-2243 4..... 321794548us : intel_timeline_pin: 0000:00:02.0 timeline:77 using HWSP offset:fffae000 <0>[ 325.917196] api_inte-2243 4..... 321794650us : __intel_context_do_pin_ww: 0000:00:02.0 rcs0: context:77 pin ring:{start:fffaf000, head:0000, tail:0000} <0>[ 325.917262] api_inte-2243 4..... 321794665us : __intel_context_do_unpin.part.0: 0000:00:02.0 rcs0: context:77 unpin <0>[ 325.917327] api_inte-2243 4..... 321794667us : __intel_context_do_pin_ww: 0000:00:02.0 rcs0: context:77 active <0>[ 325.917392] api_inte-2243 4..... 321794669us : __intel_context_do_pin_ww: 0000:00:02.0 rcs0: context:77 pin ring:{start:fffaf000, head:0000, tail:0000} <0>[ 325.917458] api_inte-2243 4..... 321794690us : __intel_context_do_unpin.part.0: 0000:00:02.0 rcs0: context:77 unpin Oops#1 Part24 <0>[ 325.917523] api_inte-2243 4..... 321794692us : __intel_context_do_pin_ww: 0000:00:02.0 rcs0: context:77 active <0>[ 325.917588] api_inte-2243 4..... 321794693us : __intel_context_do_pin_ww: 0000:00:02.0 rcs0: context:77 pin ring:{start:fffaf000, head:0000, tail:0000} <0>[ 325.917672] api_inte-2243 4..... 321794967us : __i915_request_commit: 0000:00:02.0 rcs0: fence 77:2, current 0 <0>[ 325.917758] api_inte-2243 4d.s2. 321794976us : __i915_request_submit: 0000:00:02.0 rcs0: fence 77:2, current 0 <0>[ 325.917828] api_inte-2243 4d.s1. 321794979us : execlists_submission_tasklet: 0000:00:02.0 rcs0: context:77 schedule-in, ccid:20 <0>[ 325.917895] api_inte-2243 4d.s1. 321794980us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 77:2 prio 0 } <0>[ 325.917963] api_inte-2243 4.ls1. 321795047us : process_csb: 0000:00:02.0 rcs0: cs-irq head=6, tail=8 <0>[ 325.918030] api_inte-2243 4.ls1. 321795047us : process_csb: 0000:00:02.0 rcs0: csb[7]: status=0x03ff8000:0x00008001 <0>[ 325.918096] api_inte-2243 4.ls1. 321795048us : trace_ports: 0000:00:02.0 rcs0: promote { ccid:20 77:2! prio 0 } <0>[ 325.918163] api_inte-2243 4.ls1. 321795050us : process_csb: 0000:00:02.0 rcs0: csb[8]: status=0x00008000:0x03ff8000 <0>[ 325.918229] api_inte-2243 4.ls1. 321795051us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 77:2! prio 0 } <0>[ 325.918296] api_inte-2243 4.ls1. 321795052us : __execlists_schedule_out: 0000:00:02.0 rcs0: context:77 schedule-out, ccid:20 <0>[ 325.918379] api_inte-2243 4.l... 321795072us : __i915_request_commit: 0000:00:02.0 rcs0: fence 5:27, current 26 Oops#1 Part23 <0>[ 325.918461] api_inte-2243 4dls2. 321795087us : __i915_request_submit: 0000:00:02.0 rcs0: fence 5:27, current 26 <0>[ 325.918528] api_inte-2243 4dls1. 321795097us : execlists_submission_tasklet: 0000:00:02.0 rcs0: context:5 schedule-in, ccid:20 <0>[ 325.918595] api_inte-2243 4dls1. 321795098us : trace_ports: 0000:00:02.0 rcs0: submit { ccid:20 5:27* prio 2147483646 } <0>[ 325.918662] kworker/-85 4..s1. 321795110us : process_csb: 0000:00:02.0 rcs0: cs-irq head=8, tail=9 <0>[ 325.918731] kworker/-85 4..s1. 321795110us : process_csb: 0000:00:02.0 rcs0: csb[9]: status=0x03ff8000:0x00008001 <0>[ 325.918798] kworker/-85 4..s1. 321795111us : trace_ports: 0000:00:02.0 rcs0: promote { ccid:20 5:27* prio 2147483646 } <0>[ 325.918872] kworker/-85 4..... 321795113us : rps_work: 0000:00:02.0 pm_iir:10, client_boost:no, last:-2, cur:4c, min:6, max:4e <0>[ 325.918945] kworker/-85 4..... 321795114us : rps_set: 0000:00:02.0 set val:48, freq:1200, swreq:24000000 <0>[ 325.919027] kworker/-85 4..... 321795119us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 77:2, current 2 <0>[ 325.919094] kworker/-85 4..s.. 321795121us : process_csb: 0000:00:02.0 rcs0: cs-irq head=9, tail=10 <0>[ 325.919161] kworker/-85 4..s.. 321795122us : process_csb: 0000:00:02.0 rcs0: csb[10]: status=0x00008000:0x03ff8000 <0>[ 325.919227] kworker/-85 4..s.. 321795123us : trace_ports: 0000:00:02.0 rcs0: completed { ccid:20 5:27! prio 2147483646 } <0>[ 325.919294] kworker/-85 4..s.. 321795123us : __execlists_schedule_out: 0000:00:02.0 rcs0: context:5 schedule-out, ccid:20 Oops#1 Part22 <0>[ 325.919359] kworker/-85 4..... 321795137us : __intel_context_do_unpin.part.0: 0000:00:02.0 rcs0: context:77 unpin <0>[ 325.919440] kworker/-85 4..... 321795140us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 5:27, current 27 <0>[ 325.919506] kworker/-85 4d..1. 321795143us : __intel_context_retire: 0000:00:02.0 rcs0: context:76 retire runtime: { total:0ns, avg:0ns } <0>[ 325.919581] kworker/-72 0d..2. 321795407us : intel_gt_invalidate_tlb_full.part.0: 0000:00:02.0 invalidated engines 00000001 <0>[ 325.919647] api_inte-2243 4..... 321796012us : __intel_context_do_pin_ww: 0000:00:02.0 bcs0: context:78 active <0>[ 325.919721] api_inte-2243 4..s.. 321796036us : rps_timer: 0000:00:02.0 busy:103995 [5%], max:[103995, 0, 0], interval:2 <0>[ 325.919796] api_inte-2243 4.l... 321796141us : intel_timeline_pin: 0000:00:02.0 timeline:78 using HWSP offset:fff98000 <0>[ 325.919863] api_inte-2243 4.l... 321796231us : __engine_unpark: 0000:00:02.0 bcs0: <0>[ 325.919929] api_inte-2243 4.l... 321796242us : __engine_unpark: 0000:00:02.0 bcs0: context:6 reset { seqno:fa, *hwsp:fa, ring:d48 } <0>[ 325.919994] api_inte-2243 4.l... 321796243us : __intel_context_do_pin_ww: 0000:00:02.0 bcs0: context:78 pin ring:{start:fff99000, head:0000, tail:0000} <0>[ 325.920059] api_inte-2243 4.l... 321796257us : __intel_context_do_unpin.part.0: 0000:00:02.0 bcs0: context:78 unpin <0>[ 325.920124] api_inte-2243 4.l... 321796259us : __intel_context_do_pin_ww: 0000:00:02.0 bcs0: context:78 active