[58.105950] Initializing watchdogs
[58.105999]   /dev/watchdog0
[58.121274] [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]
[58.126398] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.128626] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.132708] [001/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[58.256280] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[58.260274] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[58.362283] [002/133] (960s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[58.461511] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[58.465774] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[58.535344] [003/133] (960s left) prime_vgem (coherency-gtt)
[58.635093] Starting subtest: coherency-gtt
[58.639956] Subtest coherency-gtt: SKIP (0.000s)
[58.720483] [FACT prime_vgem (coherency-gtt)] new: kernel.kmod_is_loaded.vgem: true
[58.723357] [004/133] (960s left) gem_exec_whisper (basic-fds-forked)
[58.786602] Starting subtest: basic-fds-forked
[82.092302] Subtest basic-fds-forked: SUCCESS (23.262s)
[82.287132] [005/133] (936s left) gen9_exec_parse (bb-start-param)
[82.356772] Subtest bb-start-param: SKIP (0.000s)
[82.427407] [006/133] (936s left) perf (mi-rpc)
[82.556674] Starting subtest: mi-rpc
[82.560728] Subtest mi-rpc: SKIP (0.000s)
[82.596956] [007/133] (936s left) syncobj_wait (invalid-signal-bad-pad)
[82.642547] Starting subtest: invalid-signal-bad-pad
[82.645033] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[82.730220] [008/133] (936s left) syncobj_timeline (wait-all-for-submit-snapshot)
[82.781718] Starting subtest: wait-all-for-submit-snapshot
[82.864285] Subtest wait-all-for-submit-snapshot: SUCCESS (0.083s)
[82.941117] [009/133] (936s left) kms_setmode (basic)
[82.998687] Starting subtest: basic
[83.353069] Starting dynamic subtest: pipe-A-eDP-1
[85.369953] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.012s)
[85.754724] Starting dynamic subtest: pipe-B-eDP-1
[87.800698] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.050s)
[88.120209] Subtest basic: SUCCESS (5.119s)
[88.952162] [010/133] (930s left) gem_ctx_shared (exec-shared-gtt)
[89.022728] Starting subtest: exec-shared-gtt
[89.025035] Starting dynamic subtest: rcs0
[89.030931] Dynamic subtest rcs0: SUCCESS (0.008s)
[89.039878] Starting dynamic subtest: bcs0
[89.041763] Dynamic subtest bcs0: SUCCESS (0.006s)
[89.049861] Starting dynamic subtest: vcs0
[89.052431] Dynamic subtest vcs0: SUCCESS (0.007s)
[89.060090] Starting dynamic subtest: vcs1
[89.062156] Dynamic subtest vcs1: SUCCESS (0.006s)
[89.069597] Starting dynamic subtest: vecs0
[89.071537] Dynamic subtest vecs0: SUCCESS (0.008s)
[89.078894] Starting dynamic subtest: ccs0
[89.080858] Dynamic subtest ccs0: SUCCESS (0.005s)
[89.082831] Subtest exec-shared-gtt: SUCCESS (0.041s)
[89.246809] [011/133] (929s left) kms_pm_backlight (bad-brightness)
[89.353796] Starting subtest: bad-brightness
[89.427743] Starting dynamic subtest: eDP-1
[89.720935] Dynamic subtest eDP-1: SUCCESS (0.294s)
[89.723259] Subtest bad-brightness: SUCCESS (0.367s)
[90.633355] [012/133] (928s left) gem_ctx_param (invalid-get-ringsize)
[90.691607] Starting subtest: invalid-get-ringsize
[90.693886] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[90.783210] [013/133] (928s left) kms_chamelium_color (gamma)
[90.887878] Subtest gamma: SKIP (0.000s)
[90.939983] [014/133] (928s left) gem_exec_create (basic)
[91.002835] Starting subtest: basic
[91.005287] Starting dynamic subtest: smem
[94.873083] Dynamic subtest smem: SUCCESS (3.868s)
[94.875478] Subtest basic: SUCCESS (3.868s)
[95.056016] [015/133] (924s left) gem_flink_basic (flink-lifetime)
[95.116875] Starting subtest: flink-lifetime
[95.119145] Subtest flink-lifetime: SUCCESS (0.002s)
[95.229093] [016/133] (924s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[95.833073] Starting subtest: syncobj-timeline-multiple-ext-nodes
[95.838810] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.005s)
[97.004673] [017/133] (922s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[97.100861] Starting subtest: plane-all-modeset-transition-internal-panels
[97.102792] Starting dynamic subtest: pipe-A-eDP-1
[98.437421] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.335s)
[98.715428] Starting dynamic subtest: pipe-B-eDP-1
[99.760529] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.052s)
[100.041564] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.941s)
[100.881373] [018/133] (918s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[100.971497] Starting subtest: bo-too-small-due-to-tiling
[100.975729] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[101.091687] [019/133] (918s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[101.205158] Starting subtest: 4-tiled-32bpp-rotate-0
[102.597075] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.393s)
[102.741903] [020/133] (916s left) gem_media_fill (media-fill)
[102.804640] Subtest media-fill: SKIP (0.000s)
[102.915428] [021/133] (916s left) kms_psr (fbc-pr-no-drrs)
[102.999990] Starting subtest: fbc-pr-no-drrs
[103.003601] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[103.068767] [022/133] (916s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[103.169018] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[103.172409] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[103.259860] [023/133] (916s left) dumb_buffer (create-clear)
[103.322143] Starting subtest: create-clear
[137.946741] Subtest create-clear: SUCCESS (34.616s)
[138.069637] [024/133] (881s left) vgem_basic (bad-pad)
[138.116657] Starting subtest: bad-pad
[138.118612] Subtest bad-pad: SUCCESS (0.000s)
[138.186504] [025/133] (881s left) gem_fence_thrash (bo-write-verify-none)
[138.226832] Starting subtest: bo-write-verify-none
[138.254682] Subtest bo-write-verify-none: SKIP (0.025s)
[138.326985] [026/133] (881s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[138.421976] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[145.087291] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.666s)
[145.217394] [027/133] (874s left) kms_async_flips (test-time-stamp)
[145.303581] Starting subtest: test-time-stamp
[145.693872] Starting dynamic subtest: pipe-A-eDP-1
[146.497239] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.800s)
[146.864122] Starting dynamic subtest: pipe-B-eDP-1
[147.627685] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.770s)
[148.009826] Starting dynamic subtest: pipe-C-eDP-1
[148.766209] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.761s)
[149.138958] Starting dynamic subtest: pipe-D-eDP-1
[149.901955] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.770s)
[149.904481] Subtest test-time-stamp: SUCCESS (4.598s)
[151.083942] [028/133] (868s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[151.183207] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[151.185316] Starting dynamic subtest: pipe-A-eDP-1
[151.206859] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[151.215543] Starting dynamic subtest: pipe-B-eDP-1
[151.236131] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[151.244135] Starting dynamic subtest: pipe-C-eDP-1
[151.265169] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[151.273091] Starting dynamic subtest: pipe-D-eDP-1
[151.294946] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[151.299109] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.004s)
[153.348806] [029/133] (866s left) vgem_basic (dmabuf-fence-before)
[153.390832] Starting subtest: dmabuf-fence-before
[153.392739] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[153.446868] [030/133] (866s left) kms_cursor_edge_walk (64x64-left-edge)
[153.544589] Starting subtest: 64x64-left-edge
[153.546803] Starting dynamic subtest: pipe-A-eDP-1
[157.027814] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.481s)
[157.037284] Starting dynamic subtest: pipe-D-eDP-1
[160.157509] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.130s)
[160.159807] Subtest 64x64-left-edge: SUCCESS (6.614s)
[160.974690] [031/133] (858s left) gem_ringfill (basic-all)
[166.938274] Starting subtest: basic-all
[168.098421] Subtest basic-all: SUCCESS (1.161s)
[168.223087] [032/133] (851s left) gem_mmap_gtt (zero-extend)
[168.278560] Subtest zero-extend: SKIP (0.000s)
[168.349430] [033/133] (851s left) gem_partial_pwrite_pread (write-display)
[168.417078] Subtest write-display: SKIP (0.000s)
[168.498131] [034/133] (851s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[168.598617] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[168.602622] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[168.681259] [035/133] (851s left) syncobj_timeline (signal)
[168.734992] Starting subtest: signal
[168.737408] Subtest signal: SUCCESS (0.000s)
[168.833700] [036/133] (851s left) kms_draw_crc (draw-method-mmap-gtt)
[168.931820] Starting subtest: draw-method-mmap-gtt
[168.936224] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[169.025103] [037/133] (851s left) gem_lmem_swapping (parallel-multi)
[169.074873] Subtest parallel-multi: SKIP (0.000s)
[169.118440] [038/133] (851s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[169.208652] Starting subtest: x-tiled-32bpp-rotate-0
[170.601932] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.393s)
[170.768065] [039/133] (849s left) syncobj_wait (multi-wait-submitted-signaled)
[170.828847] Starting subtest: multi-wait-submitted-signaled
[170.831083] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[170.947440] [040/133] (849s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[171.043024] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[171.046539] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[171.144454] [041/133] (849s left) gem_ctx_persistence (many-contexts)
[171.205063] Starting subtest: many-contexts
[216.389906] Subtest many-contexts: SUCCESS (45.182s)
[216.472310] [042/133] (803s left) gem_exec_schedule (pi-ringfull)
[216.660541] Starting subtest: pi-ringfull
[216.662688] Starting dynamic subtest: rcs0
[216.694091] Dynamic subtest rcs0: SUCCESS (0.037s)
[216.703763] Starting dynamic subtest: bcs0
[216.733421] Dynamic subtest bcs0: SUCCESS (0.039s)
[216.741890] Starting dynamic subtest: vcs0
[216.769789] Dynamic subtest vcs0: SUCCESS (0.036s)
[216.778174] Starting dynamic subtest: vcs1
[216.803885] Dynamic subtest vcs1: SUCCESS (0.034s)
[216.812198] Starting dynamic subtest: vecs0
[216.836325] Dynamic subtest vecs0: SUCCESS (0.032s)
[216.844789] Starting dynamic subtest: ccs0
[216.867717] Dynamic subtest ccs0: SUCCESS (0.031s)
[216.869884] Subtest pi-ringfull: SUCCESS (0.211s)
[217.092587] [043/133] (803s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[217.198930] Starting subtest: extended-pageflip-modeset-hang-oldfb
[217.201346] Starting dynamic subtest: pipe-A
[225.104292] Dynamic subtest pipe-A: SUCCESS (7.905s)
[225.113063] Starting dynamic subtest: pipe-D
[233.702479] Dynamic subtest pipe-D: SUCCESS (8.594s)
[233.704787] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.504s)
[234.542874] [044/133] (785s left) kms_cursor_crc (cursor-random-256x256)
[234.788718] Starting subtest: cursor-random-256x256
[234.793511] Starting dynamic subtest: pipe-A-eDP-1
[238.180209] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.386s)
[238.210850] Starting dynamic subtest: pipe-D-eDP-1
[242.167551] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.965s)
[242.169822] Subtest cursor-random-256x256: SUCCESS (7.377s)
[243.013238] [045/133] (777s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[243.114640] Starting subtest: async-flip-with-page-flip-events-linear
[243.489144] Starting dynamic subtest: pipe-A-eDP-1
[246.286997] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.796s)
[246.665219] Starting dynamic subtest: pipe-B-eDP-1
[249.413777] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.757s)
[249.776958] Starting dynamic subtest: pipe-C-eDP-1
[252.538167] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.767s)
[252.898442] Starting dynamic subtest: pipe-D-eDP-1
[255.669528] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.776s)
[255.672496] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.554s)
[256.859485] [046/133] (763s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[256.960425] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[256.964745] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[257.065917] [047/133] (763s left) kms_universal_plane (universal-plane-functional)
[257.154724] Starting subtest: universal-plane-functional
[257.157437] Starting dynamic subtest: pipe-A-eDP-1
[261.048209] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.895s)
[261.057902] Starting dynamic subtest: pipe-B-eDP-1
[265.649682] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.599s)
[265.661169] Starting dynamic subtest: pipe-C-eDP-1
[269.986827] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.337s)
[269.996678] Starting dynamic subtest: pipe-D-eDP-1
[274.388655] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.399s)
[274.390801] Subtest universal-plane-functional: SUCCESS (17.236s)
[275.251991] [048/133] (745s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[275.364226] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[275.368225] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[275.467269] [049/133] (745s left) gem_pxp (reject-modify-context-protection-on)
[275.590968] Starting subtest: reject-modify-context-protection-on
[275.593338] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[275.702346] [050/133] (744s left) perf_pmu (render-node-busy-idle)
[275.777658] Starting subtest: render-node-busy-idle
[275.780096] Starting dynamic subtest: rcs0
[276.441345] Dynamic subtest rcs0: SUCCESS (0.662s)
[276.454681] Starting dynamic subtest: bcs0
[277.115146] Dynamic subtest bcs0: SUCCESS (0.672s)
[277.126648] Starting dynamic subtest: vcs0
[278.935186] Dynamic subtest vcs0: SUCCESS (1.816s)
[278.950800] Starting dynamic subtest: vcs1
[280.919448] Dynamic subtest vcs1: SUCCESS (1.982s)
[280.929919] Starting dynamic subtest: vecs0
[282.902887] Dynamic subtest vecs0: SUCCESS (1.980s)
[282.914346] Starting dynamic subtest: ccs0
[283.570850] Dynamic subtest ccs0: SUCCESS (0.667s)
[283.573302] Subtest render-node-busy-idle: SUCCESS (7.793s)
[283.664682] [051/133] (737s left) gem_readwrite (write-bad-handle)
[283.722575] Subtest write-bad-handle: SKIP (0.000s)
[283.774648] [052/133] (737s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[283.830254] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[283.939504] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.107s)
[284.016520] [053/133] (736s left) syncobj_timeline (invalid-wait-illegal-handle)
[284.076594] Starting subtest: invalid-wait-illegal-handle
[284.078506] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[284.170393] [054/133] (736s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[284.286451] Starting subtest: yf-tiled-16bpp-rotate-0
[284.290533] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[284.401277] [055/133] (736s left) gem_softpin (safe-alignment)
[284.462667] Starting subtest: safe-alignment
[284.484783] Subtest safe-alignment: SUCCESS (0.022s)
[285.962673] [056/133] (734s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[286.079135] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[286.083614] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[286.177076] [057/133] (734s left) gem_userptr_blits (create-destroy-unsync)
[286.248098] Subtest create-destroy-unsync: SKIP (0.000s)
[286.370905] [058/133] (734s left) api_intel_bb (object-noreloc-keep-cache-simple)
[286.431130] Starting subtest: object-noreloc-keep-cache-simple
[286.437091] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.006s)
[286.568343] [059/133] (734s left) gem_exec_params (dr4-dirt)
[286.624815] Starting subtest: DR4-dirt
[286.626939] Subtest DR4-dirt: SUCCESS (0.000s)
[286.724559] [060/133] (734s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[286.831146] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[286.835399] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[286.936439] [061/133] (734s left) i915_pm_rps (fence-order)
[287.007795] Starting subtest: fence-order
[289.989056] Subtest fence-order: SUCCESS (2.977s)
[290.097099] [062/133] (731s left) gem_exec_fence (expired-history)
[290.553759] Starting subtest: expired-history
[297.663493] Subtest expired-history: SUCCESS (7.111s)
[298.255595] [063/133] (722s left) kms_psr (pr-cursor-plane-onoff)
[298.348981] Starting subtest: pr-cursor-plane-onoff
[298.353275] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[298.451396] [064/133] (722s left) kms_psr (psr2-cursor-render)
[298.554981] Starting subtest: psr2-cursor-render
[298.557243] Starting dynamic subtest: eDP-1
[300.238090] Dynamic subtest eDP-1: SUCCESS (1.684s)
[300.240462] Subtest psr2-cursor-render: SUCCESS (1.685s)
[301.042722] [065/133] (720s left) gen9_exec_parse (shadow-peek)
[301.104742] Subtest shadow-peek: SKIP (0.000s)
[301.167374] [066/133] (720s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[301.261329] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[308.162871] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.902s)
[308.312176] [067/133] (713s left) gem_exec_reloc (basic-concurrent16)
[308.371989] Subtest basic-concurrent16: SKIP (0.000s)
[308.448360] [068/133] (713s left) kms_frontbuffer_tracking (fbc-2p-rte)
[308.553219] Starting subtest: fbc-2p-rte
[308.557335] Subtest fbc-2p-rte: SKIP (0.000s)
[308.653821] [069/133] (712s left) gem_unfence_active_buffers
[308.801063] [070/133] (712s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[308.902594] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[308.904946] Starting dynamic subtest: pipe-A-eDP-1
[308.928328] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[308.946534] Starting dynamic subtest: pipe-B-eDP-1
[308.969609] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[308.987643] Starting dynamic subtest: pipe-C-eDP-1
[309.010195] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[309.027583] Starting dynamic subtest: pipe-D-eDP-1
[309.051054] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[309.055319] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[311.100553] [071/133] (710s left) gem_wait (wait)
[311.163250] Starting subtest: wait
[311.165830] Starting dynamic subtest: all-engines
[312.919052] Dynamic subtest all-engines: SUCCESS (1.754s)
[312.931780] Starting dynamic subtest: rcs0
[313.965994] Dynamic subtest rcs0: SUCCESS (1.045s)
[313.978845] Starting dynamic subtest: bcs0
[315.012312] Dynamic subtest bcs0: SUCCESS (1.045s)
[315.023503] Starting dynamic subtest: vcs0
[316.056968] Dynamic subtest vcs0: SUCCESS (1.042s)
[316.069210] Starting dynamic subtest: vcs1
[317.104372] Dynamic subtest vcs1: SUCCESS (1.045s)
[317.115561] Starting dynamic subtest: vecs0
[318.150074] Dynamic subtest vecs0: SUCCESS (1.043s)
[318.161370] Starting dynamic subtest: ccs0
[319.197924] Dynamic subtest ccs0: SUCCESS (1.046s)
[319.201422] Subtest wait: SUCCESS (8.035s)
[319.409729] [072/133] (702s left) kms_pm_rpm (cursor)
[321.041944] Starting subtest: cursor
[321.047140] Subtest cursor: SKIP (0.000s)
[321.709542] [073/133] (700s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[321.799709] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[321.802036] Starting dynamic subtest: pipe-A-eDP-1
[321.822770] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[321.832845] Starting dynamic subtest: pipe-B-eDP-1
[321.852655] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[321.861136] Starting dynamic subtest: pipe-C-eDP-1
[321.880220] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[321.887971] Starting dynamic subtest: pipe-D-eDP-1
[321.907097] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[321.908962] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[324.055065] [074/133] (697s left) i915_hangman (gt-error-state-capture)
[324.105823] Starting subtest: gt-error-state-capture
[324.108064] Starting dynamic subtest: rcs0
[335.859271] Dynamic subtest rcs0: SUCCESS (11.754s)
[335.871878] Starting dynamic subtest: bcs0
[347.893357] Dynamic subtest bcs0: SUCCESS (12.031s)
[347.911707] Starting dynamic subtest: vcs0
[359.797386] Dynamic subtest vcs0: SUCCESS (11.901s)
[359.808955] Starting dynamic subtest: vcs1
[370.805348] Dynamic subtest vcs1: SUCCESS (11.005s)
[370.817711] Starting dynamic subtest: vecs0
[381.813348] Dynamic subtest vecs0: SUCCESS (11.004s)
[381.825425] Starting dynamic subtest: ccs0
[392.885033] Dynamic subtest ccs0: SUCCESS (11.068s)
[392.888065] Subtest gt-error-state-capture: SUCCESS (68.778s)
[392.967333] [075/133] (628s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[393.072060] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[393.076581] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[393.144777] [076/133] (628s left) kms_pm_rpm (modeset-pc8-residency-stress)
[395.085088] Starting subtest: modeset-pc8-residency-stress
[395.090626] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[395.473496] [077/133] (626s left) kms_plane (plane-panning-bottom-right)
[395.564907] Starting subtest: plane-panning-bottom-right
[395.567188] Starting dynamic subtest: pipe-A
[397.235137] Dynamic subtest pipe-A: SUCCESS (1.670s)
[397.245357] Starting dynamic subtest: pipe-B
[399.673294] Dynamic subtest pipe-B: SUCCESS (2.435s)
[399.675150] Subtest plane-panning-bottom-right: SUCCESS (4.108s)
[400.478397] [078/133] (621s left) kms_flip (absolute-wf_vblank)
[400.585741] Starting subtest: absolute-wf_vblank
[400.588077] Starting dynamic subtest: A-eDP1
[409.343672] Dynamic subtest A-eDP1: SUCCESS (8.759s)
[409.352675] Starting dynamic subtest: B-eDP1
[418.073632] Dynamic subtest B-eDP1: SUCCESS (8.727s)
[418.084432] Starting dynamic subtest: C-eDP1
[426.796898] Dynamic subtest C-eDP1: SUCCESS (8.721s)
[426.806817] Starting dynamic subtest: D-eDP1
[435.527575] Dynamic subtest D-eDP1: SUCCESS (8.729s)
[435.533194] Subtest absolute-wf_vblank: SUCCESS (34.946s)
[436.964761] [079/133] (584s left) kms_invalid_mode (zero-vdisplay)
[437.074445] Starting subtest: zero-vdisplay
[437.076880] Starting dynamic subtest: pipe-A-eDP-1
[437.354419] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[437.364254] Starting dynamic subtest: pipe-B-eDP-1
[437.366175] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[437.374113] Starting dynamic subtest: pipe-C-eDP-1
[437.376053] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[437.384673] Starting dynamic subtest: pipe-D-eDP-1
[437.386974] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[437.389281] Subtest zero-vdisplay: SUCCESS (0.290s)
[438.184234] [080/133] (583s left) api_intel_allocator (open-vm)
[438.245050] Starting subtest: open-vm
[438.247343] Subtest open-vm: SUCCESS (0.004s)
[438.371835] [081/133] (583s left) gem_mmap_wc (coherency)
[438.432378] Subtest coherency: SKIP (0.000s)
[438.496099] [082/133] (583s left) kms_psr (fbc-psr-dpms)
[438.596235] Starting subtest: fbc-psr-dpms
[438.598524] Starting dynamic subtest: eDP-1
[438.602841] Dynamic subtest eDP-1: SKIP (0.000s)
[438.607196] Subtest fbc-psr-dpms: SKIP (0.001s)
[438.669881] [083/133] (583s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[438.725176] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[438.799218] [084/133] (583s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[438.915149] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[438.919479] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[439.052281] [085/133] (583s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[439.171367] Starting subtest: cursorA-vs-flipA-legacy
[450.310058] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.137s)
[451.114442] [086/133] (571s left) kms_plane_multiple (tiling-x)
[451.203677] Starting subtest: tiling-x
[451.205921] Starting dynamic subtest: pipe-A-eDP-1
[454.962109] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.756s)
[454.972070] Starting dynamic subtest: pipe-B-eDP-1
[459.426586] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.464s)
[459.436137] Starting dynamic subtest: pipe-C-eDP-1
[463.761134] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.332s)
[463.771597] Starting dynamic subtest: pipe-D-eDP-1
[468.103073] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.340s)
[468.105327] Subtest tiling-x: SUCCESS (16.898s)
[468.911797] [087/133] (553s left) kms_psr (fbc-pr-suspend)
[469.018990] Starting subtest: fbc-pr-suspend
[469.023483] Subtest fbc-pr-suspend: SKIP (0.000s)
[469.092097] [088/133] (553s left) kms_vrr (seamless-rr-switch-drrs)
[469.184804] Starting subtest: seamless-rr-switch-drrs
[469.191210] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[469.258596] [089/133] (553s left) kms_prop_blob (invalid-set-prop-any)
[469.316040] Starting subtest: invalid-set-prop-any
[469.317979] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[469.412330] [090/133] (553s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[469.514529] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[469.518969] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[469.625976] [091/133] (552s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[470.004142] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[470.813830] [092/133] (551s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[470.909136] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[470.913347] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[470.999235] [093/133] (551s left) kms_vblank (wait-forked-hang)
[471.092289] Starting subtest: wait-forked-hang
[471.094169] Starting dynamic subtest: pipe-A-eDP-1
[497.686940] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.593s)
[497.700718] Starting dynamic subtest: pipe-D-eDP-1
[512.720909] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.029s)
[512.722808] Subtest wait-forked-hang: SUCCESS (41.627s)
[513.582729] [094/133] (509s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[513.708683] Starting subtest: cursor-vs-flip-atomic
[543.103431] Subtest cursor-vs-flip-atomic: SUCCESS (29.392s)
[543.916069] [095/133] (478s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[544.027193] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[544.031238] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[544.131279] [096/133] (478s left) kms_content_protection (legacy)
[544.259450] Starting subtest: legacy
[544.264060] Subtest legacy: SKIP (0.000s)
[544.375291] [097/133] (478s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[544.478562] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[544.482974] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[544.584928] [098/133] (478s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[544.688470] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[551.322719] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.637s)
[551.438084] [099/133] (471s left) gem_fence_thrash (bo-write-verify-threaded-y)
[551.473231] Starting subtest: bo-write-verify-threaded-y
[551.492836] Subtest bo-write-verify-threaded-y: SKIP (0.018s)
[551.553561] [100/133] (471s left) kms_cursor_crc (cursor-offscreen-512x170)
[551.849800] Starting subtest: cursor-offscreen-512x170
[551.854441] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[551.996492] [101/133] (470s left) kms_big_fb (linear-32bpp-rotate-180)
[552.094134] Starting subtest: linear-32bpp-rotate-180
[553.661184] Subtest linear-32bpp-rotate-180: SUCCESS (1.568s)
[553.826062] [102/133] (469s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[553.921393] Starting subtest: plane-lut1d-pre-ctm3x4
[554.067269] Starting dynamic subtest: pipe-A-plane-0
[554.392194] Dynamic subtest pipe-A-plane-0: FAIL (0.180s)
[554.401048] Starting dynamic subtest: pipe-A-plane-1
[554.594050] Dynamic subtest pipe-A-plane-1: FAIL (0.171s)
[554.604181] Starting dynamic subtest: pipe-A-plane-2
[554.809829] Dynamic subtest pipe-A-plane-2: FAIL (0.176s)
[555.863577] Starting dynamic subtest: pipe-B-plane-0
[556.304351] Dynamic subtest pipe-B-plane-0: FAIL (0.174s)
[556.312885] Starting dynamic subtest: pipe-B-plane-1
[556.626166] Dynamic subtest pipe-B-plane-1: FAIL (0.166s)
[556.635861] Starting dynamic subtest: pipe-B-plane-2
[556.947122] Dynamic subtest pipe-B-plane-2: FAIL (0.166s)
[557.582311] Starting dynamic subtest: pipe-C-plane-0
[558.094136] Dynamic subtest pipe-C-plane-0: FAIL (0.151s)
[558.105080] Starting dynamic subtest: pipe-C-plane-1
[558.489883] Dynamic subtest pipe-C-plane-1: FAIL (0.619s)
[558.498829] Starting dynamic subtest: pipe-C-plane-2
[558.858894] Dynamic subtest pipe-C-plane-2: FAIL (0.170s)
[559.712160] Starting dynamic subtest: pipe-D-plane-0
[560.319844] Dynamic subtest pipe-D-plane-0: FAIL (0.152s)
[560.331016] Starting dynamic subtest: pipe-D-plane-1
[560.786870] Dynamic subtest pipe-D-plane-1: FAIL (0.618s)
[560.797038] Starting dynamic subtest: pipe-D-plane-2
[561.241331] Dynamic subtest pipe-D-plane-2: FAIL (0.572s)
[561.347278] Subtest plane-lut1d-pre-ctm3x4: FAIL (7.428s)
[562.171200] [103/133] (460s left) gem_exec_params (batch-first)
[562.240881] Starting subtest: batch-first
[562.247176] Subtest batch-first: SUCCESS (0.006s)
[562.371111] [104/133] (460s left) kms_flip_tiling (flip-change-tiling)
[562.461124] Starting subtest: flip-change-tiling
[562.463387] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[562.655336] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.194s)
[562.667046] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[562.789867] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[562.801743] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[562.923717] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.132s)
[562.935270] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[563.066394] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.141s)
[563.078159] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[563.209979] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[563.222870] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[563.354650] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[563.366363] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[563.488747] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[563.500857] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[563.610887] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.120s)
[563.622363] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[563.745754] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[563.757975] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[563.917539] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.170s)
[563.929335] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[564.087245] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.169s)
[564.099125] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[564.231475] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[564.243697] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[564.365707] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[564.377499] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[564.500088] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[564.511760] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[564.609999] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[564.621393] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[564.754804] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s)
[564.766599] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[564.898737] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[564.910294] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[565.043508] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[565.054927] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[565.187717] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[565.199332] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[565.332356] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[565.346912] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[565.477043] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[565.488999] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[565.598065] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.119s)
[565.609576] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[565.742837] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.142s)
[565.763915] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[565.886868] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.142s)
[565.899727] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[566.031436] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[566.045928] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[566.175796] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[566.189766] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[566.320341] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[566.336600] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[566.465298] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.141s)
[566.477995] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[566.587626] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.120s)
[566.599079] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[566.732124] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.142s)
[566.744254] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[566.875766] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[566.888892] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[567.020508] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[567.035068] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[567.165664] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[567.176951] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[567.309573] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.142s)
[567.324521] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[567.454400] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.141s)
[567.466108] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[567.587513] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.131s)
[567.640168] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[568.822308] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.189s)
[568.837314] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[568.957114] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[568.968355] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[569.089692] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[569.101086] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[569.245940] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.153s)
[569.256765] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[569.389059] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[569.402772] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[569.533725] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[569.546142] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[569.667314] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[569.680336] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[569.778423] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[569.789738] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[569.913215] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[569.924720] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[570.044898] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.131s)
[570.056796] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[570.188868] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[570.200473] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[570.333390] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[570.345483] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[570.467442] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[570.479762] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[570.601674] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[570.613813] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[570.711739] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[570.722851] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[570.856259] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s)
[570.868145] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[570.999431] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.141s)
[571.014319] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[571.144287] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[571.155060] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[571.277804] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.131s)
[571.289735] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[571.411786] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.131s)
[571.423600] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[571.556332] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[571.566975] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[571.677886] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.120s)
[571.687765] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[571.864227] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.185s)
[571.875321] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[572.020054] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.153s)
[572.031069] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[572.164577] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[572.178711] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[572.308288] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[572.321882] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[572.441681] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.131s)
[572.453158] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[572.585985] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.142s)
[572.598749] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[572.708741] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.120s)
[572.723107] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[572.853450] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.142s)
[572.865235] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[572.997298] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[573.009042] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[573.141546] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[573.155979] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[573.285976] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[573.300106] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[573.430738] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.142s)
[573.442475] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[573.575492] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.142s)
[573.589703] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[573.697465] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.119s)
[573.757545] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[574.956561] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.211s)
[574.968460] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[575.056540] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[575.068450] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[575.156800] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[575.176307] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[575.267428] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s)
[575.279966] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[575.378321] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[575.389827] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[575.500230] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.121s)
[575.510465] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[575.601169] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s)
[575.615335] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[575.711719] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[575.721848] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[575.812156] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[575.821781] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[575.922859] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s)
[575.932975] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[576.033206] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[576.046655] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[576.144374] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s)
[576.158196] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[576.256409] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.109s)
[576.265719] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[576.356074] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[576.366366] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[576.467569] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[576.479153] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[576.578658] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.108s)
[576.594254] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[576.689124] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[576.700561] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[576.800140] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s)
[576.811649] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[576.911581] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.109s)
[576.923606] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[577.011520] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.098s)
[577.022896] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[577.122905] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s)
[577.137895] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[577.234039] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.109s)
[577.245654] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[577.344509] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.109s)
[577.355619] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[577.455513] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.109s)
[577.467029] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[577.566549] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.109s)
[577.580200] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[577.677757] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.109s)
[577.690974] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[577.789049] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.109s)
[577.800475] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[577.899892] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.109s)
[577.911020] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[578.011545] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.109s)
[578.023636] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[578.122695] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.109s)
[578.134660] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[578.233246] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[578.244490] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[578.344679] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s)
[578.355885] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[578.455934] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s)
[578.468282] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[578.578033] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.119s)
[578.589076] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[578.689227] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.109s)
[578.699532] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[578.800448] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.109s)
[578.841380] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[580.093559] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.258s)
[580.104942] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[580.193541] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[580.204980] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[580.293249] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[580.304889] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[580.404846] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s)
[580.416573] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[580.515331] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[580.526093] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[580.615431] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.098s)
[580.626874] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[580.715883] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s)
[580.727695] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[580.816211] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[580.827661] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[580.916025] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[580.927414] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[581.026553] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s)
[581.037950] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[581.137040] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[581.148300] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[581.248154] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s)
[581.259130] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[581.348674] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s)
[581.360268] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[581.448893] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[581.460132] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[581.548982] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[581.560527] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[581.659873] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s)
[581.670105] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[581.759376] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.098s)
[581.768903] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[581.859443] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.099s)
[581.869482] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[581.959999] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.099s)
[581.970117] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[582.059877] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.098s)
[582.070634] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[582.159927] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.098s)
[582.170118] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[582.270906] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.109s)
[582.281300] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[582.381527] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.109s)
[582.391983] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[582.492692] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.109s)
[582.503024] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[582.604010] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.109s)
[582.615542] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[582.715063] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.109s)
[582.726317] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[582.826326] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.109s)
[582.839925] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[582.936919] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.109s)
[582.948367] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[583.059889] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.121s)
[583.070888] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[583.170845] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.109s)
[583.185171] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[583.281781] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.108s)
[583.292643] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[583.393410] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s)
[583.403314] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[583.504194] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s)
[583.518694] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[583.625933] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.121s)
[583.637043] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[583.737257] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.109s)
[583.751861] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[583.848939] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.109s)
[583.881698] Subtest flip-change-tiling: SUCCESS (21.422s)
[585.081656] [105/133] (437s left) perf (sysctl-defaults)
[585.151357] Starting subtest: sysctl-defaults
[585.153958] Subtest sysctl-defaults: SUCCESS (0.000s)
[585.225906] [106/133] (437s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[585.318596] Starting subtest: primary-yf-tiled-reflect-x-90
[585.322778] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[585.393148] [107/133] (437s left) gem_exec_schedule (u-fairslice)
[585.471268] Starting subtest: u-fairslice
[585.473229] Starting dynamic subtest: rcs0
[587.486193] Dynamic subtest rcs0: SUCCESS (2.021s)
[587.495432] Starting dynamic subtest: bcs0
[589.502670] Dynamic subtest bcs0: SUCCESS (2.013s)
[589.512748] Starting dynamic subtest: vcs0
[591.519192] Dynamic subtest vcs0: SUCCESS (2.018s)
[591.527569] Starting dynamic subtest: vcs1
[593.541794] Dynamic subtest vcs1: SUCCESS (2.021s)
[593.552121] Starting dynamic subtest: vecs0
[595.560553] Dynamic subtest vecs0: SUCCESS (2.019s)
[595.569825] Starting dynamic subtest: ccs0
[597.583719] Dynamic subtest ccs0: SUCCESS (2.023s)
[597.585655] Subtest u-fairslice: SUCCESS (12.119s)
[597.884628] [108/133] (425s left) gem_exec_flush (basic-uc-set-default)
[597.940787] Starting subtest: basic-uc-set-default
[603.405493] Subtest basic-uc-set-default: SUCCESS (5.464s)
[603.590441] [109/133] (419s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[603.687499] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[610.868617] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.184s)
[610.982878] [110/133] (412s left) gem_exec_suspend (basic-s3-devices)
[611.059566] Starting subtest: basic-S3-devices
[611.062365] Starting dynamic subtest: smem
[622.871875] Dynamic subtest smem: SUCCESS (11.810s)
[622.874647] Subtest basic-S3-devices: SUCCESS (11.812s)
[623.072353] [111/133] (400s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[623.142349] Starting subtest: rel-constants-invalid-rel-gen5
[623.144747] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[623.244453] [112/133] (400s left) kms_properties (crtc-properties-legacy)
[623.359491] Starting subtest: crtc-properties-legacy
[623.361409] Starting dynamic subtest: pipe-A-eDP-1
[623.817308] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.454s)
[623.828314] Starting dynamic subtest: pipe-B-eDP-1
[624.942364] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.125s)
[624.956797] Starting dynamic subtest: pipe-C-eDP-1
[626.067748] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.124s)
[626.078565] Starting dynamic subtest: pipe-D-eDP-1
[627.207058] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.140s)
[627.209421] Subtest crtc-properties-legacy: SUCCESS (3.850s)
[628.024928] [113/133] (395s left) kms_flip (2x-nonexisting-fb-interruptible)
[628.120747] Starting subtest: 2x-nonexisting-fb-interruptible
[628.131835] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.011s)
[628.213646] [114/133] (395s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[628.306424] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[628.310414] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[628.423795] [115/133] (395s left) kms_setmode (invalid-clone-single-crtc)
[628.471738] Starting subtest: invalid-clone-single-crtc
[628.478454] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[628.580220] [116/133] (394s left) gem_create (hog-create)
[628.635325] Starting subtest: hog-create
[628.637966] Starting dynamic subtest: smem0
[661.919524] Dynamic subtest smem0: SUCCESS (33.280s)
[661.922372] Subtest hog-create: SUCCESS (33.282s)
[662.113414] [117/133] (361s left) gem_eio (in-flight-external)
[662.363019] Starting subtest: in-flight-external
[663.976303] Subtest in-flight-external: SUCCESS (1.614s)
[664.096830] [118/133] (359s left) gem_exec_balancer (bonded-chain)
[664.155412] Starting subtest: bonded-chain
[671.161140] Subtest bonded-chain: SUCCESS (7.004s)
[671.495075] [119/133] (352s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[671.594482] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[678.774344] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.181s)
[678.931491] [120/133] (344s left) kms_flip (wf_vblank-ts-check-interruptible)
[679.026973] Starting subtest: wf_vblank-ts-check-interruptible
[679.029267] Starting dynamic subtest: A-eDP1
[687.898563] Dynamic subtest A-eDP1: SUCCESS (8.869s)
[687.914085] Starting dynamic subtest: B-eDP1
[696.837777] Dynamic subtest B-eDP1: SUCCESS (8.936s)
[696.848776] Starting dynamic subtest: C-eDP1
[705.760195] Dynamic subtest C-eDP1: SUCCESS (8.921s)
[705.772222] Starting dynamic subtest: D-eDP1
[714.687311] Dynamic subtest D-eDP1: SUCCESS (8.925s)
[714.689715] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.660s)
[715.911340] [121/133] (307s left) prime_busy (hang-wait)
[715.980549] Starting subtest: hang-wait
[715.982957] Starting dynamic subtest: rcs0
[742.385366] Dynamic subtest rcs0: SUCCESS (26.400s)
[742.396582] Starting dynamic subtest: bcs0
[749.543959] Dynamic subtest bcs0: SUCCESS (7.156s)
[749.555589] Starting dynamic subtest: vcs0
[756.521753] Dynamic subtest vcs0: SUCCESS (6.973s)
[756.532824] Starting dynamic subtest: vcs1
[763.494076] Dynamic subtest vcs1: SUCCESS (6.971s)
[763.503833] Starting dynamic subtest: vecs0
[770.532403] Dynamic subtest vecs0: SUCCESS (7.039s)
[770.541778] Starting dynamic subtest: ccs0
[784.370734] Dynamic subtest ccs0: SUCCESS (13.834s)
[784.373422] Subtest hang-wait: SUCCESS (68.386s)
[784.501920] [122/133] (239s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[784.624521] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[784.629058] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[784.772258] [123/133] (239s left) i915_query (test-query-geometry-subslices)
[784.833800] Starting subtest: test-query-geometry-subslices
[784.836221] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[784.954782] [124/133] (238s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[785.035050] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[785.037312] Starting dynamic subtest: pipe-A-eDP-1
[785.057557] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[785.069425] Starting dynamic subtest: pipe-B-eDP-1
[785.088828] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[785.098675] Starting dynamic subtest: pipe-C-eDP-1
[785.117945] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[785.127435] Starting dynamic subtest: pipe-D-eDP-1
[785.146654] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[785.148865] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[787.286727] [125/133] (236s left) gem_basic (create-fd-close)
[787.356485] Starting subtest: create-fd-close
[787.360668] Subtest create-fd-close: SUCCESS (0.000s)
[787.473542] [126/133] (236s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[787.573039] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[787.577436] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[787.644951] [127/133] (236s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[787.734033] Starting subtest: read-crc-frame-sequence
[787.736433] Starting dynamic subtest: pipe-A-eDP-1
[788.443967] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.711s)
[788.454419] Starting dynamic subtest: pipe-B-eDP-1
[789.851725] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.405s)
[789.862764] Starting dynamic subtest: pipe-C-eDP-1
[791.168220] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.316s)
[791.180894] Starting dynamic subtest: pipe-D-eDP-1
[792.479942] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.311s)
[792.482641] Subtest read-crc-frame-sequence: SUCCESS (4.749s)
[793.321439] [128/133] (230s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[793.422074] Starting subtest: multiplane-rotation-cropping-bottom
[810.825463] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.405s)
[810.959718] [129/133] (213s left) gem_pwrite (basic-random)
[811.026494] Subtest basic-random: SKIP (0.000s)
[811.077748] [130/133] (213s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[811.142350] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[811.251034] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.107s)
[811.325206] [131/133] (212s left) kms_mmap_write_crc (main)
[811.416893] Starting subtest: main
[811.419264] Starting dynamic subtest: pipe-A-eDP-1
[814.859545] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.442s)
[814.861811] Subtest main: SUCCESS (3.443s)
[815.728940] [132/133] (208s left) kms_chamelium_audio (dp-audio-edid)
[816.113555] Subtest dp-audio-edid: SKIP (0.000s)
[816.928755] [133/133] (207s left) fbdev (unaligned-write)
[816.979460] Starting subtest: unaligned-write
[817.078971] Subtest unaligned-write: SUCCESS (0.101s)
[817.137062] 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.