[61.828418] Initializing watchdogs
[61.828591]   /dev/watchdog0
[61.843230] [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]
[61.847347] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.850022] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.853171] [001/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[61.986756] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[61.991064] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[62.080210] [002/133] (960s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[62.176171] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[62.180480] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[62.268067] [003/133] (960s left) prime_vgem (coherency-gtt)
[62.397448] Starting subtest: coherency-gtt
[62.401624] Subtest coherency-gtt: SKIP (0.000s)
[62.501781] [FACT prime_vgem (coherency-gtt)] new: kernel.kmod_is_loaded.vgem: true
[62.504835] [004/133] (959s left) gem_exec_whisper (basic-fds-forked)
[62.573722] Starting subtest: basic-fds-forked
[86.644253] Subtest basic-fds-forked: SUCCESS (24.028s)
[86.839467] [005/133] (935s left) gen9_exec_parse (bb-start-param)
[86.909566] Subtest bb-start-param: SKIP (0.000s)
[86.977888] [006/133] (935s left) perf (mi-rpc)
[87.090727] Starting subtest: mi-rpc
[87.094891] Subtest mi-rpc: SKIP (0.000s)
[87.135507] [007/133] (935s left) syncobj_wait (invalid-signal-bad-pad)
[87.188149] Starting subtest: invalid-signal-bad-pad
[87.190358] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[87.275048] [008/133] (935s left) syncobj_timeline (wait-all-for-submit-snapshot)
[87.322814] Starting subtest: wait-all-for-submit-snapshot
[87.403778] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[87.485436] [009/133] (935s left) kms_setmode (basic)
[87.530770] Starting subtest: basic
[87.884830] Starting dynamic subtest: pipe-A-eDP-1
[89.919050] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.028s)
[90.271783] Starting dynamic subtest: pipe-B-eDP-1
[92.347814] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.078s)
[92.663527] Subtest basic: SUCCESS (5.129s)
[93.493716] [010/133] (929s left) gem_ctx_shared (exec-shared-gtt)
[93.566775] Starting subtest: exec-shared-gtt
[93.569049] Starting dynamic subtest: rcs0
[93.573657] Dynamic subtest rcs0: SUCCESS (0.007s)
[93.584170] Starting dynamic subtest: bcs0
[93.586436] Dynamic subtest bcs0: SUCCESS (0.005s)
[93.594325] Starting dynamic subtest: vcs0
[93.596586] Dynamic subtest vcs0: SUCCESS (0.007s)
[93.604069] Starting dynamic subtest: vcs1
[93.606310] Dynamic subtest vcs1: SUCCESS (0.006s)
[93.613269] Starting dynamic subtest: vecs0
[93.615501] Dynamic subtest vecs0: SUCCESS (0.005s)
[93.623133] Starting dynamic subtest: ccs0
[93.625347] Dynamic subtest ccs0: SUCCESS (0.005s)
[93.627524] Subtest exec-shared-gtt: SUCCESS (0.036s)
[93.779714] [011/133] (928s left) kms_pm_backlight (bad-brightness)
[93.877269] Starting subtest: bad-brightness
[93.944732] Starting dynamic subtest: eDP-1
[94.227849] Dynamic subtest eDP-1: SUCCESS (0.283s)
[94.230173] Subtest bad-brightness: SUCCESS (0.352s)
[95.029687] [012/133] (927s left) gem_ctx_param (invalid-get-ringsize)
[95.094911] Starting subtest: invalid-get-ringsize
[95.097281] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[95.210863] [013/133] (927s left) kms_chamelium_color (gamma)
[95.296524] Subtest gamma: SKIP (0.000s)
[95.340749] [014/133] (927s left) gem_exec_create (basic)
[95.394048] Starting subtest: basic
[95.396314] Starting dynamic subtest: smem
[98.901527] Dynamic subtest smem: SUCCESS (3.505s)
[98.903989] Subtest basic: SUCCESS (3.505s)
[99.083894] [015/133] (923s left) gem_flink_basic (flink-lifetime)
[99.141984] Starting subtest: flink-lifetime
[99.144261] Subtest flink-lifetime: SUCCESS (0.002s)
[99.260451] [016/133] (923s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[99.844833] Starting subtest: syncobj-timeline-multiple-ext-nodes
[99.850804] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.005s)
[100.933355] [017/133] (922s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[101.037134] Starting subtest: plane-all-modeset-transition-internal-panels
[101.039395] Starting dynamic subtest: pipe-A-eDP-1
[102.384046] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.346s)
[102.665880] Starting dynamic subtest: pipe-B-eDP-1
[103.705056] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.046s)
[103.971686] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.935s)
[104.807027] [018/133] (918s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[104.904895] Starting subtest: bo-too-small-due-to-tiling
[104.909034] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[105.003436] [019/133] (918s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[105.103866] Starting subtest: 4-tiled-32bpp-rotate-0
[106.438782] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.336s)
[106.597826] [020/133] (916s left) gem_media_fill (media-fill)
[106.674798] Subtest media-fill: SKIP (0.000s)
[106.797911] [021/133] (916s left) kms_psr (fbc-pr-no-drrs)
[106.886565] Starting subtest: fbc-pr-no-drrs
[106.890173] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[106.975879] [022/133] (916s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[107.066832] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[107.070150] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[107.169181] [023/133] (916s left) dumb_buffer (create-clear)
[107.222860] Starting subtest: create-clear
[142.104560] Subtest create-clear: SUCCESS (34.874s)
[142.192887] [024/133] (881s left) vgem_basic (bad-pad)
[142.238590] Starting subtest: bad-pad
[142.241031] Subtest bad-pad: SUCCESS (0.000s)
[142.292820] [025/133] (881s left) gem_fence_thrash (bo-write-verify-none)
[142.322321] Starting subtest: bo-write-verify-none
[142.341541] Subtest bo-write-verify-none: SKIP (0.019s)
[142.397813] [026/133] (880s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[142.502437] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[149.213651] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.715s)
[149.320358] [027/133] (874s left) kms_async_flips (test-time-stamp)
[149.413080] Starting subtest: test-time-stamp
[149.802603] Starting dynamic subtest: pipe-A-eDP-1
[150.629102] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.824s)
[151.025692] Starting dynamic subtest: pipe-B-eDP-1
[151.781693] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.761s)
[152.145740] Starting dynamic subtest: pipe-C-eDP-1
[152.908919] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.768s)
[153.271852] Starting dynamic subtest: pipe-D-eDP-1
[154.039207] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.772s)
[154.041667] Subtest test-time-stamp: SUCCESS (4.626s)
[155.199704] [028/133] (868s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[155.294964] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[155.297167] Starting dynamic subtest: pipe-A-eDP-1
[155.319610] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[155.329937] Starting dynamic subtest: pipe-B-eDP-1
[155.351201] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[155.358511] Starting dynamic subtest: pipe-C-eDP-1
[155.379413] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[155.386685] Starting dynamic subtest: pipe-D-eDP-1
[155.407664] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[155.411581] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.004s)
[157.567212] [029/133] (865s left) vgem_basic (dmabuf-fence-before)
[157.621618] Starting subtest: dmabuf-fence-before
[157.623626] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[157.676694] [030/133] (865s left) kms_cursor_edge_walk (64x64-left-edge)
[157.762921] Starting subtest: 64x64-left-edge
[157.765121] Starting dynamic subtest: pipe-A-eDP-1
[161.239380] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.476s)
[161.248960] Starting dynamic subtest: pipe-D-eDP-1
[164.369796] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.130s)
[164.372127] Subtest 64x64-left-edge: SUCCESS (6.607s)
[165.196712] [031/133] (858s left) gem_ringfill (basic-all)
[170.904800] Starting subtest: basic-all
[172.079090] Subtest basic-all: SUCCESS (1.174s)
[172.217525] [032/133] (851s left) gem_mmap_gtt (zero-extend)
[172.270613] Subtest zero-extend: SKIP (0.000s)
[172.329295] [033/133] (851s left) gem_partial_pwrite_pread (write-display)
[172.391310] Subtest write-display: SKIP (0.000s)
[172.456168] [034/133] (851s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[172.549159] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[172.553491] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[172.622840] [035/133] (851s left) syncobj_timeline (signal)
[172.689188] Starting subtest: signal
[172.691515] Subtest signal: SUCCESS (0.000s)
[172.808610] [036/133] (851s left) kms_draw_crc (draw-method-mmap-gtt)
[172.900638] Starting subtest: draw-method-mmap-gtt
[172.904991] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[172.984812] [037/133] (850s left) gem_lmem_swapping (parallel-multi)
[173.026223] Subtest parallel-multi: SKIP (0.000s)
[173.065257] [038/133] (850s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[173.164254] Starting subtest: x-tiled-32bpp-rotate-0
[174.623190] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.458s)
[174.743374] [039/133] (849s left) syncobj_wait (multi-wait-submitted-signaled)
[174.798375] Starting subtest: multi-wait-submitted-signaled
[174.800418] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[174.905384] [040/133] (849s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[175.024165] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[175.027946] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[175.129018] [041/133] (848s left) gem_ctx_persistence (many-contexts)
[175.191793] Starting subtest: many-contexts
[220.358390] Subtest many-contexts: SUCCESS (45.164s)
[220.440299] [042/133] (803s left) gem_exec_schedule (pi-ringfull)
[220.629328] Starting subtest: pi-ringfull
[220.631383] Starting dynamic subtest: rcs0
[220.663672] Dynamic subtest rcs0: SUCCESS (0.037s)
[220.672250] Starting dynamic subtest: bcs0
[220.703602] Dynamic subtest bcs0: SUCCESS (0.039s)
[220.711562] Starting dynamic subtest: vcs0
[220.738059] Dynamic subtest vcs0: SUCCESS (0.034s)
[220.745614] Starting dynamic subtest: vcs1
[220.770056] Dynamic subtest vcs1: SUCCESS (0.031s)
[220.777569] Starting dynamic subtest: vecs0
[220.801939] Dynamic subtest vecs0: SUCCESS (0.032s)
[220.809410] Starting dynamic subtest: ccs0
[220.830649] Dynamic subtest ccs0: SUCCESS (0.028s)
[220.832775] Subtest pi-ringfull: SUCCESS (0.205s)
[221.059545] [043/133] (803s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[221.161680] Starting subtest: extended-pageflip-modeset-hang-oldfb
[221.163794] Starting dynamic subtest: pipe-A
[229.048809] Dynamic subtest pipe-A: SUCCESS (7.885s)
[229.058062] Starting dynamic subtest: pipe-D
[237.670126] Dynamic subtest pipe-D: SUCCESS (8.620s)
[237.672520] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.508s)
[238.512642] [044/133] (785s left) kms_cursor_crc (cursor-random-256x256)
[238.745996] Starting subtest: cursor-random-256x256
[238.753565] Starting dynamic subtest: pipe-A-eDP-1
[242.108889] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.354s)
[242.144286] Starting dynamic subtest: pipe-D-eDP-1
[246.108443] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.978s)
[246.110460] Subtest cursor-random-256x256: SUCCESS (7.359s)
[246.984239] [045/133] (777s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[247.084021] Starting subtest: async-flip-with-page-flip-events-linear
[247.465059] Starting dynamic subtest: pipe-A-eDP-1
[250.250570] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.785s)
[250.616958] Starting dynamic subtest: pipe-B-eDP-1
[253.385861] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.778s)
[253.746252] Starting dynamic subtest: pipe-C-eDP-1
[256.522351] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.780s)
[256.884600] Starting dynamic subtest: pipe-D-eDP-1
[259.658859] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.781s)
[259.661809] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.575s)
[260.861305] [046/133] (763s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[260.954607] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[260.958762] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[261.073904] [047/133] (763s left) kms_universal_plane (universal-plane-functional)
[261.177365] Starting subtest: universal-plane-functional
[261.179664] Starting dynamic subtest: pipe-A-eDP-1
[265.184768] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.008s)
[265.196801] Starting dynamic subtest: pipe-B-eDP-1
[269.762068] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.576s)
[269.770906] Starting dynamic subtest: pipe-C-eDP-1
[274.163880] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.398s)
[274.173066] Starting dynamic subtest: pipe-D-eDP-1
[278.544690] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.378s)
[278.547056] Subtest universal-plane-functional: SUCCESS (17.365s)
[279.411187] [048/133] (744s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[279.517448] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[279.521516] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[279.612646] [049/133] (744s left) gem_pxp (reject-modify-context-protection-on)
[279.741095] Starting subtest: reject-modify-context-protection-on
[279.743330] Subtest reject-modify-context-protection-on: SUCCESS (0.001s)
[279.850584] [050/133] (744s left) perf_pmu (render-node-busy-idle)
[279.915037] Starting subtest: render-node-busy-idle
[279.917438] Starting dynamic subtest: rcs0
[280.593706] Dynamic subtest rcs0: SUCCESS (0.678s)
[280.604111] Starting dynamic subtest: bcs0
[281.259427] Dynamic subtest bcs0: SUCCESS (0.663s)
[281.270695] Starting dynamic subtest: vcs0
[282.901416] Dynamic subtest vcs0: SUCCESS (1.638s)
[282.911770] Starting dynamic subtest: vcs1
[284.885479] Dynamic subtest vcs1: SUCCESS (1.981s)
[284.896617] Starting dynamic subtest: vecs0
[286.934565] Dynamic subtest vecs0: SUCCESS (2.046s)
[286.944889] Starting dynamic subtest: ccs0
[287.600912] Dynamic subtest ccs0: SUCCESS (0.665s)
[287.603583] Subtest render-node-busy-idle: SUCCESS (7.686s)
[287.690056] [051/133] (736s left) gem_readwrite (write-bad-handle)
[287.761253] Subtest write-bad-handle: SKIP (0.000s)
[287.827321] [052/133] (736s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[287.882130] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[287.986429] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[288.064121] [053/133] (736s left) syncobj_timeline (invalid-wait-illegal-handle)
[288.116244] Starting subtest: invalid-wait-illegal-handle
[288.118552] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[288.206773] [054/133] (736s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[288.318089] Starting subtest: yf-tiled-16bpp-rotate-0
[288.322337] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[288.417278] [055/133] (736s left) gem_softpin (safe-alignment)
[288.468367] Starting subtest: safe-alignment
[288.490225] Subtest safe-alignment: SUCCESS (0.022s)
[289.913949] [056/133] (734s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[290.014964] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[290.019160] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[290.119392] [057/133] (734s left) gem_userptr_blits (create-destroy-unsync)
[290.198379] Subtest create-destroy-unsync: SKIP (0.000s)
[290.307485] [058/133] (734s left) api_intel_bb (object-noreloc-keep-cache-simple)
[290.365531] Starting subtest: object-noreloc-keep-cache-simple
[290.368283] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.005s)
[290.489661] [059/133] (734s left) gem_exec_params (dr4-dirt)
[290.546950] Starting subtest: DR4-dirt
[290.549276] Subtest DR4-dirt: SUCCESS (0.000s)
[290.657646] [060/133] (734s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[290.751249] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[290.755316] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[290.857309] [061/133] (733s left) i915_pm_rps (fence-order)
[290.920280] Starting subtest: fence-order
[293.838282] Subtest fence-order: SUCCESS (2.914s)
[293.957150] [062/133] (730s left) gem_exec_fence (expired-history)
[294.421828] Starting subtest: expired-history
[301.603790] Subtest expired-history: SUCCESS (7.182s)
[303.250931] [063/133] (721s left) kms_psr (pr-cursor-plane-onoff)
[303.342780] Starting subtest: pr-cursor-plane-onoff
[303.346968] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[303.414972] [064/133] (721s left) kms_psr (psr2-cursor-render)
[303.511090] Starting subtest: psr2-cursor-render
[303.513293] Starting dynamic subtest: eDP-1
[305.200709] Dynamic subtest eDP-1: SUCCESS (1.691s)
[305.203034] Subtest psr2-cursor-render: SUCCESS (1.692s)
[306.000407] [065/133] (718s left) gen9_exec_parse (shadow-peek)
[306.063018] Subtest shadow-peek: SKIP (0.000s)
[306.143295] [066/133] (718s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[306.246750] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[313.063697] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.819s)
[313.229900] [067/133] (711s left) gem_exec_reloc (basic-concurrent16)
[313.296086] Subtest basic-concurrent16: SKIP (0.000s)
[313.369162] [068/133] (711s left) kms_frontbuffer_tracking (fbc-2p-rte)
[313.456550] Starting subtest: fbc-2p-rte
[313.460942] Subtest fbc-2p-rte: SKIP (0.000s)
[313.553040] [069/133] (711s left) gem_unfence_active_buffers
[313.711793] [070/133] (711s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[313.795176] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[313.797770] Starting dynamic subtest: pipe-A-eDP-1
[313.820683] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[313.832510] Starting dynamic subtest: pipe-B-eDP-1
[313.853843] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[313.861531] Starting dynamic subtest: pipe-C-eDP-1
[313.882918] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[313.890493] Starting dynamic subtest: pipe-D-eDP-1
[313.913244] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[313.917749] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[316.098585] [071/133] (709s left) gem_wait (wait)
[316.182741] Starting subtest: wait
[316.185142] Starting dynamic subtest: all-engines
[317.910596] Dynamic subtest all-engines: SUCCESS (1.725s)
[317.921826] Starting dynamic subtest: rcs0
[318.957310] Dynamic subtest rcs0: SUCCESS (1.045s)
[318.968170] Starting dynamic subtest: bcs0
[320.003052] Dynamic subtest bcs0: SUCCESS (1.044s)
[320.013691] Starting dynamic subtest: vcs0
[321.047525] Dynamic subtest vcs0: SUCCESS (1.042s)
[321.063795] Starting dynamic subtest: vcs1
[322.092620] Dynamic subtest vcs1: SUCCESS (1.043s)
[322.104344] Starting dynamic subtest: vecs0
[323.137736] Dynamic subtest vecs0: SUCCESS (1.043s)
[323.147916] Starting dynamic subtest: ccs0
[324.185069] Dynamic subtest ccs0: SUCCESS (1.045s)
[324.187574] Subtest wait: SUCCESS (8.003s)
[324.382965] [072/133] (700s left) kms_pm_rpm (cursor)
[326.110267] Starting subtest: cursor
[326.115300] Subtest cursor: SKIP (0.000s)
[326.623749] [073/133] (698s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[326.707365] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[326.709678] Starting dynamic subtest: pipe-A-eDP-1
[326.729761] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[326.739969] Starting dynamic subtest: pipe-B-eDP-1
[326.758667] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[326.766488] Starting dynamic subtest: pipe-C-eDP-1
[326.786482] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[326.795443] Starting dynamic subtest: pipe-D-eDP-1
[326.814340] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[326.816537] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[328.889625] [074/133] (696s left) i915_hangman (gt-error-state-capture)
[328.958734] Starting subtest: gt-error-state-capture
[328.960940] Starting dynamic subtest: rcs0
[340.852915] Dynamic subtest rcs0: SUCCESS (11.893s)
[340.864963] Starting dynamic subtest: bcs0
[352.884694] Dynamic subtest bcs0: SUCCESS (12.027s)
[352.896458] Starting dynamic subtest: vcs0
[364.852671] Dynamic subtest vcs0: SUCCESS (11.964s)
[364.864382] Starting dynamic subtest: vcs1
[376.820604] Dynamic subtest vcs1: SUCCESS (11.964s)
[376.832637] Starting dynamic subtest: vecs0
[387.829841] Dynamic subtest vecs0: SUCCESS (11.005s)
[387.844937] Starting dynamic subtest: ccs0
[399.860657] Dynamic subtest ccs0: SUCCESS (12.027s)
[399.863509] Subtest gt-error-state-capture: SUCCESS (70.899s)
[399.945296] [075/133] (625s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[400.046227] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[400.050149] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[400.144425] [076/133] (625s left) kms_pm_rpm (modeset-pc8-residency-stress)
[402.067059] Starting subtest: modeset-pc8-residency-stress
[402.071946] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[402.438176] [077/133] (623s left) kms_plane (plane-panning-bottom-right)
[402.536711] Starting subtest: plane-panning-bottom-right
[402.539186] Starting dynamic subtest: pipe-A
[404.166665] Dynamic subtest pipe-A: SUCCESS (1.632s)
[404.175819] Starting dynamic subtest: pipe-B
[406.445806] Dynamic subtest pipe-B: SUCCESS (2.277s)
[406.448077] Subtest plane-panning-bottom-right: SUCCESS (3.913s)
[407.258933] [078/133] (618s left) kms_flip (absolute-wf_vblank)
[407.356459] Starting subtest: absolute-wf_vblank
[407.358464] Starting dynamic subtest: A-eDP1
[416.098951] Dynamic subtest A-eDP1: SUCCESS (8.743s)
[416.107731] Starting dynamic subtest: B-eDP1
[424.826817] Dynamic subtest B-eDP1: SUCCESS (8.726s)
[424.835548] Starting dynamic subtest: C-eDP1
[433.540313] Dynamic subtest C-eDP1: SUCCESS (8.711s)
[433.550106] Starting dynamic subtest: D-eDP1
[442.268476] Dynamic subtest D-eDP1: SUCCESS (8.726s)
[442.273634] Subtest absolute-wf_vblank: SUCCESS (34.918s)
[443.478537] [079/133] (582s left) kms_invalid_mode (zero-vdisplay)
[443.580644] Starting subtest: zero-vdisplay
[443.583063] Starting dynamic subtest: pipe-A-eDP-1
[443.864222] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[443.874060] Starting dynamic subtest: pipe-B-eDP-1
[443.875983] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[443.883861] Starting dynamic subtest: pipe-C-eDP-1
[443.885796] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[443.894132] Starting dynamic subtest: pipe-D-eDP-1
[443.896373] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[443.898714] Subtest zero-vdisplay: SUCCESS (0.292s)
[444.729978] [080/133] (580s left) api_intel_allocator (open-vm)
[444.795393] Starting subtest: open-vm
[444.797912] Subtest open-vm: SUCCESS (0.003s)
[444.928524] [081/133] (580s left) gem_mmap_wc (coherency)
[444.993441] Subtest coherency: SKIP (0.000s)
[445.086409] [082/133] (580s left) kms_psr (fbc-psr-dpms)
[445.210243] Starting subtest: fbc-psr-dpms
[445.212639] Starting dynamic subtest: eDP-1
[445.217187] Dynamic subtest eDP-1: SKIP (0.000s)
[445.221559] Subtest fbc-psr-dpms: SKIP (0.003s)
[445.320751] [083/133] (580s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[445.393226] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[445.455601] [084/133] (580s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[445.546542] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[445.550395] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[445.662025] [085/133] (580s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[445.790275] Starting subtest: cursorA-vs-flipA-legacy
[456.914501] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.124s)
[457.740926] [086/133] (568s left) kms_plane_multiple (tiling-x)
[457.839216] Starting subtest: tiling-x
[457.841582] Starting dynamic subtest: pipe-A-eDP-1
[461.478087] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.638s)
[461.489629] Starting dynamic subtest: pipe-B-eDP-1
[465.822073] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.342s)
[465.831758] Starting dynamic subtest: pipe-C-eDP-1
[470.150101] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.327s)
[470.161904] Starting dynamic subtest: pipe-D-eDP-1
[474.469293] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.319s)
[474.471369] Subtest tiling-x: SUCCESS (16.631s)
[475.293645] [087/133] (550s left) kms_psr (fbc-pr-suspend)
[475.391259] Starting subtest: fbc-pr-suspend
[475.395765] Subtest fbc-pr-suspend: SKIP (0.000s)
[475.467485] [088/133] (550s left) kms_vrr (seamless-rr-switch-drrs)
[475.556217] Starting subtest: seamless-rr-switch-drrs
[475.562752] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[475.629572] [089/133] (550s left) kms_prop_blob (invalid-set-prop-any)
[475.678095] Starting subtest: invalid-set-prop-any
[475.680317] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[475.793126] [090/133] (550s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[475.905562] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[475.909737] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[475.998234] [091/133] (550s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[476.380786] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[477.190777] [092/133] (549s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[477.288919] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[477.293020] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[477.387949] [093/133] (548s left) kms_vblank (wait-forked-hang)
[477.484220] Starting subtest: wait-forked-hang
[477.486074] Starting dynamic subtest: pipe-A-eDP-1
[503.645477] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.160s)
[503.661443] Starting dynamic subtest: pipe-D-eDP-1
[528.653311] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.002s)
[528.655190] Subtest wait-forked-hang: SUCCESS (51.167s)
[529.463539] [094/133] (496s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[529.591830] Starting subtest: cursor-vs-flip-atomic
[558.840986] Subtest cursor-vs-flip-atomic: SUCCESS (29.248s)
[559.694495] [095/133] (466s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[559.794327] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[559.798329] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[559.904458] [096/133] (466s left) kms_content_protection (legacy)
[560.041300] Starting subtest: legacy
[560.045727] Subtest legacy: SKIP (0.000s)
[560.169806] [097/133] (466s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[560.266559] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[560.270923] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[560.370092] [098/133] (466s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[560.474854] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[567.057027] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.586s)
[567.168960] [099/133] (459s left) gem_fence_thrash (bo-write-verify-threaded-y)
[567.204483] Starting subtest: bo-write-verify-threaded-y
[567.218593] Subtest bo-write-verify-threaded-y: SKIP (0.014s)
[567.275740] [100/133] (459s left) kms_cursor_crc (cursor-offscreen-512x170)
[567.575745] Starting subtest: cursor-offscreen-512x170
[567.580401] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[567.712387] [101/133] (458s left) kms_big_fb (linear-32bpp-rotate-180)
[567.816302] Starting subtest: linear-32bpp-rotate-180
[569.383707] Subtest linear-32bpp-rotate-180: SUCCESS (1.566s)
[569.508953] [102/133] (457s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[569.594104] Starting subtest: plane-lut1d-pre-ctm3x4
[569.740812] Starting dynamic subtest: pipe-A-plane-0
[570.079884] Dynamic subtest pipe-A-plane-0: FAIL (0.193s)
[570.090434] Starting dynamic subtest: pipe-A-plane-1
[570.285834] Dynamic subtest pipe-A-plane-1: FAIL (0.170s)
[570.295068] Starting dynamic subtest: pipe-A-plane-2
[570.506875] Dynamic subtest pipe-A-plane-2: FAIL (0.171s)
[571.518551] Starting dynamic subtest: pipe-B-plane-0
[571.935982] Dynamic subtest pipe-B-plane-0: FAIL (0.152s)
[571.944423] Starting dynamic subtest: pipe-B-plane-1
[572.254268] Dynamic subtest pipe-B-plane-1: FAIL (0.155s)
[572.264892] Starting dynamic subtest: pipe-B-plane-2
[572.566820] Dynamic subtest pipe-B-plane-2: FAIL (0.612s)
[573.612593] Starting dynamic subtest: pipe-C-plane-0
[574.107679] Dynamic subtest pipe-C-plane-0: FAIL (0.129s)
[574.118378] Starting dynamic subtest: pipe-C-plane-1
[574.515945] Dynamic subtest pipe-C-plane-1: FAIL (0.629s)
[574.526090] Starting dynamic subtest: pipe-C-plane-2
[574.900811] Dynamic subtest pipe-C-plane-2: FAIL (0.170s)
[575.732645] Starting dynamic subtest: pipe-D-plane-0
[576.327321] Dynamic subtest pipe-D-plane-0: FAIL (0.152s)
[576.336586] Starting dynamic subtest: pipe-D-plane-1
[576.780618] Dynamic subtest pipe-D-plane-1: FAIL (0.607s)
[576.790375] Starting dynamic subtest: pipe-D-plane-2
[577.224733] Dynamic subtest pipe-D-plane-2: FAIL (0.556s)
[577.346667] Subtest plane-lut1d-pre-ctm3x4: FAIL (7.752s)
[578.218672] [103/133] (448s left) gem_exec_params (batch-first)
[578.270326] Starting subtest: batch-first
[578.276025] Subtest batch-first: SUCCESS (0.006s)
[578.403831] [104/133] (448s left) kms_flip_tiling (flip-change-tiling)
[578.497306] Starting subtest: flip-change-tiling
[578.499535] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[578.694236] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.198s)
[578.705943] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[578.839992] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.142s)
[578.851957] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[578.973582] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[578.985696] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[579.116920] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s)
[579.129031] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[579.260049] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[579.273689] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[579.415689] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.153s)
[579.428518] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[579.560918] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.141s)
[579.572046] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[579.682725] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.120s)
[579.696717] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[579.818099] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.130s)
[579.832168] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[579.961056] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[579.973856] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[580.116433] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.153s)
[580.126924] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[580.260401] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[580.270850] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[580.394486] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[580.404465] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[580.528276] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[580.537490] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[580.639355] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.108s)
[580.659257] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[580.783217] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s)
[580.794977] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[580.926855] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[580.943673] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[581.071614] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[581.082940] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[581.216297] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[581.228364] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[581.361052] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[581.372821] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[581.505625] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[581.517142] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[581.627245] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.120s)
[581.639796] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[581.771611] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.142s)
[581.783514] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[581.915928] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.142s)
[581.928794] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[582.048952] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.131s)
[582.062386] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[582.193202] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[582.206476] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[582.338262] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[582.348489] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[582.482274] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.142s)
[582.495658] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[582.604748] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.120s)
[582.616453] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[582.749730] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.142s)
[582.761080] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[582.893554] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[582.907717] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[583.037773] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[583.057554] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[583.183116] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[583.194819] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[583.327259] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.142s)
[583.338383] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[583.483444] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.153s)
[583.498591] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[583.647468] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.161s)
[583.704571] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[584.883613] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.188s)
[584.895350] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[585.017609] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[585.032197] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[585.162094] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.142s)
[585.174634] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[585.317657] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.153s)
[585.328338] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[585.471190] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.153s)
[585.484105] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[585.605072] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.131s)
[585.617061] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[585.739504] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[585.751436] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[585.850184] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[585.861787] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[585.984795] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[585.996869] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[586.116650] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.131s)
[586.129162] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[586.260927] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[586.272688] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[586.394574] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.131s)
[586.408575] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[586.528539] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[586.543254] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[586.662508] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.130s)
[586.674101] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[586.783288] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.119s)
[586.793109] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[586.929880] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s)
[586.941792] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[587.071602] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[587.085781] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[587.216423] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[587.229331] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[587.371882] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.152s)
[587.383069] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[587.516870] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[587.528885] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[587.661248] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[587.673366] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[587.794835] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.130s)
[587.805604] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[587.937803] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.142s)
[587.948909] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[588.082491] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.143s)
[588.094037] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[588.215959] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.131s)
[588.228080] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[588.360713] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[588.372773] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[588.494107] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.131s)
[588.505623] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[588.637725] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.142s)
[588.651478] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[588.760857] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.120s)
[588.772618] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[588.905406] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.142s)
[588.917223] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[589.049167] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[589.062685] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[589.193749] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[589.205350] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[589.327084] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.131s)
[589.338983] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[589.482174] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.153s)
[589.495473] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[589.627579] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.142s)
[589.638373] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[589.749536] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.120s)
[589.800745] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[591.012637] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.217s)
[591.024129] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[591.112519] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[591.123881] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[591.212238] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[591.223918] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[591.312155] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.098s)
[591.323837] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[591.411695] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.099s)
[591.422976] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[591.511643] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.098s)
[591.527696] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[591.612032] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s)
[591.622864] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[591.712274] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[591.723080] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[591.812232] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[591.823568] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[591.911882] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.098s)
[591.922510] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[592.011644] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.098s)
[592.022916] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[592.122550] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.110s)
[592.135746] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[592.222696] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s)
[592.233666] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[592.323368] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[592.334402] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[592.423662] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[592.435066] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[592.523515] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.098s)
[592.534834] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[592.633975] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[592.647718] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[592.745362] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.110s)
[592.760766] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[592.856795] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.108s)
[592.866669] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[592.956654] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.098s)
[592.968818] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[593.056753] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.097s)
[593.067836] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[593.167663] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.109s)
[593.179414] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[593.278502] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.109s)
[593.289720] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[593.389324] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.109s)
[593.405205] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[593.500496] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.110s)
[593.511881] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[593.600320] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.099s)
[593.611566] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[593.700570] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.099s)
[593.714466] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[593.811625] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.110s)
[593.822722] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[593.922982] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.109s)
[593.934158] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[594.034063] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.109s)
[594.045574] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[594.133895] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.098s)
[594.144966] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[594.234097] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.098s)
[594.244592] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[594.345250] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.110s)
[594.360961] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[594.467187] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.119s)
[594.478332] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[594.578662] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.110s)
[594.588081] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[594.690345] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.109s)
[594.732506] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[595.945589] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.219s)
[595.959786] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[596.045570] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[596.056808] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[596.145511] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[596.156450] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[596.245434] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.098s)
[596.257383] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[596.344750] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.098s)
[596.355853] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[596.444866] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.099s)
[596.456196] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[596.545152] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.099s)
[596.556924] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[596.645533] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[596.657937] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[596.745622] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[596.757079] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[596.844733] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.099s)
[596.856607] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[596.944590] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.098s)
[596.955683] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[597.044316] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.098s)
[597.054912] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[597.144971] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.099s)
[597.155785] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[597.245057] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[597.256539] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[597.345341] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[597.358315] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[597.456071] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s)
[597.467408] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[597.566778] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[597.577094] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[597.677921] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s)
[597.688598] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[597.778492] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.098s)
[597.789831] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[597.878304] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.098s)
[597.889058] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[597.978701] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.098s)
[597.990828] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[598.089691] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.109s)
[598.102084] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[598.199925] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.109s)
[598.209795] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[598.310999] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.109s)
[598.325592] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[598.422099] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.109s)
[598.432695] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[598.533534] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.110s)
[598.546203] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[598.644449] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.109s)
[598.657389] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[598.755371] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.110s)
[598.770175] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[598.867512] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.110s)
[598.879454] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[598.979078] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.109s)
[598.993629] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[599.078063] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.098s)
[599.088079] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[599.189672] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.110s)
[599.200376] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[599.300144] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s)
[599.311331] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[599.411165] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.109s)
[599.421849] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[599.522669] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.110s)
[599.533279] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[599.634046] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.109s)
[599.666584] Subtest flip-change-tiling: SUCCESS (21.172s)
[600.840019] [105/133] (425s left) perf (sysctl-defaults)
[600.907733] Starting subtest: sysctl-defaults
[600.910117] Subtest sysctl-defaults: SUCCESS (0.000s)
[600.987778] [106/133] (425s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[601.069170] Starting subtest: primary-yf-tiled-reflect-x-90
[601.073518] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[601.150536] [107/133] (425s left) gem_exec_schedule (u-fairslice)
[601.232339] Starting subtest: u-fairslice
[601.234336] Starting dynamic subtest: rcs0
[603.246275] Dynamic subtest rcs0: SUCCESS (2.019s)
[603.255022] Starting dynamic subtest: bcs0
[605.265074] Dynamic subtest bcs0: SUCCESS (2.018s)
[605.274652] Starting dynamic subtest: vcs0
[607.287633] Dynamic subtest vcs0: SUCCESS (2.022s)
[607.296365] Starting dynamic subtest: vcs1
[609.314196] Dynamic subtest vcs1: SUCCESS (2.026s)
[609.322465] Starting dynamic subtest: vecs0
[611.335153] Dynamic subtest vecs0: SUCCESS (2.019s)
[611.343206] Starting dynamic subtest: ccs0
[613.356229] Dynamic subtest ccs0: SUCCESS (2.021s)
[613.358497] Subtest u-fairslice: SUCCESS (12.130s)
[613.656856] [108/133] (413s left) gem_exec_flush (basic-uc-set-default)
[613.728915] Starting subtest: basic-uc-set-default
[619.191601] Subtest basic-uc-set-default: SUCCESS (5.465s)
[619.380189] [109/133] (407s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[619.479410] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[626.515072] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.038s)
[626.638728] [110/133] (400s left) gem_exec_suspend (basic-s3-devices)
[626.707564] Starting subtest: basic-S3-devices
[626.709850] Starting dynamic subtest: smem
[637.910824] Dynamic subtest smem: SUCCESS (11.200s)
[637.914049] Subtest basic-S3-devices: SUCCESS (11.203s)
[638.093712] [111/133] (388s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[638.162158] Starting subtest: rel-constants-invalid-rel-gen5
[638.164272] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[638.258243] [112/133] (388s left) kms_properties (crtc-properties-legacy)
[638.354092] Starting subtest: crtc-properties-legacy
[638.356332] Starting dynamic subtest: pipe-A-eDP-1
[638.787193] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.434s)
[638.797552] Starting dynamic subtest: pipe-B-eDP-1
[639.954075] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.164s)
[639.963606] Starting dynamic subtest: pipe-C-eDP-1
[641.082467] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.126s)
[641.092479] Starting dynamic subtest: pipe-D-eDP-1
[642.203906] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.120s)
[642.206205] Subtest crtc-properties-legacy: SUCCESS (3.850s)
[643.022685] [113/133] (384s left) kms_flip (2x-nonexisting-fb-interruptible)
[643.124450] Starting subtest: 2x-nonexisting-fb-interruptible
[643.135546] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.010s)
[643.212959] [114/133] (383s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[643.301076] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[643.305231] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[643.397495] [115/133] (383s left) kms_setmode (invalid-clone-single-crtc)
[643.452098] Starting subtest: invalid-clone-single-crtc
[643.458474] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[643.531846] [116/133] (383s left) gem_create (hog-create)
[643.586488] Starting subtest: hog-create
[643.588733] Starting dynamic subtest: smem0
[675.931814] Dynamic subtest smem0: SUCCESS (32.343s)
[675.934770] Subtest hog-create: SUCCESS (32.345s)
[676.133649] [117/133] (351s left) gem_eio (in-flight-external)
[676.375751] Starting subtest: in-flight-external
[677.989650] Subtest in-flight-external: SUCCESS (1.612s)
[678.152052] [118/133] (349s left) gem_exec_balancer (bonded-chain)
[678.219281] Starting subtest: bonded-chain
[685.189439] Subtest bonded-chain: SUCCESS (6.968s)
[685.502087] [119/133] (341s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[685.602546] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[692.789308] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.189s)
[692.914610] [120/133] (334s left) kms_flip (wf_vblank-ts-check-interruptible)
[693.015230] Starting subtest: wf_vblank-ts-check-interruptible
[693.017075] Starting dynamic subtest: A-eDP1
[701.946760] Dynamic subtest A-eDP1: SUCCESS (8.928s)
[701.958712] Starting dynamic subtest: B-eDP1
[710.884634] Dynamic subtest B-eDP1: SUCCESS (8.937s)
[710.899484] Starting dynamic subtest: C-eDP1
[719.807164] Dynamic subtest C-eDP1: SUCCESS (8.919s)
[719.820537] Starting dynamic subtest: D-eDP1
[728.731039] Dynamic subtest D-eDP1: SUCCESS (8.921s)
[728.736268] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.719s)
[729.970749] [121/133] (297s left) prime_busy (hang-wait)
[730.027867] Starting subtest: hang-wait
[730.030190] Starting dynamic subtest: rcs0
[756.399955] Dynamic subtest rcs0: SUCCESS (26.368s)
[756.409739] Starting dynamic subtest: bcs0
[763.493671] Dynamic subtest bcs0: SUCCESS (7.093s)
[763.503327] Starting dynamic subtest: vcs0
[770.531754] Dynamic subtest vcs0: SUCCESS (7.034s)
[770.542429] Starting dynamic subtest: vcs1
[777.503201] Dynamic subtest vcs1: SUCCESS (6.972s)
[777.514761] Starting dynamic subtest: vecs0
[784.545858] Dynamic subtest vecs0: SUCCESS (7.038s)
[784.565288] Starting dynamic subtest: ccs0
[798.379363] Dynamic subtest ccs0: SUCCESS (13.835s)
[798.385070] Subtest hang-wait: SUCCESS (68.352s)
[798.499156] [122/133] (228s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[798.619646] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[798.624247] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[798.764907] [123/133] (228s left) i915_query (test-query-geometry-subslices)
[798.819881] Starting subtest: test-query-geometry-subslices
[798.821698] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[798.903034] [124/133] (228s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[798.987671] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[798.989853] Starting dynamic subtest: pipe-A-eDP-1
[799.009442] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[799.021441] Starting dynamic subtest: pipe-B-eDP-1
[799.040125] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[799.048577] Starting dynamic subtest: pipe-C-eDP-1
[799.067113] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[799.075586] Starting dynamic subtest: pipe-D-eDP-1
[799.094834] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[799.097102] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[801.303449] [125/133] (226s left) gem_basic (create-fd-close)
[801.356092] Starting subtest: create-fd-close
[801.360482] Subtest create-fd-close: SUCCESS (0.000s)
[801.458367] [126/133] (226s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[801.545077] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[801.549166] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[801.628121] [127/133] (225s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[801.712990] Starting subtest: read-crc-frame-sequence
[801.715379] Starting dynamic subtest: pipe-A-eDP-1
[802.412410] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.699s)
[802.423167] Starting dynamic subtest: pipe-B-eDP-1
[803.760643] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.347s)
[803.771140] Starting dynamic subtest: pipe-C-eDP-1
[805.051268] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.287s)
[805.062053] Starting dynamic subtest: pipe-D-eDP-1
[806.372219] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.320s)
[806.374453] Subtest read-crc-frame-sequence: SUCCESS (4.658s)
[807.231515] [128/133] (220s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[807.326901] Starting subtest: multiplane-rotation-cropping-bottom
[824.829403] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.504s)
[824.934381] [129/133] (202s left) gem_pwrite (basic-random)
[824.996225] Subtest basic-random: SKIP (0.000s)
[825.054828] [130/133] (202s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[825.107944] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[825.209044] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.101s)
[825.295957] [131/133] (202s left) kms_mmap_write_crc (main)
[825.388273] Starting subtest: main
[825.390128] Starting dynamic subtest: pipe-A-eDP-1
[828.946497] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.556s)
[828.948738] Subtest main: SUCCESS (3.558s)
[829.758502] [132/133] (198s left) kms_chamelium_audio (dp-audio-edid)
[830.150043] Subtest dp-audio-edid: SKIP (0.000s)
[830.969406] [133/133] (196s left) fbdev (unaligned-write)
[831.006715] Starting subtest: unaligned-write
[831.138850] Subtest unaligned-write: SUCCESS (0.131s)
[831.205203] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_psr2_sf
results: parsing output: 2/ for test: prime_vgem
results: parsing output: 3/ for test: gem_exec_whisper
results: parsing output: 4/ for test: gen9_exec_parse
results: parsing output: 5/ for test: perf
results: parsing output: 6/ for test: syncobj_wait
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_setmode
results: parsing output: 9/ for test: gem_ctx_shared
results: parsing output: 10/ for test: kms_pm_backlight
results: parsing output: 11/ for test: gem_ctx_param
results: parsing output: 12/ for test: kms_chamelium_color
results: parsing output: 13/ for test: gem_exec_create
results: parsing output: 14/ for test: gem_flink_basic
results: parsing output: 15/ for test: gem_exec_fence
results: parsing output: 16/ for test: kms_atomic_transition
results: parsing output: 17/ for test: kms_addfb_basic
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: gem_media_fill
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: dumb_buffer
results: parsing output: 23/ for test: vgem_basic
results: parsing output: 24/ for test: gem_fence_thrash
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_async_flips
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: vgem_basic
results: parsing output: 29/ for test: kms_cursor_edge_walk
results: parsing output: 30/ for test: gem_ringfill
results: parsing output: 31/ for test: gem_mmap_gtt
results: parsing output: 32/ for test: gem_partial_pwrite_pread
results: parsing output: 33/ for test: kms_plane
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: kms_draw_crc
results: parsing output: 36/ for test: gem_lmem_swapping
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: syncobj_wait
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_ctx_persistence
results: parsing output: 41/ for test: gem_exec_schedule
results: parsing output: 42/ for test: kms_busy
results: parsing output: 43/ for test: kms_cursor_crc
results: parsing output: 44/ for test: kms_async_flips
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_universal_plane
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_pxp
results: parsing output: 49/ for test: perf_pmu
results: parsing output: 50/ for test: gem_readwrite
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: gem_softpin
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: gem_userptr_blits
results: parsing output: 57/ for test: api_intel_bb
results: parsing output: 58/ for test: gem_exec_params
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: i915_pm_rps
results: parsing output: 61/ for test: gem_exec_fence
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: gen9_exec_parse
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_exec_reloc
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_unfence_active_buffers
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: gem_wait
results: parsing output: 71/ for test: kms_pm_rpm
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: i915_hangman
results: parsing output: 74/ for test: kms_flip_scaled_crc
results: parsing output: 75/ for test: kms_pm_rpm
results: parsing output: 76/ for test: kms_plane
results: parsing output: 77/ for test: kms_flip
results: parsing output: 78/ for test: kms_invalid_mode
results: parsing output: 79/ for test: api_intel_allocator
results: parsing output: 80/ for test: gem_mmap_wc
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: gem_fenced_exec_thrash
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_cursor_legacy
results: parsing output: 85/ for test: kms_plane_multiple
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: kms_vrr
results: parsing output: 88/ for test: kms_prop_blob
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_chamelium_hpd
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_vblank
results: parsing output: 93/ for test: kms_cursor_legacy
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_content_protection
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_fence_thrash
results: parsing output: 99/ for test: kms_cursor_crc
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: kms_color_pipeline
results: parsing output: 102/ for test: gem_exec_params
results: parsing output: 103/ for test: kms_flip_tiling
results: parsing output: 104/ for test: perf
results: parsing output: 105/ for test: kms_rotation_crc
results: parsing output: 106/ for test: gem_exec_schedule
results: parsing output: 107/ for test: gem_exec_flush
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_exec_suspend
results: parsing output: 110/ for test: gem_exec_params
results: parsing output: 111/ for test: kms_properties
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_setmode
results: parsing output: 115/ for test: gem_create
results: parsing output: 116/ for test: gem_eio
results: parsing output: 117/ for test: gem_exec_balancer
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_flip
results: parsing output: 120/ for test: prime_busy
results: parsing output: 121/ for test: kms_cursor_legacy
results: parsing output: 122/ for test: i915_query
results: parsing output: 123/ for test: kms_ccs
results: parsing output: 124/ for test: gem_basic
results: parsing output: 125/ for test: kms_flip_scaled_crc
results: parsing output: 126/ for test: kms_pipe_crc_basic
results: parsing output: 127/ for test: kms_rotation_crc
results: parsing output: 128/ for test: gem_pwrite
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: kms_mmap_write_crc
results: parsing output: 131/ for test: kms_chamelium_audio
results: parsing output: 132/ for test: fbdev
Done.