Result: 466 Warning(s)
git-log-oneline i915_display_info16 igt_runner16 runtimes16 results16.json results16-i915-load.json guc_logs16.tar i915_display_info_post_exec16 boot16 dmesg16
pstore-001-dmesg16| Detail | Value |
|---|---|
| Duration | unknown |
| Hostname |
shard-dg2-6 |
| Igt-Version |
IGT-Version: 2.4-gd693520ac (x86_64) (Linux: 7.1.0-rc2-CI_DRM_18417-g835de80ce9b3+ x86_64) |
| Out |
Using IGT_SRANDOM=1778243928 for randomisation
Opened device: /dev/dri/card0
Runtime PM support: 1
PC8 residency support: 0
DMC: fw loaded: yes
i915_runtime_pm_status:
GPU idle: no
IRQs disabled: no
Usage count: 5
PCI device power state: D0 [0]
ref_tracker: intel_runtime_pm@ffff88813d1ed7b8 has 1/5 users at
track_intel_runtime_pm_wakeref+0x90/0xb0 [i915]
__intel_runtime_pm_get+0x60/0x130 [i915]
i915_display_rpm_get_raw+0x17/0x30 [i915]
intel_display_rpm_get_raw+0x20/0x30 [i915]
__intel_display_power_put_async+0x3a/0x1c0 [i915]
intel_atomic_commit_tail+0x1bba/0x20c0 [i915]
intel_atomic_commit+0x2ff/0x350 [i915]
drm_atomic_commit+0xaf/0xf0
drm_atomic_helper_set_config+0x82/0xd0
drm_mode_setcrtc+0x548/0xa10
drm_ioctl_kernel+0xb3/0x120
drm_ioctl+0x2d4/0x5a0
__x64_sys_ioctl+0xa5/0x100
x64_sys_call+0x1250/0x26e0
do_syscall_64+0x103/0x1410
entry_SYSCALL_64_after_hwframe+0x76/0x7e
ref_tracker: intel_runtime_pm@ffff88813d1ed7b8 has 2/5 users at
track_intel_runtime_pm_wakeref+0x90/0xb0 [i915]
__intel_runtime_pm_get+0x60/0x130 [i915]
intel_runtime_pm_get+0x13/0x20 [i915]
__intel_wakeref_get_first+0x2a/0xe0 [i915]
guc_context_pin+0xae/0xb0 [i915]
__intel_context_do_pin_ww+0x780/0xe90 [i915]
eb_pin_engine+0x383/0x3b0 [i915]
i915_gem_do_execbuffer+0xd97/0x36e0 [i915]
i915_gem_execbuffer2_ioctl+0x169/0x320 [i915]
drm_ioctl_kernel+0xb3/0x120
drm_ioctl+0x2d4/0x5a0
__x64_sys_ioctl+0xa5/0x100
x64_sys_call+0x1250/0x26e0
do_syscall_64+0x103/0x1410
entry_SYSCALL_64_after_hwframe+0x76/0x7e
ref_tracker: intel_runtime_pm@ffff88813d1ed7b8 has 1/5 users at
track_intel_runtime_pm_wakeref+0x90/0xb0 [i915]
__intel_runtime_pm_get+0x60/0x130 [i915]
i915_display_rpm_get+0x1a/0x30 [i915]
intel_display_rpm_get+0x1f/0x30 [i915]
intel_display_power_get+0x22/0x70 [i915]
__gt_unpark+0x5b/0x200 [i915]
__intel_wakeref_get_first+0x63/0xe0 [i915]
__i915_vma_active+0xc2/0xd0 [i915]
i915_active_acquire+0xab/0xd0 [i915]
i915_vma_pin_ww+0x2e5/0x1390 [i915]
i915_vma_pin+0x155/0x1f0 [i915]
gen8_ppgtt_create+0x3c9/0x9b0 [i915]
i915_ppgtt_create+0x55/0xf0 [i915]
i915_gem_create_context+0x418/0x950 [i915]
i915_gem_context_lookup.part.0+0x9d/0x1a0 [i915]
i915_gem_context_lookup+0x10e/0x220 [i915]
ref_tracker: intel_runtime_pm@ffff88813d1ed7b8 has 1/5 users at
track_intel_runtime_pm_wakeref+0x90/0xb0 [i915]
__intel_runtime_pm_get+0x60/0x130 [i915]
intel_runtime_pm_get+0x13/0x20 [i915]
__intel_wakeref_get_first+0x2a/0xe0 [i915]
__i915_vma_active+0xc2/0xd0 [i915]
i915_active_acquire+0xab/0xd0 [i915]
i915_vma_pin_ww+0x2e5/0x1390 [i915]
i915_vma_pin+0x155/0x1f0 [i915]
gen8_ppgtt_create+0x3c9/0x9b0 [i915]
i915_ppgtt_create+0x55/0xf0 [i915]
i915_gem_create_context+0x418/0x950 [i915]
i915_gem_context_lookup.part.0+0x9d/0x1a0 [i915]
i915_gem_context_lookup+0x10e/0x220 [i915]
i915_gem_do_execbuffer+0x5ab/0x36e0 [i915]
i915_gem_execbuffer2_ioctl+0x169/0x320 [i915]
drm_ioctl_kernel+0xb3/0x120
Starting subtest: system-suspend-execbuf
[cmd] rtcwake: assuming RTC uses UTC ...
[cmd] rtcwake: wakeup from "mem" using /dev/rtc0 at Fri May 8 12:39:08 2026
Subtest system-suspend-execbuf: SUCCESS (44.962s)
runner: This test was killed due to a kernel taint (0x42c4).
This test caused an abort condition: Lockdep not active
/proc/lockdep_stats contents:
lock-classes: 2315 [max: 8192]
dynamic-keys: 331
direct dependencies: 26120 [max: 524288]
indirect dependencies: 241072
all direct dependencies: 528272
dependency chains: 41853 [max: 524288]
dependency chain hlocks used: 185192 [max: 2621440]
dependency chain hlocks lost: 0
in-hardirq chains: 268
in-softirq chains: 905
in-process chains: 40680
stack-trace entries: 285616 [max: 524288]
number of stack traces: 13063
number of stack hash chains: 9018
combined max dependencies: 1324594642
hardirq-safe locks: 106
hardirq-unsafe locks: 1372
softirq-safe locks: 242
softirq-unsafe locks: 1269
irq-safe locks: 260
irq-unsafe locks: 1372
hardirq-read-safe locks: 4
hardirq-read-unsafe locks: 438
softirq-read-safe locks: 8
softirq-read-unsafe locks: 435
irq-read-safe locks: 8
irq-read-unsafe locks: 438
uncategorized locks: 398
unused locks: 1
max locking depth: 16
max bfs queue depth: 561
max lock class index: 2314
debug_locks: 0
zapped classes: 2
zapped lock chains: 181
large chain blocks: 1
|
| Err |
Starting subtest: system-suspend-execbuf Subtest system-suspend-execbuf: SUCCESS (44.962s) |
| Dmesg |
<0> [241.236977] i915_pm_-2133 0...1. 172881923us : tracing_mark_write: i915_pm_rpm: starting subtest system-suspend-execbuf
<0> [241.237629] i915_pm_-2133 0..... 172976111us : intel_gt_runtime_resume: 0000:03:00.0
<0> [241.238378] kworker/-58 3..... 173807820us : intel_gt_runtime_suspend: 0000:03:00.0
<0> [241.239019] rtcwake-2137 4..... 174078220us : intel_gt_runtime_resume: 0000:03:00.0
<0> [241.239662] rtcwake-2137 1..... 174101023us : __engine_unpark: 0000:03:00.0 bcs0:
<0> [241.240388] rtcwake-2137 1..... 174101155us : __gt_unpark: 0000:03:00.0
<0> [241.241034] rtcwake-2137 1..... 174104000us : __engine_unpark: 0000:03:00.0 bcs0: context:6 reset { seqno:33, *hwsp:33, ring:e78 }
<0> [241.241704] rtcwake-2137 1..... 174104389us : __i915_request_commit: 0000:03:00.0 bcs0: fence 13:138, current 137
<0> [241.242483] rtcwake-2137 1D..1. 174104422us : __i915_request_submit: 0000:03:00.0 bcs0: fence 13:138, current 137
<0> [241.243143] rtcwake-2137 1..... 174107717us : __i915_request_commit: 0000:03:00.0 bcs0: fence 13:139, current 138
<0> [241.243796] rtcwake-2137 1D..1. 174107728us : __i915_request_submit: 0000:03:00.0 bcs0: fence 13:139, current 138
<0> [241.244533] rtcwake-2137 1..... 174108688us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 13:138, current 139
<0> [241.245172] rtcwake-2137 1..... 174108858us : __i915_request_commit: 0000:03:00.0 bcs0: fence 13:140, current 139
<0> [241.245818] rtcwake-2137 1D..1. 174108868us : __i915_request_submit: 0000:03:00.0 bcs0: fence 13:140, current 139
<0> [241.246559] rtcwake-2137 1.l... 174109521us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 13:139, current 140
<0> [241.247218] rtcwake-2137 1.l... 174109686us : __i915_request_commit: 0000:03:00.0 bcs0: fence 13:141, current 140
<0> [241.247872] rtcwake-2137 1Dl.1. 174109696us : __i915_request_submit: 0000:03:00.0 bcs0: fence 13:141, current 140
<0> [241.248620] rtcwake-2137 1.l... 174110168us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 13:140, current 141
<0> [241.249269] rtcwake-2137 1.l... 174110258us : __i915_request_commit: 0000:03:00.0 bcs0: fence 13:142, current 141
<0> [241.249915] rtcwake-2137 1Dl.1. 174110267us : __i915_request_submit: 0000:03:00.0 bcs0: fence 13:142, current 141
<0> [241.250663] rtcwake-2137 1..... 174111069us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 13:141, current 142
<0> [241.251313] rtcwake-2137 1..... 174111113us : __i915_request_commit: 0000:03:00.0 bcs0: fence 13:143, current 142
<0> [241.251971] rtcwake-2137 1D..1. 174111122us : __i915_request_submit: 0000:03:00.0 bcs0: fence 13:143, current 142
<0> [241.252724] rtcwake-2137 1..... 174111620us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 13:142, current 143
<0> [241.253377] rtcwake-2137 1..... 174111644us : __i915_request_commit: 0000:03:00.0 bcs0: fence 13:144, current 143
<0> [241.254027] rtcwake-2137 1D..1. 174111653us : __i915_request_submit: 0000:03:00.0 bcs0: fence 13:144, current 143
<0> [241.254773] rtcwake-2137 1..... 174112305us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 13:143, current 144
<0> [241.255424] rtcwake-2137 1..... 174112329us : __i915_request_commit: 0000:03:00.0 bcs0: fence 13:145, current 144
<0> [241.256071] rtcwake-2137 1D..1. 174113044us : __i915_request_submit: 0000:03:00.0 bcs0: fence 13:145, current 144
<0> [241.256806] kworker/-210 4..... 174113466us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 13:144, current 145
<0> [241.257453] kworker/-210 4..... 174113469us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 13:145, current 145
<0> [241.258089] kworker/-210 4..... 174113484us : __engine_park: 0000:03:00.0 bcs0: parked
<0> [241.258825] rtcwake-2137 1..... 174114031us : __engine_unpark: 0000:03:00.0 bcs0:
<0> [241.259457] rtcwake-2137 1..... 174114180us : __engine_unpark: 0000:03:00.0 bcs0: context:6 reset { seqno:33, *hwsp:33, ring:e78 }
<0> [241.260113] rtcwake-2137 1..... 174114215us : __i915_request_commit: 0000:03:00.0 bcs0: fence 13:146, current 145
<0> [241.260873] rtcwake-2137 1D..1. 174114223us : __i915_request_submit: 0000:03:00.0 bcs0: fence 13:146, current 145
<0> [241.261535] kworker/-210 4..... 174114657us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 13:146, current 146
<0> [241.262199] kworker/-210 4..... 174114666us : __engine_park: 0000:03:00.0 bcs0: parked
<0> [241.262976] kworker/-210 4..... 174114698us : __gt_park: 0000:03:00.0
<0> [241.263644] rtcwake-2137 1..... 174114716us : __engine_unpark: 0000:03:00.0 bcs0:
<0> [241.264321] rtcwake-2137 1..... 174114733us : __gt_unpark: 0000:03:00.0
<0> [241.265100] rtcwake-2137 1..... 174115268us : __engine_unpark: 0000:03:00.0 bcs0: context:6 reset { seqno:33, *hwsp:33, ring:e78 }
<0> [241.265792] rtcwake-2137 1..... 174115305us : __i915_request_commit: 0000:03:00.0 bcs0: fence 13:147, current 146
<0> [241.266481] rtcwake-2137 1D..1. 174115313us : __i915_request_submit: 0000:03:00.0 bcs0: fence 13:147, current 146
<0> [241.267261] kworker/-210 4..... 174115805us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 13:147, current 147
<0> [241.267935] kworker/-210 4..... 174115816us : __engine_park: 0000:03:00.0 bcs0: parked
<0> [241.268604] kworker/-210 4..... 174115850us : __gt_park: 0000:03:00.0
<0> [241.269369] rtcwake-2137 1..... 174126176us : __engine_unpark: 0000:03:00.0 bcs0:
<0> [241.270040] rtcwake-2137 1..... 174126189us : __gt_unpark: 0000:03:00.0
<0> [241.270703] rtcwake-2137 1..... 174126635us : __engine_unpark: 0000:03:00.0 bcs0: context:6 reset { seqno:33, *hwsp:33, ring:e78 }
<0> [241.271495] rtcwake-2137 1..... 174126692us : __i915_request_commit: 0000:03:00.0 bcs0: fence 13:148, current 147
<0> [241.272196] rtcwake-2137 1D..1. 174126700us : __i915_request_submit: 0000:03:00.0 bcs0: fence 13:148, current 147
<0> [241.272898] rtcwake-2137 1..... 174126886us : i915_gem_suspend: 0000:03:00.0
<0> [241.273691] kworker/-210 4..... 174127739us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 13:148, current 148
<0> [241.274382] kworker/-210 4..... 174127751us : __engine_park: 0000:03:00.0 bcs0: parked
<0> [241.275067] kworker/-210 4..... 174127774us : __gt_park: 0000:03:00.0
<0> [241.275854] rtcwake-2137 1..... 174135704us : __engine_unpark: 0000:03:00.0 bcs0:
<0> [241.276538] rtcwake-2137 1..... 174135715us : __gt_unpark: 0000:03:00.0
<0> [241.277214] rtcwake-2137 1..... 174135965us : __engine_unpark: 0000:03:00.0 bcs0: context:6 reset { seqno:33, *hwsp:33, ring:e78 }
<0> [241.278027] rtcwake-2137 1..... 174135990us : __i915_request_commit: 0000:03:00.0 bcs0: fence 13:149, current 148
<0> [241.278721] rtcwake-2137 1D..1. 174135995us : __i915_request_submit: 0000:03:00.0 bcs0: fence 13:149, current 148
<0> [241.279408] kworker/-210 4..... 174136144us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 13:149, current 149
<0> [241.280180] kworker/-210 4..... 174136150us : __engine_park: 0000:03:00.0 bcs0: parked
<0> [241.280850] kworker/-210 4..... 174136169us : __gt_park: 0000:03:00.0
<0> [241.281508] rtcwake-2137 1..... 174136450us : __engine_unpark: 0000:03:00.0 bcs0:
<0> [241.282267] rtcwake-2137 1..... 174136459us : __gt_unpark: 0000:03:00.0
<0> [241.282924] rtcwake-2137 1..... 174136510us : __engine_unpark: 0000:03:00.0 bcs0: context:6 reset { seqno:33, *hwsp:33, ring:e78 }
<0> [241.283602] rtcwake-2137 1..... 174136533us : __i915_request_commit: 0000:03:00.0 bcs0: fence 13:150, current 149
<0> [241.284376] rtcwake-2137 1D..1. 174136538us : __i915_request_submit: 0000:03:00.0 bcs0: fence 13:150, current 149
<0> [241.285049] kworker/-210 4..... 174136677us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 13:150, current 150
<0> [241.285716] kworker/-210 4..... 174136682us : __engine_park: 0000:03:00.0 bcs0: parked
<0> [241.286490] kworker/-210 4..... 174136699us : __gt_park: 0000:03:00.0
<0> [241.287154] rtcwake-2137 1..... 174136868us : __engine_unpark: 0000:03:00.0 bcs0:
<0> [241.287817] rtcwake-2137 1..... 174136877us : __gt_unpark: 0000:03:00.0
<0> [241.288572] rtcwake-2137 1..... 174136927us : __engine_unpark: 0000:03:00.0 bcs0: context:6 reset { seqno:33, *hwsp:33, ring:e78 }
<0> [241.289255] rtcwake-2137 1..... 174136950us : __i915_request_commit: 0000:03:00.0 bcs0: fence 13:151, current 150
<0> [241.289943] rtcwake-2137 1D..1. 174136955us : __i915_request_submit: 0000:03:00.0 bcs0: fence 13:151, current 150
<0> [241.290735] kworker/-210 4..... 174137106us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 13:151, current 151
<0> [241.291415] kworker/-210 4..... 174137111us : __engine_park: 0000:03:00.0 bcs0: parked
<0> [241.292091] kworker/-210 4..... 174137127us : __gt_park: 0000:03:00.0
<0> [241.292863] rtcwake-2137 1..... 174137284us : __engine_unpark: 0000:03:00.0 bcs0:
<0> [241.293540] rtcwake-2137 1..... 174137293us : __gt_unpark: 0000:03:00.0
<0> [241.294207] rtcwake-2137 1..... 174137342us : __engine_unpark: 0000:03:00.0 bcs0: context:6 reset { seqno:33, *hwsp:33, ring:e78 }
<0> [241.295001] rtcwake-2137 1..... 174137363us : __i915_request_commit: 0000:03:00.0 bcs0: fence 13:152, current 151
<0> [241.295696] rtcwake-2137 1D..1. 174137368us : __i915_request_submit: 0000:03:00.0 bcs0: fence 13:152, current 151
<0> [241.296385] kworker/-210 4..... 174137507us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 13:152, current 152
<0> [241.297177] kworker/-210 4..... 174137512us : __engine_park: 0000:03:00.0 bcs0: parked
<0> [241.297863] kworker/-210 4..... 174137528us : __gt_park: 0000:03:00.0
<0> [241.298539] rtcwake-2137 1..... 174137704us : __engine_unpark: 0000:03:00.0 bcs0:
<0> [241.299308] rtcwake-2137 1..... 174137713us : __gt_unpark: 0000:03:00.0
<0> [241.299983] rtcwake-2137 1..... 174137763us : __engine_unpark: 0000:03:00.0 bcs0: context:6 reset { seqno:33, *hwsp:33, ring:e78 }
<0> [241.300683] rtcwake-2137 1..... 174137784us : __i915_request_commit: 0000:03:00.0 bcs0: fence 13:153, current 152
<0> [241.301490] rtcwake-2137 1D..1. 174137790us : __i915_request_submit: 0000:03:00.0 bcs0: fence 13:153, current 152
<0> [241.302188] kworker/-210 4..... 174137929us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 13:153, current 153
<0> [241.302878] kworker/-210 4..... 174137934us : __engine_park: 0000:03:00.0 bcs0: parked
<0> [241.303665] kworker/-210 4..... 174137949us : __gt_park: 0000:03:00.0
<0> [241.304349] rtcwake-2137 1..... 174138208us : __engine_unpark: 0000:03:00.0 bcs0:
<0> [241.305041] rtcwake-2137 1..... 174138217us : __gt_unpark: 0000:03:00.0
<0> [241.305827] rtcwake-2137 1..... 174138267us : __engine_unpark: 0000:03:00.0 bcs0: context:6 reset { seqno:33, *hwsp:33, ring:e78 }
<0> [241.306537] rtcwake-2137 1..... 174138290us : __i915_request_commit: 0000:03:00.0 bcs0: fence 13:154, current 153
<0> [241.307249] rtcwake-2137 1D..1. 174138295us : __i915_request_submit: 0000:03:00.0 bcs0: fence 13:154, current 153
<0> [241.308047] kworker/-210 4..... 174138442us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 13:154, current 154
<0> [241.308751] kworker/-210 4..... 174138448us : __engine_park: 0000:03:00.0 bcs0: parked
<0> [241.309448] kworker/-210 4..... 174138463us : __gt_park: 0000:03:00.0
<0> [241.310234] rtcwake-2137 1..... 174138729us : __engine_unpark: 0000:03:00.0 bcs0:
<0> [241.310929] rtcwake-2137 1..... 174138739us : __gt_unpark: 0000:03:00.0
<0> [241.311619] rtcwake-2137 1..... 174138788us : __engine_unpark: 0000:03:00.0 bcs0: context:6 reset { seqno:33, *hwsp:33, ring:e78 }
<0> [241.312437] rtcwake-2137 1..... 174138811us : __i915_request_commit: 0000:03:00.0 bcs0: fence 13:155, current 154
<0> [241.313147] rtcwake-2137 1D..1. 174138816us : __i915_request_submit: 0000:03:00.0 bcs0: fence 13:155, current 154
<0> [241.313851] kworker/-210 4..... 174138955us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 13:155, current 155
<0> [241.314648] kworker/-210 4..... 174138960us : __engine_park: 0000:03:00.0 bcs0: parked
<0> [241.315344] kworker/-210 4..... 174138974us : __gt_park: 0000:03:00.0
<0> [241.316033] rtcwake-2137 1..... 174142590us : __engine_unpark: 0000:03:00.0 bcs0:
<0> [241.316830] rtcwake-2137 1..... 174142599us : __gt_unpark: 0000:03:00.0
<0> [241.317520] rtcwake-2137 1..... 174142834us : __engine_unpark: 0000:03:00.0 bcs0: context:6 reset { seqno:33, *hwsp:33, ring:e78 }
<0> [241.318238] rtcwake-2137 1..... 174142867us : __i915_request_commit: 0000:03:00.0 bcs0: fence 13:156, current 155
<0> [241.319043] rtcwake-2137 1D..1. 174142872us : __i915_request_submit: 0000:03:00.0 bcs0: fence 13:156, current 155
<0> [241.319747] kworker/-210 4..... 174143444us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 13:156, current 156
<0> [241.320450] kworker/-210 4..... 174143451us : __engine_park: 0000:03:00.0 bcs0: parked
<0> [241.321254] kworker/-210 4..... 174143468us : __gt_park: 0000:03:00.0
<0> [241.321943] rtcwake-2137 1..... 174143618us : __engine_unpark: 0000:03:00.0 bcs0:
<0> [241.322632] rtcwake-2137 1..... 174143627us : __gt_unpark: 0000:03:00.0
<0> [241.323414] rtcwake-2137 1..... 174143677us : __engine_unpark: 0000:03:00.0 bcs0: context:6 reset { seqno:33, *hwsp:33, ring:e78 }
<0> [241.324124] rtcwake-2137 1..... 174143699us : __i915_request_commit: 0000:03:00.0 bcs0: fence 13:157, current 156
<0> [241.324835] rtcwake-2137 1D..1. 174143704us : __i915_request_submit: 0000:03:00.0 bcs0: fence 13:157, current 156
<0> [241.325632] kworker/-210 4..... 174143845us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 13:157, current 157
<0> [241.326327] kworker/-210 4..... 174143850us : __engine_park: 0000:03:00.0 bcs0: parked
<0> [241.327025] kworker/-210 4..... 174143865us : __gt_park: 0000:03:00.0
<0> [241.327810] rtcwake-2137 1..... 174144073us : __engine_unpark: 0000:03:00.0 bcs0:
<0> [241.328498] rtcwake-2137 1..... 174144083us : __gt_unpark: 0000:03:00.0
<0> [241.329184] rtcwake-2137 1..... 174144132us : __engine_unpark: 0000:03:00.0 bcs0: context:6 reset { seqno:33, *hwsp:33, ring:e78 }
<0> [241.329989] rtcwake-2137 1..... 174144154us : __i915_request_commit: 0000:03:00.0 bcs0: fence 13:158, current 157
<0> [241.330702] rtcwake-2137 1D..1. 174144159us : __i915_request_submit: 0000:03:00.0 bcs0: fence 13:158, current 157
<0> [241.331405] kworker/-210 4..... 174144308us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 13:158, current 158
<0> [241.332201] kworker/-210 4..... 174144312us : __engine_park: 0000:03:00.0 bcs0: parked
<0> [241.332899] kworker/-210 4..... 174144327us : __gt_park: 0000:03:00.0
<0> [241.333587] rtcwake-2137 1..... 174144518us : __engine_unpark: 0000:03:00.0 bcs0:
<0> [241.334362] rtcwake-2137 1..... 174144528us : __gt_unpark: 0000:03:00.0
<0> [241.335047] rtcwake-2137 1..... 174144577us : __engine_unpark: 0000:03:00.0 bcs0: context:6 reset { seqno:33, *hwsp:33, ring:e78 }
<0> [241.335757] rtcwake-2137 1..... 174144599us : __i915_request_commit: 0000:03:00.0 bcs0: fence 13:159, current 158
<0> [241.336572] rtcwake-2137 1D..1. 174144604us : __i915_request_submit: 0000:03:00.0 bcs0: fence 13:159, current 158
<0> [241.337277] kworker/-210 4..... 174144742us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 13:159, current 159
<0> [241.337972] kworker/-210 4..... 174144747us : __engine_park: 0000:03:00.0 bcs0: parked
<0> [241.338765] kworker/-210 4..... 174144762us : __gt_park: 0000:03:00.0
<0> [241.339453] rtcwake-2137 1..... 174144924us : __engine_unpark: 0000:03:00.0 bcs0:
<0> [241.340145] rtcwake-2137 1..... 174144933us : __gt_unpark: 0000:03:00.0
<0> [241.340929] rtcwake-2137 1..... 174144982us : __engine_unpark: 0000:03:00.0 bcs0: context:6 reset { seqno:33, *hwsp:33, ring:e78 }
<0> [241.341641] rtcwake-2137 1..... 174145005us : __i915_request_commit: 0000:03:00.0 bcs0: fence 13:160, current 159
<0> [241.342356] rtcwake-2137 1D..1. 174145010us : __i915_request_submit: 0000:03:00.0 bcs0: fence 13:160, current 159
<0> [241.343157] kworker/-210 4..... 174145150us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 13:160, current 160
<0> [241.343853] kworker/-210 4..... 174145155us : __engine_park: 0000:03:00.0 bcs0: parked
<0> [241.344553] kworker/-210 4..... 174145170us : __gt_park: 0000:03:00.0
<0> [241.345325] rtcwake-2137 1..... 174151866us : __engine_unpark: 0000:03:00.0 bcs0:
<0> [241.346016] rtcwake-2137 1..... 174151876us : __gt_unpark: 0000:03:00.0
<0> [241.346705] rtcwake-2137 1..... 174152124us : __engine_unpark: 0000:03:00.0 bcs0: context:6 reset { seqno:33, *hwsp:33, ring:e78 }
<0> [241.347491] rtcwake-2137 1..... 174152171us : __i915_request_commit: 0000:03:00.0 bcs0: fence 13:161, current 160
<0> [241.348204] rtcwake-2137 1D..1. 174152176us : __i915_request_submit: 0000:03:00.0 bcs0: fence 13:161, current 160
<0> [241.348910] kworker/-210 4..... 174153185us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 13:161, current 161
<0> [241.349711] kworker/-210 4..... 174153193us : __engine_park: 0000:03:00.0 bcs0: parked
<0> [241.350410] kworker/-210 4..... 174153210us : __gt_park: 0000:03:00.0
<0> [241.351102] kworker/-2146 0..... 174995364us : gt_sanitize: 0000:03:00.0 force:no
<0> [241.351900] kworker/-2146 0..... 174995578us : intel_engine_stop_cs: 0000:03:00.0 rcs0:
<0> [241.352590] kworker/-2146 0..... 174995587us : intel_engine_stop_cs: 0000:03:00.0 bcs0:
<0> [241.353274] kworker/-2146 0..... 174995626us : intel_engine_stop_cs: 0000:03:00.0 vcs0:
<0> [241.354056] kworker/-2146 0..... 174995637us : intel_engine_stop_cs: 0000:03:00.0 vcs1:
<0> [241.354727] kworker/-2146 0..... 174995646us : intel_engine_stop_cs: 0000:03:00.0 vecs0:
<0> [241.355390] kworker/-2146 0..... 174995656us : intel_engine_stop_cs: 0000:03:00.0 vecs1:
<0> [241.356148] kworker/-2146 0..... 174995666us : intel_engine_stop_cs: 0000:03:00.0 ccs0:
<0> [241.356802] kworker/-2146 0..... 174995675us : __intel_gt_reset: 0000:03:00.0 engine_mask=ffffffff
<0> [241.357456] kworker/-2146 0..... 174995965us : intel_gt_suspend_late: 0000:03:00.0
<0> [241.358206] kworker/-12 3..... 176628181us : __intel_gt_reset: 0000:03:00.0 engine_mask=ffffffff
<0> [241.358863] kworker/-12 3..... 176630732us : i915_gem_resume: 0000:03:00.0
<0> [241.359513] kworker/-12 3..... 176635849us : intel_gt_resume.part.0: 0000:03:00.0
<0> [241.360255] kworker/-12 3..... 176635850us : gt_sanitize: 0000:03:00.0 force:yes
<0> [241.360892] kworker/-12 3..... 176636171us : intel_engine_stop_cs: 0000:03:00.0 rcs0:
<0> [241.361531] kworker/-12 3..... 176636188us : intel_engine_stop_cs: 0000:03:00.0 bcs0:
<0> [241.362260] kworker/-12 3..... 176636617us : intel_engine_stop_cs: 0000:03:00.0 vcs0:
<0> [241.362882] kworker/-12 3..... 176636632us : intel_engine_stop_cs: 0000:03:00.0 vcs1:
<0> [241.363497] kworker/-12 3..... 176636649us : intel_engine_stop_cs: 0000:03:00.0 vecs0:
<0> [241.364193] kworker/-12 3..... 176636662us : intel_engine_stop_cs: 0000:03:00.0 vecs1:
<0> [241.364799] kworker/-12 3..... 176636675us : intel_engine_stop_cs: 0000:03:00.0 ccs0:
<0> [241.365400] kworker/-12 3..... 176636687us : __intel_gt_reset: 0000:03:00.0 engine_mask=ffffffff
<0> [241.366092] kworker/-12 3..... 176637521us : __gt_unpark: 0000:03:00.0
<0> [241.366689] kworker/-12 3..... 176653129us : __engine_unpark: 0000:03:00.0 rcs0:
<0> [241.367279] kworker/-12 3..... 176653217us : __engine_unpark: 0000:03:00.0 rcs0: context:5 reset { seqno:59, *hwsp:59, ring:328 }
<0> [241.367968] kworker/-12 3..... 176653371us : __engine_park: 0000:03:00.0 rcs0: parked
<0> [241.368561] kworker/-12 3..... 176653534us : __engine_unpark: 0000:03:00.0 bcs0:
<0> [241.369151] kworker/-12 3..... 176653556us : __engine_unpark: 0000:03:00.0 bcs0: context:6 reset { seqno:33, *hwsp:33, ring:e78 }
<0> [241.369845] kworker/-12 3..... 176653573us : __engine_park: 0000:03:00.0 bcs0: parked
<0> [241.370433] kworker/-12 3..... 176653593us : __engine_unpark: 0000:03:00.0 vcs0:
<0> [241.371018] kworker/-12 3..... 176653614us : __engine_unpark: 0000:03:00.0 vcs0: context:7 reset { seqno:18, *hwsp:18, ring:6d0 }
<0> [241.371708] kworker/-12 3..... 176653629us : __engine_park: 0000:03:00.0 vcs0: parked
<0> [241.372295] kworker/-12 3..... 176653648us : __engine_unpark: 0000:03:00.0 vcs1:
<0> [241.372875] kworker/-12 3..... 176653669us : __engine_unpark: 0000:03:00.0 vcs1: context:8 reset { seqno:18, *hwsp:18, ring:6d0 }
<0> [241.373555] kworker/-12 3..... 176653684us : __engine_park: 0000:03:00.0 vcs1: parked
<0> [241.374141] kworker/-12 3..... 176653701us : __engine_unpark: 0000:03:00.0 vecs0:
<0> [241.374726] kworker/-12 3..... 176653723us : __engine_unpark: 0000:03:00.0 vecs0: context:9 reset { seqno:18, *hwsp:18, ring:6d0 }
<0> [241.375402] kworker/-12 3..... 176653736us : __engine_park: 0000:03:00.0 vecs0: parked
<0> [241.375979] kworker/-12 3..... 176653754us : __engine_unpark: 0000:03:00.0 vecs1:
<0> [241.376556] kworker/-12 3..... 176653775us : __engine_unpark: 0000:03:00.0 vecs1: context:a reset { seqno:18, *hwsp:18, ring:6d0 }
<0> [241.377226] kworker/-12 3..... 176653789us : __engine_park: 0000:03:00.0 vecs1: parked
<0> [241.377798] kworker/-12 3..... 176653807us : __engine_unpark: 0000:03:00.0 ccs0:
<0> [241.378369] kworker/-12 3..... 176653844us : __engine_unpark: 0000:03:00.0 ccs0: context:b reset { seqno:19, *hwsp:19, ring:4a8 }
<0> [241.379051] kworker/-12 3..... 176653878us : __engine_park: 0000:03:00.0 ccs0: parked
<0> [241.379628] kworker/-12 3..... 176654071us : __gt_park: 0000:03:00.0
<0> [241.380195] kworker/-12 3..... 176654495us : __engine_unpark: 0000:03:00.0 bcs0:
<0> [241.380858] kworker/-12 3..... 176654543us : __gt_unpark: 0000:03:00.0
<0> [241.381424] kworker/-12 3..... 176655842us : __engine_unpark: 0000:03:00.0 bcs0: context:6 reset { seqno:33, *hwsp:33, ring:e78 }
<0> [241.382012] kworker/-12 3..... 176656007us : __i915_request_commit: 0000:03:00.0 bcs0: fence 13:162, current 161
<0> [241.382691] kworker/-12 3D..1. 176656024us : __i915_request_submit: 0000:03:00.0 bcs0: fence 13:162, current 161
<0> [241.383272] kworker/-12 3..... 176656578us : __i915_request_commit: 0000:03:00.0 bcs0: fence 13:163, current 162
<0> [241.383850] kworker/-12 3D..1. 176656584us : __i915_request_submit: 0000:03:00.0 bcs0: fence 13:163, current 162
<0> [241.384523] kworker/-266 0..... 176656774us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 13:162, current 163
<0> [241.385098] kworker/-266 0..... 176656783us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 13:163, current 163
<0> [241.385655] kworker/-266 0..... 176656790us : __engine_park: 0000:03:00.0 bcs0: parked
<0> [241.386309] kworker/-266 0..... 176656818us : __gt_park: 0000:03:00.0
<0> [241.386856] kworker/-12 3..... 176656880us : __engine_unpark: 0000:03:00.0 bcs0:
<0> [241.387404] kworker/-12 3..... 176656891us : __gt_unpark: 0000:03:00.0
<0> [241.388043] kworker/-12 3..... 176656943us : __engine_unpark: 0000:03:00.0 bcs0: context:6 reset { seqno:33, *hwsp:33, ring:e78 }
<0> [241.388612] kworker/-12 3..... 176656966us : __i915_request_commit: 0000:03:00.0 bcs0: fence 13:164, current 163
<0> [241.389182] kworker/-12 3D..1. 176656971us : __i915_request_submit: 0000:03:00.0 bcs0: fence 13:164, current 163
<0> [241.389841] kworker/-266 0..... 176657167us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 13:164, current 164
<0> [241.390392] kworker/-266 0..... 176657174us : __engine_park: 0000:03:00.0 bcs0: parked
<0> [241.390946] kworker/-266 0..... 176657200us : __gt_park: 0000:03:00.0
<0> [241.391597] kworker/-12 3..... 176657216us : __engine_unpark: 0000:03:00.0 bcs0:
<0> [241.392140] kworker/-12 3..... 176657226us : __gt_unpark: 0000:03:00.0
<0> [241.392680] kworker/-12 3..... 176657279us : __engine_unpark: 0000:03:00.0 bcs0: context:6 reset { seqno:33, *hwsp:33, ring:e78 }
<0> [241.393339] kworker/-12 3..... 176657303us : __i915_request_commit: 0000:03:00.0 bcs0: fence 13:165, current 164
<0> [241.393907] kworker/-12 3D..1. 176657308us : __i915_request_submit: 0000:03:00.0 bcs0: fence 13:165, current 164
<0> [241.394476] kworker/-266 0..... 176657496us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 13:165, current 165
<0> [241.395136] kworker/-266 0..... 176657505us : __engine_park: 0000:03:00.0 bcs0: parked
<0> [241.395707] kworker/-266 0..... 176657531us : __gt_park: 0000:03:00.0
<0> [241.396279] kworker/-12 3..... 176657540us : __engine_unpark: 0000:03:00.0 bcs0:
<0> [241.396956] kworker/-12 3..... 176657552us : __gt_unpark: 0000:03:00.0
<0> [241.397534] kworker/-12 3..... 176657607us : __engine_unpark: 0000:03:00.0 bcs0: context:6 reset { seqno:33, *hwsp:33, ring:e78 }
<0> [241.398138] kworker/-12 3..... 176657631us : __i915_request_commit: 0000:03:00.0 bcs0: fence 13:166, current 165
<0> [241.398839] kworker/-12 3D..1. 176657636us : __i915_request_submit: 0000:03:00.0 bcs0: fence 13:166, current 165
<0> [241.399441] kworker/-266 0..... 176657825us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 13:166, current 166
<0> [241.400038] kworker/-266 0..... 176657833us : __engine_park: 0000:03:00.0 bcs0: parked
<0> [241.400730] kworker/-266 0..... 176657858us : __gt_park: 0000:03:00.0
<0> [241.401326] kworker/-12 3..... 176657909us : __engine_unpark: 0000:03:00.0 bcs0:
<0> [241.401924] kworker/-12 3..... 176657921us : __gt_unpark: 0000:03:00.0
<0> [241.402632] kworker/-12 3..... 176657974us : __engine_unpark: 0000:03:00.0 bcs0: context:6 reset { seqno:33, *hwsp:33, ring:e78 }
<0> [241.403262] kworker/-12 3..... 176657998us : __i915_request_commit: 0000:03:00.0 bcs0: fence 13:167, current 166
<0> [241.403899] kworker/-12 3D..1. 176658004us : __i915_request_submit: 0000:03:00.0 bcs0: fence 13:167, current 166
<0> [241.404634] kworker/-266 0..... 176658194us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 13:167, current 167
<0> [241.405270] kworker/-266 0..... 176658201us : __engine_park: 0000:03:00.0 bcs0: parked
<0> [241.405910] kworker/-266 0..... 176658224us : __gt_park: 0000:03:00.0
<0> [241.406647] kworker/-12 3..... 176658271us : __engine_unpark: 0000:03:00.0 bcs0:
<0> [241.407285] kworker/-12 3..... 176658281us : __gt_unpark: 0000:03:00.0
<0> [241.407919] kworker/-12 3..... 176658335us : __engine_unpark: 0000:03:00.0 bcs0: context:6 reset { seqno:33, *hwsp:33, ring:e78 }
<0> [241.408670] kworker/-12 3..... 176658360us : __i915_request_commit: 0000:03:00.0 bcs0: fence 13:168, current 167
<0> [241.409327] kworker/-12 3D..1. 176658366us : __i915_request_submit: 0000:03:00.0 bcs0: fence 13:168, current 167
<0> [241.409982] kworker/-266 0..... 176658555us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 13:168, current 168
<0> [241.410722] kworker/-266 0..... 176658565us : __engine_park: 0000:03:00.0 bcs0: parked
<0> [241.411366] kworker/-266 0..... 176658591us : __gt_park: 0000:03:00.0
<0> [241.412008] kworker/-12 3..... 176658630us : __engine_unpark: 0000:03:00.0 bcs0:
<0> [241.412754] kworker/-12 3..... 176658641us : __gt_unpark: 0000:03:00.0
<0> [241.413389] kworker/-12 3..... 176658695us : __engine_unpark: 0000:03:00.0 bcs0: context:6 reset { seqno:33, *hwsp:33, ring:e78 }
<0> [241.414052] kworker/-12 3..... 176658758us : __i915_request_commit: 0000:03:00.0 bcs0: fence 13:169, current 168
<0> [241.414809] kworker/-12 3D..1. 176658763us : __i915_request_submit: 0000:03:00.0 bcs0: fence 13:169, current 168
<0> [241.415469] kworker/-266 0..... 176659420us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 13:169, current 169
<0> [241.416120] kworker/-266 0..... 176659430us : __engine_park: 0000:03:00.0 bcs0: parked
<0> [241.416879] kworker/-266 0..... 176659468us : __gt_park: 0000:03:00.0
<0> [241.417524] kworker/-12 3..... 176659493us : __engine_unpark: 0000:03:00.0 bcs0:
<0> [241.418174] kworker/-12 3..... 176659504us : __gt_unpark: 0000:03:00.0
<0> [241.418915] kworker/-12 3..... 176659558us : __engine_unpark: 0000:03:00.0 bcs0: context:6 reset { seqno:33, *hwsp:33, ring:e78 }
<0> [241.419582] kworker/-12 3..... 176659653us : __i915_request_commit: 0000:03:00.0 bcs0: fence 13:170, current 169
<0> [241.420253] kworker/-12 3D..1. 176659659us : __i915_request_submit: 0000:03:00.0 bcs0: fence 13:170, current 169
<0> [241.421015] kworker/-266 0..... 176659854us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 13:170, current 170
<0> [241.421674] kworker/-266 0..... 176659863us : __engine_park: 0000:03:00.0 bcs0: parked
<0> [241.422331] kworker/-266 0..... 176659889us : __gt_park: 0000:03:00.0
<0> [241.423082] kworker/-12 3..... 176659938us : __engine_unpark: 0000:03:00.0 bcs0:
<0> [241.423740] kworker/-12 3..... 176659949us : __gt_unpark: 0000:03:00.0
<0> [241.424387] kworker/-12 3..... 176660005us : __engine_unpark: 0000:03:00.0 bcs0: context:6 reset { seqno:33, *hwsp:33, ring:e78 }
<0> [241.425151] kworker/-12 3..... 176660029us : __i915_request_commit: 0000:03:00.0 bcs0: fence 13:171, current 170
<0> [241.425826] kworker/-12 3D..1. 176660034us : __i915_request_submit: 0000:03:00.0 bcs0: fence 13:171, current 170
<0> [241.426502] kworker/-266 0..... 176660221us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 13:171, current 171
<0> [241.427273] kworker/-266 0..... 176660230us : __engine_park: 0000:03:00.0 bcs0: parked
<0> [241.427939] kworker/-266 0..... 176660256us : __gt_park: 0000:03:00.0
<0> [241.428606] kworker/-12 3..... 176660326us : __engine_unpark: 0000:03:00.0 bcs0:
<0> [241.429373] kworker/-12 3..... 176660336us : __gt_unpark: 0000:03:00.0
<0> [241.430038] kworker/-12 3..... 176660389us : __engine_unpark: 0000:03:00.0 bcs0: context:6 reset { seqno:33, *hwsp:33, ring:e78 }
<0> [241.430729] kworker/-12 3..... 176660414us : __i915_request_commit: 0000:03:00.0 bcs0: fence 13:172, current 171
<0> [241.431522] kworker/-12 3D..1. 176660420us : __i915_request_submit: 0000:03:00.0 bcs0: fence 13:172, current 171
<0> [241.432206] kworker/-266 0..... 176660605us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 13:172, current 172
<0> [241.432879] kworker/-266 0..... 176660613us : __engine_park: 0000:03:00.0 bcs0: parked
<0> [241.433654] kworker/-266 0..... 176660639us : __gt_park: 0000:03:00.0
<0> [241.434322] kworker/-12 3..... 176660681us : __engine_unpark: 0000:03:00.0 bcs0:
<0> [241.434992] kworker/-12 3..... 176660692us : __gt_unpark: 0000:03:00.0
<0> [241.435766] kworker/-12 3..... 176660745us : __engine_unpark: 0000:03:00.0 bcs0: context:6 reset { seqno:33, *hwsp:33, ring:e78 }
<0> [241.436456] kworker/-12 3..... 176660770us : __i915_request_commit: 0000:03:00.0 bcs0: fence 13:173, current 172
<0> [241.437148] kworker/-12 3D..1. 176660775us : __i915_request_submit: 0000:03:00.0 bcs0: fence 13:173, current 172
<0> [241.437929] kworker/-266 0..... 176660973us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 13:173, current 173
<0> [241.438603] kworker/-266 0..... 176660982us : __engine_park: 0000:03:00.0 bcs0: parked
<0> [241.439280] kworker/-266 0..... 176661007us : __gt_park: 0000:03:00.0
<0> [241.440049] kworker/-12 3..... 176661038us : __engine_unpark: 0000:03:00.0 bcs0:
<0> [241.440719] kworker/-12 3..... 176661049us : __gt_unpark: 0000:03:00.0
<0> [241.441383] kworker/-12 3..... 176661102us : __engine_unpark: 0000:03:00.0 bcs0: context:6 reset { seqno:33, *hwsp:33, ring:e78 }
<0> [241.442164] kworker/-12 3..... 176661156us : __i915_request_commit: 0000:03:00.0 bcs0: fence 13:174, current 173
<0> [241.442858] kworker/-12 3D..1. 176661161us : __i915_request_submit: 0000:03:00.0 bcs0: fence 13:174, current 173
<0> [241.443542] kworker/-266 0..... 176662282us : i915_request_retire.part.0: 0000:03:00.0 bcs0: fence 13:174, current 174
<0> [241.444314] kworker/-266 0..... 176662293us : __engine_park: 0000:03:00.0 bcs0: parked
<0> [241.444989] kworker/-266 0..... 176662319us : __gt_park: 0000:03:00.0
<0> [241.445660] kworker/-2146 5..... 178309172us : intel_gt_runtime_suspend: 0000:03:00.0
<0> [241.446427] i915_pm_-2133 0..... 178480670us : intel_gt_runtime_resume: 0000:03:00.0
<0> [241.447097] i915_pm_-2133 0..... 178484314us : __gt_unpark: 0000:03:00.0
<0> [241.447759] i915_pm_-2133 0.l... 178485269us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:185 active
<0> [241.448536] i915_pm_-2133 0.l... 178485471us : intel_timeline_pin: 0000:03:00.0 timeline:185 using HWSP offset:fede3000
<0> [241.449208] i915_pm_-2133 0.l... 178485619us : __engine_unpark: 0000:03:00.0 rcs0:
<0> [241.449874] i915_pm_-2133 0.l... 178485655us : __engine_unpark: 0000:03:00.0 rcs0: context:5 reset { seqno:59, *hwsp:59, ring:328 }
<0> [241.450646] i915_pm_-2133 0.l... 178485656us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:185 pin ring:{start:01500000, head:0000, tail:0000}
<0> [241.451339] i915_pm_-2133 0.l... 178486695us : __i915_request_commit: 0000:03:00.0 rcs0: fence 185:2, current 0
<0> [241.452029] i915_pm_-2133 0Dl.1. 178486701us : __i915_request_submit: 0000:03:00.0 rcs0: fence 185:2, current 0
<0> [241.452810] kworker/-111 0..... 178745225us : __i915_request_commit: 0000:03:00.0 rcs0: fence 5:90, current 89
<0> [241.453497] kworker/-111 0D..1. 178745247us : __i915_request_submit: 0000:03:00.0 rcs0: fence 5:90, current 89
<0> [241.454181] kworker/-266 0..... 179833433us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 185:2, current 2
<0> [241.454962] kworker/-266 0..... 179833501us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 5:90, current 90
<0> [241.455626] kworker/-121 0..... 179868796us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:185 unpin
<0> [241.456297] kworker/-121 0..... 179869537us : __intel_context_retire: 0000:03:00.0 rcs0: context:185 retire runtime: { total:54964ns, avg:54964ns }
<0> [241.457068] kworker/-266 0..... 179869573us : __engine_park: 0000:03:00.0 rcs0: parked
<0> [241.457742] kworker/-266 0..... 179869608us : __gt_park: 0000:03:00.0
<0> [241.458413] kworker/-121 0..... 179981044us : intel_gt_runtime_suspend: 0000:03:00.0
<0> [241.459196] i915_pm_-2133 1..... 180150192us : intel_gt_runtime_resume: 0000:03:00.0
<0> [241.459871] i915_pm_-2133 1..... 180151917us : __gt_unpark: 0000:03:00.0
<0> [241.460535] i915_pm_-2133 1..... 180152129us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:185 active
<0> [241.461301] i915_pm_-2133 1..... 180152134us : intel_timeline_pin: 0000:03:00.0 timeline:185 using HWSP offset:fede3000
<0> [241.461977] i915_pm_-2133 1..... 180152151us : __engine_unpark: 0000:03:00.0 rcs0:
<0> [241.462645] i915_pm_-2133 1..... 180152188us : __engine_unpark: 0000:03:00.0 rcs0: context:5 reset { seqno:5a, *hwsp:5a, ring:3b8 }
<0> [241.463416] i915_pm_-2133 1..... 180152189us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:185 pin ring:{start:01500000, head:00d8, tail:00d8}
<0> [241.464109] i915_pm_-2133 1..... 180152234us : __i915_request_commit: 0000:03:00.0 rcs0: fence 185:4, current 2
<0> [241.464803] i915_pm_-2133 1D..1. 180152240us : __i915_request_submit: 0000:03:00.0 rcs0: fence 185:4, current 2
<0> [241.465587] kworker/-81 1..... 180409299us : __i915_request_commit: 0000:03:00.0 rcs0: fence 5:91, current 90
<0> [241.466273] kworker/-81 1D..1. 180409305us : __i915_request_submit: 0000:03:00.0 rcs0: fence 5:91, current 90
<0> [241.466953] kworker/-211 2..... 181817472us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 185:4, current 4
<0> [241.467738] kworker/-211 2..... 181817536us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 5:91, current 91
<0> [241.468404] kworker/-121 4..... 181853035us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:185 unpin
<0> [241.469072] kworker/-121 4..... 181853867us : __intel_context_retire: 0000:03:00.0 rcs0: context:185 retire runtime: { total:109304ns, avg:54860ns }
<0> [241.469839] kworker/-210 4..... 181853929us : __engine_park: 0000:03:00.0 rcs0: parked
<0> [241.470517] kworker/-210 4..... 181853984us : __gt_park: 0000:03:00.0
<0> [241.471193] kworker/-121 4..... 181964868us : intel_gt_runtime_suspend: 0000:03:00.0
<0> [241.471968] i915_pm_-2133 1..... 182117780us : intel_gt_runtime_resume: 0000:03:00.0
<0> [241.472637] i915_pm_-2133 1..... 182119557us : __gt_unpark: 0000:03:00.0
<0> [241.473304] i915_pm_-2133 1..... 182119756us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:185 active
<0> [241.474072] i915_pm_-2133 1..... 182119761us : intel_timeline_pin: 0000:03:00.0 timeline:185 using HWSP offset:fede3000
<0> [241.474743] i915_pm_-2133 1..... 182119778us : __engine_unpark: 0000:03:00.0 rcs0:
<0> [241.475415] i915_pm_-2133 1..... 182119815us : __engine_unpark: 0000:03:00.0 rcs0: context:5 reset { seqno:5b, *hwsp:5b, ring:448 }
<0> [241.476188] i915_pm_-2133 1..... 182119816us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:185 pin ring:{start:01500000, head:01b0, tail:01b0}
<0> [241.476889] i915_pm_-2133 1..... 182119858us : __i915_request_commit: 0000:03:00.0 rcs0: fence 185:6, current 4
<0> [241.477581] i915_pm_-2133 1D..1. 182119863us : __i915_request_submit: 0000:03:00.0 rcs0: fence 185:6, current 4
<0> [241.478363] kworker/-81 1..... 182377126us : __i915_request_commit: 0000:03:00.0 rcs0: fence 5:92, current 91
<0> [241.479054] kworker/-81 1D..1. 182377131us : __i915_request_submit: 0000:03:00.0 rcs0: fence 5:92, current 91
<0> [241.479737] kworker/-210 4..... 183801700us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 185:6, current 6
<0> [241.480520] kworker/-210 4..... 183801775us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 5:92, current 92
<0> [241.481187] kworker/-121 3..... 183836888us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:185 unpin
<0> [241.481858] kworker/-121 3..... 183837740us : __intel_context_retire: 0000:03:00.0 rcs0: context:185 retire runtime: { total:163488ns, avg:54756ns }
<0> [241.482631] kworker/-526 3..... 183837807us : __engine_park: 0000:03:00.0 rcs0: parked
<0> [241.483309] kworker/-526 3..... 183837866us : __gt_park: 0000:03:00.0
<0> [241.483981] kworker/-121 3..... 183949029us : intel_gt_runtime_suspend: 0000:03:00.0
<0> [241.484759] i915_pm_-2133 0..... 184084400us : intel_gt_runtime_resume: 0000:03:00.0
<0> [241.485433] i915_pm_-2133 0..... 184086204us : __gt_unpark: 0000:03:00.0
<0> [241.486098] i915_pm_-2133 0..... 184086434us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:185 active
<0> [241.486882] i915_pm_-2133 0..... 184086439us : intel_timeline_pin: 0000:03:00.0 timeline:185 using HWSP offset:fede3000
<0> [241.487561] i915_pm_-2133 0..... 184086455us : __engine_unpark: 0000:03:00.0 rcs0:
<0> [241.488241] i915_pm_-2133 0..... 184086491us : __engine_unpark: 0000:03:00.0 rcs0: context:5 reset { seqno:5c, *hwsp:5c, ring:4d8 }
<0> [241.489013] i915_pm_-2133 0..... 184086492us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:185 pin ring:{start:01500000, head:0288, tail:0288}
<0> [241.489709] i915_pm_-2133 0..... 184086549us : __i915_request_commit: 0000:03:00.0 rcs0: fence 185:8, current 6
<0> [241.490406] i915_pm_-2133 0D..1. 184086555us : __i915_request_submit: 0000:03:00.0 rcs0: fence 185:8, current 6
<0> [241.491193] kworker/-111 0..... 184345104us : __i915_request_commit: 0000:03:00.0 rcs0: fence 5:93, current 92
<0> [241.491881] kworker/-111 0D..1. 184345109us : __i915_request_submit: 0000:03:00.0 rcs0: fence 5:93, current 92
<0> [241.492564] kworker/-848 1..... 185849416us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 185:8, current 8
<0> [241.493351] kworker/-848 1..... 185849485us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 5:93, current 93
<0> [241.494024] kworker/-2152 5..... 185884897us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:185 unpin
<0> [241.494701] kworker/-2152 5..... 185885762us : __intel_context_retire: 0000:03:00.0 rcs0: context:185 retire runtime: { total:217880ns, avg:54704ns }
<0> [241.495483] kworker/-78 5..... 185885837us : __engine_park: 0000:03:00.0 rcs0: parked
<0> [241.496168] kworker/-78 5..... 185885892us : __gt_park: 0000:03:00.0
<0> [241.496846] kworker/-2152 5..... 185996495us : intel_gt_runtime_suspend: 0000:03:00.0
<0> [241.497631] i915_pm_-2133 0..... 186151378us : intel_gt_runtime_resume: 0000:03:00.0
<0> [241.498306] i915_pm_-2133 0..... 186153106us : __gt_unpark: 0000:03:00.0
<0> [241.498969] i915_pm_-2133 0..... 186153313us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:185 active
<0> [241.499743] i915_pm_-2133 0..... 186153318us : intel_timeline_pin: 0000:03:00.0 timeline:185 using HWSP offset:fede3000
<0> [241.500420] i915_pm_-2133 0..... 186153336us : __engine_unpark: 0000:03:00.0 rcs0:
<0> [241.501100] i915_pm_-2133 0..... 186153373us : __engine_unpark: 0000:03:00.0 rcs0: context:5 reset { seqno:5d, *hwsp:5d, ring:568 }
<0> [241.501879] i915_pm_-2133 0..... 186153375us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:185 pin ring:{start:01500000, head:0360, tail:0360}
<0> [241.502585] i915_pm_-2133 0..... 186153418us : __i915_request_commit: 0000:03:00.0 rcs0: fence 185:10, current 8
<0> [241.503286] i915_pm_-2133 0D..1. 186153424us : __i915_request_submit: 0000:03:00.0 rcs0: fence 185:10, current 8
<0> [241.504076] kworker/-111 0..... 186409087us : __i915_request_commit: 0000:03:00.0 rcs0: fence 5:94, current 93
<0> [241.504761] kworker/-111 0D..1. 186409093us : __i915_request_submit: 0000:03:00.0 rcs0: fence 5:94, current 93
<0> [241.505442] kworker/-211 2..... 187833851us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 185:10, current 10
<0> [241.506224] kworker/-211 2..... 187833921us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 5:94, current 94
<0> [241.506896] kworker/-121 1..... 187868987us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:185 unpin
<0> [241.507574] kworker/-121 1.l... 187869840us : __intel_context_retire: 0000:03:00.0 rcs0: context:185 retire runtime: { total:272116ns, avg:54652ns }
<0> [241.508354] kworker/-848 1..... 187869898us : __engine_park: 0000:03:00.0 rcs0: parked
<0> [241.509038] kworker/-848 1..... 187869952us : __gt_park: 0000:03:00.0
<0> [241.509717] kworker/-121 1..... 187980445us : intel_gt_runtime_suspend: 0000:03:00.0
<0> [241.510490] i915_pm_-2133 0..... 188117667us : intel_gt_runtime_resume: 0000:03:00.0
<0> [241.511164] i915_pm_-2133 0..... 188119436us : __gt_unpark: 0000:03:00.0
<0> [241.511827] i915_pm_-2133 0..... 188119635us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:185 active
<0> [241.512606] i915_pm_-2133 0..... 188119640us : intel_timeline_pin: 0000:03:00.0 timeline:185 using HWSP offset:fede3000
<0> [241.513285] i915_pm_-2133 0..... 188119657us : __engine_unpark: 0000:03:00.0 rcs0:
<0> [241.513965] i915_pm_-2133 0..... 188119693us : __engine_unpark: 0000:03:00.0 rcs0: context:5 reset { seqno:5e, *hwsp:5e, ring:5f8 }
<0> [241.514740] i915_pm_-2133 0..... 188119695us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:185 pin ring:{start:01500000, head:0438, tail:0438}
<0> [241.515446] i915_pm_-2133 0..... 188119737us : __i915_request_commit: 0000:03:00.0 rcs0: fence 185:12, current 10
<0> [241.516148] i915_pm_-2133 0D..1. 188119742us : __i915_request_submit: 0000:03:00.0 rcs0: fence 185:12, current 10
<0> [241.516942] kworker/-111 0..... 188374424us : __i915_request_commit: 0000:03:00.0 rcs0: fence 5:95, current 94
<0> [241.517627] kworker/-111 0D..1. 188374430us : __i915_request_submit: 0000:03:00.0 rcs0: fence 5:95, current 94
<0> [241.518309] kworker/-210 4..... 189777036us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 185:12, current 12
<0> [241.519103] kworker/-210 4..... 189777110us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 5:95, current 95
<0> [241.519777] kworker/-2152 5..... 189811628us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:185 unpin
<0> [241.520454] kworker/-2152 5..... 189812480us : __intel_context_retire: 0000:03:00.0 rcs0: context:185 retire runtime: { total:326560ns, avg:54600ns }
<0> [241.521234] kworker/-78 5..... 189812553us : __engine_park: 0000:03:00.0 rcs0: parked
<0> [241.521917] kworker/-78 5..... 189812609us : __gt_park: 0000:03:00.0
<0> [241.522594] kworker/-2152 5..... 189920572us : intel_gt_runtime_suspend: 0000:03:00.0
<0> [241.523377] i915_pm_-2133 1..... 190035914us : intel_gt_runtime_resume: 0000:03:00.0
<0> [241.524048] i915_pm_-2133 1..... 190037704us : __gt_unpark: 0000:03:00.0
<0> [241.524711] i915_pm_-2133 1..... 190037907us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:185 active
<0> [241.525484] i915_pm_-2133 1..... 190037912us : intel_timeline_pin: 0000:03:00.0 timeline:185 using HWSP offset:fede3000
<0> [241.526162] i915_pm_-2133 1..... 190037930us : __engine_unpark: 0000:03:00.0 rcs0:
<0> [241.526840] i915_pm_-2133 1..... 190037966us : __engine_unpark: 0000:03:00.0 rcs0: context:5 reset { seqno:5f, *hwsp:5f, ring:688 }
<0> [241.527598] i915_pm_-2133 1..... 190037967us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:185 pin ring:{start:01500000, head:0510, tail:0510}
<0> [241.528304] i915_pm_-2133 1..... 190038010us : __i915_request_commit: 0000:03:00.0 rcs0: fence 185:14, current 12
<0> [241.529004] i915_pm_-2133 1D..1. 190038016us : __i915_request_submit: 0000:03:00.0 rcs0: fence 185:14, current 12
<0> [241.529793] kworker/-81 1..... 190284298us : __i915_request_commit: 0000:03:00.0 rcs0: fence 5:96, current 95
<0> [241.530477] kworker/-81 1D..1. 190284303us : __i915_request_submit: 0000:03:00.0 rcs0: fence 5:96, current 95
<0> [241.531157] kworker/-848 1..... 191718883us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 185:14, current 14
<0> [241.531942] kworker/-848 1..... 191718957us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 5:96, current 96
<0> [241.532613] kworker/-121 2..... 191753821us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:185 unpin
<0> [241.533286] kworker/-121 2..... 191754694us : __intel_context_retire: 0000:03:00.0 rcs0: context:185 retire runtime: { total:380796ns, avg:54548ns }
<0> [241.534066] kworker/-211 2..... 191754764us : __engine_park: 0000:03:00.0 rcs0: parked
<0> [241.534747] kworker/-211 2..... 191754821us : __gt_park: 0000:03:00.0
<0> [241.535422] kworker/-121 2..... 191863818us : intel_gt_runtime_suspend: 0000:03:00.0
<0> [241.536191] i915_pm_-2133 1..... 191974002us : intel_gt_runtime_resume: 0000:03:00.0
<0> [241.536862] i915_pm_-2133 1.l... 191976320us : __gt_unpark: 0000:03:00.0
<0> [241.537523] i915_pm_-2133 1.l... 191976515us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:185 active
<0> [241.538303] i915_pm_-2133 1.l... 191976520us : intel_timeline_pin: 0000:03:00.0 timeline:185 using HWSP offset:fede3000
<0> [241.538979] i915_pm_-2133 1.l... 191976535us : __engine_unpark: 0000:03:00.0 rcs0:
<0> [241.539656] i915_pm_-2133 1.l... 191976572us : __engine_unpark: 0000:03:00.0 rcs0: context:5 reset { seqno:60, *hwsp:60, ring:718 }
<0> [241.540425] i915_pm_-2133 1.l... 191976573us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:185 pin ring:{start:01500000, head:05e8, tail:05e8}
<0> [241.541128] i915_pm_-2133 1.l... 191976614us : __i915_request_commit: 0000:03:00.0 rcs0: fence 185:16, current 14
<0> [241.541828] i915_pm_-2133 1Dl.1. 191976620us : __i915_request_submit: 0000:03:00.0 rcs0: fence 185:16, current 14
<0> [241.542614] kworker/-81 1..... 192228924us : __i915_request_commit: 0000:03:00.0 rcs0: fence 5:97, current 96
<0> [241.543297] kworker/-81 1D..1. 192228929us : __i915_request_submit: 0000:03:00.0 rcs0: fence 5:97, current 96
<0> [241.543978] kworker/-210 4..... 193733172us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 185:16, current 16
<0> [241.544772] kworker/-210 4..... 193733249us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 5:97, current 97
<0> [241.545443] kworker/-121 3..... 193768146us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:185 unpin
<0> [241.546118] kworker/-121 3..... 193769009us : __intel_context_retire: 0000:03:00.0 rcs0: context:185 retire runtime: { total:435448ns, avg:54600ns }
<0> [241.546891] kworker/-526 3..... 193769077us : __engine_park: 0000:03:00.0 rcs0: parked
<0> [241.547575] kworker/-526 3..... 193769140us : __gt_park: 0000:03:00.0
<0> [241.548251] kworker/-121 3..... 193878567us : intel_gt_runtime_suspend: 0000:03:00.0
<0> [241.549023] i915_pm_-2133 1..... 194009151us : intel_gt_runtime_resume: 0000:03:00.0
<0> [241.549696] i915_pm_-2133 1..... 194010875us : __gt_unpark: 0000:03:00.0
<0> [241.550360] i915_pm_-2133 1..... 194011080us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:185 active
<0> [241.551132] i915_pm_-2133 1..... 194011084us : intel_timeline_pin: 0000:03:00.0 timeline:185 using HWSP offset:fede3000
<0> [241.551812] i915_pm_-2133 1..... 194011102us : __engine_unpark: 0000:03:00.0 rcs0:
<0> [241.552492] i915_pm_-2133 1..... 194011138us : __engine_unpark: 0000:03:00.0 rcs0: context:5 reset { seqno:61, *hwsp:61, ring:7a8 }
<0> [241.553282] i915_pm_-2133 1..... 194011139us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:185 pin ring:{start:01500000, head:06c0, tail:06c0}
<0> [241.553989] i915_pm_-2133 1..... 194011183us : __i915_request_commit: 0000:03:00.0 rcs0: fence 185:18, current 16
<0> [241.554691] i915_pm_-2133 1D..1. 194011189us : __i915_request_submit: 0000:03:00.0 rcs0: fence 185:18, current 16
<0> [241.555481] kworker/-81 1..... 194261274us : __i915_request_commit: 0000:03:00.0 rcs0: fence 5:98, current 97
<0> [241.556165] kworker/-81 1D..1. 194261279us : __i915_request_submit: 0000:03:00.0 rcs0: fence 5:98, current 97
<0> [241.556848] kworker/-848 1..... 195691983us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 185:18, current 18
<0> [241.557631] kworker/-848 1..... 195692059us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 5:98, current 98
<0> [241.558302] kworker/-2146 2..... 195727159us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:185 unpin
<0> [241.558979] kworker/-2146 2..... 195728041us : __intel_context_retire: 0000:03:00.0 rcs0: context:185 retire runtime: { total:490516ns, avg:54652ns }
<0> [241.559758] kworker/-211 2..... 195728113us : __engine_park: 0000:03:00.0 rcs0: parked
<0> [241.560440] kworker/-211 2..... 195728171us : __gt_park: 0000:03:00.0
<0> [241.561115] kworker/-2146 2..... 195837948us : intel_gt_runtime_suspend: 0000:03:00.0
<0> [241.561890] i915_pm_-2133 0..... 195949337us : intel_gt_runtime_resume: 0000:03:00.0
<0> [241.562561] i915_pm_-2133 0..... 195951314us : __gt_unpark: 0000:03:00.0
<0> [241.563222] i915_pm_-2133 0..... 195951505us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:185 active
<0> [241.563997] i915_pm_-2133 0..... 195951509us : intel_timeline_pin: 0000:03:00.0 timeline:185 using HWSP offset:fede3000
<0> [241.564673] i915_pm_-2133 0..... 195951525us : __engine_unpark: 0000:03:00.0 rcs0:
<0> [241.565351] i915_pm_-2133 0..... 195951561us : __engine_unpark: 0000:03:00.0 rcs0: context:5 reset { seqno:62, *hwsp:62, ring:838 }
<0> [241.566124] i915_pm_-2133 0..... 195951562us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:185 pin ring:{start:01500000, head:0798, tail:0798}
<0> [241.566829] i915_pm_-2133 0..... 195951603us : __i915_request_commit: 0000:03:00.0 rcs0: fence 185:20, current 18
<0> [241.567528] i915_pm_-2133 0D..1. 195951609us : __i915_request_submit: 0000:03:00.0 rcs0: fence 185:20, current 18
<0> [241.568312] kworker/-111 0..... 196205891us : __i915_request_commit: 0000:03:00.0 rcs0: fence 5:99, current 98
<0> [241.568996] kworker/-111 0D..1. 196205896us : __i915_request_submit: 0000:03:00.0 rcs0: fence 5:99, current 98
<0> [241.569677] kworker/-526 3..... 197656386us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 185:20, current 20
<0> [241.570463] kworker/-526 3..... 197656460us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 5:99, current 99
<0> [241.571135] kworker/-2146 2..... 197691636us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:185 unpin
<0> [241.571810] kworker/-2146 2..... 197692491us : __intel_context_retire: 0000:03:00.0 rcs0: context:185 retire runtime: { total:553436ns, avg:55640ns }
<0> [241.572570] kworker/-211 2..... 197692552us : __engine_park: 0000:03:00.0 rcs0: parked
<0> [241.573251] kworker/-211 2..... 197692611us : __gt_park: 0000:03:00.0
<0> [241.573928] kworker/-2146 2..... 197802521us : intel_gt_runtime_suspend: 0000:03:00.0
<0> [241.574701] i915_pm_-2133 1..... 197915174us : intel_gt_runtime_resume: 0000:03:00.0
<0> [241.575373] i915_pm_-2133 1..... 197916934us : __gt_unpark: 0000:03:00.0
<0> [241.576038] i915_pm_-2133 1..... 197917155us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:185 active
<0> [241.576812] i915_pm_-2133 1..... 197917160us : intel_timeline_pin: 0000:03:00.0 timeline:185 using HWSP offset:fede3000
<0> [241.577491] i915_pm_-2133 1..... 197917175us : __engine_unpark: 0000:03:00.0 rcs0:
<0> [241.578170] i915_pm_-2133 1..... 197917211us : __engine_unpark: 0000:03:00.0 rcs0: context:5 reset { seqno:63, *hwsp:63, ring:8c8 }
<0> [241.578952] i915_pm_-2133 1..... 197917212us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:185 pin ring:{start:01500000, head:0870, tail:0870}
<0> [241.579658] i915_pm_-2133 1..... 197917253us : __i915_request_commit: 0000:03:00.0 rcs0: fence 185:22, current 20
<0> [241.580358] i915_pm_-2133 1D..1. 197917259us : __i915_request_submit: 0000:03:00.0 rcs0: fence 185:22, current 20
<0> [241.581150] kworker/-81 1..... 198171524us : __i915_request_commit: 0000:03:00.0 rcs0: fence 5:100, current 99
<0> [241.581840] kworker/-81 1D..1. 198171529us : __i915_request_submit: 0000:03:00.0 rcs0: fence 5:100, current 99
<0> [241.582522] kworker/-848 1..... 199624872us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 185:22, current 22
<0> [241.583307] kworker/-848 1..... 199624939us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 5:100, current 100
<0> [241.583980] kworker/-2146 3..... 199660371us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:185 unpin
<0> [241.584657] kworker/-2146 3..... 199661213us : __intel_context_retire: 0000:03:00.0 rcs0: context:185 retire runtime: { total:608140ns, avg:55536ns }
<0> [241.585444] kworker/-526 3..... 199661275us : __engine_park: 0000:03:00.0 rcs0: parked
<0> [241.586127] kworker/-526 3..... 199661330us : __gt_park: 0000:03:00.0
<0> [241.586806] kworker/-2146 3..... 199771322us : intel_gt_runtime_suspend: 0000:03:00.0
<0> [241.587580] i915_pm_-2133 1..... 199886081us : intel_gt_runtime_resume: 0000:03:00.0
<0> [241.588253] i915_pm_-2133 1..... 199887876us : __gt_unpark: 0000:03:00.0
<0> [241.588917] i915_pm_-2133 1..... 199888094us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:185 active
<0> [241.589693] i915_pm_-2133 1..... 199888098us : intel_timeline_pin: 0000:03:00.0 timeline:185 using HWSP offset:fede3000
<0> [241.590370] i915_pm_-2133 1..... 199888115us : __engine_unpark: 0000:03:00.0 rcs0:
<0> [241.591051] i915_pm_-2133 1..... 199888153us : __engine_unpark: 0000:03:00.0 rcs0: context:5 reset { seqno:64, *hwsp:64, ring:958 }
<0> [241.591827] i915_pm_-2133 1..... 199888154us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:185 pin ring:{start:01500000, head:0948, tail:0948}
<0> [241.592532] i915_pm_-2133 1..... 199888199us : __i915_request_commit: 0000:03:00.0 rcs0: fence 185:24, current 22
<0> [241.593231] i915_pm_-2133 1D..1. 199888205us : __i915_request_submit: 0000:03:00.0 rcs0: fence 185:24, current 22
<0> [241.594020] kworker/-81 1..... 200141183us : __i915_request_commit: 0000:03:00.0 rcs0: fence 5:101, current 100
<0> [241.594705] kworker/-81 1D..1. 200141189us : __i915_request_submit: 0000:03:00.0 rcs0: fence 5:101, current 100
<0> [241.595386] kworker/-848 1..... 201660635us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 185:24, current 24
<0> [241.596170] kworker/-848 1..... 201660704us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 5:101, current 101
<0> [241.596841] kworker/-2146 4..... 201696019us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:185 unpin
<0> [241.597517] kworker/-2146 4..... 201696899us : __intel_context_retire: 0000:03:00.0 rcs0: context:185 retire runtime: { total:663988ns, avg:55588ns }
<0> [241.598310] kworker/-210 4..... 201696957us : __engine_park: 0000:03:00.0 rcs0: parked
<0> [241.598992] kworker/-210 4..... 201697011us : __gt_park: 0000:03:00.0
<0> [241.599670] kworker/-2146 4..... 201806945us : intel_gt_runtime_suspend: 0000:03:00.0
<0> [241.600447] i915_pm_-2133 1..... 201940458us : intel_gt_runtime_resume: 0000:03:00.0
<0> [241.601120] i915_pm_-2133 1..... 201942230us : __gt_unpark: 0000:03:00.0
<0> [241.601785] i915_pm_-2133 1..... 201942436us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:185 active
<0> [241.602567] i915_pm_-2133 1..... 201942441us : intel_timeline_pin: 0000:03:00.0 timeline:185 using HWSP offset:fede3000
<0> [241.603246] i915_pm_-2133 1..... 201942458us : __engine_unpark: 0000:03:00.0 rcs0:
<0> [241.603927] i915_pm_-2133 1..... 201942494us : __engine_unpark: 0000:03:00.0 rcs0: context:5 reset { seqno:65, *hwsp:65, ring:9e8 }
<0> [241.604705] i915_pm_-2133 1..... 201942496us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:185 pin ring:{start:01500000, head:0a20, tail:0a20}
<0> [241.605411] i915_pm_-2133 1..... 201942538us : __i915_request_commit: 0000:03:00.0 rcs0: fence 185:26, current 24
<0> [241.606113] i915_pm_-2133 1D..1. 201942544us : __i915_request_submit: 0000:03:00.0 rcs0: fence 185:26, current 24
<0> [241.606902] kworker/-81 1..... 202193525us : __i915_request_commit: 0000:03:00.0 rcs0: fence 5:102, current 101
<0> [241.607590] kworker/-81 1D..1. 202193531us : __i915_request_submit: 0000:03:00.0 rcs0: fence 5:102, current 101
<0> [241.608275] kworker/-848 1..... 203635280us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 185:26, current 26
<0> [241.609059] kworker/-848 1..... 203635355us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 5:102, current 102
<0> [241.609735] kworker/-121 3..... 203670609us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:185 unpin
<0> [241.610415] kworker/-121 3..... 203671507us : __intel_context_retire: 0000:03:00.0 rcs0: context:185 retire runtime: { total:720408ns, avg:55692ns }
<0> [241.611194] kworker/-526 3..... 203671575us : __engine_park: 0000:03:00.0 rcs0: parked
<0> [241.611883] kworker/-526 3..... 203671635us : __gt_park: 0000:03:00.0
<0> [241.612565] kworker/-121 3..... 203782130us : intel_gt_runtime_suspend: 0000:03:00.0
<0> [241.613353] i915_pm_-2133 1..... 203897832us : intel_gt_runtime_resume: 0000:03:00.0
<0> [241.614030] i915_pm_-2133 1..... 203899588us : __gt_unpark: 0000:03:00.0
<0> [241.614699] i915_pm_-2133 1..... 203899790us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:185 active
<0> [241.615485] i915_pm_-2133 1..... 203899795us : intel_timeline_pin: 0000:03:00.0 timeline:185 using HWSP offset:fede3000
<0> [241.616168] i915_pm_-2133 1..... 203899821us : __engine_unpark: 0000:03:00.0 rcs0:
<0> [241.616853] i915_pm_-2133 1..... 203899857us : __engine_unpark: 0000:03:00.0 rcs0: context:5 reset { seqno:66, *hwsp:66, ring:a78 }
<0> [241.617631] i915_pm_-2133 1..... 203899859us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:185 pin ring:{start:01500000, head:0af8, tail:0af8}
<0> [241.618344] i915_pm_-2133 1..... 203899903us : __i915_request_commit: 0000:03:00.0 rcs0: fence 185:28, current 26
<0> [241.619049] i915_pm_-2133 1D..1. 203899908us : __i915_request_submit: 0000:03:00.0 rcs0: fence 185:28, current 26
<0> [241.619845] kworker/-81 1..... 204152787us : __i915_request_commit: 0000:03:00.0 rcs0: fence 5:103, current 102
<0> [241.620537] kworker/-81 1D..1. 204152793us : __i915_request_submit: 0000:03:00.0 rcs0: fence 5:103, current 102
<0> [241.621225] kworker/-211 2..... 205611668us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 185:28, current 28
<0> [241.622010] kworker/-211 2..... 205611739us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 5:103, current 103
<0> [241.622690] kworker/-2152 1..... 205647321us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:185 unpin
<0> [241.623375] kworker/-2152 1..... 205648187us : __intel_context_retire: 0000:03:00.0 rcs0: context:185 retire runtime: { total:776412ns, avg:55692ns }
<0> [241.624162] kworker/-848 1..... 205648253us : __engine_park: 0000:03:00.0 rcs0: parked
<0> [241.624853] kworker/-848 1..... 205648307us : __gt_park: 0000:03:00.0
<0> [241.625537] kworker/-2152 1..... 205758477us : intel_gt_runtime_suspend: 0000:03:00.0
<0> [241.626325] i915_pm_-2133 0..... 205868279us : intel_gt_runtime_resume: 0000:03:00.0
<0> [241.627005] i915_pm_-2133 0..... 205870052us : __gt_unpark: 0000:03:00.0
<0> [241.627677] i915_pm_-2133 0..... 205870256us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:185 active
<0> [241.628466] i915_pm_-2133 0..... 205870261us : intel_timeline_pin: 0000:03:00.0 timeline:185 using HWSP offset:fede3000
<0> [241.629153] i915_pm_-2133 0..... 205870278us : __engine_unpark: 0000:03:00.0 rcs0:
<0> [241.629840] i915_pm_-2133 0..... 205870315us : __engine_unpark: 0000:03:00.0 rcs0: context:5 reset { seqno:67, *hwsp:67, ring:b08 }
<0> [241.630629] i915_pm_-2133 0..... 205870316us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:185 pin ring:{start:01500000, head:0bd0, tail:0bd0}
<0> [241.631330] i915_pm_-2133 0..... 205870334us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:185 unpin
<0> [241.632027] i915_pm_-2133 0..... 205871200us : __intel_context_retire: 0000:03:00.0 rcs0: context:185 retire runtime: { total:776412ns, avg:55692ns }
<0> [241.632818] i915_pm_-2133 0..... 205871204us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:185 active
<0> [241.633517] i915_pm_-2133 0..... 205871205us : intel_timeline_pin: 0000:03:00.0 timeline:185 using HWSP offset:fede3000
<0> [241.634213] i915_pm_-2133 0..... 205871209us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:185 pin ring:{start:01500000, head:0bd0, tail:0bd0}
<0> [241.635022] i915_pm_-2133 0..... 205871248us : __i915_request_commit: 0000:03:00.0 rcs0: fence 185:30, current 28
<0> [241.635738] i915_pm_-2133 0D..1. 205871254us : __i915_request_submit: 0000:03:00.0 rcs0: fence 185:30, current 28
<0> [241.636452] kworker/-111 0..... 206121811us : __i915_request_commit: 0000:03:00.0 rcs0: fence 5:104, current 103
<0> [241.637259] kworker/-111 0D..1. 206121817us : __i915_request_submit: 0000:03:00.0 rcs0: fence 5:104, current 103
<0> [241.637968] kworker/-266 0..... 207589886us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 185:30, current 30
<0> [241.638680] kworker/-266 0..... 207589962us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 5:104, current 104
<0> [241.639474] kworker/-2152 1..... 207625295us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:185 unpin
<0> [241.640168] kworker/-2152 1..... 207626195us : __intel_context_retire: 0000:03:00.0 rcs0: context:185 retire runtime: { total:832572ns, avg:55744ns }
<0> [241.640869] kworker/-848 1..... 207626263us : __engine_park: 0000:03:00.0 rcs0: parked
<0> [241.641668] kworker/-848 1..... 207626324us : __gt_park: 0000:03:00.0
<0> [241.642368] kworker/-2152 1..... 207737086us : intel_gt_runtime_suspend: 0000:03:00.0
<0> [241.643074] i915_pm_-2133 0..... 207847408us : intel_gt_runtime_resume: 0000:03:00.0
<0> [241.643877] i915_pm_-2133 0..... 207849195us : __gt_unpark: 0000:03:00.0
<0> [241.644574] i915_pm_-2133 0..... 207849416us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:185 active
<0> [241.645284] i915_pm_-2133 0..... 207849421us : intel_timeline_pin: 0000:03:00.0 timeline:185 using HWSP offset:fede3000
<0> [241.646079] i915_pm_-2133 0..... 207849436us : __engine_unpark: 0000:03:00.0 rcs0:
<0> [241.646770] i915_pm_-2133 0..... 207849472us : __engine_unpark: 0000:03:00.0 rcs0: context:5 reset { seqno:68, *hwsp:68, ring:b98 }
<0> [241.647469] i915_pm_-2133 0..... 207849473us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:185 pin ring:{start:01500000, head:0ca8, tail:0ca8}
<0> [241.648263] i915_pm_-2133 0..... 207849514us : __i915_request_commit: 0000:03:00.0 rcs0: fence 185:32, current 30
<0> [241.648980] i915_pm_-2133 0D..1. 207849520us : __i915_request_submit: 0000:03:00.0 rcs0: fence 185:32, current 30
<0> [241.649694] kworker/-111 0..... 208108183us : __i915_request_commit: 0000:03:00.0 rcs0: fence 5:105, current 104
<0> [241.650502] kworker/-111 0D..1. 208108188us : __i915_request_submit: 0000:03:00.0 rcs0: fence 5:105, current 104
<0> [241.651213] kworker/-211 2..... 209633377us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 185:32, current 32
<0> [241.651925] kworker/-211 2..... 209633448us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 5:105, current 105
<0> [241.652712] kworker/-2146 3..... 209668481us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:185 unpin
<0> [241.653406] kworker/-2146 3..... 209669357us : __intel_context_retire: 0000:03:00.0 rcs0: context:185 retire runtime: { total:888316ns, avg:55744ns }
<0> [241.654108] kworker/-526 3..... 209669415us : __engine_park: 0000:03:00.0 rcs0: parked
<0> [241.654908] kworker/-526 3..... 209669469us : __gt_park: 0000:03:00.0
<0> [241.655606] kworker/-2146 3..... 209779710us : intel_gt_runtime_suspend: 0000:03:00.0
<0> [241.656310] i915_pm_-2133 1..... 209910366us : intel_gt_runtime_resume: 0000:03:00.0
<0> [241.657111] i915_pm_-2133 1..... 209912128us : __gt_unpark: 0000:03:00.0
<0> [241.657809] i915_pm_-2133 1..... 209912329us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:185 active
<0> [241.658517] i915_pm_-2133 1..... 209912334us : intel_timeline_pin: 0000:03:00.0 timeline:185 using HWSP offset:fede3000
<0> [241.659310] i915_pm_-2133 1..... 209912350us : __engine_unpark: 0000:03:00.0 rcs0:
<0> [241.660001] i915_pm_-2133 1..... 209912387us : __engine_unpark: 0000:03:00.0 rcs0: context:5 reset { seqno:69, *hwsp:69, ring:c28 }
<0> [241.660700] i915_pm_-2133 1..... 209912388us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:185 pin ring:{start:01500000, head:0d80, tail:0d80}
<0> [241.661508] i915_pm_-2133 1..... 209912430us : __i915_request_commit: 0000:03:00.0 rcs0: fence 185:34, current 32
<0> [241.662224] i915_pm_-2133 1D..1. 209912436us : __i915_request_submit: 0000:03:00.0 rcs0: fence 185:34, current 32
<0> [241.662938] kworker/-81 1..... 210167494us : __i915_request_commit: 0000:03:00.0 rcs0: fence 5:106, current 105
<0> [241.663753] kworker/-81 1D..1. 210167500us : __i915_request_submit: 0000:03:00.0 rcs0: fence 5:106, current 105
<0> [241.664461] kworker/-848 1..... 211613100us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 185:34, current 34
<0> [241.665171] kworker/-848 1..... 211613175us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 5:106, current 106
<0> [241.665963] kworker/-2146 5..... 211648619us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:185 unpin
<0> [241.666653] kworker/-2146 5..... 211649526us : __intel_context_retire: 0000:03:00.0 rcs0: context:185 retire runtime: { total:943852ns, avg:55744ns }
<0> [241.667351] kworker/-78 5..... 211649599us : __engine_park: 0000:03:00.0 rcs0: parked
<0> [241.668146] kworker/-78 5..... 211649658us : __gt_park: 0000:03:00.0
<0> [241.668842] kworker/-2146 5..... 211760137us : intel_gt_runtime_suspend: 0000:03:00.0
<0> [241.669544] i915_pm_-2133 0..... 211871649us : intel_gt_runtime_resume: 0000:03:00.0
<0> [241.670339] i915_pm_-2133 0..... 211873452us : __gt_unpark: 0000:03:00.0
<0> [241.671033] i915_pm_-2133 0..... 211873682us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:185 active
<0> [241.671738] i915_pm_-2133 0..... 211873687us : intel_timeline_pin: 0000:03:00.0 timeline:185 using HWSP offset:fede3000
<0> [241.672531] i915_pm_-2133 0..... 211873704us : __engine_unpark: 0000:03:00.0 rcs0:
<0> [241.673221] i915_pm_-2133 0..... 211873755us : __engine_unpark: 0000:03:00.0 rcs0: context:5 reset { seqno:6a, *hwsp:6a, ring:cb8 }
<0> [241.673919] i915_pm_-2133 0..... 211873757us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:185 pin ring:{start:01500000, head:0e58, tail:0e58}
<0> [241.674734] i915_pm_-2133 0..... 211873812us : __i915_request_commit: 0000:03:00.0 rcs0: fence 185:36, current 34
<0> [241.675448] i915_pm_-2133 0D..1. 211873817us : __i915_request_submit: 0000:03:00.0 rcs0: fence 185:36, current 34
<0> [241.676164] kworker/-111 0..... 212131842us : __i915_request_commit: 0000:03:00.0 rcs0: fence 5:107, current 106
<0> [241.676971] kworker/-111 0D..1. 212131847us : __i915_request_submit: 0000:03:00.0 rcs0: fence 5:107, current 106
<0> [241.677677] kworker/-211 2..... 213593693us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 185:36, current 36
<0> [241.678387] kworker/-211 2..... 213593756us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 5:107, current 107
<0> [241.679173] kworker/-2146 5..... 213629414us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:185 unpin
<0> [241.679861] kworker/-2146 5..... 213630305us : __intel_context_retire: 0000:03:00.0 rcs0: context:185 retire runtime: { total:1000064ns, avg:55796ns }
<0> [241.680557] kworker/-78 5..... 213630377us : __engine_park: 0000:03:00.0 rcs0: parked
<0> [241.681335] kworker/-78 5..... 213630433us : __gt_park: 0000:03:00.0
<0> [241.682018] kworker/-2146 5..... 213740829us : intel_gt_runtime_suspend: 0000:03:00.0
<0> [241.682701] i915_pm_-2133 0..... 213850415us : intel_gt_runtime_resume: 0000:03:00.0
<0> [241.683476] i915_pm_-2133 0..... 213852185us : __gt_unpark: 0000:03:00.0
<0> [241.684144] i915_pm_-2133 0..... 213852392us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:185 active
<0> [241.684831] i915_pm_-2133 0..... 213852396us : intel_timeline_pin: 0000:03:00.0 timeline:185 using HWSP offset:fede3000
<0> [241.685604] i915_pm_-2133 0..... 213852413us : __engine_unpark: 0000:03:00.0 rcs0:
<0> [241.686290] i915_pm_-2133 0..... 213852465us : __engine_unpark: 0000:03:00.0 rcs0: context:5 reset { seqno:6b, *hwsp:6b, ring:d48 }
<0> [241.686979] i915_pm_-2133 0..... 213852466us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:185 pin ring:{start:01500000, head:0f30, tail:0f30}
<0> [241.687781] i915_pm_-2133 0..... 213852510us : __i915_request_commit: 0000:03:00.0 rcs0: fence 185:38, current 36
<0> [241.688485] i915_pm_-2133 0D..1. 213852516us : __i915_request_submit: 0000:03:00.0 rcs0: fence 185:38, current 36
<0> [241.689181] kworker/-111 0..... 214104794us : __i915_request_commit: 0000:03:00.0 rcs0: fence 5:108, current 107
<0> [241.689973] kworker/-111 0D..1. 214104799us : __i915_request_submit: 0000:03:00.0 rcs0: fence 5:108, current 107
<0> [241.690659] kworker/-266 0..... 215575141us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 185:38, current 38
<0> [241.691354] kworker/-266 0..... 215575173us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 5:108, current 108
<0> [241.692127] kworker/-2152 1..... 215610713us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:185 unpin
<0> [241.692810] kworker/-2152 1..... 215611530us : __intel_context_retire: 0000:03:00.0 rcs0: context:185 retire runtime: { total:1055756ns, avg:55744ns }
<0> [241.693501] kworker/-848 1..... 215611575us : __engine_park: 0000:03:00.0 rcs0: parked
<0> [241.694283] kworker/-848 1..... 215611618us : __gt_park: 0000:03:00.0
<0> [241.694966] kworker/-2152 1..... 215722304us : intel_gt_runtime_suspend: 0000:03:00.0
<0> [241.695648] i915_pm_-2133 2..... 215841304us : intel_gt_runtime_resume: 0000:03:00.0
<0> [241.696432] i915_pm_-2133 2.l... 215843358us : __gt_unpark: 0000:03:00.0
<0> [241.697101] i915_pm_-2133 2.l... 215845323us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:185 active
<0> [241.697788] i915_pm_-2133 2.l... 215845331us : intel_timeline_pin: 0000:03:00.0 timeline:185 using HWSP offset:fede3000
<0> [241.698568] i915_pm_-2133 2.l... 215845360us : __engine_unpark: 0000:03:00.0 rcs0:
<0> [241.699253] i915_pm_-2133 2.l... 215845407us : __engine_unpark: 0000:03:00.0 rcs0: context:5 reset { seqno:6c, *hwsp:6c, ring:dd8 }
<0> [241.699942] i915_pm_-2133 2.l... 215845409us : __intel_context_do_pin_ww: 0000:03:00.0 rcs0: context:185 pin ring:{start:01500000, head:1008, tail:1008}
<0> [241.700751] i915_pm_-2133 2..... 215846012us : __i915_request_commit: 0000:03:00.0 rcs0: fence 185:40, current 38
<0> [241.701458] i915_pm_-2133 2D..1. 215846024us : __i915_request_submit: 0000:03:00.0 rcs0: fence 185:40, current 38
<0> [241.702155] kworker/-268 2..... 216102192us : __i915_request_commit: 0000:03:00.0 rcs0: fence 5:109, current 108
<0> [241.702940] kworker/-268 2D..1. 216102198us : __i915_request_submit: 0000:03:00.0 rcs0: fence 5:109, current 108
<0> [241.703626] kworker/-211 2..... 217620805us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 185:40, current 40
<0> [241.704321] kworker/-211 2..... 217620880us : i915_request_retire.part.0: 0000:03:00.0 rcs0: fence 5:109, current 109
<0> [241.705099] kworker/-2152 1..... 217656403us : __intel_context_do_unpin.part.0: 0000:03:00.0 rcs0: context:185 unpin
<0> [241.705781] kworker/-2152 1..... 217657317us : __intel_context_retire: 0000:03:00.0 rcs0: context:185 retire runtime: { total:1111188ns, avg:55692ns }
<0> [241.706471] kworker/-848 1..... 217657388us : __engine_park: 0000:03:00.0 rcs0: parked
<0> [241.707270] kworker/-848 1..... 217657480us : __gt_park: 0000:03:00.0
<0> [241.707952] kworker/-2152 1..... 217768108us : intel_gt_runtime_suspend: 0000:03:00.0
<0> [241.708567] i915_pm_-2133 2...1. 217849012us : tracing_mark_write: i915_pm_rpm: finished subtest system-suspend-execbuf, SUCCESS
<0> [241.709382] kworker/-2152 1..... 217907793us : intel_gt_runtime_resume: 0000:03:00.0
<0> [241.710066] kworker/-2152 3..... 217922463us : __gt_unpark: 0000:03:00.0
<0> [241.710765] kworker/-2152 3..... 217922725us : destroyed_worker_func: guc_lrc_desc_unpin:3418 GEM_BUG_ON(!ctx_id_mapped(guc, ce->guc_id.id))
<0> [241.711485] ---------------------------------
<4> [241.713722] ------------[ cut here ]------------
<2> [241.713725] kernel BUG at drivers/gpu/drm/i915/gt/uc/intel_guc_submission.c:3418!
<4> [241.715079] Oops: invalid opcode: 0000 [#1] SMP NOPTI
<4> [241.715727] CPU: 2 UID: 0 PID: 2152 Comm: kworker/u24:20 Tainted: G S U W L 7.1.0-rc2-CI_DRM_18417-g835de80ce9b3+ #1 PREEMPT(lazy)
<4> [241.716253] Tainted: [S]=CPU_OUT_OF_SPEC, [U]=USER, [W]=WARN, [L]=SOFTLOCKUP
<4> [241.716772] Hardware name: Intel Corporation CoffeeLake Client Platform/CoffeeLake S UDIMM RVP, BIOS CNLSFWR1.R00.X220.B00.2103302221 03/30/2021
<4> [241.717453] Workqueue: events_unbound destroyed_worker_func [i915]
<4> [241.718196] RIP: 0010:destroyed_worker_func+0x66d/0x8a0 [i915]
<4> [241.718897] Code: 00 48 c7 c2 d0 14 1d a1 48 8d 3d 00 00 00 00 e8 09 23 86 e0 bf 01 00 00 00 e8 0f ca 85 e0 31 f6 bf 09 00 00 00 e8 53 c5 64 e0 <0f> 0b 48 c7 c1 d9 35 20 a1 ba 08 02 00 00 48 c7 c6 10 1d 1d a1 48
<4> [241.719594] RSP: 0018:ffffc90001797d88 EFLAGS: 00010246
<4> [241.720165] RAX: 0000000000000000 RBX: ffff888119558028 RCX: 0000000000000000
<4> [241.720735] RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000000
<4> [241.721442] RBP: ffffc90001797df8 R08: 0000000000000000 R09: 0000000000000000
<4> [241.721999] R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000001006
<4> [241.722554] R13: ffff888119558dc8 R14: ffff88813ebc5f10 R15: ffff888119558db8
<4> [241.723244] FS: 0000000000000000(0000) GS:ffff8884d9783000(0000) knlGS:0000000000000000
<4> [241.723794] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
<4> [241.724345] CR2: 0000000716385000 CR3: 000000000344a006 CR4: 00000000003726f0
<4> [241.724896] Call Trace:
<4> [241.725445] <TASK>
<4> [241.725991] process_one_work+0x239/0x740
<4> [241.725997] worker_thread+0x200/0x3f0
<4> [241.725999] ? __pfx_worker_thread+0x10/0x10
<4> [241.726001] kthread+0x10d/0x150
<4> [241.726003] ? __pfx_kthread+0x10/0x10
<4> [241.726004] ret_from_fork+0x3bd/0x470
<4> [241.726006] ? __pfx_kthread+0x10/0x10
<4> [241.726008] ret_from_fork_asm+0x1a/0x30
<4> [241.726013] </TASK>
<4> [241.726013] Modules linked in: vgem snd_hda_codec_intelhdmi snd_hda_codec_hdmi mei_lb mei_gsc i915 prime_numbers drm_buddy ttm drm_display_helper cec rc_core i2c_algo_bit kunit intel_rapl_msr intel_rapl_common intel_uncore_frequency intel_uncore_frequency_common cmdlinepart intel_tcc_cooling spi_nor ee1004 x86_pkg_temp_thermal mtd intel_powerclamp coretemp mei_hdcp mei_pxp ppdev intel_wmi_thunderbolt wmi_bmof kvm_intel kvm snd_hda_intel irqbypass snd_intel_dspcfg aesni_intel gf128mul snd_hda_codec rapl intel_cstate i2c_i801 snd_hda_core i2c_mux snd_hwdep spi_intel_pci snd_pcm video i2c_smbus spi_intel e1000e snd_timer snd soundcore idma64 parport_pc binfmt_misc parport nls_iso8859_1 mei_me pinctrl_cannonlake intel_pmc_core mei intel_pch_thermal pmt_telemetry pmt_discovery pmt_class intel_pmc_ssram_telemetry wmi acpi_tad acpi_pad intel_vsec input_leds serio_raw dm_multipath msr nvme_fabrics fuse efi_pstore nfnetlink autofs4
<4> [241.733337] ---[ end trace 0000000000000000 ]---
|