Results for igt@gem_exec_nop@basic-sequential

Result: Abort 138 Warning(s)

integration-manifest git-log-oneline i915_display_info23 igt_runner23 runtimes23 results23.json results23-i915-load.json i915_display_info_post_exec23 boot23 dmesg23

DetailValue
Duration unknown
Hostname
shard-mtlp-7
Igt-Version
IGT-Version: 2.2-g7f6690bd9 (x86_64) (Linux: 6.18.0-rc5-CI_DRM_17551-g5f250ba2e3bb+ x86_64)
Out
Using IGT_SRANDOM=1763194640 for randomisation
Opened device: /dev/dri/card0
Running on meteorlake
Using GuC submission
Has kernel scheduler
 - With priority sorting
 - With preemption enabled
 - With engine busy statistics
 - With timeslicing enabled
Starting subtest: basic-sequential
Total (individual) execution latency 229.726us per cycle
Sequential (6 engines, 1 processes): average 2029.849us per cycle [expected 229.726us]
Subtest basic-sequential: SUCCESS (14.781s)
runner: This test was killed due to a kernel taint (0x2c4).
runner: This test was killed due to exceeding disk usage limit. (Used 18158226 bytes, limit 10485760)

This test caused an abort condition: Lockdep not active

/proc/lockdep_stats contents:
 lock-classes:                         2426 [max: 8192]
 dynamic-keys:                          325
 direct dependencies:                 27008 [max: 524288]
 indirect dependencies:              264901
 all direct dependencies:            606692
 dependency chains:                   41073 [max: 524288]
 dependency chain hlocks used:       180304 [max: 2621440]
 dependency chain hlocks lost:            0
 in-hardirq chains:                     315
 in-softirq chains:                     795
 in-process chains:                   39963
 stack-trace entries:                293048 [max: 524288]
 number of stack traces:              13331
 number of stack hash chains:          9091
 combined max dependencies:      1462450112
 hardirq-safe locks:                    130
 hardirq-unsafe locks:                 1407
 softirq-safe locks:                    263
 softirq-unsafe locks:                 1308
 irq-safe locks:                        282
 irq-unsafe locks:                     1407
 hardirq-read-safe locks:                 5
 hardirq-read-unsafe locks:             490
 softirq-read-safe locks:                10
 softirq-read-unsafe locks:             487
 irq-read-safe locks:                    11
 irq-read-unsafe locks:                 490
 uncategorized locks:                   401
 unused locks:                            1
 max locking depth:                      18
 max bfs queue depth:                   433
 max lock class index:                 2425
 debug_locks:                             0

 zapped classes:                          3
 zapped lock chains:                    155
 large chain blocks:                      1
Err
Starting subtest: basic-sequential
Subtest basic-sequential: SUCCESS (14.781s)
Dmesg

<6> [324.731771] Console: switching to colour dummy device 80x25
<6> [324.732078] [IGT] gem_exec_nop: executing
<7> [324.738735] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [324.741376] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<7> [324.760590] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<7> [324.762823] i915 0000:00:02.0: [drm:i915_gem_open [i915]]
<6> [324.770760] [IGT] gem_exec_nop: starting subtest basic-sequential
<7> [324.774579] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [325.058480] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [325.095965] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [325.378872] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [325.416016] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [325.628582] i915 0000:00:02.0: [drm:intel_tc_port_reset_mode [i915]] Port G/TC#4: TC port mode reset (tbt-alt -> disconnected) pin assignment: - max lanes: 4
<7> [325.628689] i915 0000:00:02.0: [drm:intel_tc_port_reset_mode [i915]] Port F/TC#3: TC port mode reset (tbt-alt -> disconnected) pin assignment: - max lanes: 4
<7> [325.628851] i915 0000:00:02.0: [drm:intel_tc_port_reset_mode [i915]] Port D/TC#1: TC port mode reset (tbt-alt -> disconnected) pin assignment: - max lanes: 4
<7> [325.628814] i915 0000:00:02.0: [drm:intel_tc_port_reset_mode [i915]] Port E/TC#2: TC port mode reset (legacy -> disconnected) pin assignment: - max lanes: 4
<7> [327.088839] i915 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 turning VDD off
<7> [327.089423] i915 0000:00:02.0: [drm:intel_pps_vdd_off_sync_unlocked [i915]] [ENCODER:261:DDI A/PHY A] PPS 0 PP_STATUS: 0x80000008 PP_CONTROL: 0x00000067
<7> [327.089885] i915 0000:00:02.0: [drm:intel_power_well_disable [i915]] disabling DC_off
<7> [327.090425] i915 0000:00:02.0: [drm:skl_enable_dc6 [i915]] Enabling DC6
<7> [327.090950] i915 0000:00:02.0: [drm:gen9_set_dc_state.part.0 [i915]] Setting DC state from 00 to 02
<7> [327.310089] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [329.102030] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [331.319905] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [333.052257] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [335.273955] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [337.074999] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [337.360738] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [337.416441] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<7> [339.519979] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x0000005c [0x0000005c]
<6> [339.552927] [IGT] gem_exec_nop: finished subtest basic-sequential, SUCCESS
<6> [339.661385] [IGT] gem_exec_nop: exiting, ret=0
<7> [339.663204] i915 0000:00:02.0: [drm:i915_drop_caches_set [i915]] Dropping caches: 0x000001dc [0x000001dc]
<3> [339.668815] guc_lrc_desc_unpin:3418 GEM_BUG_ON(!ctx_id_mapped(guc, ce->guc_id.id))
<0> [339.669634] Dumping ftrace buffer:
<0> [339.669659] ---------------------------------
<0> [339.670046] kworker/-883 10..... 46784502us : __intel_context_do_unpin.part.0: 0000:00:02.0 bcs'0: context:9 unpin
<0> [339.670333] kworker/-883 10.N... 46785249us : __intel_context_retire: 0000:00:02.0 bcs'0: context:9 retire runtime: { total:14196ns, avg:14196ns }
<0> [339.670619] kworker/-883 10.N... 46785393us : __intel_context_do_unpin.part.0: 0000:00:02.0 rcs'0: context:8 unpin
<0> [339.670886] kworker/-883 10.N... 46785488us : __intel_context_retire: 0000:00:02.0 rcs'0: context:8 retire runtime: { total:91000ns, avg:91000ns }
<0> [339.671043] kworker/-883 10.N... 46785504us : __intel_context_do_unpin.part.0: 0000:00:02.0 ccs'0: context:a unpin
<0> [339.671194] kworker/-883 10.N... 46785598us : __intel_context_retire: 0000:00:02.0 ccs'0: context:a retire runtime: { total:86008ns, avg:86008ns }
<0> [339.671358] kworker/-181 10..... 46785752us : __engine_park: 0000:00:02.0 bcs'0: parked
<0> [339.671505] kworker/-181 10..... 46785851us : __engine_park: 0000:00:02.0 rcs'0: parked
<0> [339.671653] kworker/-181 10..... 46785882us : __engine_park: 0000:00:02.0 ccs'0: parked
<0> [339.671826] kworker/-188 8..... 46832929us : __i915_request_commit: 0000:00:02.0 other0: fence 10:1, current 0
<0> [339.672002] kworker/-188 8D..1. 46832959us : __i915_request_submit: 0000:00:02.0 other0: fence 10:1, current 0
<0> [339.672143] kworker/-237 8..... 46851711us : __intel_context_do_unpin.part.0: 0000:00:02.0 vecs0: context:13 unpin
<0> [339.672255] kworker/-237 8.N... 46851825us : __intel_context_retire: 0000:00:02.0 vecs0: context:13 retire runtime: { total:12012ns, avg:12012ns }
<0> [339.672371] kworker/-557 8..... 46851870us : __engine_park: 0000:00:02.0 vecs0: parked
<0> [339.672477] kworker/-237 10..... 46851882us : __intel_context_do_unpin.part.0: 0000:00:02.0 other0: context:14 unpin
<0> [339.672587] kworker/-237 10..... 46851964us : __intel_context_retire: 0000:00:02.0 other0: context:14 retire runtime: { total:10140ns, avg:10140ns }
<0> [339.672702] kworker/-237 10.N... 46852162us : __intel_context_do_unpin.part.0: 0000:00:02.0 vcs1: context:12 unpin
<0> [339.672811] kworker/-237 10.N... 46852245us : __intel_context_retire: 0000:00:02.0 vcs1: context:12 retire runtime: { total:12532ns, avg:12532ns }
<0> [339.672926] kworker/-237 10.N... 46852251us : __intel_context_do_unpin.part.0: 0000:00:02.0 vcs0: context:11 unpin
<0> [339.673036] kworker/-237 10.N... 46852331us : __intel_context_retire: 0000:00:02.0 vcs0: context:11 retire runtime: { total:12688ns, avg:12688ns }
<0> [339.673153] kworker/-181 10..... 46852463us : __engine_park: 0000:00:02.0 vcs1: parked
<0> [339.673276] kworker/-181 10..... 46852472us : __engine_park: 0000:00:02.0 vcs0: parked
<0> [339.673386] i915_mod-2085 6..... 46876853us : __gt_unpark: 0000:00:02.0
<0> [339.673497] kworker/-169 6..... 46878379us : __gt_park: 0000:00:02.0
<0> [339.673616] kworker/-188 8..... 46967784us : __engine_unpark: 0000:00:02.0 other0:
<0> [339.673748] kworker/-188 8..... 46967851us : __gt_unpark: 0000:00:02.0
<0> [339.673873] kworker/-188 8..... 46968364us : __engine_unpark: 0000:00:02.0 other0: context:f reset { seqno:1, *hwsp:1, ring:58 }
<0> [339.674021] kworker/-188 8..... 46968385us : __i915_request_commit: 0000:00:02.0 other0: fence 10:2, current 1
<0> [339.674151] kworker/-188 8D..1. 46968392us : __i915_request_submit: 0000:00:02.0 other0: fence 10:2, current 1
<0> [339.674266] kworker/-188 8..... 46972170us : __engine_unpark: 0000:00:02.0 other0:
<0> [339.674378] kworker/-188 8..... 46972178us : __gt_unpark: 0000:00:02.0
<0> [339.674484] kworker/-188 8..... 46972208us : __engine_unpark: 0000:00:02.0 other0: context:f reset { seqno:1, *hwsp:1, ring:58 }
<0> [339.674616] kworker/-188 8..... 46972221us : __i915_request_commit: 0000:00:02.0 other0: fence 10:3, current 2
<0> [339.674742] kworker/-188 8D..1. 46972225us : __i915_request_submit: 0000:00:02.0 other0: fence 10:3, current 2
<0> [339.674855] kworker/-188 8..... 46993014us : __engine_unpark: 0000:00:02.0 other0:
<0> [339.674967] kworker/-188 8..... 46993040us : __gt_unpark: 0000:00:02.0
<0> [339.675075] kworker/-188 8..... 46993397us : __engine_unpark: 0000:00:02.0 other0: context:f reset { seqno:1, *hwsp:1, ring:58 }
<0> [339.675201] kworker/-188 8..... 46993439us : __i915_request_commit: 0000:00:02.0 other0: fence 10:4, current 3
<0> [339.675326] kworker/-188 8D..1. 46993447us : __i915_request_submit: 0000:00:02.0 other0: fence 10:4, current 3
<0> [339.675442] kworker/-188 13..... 47028951us : __engine_unpark: 0000:00:02.0 other0:
<0> [339.675553] kworker/-188 13..... 47028973us : __gt_unpark: 0000:00:02.0
<0> [339.675659] kworker/-188 13..... 47029055us : __engine_unpark: 0000:00:02.0 other0: context:f reset { seqno:1, *hwsp:1, ring:58 }
<0> [339.675786] kworker/-188 13..... 47029235us : __i915_request_commit: 0000:00:02.0 other0: fence 10:5, current 4
<0> [339.675911] kworker/-188 13D..1. 47029249us : __i915_request_submit: 0000:00:02.0 other0: fence 10:5, current 4
<0> [339.676025] kworker/-188 13..... 47054807us : __engine_unpark: 0000:00:02.0 other0:
<0> [339.676135] kworker/-188 13..... 47054820us : __gt_unpark: 0000:00:02.0
<0> [339.676241] kworker/-188 13..... 47054895us : __engine_unpark: 0000:00:02.0 other0: context:f reset { seqno:1, *hwsp:1, ring:58 }
<0> [339.676369] kworker/-188 13..... 47054926us : __i915_request_commit: 0000:00:02.0 other0: fence 10:6, current 5
<0> [339.676496] kworker/-188 13D..1. 47054938us : __i915_request_submit: 0000:00:02.0 other0: fence 10:6, current 5
<0> [339.676610] kworker/-188 13..... 47188974us : __engine_unpark: 0000:00:02.0 other0:
<0> [339.676721] kworker/-188 13..... 47188995us : __gt_unpark: 0000:00:02.0
<0> [339.676827] kworker/-188 13..... 47189079us : __engine_unpark: 0000:00:02.0 other0: context:f reset { seqno:1, *hwsp:1, ring:58 }
<0> [339.676959] kworker/-188 13..... 47189117us : __i915_request_commit: 0000:00:02.0 other0: fence 10:7, current 6
<0> [339.677088] kworker/-188 13D..1. 47189132us : __i915_request_submit: 0000:00:02.0 other0: fence 10:7, current 6
<0> [339.677202] kworker/-188 13..... 47221580us : __engine_unpark: 0000:00:02.0 other0:
<0> [339.677311] kworker/-188 13..... 47221601us : __gt_unpark: 0000:00:02.0
<0> [339.677428] setfont-2110 8..... 48056148us : intel_rps_mark_interactive: 0000:00:02.0 mark interactive: yes
<0> [339.677544] kworker/-289 8..... 48065725us : intel_rps_mark_interactive: 0000:00:02.0 mark interactive: no
<0> [339.677657] i915_mod-2085 11..... 48133202us : __gt_unpark: 0000:00:02.0
<0> [339.677764] i915_mod-2085 11..... 48135269us : __gt_park: 0000:00:02.0
<0> [339.677870] i915_mod-2085 11..... 48137281us : __gt_unpark: 0000:00:02.0
<0> [339.677976] i915_mod-2085 11..... 48138560us : __intel_context_do_pin_ww: 0000:00:02.0 rcs0: context:17 active
<0> [339.678093] i915_mod-2085 11..... 48139846us : intel_timeline_pin: 0000:00:02.0 timeline:17 using HWSP offset:fedcd000
<0> [339.678205] i915_mod-2085 11..... 48140314us : __engine_unpark: 0000:00:02.0 rcs0:
<0> [339.678313] i915_mod-2085 11..... 48140338us : __engine_unpark: 0000:00:02.0 rcs0: context:5 reset { seqno:1, *hwsp:1, ring:140 }
<0> [339.678429] i915_mod-2085 11..... 48140342us : __intel_context_do_pin_ww: 0000:00:02.0 rcs0: context:17 pin ring:{start:fedce000, head:0000, tail:0000}
<0> [339.678559] i915_mod-2085 11..... 48142002us : __i915_request_commit: 0000:00:02.0 rcs0: fence 17:2, current 0
<0> [339.678685] i915_mod-2085 11D..1. 48142341us : __i915_request_submit: 0000:00:02.0 rcs0: fence 17:2, current 0
<0> [339.678808] i915_mod-2085 11..... 48142567us : __i915_request_commit: 0000:00:02.0 rcs0: fence 5:2, current 1
<0> [339.678931] i915_mod-2085 11D..1. 48142575us : __i915_request_submit: 0000:00:02.0 rcs0: fence 5:2, current 1
<0> [339.679043] i915_mod-2085 11..... 48143347us : __intel_context_do_pin_ww: 0000:00:02.0 rcs0: context:18 active
<0> [339.679162] i915_mod-2085 11..... 48144067us : intel_timeline_pin: 0000:00:02.0 timeline:18 using HWSP offset:fedc8000
<0> [339.679274] i915_mod-2085 11..... 48144663us : __intel_context_do_pin_ww: 0000:00:02.0 rcs0: context:18 pin ring:{start:fedc9000, head:0000, tail:0000}
<0> [339.679405] i915_mod-2085 11..... 48145516us : __i915_request_commit: 0000:00:02.0 rcs0: fence 18:2, current 0
<0> [339.679528] i915_mod-2085 11D..1. 48145520us : __i915_request_submit: 0000:00:02.0 rcs0: fence 18:2, current 0
<0> [339.679640] i915_mod-2085 11..... 48145653us : __intel_context_do_pin_ww: 0000:00:02.0 bcs0: context:19 active
<0> [339.679760] i915_mod-2085 11..... 48146752us : intel_timeline_pin: 0000:00:02.0 timeline:19 using HWSP offset:fedc3000
<0> [339.679875] i915_mod-2085 11..... 48147295us : __engine_unpark: 0000:00:02.0 bcs0:
<0> [339.679984] i915_mod-2085 11..... 48147306us : __engine_unpark: 0000:00:02.0 bcs0: context:6 reset { seqno:1, *hwsp:1, ring:88 }
<0> [339.680101] i915_mod-2085 11..... 48147307us : __intel_context_do_pin_ww: 0000:00:02.0 bcs0: context:19 pin ring:{start:fedc4000, head:0000, tail:0000}
<0> [339.680215] i915_mod-2085 11..... 48147324us : __intel_context_do_unpin.part.0: 0000:00:02.0 bcs0: context:19 unpin
<0> [339.680325] i915_mod-2085 11.N... 48147649us : __intel_context_retire: 0000:00:02.0 bcs0: context:19 retire runtime: { total:0ns, avg:0ns }
<0> [339.680442] kworker/-146 11..... 48147707us : __engine_park: 0000:00:02.0 bcs0: parked
<0> [339.680547] i915_mod-2085 11..... 48147718us : __intel_context_do_pin_ww: 0000:00:02.0 bcs0: context:19 active
<0> [339.680665] i915_mod-2085 11..... 48147719us : intel_timeline_pin: 0000:00:02.0 timeline:19 using HWSP offset:fedc3000
<0> [339.680776] i915_mod-2085 11..... 48147727us : __engine_unpark: 0000:00:02.0 bcs0:
<0> [339.680883] i915_mod-2085 11..... 48147734us : __engine_unpark: 0000:00:02.0 bcs0: context:6 reset { seqno:1, *hwsp:1, ring:88 }
<0> [339.680994] i915_mod-2085 11..... 48147735us : __intel_context_do_pin_ww: 0000:00:02.0 bcs0: context:19 pin ring:{start:fedc4000, head:0000, tail:0000}
<0> [339.681123] i915_mod-2085 11..... 48147865us : __i915_request_commit: 0000:00:02.0 bcs0: fence 19:2, current 0
<0> [339.681248] i915_mod-2085 11D..1. 48147868us : __i915_request_submit: 0000:00:02.0 bcs0: fence 19:2, current 0
<0> [339.681363] i915_mod-2085 11..... 48147895us : __gt_unpark: 0000:00:02.0
<0> [339.681472] i915_mod-2085 11..... 48148082us : __intel_context_do_pin_ww: 0000:00:02.0 vcs0: context:1a active
<0> [339.681589] i915_mod-2085 11..... 48148648us : intel_timeline_pin: 0000:00:02.0 timeline:1a using HWSP offset:fedbd000
<0> [339.681701] i915_mod-2085 11..... 48149286us : __engine_unpark: 0000:00:02.0 vcs0:
<0> [339.681808] i915_mod-2085 11..... 48149295us : __engine_unpark: 0000:00:02.0 vcs0: context:c reset { seqno:1, *hwsp:1, ring:78 }
<0> [339.681919] i915_mod-2085 11..... 48149296us : __intel_context_do_pin_ww: 0000:00:02.0 vcs0: context:1a pin ring:{start:fedb4000, head:0000, tail:0000}
<0> [339.682032] i915_mod-2085 11..... 48149305us : __intel_context_do_unpin.part.0: 0000:00:02.0 vcs0: context:1a unpin
<0> [339.682140] i915_mod-2085 11.N... 48149375us : __intel_context_retire: 0000:00:02.0 vcs0: context:1a retire runtime: { total:0ns, avg:0ns }
<0> [339.682252] kworker/-146 11..... 48149379us : __engine_park: 0000:00:02.0 vcs0: parked
<0> [339.682361] i915_mod-2085 11..... 48149387us : __intel_context_do_pin_ww: 0000:00:02.0 vcs0: context:1a active
<0> [339.682485] i915_mod-2085 11..... 48149388us : intel_timeline_pin: 0000:00:02.0 timeline:1a using HWSP offset:fedbd000
<0> [339.682595] i915_mod-2085 11..... 48149394us : __engine_unpark: 0000:00:02.0 vcs0:
<0> [339.682702] i915_mod-2085 11..... 48149401us : __engine_unpark: 0000:00:02.0 vcs0: context:c reset { seqno:1, *hwsp:1, ring:78 }
<0> [339.682820] i915_mod-2085 11..... 48149402us : __intel_context_do_pin_ww: 0000:00:02.0 vcs0: context:1a pin ring:{start:fedb4000, head:0000, tail:0000}
<0> [339.682950] i915_mod-2085 11..... 48149435us : __i915_request_commit: 0000:00:02.0 vcs0: fence 1a:2, current 0
<0> [339.683074] i915_mod-2085 11D..1. 48149439us : __i915_request_submit: 0000:00:02.0 vcs0: fence 1a:2, current 0
<0> [339.683185] i915_mod-2085 11..... 48149523us : __intel_context_do_pin_ww: 0000:00:02.0 vcs1: context:1b active
<0> [339.683302] i915_mod-2085 11..... 48150377us : intel_timeline_pin: 0000:00:02.0 timeline:1b using HWSP offset:fedb3000
<0> [339.683414] i915_mod-2085 11..... 48150659us : __engine_unpark: 0000:00:02.0 vcs1:
<0> [339.683521] i915_mod-2085 11..... 48150666us : __engine_unpark: 0000:00:02.0 vcs1: context:d reset { seqno:1, *hwsp:1, ring:78 }
<0> [339.683632] i915_mod-2085 11..... 48150667us : __intel_context_do_pin_ww: 0000:00:02.0 vcs1: context:1b pin ring:{start:feda5000, head:0000, tail:0000}
<0> [339.683745] i915_mod-2085 11..... 48150676us : __intel_context_do_unpin.part.0: 0000:00:02.0 vcs1: context:1b unpin
<0> [339.683854] i915_mod-2085 11.N... 48150744us : __intel_context_retire: 0000:00:02.0 vcs1: context:1b retire runtime: { total:0ns, avg:0ns }
<0> [339.683966] kworker/-146 11..... 48150748us : __engine_park: 0000:00:02.0 vcs1: parked
<0> [339.684071] i915_mod-2085 11..... 48150755us : __intel_context_do_pin_ww: 0000:00:02.0 vcs1: context:1b active
<0> [339.684187] i915_mod-2085 11..... 48150756us : intel_timeline_pin: 0000:00:02.0 timeline:1b using HWSP offset:fedb3000
<0> [339.684298] i915_mod-2085 11..... 48150763us : __engine_unpark: 0000:00:02.0 vcs1:
<0> [339.684406] i915_mod-2085 11..... 48150769us : __engine_unpark: 0000:00:02.0 vcs1: context:d reset { seqno:1, *hwsp:1, ring:78 }
<0> [339.684516] i915_mod-2085 11..... 48150769us : __intel_context_do_pin_ww: 0000:00:02.0 vcs1: context:1b pin ring:{start:feda5000, head:0000, tail:0000}
<0> [339.684628] i915_mod-2085 11..... 48150778us : __intel_context_do_unpin.part.0: 0000:00:02.0 vcs1: context:1b unpin
<0> [339.684736] i915_mod-2085 11.N... 48150846us : __intel_context_retire: 0000:00:02.0 vcs1: context:1b retire runtime: { total:0ns, avg:0ns }
<0> [339.684847] kworker/-146 11..... 48150849us : __engine_park: 0000:00:02.0 vcs1: parked
<0> [339.684952] i915_mod-2085 11..... 48150855us : __intel_context_do_pin_ww: 0000:00:02.0 vcs1: context:1b active
<0> [339.685092] i915_mod-2085 11..... 48150856us : intel_timeline_pin: 0000:00:02.0 timeline:1b using HWSP offset:fedb3000
<0> [339.685228] i915_mod-2085 11..... 48150863us : __engine_unpark: 0000:00:02.0 vcs1:
<0> [339.685340] i915_mod-2085 11..... 48150869us : __engine_unpark: 0000:00:02.0 vcs1: context:d reset { seqno:1, *hwsp:1, ring:78 }
<0> [339.685455] i915_mod-2085 11..... 48150870us : __intel_context_do_pin_ww: 0000:00:02.0 vcs1: context:1b pin ring:{start:feda5000, head:0000, tail:0000}
<0> [339.685586] i915_mod-2085 11..... 48150905us : __i915_request_commit: 0000:00:02.0 vcs1: fence 1b:2, current 0
<0> [339.685711] i915_mod-2085 11D..1. 48150909us : __i915_request_submit: 0000:00:02.0 vcs1: fence 1b:2, current 0
<0> [339.685823] i915_mod-2085 11..... 48151008us : __intel_context_do_pin_ww: 0000:00:02.0 vecs0: context:1c active
<0> [339.685941] i915_mod-2085 11..... 48151894us : intel_timeline_pin: 0000:00:02.0 timeline:1c using HWSP offset:fedb2000
<0> [339.686053] i915_mod-2085 11..... 48152164us : __engine_unpark: 0000:00:02.0 vecs0:
<0> [339.686161] i915_mod-2085 11..... 48152171us : __engine_unpark: 0000:00:02.0 vecs0: context:e reset { seqno:1, *hwsp:1, ring:78 }
<0> [339.686272] i915_mod-2085 11..... 48152172us : __intel_context_do_pin_ww: 0000:00:02.0 vecs0: context:1c pin ring:{start:03055000, head:0000, tail:0000}
<0> [339.686386] i915_mod-2085 11..... 48152180us : __intel_context_do_unpin.part.0: 0000:00:02.0 vecs0: context:1c unpin
<0> [339.686494] i915_mod-2085 11.N... 48152248us : __intel_context_retire: 0000:00:02.0 vecs0: context:1c retire runtime: { total:0ns, avg:0ns }
<0> [339.686607] kworker/-146 11..... 48152252us : __engine_park: 0000:00:02.0 vecs0: parked
<0> [339.686712] i915_mod-2085 11..... 48152258us : __intel_context_do_pin_ww: 0000:00:02.0 vecs0: context:1c active
<0> [339.686830] i915_mod-2085 11..... 48152259us : intel_timeline_pin: 0000:00:02.0 timeline:1c using HWSP offset:fedb2000
<0> [339.686941] i915_mod-2085 11..... 48152265us : __engine_unpark: 0000:00:02.0 vecs0:
<0> [339.687048] i915_mod-2085 11..... 48152271us : __engine_unpark: 0000:00:02.0 vecs0: context:e reset { seqno:1, *hwsp:1, ring:78 }
<0> [339.687158] i915_mod-2085 11..... 48152272us : __intel_context_do_pin_ww: 0000:00:02.0 vecs0: context:1c pin ring:{start:03055000, head:0000, tail:0000}
<0> [339.687271] i915_mod-2085 11..... 48152279us : __intel_context_do_unpin.part.0: 0000:00:02.0 vecs0: context:1c unpin
<0> [339.687382] i915_mod-2085 11.N... 48152346us : __intel_context_retire: 0000:00:02.0 vecs0: context:1c retire runtime: { total:0ns, avg:0ns }
<0> [339.687494] kworker/-146 11..... 48152349us : __engine_park: 0000:00:02.0 vecs0: parked
<0> [339.687599] i915_mod-2085 11..... 48152354us : __intel_context_do_pin_ww: 0000:00:02.0 vecs0: context:1c active
<0> [339.687723] i915_mod-2085 11..... 48152355us : intel_timeline_pin: 0000:00:02.0 timeline:1c using HWSP offset:fedb2000
<0> [339.687853] i915_mod-2085 11..... 48152361us : __engine_unpark: 0000:00:02.0 vecs0:
<0> [339.687959] i915_mod-2085 11..... 48152367us : __engine_unpark: 0000:00:02.0 vecs0: context:e reset { seqno:1, *hwsp:1, ring:78 }
<0> [339.688071] i915_mod-2085 11..... 48152368us : __intel_context_do_pin_ww: 0000:00:02.0 vecs0: context:1c pin ring:{start:03055000, head:0000, tail:0000}
<0> [339.688201] i915_mod-2085 11..... 48152398us : __i915_request_commit: 0000:00:02.0 vecs0: fence 1c:2, current 0
<0> [339.688326] i915_mod-2085 11D..1. 48152401us : __i915_request_submit: 0000:00:02.0 vecs0: fence 1c:2, current 0
<0> [339.688439] i915_mod-2085 11..... 48152476us : __intel_context_do_pin_ww: 0000:00:02.0 ccs0: context:1d active
<0> [339.688557] i915_mod-2085 11..... 48153283us : intel_timeline_pin: 0000:00:02.0 timeline:1d using HWSP offset:fedb1000
<0> [339.688670] i915_mod-2085 11..... 48153568us : __engine_unpark: 0000:00:02.0 ccs0:
<0> [339.688777] i915_mod-2085 11..... 48153576us : __engine_unpark: 0000:00:02.0 ccs0: context:7 reset { seqno:1, *hwsp:1, ring:130 }
<0> [339.688889] i915_mod-2085 11..... 48153577us : __intel_context_do_pin_ww: 0000:00:02.0 ccs0: context:1d pin ring:{start:03059000, head:0000, tail:0000}
<0> [339.689018] i915_mod-2085 11..... 48153682us : __i915_request_commit: 0000:00:02.0 ccs0: fence 1d:2, current 0
<0> [339.689142] i915_mod-2085 11D..1. 48153686us : __i915_request_submit: 0000:00:02.0 ccs0: fence 1d:2, current 0
<0> [339.689260] i915_mod-2085 11..... 48153767us : intel_rps_boost: 0000:00:02.0 boost fence:1d:2
<0> [339.689376] i915_mod-2085 11..... 48155773us : intel_rps_mark_interactive: 0000:00:02.0 mark interactive: yes
<0> [339.689491] kworker/-286 11..... 48163807us : intel_rps_mark_interactive: 0000:00:02.0 mark interactive: no
<0> [339.689529] i915_mod-2085 11...1. 48164149us : tracing_mark_write: i915_module_load: finished subtest load, SUCCESS
<0> [339.689654] kworker/-146 11..... 49721392us : i915_request_retire.part.0: 0000:00:02.0 vcs0: fence 1a:2, current 2
<0> [339.689777] kworker/-146 11..... 49722597us : i915_request_retire.part.0: 0000:00:02.0 vcs1: fence 1b:2, current 2
<0> [339.689899] kworker/-146 11..... 49722714us : i915_request_retire.part.0: 0000:00:02.0 vecs0: fence 1c:2, current 2
<0> [339.690021] kworker/-146 11..... 49722788us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 17:2, current 2
<0> [339.690143] kworker/-146 11..... 49725322us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 5:2, current 2
<0> [339.690265] kworker/-146 11..... 49726741us : i915_request_retire.part.0: 0000:00:02.0 rcs0: fence 18:2, current 2
<0> [339.690402] kworker/-146 11..... 49726880us : i915_request_retire.part.0: 0000:00:02.0 bcs0: fence 19:2, current 2
<0> [339.690524] kworker/-146 11..... 49726908us : i915_request_retire.part.0: 0000:00:02.0 ccs0: fence 1d:2, current 2
<0> [339.690641] kworker/-157 7..... 49748838us : __gt_unpark: 0000:00:02.0
<0> [339.690751] kworker/-185 7..... 49749884us : __gt_park: 0000:00:02.0
<0> [339.690859] kms_debu-2231 5..... 56804164us : __gt_unpark: 0000:00:02.0
<0> [339.690967] kworker/-172 5..... 56804634us : __gt_park: 0000:00:02.0
<0> [339.690990] kms_debu-2231 7...1. 57163044us : tracing_mark_write: kms_debugfs: finished subtest display-off-read-all, SUCCESS
Created at 2025-11-15 08:57:54