[38.942981] Initializing watchdogs
[38.943026]   /dev/watchdog0
[38.948467] [001/130] (960s left) gen9_exec_parse (bb-large)
[39.008122] Subtest bb-large: SKIP (0.000s)
[39.047800] [002/130] (960s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[39.159173] Starting subtest: basic-flip-before-cursor-atomic
[40.106923] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.949s)
[40.975182] [003/130] (958s left) syncobj_wait (wait-all-for-submit-snapshot)
[41.014230] Starting subtest: wait-all-for-submit-snapshot
[41.096717] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[41.146108] [004/130] (958s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[41.232980] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[42.097698] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (0.866s)
[42.209166] [005/130] (957s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[42.306207] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[42.310470] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[42.370078] [006/130] (957s left) sw_sync (sync_expired_merge)
[42.404991] Starting subtest: sync_expired_merge
[43.479121] Subtest sync_expired_merge: SUCCESS (1.074s)
[43.521111] [007/130] (956s left) kms_lease (lease-again)
[43.620896] Starting subtest: lease-again
[43.623528] Starting dynamic subtest: pipe-A-eDP-1
[43.626163] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[43.633652] Starting dynamic subtest: pipe-B-eDP-1
[43.635756] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[43.640783] Starting dynamic subtest: pipe-C-eDP-1
[43.642956] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[43.647839] Starting dynamic subtest: pipe-D-eDP-1
[43.650060] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[43.652245] Subtest lease-again: SUCCESS (0.008s)
[43.721521] [008/130] (955s left) gem_pxp (create-regular-context-2)
[46.295463] Subtest create-regular-context-2: SKIP (0.000s)
[46.343068] [009/130] (953s left) perf (gen12-group-exclusive-stream-ctx-handle)
[46.486063] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[46.507765] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.024s)
[46.529898] [010/130] (953s left) kms_pm_rpm (fences)
[48.544243] Starting subtest: fences
[48.550212] Subtest fences: SKIP (0.000s)
[48.871516] [011/130] (950s left) gem_ctx_sseu (engines)
[48.927407] Subtest engines: SKIP (0.000s)
[48.968998] [012/130] (950s left) gem_userptr_blits (create-destroy-sync)
[49.024405] Starting subtest: create-destroy-sync
[54.033624] Subtest create-destroy-sync: SUCCESS (5.012s)
[54.133130] [013/130] (945s left) i915_pm_rps (thresholds-park)
[54.189554] Starting subtest: thresholds-park
[54.195015] Subtest thresholds-park: SKIP (0.000s)
[54.244113] [014/130] (945s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[54.775650] Starting subtest: syncobj-timeline-invalid-flags
[54.778554] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[56.415073] [015/130] (943s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[56.466139] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[56.574507] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.108s)
[56.631710] [016/130] (943s left) kms_cursor_crc (cursor-sliding-256x85)
[56.838750] Starting subtest: cursor-sliding-256x85
[56.879193] Subtest cursor-sliding-256x85: SKIP (0.035s)
[57.024773] [017/130] (942s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[57.114750] Starting subtest: fbc-1p-pri-indfb-multidraw
[67.912753] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (10.802s)
[68.027545] [018/130] (931s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[68.113362] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[68.115244] Starting dynamic subtest: pipe-A-default-mode
[68.433353] Dynamic subtest pipe-A-default-mode: SKIP (0.314s)
[68.437679] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.314s)
[69.270400] [019/130] (930s left) kms_addfb_basic (invalid-set-prop-any)
[69.314981] Starting subtest: invalid-set-prop-any
[69.317020] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[69.440614] [020/130] (930s left) kms_feature_discovery (display-2x)
[69.534117] Starting subtest: display-2x
[69.538366] Subtest display-2x: SKIP (0.000s)
[69.581491] [021/130] (930s left) gem_exec_reloc (basic-cpu-gtt)
[69.636977] Subtest basic-cpu-gtt: SKIP (0.000s)
[69.681478] [022/130] (930s left) gem_userptr_blits (probe)
[69.747751] Starting subtest: probe
[69.803449] Subtest probe: SUCCESS (0.055s)
[69.901388] [023/130] (929s left) syncobj_wait (invalid-reset-zero-handles)
[69.954136] Starting subtest: invalid-reset-zero-handles
[69.956850] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[70.031651] [024/130] (929s left) device_reset (unbind-reset-rebind)
[70.069178] Starting subtest: unbind-reset-rebind
[73.084644] Subtest unbind-reset-rebind: SUCCESS (3.010s)
[73.103100] [025/130] (926s left) gem_exec_params (invalid-ring2)
[73.161009] Starting subtest: invalid-ring2
[73.162960] Subtest invalid-ring2: SUCCESS (0.000s)
[73.249296] [026/130] (926s left) i915_hangman (engine-engine-error)
[73.306548] Starting subtest: engine-engine-error
[73.308740] Starting dynamic subtest: rcs0
[74.314625] Dynamic subtest rcs0: SUCCESS (1.006s)
[74.322096] Starting dynamic subtest: bcs0
[76.362849] Dynamic subtest bcs0: SUCCESS (2.048s)
[76.371478] Starting dynamic subtest: vcs0
[78.345952] Dynamic subtest vcs0: SUCCESS (1.981s)
[78.355049] Starting dynamic subtest: vcs1
[80.328801] Dynamic subtest vcs1: SUCCESS (1.984s)
[80.335481] Starting dynamic subtest: vecs0
[82.378371] Dynamic subtest vecs0: SUCCESS (2.049s)
[82.389093] Starting dynamic subtest: ccs0
[84.361884] Dynamic subtest ccs0: SUCCESS (1.982s)
[84.364430] Subtest engine-engine-error: SUCCESS (11.052s)
[84.413920] [027/130] (915s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[84.455961] Starting subtest: single-wait-all-for-submit-unsubmitted
[84.559161] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[84.610497] [028/130] (915s left) syncobj_timeline (multi-wait-available-signaled)
[84.662544] Starting subtest: multi-wait-available-signaled
[84.664864] Subtest multi-wait-available-signaled: SUCCESS (0.000s)
[84.726794] [029/130] (915s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[84.819514] Starting subtest: fbc-rgb565-draw-mmap-cpu
[87.593063] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (2.777s)
[87.692224] [030/130] (912s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[87.732978] Starting subtest: x-tiled-to-vebox-y-tiled
[87.736606] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[87.891792] [031/130] (911s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[87.941561] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[87.946315] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[88.097878] [032/130] (911s left) gem_exec_params (sol-reset-invalid)
[88.142089] Starting subtest: sol-reset-invalid
[88.145242] Subtest sol-reset-invalid: SUCCESS (0.002s)
[89.415040] [033/130] (910s left) gem_exec_schedule (reorder-wide)
[89.585070] Subtest reorder-wide: SKIP (0.000s)
[89.741672] [034/130] (910s left) syncobj_wait (single-wait-all-for-submit-signaled)
[89.797592] Starting subtest: single-wait-all-for-submit-signaled
[89.800166] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[89.894445] [035/130] (910s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[89.985730] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[89.990031] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[90.047509] [036/130] (909s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[90.086054] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[90.088155] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[90.146566] [037/130] (909s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[90.192709] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[90.315302] [038/130] (909s left) kms_flip (2x-plain-flip-fb-recreate)
[90.415138] Starting subtest: 2x-plain-flip-fb-recreate
[90.429543] Subtest 2x-plain-flip-fb-recreate: SKIP (0.014s)
[90.479825] [039/130] (909s left) prime_vgem (basic-gtt)
[90.555298] Starting subtest: basic-gtt
[90.559991] Subtest basic-gtt: SKIP (0.000s)
[90.629231] [040/130] (909s left) gem_exec_whisper (basic-queues-priority)
[90.682461] Starting subtest: basic-queues-priority
[112.615569] Subtest basic-queues-priority: SUCCESS (21.929s)
[112.771803] [041/130] (887s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[112.865221] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[117.846639] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.986s)
[117.966893] [042/130] (882s left) kms_mmap_write_crc (main)
[118.064632] Starting subtest: main
[118.066956] Starting dynamic subtest: pipe-A-eDP-1
[121.088487] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.020s)
[121.091440] Subtest main: SUCCESS (3.021s)
[122.006915] [043/130] (878s left) kms_content_protection (dp-mst-type-0)
[122.146421] Starting subtest: dp-mst-type-0
[122.151813] Subtest dp-mst-type-0: SKIP (0.000s)
[122.262895] [044/130] (877s left) gem_exec_balancer (semaphore)
[122.317708] Starting subtest: semaphore
[124.376468] Subtest semaphore: SUCCESS (2.057s)
[124.641749] [045/130] (875s left) gem_softpin (zero)
[124.701335] Starting subtest: zero
[124.705827] Subtest zero: SUCCESS (0.004s)
[124.811458] [046/130] (875s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[124.890592] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[124.895217] Starting dynamic subtest: A-eDP1
[133.899442] Dynamic subtest A-eDP1: SUCCESS (9.006s)
[133.907720] Starting dynamic subtest: B-eDP1
[142.858544] Dynamic subtest B-eDP1: SUCCESS (8.958s)
[142.869612] Starting dynamic subtest: C-eDP1
[151.807037] Dynamic subtest C-eDP1: SUCCESS (8.946s)
[151.814045] Starting dynamic subtest: D-eDP1
[160.768295] Dynamic subtest D-eDP1: SUCCESS (8.960s)
[160.773710] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.879s)
[161.999174] [047/130] (838s left) api_intel_bb (bb-with-allocator)
[162.048534] Starting subtest: bb-with-allocator
[162.053579] Subtest bb-with-allocator: SUCCESS (0.005s)
[162.139647] [048/130] (837s left) prime_self_import (basic-llseek-bad)
[162.168895] Starting subtest: basic-llseek-bad
[162.183578] Subtest basic-llseek-bad: SUCCESS (0.012s)
[162.256860] [049/130] (837s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[167.409061] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[167.413379] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[168.266908] [050/130] (831s left) gem_lmem_swapping (parallel-multi)
[168.304252] Subtest parallel-multi: SKIP (0.000s)
[168.322354] [051/130] (831s left) kms_psr (psr-sprite-render)
[168.404235] Starting subtest: psr-sprite-render
[168.406796] Starting dynamic subtest: eDP-1
[170.194733] Dynamic subtest eDP-1: SUCCESS (1.788s)
[170.196847] Subtest psr-sprite-render: SUCCESS (1.788s)
[171.085930] [052/130] (829s left) kms_psr (fbc-pr-sprite-blt)
[171.172039] Starting subtest: fbc-pr-sprite-blt
[171.176674] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[171.221885] [053/130] (828s left) gem_ctx_exec (basic-invalid-context)
[171.276603] Starting subtest: basic-invalid-context
[171.281025] Subtest basic-invalid-context: SUCCESS (0.005s)
[171.371507] [054/130] (828s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[171.467067] Starting subtest: psr-2p-primscrn-spr-indfb-move
[171.471121] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[171.536701] [055/130] (828s left) kms_cursor_crc (cursor-random-128x42)
[171.721390] Starting subtest: cursor-random-128x42
[171.758654] Subtest cursor-random-128x42: SKIP (0.034s)
[171.931189] [056/130] (828s left) kms_pm_rpm (modeset-lpsp)
[173.547044] Starting subtest: modeset-lpsp
[174.998182] Subtest modeset-lpsp: SUCCESS (1.451s)
[175.066420] [057/130] (825s left) gem_exec_schedule (deep)
[175.238284] Starting subtest: deep
[175.240962] Starting dynamic subtest: rcs0
[178.555394] Dynamic subtest rcs0: SKIP (3.314s)
[178.565112] Starting dynamic subtest: vcs0
[187.247572] Dynamic subtest vcs0: SUCCESS (8.694s)
[187.257258] Starting dynamic subtest: vcs1
[196.386908] Dynamic subtest vcs1: SUCCESS (9.139s)
[196.395252] Starting dynamic subtest: vecs0
[205.450737] Dynamic subtest vecs0: SUCCESS (9.063s)
[205.457580] Starting dynamic subtest: ccs0
[216.103723] Dynamic subtest ccs0: SUCCESS (10.652s)
[216.106552] Subtest deep: SUCCESS (40.864s)
[216.924590] [058/130] (783s left) kms_psr (fbc-psr-primary-render)
[217.014972] Starting subtest: fbc-psr-primary-render
[217.017360] Starting dynamic subtest: eDP-1
[217.021879] Dynamic subtest eDP-1: SKIP (0.000s)
[217.026385] Subtest fbc-psr-primary-render: SKIP (0.000s)
[217.063085] [059/130] (783s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[217.158883] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[217.163175] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[217.252626] [060/130] (783s left) syncobj_eventfd (binary-wait-before-signal)
[217.299076] Starting subtest: binary-wait-before-signal
[217.329030] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[217.378478] [061/130] (782s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[217.470410] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[217.474632] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[217.538483] [062/130] (782s left) gem_mmap_gtt (basic-wc)
[217.587976] Subtest basic-wc: SKIP (0.000s)
[217.626454] [063/130] (782s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[217.720108] Starting subtest: fbcpsr-stridechange
[221.841568] Subtest fbcpsr-stridechange: SUCCESS (4.123s)
[221.956303] [064/130] (778s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[222.055252] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[225.274058] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (3.222s)
[225.395652] [065/130] (774s left) kms_cursor_edge_walk (64x64-right-edge)
[225.483283] Starting subtest: 64x64-right-edge
[225.485209] Starting dynamic subtest: pipe-A-eDP-1
[228.995690] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.511s)
[229.003298] Starting dynamic subtest: pipe-D-eDP-1
[232.228483] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.232s)
[232.231035] Subtest 64x64-right-edge: SUCCESS (6.746s)
[233.104226] [066/130] (767s left) kms_atomic_transition (plane-toggle-modeset-transition)
[233.191966] Starting subtest: plane-toggle-modeset-transition
[233.194374] Starting dynamic subtest: pipe-A-eDP-1
[247.284275] Dynamic subtest pipe-A-eDP-1: SUCCESS (14.088s)
[247.291077] Starting dynamic subtest: pipe-B-eDP-1
[261.106542] Dynamic subtest pipe-B-eDP-1: SUCCESS (13.818s)
[261.109068] Subtest plane-toggle-modeset-transition: SUCCESS (27.912s)
[262.030265] [067/130] (738s left) drm_fdinfo (virtual-idle)
[262.063771] Starting subtest: virtual-idle
[265.111737] Subtest virtual-idle: SUCCESS (3.050s)
[265.168685] [068/130] (735s left) i915_pm_rpm (gem-idle)
[266.693437] Starting subtest: gem-idle
[272.890465] Subtest gem-idle: SUCCESS (6.197s)
[273.178620] [069/130] (727s left) gem_ctx_persistence (hang)
[274.319808] Starting subtest: hang
[274.324777] Subtest hang: SKIP (0.000s)
[274.426789] [070/130] (726s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-wc)
[274.527528] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-wc
[277.176671] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (2.650s)
[277.267064] [071/130] (723s left) gem_exec_balancer (parallel-keep-in-fence)
[277.475434] Starting subtest: parallel-keep-in-fence
[278.211078] Subtest parallel-keep-in-fence: SUCCESS (0.735s)
[278.285255] [072/130] (722s left) gem_exec_reloc (basic-write-cpu-noreloc)
[278.335241] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[278.386470] [073/130] (722s left) gem_exec_fence (basic-await)
[278.549883] Starting subtest: basic-await
[278.552844] Starting dynamic subtest: rcs0
[278.618181] Dynamic subtest rcs0: SUCCESS (0.068s)
[278.627287] Starting dynamic subtest: bcs0
[278.685773] Dynamic subtest bcs0: SUCCESS (0.067s)
[278.694636] Starting dynamic subtest: vcs0
[278.753267] Dynamic subtest vcs0: SUCCESS (0.067s)
[278.762469] Starting dynamic subtest: vcs1
[278.819637] Dynamic subtest vcs1: SUCCESS (0.066s)
[278.827612] Starting dynamic subtest: vecs0
[278.885267] Dynamic subtest vecs0: SUCCESS (0.065s)
[278.894306] Starting dynamic subtest: ccs0
[278.950733] Dynamic subtest ccs0: SUCCESS (0.065s)
[278.953714] Subtest basic-await: SUCCESS (0.401s)
[280.439619] [074/130] (720s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[280.539216] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[280.543635] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[280.602694] [075/130] (719s left) gem_mmap_gtt (basic-copy)
[280.638239] Subtest basic-copy: SKIP (0.000s)
[280.666978] [076/130] (719s left) gem_exec_whisper (basic-contexts-priority)
[280.720719] Starting subtest: basic-contexts-priority
[303.969657] Subtest basic-contexts-priority: SUCCESS (23.246s)
[304.124925] [077/130] (696s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[304.226583] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[305.050200] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.822s)
[305.158202] [078/130] (695s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-gtt)
[305.251047] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-gtt
[305.255290] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[305.314824] [079/130] (695s left) prime_vgem (fence-write-hang)
[305.394386] Subtest fence-write-hang: SKIP (0.000s)
[305.458600] [080/130] (695s left) perf_pmu (render-node-busy-idle)
[305.512433] Starting subtest: render-node-busy-idle
[305.514766] Starting dynamic subtest: rcs0
[306.189816] Dynamic subtest rcs0: SUCCESS (0.676s)
[306.200797] Starting dynamic subtest: bcs0
[306.854159] Dynamic subtest bcs0: SUCCESS (0.663s)
[306.863888] Starting dynamic subtest: vcs0
[308.393709] Dynamic subtest vcs0: SUCCESS (1.539s)
[308.402231] Starting dynamic subtest: vcs1
[310.378676] Dynamic subtest vcs1: SUCCESS (1.983s)
[310.388308] Starting dynamic subtest: vecs0
[312.362854] Dynamic subtest vecs0: SUCCESS (1.983s)
[312.371628] Starting dynamic subtest: ccs0
[313.024921] Dynamic subtest ccs0: SUCCESS (0.663s)
[313.027806] Subtest render-node-busy-idle: SUCCESS (7.512s)
[313.075560] [081/130] (687s left) perf (mi-rpc)
[313.162985] Starting subtest: mi-rpc
[313.166865] Subtest mi-rpc: SKIP (0.000s)
[313.186942] [082/130] (687s left) gem_ccs (ctrl-surf-copy-new-ctx)
[313.240769] Starting subtest: ctrl-surf-copy-new-ctx
[313.244716] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[313.323606] [083/130] (687s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[313.428502] Starting subtest: cursorA-vs-flipA-toggle
[324.531224] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.103s)
[325.395228] [084/130] (675s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[325.488038] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[325.490441] Starting dynamic subtest: pipe-A
[325.499872] Dynamic subtest pipe-A: SKIP (0.004s)
[325.508351] Starting dynamic subtest: pipe-B
[325.518609] Dynamic subtest pipe-B: SKIP (0.014s)
[325.525371] Starting dynamic subtest: pipe-C
[325.535485] Dynamic subtest pipe-C: SKIP (0.015s)
[325.541780] Starting dynamic subtest: pipe-D
[325.549264] Dynamic subtest pipe-D: SKIP (0.015s)
[325.552834] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.049s)
[325.614681] [085/130] (675s left) kms_flip (2x-flip-vs-suspend)
[325.704060] Starting subtest: 2x-flip-vs-suspend
[325.718318] Subtest 2x-flip-vs-suspend: SKIP (0.014s)
[325.767942] [086/130] (674s left) syncobj_timeline (invalid-transfer-illegal-handle)
[325.817851] Starting subtest: invalid-transfer-illegal-handle
[325.819627] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[325.883324] [087/130] (674s left) kms_psr (pr-primary-render)
[325.985970] Starting subtest: pr-primary-render
[325.990592] Subtest pr-primary-render: SKIP (0.000s)
[326.036333] [088/130] (674s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[326.140618] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[326.145750] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[326.210227] [089/130] (674s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[326.312175] Starting subtest: psr-indfb-scaledprimary
[330.069169] Subtest psr-indfb-scaledprimary: SUCCESS (3.760s)
[330.179912] [090/130] (670s left) gem_mmap_gtt (big-copy-xy)
[330.229858] Subtest big-copy-XY: SKIP (0.000s)
[330.271097] [091/130] (670s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[330.365044] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[334.964276] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.601s)
[335.050747] [092/130] (665s left) kms_atomic (crtc-invalid-params-fence)
[335.134977] Starting subtest: crtc-invalid-params-fence
[335.137279] Starting dynamic subtest: pipe-A-eDP-1
[335.522737] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.385s)
[335.525226] Subtest crtc-invalid-params-fence: SUCCESS (0.386s)
[336.402309] [093/130] (664s left) kms_sequence (get-idle)
[336.496057] Starting subtest: get-idle
[336.498479] Starting dynamic subtest: pipe-A-eDP-1
[338.284095] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.786s)
[338.291452] Starting dynamic subtest: pipe-B-eDP-1
[340.798902] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.513s)
[340.806620] Starting dynamic subtest: pipe-C-eDP-1
[343.357473] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.558s)
[343.364479] Starting dynamic subtest: pipe-D-eDP-1
[345.906418] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.547s)
[345.908700] Subtest get-idle: SUCCESS (9.408s)
[346.764245] [094/130] (654s left) gem_caching (writes)
[346.825460] Subtest writes: SKIP (0.000s)
[346.873636] [095/130] (653s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[346.960614] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[351.290033] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (4.333s)
[351.389279] [096/130] (649s left) gem_exec_reloc (basic-wc-gtt-active)
[351.444640] Subtest basic-wc-gtt-active: SKIP (0.000s)
[351.489690] [097/130] (649s left) kms_psr (psr2-sprite-render)
[351.568148] Starting subtest: psr2-sprite-render
[351.570473] Starting dynamic subtest: eDP-1
[353.335201] Dynamic subtest eDP-1: SUCCESS (1.764s)
[353.337740] Subtest psr2-sprite-render: SUCCESS (1.764s)
[354.252829] [098/130] (646s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[354.345595] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[354.350143] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[354.410747] [099/130] (646s left) kms_vrr (lobf)
[354.504823] Starting subtest: lobf
[354.509268] Subtest lobf: SKIP (0.000s)
[354.554275] [100/130] (646s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[354.638053] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[354.640371] Starting dynamic subtest: pipe-A-eDP-1
[354.664026] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[354.671117] Starting dynamic subtest: pipe-B-eDP-1
[354.694920] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[354.700852] Starting dynamic subtest: pipe-C-eDP-1
[354.724438] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[354.730585] Starting dynamic subtest: pipe-D-eDP-1
[354.756813] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[354.761929] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[357.005843] [101/130] (643s left) gem_exec_reloc (basic-write-wc)
[357.047543] Subtest basic-write-wc: SKIP (0.000s)
[357.106806] [102/130] (643s left) kms_pm_backlight (basic-brightness)
[357.185979] Starting subtest: basic-brightness
[357.233180] Starting dynamic subtest: eDP-1
[357.723980] Dynamic subtest eDP-1: SUCCESS (0.489s)
[357.726725] Subtest basic-brightness: SUCCESS (0.537s)
[358.608949] [103/130] (642s left) kms_busy (extended-modeset-hang-oldfb)
[358.694909] Starting subtest: extended-modeset-hang-oldfb
[358.697288] Starting dynamic subtest: pipe-A
[370.886856] Dynamic subtest pipe-A: SUCCESS (12.189s)
[370.895313] Starting dynamic subtest: pipe-D
[383.440847] Dynamic subtest pipe-D: SUCCESS (12.552s)
[383.443300] Subtest extended-modeset-hang-oldfb: SUCCESS (24.745s)
[384.331853] [104/130] (616s left) kms_hdr (static-toggle-dpms)
[384.418926] Starting subtest: static-toggle-dpms
[384.425958] Subtest static-toggle-dpms: SKIP (0.000s)
[384.474305] [105/130] (616s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[384.570723] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[385.370152] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.800s)
[385.479221] [106/130] (615s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[385.532551] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[385.583075] [107/130] (615s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[390.708213] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[390.713124] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.002s)
[391.566223] [108/130] (609s left) gem_mmap_gtt (ptrace)
[391.627679] Subtest ptrace: SKIP (0.000s)
[391.662017] [109/130] (609s left) kms_plane_multiple (tiling-4)
[391.761896] Starting subtest: tiling-4
[391.764299] Starting dynamic subtest: pipe-A-eDP-1
[395.743923] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.979s)
[395.751509] Starting dynamic subtest: pipe-B-eDP-1
[400.544637] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.800s)
[400.551698] Starting dynamic subtest: pipe-C-eDP-1
[405.267264] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.721s)
[405.276084] Starting dynamic subtest: pipe-D-eDP-1
[409.992626] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.726s)
[409.995221] Subtest tiling-4: SUCCESS (18.230s)
[410.897386] [110/130] (590s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[411.002566] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[411.007064] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[411.086557] [111/130] (589s left) kms_psr (fbc-psr2-cursor-blt)
[411.168776] Starting subtest: fbc-psr2-cursor-blt
[411.170909] Starting dynamic subtest: eDP-1
[411.174935] Dynamic subtest eDP-1: SKIP (0.000s)
[411.179039] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[411.219767] [112/130] (589s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[411.306621] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[411.308876] Starting dynamic subtest: pipe-A-eDP-1
[411.718110] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.380s)
[411.724819] Starting dynamic subtest: pipe-B-eDP-1
[413.196566] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.480s)
[413.204790] Starting dynamic subtest: pipe-C-eDP-1
[414.610366] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.413s)
[414.618743] Starting dynamic subtest: pipe-D-eDP-1
[416.017957] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.406s)
[416.020290] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.681s)
[417.230069] [113/130] (583s left) debugfs_test (read_all_entries_display_off)
[417.331047] Starting subtest: read_all_entries_display_off
[418.436890] Subtest read_all_entries_display_off: SUCCESS (1.105s)
[418.717170] [114/130] (582s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[418.810634] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[418.814830] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[418.884233] [115/130] (582s left) gem_ctx_persistence (legacy-engines-hostile)
[418.925340] Starting subtest: legacy-engines-hostile
[418.927874] Starting dynamic subtest: render
[419.009427] Dynamic subtest render: SUCCESS (0.083s)
[419.018449] Starting dynamic subtest: bsd1
[419.115342] Dynamic subtest bsd1: SUCCESS (0.104s)
[419.124846] Starting dynamic subtest: bsd2
[419.200186] Dynamic subtest bsd2: SUCCESS (0.083s)
[419.209214] Starting dynamic subtest: blt
[419.247324] Dynamic subtest blt: SUCCESS (0.045s)
[419.255955] Starting dynamic subtest: vebox
[419.352293] Dynamic subtest vebox: SUCCESS (0.104s)
[419.355241] Subtest legacy-engines-hostile: SUCCESS (0.427s)
[419.409281] [116/130] (581s left) core_setmaster (master-drop-set-root)
[420.129327] Starting subtest: master-drop-set-root
[420.134287] Subtest master-drop-set-root: SUCCESS (0.005s)
[420.156957] [117/130] (581s left) gem_reg_read (timestamp-moving)
[420.196945] Starting subtest: timestamp-moving
[421.200526] Subtest timestamp-moving: SUCCESS (1.001s)
[421.253696] [118/130] (579s left) kms_chamelium_edid (hdmi-edid-stress-resolution-4k)
[421.631083] Subtest hdmi-edid-stress-resolution-4k: SKIP (0.000s)
[422.524583] [119/130] (578s left) vgem_basic (busy-fence)
[422.563257] Starting subtest: busy-fence
[422.565658] Subtest busy-fence: SUCCESS (0.000s)
[422.598470] [120/130] (578s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[422.673346] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[422.675739] Starting dynamic subtest: pipe-A-eDP-1
[422.698704] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[422.705312] Starting dynamic subtest: pipe-B-eDP-1
[422.727311] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[422.733737] Starting dynamic subtest: pipe-C-eDP-1
[422.755704] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[422.762361] Starting dynamic subtest: pipe-D-eDP-1
[422.784597] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[422.789057] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[425.038578] [121/130] (576s left) gem_exec_create (forked)
[425.094745] Starting subtest: forked
[425.097459] Starting dynamic subtest: smem
[445.355496] Dynamic subtest smem: SUCCESS (20.259s)
[445.358318] Subtest forked: SUCCESS (20.259s)
[445.516185] [122/130] (555s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[445.891941] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[446.778779] [123/130] (554s left) kms_addfb_basic (invalid-get-prop)
[446.843121] Starting subtest: invalid-get-prop
[446.845583] Subtest invalid-get-prop: SUCCESS (0.000s)
[446.966393] [124/130] (554s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[447.060250] Starting subtest: yf-tiled-64bpp-rotate-90
[447.064270] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[447.122841] [125/130] (554s left) syncobj_timeline (single-wait-for-submit-signaled)
[447.176066] Starting subtest: single-wait-for-submit-signaled
[447.178450] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[447.237916] [126/130] (554s left) gen3_render_tiledx_blits
[447.337220] [127/130] (553s left) kms_color (ctm-red-to-blue)
[447.421955] Starting subtest: ctm-red-to-blue
[447.424276] Starting dynamic subtest: pipe-A-eDP-1
[448.066219] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.640s)
[448.074803] Starting dynamic subtest: pipe-B-eDP-1
[449.508788] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.442s)
[449.517446] Starting dynamic subtest: pipe-C-eDP-1
[450.883072] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.374s)
[450.892330] Starting dynamic subtest: pipe-D-eDP-1
[452.282044] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.397s)
[452.284366] Subtest ctm-red-to-blue: SUCCESS (4.858s)
[453.200139] [128/130] (548s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[453.300761] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[453.304875] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[453.373339] [129/130] (547s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[453.464848] Starting subtest: bad-pixel-format-yf-tiled-ccs
[453.467196] Starting dynamic subtest: pipe-A-eDP-1
[453.493655] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[453.505074] Starting dynamic subtest: pipe-B-eDP-1
[453.529251] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[453.535688] Starting dynamic subtest: pipe-C-eDP-1
[453.559585] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[453.566477] Starting dynamic subtest: pipe-D-eDP-1
[453.590399] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[453.594777] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.003s)
[455.820382] [130/130] (545s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[455.873982] Starting subtest: multi-wait-all-for-submit-submitted
[455.973429] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.102s)
[456.022055] Closing watchdogs
Done.