Results for igt@sysfs_heartbeat_interval@mixed@ccs0

Result: Incomplete 1056 Warning(s)

git-log-oneline i915_display_info21 igt_runner21 runtimes21 results21.json results21-i915-load.json i915_display_info_post_exec21 boot21 dmesg21

DetailValue
Duration unknown
Hostname 
shard-dg2-11
Igt-Version 
IGT-Version: 2.1-g994557ecd (x86_64) (Linux: 6.17.0-rc2-CI_DRM_17043-g16e133c7e692+ x86_64)
Out 
This test caused an abort condition: Lockdep not active

/proc/lockdep_stats contents:
 lock-classes:                         2299 [max: 8192]
 dynamic-keys:                          315
 direct dependencies:                 26464 [max: 524288]
 indirect dependencies:              255653
 all direct dependencies:            574738
 dependency chains:                   41681 [max: 524288]
 dependency chain hlocks used:       191755 [max: 2621440]
 dependency chain hlocks lost:            0
 in-hardirq chains:                     344
 in-softirq chains:                     899
 in-process chains:                   40438
 stack-trace entries:                339988 [max: 524288]
 number of stack traces:              14797
 number of stack hash chains:          9690
 combined max dependencies:      3966374908
 hardirq-safe locks:                    124
 hardirq-unsafe locks:                 1334
 softirq-safe locks:                    268
 softirq-unsafe locks:                 1227
 irq-safe locks:                        287
 irq-unsafe locks:                     1334
 hardirq-read-safe locks:                 6
 hardirq-read-unsafe locks:             425
 softirq-read-safe locks:                12
 softirq-read-unsafe locks:             421
 irq-read-safe locks:                    12
 irq-read-unsafe locks:                 425
 uncategorized locks:                   392
 unused locks:                            1
 max locking depth:                      18
 max bfs queue depth:                   428
 max lock class index:                 2298
 debug_locks:                             0

 zapped classes:                        961
 zapped lock chains:                  20906
 large chain blocks:                      2
Starting dynamic subtest: ccs0
Err 
Starting dynamic subtest: ccs0
Dmesg

Scroll to first warning
<0> [445.574692] sysfs_he-2776 5..... 431397253us : tracing_mark_write: sysfs_heartbeat_interval: starting subtest mixed
<0> [445.574773] sysfs_he-2776 5..... 431433370us : __engine_unpark: 0000:03:00.0 vecs0:
<0> [445.574854] sysfs_he-2776 5..... 431433381us : __gt_unpark: 0000:03:00.0
<0> [445.574933] sysfs_he-2776 5..... 431433644us : __engine_unpark: 0000:03:00.0 vecs0: context:88e reset { seqno:31, *hwsp:31, ring:dd8 }
<0> [445.575031] sysfs_he-2776 5..... 431433668us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:50, current 49
<0> [445.575127] sysfs_he-2776 5D..1. 431433675us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:50, current 49
<0> [445.575209] sysfs_he-2777 3..... 431443100us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f61 active
<0> [445.575298] sysfs_he-2777 3..... 431443301us : intel_timeline_pin: 0000:03:00.0 timeline:f61 using HWSP offset:fede3000
<0> [445.575381] sysfs_he-2777 3..... 431443485us : __engine_unpark: 0000:03:00.0 rcs0:
<0> [445.575460] sysfs_he-2777 3..... 431443553us : __engine_unpark: 0000:03:00.0 rcs0: context:88a reset { seqno:14f, *hwsp:14f, ring:f88 }
<0> [445.575542] sysfs_he-2777 3..... 431443555us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f61 pin ring:{start:fec50000, head:0000, tail:0000}
<0> [445.575642] sysfs_he-2777 3..... 431444531us : __i915_request_commit: 0000:03:00.0 rcs0: fence f61:2, current 0
<0> [445.575739] sysfs_he-2777 3D..1. 431444538us : __i915_request_submit: 0000:03:00.0 rcs0: fence f61:2, current 0
<0> [445.575835] sysfs_he-2777 3..... 431444613us : __i915_request_commit: 0000:03:00.0 rcs0: fence 88a:336, current 335
<0> [445.575932] sysfs_he-2777 3D..1. 431444618us : __i915_request_submit: 0000:03:00.0 rcs0: fence 88a:336, current 335
<0> [445.576014] sysfs_he-2777 3..... 431446341us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f62 active
<0> [445.576103] sysfs_he-2777 3..... 431446478us : intel_timeline_pin: 0000:03:00.0 timeline:f62 using HWSP offset:fede2000
<0> [445.576184] sysfs_he-2777 3..... 431446608us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f62 pin ring:{start:fec20000, head:0000, tail:0000}
<0> [445.576269] sysfs_he-2777 3..... 431446699us : __engine_unpark: 0000:03:00.0 bcs0:
<0> [445.576349] sysfs_he-2777 3..... 431446847us : __engine_unpark: 0000:03:00.0 bcs0: context:88b reset { seqno:125, *hwsp:125, ring:300 }
<0> [445.576447] sysfs_he-2777 3..... 431446873us : __i915_request_commit: 0000:03:00.0 bcs0: fence 898:1007, current 1006
<0> [445.576543] sysfs_he-2777 3D..1. 431446878us : __i915_request_submit: 0000:03:00.0 bcs0: fence 898:1007, current 1006
<0> [445.576639] kworker/-379 0..... 431447547us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 898:1007, current 1007
<0> [445.576722] kworker/-379 0..... 431447555us : __engine_park: 0000:03:00.0 bcs0: parked
<0> [445.576817] sysfs_he-2777 3..... 431447688us : __i915_request_commit: 0000:03:00.0 rcs0: fence f62:2, current 0
<0> [445.576913] sysfs_he-2777 3D..1. 431447693us : __i915_request_submit: 0000:03:00.0 rcs0: fence f62:2, current 0
<0> [445.576994] sysfs_he-2778 2..... 431448270us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f63 active
<0> [445.577082] sysfs_he-2778 2..... 431448403us : intel_timeline_pin: 0000:03:00.0 timeline:f63 using HWSP offset:fede1000
<0> [445.577163] sysfs_he-2778 2..... 431448543us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f63 pin ring:{start:febf0000, head:0000, tail:0000}
<0> [445.577263] sysfs_he-2778 2..... 431449268us : __i915_request_commit: 0000:03:00.0 rcs0: fence f63:2, current 0
<0> [445.577359] sysfs_he-2778 2D..1. 431449273us : __i915_request_submit: 0000:03:00.0 rcs0: fence f63:2, current 0
<0> [445.577440] sysfs_he-2777 3..... 431449824us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f64 active
<0> [445.577529] sysfs_he-2777 3..... 431450000us : intel_timeline_pin: 0000:03:00.0 timeline:f64 using HWSP offset:fede0000
<0> [445.577610] sysfs_he-2777 3..... 431450173us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f64 pin ring:{start:febc0000, head:0000, tail:0000}
<0> [445.577694] sysfs_he-2778 2..... 431451377us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f65 active
<0> [445.577790] sysfs_he-2777 3..... 431451527us : __i915_request_commit: 0000:03:00.0 rcs0: fence f64:2, current 0
<0> [445.577886] sysfs_he-2777 3D..1. 431451531us : __i915_request_submit: 0000:03:00.0 rcs0: fence f64:2, current 0
<0> [445.577976] sysfs_he-2778 2..... 431451534us : intel_timeline_pin: 0000:03:00.0 timeline:f65 using HWSP offset:feb8f000
<0> [445.578073] sysfs_he-2777 3..... 431451582us : __i915_request_commit: 0000:03:00.0 rcs0: fence 88a:337, current 336
<0> [445.578169] sysfs_he-2777 3D..1. 431451586us : __i915_request_submit: 0000:03:00.0 rcs0: fence 88a:337, current 336
<0> [445.578251] sysfs_he-2778 2..... 431451662us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f65 pin ring:{start:feb90000, head:0000, tail:0000}
<0> [445.578336] sysfs_he-2778 2..... 431451729us : __engine_unpark: 0000:03:00.0 bcs0:
<0> [445.578416] sysfs_he-2778 2..... 431451767us : __engine_unpark: 0000:03:00.0 bcs0: context:88b reset { seqno:125, *hwsp:125, ring:300 }
<0> [445.578514] sysfs_he-2778 2..... 431451792us : __i915_request_commit: 0000:03:00.0 bcs0: fence 898:1008, current 1007
<0> [445.578610] sysfs_he-2778 2D..1. 431451796us : __i915_request_submit: 0000:03:00.0 bcs0: fence 898:1008, current 1007
<0> [445.578707] sysfs_he-2778 2..... 431452587us : __i915_request_commit: 0000:03:00.0 rcs0: fence f65:2, current 0
<0> [445.578803] kworker/-379 0..... 431452647us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 898:1008, current 1008
<0> [445.578886] kworker/-379 0..... 431452653us : __engine_park: 0000:03:00.0 bcs0: parked
<0> [445.578980] kworker/-58 4d..2. 431452707us : __i915_request_submit: 0000:03:00.0 rcs0: fence f65:2, current 0
<0> [445.579061] sysfs_he-2777 3..... 431453279us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f66 active
<0> [445.579150] sysfs_he-2777 3..... 431453426us : intel_timeline_pin: 0000:03:00.0 timeline:f66 using HWSP offset:feb8e000
<0> [445.579231] sysfs_he-2777 3..... 431453574us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f66 pin ring:{start:feb50000, head:0000, tail:0000}
<0> [445.579316] sysfs_he-2777 3..... 431454315us : __engine_unpark: 0000:03:00.0 bcs0:
<0> [445.579396] sysfs_he-2777 3..... 431454354us : __engine_unpark: 0000:03:00.0 bcs0: context:88b reset { seqno:125, *hwsp:125, ring:300 }
<0> [445.579493] sysfs_he-2777 3..... 431454374us : __i915_request_commit: 0000:03:00.0 bcs0: fence 898:1009, current 1008
<0> [445.579590] sysfs_he-2777 3D..1. 431454379us : __i915_request_submit: 0000:03:00.0 bcs0: fence 898:1009, current 1008
<0> [445.579687] kworker/-379 0..... 431454561us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 898:1009, current 1009
<0> [445.579769] kworker/-379 0..... 431454566us : __engine_park: 0000:03:00.0 bcs0: parked
<0> [445.579848] sysfs_he-2778 2..... 431454791us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f67 active
<0> [445.579937] sysfs_he-2778 2..... 431454929us : intel_timeline_pin: 0000:03:00.0 timeline:f67 using HWSP offset:feb8d000
<0> [445.580018] sysfs_he-2778 2..... 431455181us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f67 pin ring:{start:feb20000, head:0000, tail:0000}
<0> [445.580101] sysfs_he-2778 2..... 431455195us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:f67 unpin
<0> [445.580182] sysfs_he-2777 3..... 431455770us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:f66 unpin
<0> [445.580263] sysfs_he-2778 2..... 431455898us : __intel_context_retire: 0000:03:00.0 rcs0: context:f67 retire runtime: { total:0ns, avg:0ns }
<0> [445.580346] sysfs_he-2778 2..... 431455902us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f67 active
<0> [445.580434] sysfs_he-2778 2..... 431455903us : intel_timeline_pin: 0000:03:00.0 timeline:f67 using HWSP offset:feb8d000
<0> [445.580515] sysfs_he-2778 2..... 431455907us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f67 pin ring:{start:feb20000, head:0000, tail:0000}
<0> [445.580599] sysfs_he-2777 3..... 431456670us : __intel_context_retire: 0000:03:00.0 rcs0: context:f66 retire runtime: { total:0ns, avg:0ns }
<0> [445.580682] sysfs_he-2777 3..... 431456699us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f66 active
<0> [445.580771] sysfs_he-2777 3..... 431456702us : intel_timeline_pin: 0000:03:00.0 timeline:f66 using HWSP offset:feb8e000
<0> [445.580852] sysfs_he-2777 3..... 431456706us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f66 pin ring:{start:feb50000, head:0000, tail:0000}
<0> [445.580936] sysfs_he-2777 3..... 431456718us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:f66 unpin
<0> [445.581032] sysfs_he-2778 2..... 431457341us : __i915_request_commit: 0000:03:00.0 rcs0: fence f67:2, current 0
<0> [445.581128] sysfs_he-2778 2D..1. 431457346us : __i915_request_submit: 0000:03:00.0 rcs0: fence f67:2, current 0
<0> [445.581225] sysfs_he-2778 2..... 431457397us : __i915_request_commit: 0000:03:00.0 rcs0: fence 88a:338, current 337
<0> [445.581321] sysfs_he-2778 2D..1. 431457401us : __i915_request_submit: 0000:03:00.0 rcs0: fence 88a:338, current 337
<0> [445.581403] sysfs_he-2777 3..... 431457412us : __intel_context_retire: 0000:03:00.0 rcs0: context:f66 retire runtime: { total:0ns, avg:0ns }
<0> [445.581486] sysfs_he-2777 3..... 431457416us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f66 active
<0> [445.581575] sysfs_he-2777 3..... 431457417us : intel_timeline_pin: 0000:03:00.0 timeline:f66 using HWSP offset:feb8e000
<0> [445.581656] sysfs_he-2777 3..... 431457421us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f66 pin ring:{start:feb50000, head:0000, tail:0000}
<0> [445.581739] sysfs_he-2777 3..... 431458749us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:f66 unpin
<0> [445.581821] sysfs_he-2778 2..... 431459093us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f68 active
<0> [445.581909] sysfs_he-2778 2..... 431459244us : intel_timeline_pin: 0000:03:00.0 timeline:f68 using HWSP offset:feb8c000
<0> [445.581990] sysfs_he-2778 2..... 431459382us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f68 pin ring:{start:feaf0000, head:0000, tail:0000}
<0> [445.582074] sysfs_he-2778 2..... 431459396us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:f68 unpin
<0> [445.582154] sysfs_he-2777 3..... 431459481us : __intel_context_retire: 0000:03:00.0 rcs0: context:f66 retire runtime: { total:0ns, avg:0ns }
<0> [445.582236] sysfs_he-2777 3..... 431459508us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f66 active
<0> [445.582324] sysfs_he-2777 3..... 431459510us : intel_timeline_pin: 0000:03:00.0 timeline:f66 using HWSP offset:feb8e000
<0> [445.582405] sysfs_he-2777 3..... 431459514us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f66 pin ring:{start:feb50000, head:0000, tail:0000}
<0> [445.582489] sysfs_he-2777 3..... 431459542us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:f66 unpin
<0> [445.582570] sysfs_he-2778 2..... 431460837us : __intel_context_retire: 0000:03:00.0 rcs0: context:f68 retire runtime: { total:0ns, avg:0ns }
<0> [445.582652] sysfs_he-2778 2..... 431460841us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f68 active
<0> [445.582740] sysfs_he-2778 2..... 431460843us : intel_timeline_pin: 0000:03:00.0 timeline:f68 using HWSP offset:feb8c000
<0> [445.582821] sysfs_he-2778 2..... 431460847us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f68 pin ring:{start:feaf0000, head:0000, tail:0000}
<0> [445.582905] sysfs_he-2778 2..... 431460858us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:f68 unpin
<0> [445.582986] sysfs_he-2777 3.N... 431461141us : __intel_context_retire: 0000:03:00.0 rcs0: context:f66 retire runtime: { total:0ns, avg:0ns }
<0> [445.583069] sysfs_he-2777 3..... 431461320us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f66 active
<0> [445.583157] sysfs_he-2777 3..... 431461322us : intel_timeline_pin: 0000:03:00.0 timeline:f66 using HWSP offset:feb8e000
<0> [445.583238] sysfs_he-2777 3..... 431461327us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f66 pin ring:{start:feb50000, head:0000, tail:0000}
<0> [445.583322] sysfs_he-2777 3..... 431461340us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:f66 unpin
<0> [445.583403] sysfs_he-2778 2..... 431462208us : __intel_context_retire: 0000:03:00.0 rcs0: context:f68 retire runtime: { total:0ns, avg:0ns }
<0> [445.583486] sysfs_he-2778 2..... 431462211us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f68 active
<0> [445.583575] sysfs_he-2778 2..... 431462212us : intel_timeline_pin: 0000:03:00.0 timeline:f68 using HWSP offset:feb8c000
<0> [445.583655] sysfs_he-2778 2..... 431462216us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f68 pin ring:{start:feaf0000, head:0000, tail:0000}
<0> [445.583740] sysfs_he-2777 3..... 431462561us : __intel_context_retire: 0000:03:00.0 rcs0: context:f66 retire runtime: { total:0ns, avg:0ns }
<0> [445.583822] sysfs_he-2777 3..... 431462564us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f66 active
<0> [445.583910] sysfs_he-2777 3..... 431462565us : intel_timeline_pin: 0000:03:00.0 timeline:f66 using HWSP offset:feb8e000
<0> [445.583991] sysfs_he-2777 3..... 431462569us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f66 pin ring:{start:feb50000, head:0000, tail:0000}
<0> [445.584076] sysfs_he-2778 2..... 431462840us : __engine_unpark: 0000:03:00.0 bcs0:
<0> [445.584155] sysfs_he-2778 2..... 431462878us : __engine_unpark: 0000:03:00.0 bcs0: context:88b reset { seqno:125, *hwsp:125, ring:300 }
<0> [445.584254] sysfs_he-2778 2..... 431462898us : __i915_request_commit: 0000:03:00.0 bcs0: fence 898:1010, current 1009
<0> [445.584351] sysfs_he-2778 2D..1. 431462902us : __i915_request_submit: 0000:03:00.0 bcs0: fence 898:1010, current 1009
<0> [445.584448] kworker/-379 0..... 431463083us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 898:1010, current 1010
<0> [445.584531] kworker/-379 0..... 431463090us : __engine_park: 0000:03:00.0 bcs0: parked
<0> [445.584609] sysfs_he-2777 3..... 431463835us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:f66 unpin
<0> [445.584690] sysfs_he-2778 2..... 431464168us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:f68 unpin
<0> [445.584771] sysfs_he-2777 3..... 431465172us : __intel_context_retire: 0000:03:00.0 rcs0: context:f66 retire runtime: { total:0ns, avg:0ns }
<0> [445.584854] sysfs_he-2777 3..... 431465200us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f66 active
<0> [445.584942] sysfs_he-2777 3..... 431465202us : intel_timeline_pin: 0000:03:00.0 timeline:f66 using HWSP offset:feb8e000
<0> [445.585024] sysfs_he-2777 3..... 431465207us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f66 pin ring:{start:feb50000, head:0000, tail:0000}
<0> [445.585107] sysfs_he-2778 2..... 431465465us : __intel_context_retire: 0000:03:00.0 rcs0: context:f68 retire runtime: { total:0ns, avg:0ns }
<0> [445.585191] sysfs_he-2778 2..... 431465493us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f68 active
<0> [445.585279] sysfs_he-2778 2..... 431465495us : intel_timeline_pin: 0000:03:00.0 timeline:f68 using HWSP offset:feb8c000
<0> [445.585361] sysfs_he-2778 2..... 431465499us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f68 pin ring:{start:feaf0000, head:0000, tail:0000}
<0> [445.585444] sysfs_he-2777 3..... 431466511us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:f66 unpin
<0> [445.585525] sysfs_he-2778 2..... 431467121us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:f68 unpin
<0> [445.585606] sysfs_he-2777 3..... 431467568us : __intel_context_retire: 0000:03:00.0 rcs0: context:f66 retire runtime: { total:0ns, avg:0ns }
<0> [445.585689] sysfs_he-2777 3..... 431467594us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f66 active
<0> [445.585778] sysfs_he-2777 3..... 431467596us : intel_timeline_pin: 0000:03:00.0 timeline:f66 using HWSP offset:feb8e000
<0> [445.585860] sysfs_he-2777 3..... 431467600us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f66 pin ring:{start:feb50000, head:0000, tail:0000}
<0> [445.585944] sysfs_he-2778 2..... 431468012us : __intel_context_retire: 0000:03:00.0 rcs0: context:f68 retire runtime: { total:0ns, avg:0ns }
<0> [445.586027] sysfs_he-2778 2..... 431468038us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f68 active
<0> [445.586116] sysfs_he-2778 2..... 431468040us : intel_timeline_pin: 0000:03:00.0 timeline:f68 using HWSP offset:feb8c000
<0> [445.586197] sysfs_he-2778 2..... 431468045us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f68 pin ring:{start:feaf0000, head:0000, tail:0000}
<0> [445.586297] sysfs_he-2777 3..... 431468333us : __i915_request_commit: 0000:03:00.0 rcs0: fence f66:2, current 0
<0> [445.586394] sysfs_he-2777 3D..1. 431468338us : __i915_request_submit: 0000:03:00.0 rcs0: fence f66:2, current 0
<0> [445.586490] sysfs_he-2777 3..... 431468388us : __i915_request_commit: 0000:03:00.0 rcs0: fence 88a:339, current 338
<0> [445.586587] sysfs_he-2777 3D..1. 431468392us : __i915_request_submit: 0000:03:00.0 rcs0: fence 88a:339, current 338
<0> [445.586667] sysfs_he-2778 2..... 431469341us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:f68 unpin
<0> [445.586749] sysfs_he-2778 2..... 431470034us : __intel_context_retire: 0000:03:00.0 rcs0: context:f68 retire runtime: { total:0ns, avg:0ns }
<0> [445.586831] sysfs_he-2778 2..... 431470059us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f68 active
<0> [445.586920] sysfs_he-2778 2..... 431470061us : intel_timeline_pin: 0000:03:00.0 timeline:f68 using HWSP offset:feb8c000
<0> [445.587001] sysfs_he-2778 2..... 431470065us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f68 pin ring:{start:feaf0000, head:0000, tail:0000}
<0> [445.587085] sysfs_he-2777 3..... 431470125us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f69 active
<0> [445.587174] sysfs_he-2777 3..... 431470262us : intel_timeline_pin: 0000:03:00.0 timeline:f69 using HWSP offset:feb8b000
<0> [445.587255] sysfs_he-2777 3..... 431470401us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f69 pin ring:{start:feac0000, head:0000, tail:0000}
<0> [445.587339] sysfs_he-2777 3..... 431470508us : __engine_unpark: 0000:03:00.0 bcs0:
<0> [445.587419] sysfs_he-2777 3..... 431470546us : __engine_unpark: 0000:03:00.0 bcs0: context:88b reset { seqno:125, *hwsp:125, ring:300 }
<0> [445.587517] sysfs_he-2777 3..... 431470570us : __i915_request_commit: 0000:03:00.0 bcs0: fence 898:1011, current 1010
<0> [445.587613] sysfs_he-2777 3D..1. 431470574us : __i915_request_submit: 0000:03:00.0 bcs0: fence 898:1011, current 1010
<0> [445.587709] kworker/-379 0..... 431470785us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 898:1011, current 1011
<0> [445.587793] kworker/-379 0..... 431470792us : __engine_park: 0000:03:00.0 bcs0: parked
<0> [445.587871] sysfs_he-2777 3..... 431471329us : __engine_unpark: 0000:03:00.0 bcs0:
<0> [445.587951] sysfs_he-2777 3..... 431471367us : __engine_unpark: 0000:03:00.0 bcs0: context:88b reset { seqno:125, *hwsp:125, ring:300 }
<0> [445.588049] sysfs_he-2777 3..... 431471387us : __i915_request_commit: 0000:03:00.0 bcs0: fence 898:1012, current 1011
<0> [445.588145] sysfs_he-2777 3D..1. 431471391us : __i915_request_submit: 0000:03:00.0 bcs0: fence 898:1012, current 1011
<0> [445.588226] sysfs_he-2778 2..... 431471447us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:f68 unpin
<0> [445.588322] kworker/-379 0..... 431471565us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 898:1012, current 1012
<0> [445.588405] kworker/-379 0..... 431471572us : __engine_park: 0000:03:00.0 bcs0: parked
<0> [445.588498] sysfs_he-2777 3..... 431472105us : __i915_request_commit: 0000:03:00.0 rcs0: fence f69:2, current 0
<0> [445.588594] sysfs_he-2777 3D..1. 431472110us : __i915_request_submit: 0000:03:00.0 rcs0: fence f69:2, current 0
<0> [445.588675] sysfs_he-2778 2..... 431472136us : __intel_context_retire: 0000:03:00.0 rcs0: context:f68 retire runtime: { total:0ns, avg:0ns }
<0> [445.588773] sysfs_he-2777 3..... 431472160us : __i915_request_commit: 0000:03:00.0 rcs0: fence 88a:340, current 339
<0> [445.588854] sysfs_he-2778 2..... 431472163us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f68 active
<0> [445.588950] sysfs_he-2777 3D..1. 431472163us : __i915_request_submit: 0000:03:00.0 rcs0: fence 88a:340, current 339
<0> [445.589039] sysfs_he-2778 2..... 431472165us : intel_timeline_pin: 0000:03:00.0 timeline:f68 using HWSP offset:feb8c000
<0> [445.589121] sysfs_he-2778 2..... 431472169us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f68 pin ring:{start:feaf0000, head:0000, tail:0000}
<0> [445.589221] sysfs_he-2778 2..... 431472832us : __i915_request_commit: 0000:03:00.0 rcs0: fence f68:2, current 0
<0> [445.589317] sysfs_he-2778 2D..1. 431472837us : __i915_request_submit: 0000:03:00.0 rcs0: fence f68:2, current 0
<0> [445.589398] sysfs_he-2777 3..... 431473803us : __intel_context_do_pin_ww: 0000:03:00.0 vecs0: context:f6a active
<0> [445.589487] sysfs_he-2777 3..... 431474047us : intel_timeline_pin: 0000:03:00.0 timeline:f6a using HWSP offset:feb8a000
<0> [445.589568] sysfs_he-2777 3..... 431474161us : __intel_context_do_pin_ww: 0000:03:00.0 vecs0: context:f6a pin ring:{start:fea90000, head:0000, tail:0000}
<0> [445.589653] sysfs_he-2778 2..... 431475399us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f6b active
<0> [445.589748] sysfs_he-2777 3..... 431475545us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:2, current 0
<0> [445.589845] sysfs_he-2777 3D..1. 431475550us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:2, current 0
<0> [445.589934] sysfs_he-2778 2..... 431475556us : intel_timeline_pin: 0000:03:00.0 timeline:f6b using HWSP offset:feb89000
<0> [445.590016] sysfs_he-2778 2..... 431475708us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f6b pin ring:{start:fea70000, head:0000, tail:0000}
<0> [445.590100] sysfs_he-2778 2..... 431475722us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:f6b unpin
<0> [445.590181] sysfs_he-2778 2..... 431476401us : __intel_context_retire: 0000:03:00.0 rcs0: context:f6b retire runtime: { total:0ns, avg:0ns }
<0> [445.590263] sysfs_he-2778 2..... 431476405us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f6b active
<0> [445.590351] sysfs_he-2778 2..... 431476406us : intel_timeline_pin: 0000:03:00.0 timeline:f6b using HWSP offset:feb89000
<0> [445.590433] sysfs_he-2778 2..... 431476410us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:f6b pin ring:{start:fea70000, head:0000, tail:0000}
<0> [445.590518] sysfs_he-2778 2..... 431476474us : __engine_unpark: 0000:03:00.0 bcs0:
<0> [445.590597] sysfs_he-2778 2..... 431476514us : __engine_unpark: 0000:03:00.0 bcs0: context:88b reset { seqno:125, *hwsp:125, ring:300 }
<0> [445.590695] sysfs_he-2778 2..... 431476538us : __i915_request_commit: 0000:03:00.0 bcs0: fence 898:1013, current 1012
<0> [445.590792] sysfs_he-2778 2D..1. 431476542us : __i915_request_submit: 0000:03:00.0 bcs0: fence 898:1013, current 1012
<0> [445.590889] kworker/-379 0..... 431476736us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 898:1013, current 1013
<0> [445.590972] kworker/-379 0..... 431476744us : __engine_park: 0000:03:00.0 bcs0: parked
<0> [445.591052] sysfs_he-2778 2..... 431477335us : __engine_unpark: 0000:03:00.0 bcs0:
<0> [445.591130] sysfs_he-2778 2..... 431477374us : __engine_unpark: 0000:03:00.0 bcs0: context:88b reset { seqno:125, *hwsp:125, ring:300 }
<0> [445.591228] sysfs_he-2778 2..... 431477394us : __i915_request_commit: 0000:03:00.0 bcs0: fence 898:1014, current 1013
<0> [445.591325] sysfs_he-2778 2D..1. 431477398us : __i915_request_submit: 0000:03:00.0 bcs0: fence 898:1014, current 1013
<0> [445.591422] kworker/-379 0..... 431477553us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 898:1014, current 1014
<0> [445.591504] kworker/-379 0..... 431477560us : __engine_park: 0000:03:00.0 bcs0: parked
<0> [445.591599] sysfs_he-2778 2..... 431478119us : __i915_request_commit: 0000:03:00.0 rcs0: fence f6b:2, current 0
<0> [445.591695] sysfs_he-2778 2D..1. 431478124us : __i915_request_submit: 0000:03:00.0 rcs0: fence f6b:2, current 0
<0> [445.591793] sysfs_he-2778 2..... 431478171us : __i915_request_commit: 0000:03:00.0 rcs0: fence 88a:341, current 340
<0> [445.591889] sysfs_he-2778 2D..1. 431478175us : __i915_request_submit: 0000:03:00.0 rcs0: fence 88a:341, current 340
<0> [445.591971] sysfs_he-2778 2..... 431479832us : __intel_context_do_pin_ww: 0000:03:00.0 vecs0: context:f6c active
<0> [445.592060] sysfs_he-2778 2..... 431480018us : intel_timeline_pin: 0000:03:00.0 timeline:f6c using HWSP offset:feb88000
<0> [445.592141] sysfs_he-2778 2..... 431480133us : __intel_context_do_pin_ww: 0000:03:00.0 vecs0: context:f6c pin ring:{start:fea40000, head:0000, tail:0000}
<0> [445.592225] sysfs_he-2778 2..... 431480146us : __intel_context_do_unpin.part.0: 0000:03:00.0 vecs0: context:f6c unpin
<0> [445.592306] sysfs_he-2778 2..... 431480762us : __intel_context_retire: 0000:03:00.0 vecs0: context:f6c retire runtime: { total:0ns, avg:0ns }
<0> [445.592390] sysfs_he-2778 2..... 431480765us : __intel_context_do_pin_ww: 0000:03:00.0 vecs0: context:f6c active
<0> [445.592478] sysfs_he-2778 2..... 431480767us : intel_timeline_pin: 0000:03:00.0 timeline:f6c using HWSP offset:feb88000
<0> [445.592560] sysfs_he-2778 2..... 431480771us : __intel_context_do_pin_ww: 0000:03:00.0 vecs0: context:f6c pin ring:{start:fea40000, head:0000, tail:0000}
<0> [445.592644] sysfs_he-2778 2..... 431480782us : __intel_context_do_unpin.part.0: 0000:03:00.0 vecs0: context:f6c unpin
<0> [445.592725] sysfs_he-2778 2..... 431481442us : __intel_context_retire: 0000:03:00.0 vecs0: context:f6c retire runtime: { total:0ns, avg:0ns }
<0> [445.592808] sysfs_he-2778 2..... 431481445us : __intel_context_do_pin_ww: 0000:03:00.0 vecs0: context:f6c active
<0> [445.592897] sysfs_he-2778 2..... 431481446us : intel_timeline_pin: 0000:03:00.0 timeline:f6c using HWSP offset:feb88000
<0> [445.592978] sysfs_he-2778 2..... 431481450us : __intel_context_do_pin_ww: 0000:03:00.0 vecs0: context:f6c pin ring:{start:fea40000, head:0000, tail:0000}
<0> [445.593078] sysfs_he-2778 2..... 431482798us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6c:2, current 0
<0> [445.593175] sysfs_he-2778 2D..1. 431482803us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6c:2, current 0
<0> [445.593271] kworker/-379 0..... 431485908us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:2, current 2
<0> [445.593361] kworker/-2101 4d..2. 431486145us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.593452] kworker/-2101 4d..2. 431486231us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.593549] sysfs_he-2777 3..... 431487525us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:4, current 2
<0> [445.593646] sysfs_he-2777 3D..1. 431487530us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:4, current 2
<0> [445.593743] kworker/-181 5..... 431488986us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:51, current 50
<0> [445.593839] kworker/-181 5D..1. 431489159us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:51, current 50
<0> [445.593936] kworker/-379 0..... 431523795us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:4, current 4
<0> [445.594026] kworker/-58 0dN.2. 431524133us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.594116] sysfs_he-2777 3d..2. 431524318us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.594213] sysfs_he-2777 3..... 431525924us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:6, current 4
<0> [445.594310] sysfs_he-2777 3D..1. 431525929us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:6, current 4
<0> [445.594406] kworker/-379 0..... 431536281us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:6, current 6
<0> [445.594496] sysfs_he-2777 3d..2. 431536650us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.594586] sysfs_he-2777 3d..2. 431536749us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.594683] sysfs_he-2777 3..... 431538255us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:8, current 6
<0> [445.594779] sysfs_he-2777 3D..1. 431538259us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:8, current 6
<0> [445.594876] kworker/-181 5..... 431544982us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:52, current 51
<0> [445.594972] kworker/-181 5D..1. 431544987us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:52, current 51
<0> [445.595068] kworker/-379 0..... 431548521us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:8, current 8
<0> [445.595159] sysfs_he-2777 3d..2. 431548886us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.595250] sysfs_he-2777 3d..2. 431548989us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.595347] sysfs_he-2777 3..... 431550475us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:10, current 8
<0> [445.595443] sysfs_he-2777 3D..1. 431550480us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:10, current 8
<0> [445.595539] kworker/-379 0..... 431560686us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:10, current 10
<0> [445.595630] kworker/-58 0d..2. 431561085us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.595721] kworker/-58 0d..2. 431561190us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.595818] sysfs_he-2777 3..... 431562225us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:12, current 10
<0> [445.595914] sysfs_he-2777 3D..1. 431562230us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:12, current 10
<0> [445.596010] kworker/-379 0..... 431572427us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:12, current 12
<0> [445.596101] sysfs_he-2777 3d..2. 431572789us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.596191] sysfs_he-2777 3d..2. 431572886us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.596289] kworker/-181 5..... 431572987us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:53, current 52
<0> [445.596385] kworker/-181 5D..1. 431572992us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:53, current 52
<0> [445.596482] sysfs_he-2777 3..... 431574437us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:14, current 12
<0> [445.596578] sysfs_he-2777 3D..1. 431574442us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:14, current 12
<0> [445.596675] kworker/-379 0..... 431584727us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:14, current 14
<0> [445.596765] sysfs_he-2777 3d..2. 431585151us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.596856] sysfs_he-2777 3d..2. 431585243us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.596954] sysfs_he-2777 3..... 431586719us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:16, current 14
<0> [445.597050] sysfs_he-2777 3D..1. 431586724us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:16, current 14
<0> [445.597146] kworker/-379 0..... 431596929us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:16, current 16
<0> [445.597236] sysfs_he-2777 3d..2. 431597282us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.597327] sysfs_he-2777 3d..2. 431597364us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.597425] sysfs_he-2777 3..... 431598844us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:18, current 16
<0> [445.597521] sysfs_he-2777 3D..1. 431598849us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:18, current 16
<0> [445.597617] kworker/-80 0..... 431601977us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:54, current 53
<0> [445.597713] kworker/-80 0D..1. 431601982us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:54, current 53
<0> [445.597809] kworker/-379 0..... 431609046us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:18, current 18
<0> [445.597900] sysfs_he-2777 3d..2. 431609447us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.597990] sysfs_he-2777 3d..2. 431609537us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.598087] sysfs_he-2777 3..... 431611014us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:20, current 18
<0> [445.598183] sysfs_he-2777 3D..1. 431611019us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:20, current 18
<0> [445.598279] kworker/-379 0..... 431621441us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:20, current 20
<0> [445.598369] sysfs_he-2777 3d..2. 431621803us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.598459] sysfs_he-2777 3d..2. 431621919us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.598557] sysfs_he-2777 3..... 431623504us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:22, current 20
<0> [445.598653] sysfs_he-2777 3D..1. 431623508us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:22, current 20
<0> [445.598749] kworker/-80 0..... 431630982us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:55, current 54
<0> [445.598846] kworker/-80 0D..1. 431630986us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:55, current 54
<0> [445.598942] kworker/-379 0..... 431633824us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:22, current 22
<0> [445.599033] kworker/-2105 1d..2. 431634204us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.599123] kworker/-2105 1d..2. 431634304us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.599220] sysfs_he-2777 3..... 431635346us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:24, current 22
<0> [445.599316] sysfs_he-2777 3D..1. 431635350us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:24, current 22
<0> [445.599412] kworker/-379 0..... 431645593us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:24, current 24
<0> [445.599503] sysfs_he-2777 3d..2. 431645964us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.599593] sysfs_he-2777 3d..2. 431646103us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.599690] sysfs_he-2777 3..... 431647593us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:26, current 24
<0> [445.599786] sysfs_he-2777 3D..1. 431647598us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:26, current 24
<0> [445.599882] kworker/-379 0..... 431657821us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:26, current 26
<0> [445.599972] sysfs_he-2777 3d..2. 431658162us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.600062] sysfs_he-2777 3d..2. 431658271us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.600159] kworker/-80 0..... 431658970us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:56, current 55
<0> [445.600255] kworker/-80 0D..1. 431658975us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:56, current 55
<0> [445.600351] sysfs_he-2777 3..... 431659777us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:28, current 26
<0> [445.600448] sysfs_he-2777 3D..1. 431659782us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:28, current 26
<0> [445.600544] kworker/-379 0..... 431669986us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:28, current 28
<0> [445.600635] sysfs_he-2777 3d..2. 431670391us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.600725] sysfs_he-2777 3d..2. 431670486us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.600822] sysfs_he-2777 3..... 431672023us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:30, current 28
<0> [445.600918] sysfs_he-2777 3D..1. 431672028us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:30, current 28
<0> [445.601006] kworker/-2101 4..... 431673856us : __i915_request_reset: 0000:03:00.0 vecs0: fence f6c:2, current 1 guilty? yes
<0> [445.601102] kworker/-2101 4..... 431673857us : __i915_request_skip: 0000:03:00.0 vecs0: fence f6c:2, current 1 error: -5
<0> [445.601199] kworker/-2101 4d..2. 431673865us : __i915_request_unsubmit: 0000:03:00.0 vecs0: fence f6c:2, current 1
<0> [445.601296] ksoftirq-42 4d.s1. 431674283us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6c:2, current 1
<0> [445.601392] kworker/-379 0..... 431682477us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:30, current 30
<0> [445.601489] kworker/-379 0..... 431682495us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6c:2, current 2
<0> [445.601579] sysfs_he-2777 3d..2. 431682881us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.601670] sysfs_he-2777 3d..2. 431682994us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.601767] sysfs_he-2777 3..... 431684558us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:32, current 30
<0> [445.601863] sysfs_he-2777 3D..1. 431684563us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:32, current 30
<0> [445.601960] kworker/-80 0..... 431688077us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:57, current 56
<0> [445.602057] kworker/-80 0D..1. 431688082us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:57, current 56
<0> [445.602153] kworker/-379 0..... 431694935us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:32, current 32
<0> [445.602243] sysfs_he-2777 3d..2. 431695288us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.602334] sysfs_he-2777 3d..2. 431695365us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.602431] sysfs_he-2777 3..... 431696850us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:34, current 32
<0> [445.602528] sysfs_he-2777 3D..1. 431696855us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:34, current 32
<0> [445.602624] kworker/-379 0..... 431707122us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:34, current 34
<0> [445.602714] kworker/-2101 4d..2. 431707517us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.602805] kworker/-2101 4d..2. 431707625us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.602902] sysfs_he-2777 3..... 431708833us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:36, current 34
<0> [445.602999] sysfs_he-2777 3D..1. 431708839us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:36, current 34
<0> [445.603095] kworker/-80 0..... 431717060us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:58, current 57
<0> [445.603192] kworker/-80 0D..1. 431717065us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:58, current 57
<0> [445.603273] kworker/-2101 0..... 431717240us : __intel_context_do_unpin.part.0: 0000:03:00.0 vecs0: context:f6c unpin
<0> [445.603355] kworker/-2101 0..... 431717808us : __intel_context_retire: 0000:03:00.0 vecs0: context:f6c retire runtime: { total:5088ns, avg:5088ns }
<0> [445.603453] kworker/-379 0..... 431719217us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:36, current 36
<0> [445.603544] kworker/-2101 0d..2. 431719625us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.603634] kworker/-2101 0d..2. 431719738us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.603731] sysfs_he-2777 3..... 431721155us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:38, current 36
<0> [445.603827] sysfs_he-2777 3D..1. 431721161us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:38, current 36
<0> [445.603924] kworker/-379 0..... 431731534us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:38, current 38
<0> [445.604014] kworker/-2101 0d..2. 431731934us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.604105] kworker/-2101 0d..2. 431732038us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.604201] sysfs_he-2777 3..... 431733565us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:40, current 38
<0> [445.604298] sysfs_he-2777 3D..1. 431733571us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:40, current 38
<0> [445.604388] kworker/-2101 0d..2. 431736272us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.604478] kworker/-2101 0d..2. 431736385us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.604560] sysfs_he-2778 2..... 431736470us : __intel_context_do_pin_ww: 0000:03:00.0 vecs0: context:f6c active
<0> [445.604649] sysfs_he-2778 2..... 431736474us : intel_timeline_pin: 0000:03:00.0 timeline:f6c using HWSP offset:feb88000
<0> [445.604731] sysfs_he-2778 2..... 431736483us : __intel_context_do_pin_ww: 0000:03:00.0 vecs0: context:f6c pin ring:{start:fea40000, head:0090, tail:0090}
<0> [445.604831] sysfs_he-2778 2..... 431738219us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6c:4, current 2
<0> [445.604928] sysfs_he-2778 2D..1. 431738226us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6c:4, current 2
<0> [445.605024] kworker/-379 0..... 431743782us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:40, current 40
<0> [445.605115] kworker/-2101 0d..2. 431744067us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.605205] sysfs_he-2777 3d..2. 431744082us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.605302] kworker/-80 0..... 431744986us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:59, current 58
<0> [445.605399] kworker/-80 0D..1. 431744995us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:59, current 58
<0> [445.605496] sysfs_he-2777 3..... 431746737us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:42, current 40
<0> [445.605592] sysfs_he-2777 3D..1. 431746745us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:42, current 40
<0> [445.605689] kworker/-80 0..... 431773986us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:60, current 59
<0> [445.605785] kworker/-80 0D..1. 431773995us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:60, current 59
<0> [445.605882] kworker/-379 0..... 431780785us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:42, current 42
<0> [445.605972] sysfs_he-2777 3d..2. 431780853us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.606062] sysfs_he-2777 3d..2. 431781026us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.606160] sysfs_he-2777 3..... 431782650us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:44, current 42
<0> [445.606256] sysfs_he-2777 3D..1. 431782654us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:44, current 42
<0> [445.606352] kworker/-379 0..... 431792894us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:44, current 44
<0> [445.606442] sysfs_he-2777 3d..2. 431793068us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.606532] sysfs_he-2777 3d..2. 431793179us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.606630] sysfs_he-2777 3..... 431794763us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:46, current 44
<0> [445.606726] sysfs_he-2777 3D..1. 431794768us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:46, current 44
<0> [445.606822] kworker/-80 0..... 431802972us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:61, current 60
<0> [445.606919] kworker/-80 0D..1. 431802977us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:61, current 60
<0> [445.607015] kworker/-379 0..... 431804947us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:46, current 46
<0> [445.607106] sysfs_he-2777 3d..2. 431805260us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.607196] sysfs_he-2777 3d..2. 431805373us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.607293] sysfs_he-2777 3..... 431807014us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:48, current 46
<0> [445.607389] sysfs_he-2777 3D..1. 431807018us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:48, current 46
<0> [445.607485] kworker/-379 0..... 431817162us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:48, current 48
<0> [445.607575] sysfs_he-2777 3d..2. 431817442us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.607665] sysfs_he-2777 3d..2. 431817539us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.607762] sysfs_he-2777 3..... 431819095us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:50, current 48
<0> [445.607858] sysfs_he-2777 3D..1. 431819100us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:50, current 48
<0> [445.607956] kworker/-379 0..... 431829295us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:50, current 50
<0> [445.608046] sysfs_he-2777 3d..2. 431829587us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.608136] sysfs_he-2777 3d..2. 431829680us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.608234] kworker/-80 0..... 431830988us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:62, current 61
<0> [445.608330] kworker/-80 0D..1. 431830992us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:62, current 61
<0> [445.608427] sysfs_he-2777 3..... 431831247us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:52, current 50
<0> [445.608523] sysfs_he-2777 3D..1. 431831251us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:52, current 50
<0> [445.608619] kworker/-379 0..... 431841606us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:52, current 52
<0> [445.608709] sysfs_he-2777 3d..2. 431841724us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.608799] sysfs_he-2777 3d..2. 431841825us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.608897] sysfs_he-2777 3..... 431843425us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:54, current 52
<0> [445.608993] sysfs_he-2777 3D..1. 431843429us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:54, current 52
<0> [445.609089] kworker/-379 0..... 431853599us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:54, current 54
<0> [445.609179] sysfs_he-2777 3d..2. 431853874us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.609269] sysfs_he-2777 3d..2. 431853974us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.609367] sysfs_he-2777 3..... 431855518us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:56, current 54
<0> [445.609463] sysfs_he-2777 3D..1. 431855523us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:56, current 54
<0> [445.609559] kworker/-80 0..... 431860079us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:63, current 62
<0> [445.609656] kworker/-80 0D..1. 431860083us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:63, current 62
<0> [445.609752] kworker/-379 0..... 431865696us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:56, current 56
<0> [445.609842] sysfs_he-2777 3d..2. 431866006us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.609933] sysfs_he-2777 3d..2. 431866095us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.610030] sysfs_he-2777 3..... 431867640us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:58, current 56
<0> [445.610127] sysfs_he-2777 3D..1. 431867644us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:58, current 56
<0> [445.610223] kworker/-379 0..... 431877892us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:58, current 58
<0> [445.610314] sysfs_he-2777 3d..2. 431878095us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.610405] sysfs_he-2777 3d..2. 431878190us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.610502] sysfs_he-2777 3..... 431879824us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:60, current 58
<0> [445.610599] sysfs_he-2777 3D..1. 431879828us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:60, current 58
<0> [445.610696] kworker/-80 0..... 431889067us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:64, current 63
<0> [445.610792] kworker/-80 0D..1. 431889072us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:64, current 63
<0> [445.610888] kworker/-379 0..... 431890050us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:60, current 60
<0> [445.610979] sysfs_he-2777 3d..2. 431890305us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.611069] sysfs_he-2777 3d..2. 431890396us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.611166] sysfs_he-2777 3..... 431892086us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:62, current 60
<0> [445.611263] sysfs_he-2777 3D..1. 431892091us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:62, current 60
<0> [445.611359] kworker/-379 0..... 431902298us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:62, current 62
<0> [445.611450] sysfs_he-2777 3d..2. 431902588us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.611540] sysfs_he-2777 3d..2. 431902680us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.611637] sysfs_he-2777 3..... 431904263us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:64, current 62
<0> [445.611734] sysfs_he-2777 3D..1. 431904268us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:64, current 62
<0> [445.611830] kworker/-379 0..... 431914542us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:64, current 64
<0> [445.611920] sysfs_he-2777 3d..2. 431914736us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.612010] sysfs_he-2777 3d..2. 431914826us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.612108] sysfs_he-2777 3..... 431916450us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:66, current 64
<0> [445.612204] sysfs_he-2777 3D..1. 431916455us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:66, current 64
<0> [445.612300] kworker/-80 0..... 431918049us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:65, current 64
<0> [445.612396] kworker/-80 0D..1. 431918053us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:65, current 64
<0> [445.612493] kworker/-379 0..... 431926725us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:66, current 66
<0> [445.612584] sysfs_he-2777 3d..2. 431927004us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.612674] sysfs_he-2777 3d..2. 431927097us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.612771] sysfs_he-2777 3..... 431928757us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:68, current 66
<0> [445.612867] sysfs_he-2777 3D..1. 431928762us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:68, current 66
<0> [445.612954] kworker/-2101 0..... 431938789us : __i915_request_reset: 0000:03:00.0 vecs0: fence f6c:4, current 3 guilty? yes
<0> [445.613052] kworker/-2101 0..... 431938790us : __i915_request_skip: 0000:03:00.0 vecs0: fence f6c:4, current 3 error: -5
<0> [445.613148] kworker/-2101 0d..2. 431938797us : __i915_request_unsubmit: 0000:03:00.0 vecs0: fence f6c:4, current 3
<0> [445.613244] ksoftirq-14 0d.s1. 431938807us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6c:4, current 3
<0> [445.613340] kworker/-379 0..... 431938991us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:68, current 68
<0> [445.613437] kworker/-379 0..... 431939008us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6c:4, current 4
<0> [445.613527] sysfs_he-2777 2d..2. 431939293us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.613617] sysfs_he-2777 2d..2. 431939396us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.613714] sysfs_he-2777 2..... 431941038us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:70, current 68
<0> [445.613811] sysfs_he-2777 2D..1. 431941042us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:70, current 68
<0> [445.613907] kworker/-80 0..... 431947073us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:66, current 65
<0> [445.614004] kworker/-80 0D..1. 431947091us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:66, current 65
<0> [445.614100] kworker/-379 0..... 431951214us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:70, current 70
<0> [445.614190] sysfs_he-2777 2d..2. 431951495us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.614280] sysfs_he-2777 2d..2. 431951570us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.614377] sysfs_he-2777 2..... 431953187us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:72, current 70
<0> [445.614473] sysfs_he-2777 2D..1. 431953191us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:72, current 70
<0> [445.614569] kworker/-379 0..... 431963470us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:72, current 72
<0> [445.614659] sysfs_he-2777 2d..2. 431963788us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.614750] sysfs_he-2777 2d..2. 431963864us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.614847] sysfs_he-2777 2..... 431965378us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:74, current 72
<0> [445.614943] sysfs_he-2777 2D..1. 431965382us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:74, current 72
<0> [445.615024] kworker/-2101 0..... 431974120us : __intel_context_do_unpin.part.0: 0000:03:00.0 vecs0: context:f6c unpin
<0> [445.615106] kworker/-2101 0..... 431974671us : __intel_context_retire: 0000:03:00.0 vecs0: context:f6c retire runtime: { total:10176ns, avg:5088ns }
<0> [445.615206] kworker/-80 0..... 431975049us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:67, current 66
<0> [445.615301] kworker/-80 0D..1. 431975053us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:67, current 66
<0> [445.615398] kworker/-379 0..... 431975677us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:74, current 74
<0> [445.615489] kworker/-2101 0d..2. 431975987us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.615579] kworker/-2101 0d..2. 431976071us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.615676] sysfs_he-2777 2..... 431977292us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:76, current 74
<0> [445.615772] sysfs_he-2777 2D..1. 431977296us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:76, current 74
<0> [445.615868] kworker/-379 0..... 431987568us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:76, current 76
<0> [445.615958] sysfs_he-2777 2d..2. 431987866us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.616049] sysfs_he-2777 2d..2. 431987964us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.616146] sysfs_he-2777 2..... 431989714us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:78, current 76
<0> [445.616243] sysfs_he-2777 2D..1. 431989719us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:78, current 76
<0> [445.616332] kworker/-2101 1d..2. 431994240us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.616423] kworker/-2101 1d..2. 431994344us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.616505] sysfs_he-2778 4..... 431994403us : __intel_context_do_pin_ww: 0000:03:00.0 vecs0: context:f6c active
<0> [445.616593] sysfs_he-2778 4..... 431994407us : intel_timeline_pin: 0000:03:00.0 timeline:f6c using HWSP offset:feb88000
<0> [445.616675] sysfs_he-2778 4..... 431994415us : __intel_context_do_pin_ww: 0000:03:00.0 vecs0: context:f6c pin ring:{start:fea40000, head:0120, tail:0120}
<0> [445.616774] sysfs_he-2778 4..... 431995910us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6c:6, current 4
<0> [445.616870] sysfs_he-2778 4D..1. 431995916us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6c:6, current 4
<0> [445.616966] kworker/-379 0..... 431999925us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:78, current 78
<0> [445.617057] kworker/-2101 1d..2. 432000203us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.617147] kworker/-2101 1d..2. 432000309us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.617245] sysfs_he-2777 2..... 432002039us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:80, current 78
<0> [445.617342] sysfs_he-2777 2D..1. 432002046us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:80, current 78
<0> [445.617437] kworker/-80 0..... 432002978us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:68, current 67
<0> [445.617533] kworker/-80 0D..1. 432002985us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:68, current 67
<0> [445.617630] kworker/-379 0..... 432038460us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:80, current 80
<0> [445.617720] kworker/-2105 3d..2. 432038769us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.617810] kworker/-2105 3d..2. 432038871us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.617907] sysfs_he-2777 2..... 432040166us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:82, current 80
<0> [445.618004] sysfs_he-2777 2D..1. 432040171us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:82, current 80
<0> [445.618099] kworker/-379 0..... 432050410us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:82, current 82
<0> [445.618190] sysfs_he-2777 2d..2. 432050737us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.618280] sysfs_he-2777 2d..2. 432050833us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.618377] sysfs_he-2777 2..... 432052385us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:84, current 82
<0> [445.618474] sysfs_he-2777 2D..1. 432052390us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:84, current 82
<0> [445.618570] kworker/-137 1..... 432061008us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:69, current 68
<0> [445.618667] kworker/-137 1D..1. 432061013us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:69, current 68
<0> [445.618763] kworker/-379 0..... 432062605us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:84, current 84
<0> [445.618854] sysfs_he-2777 2d..2. 432062935us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.618944] sysfs_he-2777 2d..2. 432063043us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.619041] sysfs_he-2777 2..... 432064576us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:86, current 84
<0> [445.619137] sysfs_he-2777 2D..1. 432064581us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:86, current 84
<0> [445.619233] kworker/-379 0..... 432074799us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:86, current 86
<0> [445.619323] sysfs_he-2777 2dN.2. 432075131us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.619413] sysfs_he-2777 2d..2. 432075220us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.619511] sysfs_he-2777 2..... 432076794us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:88, current 86
<0> [445.619607] sysfs_he-2777 2D..1. 432076799us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:88, current 86
<0> [445.619704] kworker/-379 0..... 432087008us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:88, current 88
<0> [445.619794] sysfs_he-2777 2d..2. 432087306us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.619884] sysfs_he-2777 2d..2. 432087397us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.619982] sysfs_he-2777 2..... 432088986us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:90, current 88
<0> [445.620078] sysfs_he-2777 2D..1. 432088991us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:90, current 88
<0> [445.620174] kworker/-137 1..... 432089219us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:70, current 69
<0> [445.620270] kworker/-137 1D..1. 432089224us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:70, current 69
<0> [445.620366] kworker/-379 0..... 432099186us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:90, current 90
<0> [445.620457] sysfs_he-2777 2d..2. 432099496us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.620547] sysfs_he-2777 2d..2. 432099580us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.620645] sysfs_he-2777 2..... 432101242us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:92, current 90
<0> [445.620741] sysfs_he-2777 2D..1. 432101246us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:92, current 90
<0> [445.620838] kworker/-379 0..... 432111437us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:92, current 92
<0> [445.620928] sysfs_he-2777 2d..2. 432111742us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.621018] sysfs_he-2777 2d..2. 432111835us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.621115] sysfs_he-2777 2..... 432113394us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:94, current 92
<0> [445.621212] sysfs_he-2777 2D..1. 432113398us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:94, current 92
<0> [445.621309] kworker/-137 1..... 432118095us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:71, current 70
<0> [445.621405] kworker/-137 1D..1. 432118099us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:71, current 70
<0> [445.621502] kworker/-379 0..... 432123595us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:94, current 94
<0> [445.621592] sysfs_he-2777 2d..2. 432123872us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.621683] sysfs_he-2777 2d..2. 432123973us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.621780] sysfs_he-2777 2..... 432125592us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:96, current 94
<0> [445.621876] sysfs_he-2777 2D..1. 432125597us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:96, current 94
<0> [445.621972] kworker/-379 0..... 432135792us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:96, current 96
<0> [445.622062] sysfs_he-2777 2d..2. 432136051us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.622153] sysfs_he-2777 2d..2. 432136134us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.622250] sysfs_he-2777 2..... 432137719us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:98, current 96
<0> [445.622346] sysfs_he-2777 2D..1. 432137723us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:98, current 96
<0> [445.622443] kworker/-137 1..... 432146981us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:72, current 71
<0> [445.622540] kworker/-137 1D..1. 432146985us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:72, current 71
<0> [445.622636] kworker/-379 0..... 432147962us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:98, current 98
<0> [445.622727] sysfs_he-2777 2d..2. 432148247us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.622817] sysfs_he-2777 2d..2. 432148367us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.622914] sysfs_he-2777 2..... 432150016us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:100, current 98
<0> [445.623011] sysfs_he-2777 2D..1. 432150020us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:100, current 98
<0> [445.623107] kworker/-379 0..... 432160224us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:100, current 100
<0> [445.623198] sysfs_he-2777 2d..2. 432160559us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.623288] sysfs_he-2777 2d..2. 432160669us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.623385] sysfs_he-2777 2..... 432162237us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:102, current 100
<0> [445.623481] sysfs_he-2777 2D..1. 432162242us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:102, current 100
<0> [445.623578] kworker/-379 0..... 432172499us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:102, current 102
<0> [445.623668] sysfs_he-2777 2d..2. 432172734us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.623758] sysfs_he-2777 2d..2. 432172824us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.623855] sysfs_he-2777 2..... 432174416us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:104, current 102
<0> [445.623952] sysfs_he-2777 2D..1. 432174421us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:104, current 102
<0> [445.624049] kworker/-137 1..... 432175991us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:73, current 72
<0> [445.624146] kworker/-137 1D..1. 432175995us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:73, current 72
<0> [445.624242] kworker/-379 0..... 432184635us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:104, current 104
<0> [445.624333] sysfs_he-2777 2d..2. 432184961us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.624423] sysfs_he-2777 2d..2. 432185050us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.624520] sysfs_he-2777 2..... 432186583us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:106, current 104
<0> [445.624616] sysfs_he-2777 2D..1. 432186588us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:106, current 104
<0> [445.624704] kworker/-2101 1..... 432193147us : __i915_request_reset: 0000:03:00.0 vecs0: fence f6c:6, current 5 guilty? yes
<0> [445.624801] kworker/-2101 1..... 432193148us : __i915_request_skip: 0000:03:00.0 vecs0: fence f6c:6, current 5 error: -5
<0> [445.624898] kworker/-2101 1d..2. 432193156us : __i915_request_unsubmit: 0000:03:00.0 vecs0: fence f6c:6, current 5
<0> [445.624994] ksoftirq-24 1d.s1. 432193166us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6c:6, current 5
<0> [445.625091] kworker/-379 0..... 432196870us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:106, current 106
<0> [445.625187] kworker/-379 0..... 432196888us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6c:6, current 6
<0> [445.625277] kworker/-2101 1d..2. 432197174us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.625367] kworker/-2101 1d..2. 432197258us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.625464] sysfs_he-2777 2..... 432198516us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:108, current 106
<0> [445.625561] sysfs_he-2777 2D..1. 432198521us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:108, current 106
<0> [445.625658] kworker/-137 1..... 432205142us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:74, current 73
<0> [445.625754] kworker/-137 1D..1. 432205146us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:74, current 73
<0> [445.625850] kworker/-379 0..... 432208808us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:108, current 108
<0> [445.625940] kworker/-2101 1d..2. 432209196us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.626031] kworker/-2101 1d..2. 432209278us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.626128] sysfs_he-2777 2..... 432210455us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:110, current 108
<0> [445.626224] sysfs_he-2777 2D..1. 432210460us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:110, current 108
<0> [445.626321] kworker/-379 0..... 432220729us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:110, current 110
<0> [445.626412] sysfs_he-2777 2d..2. 432221037us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.626502] sysfs_he-2777 2d..2. 432221118us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.626600] sysfs_he-2777 2..... 432222654us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:112, current 110
<0> [445.626696] sysfs_he-2777 2D..1. 432222659us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:112, current 110
<0> [445.626777] kworker/-2101 1..... 432232158us : __intel_context_do_unpin.part.0: 0000:03:00.0 vecs0: context:f6c unpin
<0> [445.626859] kworker/-2101 1..... 432232712us : __intel_context_retire: 0000:03:00.0 vecs0: context:f6c retire runtime: { total:15264ns, avg:5088ns }
<0> [445.626957] kworker/-379 0..... 432232902us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:112, current 112
<0> [445.627055] kworker/-137 1..... 432232947us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:75, current 74
<0> [445.627151] kworker/-137 1D..1. 432232951us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:75, current 74
<0> [445.627241] sysfs_he-2777 2d..2. 432233159us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.627331] sysfs_he-2777 2d..2. 432233236us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.627428] sysfs_he-2777 2..... 432234783us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:114, current 112
<0> [445.627524] sysfs_he-2777 2D..1. 432234788us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:114, current 112
<0> [445.627620] kworker/-379 0..... 432245074us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:114, current 114
<0> [445.627710] kworker/-2101 0d..2. 432245371us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.627801] kworker/-2101 0d..2. 432245466us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.627898] sysfs_he-2777 2..... 432246933us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:116, current 114
<0> [445.627995] sysfs_he-2777 2D..1. 432246938us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:116, current 114
<0> [445.628085] kworker/-2101 0d..2. 432250265us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.628175] kworker/-2101 0d..2. 432250366us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.628258] sysfs_he-2778 4..... 432250405us : __intel_context_do_pin_ww: 0000:03:00.0 vecs0: context:f6c active
<0> [445.628346] sysfs_he-2778 4..... 432250410us : intel_timeline_pin: 0000:03:00.0 timeline:f6c using HWSP offset:feb88000
<0> [445.628427] sysfs_he-2778 4..... 432250417us : __intel_context_do_pin_ww: 0000:03:00.0 vecs0: context:f6c pin ring:{start:fea40000, head:01b0, tail:01b0}
<0> [445.628526] sysfs_he-2778 4..... 432251940us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6c:8, current 6
<0> [445.628623] sysfs_he-2778 4D..1. 432251946us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6c:8, current 6
<0> [445.628718] kworker/-379 0..... 432257116us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:116, current 116
<0> [445.628809] sysfs_he-2777 2d..2. 432257367us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.628900] sysfs_he-2777 2d..2. 432257446us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.628997] sysfs_he-2777 2..... 432259100us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:118, current 116
<0> [445.629094] sysfs_he-2777 2D..1. 432259105us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:118, current 116
<0> [445.629191] kworker/-137 1..... 432260966us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:76, current 75
<0> [445.629288] kworker/-137 1D..1. 432260971us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:76, current 75
<0> [445.629378] kworker/-2105 3d..2. 432294920us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.629469] kworker/-2105 3d..2. 432295075us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.629565] kworker/-379 0..... 432295190us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:118, current 118
<0> [445.629662] sysfs_he-2777 2..... 432296476us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:120, current 118
<0> [445.629759] sysfs_he-2777 2D..1. 432296481us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:120, current 118
<0> [445.629856] kworker/-379 0..... 432306833us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:120, current 120
<0> [445.629946] kworker/-2105 3d..2. 432306983us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.630036] kworker/-2105 3d..2. 432307089us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.630133] sysfs_he-2777 2..... 432308559us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:122, current 120
<0> [445.630231] sysfs_he-2777 2D..1. 432308564us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:122, current 120
<0> [445.630327] kworker/-379 0..... 432318859us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:122, current 122
<0> [445.630418] kworker/-2105 3d..2. 432319032us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.630508] kworker/-2105 3d..2. 432319124us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.630605] sysfs_he-2777 2..... 432320432us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:124, current 122
<0> [445.630702] sysfs_he-2777 2D..1. 432320437us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:124, current 122
<0> [445.630799] kworker/-80 0..... 432322007us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:77, current 76
<0> [445.630895] kworker/-80 0D..1. 432322011us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:77, current 76
<0> [445.630992] kworker/-379 0..... 432330632us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:124, current 124
<0> [445.631082] sysfs_he-2777 2d..2. 432330915us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.631173] sysfs_he-2777 2d..2. 432331045us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.631270] sysfs_he-2777 2..... 432332586us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:126, current 124
<0> [445.631366] sysfs_he-2777 2D..1. 432332591us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:126, current 124
<0> [445.631462] kworker/-379 0..... 432342931us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:126, current 126
<0> [445.631553] sysfs_he-2777 2d..2. 432343045us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.631643] sysfs_he-2777 2d..2. 432343135us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.631740] sysfs_he-2777 2..... 432344671us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:128, current 126
<0> [445.631836] sysfs_he-2777 2D..1. 432344675us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:128, current 126
<0> [445.631933] kworker/-80 0..... 432351085us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:78, current 77
<0> [445.632029] kworker/-80 0D..1. 432351090us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:78, current 77
<0> [445.632125] kworker/-379 0..... 432354887us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:128, current 128
<0> [445.632215] kworker/-2105 3d..2. 432355122us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.632305] kworker/-2105 3d..2. 432355256us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.632402] sysfs_he-2777 2..... 432356412us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:130, current 128
<0> [445.632498] sysfs_he-2777 2D..1. 432356416us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:130, current 128
<0> [445.632595] kworker/-379 0..... 432366765us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:130, current 130
<0> [445.632685] sysfs_he-2777 2d..2. 432366871us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.632775] sysfs_he-2777 2d..2. 432366972us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.632872] sysfs_he-2777 2..... 432368516us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:132, current 130
<0> [445.632969] sysfs_he-2777 2D..1. 432368521us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:132, current 130
<0> [445.633065] kworker/-379 0..... 432378880us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:132, current 132
<0> [445.633155] sysfs_he-2777 2d..2. 432379012us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.633246] sysfs_he-2777 2d..2. 432379101us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.633343] kworker/-80 0..... 432379190us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:79, current 78
<0> [445.633439] kworker/-80 0D..1. 432379194us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:79, current 78
<0> [445.633536] sysfs_he-2777 2..... 432380685us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:134, current 132
<0> [445.633633] sysfs_he-2777 2D..1. 432380690us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:134, current 132
<0> [445.633729] kworker/-379 0..... 432390880us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:134, current 134
<0> [445.633820] kworker/-2105 3d..2. 432391207us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.633911] kworker/-2105 3d..2. 432391299us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.634008] sysfs_he-2777 2..... 432392499us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:136, current 134
<0> [445.634105] sysfs_he-2777 2D..1. 432392504us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:136, current 134
<0> [445.634201] kworker/-379 0..... 432402740us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:136, current 136
<0> [445.634292] sysfs_he-2777 2d..2. 432402989us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.634381] sysfs_he-2777 2d..2. 432403084us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.634478] sysfs_he-2777 2..... 432404632us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:138, current 136
<0> [445.634575] sysfs_he-2777 2D..1. 432404637us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:138, current 136
<0> [445.634671] kworker/-80 0..... 432408035us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:80, current 79
<0> [445.634768] kworker/-80 0D..1. 432408039us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:80, current 79
<0> [445.634864] kworker/-379 0..... 432414866us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:138, current 138
<0> [445.634954] kworker/-2105 3d..2. 432415134us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.635044] kworker/-2105 3d..2. 432415271us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.635141] sysfs_he-2777 2..... 432416492us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:140, current 138
<0> [445.635238] sysfs_he-2777 2D..1. 432416497us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:140, current 138
<0> [445.635334] kworker/-379 0..... 432426759us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:140, current 140
<0> [445.635424] sysfs_he-2777 2d..2. 432427028us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.635515] sysfs_he-2777 2d..2. 432427159us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.635612] sysfs_he-2777 2..... 432428686us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:142, current 140
<0> [445.635709] sysfs_he-2777 2D..1. 432428690us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:142, current 140
<0> [445.635806] kworker/-80 0..... 432437007us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:81, current 80
<0> [445.635902] kworker/-80 0D..1. 432437011us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:81, current 80
<0> [445.635999] kworker/-379 0..... 432439020us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:142, current 142
<0> [445.636089] kworker/-2105 3d..2. 432439254us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.636179] sysfs_he-2777 2d..2. 432439284us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.636276] sysfs_he-2777 2..... 432440849us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:144, current 142
<0> [445.636372] sysfs_he-2777 2D..1. 432440853us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:144, current 142
<0> [445.636460] kworker/-2101 0..... 432449604us : __i915_request_reset: 0000:03:00.0 vecs0: fence f6c:8, current 7 guilty? yes
<0> [445.636557] kworker/-2101 0..... 432449605us : __i915_request_skip: 0000:03:00.0 vecs0: fence f6c:8, current 7 error: -5
<0> [445.636654] kworker/-2101 0d..2. 432449612us : __i915_request_unsubmit: 0000:03:00.0 vecs0: fence f6c:8, current 7
<0> [445.636750] ksoftirq-14 0d.s1. 432449622us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6c:8, current 7
<0> [445.636846] kworker/-379 0..... 432451032us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6c:8, current 8
<0> [445.636942] kworker/-379 0..... 432451041us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:144, current 144
<0> [445.637033] sysfs_he-2777 2d..2. 432451297us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.637123] sysfs_he-2777 2d..2. 432451374us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.637221] sysfs_he-2777 2..... 432453021us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:146, current 144
<0> [445.637317] sysfs_he-2777 2D..1. 432453026us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:146, current 144
<0> [445.637413] kworker/-379 0..... 432463191us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:146, current 146
<0> [445.637504] sysfs_he-2777 2d..2. 432463479us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.637594] sysfs_he-2777 2d..2. 432463554us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.637692] kworker/-80 0..... 432464948us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:82, current 81
<0> [445.637788] kworker/-80 0D..1. 432464953us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:82, current 81
<0> [445.637884] sysfs_he-2777 2..... 432465179us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:148, current 146
<0> [445.637981] sysfs_he-2777 2D..1. 432465184us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:148, current 146
<0> [445.638077] kworker/-379 0..... 432475461us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:148, current 148
<0> [445.638167] sysfs_he-2777 2d..2. 432475733us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.638258] sysfs_he-2777 2d..2. 432475809us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.638355] sysfs_he-2777 2..... 432477367us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:150, current 148
<0> [445.638452] sysfs_he-2777 2D..1. 432477372us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:150, current 148
<0> [445.638532] kworker/-2101 0..... 432487123us : __intel_context_do_unpin.part.0: 0000:03:00.0 vecs0: context:f6c unpin
<0> [445.638614] kworker/-2101 0..... 432487771us : __intel_context_retire: 0000:03:00.0 vecs0: context:f6c retire runtime: { total:20299ns, avg:5035ns }
<0> [445.638713] kworker/-379 0..... 432487782us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:150, current 150
<0> [445.638803] sysfs_he-2777 2d..2. 432487796us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.638894] sysfs_he-2777 2d..2. 432487873us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.638991] sysfs_he-2777 2..... 432489395us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:152, current 150
<0> [445.639088] sysfs_he-2777 2D..1. 432489399us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:152, current 150
<0> [445.639185] kworker/-80 0..... 432494024us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:83, current 82
<0> [445.639281] kworker/-80 0D..1. 432494029us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:83, current 82
<0> [445.639378] kworker/-379 0..... 432499683us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:152, current 152
<0> [445.639468] kworker/-2101 0d..2. 432500017us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.639558] kworker/-2101 0d..2. 432500135us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.639655] sysfs_he-2777 2..... 432501696us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:154, current 152
<0> [445.639752] sysfs_he-2777 2D..1. 432501702us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:154, current 152
<0> [445.639842] kworker/-2101 0d..2. 432507472us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.639932] kworker/-2101 0d..2. 432507577us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.640014] sysfs_he-2778 4..... 432507611us : __intel_context_do_pin_ww: 0000:03:00.0 vecs0: context:f6c active
<0> [445.640103] sysfs_he-2778 4..... 432507615us : intel_timeline_pin: 0000:03:00.0 timeline:f6c using HWSP offset:feb88000
<0> [445.640184] sysfs_he-2778 4..... 432507623us : __intel_context_do_pin_ww: 0000:03:00.0 vecs0: context:f6c pin ring:{start:fea40000, head:0240, tail:0240}
<0> [445.640269] sysfs_he-2778 4..... 432507640us : __intel_context_do_unpin.part.0: 0000:03:00.0 vecs0: context:f6c unpin
<0> [445.640350] sysfs_he-2778 4..... 432508227us : __intel_context_retire: 0000:03:00.0 vecs0: context:f6c retire runtime: { total:20299ns, avg:5035ns }
<0> [445.640433] sysfs_he-2778 4..... 432508232us : __intel_context_do_pin_ww: 0000:03:00.0 vecs0: context:f6c active
<0> [445.640522] sysfs_he-2778 4..... 432508234us : intel_timeline_pin: 0000:03:00.0 timeline:f6c using HWSP offset:feb88000
<0> [445.640602] sysfs_he-2778 4..... 432508239us : __intel_context_do_pin_ww: 0000:03:00.0 vecs0: context:f6c pin ring:{start:fea40000, head:0240, tail:0240}
<0> [445.640688] sysfs_he-2778 4..... 432508255us : __intel_context_do_unpin.part.0: 0000:03:00.0 vecs0: context:f6c unpin
<0> [445.640768] sysfs_he-2778 4..... 432508817us : __intel_context_retire: 0000:03:00.0 vecs0: context:f6c retire runtime: { total:20299ns, avg:5035ns }
<0> [445.640851] sysfs_he-2778 4..... 432508821us : __intel_context_do_pin_ww: 0000:03:00.0 vecs0: context:f6c active
<0> [445.640939] sysfs_he-2778 4..... 432508823us : intel_timeline_pin: 0000:03:00.0 timeline:f6c using HWSP offset:feb88000
<0> [445.641020] sysfs_he-2778 4..... 432508828us : __intel_context_do_pin_ww: 0000:03:00.0 vecs0: context:f6c pin ring:{start:fea40000, head:0240, tail:0240}
<0> [445.641120] sysfs_he-2778 4..... 432510443us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6c:10, current 8
<0> [445.641216] sysfs_he-2778 4D..1. 432510449us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6c:10, current 8
<0> [445.641312] kworker/-379 0..... 432511920us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:154, current 154
<0> [445.641402] kworker/-2101 0d..2. 432512196us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.641492] kworker/-2101 0d..2. 432512305us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.641590] sysfs_he-2777 2..... 432514201us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:156, current 154
<0> [445.641687] sysfs_he-2777 2D..1. 432514208us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:156, current 154
<0> [445.641784] kworker/-80 0..... 432521968us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:84, current 83
<0> [445.641880] kworker/-80 0D..1. 432521977us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:84, current 83
<0> [445.641970] kworker/-2105 3d..2. 432550829us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.642061] kworker/-2105 3d..2. 432550991us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.642158] kworker/-379 0..... 432551165us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:156, current 156
<0> [445.642255] sysfs_he-2777 2..... 432553057us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:158, current 156
<0> [445.642352] sysfs_he-2777 2D..1. 432553065us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:158, current 156
<0> [445.642448] kworker/-379 0..... 432563593us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:158, current 158
<0> [445.642539] kworker/-2105 1d..2. 432563607us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.642629] kworker/-2105 1d..2. 432563768us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.642726] sysfs_he-2777 2..... 432565860us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:160, current 158
<0> [445.642822] sysfs_he-2777 2D..1. 432565868us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:160, current 158
<0> [445.642918] kworker/-379 0..... 432576159us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:160, current 160
<0> [445.643009] kworker/-2105 1d..2. 432576390us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.643099] kworker/-2105 1d..2. 432576490us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.643197] sysfs_he-2777 2..... 432578049us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:162, current 160
<0> [445.643293] sysfs_he-2777 2D..1. 432578055us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:162, current 160
<0> [445.643391] kworker/-80 0..... 432579968us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:85, current 84
<0> [445.643487] kworker/-80 0D..1. 432579973us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:85, current 84
<0> [445.643583] kworker/-379 0..... 432588296us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:162, current 162
<0> [445.643674] sysfs_he-2777 2d..2. 432588540us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.643764] sysfs_he-2777 2d..2. 432588624us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.643862] sysfs_he-2777 2..... 432590248us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:164, current 162
<0> [445.643958] sysfs_he-2777 2D..1. 432590252us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:164, current 162
<0> [445.644049] sysfs_he-2777 2d..2. 432600756us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.644139] sysfs_he-2777 2d..2. 432600846us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.644236] kworker/-379 0..... 432601126us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:164, current 164
<0> [445.644333] sysfs_he-2777 2..... 432602496us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:166, current 164
<0> [445.644430] sysfs_he-2777 2D..1. 432602501us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:166, current 164
<0> [445.644526] kworker/-80 0..... 432609093us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:86, current 85
<0> [445.644623] kworker/-80 0D..1. 432609097us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:86, current 85
<0> [445.644719] kworker/-379 0..... 432612839us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:166, current 166
<0> [445.644809] sysfs_he-2777 2d..2. 432613065us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.644899] sysfs_he-2777 2d..2. 432613144us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.644996] sysfs_he-2777 2..... 432614677us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:168, current 166
<0> [445.645093] sysfs_he-2777 2D..1. 432614681us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:168, current 166
<0> [445.645189] kworker/-379 0..... 432625073us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:168, current 168
<0> [445.645279] kworker/-2105 3d..2. 432625147us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.645369] kworker/-2105 3d..2. 432625243us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.645466] sysfs_he-2777 2..... 432626424us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:170, current 168
<0> [445.645562] sysfs_he-2777 2D..1. 432626429us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:170, current 168
<0> [445.645659] kworker/-379 0..... 432636666us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:170, current 170
<0> [445.645749] sysfs_he-2777 2d..2. 432636904us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.645839] sysfs_he-2777 2d..2. 432637016us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.645937] kworker/-80 0..... 432637050us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:87, current 86
<0> [445.646033] kworker/-80 0D..1. 432637054us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:87, current 86
<0> [445.646130] sysfs_he-2777 2..... 432638569us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:172, current 170
<0> [445.646226] sysfs_he-2777 2D..1. 432638574us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:172, current 170
<0> [445.646323] kworker/-379 0..... 432649013us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:172, current 172
<0> [445.646413] sysfs_he-2777 2dN.2. 432649139us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.646503] sysfs_he-2777 2d..2. 432649228us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.646600] sysfs_he-2777 2..... 432650760us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:174, current 172
<0> [445.646697] sysfs_he-2777 2D..1. 432650764us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:174, current 172
<0> [445.646793] kworker/-379 0..... 432660964us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:174, current 174
<0> [445.646884] sysfs_he-2777 2d..2. 432661241us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.646974] sysfs_he-2777 2d..2. 432661333us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.647070] sysfs_he-2777 2..... 432662913us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:176, current 174
<0> [445.647167] sysfs_he-2777 2D..1. 432662918us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:176, current 174
<0> [445.647263] kworker/-80 0..... 432666036us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:88, current 87
<0> [445.647359] kworker/-80 0D..1. 432666041us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:88, current 87
<0> [445.647455] kworker/-379 0..... 432673144us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:176, current 176
<0> [445.647546] sysfs_he-2777 2d..2. 432673424us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.647636] sysfs_he-2777 2d..2. 432673509us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.647734] sysfs_he-2777 2..... 432675158us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:178, current 176
<0> [445.647830] sysfs_he-2777 2D..1. 432675162us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:178, current 176
<0> [445.647927] kworker/-379 0..... 432685369us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:178, current 178
<0> [445.648017] sysfs_he-2777 2d..2. 432685645us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.648107] sysfs_he-2777 2d..2. 432685737us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.648204] sysfs_he-2777 2..... 432687408us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:180, current 178
<0> [445.648300] sysfs_he-2777 2D..1. 432687412us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:180, current 178
<0> [445.648397] kworker/-80 0..... 432694917us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:89, current 88
<0> [445.648493] kworker/-80 0D..1. 432694922us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:89, current 88
<0> [445.648589] kworker/-379 0..... 432697623us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:180, current 180
<0> [445.648679] sysfs_he-2777 2d..2. 432697883us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.648770] sysfs_he-2777 2d..2. 432698000us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.648867] sysfs_he-2777 2..... 432699544us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:182, current 180
<0> [445.648964] sysfs_he-2777 2D..1. 432699549us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:182, current 180
<0> [445.649060] kworker/-379 0..... 432709802us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:182, current 182
<0> [445.649150] sysfs_he-2777 2d..2. 432710023us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.649240] sysfs_he-2777 2d..2. 432710111us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.649337] sysfs_he-2777 2..... 432711725us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:184, current 182
<0> [445.649433] sysfs_he-2777 2D..1. 432711730us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:184, current 182
<0> [445.649521] kworker/-2101 0..... 432711836us : __i915_request_reset: 0000:03:00.0 vecs0: fence f6c:10, current 9 guilty? yes
<0> [445.649618] kworker/-2101 0..... 432711837us : __i915_request_skip: 0000:03:00.0 vecs0: fence f6c:10, current 9 error: -5
<0> [445.649715] kworker/-2101 0d..2. 432711844us : __i915_request_unsubmit: 0000:03:00.0 vecs0: fence f6c:10, current 9
<0> [445.649811] ksoftirq-14 0d.s1. 432711854us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6c:10, current 9
<0> [445.649907] kworker/-379 0..... 432722178us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:184, current 184
<0> [445.650004] kworker/-379 0..... 432722195us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6c:10, current 10
<0> [445.650094] sysfs_he-2777 2d..2. 432722497us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.650184] sysfs_he-2777 2d..2. 432722575us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.650282] kworker/-80 0..... 432723005us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:90, current 89
<0> [445.650378] kworker/-80 0D..1. 432723010us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:90, current 89
<0> [445.650475] sysfs_he-2777 2..... 432724201us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:186, current 184
<0> [445.650572] sysfs_he-2777 2D..1. 432724206us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:186, current 184
<0> [445.650669] kworker/-379 0..... 432734488us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:186, current 186
<0> [445.650759] sysfs_he-2777 2d..2. 432734790us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.650850] sysfs_he-2777 2d..2. 432734867us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.650947] sysfs_he-2777 2..... 432736447us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:188, current 186
<0> [445.651044] sysfs_he-2777 2D..1. 432736452us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:188, current 186
<0> [445.651140] kworker/-379 0..... 432746737us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:188, current 188
<0> [445.651231] sysfs_he-2777 2d..2. 432747015us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.651321] sysfs_he-2777 2d..2. 432747091us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.651419] sysfs_he-2777 2..... 432748640us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:190, current 188
<0> [445.651516] sysfs_he-2777 2D..1. 432748644us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:190, current 188
<0> [445.651612] kworker/-80 0..... 432752058us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:91, current 90
<0> [445.651709] kworker/-80 0D..1. 432752062us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:91, current 90
<0> [445.651790] kworker/-2105 1..... 432758130us : __intel_context_do_unpin.part.0: 0000:03:00.0 vecs0: context:f6c unpin
<0> [445.651872] kworker/-2105 1..... 432758687us : __intel_context_retire: 0000:03:00.0 vecs0: context:f6c retire runtime: { total:25334ns, avg:5035ns }
<0> [445.651971] kworker/-379 0..... 432758913us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:190, current 190
<0> [445.652061] kworker/-2105 1d..2. 432759191us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.652151] kworker/-2105 1d..2. 432759286us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.652248] sysfs_he-2777 2..... 432760713us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:192, current 190
<0> [445.652345] sysfs_he-2777 2D..1. 432760718us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:192, current 190
<0> [445.652435] kworker/-2105 1d..2. 432762243us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.652526] kworker/-2105 1d..2. 432762334us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.652608] sysfs_he-2778 4..... 432762365us : __intel_context_do_pin_ww: 0000:03:00.0 vecs0: context:f6c active
<0> [445.652696] sysfs_he-2778 4..... 432762368us : intel_timeline_pin: 0000:03:00.0 timeline:f6c using HWSP offset:feb88000
<0> [445.652777] sysfs_he-2778 4..... 432762375us : __intel_context_do_pin_ww: 0000:03:00.0 vecs0: context:f6c pin ring:{start:fea40000, head:02d0, tail:02d0}
<0> [445.652877] sysfs_he-2778 4..... 432763834us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6c:12, current 10
<0> [445.652973] sysfs_he-2778 4D..1. 432763840us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6c:12, current 10
<0> [445.653069] kworker/-379 0..... 432770943us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:192, current 192
<0> [445.653159] kworker/-2105 1d..2. 432771144us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.653249] sysfs_he-2777 2d..2. 432771156us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.653346] sysfs_he-2777 2..... 432772694us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:194, current 192
<0> [445.653442] sysfs_he-2777 2D..1. 432772699us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:194, current 192
<0> [445.653538] kworker/-80 0..... 432779951us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:92, current 91
<0> [445.653635] kworker/-80 0D..1. 432779956us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:92, current 91
<0> [445.653731] kworker/-379 0..... 432808499us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:194, current 194
<0> [445.653821] kworker/-2101 0d..2. 432808829us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.653912] kworker/-2101 0d..2. 432809005us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.654009] sysfs_he-2777 2..... 432810219us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:196, current 194
<0> [445.654105] sysfs_he-2777 2D..1. 432810224us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:196, current 194
<0> [445.654202] kworker/-379 0..... 432820421us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:196, current 196
<0> [445.654292] sysfs_he-2777 2d..2. 432820754us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.654382] sysfs_he-2777 2d..2. 432820847us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.654480] sysfs_he-2777 2..... 432822428us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:198, current 196
<0> [445.654576] sysfs_he-2777 2D..1. 432822433us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:198, current 196
<0> [445.654673] kworker/-379 0..... 432832627us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:198, current 198
<0> [445.654763] kworker/-2101 0d..2. 432832911us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.654854] kworker/-2101 0d..2. 432833020us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.654951] sysfs_he-2777 2..... 432834222us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:200, current 198
<0> [445.655048] sysfs_he-2777 2D..1. 432834226us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:200, current 198
<0> [445.655144] kworker/-80 0..... 432837942us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:93, current 92
<0> [445.655241] kworker/-80 0D..1. 432837947us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:93, current 92
<0> [445.655337] kworker/-379 0..... 432844486us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:200, current 200
<0> [445.655427] sysfs_he-2777 2d..2. 432844738us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.655517] sysfs_he-2777 2d..2. 432844835us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.655614] sysfs_he-2777 2..... 432846395us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:202, current 200
<0> [445.655711] sysfs_he-2777 2D..1. 432846400us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:202, current 200
<0> [445.655808] kworker/-379 0..... 432856596us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:202, current 202
<0> [445.655898] sysfs_he-2777 2d..2. 432856906us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.655988] sysfs_he-2777 2d..2. 432857043us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.656085] sysfs_he-2777 2..... 432858639us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:204, current 202
<0> [445.656182] sysfs_he-2777 2D..1. 432858643us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:204, current 202
<0> [445.656279] kworker/-80 0..... 432866948us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:94, current 93
<0> [445.656375] kworker/-80 0D..1. 432866952us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:94, current 93
<0> [445.656471] kworker/-379 0..... 432868843us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:204, current 204
<0> [445.656561] kworker/-2101 0d..2. 432869193us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.656651] sysfs_he-2777 2d..2. 432869206us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.656748] sysfs_he-2777 2..... 432870739us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:206, current 204
<0> [445.656844] sysfs_he-2777 2D..1. 432870744us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:206, current 204
<0> [445.656941] kworker/-379 0..... 432880979us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:206, current 206
<0> [445.657031] sysfs_he-2777 2d..2. 432881256us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.657121] sysfs_he-2777 2d..2. 432881376us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.657218] sysfs_he-2777 2..... 432882919us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:208, current 206
<0> [445.657315] sysfs_he-2777 2D..1. 432882923us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:208, current 206
<0> [445.657411] kworker/-379 0..... 432893149us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:208, current 208
<0> [445.657501] sysfs_he-2777 2d..2. 432893423us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.657591] sysfs_he-2777 2d..2. 432893512us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.657688] kworker/-80 0..... 432894925us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:95, current 94
<0> [445.657785] kworker/-80 0D..1. 432894929us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:95, current 94
<0> [445.657881] sysfs_he-2777 2..... 432895093us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:210, current 208
<0> [445.657978] sysfs_he-2777 2D..1. 432895098us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:210, current 208
<0> [445.658074] kworker/-379 0..... 432905315us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:210, current 210
<0> [445.658165] sysfs_he-2777 2d..2. 432905587us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.658255] sysfs_he-2777 2d..2. 432905674us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.658353] sysfs_he-2777 2..... 432907227us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:212, current 210
<0> [445.658449] sysfs_he-2777 2D..1. 432907232us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:212, current 210
<0> [445.658545] kworker/-379 0..... 432917471us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:212, current 212
<0> [445.658635] sysfs_he-2777 2d..2. 432917774us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.658725] sysfs_he-2777 2d..2. 432917866us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.658822] sysfs_he-2777 2..... 432919496us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:214, current 212
<0> [445.658919] sysfs_he-2777 2D..1. 432919501us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:214, current 212
<0> [445.659015] kworker/-80 0..... 432923938us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:96, current 95
<0> [445.659111] kworker/-80 0D..1. 432923943us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:96, current 95
<0> [445.659208] kworker/-379 0..... 432929720us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:214, current 214
<0> [445.659298] kworker/-2101 0d..2. 432930010us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.659388] sysfs_he-2777 2d..2. 432930034us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.659485] sysfs_he-2777 2..... 432931694us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:216, current 214
<0> [445.659582] sysfs_he-2777 2D..1. 432931698us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:216, current 214
<0> [445.659679] kworker/-379 0..... 432941973us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:216, current 216
<0> [445.659769] kworker/-2101 3d..2. 432942273us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.659859] kworker/-2101 3d..2. 432942362us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.659957] sysfs_he-2777 2..... 432943583us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:218, current 216
<0> [445.660053] sysfs_he-2777 2D..1. 432943588us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:218, current 216
<0> [445.660150] kworker/-80 0..... 432951995us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:97, current 96
<0> [445.660246] kworker/-80 0D..1. 432952000us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:97, current 96
<0> [445.660342] kworker/-379 0..... 432953795us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:218, current 218
<0> [445.660433] kworker/-2101 3d..2. 432954119us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.660523] kworker/-2101 3d..2. 432954211us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.660620] sysfs_he-2777 2..... 432955399us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:220, current 218
<0> [445.660717] sysfs_he-2777 2D..1. 432955403us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:220, current 218
<0> [445.660805] kworker/-2105 1..... 432961818us : __i915_request_reset: 0000:03:00.0 vecs0: fence f6c:12, current 11 guilty? yes
<0> [445.660902] kworker/-2105 1..... 432961819us : __i915_request_skip: 0000:03:00.0 vecs0: fence f6c:12, current 11 error: -5
<0> [445.660999] kworker/-2105 1d..2. 432961827us : __i915_request_unsubmit: 0000:03:00.0 vecs0: fence f6c:12, current 11
<0> [445.661095] ksoftirq-24 1d.s1. 432961837us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6c:12, current 11
<0> [445.661191] kworker/-379 0..... 432965701us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:220, current 220
<0> [445.661287] kworker/-379 0..... 432965718us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6c:12, current 12
<0> [445.661378] sysfs_he-2777 2d..2. 432966023us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.661468] sysfs_he-2777 2d..2. 432966105us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.661565] sysfs_he-2777 2..... 432967666us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:222, current 220
<0> [445.661662] sysfs_he-2777 2D..1. 432967670us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:222, current 220
<0> [445.661758] kworker/-379 0..... 432977984us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:222, current 222
<0> [445.661849] sysfs_he-2777 2d..2. 432978306us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.661939] sysfs_he-2777 2d..2. 432978382us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.662036] kworker/-80 0..... 432979937us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:98, current 97
<0> [445.662133] kworker/-80 0D..1. 432979942us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:98, current 97
<0> [445.662230] sysfs_he-2777 2..... 432979949us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:224, current 222
<0> [445.662326] sysfs_he-2777 2D..1. 432979954us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:224, current 222
<0> [445.662422] kworker/-379 0..... 432990190us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:224, current 224
<0> [445.662513] sysfs_he-2777 2d..2. 432990498us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.662603] sysfs_he-2777 2d..2. 432990574us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.662701] sysfs_he-2777 2..... 432992147us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:226, current 224
<0> [445.662797] sysfs_he-2777 2D..1. 432992152us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:226, current 224
<0> [445.662879] kworker/-2105 1..... 433001154us : __intel_context_do_unpin.part.0: 0000:03:00.0 vecs0: context:f6c unpin
<0> [445.662960] kworker/-2105 1..... 433001708us : __intel_context_retire: 0000:03:00.0 vecs0: context:f6c retire runtime: { total:30369ns, avg:5035ns }
<0> [445.663059] kworker/-379 0..... 433002432us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:226, current 226
<0> [445.663150] sysfs_he-2777 2d..2. 433002730us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.663240] sysfs_he-2777 2d..2. 433002824us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.663338] sysfs_he-2777 2..... 433004527us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:228, current 226
<0> [445.663434] sysfs_he-2777 2D..1. 433004532us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:228, current 226
<0> [445.663531] kworker/-80 0..... 433009012us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:99, current 98
<0> [445.663628] kworker/-80 0D..1. 433009017us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:99, current 98
<0> [445.663724] kworker/-379 0..... 433014808us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:228, current 228
<0> [445.663814] kworker/-2105 1d..2. 433015087us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.663904] kworker/-2105 1d..2. 433015187us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.664001] sysfs_he-2777 2..... 433016723us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:230, current 228
<0> [445.664098] sysfs_he-2777 2D..1. 433016728us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:230, current 228
<0> [445.664187] kworker/-2105 1d..2. 433021291us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.664278] kworker/-2105 1d..2. 433021399us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.664359] sysfs_he-2778 4..... 433021458us : __intel_context_do_pin_ww: 0000:03:00.0 vecs0: context:f6c active
<0> [445.664447] sysfs_he-2778 4..... 433021462us : intel_timeline_pin: 0000:03:00.0 timeline:f6c using HWSP offset:feb88000
<0> [445.664528] sysfs_he-2778 4..... 433021470us : __intel_context_do_pin_ww: 0000:03:00.0 vecs0: context:f6c pin ring:{start:fea40000, head:0360, tail:0360}
<0> [445.664628] sysfs_he-2778 4..... 433023133us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6c:14, current 12
<0> [445.664725] sysfs_he-2778 4D..1. 433023141us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6c:14, current 12
<0> [445.664821] kworker/-379 0..... 433026944us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence f6a:230, current 230
<0> [445.664911] kworker/-2101 3d..2. 433027227us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.665000] kworker/-2101 3d..2. 433027344us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.665097] sysfs_he-2777 2..... 433029448us : __i915_request_commit: 0000:03:00.0 vecs0: fence f6a:232, current 230
<0> [445.665194] sysfs_he-2777 2D..1. 433029456us : __i915_request_submit: 0000:03:00.0 vecs0: fence f6a:232, current 230
<0> [445.665291] kworker/-80 0..... 433036958us : __i915_request_commit: 0000:03:00.0 vecs0: fence 88e:100, current 99
<0> [445.665387] kworker/-80 0D..1. 433036967us : __i915_request_submit: 0000:03:00.0 vecs0: fence 88e:100, current 99
<0> [445.665483] kworker/-138 2..... 433049954us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:50, current 99
<0> [445.665579] kworker/-138 2..... 433050426us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:51, current 99
<0> [445.665676] kworker/-138 2..... 433050436us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:52, current 99
<0> [445.665772] kworker/-138 2..... 433050443us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:53, current 99
<0> [445.665869] kworker/-138 2..... 433050450us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:54, current 99
<0> [445.665965] kworker/-138 2..... 433050457us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:55, current 99
<0> [445.666062] kworker/-138 2..... 433050464us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:56, current 99
<0> [445.666158] kworker/-138 2..... 433050471us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:57, current 99
<0> [445.666255] kworker/-138 2..... 433050478us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:58, current 99
<0> [445.666351] kworker/-138 2..... 433050485us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:59, current 99
<0> [445.666448] kworker/-138 2..... 433050492us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:60, current 99
<0> [445.666544] kworker/-138 2..... 433050498us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:61, current 99
<0> [445.666641] kworker/-138 2..... 433050505us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:62, current 99
<0> [445.666737] kworker/-138 2..... 433050511us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:63, current 99
<0> [445.666833] kworker/-138 2..... 433050520us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:64, current 99
<0> [445.666929] kworker/-138 2..... 433050527us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:65, current 99
<0> [445.667025] kworker/-138 2..... 433050534us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:66, current 99
<0> [445.667122] kworker/-138 2..... 433050541us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:67, current 99
<0> [445.667218] kworker/-138 2..... 433050547us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:68, current 99
<0> [445.667315] kworker/-138 2..... 433050554us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:69, current 99
<0> [445.667411] kworker/-138 2..... 433050561us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:70, current 99
<0> [445.667509] kworker/-138 2..... 433050569us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:71, current 99
<0> [445.667606] kworker/-138 2..... 433050576us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:72, current 99
<0> [445.667703] kworker/-138 2..... 433050583us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:73, current 99
<0> [445.667799] kworker/-138 2..... 433050590us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:74, current 99
<0> [445.667896] kworker/-138 2..... 433050597us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:75, current 99
<0> [445.667993] kworker/-138 2..... 433050604us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:76, current 99
<0> [445.668089] kworker/-138 2..... 433050611us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:77, current 99
<0> [445.668185] kworker/-138 2..... 433050618us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:78, current 99
<0> [445.668282] kworker/-138 2..... 433050624us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:79, current 99
<0> [445.668378] kworker/-138 2..... 433050631us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:80, current 99
<0> [445.668475] kworker/-138 2..... 433050639us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:81, current 99
<0> [445.668572] kworker/-138 2..... 433050645us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:82, current 99
<0> [445.668668] kworker/-138 2..... 433050652us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:83, current 99
<0> [445.668765] kworker/-138 2..... 433050659us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:84, current 99
<0> [445.668861] kworker/-138 2..... 433050666us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:85, current 99
<0> [445.668958] kworker/-138 2..... 433050673us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:86, current 99
<0> [445.669054] kworker/-138 2..... 433050680us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:87, current 99
<0> [445.669150] kworker/-138 2..... 433050686us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:88, current 99
<0> [445.669247] kworker/-138 2..... 433050693us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:89, current 99
<0> [445.669343] kworker/-138 2..... 433050699us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:90, current 99
<0> [445.669440] kworker/-138 2..... 433050705us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:91, current 99
<0> [445.669536] kworker/-138 2..... 433050712us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:92, current 99
<0> [445.669633] kworker/-138 2..... 433050718us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:93, current 99
<0> [445.669729] kworker/-138 2..... 433050725us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:94, current 99
<0> [445.669825] kworker/-138 2..... 433050732us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:95, current 99
<0> [445.669922] kworker/-138 2..... 433050740us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:96, current 99
<0> [445.670019] kworker/-138 2..... 433050747us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:97, current 99
<0> [445.670115] kworker/-138 2..... 433050753us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:98, current 99
<0> [445.670211] kworker/-138 2..... 433050760us : i915_request_retire.part.0: 0000:03:00.0 vecs0: fence 88e:99, current 99
<0> [445.670308] kworker/-138 2..... 433050768us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence f61:2, current 2
<0> [445.670404] kworker/-138 2..... 433050815us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 88a:336, current 341
<0> [445.670501] kworker/-138 2..... 433050817us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 88a:337, current 341
<0> [445.670597] kworker/-138 2..... 433050825us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 88a:338, current 341
<0> [445.670694] kworker/-138 2..... 433050832us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 88a:339, current 341
<0> [445.670790] kworker/-138 2..... 433050839us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 88a:340, current 341
<0> [445.670887] kworker/-138 2..... 433050845us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 88a:341, current 341
<0> [445.670983] kworker/-138 2..... 433050862us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence f62:2, current 2
<0> [445.671079] kworker/-138 2..... 433050916us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence f63:2, current 2
<0> [445.671161] kworker/-2105 1..... 433050931us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:f61 unpin
<0> [445.671250] kworker/-2101 3d..2. 433051065us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.671347] kworker/-138 2..... 433051072us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence f64:2, current 2
<0> [445.671443] kworker/-138 2..... 433051112us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence f65:2, current 2
<0> [445.671539] kworker/-138 2..... 433051151us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence f67:2, current 2
<0> [445.671635] kworker/-138 2..... 433051192us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence f66:2, current 2
<0> [445.671731] kworker/-138 2..... 433051233us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence f69:2, current 2
<0> [445.671820] kworker/-2101 3d..2. 433051257us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.671917] kworker/-138 2..... 433051280us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence f68:2, current 2
<0> [445.672013] kworker/-138 2..... 433051321us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence f6b:2, current 2
<0> [445.672103] kworker/-2101 3d..2. 433051361us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.672193] kworker/-2101 3d..2. 433051503us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.672282] kworker/-2101 3d..2. 433051641us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.672364] kworker/-2105 1..... 433051709us : __intel_context_retire: 0000:03:00.0 rcs0: context:f61 retire runtime: { total:55544ns, avg:55544ns }
<0> [445.672447] kworker/-2105 1..... 433051737us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:f62 unpin
<0> [445.672536] kworker/-2101 3d..2. 433051862us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.672617] kworker/-2105 1..... 433052343us : __intel_context_retire: 0000:03:00.0 rcs0: context:f62 retire runtime: { total:54749ns, avg:54749ns }
<0> [445.672701] kworker/-2105 1..... 433052362us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:f63 unpin
<0> [445.672789] kworker/-2101 3d..2. 433052525us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.672878] kworker/-2101 3d..2. 433052682us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.672967] kworker/-2101 3d..2. 433052772us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.673048] kworker/-2105 1..... 433053063us : __intel_context_retire: 0000:03:00.0 rcs0: context:f63 retire runtime: { total:55809ns, avg:55809ns }
<0> [445.673140] kworker/-2101 3d..2. 433053072us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.673220] kworker/-2105 1..... 433053083us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:f64 unpin
<0> [445.673309] kworker/-2101 3d..2. 433053183us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.673397] kworker/-2101 3d..2. 433053336us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.673486] kworker/-2101 3d..2. 433053423us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.673576] kworker/-2101 3d..2. 433053582us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.673657] kworker/-2105 1..... 433053690us : __intel_context_retire: 0000:03:00.0 rcs0: context:f64 retire runtime: { total:55915ns, avg:55915ns }
<0> [445.673740] kworker/-2105 1..... 433053706us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:f65 unpin
<0> [445.673829] kworker/-2101 3d..2. 433053770us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.673919] kworker/-2101 3d..2. 433054144us : intel_gt_invalidate_tlb_full.part.0: 0000:03:00.0 invalidated engines 00040001
<0> [445.674000] kworker/-2105 1.N... 433054304us : __intel_context_retire: 0000:03:00.0 rcs0: context:f65 retire runtime: { total:54113ns, avg:54113ns }
<0> [445.674083] kworker/-2105 1.N... 433054323us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:f67 unpin
<0> [445.674163] kworker/-2105 1.N... 433054910us : __intel_context_retire: 0000:03:00.0 rcs0: context:f67 retire runtime: { total:56074ns, avg:56074ns }
<0> [445.674245] kworker/-2105 1.N... 433054929us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:f66 unpin
<0> [445.674326] kworker/-2105 1.N... 433055545us : __intel_context_retire: 0000:03:00.0 rcs0: context:f66 retire runtime: { total:55332ns, avg:55332ns }
<0> [445.674408] kworker/-2105 1.N... 433055565us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:f69 unpin
<0> [445.674489] kworker/-2105 1.N... 433056152us : __intel_context_retire: 0000:03:00.0 rcs0: context:f69 retire runtime: { total:54272ns, avg:54272ns }
<0> [445.674571] kworker/-2105 1.N... 433056171us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:f68 unpin
<0> [445.674651] kworker/-2105 1.N... 433056751us : __intel_context_retire: 0000:03:00.0 rcs0: context:f68 retire runtime: { total:55544ns, avg:55544ns }
<0> [445.674733] kworker/-2105 1.N... 433056769us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:f6b unpin
<0> [445.674813] kworker/-2105 1.N... 433057359us : __intel_context_retire: 0000:03:00.0 rcs0: context:f6b retire runtime: { total:60473ns, avg:60473ns }
<0> [445.674896] kworker/-104 1..... 433058335us : __engine_park: 0000:03:00.0 rcs0: parked
<0> [445.674994] kworker/-2101 3..... 433061110us : destroyed_worker_func: guc_lrc_desc_unpin:3418 GEM_BUG_ON(!ctx_id_mapped(guc, ce->guc_id.id))
<0> [445.675010] ---------------------------------
<4> [445.675112] ------------[ cut here ]------------
<2> [445.675114] kernel BUG at drivers/gpu/drm/i915/gt/uc/intel_guc_submission.c:3418!
<4> [445.675130] Oops: invalid opcode: 0000 [#1] SMP NOPTI
<4> [445.675136] CPU: 3 UID: 0 PID: 2101 Comm: kworker/u24:8 Tainted: G S U W 6.17.0-rc2-CI_DRM_17043-g16e133c7e692+ #1 PREEMPT(voluntary)
<4> [445.675144] Tainted: [S]=CPU_OUT_OF_SPEC, [U]=USER, [W]=WARN
<4> [445.675147] Hardware name: Intel Corporation CoffeeLake Client Platform/CoffeeLake S UDIMM RVP, BIOS CNLSFWR1.R00.X220.B00.2103302221 03/30/2021
<4> [445.675153] Workqueue: events_unbound destroyed_worker_func [i915]
<4> [445.675352] RIP: 0010:destroyed_worker_func+0x66d/0x8a0 [i915]
<4> [445.675535] Code: 00 48 c7 c2 50 be 1b a1 48 8d 3d 00 00 00 00 e8 f9 c5 85 e0 bf 01 00 00 00 e8 cf 7d 85 e0 31 f6 bf 09 00 00 00 e8 c3 3b 65 e0 <0f> 0b 48 c7 c1 46 e5 2c a1 ba 08 02 00 00 48 c7 c6 90 c6 1b a1 48
<4> [445.675543] RSP: 0018:ffffc90002cf7d80 EFLAGS: 00010246
<4> [445.675547] RAX: 0000000000000000 RBX: ffff88813a430028 RCX: 0000000000000000
<4> [445.675551] RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000000
<4> [445.675554] RBP: ffffc90002cf7df0 R08: 0000000000000000 R09: 0000000000000000
<4> [445.675558] R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000001007
<4> [445.675561] R13: ffff88813a430ce0 R14: ffff88818899c120 R15: ffff88813a430cd0
<4> [445.675565] FS: 0000000000000000(0000) GS:ffff8884d9878000(0000) knlGS:0000000000000000
<4> [445.675569] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
<4> [445.675573] CR2: 0000704fa1ad7000 CR3: 0000000003448004 CR4: 00000000003726f0
<4> [445.675577] Call Trace:
<4> [445.675579] <TASK>
<4> [445.675583] process_one_work+0x22e/0x6f0
<4> [445.675590] worker_thread+0x1e8/0x3d0
<4> [445.675594] ? __pfx_worker_thread+0x10/0x10
<4> [445.675598] kthread+0x11c/0x250
<4> [445.675602] ? __pfx_kthread+0x10/0x10
<4> [445.675605] ret_from_fork+0x26f/0x2e0
<4> [445.675609] ? __pfx_kthread+0x10/0x10
<4> [445.675612] ret_from_fork_asm+0x1a/0x30
<4> [445.675619] </TASK>
<4> [445.675621] Modules linked in: snd_hda_intel i915 vgem snd_hda_codec_intelhdmi snd_hda_codec_hdmi mei_gsc prime_numbers ttm drm_buddy drm_display_helper cec rc_core i2c_algo_bit kunit intel_rapl_msr cmdlinepart intel_rapl_common spi_nor mtd intel_uncore_frequency intel_uncore_frequency_common ee1004 r8153_ecm mei_pxp mei_hdcp cdc_ether usbnet ppdev intel_tcc_cooling x86_pkg_temp_thermal wmi_bmof intel_powerclamp intel_wmi_thunderbolt coretemp kvm_intel snd_intel_dspcfg kvm irqbypass snd_hda_codec polyval_clmulni ghash_clmulni_intel snd_hda_core aesni_intel snd_hwdep rapl r8152 snd_pcm mii intel_cstate i2c_i801 snd_timer spi_intel_pci snd e1000e spi_intel i2c_mux i2c_smbus idma64 mei_me mei soundcore video binfmt_misc parport_pc parport intel_pmc_core pmt_telemetry nls_iso8859_1 pmt_discovery pinctrl_cannonlake intel_pch_thermal input_leds pmt_class intel_pmc_ssram_telemetry wmi acpi_tad intel_vsec acpi_pad serio_raw dm_multipath msr nvme_fabrics fuse efi_pstore nfnetlink autofs4 [last unloaded: i915]
<4> [445.675750] ---[ end trace 0000000000000000 ]---
<4> [445.678032] kauditd_printk_skb: 113 callbacks suppressed
<5> [445.678034] audit: type=1400 audit(1755794533.547:125): apparmor="DENIED" operation="open" class="file" profile="rsyslogd" name="/run/systemd/sessions/" pid=630 comm=72733A6D61696E20513A526567 requested_mask="r" denied_mask="r" fsuid=103 ouid=0
<5> [445.678096] audit: type=1400 audit(1755794533.547:126): apparmor="DENIED" operation="open" class="file" profile="rsyslogd" name="/run/systemd/sessions/" pid=630 comm=72733A6D61696E20513A526567 requested_mask="r" denied_mask="r" fsuid=103 ouid=0
<5> [445.678148] audit: type=1400 audit(1755794533.547:127): apparmor="DENIED" operation="open" class="file" profile="rsyslogd" name="/run/systemd/sessions/" pid=630 comm=72733A6D61696E20513A526567 requested_mask="r" denied_mask="r" fsuid=103 ouid=0
<5> [445.678197] audit: type=1400 audit(1755794533.547:128): apparmor="DENIED" operation="open" class="file" profile="rsyslogd" name="/run/systemd/sessions/" pid=630 comm=72733A6D61696E20513A526567 requested_mask="r" denied_mask="r" fsuid=103 ouid=0
<5> [445.678245] audit: type=1400 audit(1755794533.547:129): apparmor="DENIED" operation="open" class="file" profile="rsyslogd" name="/run/systemd/sessions/" pid=630 comm=72733A6D61696E20513A526567 requested_mask="r" denied_mask="r" fsuid=103 ouid=0
<5> [445.678295] audit: type=1400 audit(1755794533.547:130): apparmor="DENIED" operation="open" class="file" profile="rsyslogd" name="/run/systemd/sessions/" pid=630 comm=72733A6D61696E20513A526567 requested_mask="r" denied_mask="r" fsuid=103 ouid=0
<5> [445.678343] audit: type=1400 audit(1755794533.547:131): apparmor="DENIED" operation="open" class="file" profile="rsyslogd" name="/run/systemd/sessions/" pid=630 comm=72733A6D61696E20513A526567 requested_mask="r" denied_mask="r" fsuid=103 ouid=0
<5> [445.678389] audit: type=1400 audit(1755794533.547:132): apparmor="DENIED" operation="open" class="file" profile="rsyslogd" name="/run/systemd/sessions/" pid=630 comm=72733A6D61696E20513A526567 requested_mask="r" denied_mask="r" fsuid=103 ouid=0
<5> [445.678437] audit: type=1400 audit(1755794533.547:133): apparmor="DENIED" operation="open" class="file" profile="rsyslogd" name="/run/systemd/sessions/" pid=630 comm=72733A6D61696E20513A526567 requested_mask="r" denied_mask="r" fsuid=103 ouid=0
<5> [445.678483] audit: type=1400 audit(1755794533.547:134): apparmor="DENIED" operation="open" class="file" profile="rsyslogd" name="/run/systemd/sessions/" pid=630 comm=72733A6D61696E20513A526567 requested_mask="r" denied_mask="r" fsuid=103 ouid=0
<4> [446.029811] RIP: 0010:destroyed_worker_func+0x66d/0x8a0 [i915]
<4> [446.030152] Code: 00 48 c7 c2 50 be 1b a1 48 8d 3d 00 00 00 00 e8 f9 c5 85 e0 bf 01 00 00 00 e8 cf 7d 85 e0 31 f6 bf 09 00 00 00 e8 c3 3b 65 e0 <0f> 0b 48 c7 c1 46 e5 2c a1 ba 08 02 00 00 48 c7 c6 90 c6 1b a1 48
<4> [446.030160] RSP: 0018:ffffc90002cf7d80 EFLAGS: 00010246
<4> [446.030165] RAX: 0000000000000000 RBX: ffff88813a430028 RCX: 0000000000000000
<4> [446.030169] RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000000
<4> [446.030173] RBP: ffffc90002cf7df0 R08: 0000000000000000 R09: 0000000000000000
<4> [446.030176] R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000001007
<4> [446.030180] R13: ffff88813a430ce0 R14: ffff88818899c120 R15: ffff88813a430cd0
<4> [446.030183] FS: 0000000000000000(0000) GS:ffff8884d9878000(0000) knlGS:0000000000000000
<4> [446.030188] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
<4> [446.030191] CR2: 0000704fa1ad7000 CR3: 0000000003448004 CR4: 00000000003726f0
<6> [446.044967] [IGT] sysfs_heartbeat_interval: finished subtest vecs0, FAIL
<6> [446.045555] [IGT] sysfs_heartbeat_interval: starting dynamic subtest ccs0
<7> [446.045760] i915 0000:03:00.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<4> [478.986793] sched: DL replenish lagged too much
Created at 2025-08-21 17:29:04