[60.833423] Initializing watchdogs
[60.833498]   /dev/watchdog0
[60.849230] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[60.853492] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.855864] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.859512] [001/133] (960s left) gem_set_tiling_vs_pwrite
[61.001557] [002/133] (960s left) gem_mmap_gtt (fault-concurrent-x)
[61.057478] Subtest fault-concurrent-X: SKIP (0.000s)
[61.118836] [003/133] (960s left) gem_flink_basic (bad-flink)
[61.176886] Starting subtest: bad-flink
[61.178929] Subtest bad-flink: SUCCESS (0.000s)
[61.285151] [004/133] (960s left) kms_hdr (bpc-switch)
[61.398815] Starting subtest: bpc-switch
[62.486444] Starting dynamic subtest: pipe-A-eDP-1
[65.996529] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.510s)
[65.998822] Subtest bpc-switch: SUCCESS (4.600s)
[66.117814] [005/133] (955s left) syncobj_wait (wait-any-interrupted)
[66.182246] Starting subtest: wait-any-interrupted
[66.289910] Subtest wait-any-interrupted: SUCCESS (0.107s)
[66.375016] [006/133] (955s left) gem_ctx_param (invalid-set-ringsize)
[66.434926] Starting subtest: invalid-set-ringsize
[66.437315] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[66.504584] [007/133] (955s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[66.598412] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[66.600681] Starting dynamic subtest: pipe-A-eDP-1
[83.065377] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.471s)
[83.074136] Starting dynamic subtest: pipe-B-eDP-1
[100.237918] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.168s)
[100.240419] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.641s)
[101.113209] [008/133] (920s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[101.218416] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[101.222998] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[102.350365] [009/133] (919s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[102.438084] Starting subtest: plane-all-transition-nonblocking-fencing
[102.440584] Starting dynamic subtest: pipe-A-eDP-1
[104.934472] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[105.248605] Starting dynamic subtest: pipe-B-eDP-1
[108.489269] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.247s)
[108.786499] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.347s)
[109.614082] [010/133] (912s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[109.738356] Starting subtest: cursorB-vs-flipB-legacy
[109.743020] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[109.881865] [011/133] (911s left) kms_sequence (get-idle)
[109.967128] Starting subtest: get-idle
[109.969439] Starting dynamic subtest: pipe-A-eDP-1
[111.766991] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.799s)
[111.774130] Starting dynamic subtest: pipe-B-eDP-1
[114.289765] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.521s)
[114.298180] Starting dynamic subtest: pipe-C-eDP-1
[116.709723] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.420s)
[116.722801] Starting dynamic subtest: pipe-D-eDP-1
[119.144357] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.434s)
[119.146653] Subtest get-idle: SUCCESS (9.179s)
[119.961871] [012/133] (901s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[120.061065] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[120.877993] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.818s)
[121.086490] [013/133] (900s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[121.149203] Starting subtest: etime-single-wait-all-available-unsubmitted
[121.257100] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.107s)
[121.329183] [014/133] (900s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[121.392715] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[121.397748] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[121.599274] [015/133] (900s left) kms_pipe_crc_basic (suspend-read-crc)
[121.703816] Starting subtest: suspend-read-crc
[121.705712] Starting dynamic subtest: pipe-A-eDP-1
[140.157721] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.128s)
[140.167214] Starting dynamic subtest: pipe-B-eDP-1
[159.187571] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.608s)
[159.197003] Starting dynamic subtest: pipe-C-eDP-1
[178.126922] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.511s)
[178.136319] Starting dynamic subtest: pipe-D-eDP-1
[197.113533] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.464s)
[197.115866] Subtest suspend-read-crc: SUCCESS (13.715s)
[207.953778] [016/133] (823s left) kms_scaling_modes (scaling-mode-center)
[208.065589] Starting subtest: scaling-mode-center
[208.067975] Starting dynamic subtest: pipe-A-eDP-1
[208.162263] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.098s)
[208.171602] Starting dynamic subtest: pipe-B-eDP-1
[209.360927] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.198s)
[209.372986] Starting dynamic subtest: pipe-C-eDP-1
[210.578197] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.216s)
[210.588381] Starting dynamic subtest: pipe-D-eDP-1
[211.687695] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.108s)
[211.690000] Subtest scaling-mode-center: SUCCESS (3.626s)
[212.861982] [017/133] (819s left) kms_addfb_basic (basic-x-tiled-legacy)
[212.918835] Starting subtest: basic-x-tiled-legacy
[212.923094] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[213.058387] [018/133] (818s left) gen9_exec_parse (basic-rejected-ctx-param)
[213.115001] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[213.191936] [019/133] (818s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[213.286390] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[213.290706] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[213.356910] [020/133] (818s left) gem_exec_whisper (basic-fds-forked-all)
[213.423693] Starting subtest: basic-fds-forked-all
[233.734061] Subtest basic-fds-forked-all: SUCCESS (20.311s)
[233.917761] [021/133] (798s left) kms_flip (bo-too-big)
[234.007716] Starting subtest: bo-too-big
[234.009870] Starting dynamic subtest: A-eDP1
[235.301415] Dynamic subtest A-eDP1: SUCCESS (1.295s)
[235.314442] Starting dynamic subtest: B-eDP1
[236.628579] Dynamic subtest B-eDP1: SUCCESS (1.324s)
[236.641060] Starting dynamic subtest: C-eDP1
[237.961111] Dynamic subtest C-eDP1: SUCCESS (1.331s)
[237.971530] Starting dynamic subtest: D-eDP1
[239.298357] Dynamic subtest D-eDP1: SUCCESS (1.336s)
[239.300824] Subtest bo-too-big: SUCCESS (5.297s)
[240.494366] [022/133] (791s left) syncobj_timeline (wait-any-complex)
[240.553332] Starting subtest: wait-any-complex
[240.614418] Subtest wait-any-complex: SUCCESS (0.062s)
[240.687471] [023/133] (791s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[240.781504] Starting subtest: y-tiled-64bpp-rotate-90
[240.785762] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[240.892534] [024/133] (791s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[240.954805] Starting subtest: yf-tiled-ccs-to-x-tiled
[240.959645] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[241.136868] [025/133] (791s left) syncobj_basic (bad-create-flags)
[241.192070] Starting subtest: bad-create-flags
[241.193950] Subtest bad-create-flags: SUCCESS (0.000s)
[241.278858] [026/133] (791s left) gem_mmap_wc (write-read)
[241.331983] Subtest write-read: SKIP (0.000s)
[241.389441] [027/133] (790s left) kms_vblank (query-forked)
[241.482095] Starting subtest: query-forked
[241.484251] Starting dynamic subtest: pipe-A-eDP-1
[243.305690] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.822s)
[243.319388] Starting dynamic subtest: pipe-D-eDP-1
[245.810255] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.503s)
[245.812497] Subtest query-forked: SUCCESS (4.329s)
[246.661254] [028/133] (785s left) sw_sync (sync_random_merge)
[246.695118] Starting subtest: sync_random_merge
[246.735964] Subtest sync_random_merge: SUCCESS (0.045s)
[246.793243] [029/133] (785s left) gem_exec_reloc (basic-write-wc-active)
[246.843776] Subtest basic-write-wc-active: SKIP (0.000s)
[246.906842] [030/133] (785s left) kms_plane (plane-panning-top-left)
[246.994051] Starting subtest: plane-panning-top-left
[246.996264] Starting dynamic subtest: pipe-A
[248.713844] Dynamic subtest pipe-A: SUCCESS (1.721s)
[248.722605] Starting dynamic subtest: pipe-B
[251.098110] Dynamic subtest pipe-B: SUCCESS (2.383s)
[251.100485] Subtest plane-panning-top-left: SUCCESS (4.106s)
[251.906673] [031/133] (780s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[252.011690] Starting subtest: yf-tiled-64bpp-rotate-270
[252.016278] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[252.098654] [032/133] (780s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[252.198391] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[252.200704] Starting dynamic subtest: pipe-A-eDP-1
[252.293734] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[252.303120] Starting dynamic subtest: pipe-B-eDP-1
[253.483059] Dynamic subtest pipe-B-eDP-1: SKIP (1.187s)
[253.487657] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.290s)
[254.676360] [033/133] (777s left) kms_plane_scaling (planes-scaler-unity-scaling)
[254.767897] Starting subtest: planes-scaler-unity-scaling
[254.770175] Starting dynamic subtest: pipe-A
[254.830275] Dynamic subtest pipe-A: SUCCESS (0.064s)
[254.839108] Starting dynamic subtest: pipe-B
[256.006457] Dynamic subtest pipe-B: SUCCESS (1.175s)
[256.014864] Starting dynamic subtest: pipe-C
[257.126969] Dynamic subtest pipe-C: SUCCESS (1.119s)
[257.135483] Starting dynamic subtest: pipe-D
[258.271166] Dynamic subtest pipe-D: SUCCESS (1.143s)
[258.273298] Subtest planes-scaler-unity-scaling: SUCCESS (3.506s)
[259.422183] [034/133] (773s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[259.536337] Starting subtest: basic-flip-after-cursor-varying-size
[260.462272] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.923s)
[261.258523] [035/133] (771s left) prime_vgem (basic-read)
[261.434342] Starting subtest: basic-read
[261.442498] Subtest basic-read: SKIP (0.006s)
[261.547716] [FACT prime_vgem (basic-read)] new: kernel.kmod_is_loaded.vgem: true
[261.551242] [036/133] (771s left) gem_wait (invalid-buf)
[261.608060] Starting subtest: invalid-buf
[261.610336] Subtest invalid-buf: SUCCESS (0.000s)
[261.809658] [037/133] (770s left) gem_exec_params (cliprects_ptr-dirt)
[261.867222] Starting subtest: cliprects_ptr-dirt
[261.869409] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[261.963643] [038/133] (770s left) gem_exec_schedule (u-fairslice-all)
[262.040431] Starting subtest: u-fairslice-all
[264.092763] Subtest u-fairslice-all: SUCCESS (2.058s)
[265.674299] [039/133] (767s left) gem_exec_schedule (preempt-queue-chain)
[265.747082] Subtest preempt-queue-chain: SKIP (0.000s)
[266.034744] [040/133] (766s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[266.144325] Starting subtest: fbcpsr-tiling-linear
[272.823233] Subtest fbcpsr-tiling-linear: SUCCESS (6.681s)
[272.960259] [041/133] (759s left) syncobj_wait (single-wait-all-for-submit-submitted)
[273.011697] Starting subtest: single-wait-all-for-submit-submitted
[273.117845] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.107s)
[273.196896] [042/133] (759s left) gem_exec_reloc (basic-wc-gtt-active)
[273.257535] Subtest basic-wc-gtt-active: SKIP (0.000s)
[273.335861] [043/133] (759s left) prime_self_import (basic-llseek-bad)
[273.369909] Starting subtest: basic-llseek-bad
[273.395865] Subtest basic-llseek-bad: SUCCESS (0.025s)
[273.505007] [044/133] (759s left) i915_query (query-regions-garbage-items)
[273.553166] Starting subtest: query-regions-garbage-items
[273.555030] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[273.636704] [045/133] (759s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[273.740626] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[273.744922] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[273.838691] [046/133] (759s left) syncobj_wait (multi-wait-all-submitted)
[273.902905] Starting subtest: multi-wait-all-submitted
[274.006676] Subtest multi-wait-all-submitted: SUCCESS (0.103s)
[274.082542] [047/133] (759s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[274.173509] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[274.177496] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[274.244801] [048/133] (758s left) gem_softpin (safe-alignment)
[274.296451] Starting subtest: safe-alignment
[274.320016] Subtest safe-alignment: SUCCESS (0.023s)
[275.641274] [049/133] (757s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[275.747129] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[275.751141] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[275.841523] [050/133] (757s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[276.369005] Starting subtest: syncobj-timeline-multiple-ext-nodes
[276.375604] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.005s)
[277.682429] [051/133] (755s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[277.797733] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[277.802261] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[277.892691] [052/133] (755s left) gem_readwrite (read-bad-handle)
[277.955378] Subtest read-bad-handle: SKIP (0.000s)
[278.020588] [053/133] (755s left) perf_pmu (busy-idle-check-all)
[278.066671] Starting subtest: busy-idle-check-all
[278.068560] Starting dynamic subtest: rcs0
[278.726413] Dynamic subtest rcs0: SUCCESS (0.662s)
[278.737726] Starting dynamic subtest: bcs0
[279.377186] Dynamic subtest bcs0: SUCCESS (0.649s)
[279.388720] Starting dynamic subtest: vcs0
[280.594246] Dynamic subtest vcs0: SUCCESS (1.213s)
[280.606548] Starting dynamic subtest: vcs1
[282.578845] Dynamic subtest vcs1: SUCCESS (1.980s)
[282.590437] Starting dynamic subtest: vecs0
[284.562554] Dynamic subtest vecs0: SUCCESS (1.981s)
[284.575339] Starting dynamic subtest: ccs0
[285.218199] Dynamic subtest ccs0: SUCCESS (0.654s)
[285.220611] Subtest busy-idle-check-all: SUCCESS (7.155s)
[285.310510] [054/133] (748s left) prime_busy (hang)
[285.360581] Starting subtest: hang
[285.362951] Starting dynamic subtest: rcs0
[311.147534] Dynamic subtest rcs0: SUCCESS (25.783s)
[311.156082] Starting dynamic subtest: bcs0
[318.241667] Dynamic subtest bcs0: SUCCESS (7.093s)
[318.250407] Starting dynamic subtest: vcs0
[325.281156] Dynamic subtest vcs0: SUCCESS (7.040s)
[325.289951] Starting dynamic subtest: vcs1
[332.254822] Dynamic subtest vcs1: SUCCESS (6.971s)
[332.263827] Starting dynamic subtest: vecs0
[339.227490] Dynamic subtest vecs0: SUCCESS (6.975s)
[339.238563] Starting dynamic subtest: ccs0
[353.131655] Dynamic subtest ccs0: SUCCESS (13.900s)
[353.134430] Subtest hang: SUCCESS (67.771s)
[353.244087] [055/133] (680s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[353.356064] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[358.361508] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (5.009s)
[359.496965] [056/133] (674s left) kms_vrr (seamless-rr-switch-vrr)
[359.592680] Starting subtest: seamless-rr-switch-vrr
[359.599296] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[359.666252] [057/133] (673s left) kms_big_fb (linear-16bpp-rotate-0)
[359.761035] Starting subtest: linear-16bpp-rotate-0
[361.174123] Subtest linear-16bpp-rotate-0: SUCCESS (1.413s)
[361.295608] [058/133] (672s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[361.389891] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[368.210123] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.822s)
[368.358059] [059/133] (665s left) syncobj_timeline (invalid-transfer-illegal-handle)
[368.420402] Starting subtest: invalid-transfer-illegal-handle
[368.422688] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[368.542647] [060/133] (665s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[368.644566] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[368.648711] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[368.757612] [061/133] (664s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[368.868552] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[373.439083] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.574s)
[374.632392] [062/133] (659s left) kms_psr (fbc-psr2-cursor-blt)
[374.727967] Starting subtest: fbc-psr2-cursor-blt
[374.730235] Starting dynamic subtest: eDP-1
[374.734522] Dynamic subtest eDP-1: SKIP (0.000s)
[374.738917] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[374.802232] [063/133] (659s left) prime_vgem (fence-write-hang)
[374.898554] Subtest fence-write-hang: SKIP (0.000s)
[374.995315] [064/133] (658s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[375.048813] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[375.051141] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[375.144213] [065/133] (658s left) gem_userptr_blits (mmap-offset-banned)
[375.208991] Starting subtest: mmap-offset-banned
[375.211221] Starting dynamic subtest: wb
[375.217847] Dynamic subtest wb: SUCCESS (0.000s)
[375.227018] Starting dynamic subtest: wc
[375.228874] Dynamic subtest wc: SUCCESS (0.000s)
[375.238419] Starting dynamic subtest: uc
[375.240386] Dynamic subtest uc: SUCCESS (0.000s)
[375.242298] Subtest mmap-offset-banned: SUCCESS (0.004s)
[375.338379] [066/133] (658s left) perf_pmu (interrupts)
[375.380038] Starting subtest: interrupts
[376.448246] Subtest interrupts: SUCCESS (1.067s)
[376.556408] [067/133] (657s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[376.615503] Subtest writes-after-reads-uncached: SKIP (0.000s)
[376.698146] [068/133] (657s left) i915_drm_fdinfo (virtual-busy-idle)
[376.738090] Starting subtest: virtual-busy-idle
[376.742577] Subtest virtual-busy-idle: SKIP (0.000s)
[376.801536] [069/133] (657s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[376.892805] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[376.895061] Starting dynamic subtest: pipe-A-eDP-1
[376.917327] Dynamic subtest pipe-A-eDP-1: SKIP (0.002s)
[376.929217] Starting dynamic subtest: pipe-B-eDP-1
[376.950755] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[376.959842] Starting dynamic subtest: pipe-C-eDP-1
[376.981124] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[376.989749] Starting dynamic subtest: pipe-D-eDP-1
[377.011574] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[377.015613] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.008s)
[379.179686] [070/133] (654s left) syncobj_eventfd (invalid-bad-flags)
[379.234615] Starting subtest: invalid-bad-flags
[379.236767] Subtest invalid-bad-flags: SUCCESS (0.000s)
[379.323906] [071/133] (654s left) gem_userptr_blits (sync-unmap-cycles)
[379.391431] Starting subtest: sync-unmap-cycles
[384.762602] Subtest sync-unmap-cycles: SUCCESS (5.372s)
[384.886541] [072/133] (649s left) kms_psr (pr-cursor-plane-move)
[384.986804] Starting subtest: pr-cursor-plane-move
[384.990445] Subtest pr-cursor-plane-move: SKIP (0.000s)
[385.061299] [073/133] (649s left) gem_exec_params (no-vebox)
[385.114848] Starting subtest: no-vebox
[385.119247] Subtest no-vebox: SUCCESS (0.002s)
[386.714098] [074/133] (647s left) kms_atomic (atomic-plane-damage)
[386.803179] Starting subtest: atomic-plane-damage
[386.851846] Starting dynamic subtest: pipe-A-eDP-1
[387.381125] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.529s)
[387.383411] Subtest atomic-plane-damage: SUCCESS (0.578s)
[388.208649] [075/133] (646s left) kms_cursor_crc (cursor-offscreen-64x21)
[388.412409] Starting subtest: cursor-offscreen-64x21
[388.462496] Subtest cursor-offscreen-64x21: SKIP (0.047s)
[388.704880] [076/133] (645s left) kms_addfb_basic (too-wide)
[388.785966] Starting subtest: too-wide
[388.788272] Subtest too-wide: SUCCESS (0.000s)
[388.881291] [077/133] (645s left) gem_ctx_shared (q-promotion)
[388.936965] Starting subtest: Q-promotion
[388.939159] Starting dynamic subtest: rcs0
[389.051836] Dynamic subtest rcs0: SUCCESS (0.115s)
[389.070303] Starting dynamic subtest: vcs0
[389.153675] Dynamic subtest vcs0: SUCCESS (0.101s)
[389.171499] Starting dynamic subtest: vcs1
[389.242556] Dynamic subtest vcs1: SUCCESS (0.087s)
[389.260441] Starting dynamic subtest: vecs0
[389.316566] Dynamic subtest vecs0: SUCCESS (0.073s)
[389.333253] Starting dynamic subtest: ccs0
[389.399528] Dynamic subtest ccs0: SUCCESS (0.082s)
[389.401945] Subtest Q-promotion: SUCCESS (0.465s)
[390.699171] [078/133] (643s left) kms_flip (modeset-vs-vblank-race)
[390.790146] Starting subtest: modeset-vs-vblank-race
[390.792530] Starting dynamic subtest: A-eDP1
[395.522809] Dynamic subtest A-eDP1: SUCCESS (4.730s)
[395.535450] Starting dynamic subtest: B-eDP1
[400.271667] Dynamic subtest B-eDP1: SUCCESS (4.744s)
[400.283600] Starting dynamic subtest: C-eDP1
[404.896253] Dynamic subtest C-eDP1: SUCCESS (4.621s)
[404.905747] Starting dynamic subtest: D-eDP1
[409.550190] Dynamic subtest D-eDP1: SUCCESS (4.651s)
[409.555125] Subtest modeset-vs-vblank-race: SUCCESS (18.759s)
[410.716965] [079/133] (623s left) kms_content_protection (type1)
[410.870212] Starting subtest: type1
[410.874893] Subtest type1: SKIP (0.000s)
[410.982732] [080/133] (623s left) i915_pm_freq_mult (media-freq)
[411.047913] Starting subtest: media-freq
[411.050130] Starting dynamic subtest: gt0
[411.054199] Dynamic subtest gt0: SKIP (0.000s)
[411.064252] Starting dynamic subtest: gt1
[411.068285] Dynamic subtest gt1: SKIP (0.000s)
[411.072337] Subtest media-freq: SKIP (0.003s)
[411.149599] [081/133] (623s left) kms_flip (2x-blocking-wf_vblank)
[411.243340] Starting subtest: 2x-blocking-wf_vblank
[411.252250] Subtest 2x-blocking-wf_vblank: SKIP (0.011s)
[411.332944] [082/133] (623s left) kms_lease (implicit-plane-lease)
[411.418859] Starting subtest: implicit-plane-lease
[411.421160] Subtest implicit-plane-lease: SUCCESS (0.003s)
[411.531485] [083/133] (623s left) gem_mmap_offset (partial-unmap)
[411.588347] Starting subtest: partial-unmap
[411.590577] Starting dynamic subtest: smem0
[412.095858] Dynamic subtest smem0: SUCCESS (0.508s)
[412.098430] Subtest partial-unmap: SUCCESS (0.509s)
[412.225014] [084/133] (622s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[412.289363] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[412.390724] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[412.483644] [085/133] (622s left) kms_psr (psr-cursor-plane-move)
[412.586254] Starting subtest: psr-cursor-plane-move
[412.588549] Starting dynamic subtest: eDP-1
[414.322738] Dynamic subtest eDP-1: SUCCESS (1.735s)
[414.324923] Subtest psr-cursor-plane-move: SUCCESS (1.736s)
[415.196413] [086/133] (619s left) kms_feature_discovery (display-2x)
[415.287609] Starting subtest: display-2x
[415.291947] Subtest display-2x: SKIP (0.000s)
[415.368517] [087/133] (619s left) kms_cursor_edge_walk (128x128-right-edge)
[415.455757] Starting subtest: 128x128-right-edge
[415.458110] Starting dynamic subtest: pipe-A-eDP-1
[418.963717] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.505s)
[418.974031] Starting dynamic subtest: pipe-D-eDP-1
[422.083972] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.120s)
[422.086230] Subtest 128x128-right-edge: SUCCESS (6.628s)
[422.883714] [088/133] (611s left) kms_plane_scaling (2x-scaler-multi-pipe)
[422.982589] Starting subtest: 2x-scaler-multi-pipe
[422.987047] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[423.073679] [089/133] (611s left) gem_pxp (fail-invalid-protected-context)
[423.203045] Starting subtest: fail-invalid-protected-context
[423.205659] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[423.319103] [090/133] (611s left) kms_pm_rpm (modeset-non-lpsp)
[424.865857] Starting subtest: modeset-non-lpsp
[426.023891] Subtest modeset-non-lpsp: SKIP (1.158s)
[426.405868] [091/133] (608s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[426.512664] Starting subtest: fbc-pr-cursor-plane-update-sf
[426.516682] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[426.599076] [092/133] (608s left) kms_joiner (invalid-modeset-force-big-joiner)
[426.703002] Starting subtest: invalid-modeset-force-big-joiner
[426.707240] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[426.770804] [093/133] (608s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[426.865900] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[426.868152] Starting dynamic subtest: pipe-A-eDP-1
[426.891210] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[426.902508] Starting dynamic subtest: pipe-B-eDP-1
[426.923893] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[426.932835] Starting dynamic subtest: pipe-C-eDP-1
[426.953923] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[426.962596] Starting dynamic subtest: pipe-D-eDP-1
[426.984268] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[426.988645] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[429.069572] [094/133] (606s left) gem_mmap_gtt (big-bo-tiledy)
[429.118982] Subtest big-bo-tiledY: SKIP (0.000s)
[429.183053] [095/133] (605s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[429.286640] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[429.290984] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[429.381651] [096/133] (605s left) gem_exec_reloc (basic-wc-read-active)
[429.446722] Subtest basic-wc-read-active: SKIP (0.000s)
[429.516742] [097/133] (605s left) device_reset (unbind-reset-rebind)
[429.569178] Starting subtest: unbind-reset-rebind
[435.780353] Subtest unbind-reset-rebind: SUCCESS (6.204s)
[435.825157] [098/133] (599s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[435.940101] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[435.944066] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[436.042306] [099/133] (599s left) gem_cs_tlb (engines)
[436.102198] Starting subtest: engines
[436.104494] Starting dynamic subtest: rcs0
[438.258462] Dynamic subtest rcs0: SUCCESS (2.152s)
[438.270773] Starting dynamic subtest: bcs0
[440.411655] Dynamic subtest bcs0: SUCCESS (2.151s)
[440.423512] Starting dynamic subtest: vcs0
[442.564351] Dynamic subtest vcs0: SUCCESS (2.151s)
[442.576423] Starting dynamic subtest: vcs1
[444.717537] Dynamic subtest vcs1: SUCCESS (2.152s)
[444.727744] Starting dynamic subtest: vecs0
[446.870813] Dynamic subtest vecs0: SUCCESS (2.151s)
[446.882214] Starting dynamic subtest: ccs0
[449.024660] Dynamic subtest ccs0: SUCCESS (2.152s)
[449.027178] Subtest engines: SUCCESS (12.917s)
[449.139475] [100/133] (586s left) sw_sync (sync_multi_consumer_producer)
[449.183173] Starting subtest: sync_multi_consumer_producer
[449.501503] Subtest sync_multi_consumer_producer: SUCCESS (0.318s)
[449.568616] [101/133] (585s left) kms_busy (extended-pageflip-hang-oldfb)
[449.674822] Starting subtest: extended-pageflip-hang-oldfb
[449.677212] Starting dynamic subtest: pipe-A
[450.130180] Dynamic subtest pipe-A: SUCCESS (0.454s)
[450.141587] Starting dynamic subtest: pipe-D
[451.227582] Dynamic subtest pipe-D: SUCCESS (1.093s)
[451.229909] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.552s)
[452.086960] [102/133] (583s left) sysfs_timeslice_duration (idempotent)
[452.156828] Starting subtest: idempotent
[452.159236] Starting dynamic subtest: vecs0
[452.161718] Dynamic subtest vecs0: SUCCESS (0.002s)
[452.174840] Starting dynamic subtest: ccs0
[452.176964] Dynamic subtest ccs0: SUCCESS (0.001s)
[452.186397] Starting dynamic subtest: vcs0
[452.188535] Dynamic subtest vcs0: SUCCESS (0.001s)
[452.197737] Starting dynamic subtest: bcs0
[452.199934] Dynamic subtest bcs0: SUCCESS (0.001s)
[452.209551] Starting dynamic subtest: rcs0
[452.211712] Dynamic subtest rcs0: SUCCESS (0.000s)
[452.221034] Starting dynamic subtest: vcs1
[452.222930] Dynamic subtest vcs1: SUCCESS (0.000s)
[452.224804] Subtest idempotent: SUCCESS (0.014s)
[452.281587] [103/133] (583s left) kms_color (ctm-blue-to-red)
[452.375058] Starting subtest: ctm-blue-to-red
[452.376945] Starting dynamic subtest: pipe-A-eDP-1
[453.074163] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.698s)
[453.084663] Starting dynamic subtest: pipe-B-eDP-1
[454.492815] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.419s)
[454.503247] Starting dynamic subtest: pipe-C-eDP-1
[455.868058] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.375s)
[455.878480] Starting dynamic subtest: pipe-D-eDP-1
[457.205350] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.334s)
[457.207241] Subtest ctm-blue-to-red: SUCCESS (4.830s)
[458.015062] [104/133] (577s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[458.116010] Starting subtest: fbc-psr2-sprite-mmap-cpu
[458.118262] Starting dynamic subtest: eDP-1
[458.122343] Dynamic subtest eDP-1: SKIP (0.000s)
[458.126583] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[458.193297] [105/133] (577s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[458.291949] Starting subtest: primary-y-tiled-reflect-x-0
[458.352709] Subtest primary-y-tiled-reflect-x-0: SKIP (0.060s)
[458.457053] [106/133] (577s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[458.562988] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[458.567021] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[458.636193] [107/133] (577s left) gem_exec_params (mmapped)
[458.703344] Starting subtest: mmapped
[458.708258] Subtest mmapped: SUCCESS (0.003s)
[458.845036] [108/133] (576s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[458.947362] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[464.288370] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.343s)
[465.430372] [109/133] (570s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[465.543647] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[465.548042] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[465.666622] [110/133] (570s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[465.772210] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[465.774593] Starting dynamic subtest: pipe-A-eDP-1
[465.799783] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[465.810071] Starting dynamic subtest: pipe-B-eDP-1
[465.834026] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[465.843641] Starting dynamic subtest: pipe-C-eDP-1
[465.867628] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[465.876814] Starting dynamic subtest: pipe-D-eDP-1
[465.901023] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[465.905095] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[468.098441] [111/133] (567s left) kms_plane_cursor (viewport)
[468.193784] Starting subtest: viewport
[468.198045] Starting dynamic subtest: pipe-A-eDP-1-size-64
[470.804412] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.610s)
[470.865412] Starting dynamic subtest: pipe-A-eDP-1-size-128
[473.438757] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.582s)
[473.498044] Starting dynamic subtest: pipe-A-eDP-1-size-256
[476.097279] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.606s)
[476.454737] Starting dynamic subtest: pipe-B-eDP-1-size-64
[479.777867] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.334s)
[479.839652] Starting dynamic subtest: pipe-B-eDP-1-size-128
[482.446559] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.617s)
[482.504235] Starting dynamic subtest: pipe-B-eDP-1-size-256
[485.202407] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.705s)
[485.558770] Starting dynamic subtest: pipe-C-eDP-1-size-64
[488.479088] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.932s)
[488.517634] Starting dynamic subtest: pipe-C-eDP-1-size-128
[490.768212] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.259s)
[490.806867] Starting dynamic subtest: pipe-C-eDP-1-size-256
[493.023498] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.225s)
[493.357776] Starting dynamic subtest: pipe-D-eDP-1-size-64
[496.367701] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.022s)
[496.405811] Starting dynamic subtest: pipe-D-eDP-1-size-128
[498.612096] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.214s)
[498.650681] Starting dynamic subtest: pipe-D-eDP-1-size-256
[500.857053] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.214s)
[501.177700] Subtest viewport: SUCCESS (32.981s)
[502.023156] [112/133] (533s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[502.132018] Starting subtest: x-tiled-64bpp-rotate-180
[503.767693] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.637s)
[503.949196] [113/133] (531s left) gem_exec_balancer (bonded-pair)
[504.008140] Starting subtest: bonded-pair
[504.011863] Subtest bonded-pair: SKIP (0.000s)
[504.317315] [114/133] (531s left) api_intel_bb (object-reloc-purge-cache)
[504.375322] Starting subtest: object-reloc-purge-cache
[504.379962] Subtest object-reloc-purge-cache: SKIP (0.003s)
[504.482010] [115/133] (531s left) gem_ccs (block-multicopy-compressed)
[504.544572] Starting subtest: block-multicopy-compressed
[504.548630] Subtest block-multicopy-compressed: SKIP (0.000s)
[504.644093] [116/133] (531s left) gem_ctx_shared (create-shared-gtt)
[504.712605] Starting subtest: create-shared-gtt
[506.866840] Subtest create-shared-gtt: SUCCESS (2.153s)
[507.283607] [117/133] (528s left) gem_exec_whisper (basic-queues-all)
[507.345079] Starting subtest: basic-queues-all
[520.560657] Subtest basic-queues-all: SUCCESS (13.213s)
[520.751646] [118/133] (515s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[520.855674] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[520.857831] Starting dynamic subtest: pipe-A-eDP-1
[520.876498] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s)
[520.886874] Starting dynamic subtest: pipe-B-eDP-1
[520.905301] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[520.915244] Starting dynamic subtest: pipe-C-eDP-1
[520.934162] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.019s)
[520.944085] Starting dynamic subtest: pipe-D-eDP-1
[520.963552] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[520.965710] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.085s)
[523.176813] [119/133] (512s left) kms_atomic_interruptible (universal-setplane-primary)
[523.265842] Starting subtest: universal-setplane-primary
[523.267945] Starting dynamic subtest: pipe-A-eDP-1
[530.726076] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.458s)
[530.728461] Subtest universal-setplane-primary: SUCCESS (7.460s)
[531.556760] [120/133] (504s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[531.655783] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[531.660212] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[531.769131] [121/133] (504s left) kms_cursor_legacy (single-move)
[531.888328] Starting subtest: single-move
[531.890254] Starting dynamic subtest: pipe-A
[537.270407] Dynamic subtest pipe-A: SUCCESS (5.379s)
[537.282306] Starting dynamic subtest: pipe-B
[542.652246] Dynamic subtest pipe-B: SUCCESS (5.379s)
[542.663642] Starting dynamic subtest: pipe-C
[548.035307] Dynamic subtest pipe-C: SUCCESS (5.380s)
[548.046853] Starting dynamic subtest: pipe-D
[553.417827] Dynamic subtest pipe-D: SUCCESS (5.379s)
[553.429620] Starting dynamic subtest: all-pipes
[558.808163] Dynamic subtest all-pipes: SUCCESS (5.387s)
[558.810673] Subtest single-move: SUCCESS (26.918s)
[558.962957] [122/133] (477s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[559.358381] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[560.148728] [123/133] (476s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[560.251702] Starting subtest: fbcpsr-rgb565-draw-render
[567.265448] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.017s)
[567.401472] [124/133] (468s left) gem_tiled_wb
[567.518645] [125/133] (468s left) i915_drm_fdinfo (busy-idle)
[567.563668] Starting subtest: busy-idle
[567.565897] Starting dynamic subtest: rcs0
[567.589597] Dynamic subtest rcs0: SKIP (0.026s)
[567.601542] Starting dynamic subtest: bcs0
[567.605441] Dynamic subtest bcs0: SKIP (0.001s)
[567.615531] Starting dynamic subtest: vcs0
[567.619956] Dynamic subtest vcs0: SKIP (0.000s)
[567.629410] Starting dynamic subtest: vcs1
[567.633730] Dynamic subtest vcs1: SKIP (0.000s)
[567.643715] Starting dynamic subtest: vecs0
[567.647942] Dynamic subtest vecs0: SKIP (0.000s)
[567.656923] Starting dynamic subtest: ccs0
[567.661154] Dynamic subtest ccs0: SKIP (0.000s)
[567.665438] Subtest busy-idle: SKIP (0.034s)
[567.703926] [126/133] (468s left) gem_exec_basic (basic)
[567.753796] Starting subtest: basic
[567.756013] Starting dynamic subtest: rcs0-smem
[567.758117] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[567.768727] Starting dynamic subtest: bcs0-smem
[567.770886] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[567.780202] Starting dynamic subtest: vcs0-smem
[567.782034] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[567.791292] Starting dynamic subtest: vcs1-smem
[567.793093] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[567.802767] Starting dynamic subtest: vecs0-smem
[567.804569] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[567.813406] Starting dynamic subtest: ccs0-smem
[567.815198] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[567.816964] Subtest basic: SUCCESS (0.014s)
[569.681892] [127/133] (466s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[569.786208] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[577.076026] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.292s)
[577.201532] [128/133] (459s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[577.588283] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[578.424840] [129/133] (458s left) kms_pm_dc (dc5-psr)
[579.523967] Starting subtest: dc5-psr
[582.409399] Subtest dc5-psr: SUCCESS (2.885s)
[583.282103] [130/133] (453s left) gem_exec_reloc (basic-cpu)
[583.348406] Subtest basic-cpu: SKIP (0.000s)
[583.418586] [131/133] (453s left) kms_cursor_crc (cursor-random-128x128)
[583.621158] Starting subtest: cursor-random-128x128
[583.623464] Starting dynamic subtest: pipe-A-eDP-1
[586.999597] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.375s)
[587.030700] Starting dynamic subtest: pipe-D-eDP-1
[590.993096] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.972s)
[590.995428] Subtest cursor-random-128x128: SUCCESS (7.374s)
[591.850085] [132/133] (444s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[591.950538] Starting subtest: 4-tiled-32bpp-rotate-0
[593.363225] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.413s)
[593.506883] [133/133] (443s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[593.608577] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[601.081023] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.474s)
[601.221944] Closing watchdogs
results: parsing output: 0/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 1/ for test: gem_mmap_gtt
results: parsing output: 2/ for test: gem_flink_basic
results: parsing output: 3/ for test: kms_hdr
results: parsing output: 4/ for test: syncobj_wait
results: parsing output: 5/ for test: gem_ctx_param
results: parsing output: 6/ for test: kms_psr2_sf
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: kms_atomic_transition
results: parsing output: 9/ for test: kms_cursor_legacy
results: parsing output: 10/ for test: kms_sequence
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: gem_render_copy
results: parsing output: 14/ for test: kms_pipe_crc_basic
results: parsing output: 15/ for test: kms_scaling_modes
results: parsing output: 16/ for test: kms_addfb_basic
results: parsing output: 17/ for test: gen9_exec_parse
results: parsing output: 18/ for test: kms_flip_scaled_crc
results: parsing output: 19/ for test: gem_exec_whisper
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: gem_render_copy
results: parsing output: 24/ for test: syncobj_basic
results: parsing output: 25/ for test: gem_mmap_wc
results: parsing output: 26/ for test: kms_vblank
results: parsing output: 27/ for test: sw_sync
results: parsing output: 28/ for test: gem_exec_reloc
results: parsing output: 29/ for test: kms_plane
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_psr2_sf
results: parsing output: 32/ for test: kms_plane_scaling
results: parsing output: 33/ for test: kms_cursor_legacy
results: parsing output: 34/ for test: prime_vgem
results: parsing output: 35/ for test: gem_wait
results: parsing output: 36/ for test: gem_exec_params
results: parsing output: 37/ for test: gem_exec_schedule
results: parsing output: 38/ for test: gem_exec_schedule
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: syncobj_wait
results: parsing output: 41/ for test: gem_exec_reloc
results: parsing output: 42/ for test: prime_self_import
results: parsing output: 43/ for test: i915_query
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: syncobj_wait
results: parsing output: 46/ for test: kms_plane
results: parsing output: 47/ for test: gem_softpin
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_exec_fence
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_readwrite
results: parsing output: 52/ for test: perf_pmu
results: parsing output: 53/ for test: prime_busy
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_vrr
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_psr
results: parsing output: 62/ for test: prime_vgem
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: gem_userptr_blits
results: parsing output: 65/ for test: perf_pmu
results: parsing output: 66/ for test: gem_partial_pwrite_pread
results: parsing output: 67/ for test: i915_drm_fdinfo
results: parsing output: 68/ for test: kms_ccs
results: parsing output: 69/ for test: syncobj_eventfd
results: parsing output: 70/ for test: gem_userptr_blits
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: gem_exec_params
results: parsing output: 73/ for test: kms_atomic
results: parsing output: 74/ for test: kms_cursor_crc
results: parsing output: 75/ for test: kms_addfb_basic
results: parsing output: 76/ for test: gem_ctx_shared
results: parsing output: 77/ for test: kms_flip
results: parsing output: 78/ for test: kms_content_protection
results: parsing output: 79/ for test: i915_pm_freq_mult
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_lease
results: parsing output: 82/ for test: gem_mmap_offset
results: parsing output: 83/ for test: syncobj_wait
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: kms_feature_discovery
results: parsing output: 86/ for test: kms_cursor_edge_walk
results: parsing output: 87/ for test: kms_plane_scaling
results: parsing output: 88/ for test: gem_pxp
results: parsing output: 89/ for test: kms_pm_rpm
results: parsing output: 90/ for test: kms_psr2_sf
results: parsing output: 91/ for test: kms_joiner
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: gem_mmap_gtt
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_exec_reloc
results: parsing output: 96/ for test: device_reset
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_cs_tlb
results: parsing output: 99/ for test: sw_sync
results: parsing output: 100/ for test: kms_busy
results: parsing output: 101/ for test: sysfs_timeslice_duration
results: parsing output: 102/ for test: kms_color
results: parsing output: 103/ for test: kms_psr
results: parsing output: 104/ for test: kms_rotation_crc
results: parsing output: 105/ for test: kms_flip_scaled_crc
results: parsing output: 106/ for test: gem_exec_params
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: kms_plane_cursor
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: gem_exec_balancer
results: parsing output: 113/ for test: api_intel_bb
results: parsing output: 114/ for test: gem_ccs
results: parsing output: 115/ for test: gem_ctx_shared
results: parsing output: 116/ for test: gem_exec_whisper
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: kms_atomic_interruptible
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_cursor_legacy
results: parsing output: 121/ for test: kms_chamelium_hpd
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_tiled_wb
results: parsing output: 124/ for test: i915_drm_fdinfo
results: parsing output: 125/ for test: gem_exec_basic
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_chamelium_edid
results: parsing output: 128/ for test: kms_pm_dc
results: parsing output: 129/ for test: gem_exec_reloc
results: parsing output: 130/ for test: kms_cursor_crc
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.