[62.994184] Initializing watchdogs
[62.994229]   /dev/watchdog0
[63.007653] [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]
[63.011803] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[63.013902] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.017110] [001/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[63.144560] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[63.149034] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[63.228320] [002/133] (960s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[63.323865] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[63.328368] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[63.388478] [003/133] (960s left) prime_vgem (coherency-gtt)
[63.487731] Starting subtest: coherency-gtt
[63.492436] Subtest coherency-gtt: SKIP (0.000s)
[63.579034] [FACT prime_vgem (coherency-gtt)] new: kernel.kmod_is_loaded.vgem: true
[63.582702] [004/133] (960s left) gem_exec_whisper (basic-fds-forked)
[63.640813] Starting subtest: basic-fds-forked
[88.139508] Subtest basic-fds-forked: SUCCESS (24.487s)
[88.313519] [005/133] (935s left) gen9_exec_parse (bb-start-param)
[88.387088] Subtest bb-start-param: SKIP (0.000s)
[88.457730] [006/133] (935s left) perf (mi-rpc)
[88.581601] Starting subtest: mi-rpc
[88.585729] Subtest mi-rpc: SKIP (0.000s)
[88.621855] [007/133] (935s left) syncobj_wait (invalid-signal-bad-pad)
[88.679270] Starting subtest: invalid-signal-bad-pad
[88.681665] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[88.778496] [008/133] (935s left) syncobj_timeline (wait-all-for-submit-snapshot)
[88.838065] Starting subtest: wait-all-for-submit-snapshot
[88.920941] Subtest wait-all-for-submit-snapshot: SUCCESS (0.083s)
[88.995236] [009/133] (934s left) kms_setmode (basic)
[89.054933] Starting subtest: basic
[89.412475] Starting dynamic subtest: pipe-A-eDP-1
[91.474335] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.057s)
[91.815443] Starting dynamic subtest: pipe-B-eDP-1
[93.898451] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.084s)
[94.207059] Subtest basic: SUCCESS (5.150s)
[95.039767] [010/133] (928s left) gem_ctx_shared (exec-shared-gtt)
[95.100526] Starting subtest: exec-shared-gtt
[95.102643] Starting dynamic subtest: rcs0
[95.106739] Dynamic subtest rcs0: SUCCESS (0.008s)
[95.114395] Starting dynamic subtest: bcs0
[95.116573] Dynamic subtest bcs0: SUCCESS (0.005s)
[95.125913] Starting dynamic subtest: vcs0
[95.127816] Dynamic subtest vcs0: SUCCESS (0.010s)
[95.135543] Starting dynamic subtest: vcs1
[95.137736] Dynamic subtest vcs1: SUCCESS (0.006s)
[95.150027] Starting dynamic subtest: vecs0
[95.151866] Dynamic subtest vecs0: SUCCESS (0.008s)
[95.158274] Starting dynamic subtest: ccs0
[95.160097] Dynamic subtest ccs0: SUCCESS (0.005s)
[95.161883] Subtest exec-shared-gtt: SUCCESS (0.046s)
[95.326623] [011/133] (928s left) kms_pm_backlight (bad-brightness)
[95.423103] Starting subtest: bad-brightness
[95.488711] Starting dynamic subtest: eDP-1
[95.770630] Dynamic subtest eDP-1: SUCCESS (0.280s)
[95.773499] Subtest bad-brightness: SUCCESS (0.348s)
[96.560415] [012/133] (927s left) gem_ctx_param (invalid-get-ringsize)
[96.608690] Starting subtest: invalid-get-ringsize
[96.611089] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[96.698692] [013/133] (927s left) kms_chamelium_color (gamma)
[96.790953] Subtest gamma: SKIP (0.000s)
[96.833669] [014/133] (927s left) gem_exec_create (basic)
[96.891856] Starting subtest: basic
[96.894223] Starting dynamic subtest: smem
[98.979741] Dynamic subtest smem: SUCCESS (2.087s)
[98.982203] Subtest basic: SUCCESS (2.088s)
[99.160756] [015/133] (924s left) gem_flink_basic (flink-lifetime)
[99.220648] Starting subtest: flink-lifetime
[99.223050] Subtest flink-lifetime: SUCCESS (0.002s)
[99.330606] [016/133] (924s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[99.930167] Starting subtest: syncobj-timeline-multiple-ext-nodes
[99.932948] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.006s)
[100.967872] [017/133] (923s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[101.059706] Starting subtest: plane-all-modeset-transition-internal-panels
[101.061902] Starting dynamic subtest: pipe-A-eDP-1
[102.415196] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.354s)
[102.690234] Starting dynamic subtest: pipe-B-eDP-1
[103.743112] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.060s)
[104.007289] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.948s)
[104.846022] [018/133] (919s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[104.945074] Starting subtest: bo-too-small-due-to-tiling
[104.949457] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[105.033623] [019/133] (919s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[105.137670] Starting subtest: 4-tiled-32bpp-rotate-0
[106.449162] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.311s)
[106.605900] [020/133] (917s left) gem_media_fill (media-fill)
[106.667093] Subtest media-fill: SKIP (0.000s)
[106.781306] [021/133] (917s left) kms_psr (fbc-pr-no-drrs)
[106.862015] Starting subtest: fbc-pr-no-drrs
[106.865314] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[106.933630] [022/133] (917s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[107.035372] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[107.039031] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[107.130176] [023/133] (917s left) dumb_buffer (create-clear)
[107.187275] Starting subtest: create-clear
[140.751663] Subtest create-clear: SUCCESS (33.562s)
[140.867392] [024/133] (883s left) vgem_basic (bad-pad)
[140.918845] Starting subtest: bad-pad
[140.920799] Subtest bad-pad: SUCCESS (0.000s)
[140.979018] [025/133] (883s left) gem_fence_thrash (bo-write-verify-none)
[141.012942] Starting subtest: bo-write-verify-none
[141.042029] Subtest bo-write-verify-none: SKIP (0.025s)
[141.103046] [026/133] (883s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[141.197697] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[147.880760] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.686s)
[147.969071] [027/133] (876s left) kms_async_flips (test-time-stamp)
[148.066245] Starting subtest: test-time-stamp
[148.437410] Starting dynamic subtest: pipe-A-eDP-1
[149.205866] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.765s)
[149.568795] Starting dynamic subtest: pipe-B-eDP-1
[150.331049] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.766s)
[150.700786] Starting dynamic subtest: pipe-C-eDP-1
[151.460173] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.764s)
[151.822305] Starting dynamic subtest: pipe-D-eDP-1
[152.589802] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.772s)
[152.592318] Subtest test-time-stamp: SUCCESS (4.522s)
[153.743221] [028/133] (870s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[153.822074] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[153.824365] Starting dynamic subtest: pipe-A-eDP-1
[153.846641] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[153.856115] Starting dynamic subtest: pipe-B-eDP-1
[153.877268] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[153.884115] Starting dynamic subtest: pipe-C-eDP-1
[153.905132] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[153.911685] Starting dynamic subtest: pipe-D-eDP-1
[153.932546] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[153.936623] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.004s)
[156.107033] [029/133] (868s left) vgem_basic (dmabuf-fence-before)
[156.150800] Starting subtest: dmabuf-fence-before
[156.152631] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[156.204853] [030/133] (868s left) kms_cursor_edge_walk (64x64-left-edge)
[156.288057] Starting subtest: 64x64-left-edge
[156.290636] Starting dynamic subtest: pipe-A-eDP-1
[159.791223] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.502s)
[159.798920] Starting dynamic subtest: pipe-D-eDP-1
[162.925125] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.132s)
[162.927395] Subtest 64x64-left-edge: SUCCESS (6.636s)
[163.734664] [031/133] (860s left) gem_ringfill (basic-all)
[169.943989] Starting subtest: basic-all
[171.114572] Subtest basic-all: SUCCESS (1.170s)
[171.252954] [032/133] (853s left) gem_mmap_gtt (zero-extend)
[171.304212] Subtest zero-extend: SKIP (0.000s)
[171.363756] [033/133] (853s left) gem_partial_pwrite_pread (write-display)
[171.421378] Subtest write-display: SKIP (0.000s)
[171.493841] [034/133] (853s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[171.597884] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[171.602240] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[171.675613] [035/133] (853s left) syncobj_timeline (signal)
[171.734933] Starting subtest: signal
[171.737316] Subtest signal: SUCCESS (0.000s)
[171.840297] [036/133] (853s left) kms_draw_crc (draw-method-mmap-gtt)
[171.928762] Starting subtest: draw-method-mmap-gtt
[171.933229] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[172.024100] [037/133] (852s left) gem_lmem_swapping (parallel-multi)
[172.072355] Subtest parallel-multi: SKIP (0.000s)
[172.106160] [038/133] (852s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[172.202723] Starting subtest: x-tiled-32bpp-rotate-0
[173.639893] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.436s)
[173.804148] [039/133] (851s left) syncobj_wait (multi-wait-submitted-signaled)
[173.866471] Starting subtest: multi-wait-submitted-signaled
[173.868439] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[173.968673] [040/133] (851s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[174.071192] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[174.074662] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[174.182460] [041/133] (850s left) gem_ctx_persistence (many-contexts)
[174.237654] Starting subtest: many-contexts
[219.407207] Subtest many-contexts: SUCCESS (45.165s)
[219.496216] [042/133] (805s left) gem_exec_schedule (pi-ringfull)
[219.679674] Starting subtest: pi-ringfull
[219.682211] Starting dynamic subtest: rcs0
[219.715141] Dynamic subtest rcs0: SUCCESS (0.039s)
[219.723488] Starting dynamic subtest: bcs0
[219.755063] Dynamic subtest bcs0: SUCCESS (0.039s)
[219.762895] Starting dynamic subtest: vcs0
[219.787385] Dynamic subtest vcs0: SUCCESS (0.032s)
[219.794909] Starting dynamic subtest: vcs1
[219.819197] Dynamic subtest vcs1: SUCCESS (0.031s)
[219.826931] Starting dynamic subtest: vecs0
[219.850407] Dynamic subtest vecs0: SUCCESS (0.031s)
[219.862265] Starting dynamic subtest: ccs0
[219.879816] Dynamic subtest ccs0: SUCCESS (0.029s)
[219.882123] Subtest pi-ringfull: SUCCESS (0.205s)
[220.111669] [043/133] (805s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[220.224979] Starting subtest: extended-pageflip-modeset-hang-oldfb
[220.226987] Starting dynamic subtest: pipe-A
[228.114640] Dynamic subtest pipe-A: SUCCESS (7.890s)
[228.123901] Starting dynamic subtest: pipe-D
[236.724612] Dynamic subtest pipe-D: SUCCESS (8.606s)
[236.726923] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.499s)
[237.594290] [044/133] (787s left) kms_cursor_crc (cursor-random-256x256)
[237.840079] Starting subtest: cursor-random-256x256
[237.845041] Starting dynamic subtest: pipe-A-eDP-1
[241.185782] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.340s)
[241.212126] Starting dynamic subtest: pipe-D-eDP-1
[245.201599] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.995s)
[245.203528] Subtest cursor-random-256x256: SUCCESS (7.359s)
[246.042929] [045/133] (779s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[246.148250] Starting subtest: async-flip-with-page-flip-events-linear
[246.529046] Starting dynamic subtest: pipe-A-eDP-1
[249.312287] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.781s)
[249.678474] Starting dynamic subtest: pipe-B-eDP-1
[252.441598] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.768s)
[252.807591] Starting dynamic subtest: pipe-C-eDP-1
[255.572552] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.776s)
[255.931392] Starting dynamic subtest: pipe-D-eDP-1
[258.697077] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.771s)
[258.699578] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.548s)
[259.881228] [046/133] (765s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[259.996385] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[260.000604] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[260.099213] [047/133] (765s left) kms_universal_plane (universal-plane-functional)
[260.182046] Starting subtest: universal-plane-functional
[260.183980] Starting dynamic subtest: pipe-A-eDP-1
[264.139253] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.957s)
[264.148737] Starting dynamic subtest: pipe-B-eDP-1
[268.624802] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.482s)
[268.633669] Starting dynamic subtest: pipe-C-eDP-1
[272.983958] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.360s)
[272.993783] Starting dynamic subtest: pipe-D-eDP-1
[277.300514] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.316s)
[277.302871] Subtest universal-plane-functional: SUCCESS (17.120s)
[278.174608] [048/133] (747s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[278.281317] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[278.285155] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[278.381904] [049/133] (747s left) gem_pxp (reject-modify-context-protection-on)
[278.517024] Starting subtest: reject-modify-context-protection-on
[278.519457] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[278.642890] [050/133] (746s left) perf_pmu (render-node-busy-idle)
[278.709054] Starting subtest: render-node-busy-idle
[278.711288] Starting dynamic subtest: rcs0
[279.398690] Dynamic subtest rcs0: SUCCESS (0.689s)
[279.412474] Starting dynamic subtest: bcs0
[280.061806] Dynamic subtest bcs0: SUCCESS (0.661s)
[280.072070] Starting dynamic subtest: vcs0
[281.876438] Dynamic subtest vcs0: SUCCESS (1.811s)
[281.887762] Starting dynamic subtest: vcs1
[283.924701] Dynamic subtest vcs1: SUCCESS (2.046s)
[283.936672] Starting dynamic subtest: vecs0
[285.908527] Dynamic subtest vecs0: SUCCESS (1.981s)
[285.919634] Starting dynamic subtest: ccs0
[286.577361] Dynamic subtest ccs0: SUCCESS (0.668s)
[286.579872] Subtest render-node-busy-idle: SUCCESS (7.869s)
[286.653555] [051/133] (738s left) gem_readwrite (write-bad-handle)
[286.722745] Subtest write-bad-handle: SKIP (0.000s)
[286.785223] [052/133] (738s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[286.837884] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[286.945090] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[287.020890] [053/133] (738s left) syncobj_timeline (invalid-wait-illegal-handle)
[287.074065] Starting subtest: invalid-wait-illegal-handle
[287.076331] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[287.176814] [054/133] (738s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[287.269744] Starting subtest: yf-tiled-16bpp-rotate-0
[287.274101] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[287.380434] [055/133] (738s left) gem_softpin (safe-alignment)
[287.431601] Starting subtest: safe-alignment
[287.459080] Subtest safe-alignment: SUCCESS (0.027s)
[288.954063] [056/133] (736s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[289.051104] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[289.055359] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[289.147406] [057/133] (736s left) gem_userptr_blits (create-destroy-unsync)
[289.215756] Subtest create-destroy-unsync: SKIP (0.000s)
[289.321336] [058/133] (736s left) api_intel_bb (object-noreloc-keep-cache-simple)
[289.373171] Starting subtest: object-noreloc-keep-cache-simple
[289.376219] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.005s)
[289.487536] [059/133] (736s left) gem_exec_params (dr4-dirt)
[289.542876] Starting subtest: DR4-dirt
[289.545723] Subtest DR4-dirt: SUCCESS (0.000s)
[289.633445] [060/133] (736s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[289.732550] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[289.736749] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[289.826108] [061/133] (736s left) i915_pm_rps (fence-order)
[289.885885] Starting subtest: fence-order
[292.861368] Subtest fence-order: SUCCESS (2.974s)
[292.996779] [062/133] (732s left) gem_exec_fence (expired-history)
[293.457548] Starting subtest: expired-history
[300.627403] Subtest expired-history: SUCCESS (7.170s)
[301.188769] [063/133] (724s left) kms_psr (pr-cursor-plane-onoff)
[301.290288] Starting subtest: pr-cursor-plane-onoff
[301.294672] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[301.359256] [064/133] (724s left) kms_psr (psr2-cursor-render)
[301.455206] Starting subtest: psr2-cursor-render
[301.457446] Starting dynamic subtest: eDP-1
[303.154403] Dynamic subtest eDP-1: SUCCESS (1.698s)
[303.156612] Subtest psr2-cursor-render: SUCCESS (1.699s)
[303.948012] [065/133] (722s left) gen9_exec_parse (shadow-peek)
[304.008843] Subtest shadow-peek: SKIP (0.000s)
[304.076030] [066/133] (722s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[304.173314] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[311.016858] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.845s)
[311.138777] [067/133] (714s left) gem_exec_reloc (basic-concurrent16)
[311.194029] Subtest basic-concurrent16: SKIP (0.000s)
[311.274680] [068/133] (714s left) kms_frontbuffer_tracking (fbc-2p-rte)
[311.363323] Starting subtest: fbc-2p-rte
[311.367345] Subtest fbc-2p-rte: SKIP (0.000s)
[311.465201] [069/133] (714s left) gem_unfence_active_buffers
[311.628661] [070/133] (714s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[311.729252] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[311.731444] Starting dynamic subtest: pipe-A-eDP-1
[311.753796] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[311.764550] Starting dynamic subtest: pipe-B-eDP-1
[311.785392] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[311.792947] Starting dynamic subtest: pipe-C-eDP-1
[311.813707] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[311.821292] Starting dynamic subtest: pipe-D-eDP-1
[311.842263] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[311.846588] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[314.047228] [071/133] (712s left) gem_wait (wait)
[314.116812] Starting subtest: wait
[314.119121] Starting dynamic subtest: all-engines
[315.924381] Dynamic subtest all-engines: SUCCESS (1.805s)
[315.935996] Starting dynamic subtest: rcs0
[316.969497] Dynamic subtest rcs0: SUCCESS (1.044s)
[316.981156] Starting dynamic subtest: bcs0
[318.017654] Dynamic subtest bcs0: SUCCESS (1.046s)
[318.028385] Starting dynamic subtest: vcs0
[319.061591] Dynamic subtest vcs0: SUCCESS (1.042s)
[319.072136] Starting dynamic subtest: vcs1
[320.105589] Dynamic subtest vcs1: SUCCESS (1.042s)
[320.116211] Starting dynamic subtest: vecs0
[321.149729] Dynamic subtest vecs0: SUCCESS (1.042s)
[321.161123] Starting dynamic subtest: ccs0
[322.196603] Dynamic subtest ccs0: SUCCESS (1.045s)
[322.199071] Subtest wait: SUCCESS (8.080s)
[322.395937] [072/133] (703s left) kms_pm_rpm (cursor)
[324.027297] Starting subtest: cursor
[324.032136] Subtest cursor: SKIP (0.000s)
[324.673574] [073/133] (701s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[324.764305] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[324.766478] Starting dynamic subtest: pipe-A-eDP-1
[324.786388] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[324.796695] Starting dynamic subtest: pipe-B-eDP-1
[324.815611] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[324.823810] Starting dynamic subtest: pipe-C-eDP-1
[324.842713] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[324.851227] Starting dynamic subtest: pipe-D-eDP-1
[324.870356] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[324.872530] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[327.023383] [074/133] (699s left) i915_hangman (gt-error-state-capture)
[327.085268] Starting subtest: gt-error-state-capture
[327.087376] Starting dynamic subtest: rcs0
[338.867511] Dynamic subtest rcs0: SUCCESS (11.779s)
[338.879432] Starting dynamic subtest: bcs0
[350.900035] Dynamic subtest bcs0: SUCCESS (12.029s)
[350.911439] Starting dynamic subtest: vcs0
[362.802892] Dynamic subtest vcs0: SUCCESS (11.900s)
[362.814786] Starting dynamic subtest: vcs1
[373.875468] Dynamic subtest vcs1: SUCCESS (11.069s)
[373.887438] Starting dynamic subtest: vecs0
[385.843710] Dynamic subtest vecs0: SUCCESS (11.964s)
[385.857681] Starting dynamic subtest: ccs0
[397.875861] Dynamic subtest ccs0: SUCCESS (12.029s)
[397.879076] Subtest gt-error-state-capture: SUCCESS (70.789s)
[397.955907] [075/133] (628s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[398.071153] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[398.075569] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[398.142912] [076/133] (628s left) kms_pm_rpm (modeset-pc8-residency-stress)
[400.075601] Starting subtest: modeset-pc8-residency-stress
[400.080553] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[400.447849] [077/133] (626s left) kms_plane (plane-panning-bottom-right)
[400.546134] Starting subtest: plane-panning-bottom-right
[400.548528] Starting dynamic subtest: pipe-A
[402.186421] Dynamic subtest pipe-A: SUCCESS (1.638s)
[402.195962] Starting dynamic subtest: pipe-B
[404.548174] Dynamic subtest pipe-B: SUCCESS (2.362s)
[404.550675] Subtest plane-panning-bottom-right: SUCCESS (4.003s)
[405.346139] [078/133] (621s left) kms_flip (absolute-wf_vblank)
[405.440624] Starting subtest: absolute-wf_vblank
[405.442958] Starting dynamic subtest: A-eDP1
[414.208581] Dynamic subtest A-eDP1: SUCCESS (8.770s)
[414.221615] Starting dynamic subtest: B-eDP1
[422.946043] Dynamic subtest B-eDP1: SUCCESS (8.736s)
[422.955576] Starting dynamic subtest: C-eDP1
[431.658253] Dynamic subtest C-eDP1: SUCCESS (8.711s)
[431.667520] Starting dynamic subtest: D-eDP1
[440.382685] Dynamic subtest D-eDP1: SUCCESS (8.723s)
[440.387952] Subtest absolute-wf_vblank: SUCCESS (34.948s)
[441.590814] [079/133] (585s left) kms_invalid_mode (zero-vdisplay)
[441.683889] Starting subtest: zero-vdisplay
[441.686103] Starting dynamic subtest: pipe-A-eDP-1
[441.966652] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[441.976161] Starting dynamic subtest: pipe-B-eDP-1
[441.978060] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[441.985895] Starting dynamic subtest: pipe-C-eDP-1
[441.988175] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[441.996068] Starting dynamic subtest: pipe-D-eDP-1
[441.998311] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[442.000525] Subtest zero-vdisplay: SUCCESS (0.291s)
[442.844767] [080/133] (583s left) api_intel_allocator (open-vm)
[442.902080] Starting subtest: open-vm
[442.904472] Subtest open-vm: SUCCESS (0.003s)
[443.028713] [081/133] (583s left) gem_mmap_wc (coherency)
[443.080540] Subtest coherency: SKIP (0.000s)
[443.137247] [082/133] (583s left) kms_psr (fbc-psr-dpms)
[443.243041] Starting subtest: fbc-psr-dpms
[443.245341] Starting dynamic subtest: eDP-1
[443.249748] Dynamic subtest eDP-1: SKIP (0.000s)
[443.254183] Subtest fbc-psr-dpms: SKIP (0.001s)
[443.315648] [083/133] (583s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[443.366094] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[443.434024] [084/133] (583s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[443.522326] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[443.526871] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[443.614166] [085/133] (583s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[443.721673] Starting subtest: cursorA-vs-flipA-legacy
[454.856641] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.135s)
[455.650714] [086/133] (571s left) kms_plane_multiple (tiling-x)
[455.749305] Starting subtest: tiling-x
[455.751653] Starting dynamic subtest: pipe-A-eDP-1
[459.382306] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.630s)
[459.392105] Starting dynamic subtest: pipe-B-eDP-1
[463.812883] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.432s)
[463.822461] Starting dynamic subtest: pipe-C-eDP-1
[468.132756] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.317s)
[468.142540] Starting dynamic subtest: pipe-D-eDP-1
[472.468141] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.335s)
[472.469970] Subtest tiling-x: SUCCESS (16.719s)
[473.284671] [087/133] (553s left) kms_psr (fbc-pr-suspend)
[473.374125] Starting subtest: fbc-pr-suspend
[473.378210] Subtest fbc-pr-suspend: SKIP (0.000s)
[473.451132] [088/133] (553s left) kms_vrr (seamless-rr-switch-drrs)
[473.554705] Starting subtest: seamless-rr-switch-drrs
[473.561153] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[473.628262] [089/133] (553s left) kms_prop_blob (invalid-set-prop-any)
[473.685330] Starting subtest: invalid-set-prop-any
[473.687214] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[473.776697] [090/133] (553s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[473.880421] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[473.884298] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[473.992956] [091/133] (553s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[474.375721] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[475.177478] [092/133] (551s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[475.271333] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[475.275316] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[475.364616] [093/133] (551s left) kms_vblank (wait-forked-hang)
[475.450228] Starting subtest: wait-forked-hang
[475.452312] Starting dynamic subtest: pipe-A-eDP-1
[501.664182] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.213s)
[501.677771] Starting dynamic subtest: pipe-D-eDP-1
[525.650231] Dynamic subtest pipe-D-eDP-1: SUCCESS (23.983s)
[525.652513] Subtest wait-forked-hang: SUCCESS (50.201s)
[526.460981] [094/133] (500s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[526.592498] Starting subtest: cursor-vs-flip-atomic
[555.907552] Subtest cursor-vs-flip-atomic: SUCCESS (29.314s)
[556.797130] [095/133] (470s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[556.905802] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[556.910402] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[557.006413] [096/133] (470s left) kms_content_protection (legacy)
[557.147423] Starting subtest: legacy
[557.152231] Subtest legacy: SKIP (0.000s)
[557.273600] [097/133] (470s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[557.381483] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[557.386057] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[557.488419] [098/133] (469s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[557.591566] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[564.160988] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.572s)
[564.308568] [099/133] (463s left) gem_fence_thrash (bo-write-verify-threaded-y)
[564.354681] Starting subtest: bo-write-verify-threaded-y
[564.382608] Subtest bo-write-verify-threaded-y: SKIP (0.025s)
[564.436888] [100/133] (463s left) kms_cursor_crc (cursor-offscreen-512x170)
[564.748961] Starting subtest: cursor-offscreen-512x170
[564.753714] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[564.888894] [101/133] (462s left) kms_big_fb (linear-32bpp-rotate-180)
[564.987591] Starting subtest: linear-32bpp-rotate-180
[566.610193] Subtest linear-32bpp-rotate-180: SUCCESS (1.623s)
[566.741799] [102/133] (460s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[566.835349] Starting subtest: plane-lut1d-pre-ctm3x4
[566.992076] Starting dynamic subtest: pipe-A-plane-0
[567.308136] Dynamic subtest pipe-A-plane-0: FAIL (0.182s)
[567.318724] Starting dynamic subtest: pipe-A-plane-1
[567.522884] Dynamic subtest pipe-A-plane-1: FAIL (0.174s)
[567.533505] Starting dynamic subtest: pipe-A-plane-2
[567.740987] Dynamic subtest pipe-A-plane-2: FAIL (0.184s)
[568.745701] Starting dynamic subtest: pipe-B-plane-0
[569.176442] Dynamic subtest pipe-B-plane-0: FAIL (0.163s)
[569.186707] Starting dynamic subtest: pipe-B-plane-1
[569.503226] Dynamic subtest pipe-B-plane-1: FAIL (0.166s)
[569.513409] Starting dynamic subtest: pipe-B-plane-2
[569.806813] Dynamic subtest pipe-B-plane-2: FAIL (0.167s)
[570.426717] Starting dynamic subtest: pipe-C-plane-0
[570.907276] Dynamic subtest pipe-C-plane-0: FAIL (0.129s)
[570.916954] Starting dynamic subtest: pipe-C-plane-1
[571.312172] Dynamic subtest pipe-C-plane-1: FAIL (0.589s)
[571.332358] Starting dynamic subtest: pipe-C-plane-2
[571.685600] Dynamic subtest pipe-C-plane-2: FAIL (0.148s)
[572.457076] Starting dynamic subtest: pipe-D-plane-0
[573.063259] Dynamic subtest pipe-D-plane-0: FAIL (0.151s)
[573.073672] Starting dynamic subtest: pipe-D-plane-1
[573.528912] Dynamic subtest pipe-D-plane-1: FAIL (0.619s)
[573.539102] Starting dynamic subtest: pipe-D-plane-2
[573.977519] Dynamic subtest pipe-D-plane-2: FAIL (0.544s)
[574.066797] Subtest plane-lut1d-pre-ctm3x4: FAIL (7.233s)
[574.922576] [103/133] (452s left) gem_exec_params (batch-first)
[574.982370] Starting subtest: batch-first
[574.987486] Subtest batch-first: SUCCESS (0.005s)
[575.120872] [104/133] (452s left) kms_flip_tiling (flip-change-tiling)
[575.203083] Starting subtest: flip-change-tiling
[575.205311] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[575.375931] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.173s)
[575.387359] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[575.510252] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[575.522127] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[575.643035] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[575.654803] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[575.775653] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.131s)
[575.787085] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[575.919557] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[575.931696] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[576.091926] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.170s)
[576.103572] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[576.225551] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[576.236146] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[576.336672] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[576.348134] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[576.471549] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[576.490659] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[576.614464] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[576.626790] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[576.746973] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.131s)
[576.761642] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[576.891770] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.143s)
[576.902560] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[577.025450] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[577.037072] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[577.159917] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[577.171944] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[577.269962] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[577.281627] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[577.403243] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.131s)
[577.415237] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[577.547332] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[577.559047] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[577.692122] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[577.703402] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[577.824840] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.131s)
[577.836157] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[577.969854] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[577.981224] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[578.103126] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.131s)
[578.113717] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[578.225137] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.120s)
[578.238759] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[578.391593] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.164s)
[578.401588] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[578.536183] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.142s)
[578.547083] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[578.680432] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[578.691501] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[578.824566] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[578.837584] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[578.969630] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[578.981040] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[579.113672] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.142s)
[579.124561] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[579.236192] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.120s)
[579.249880] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[579.408641] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.170s)
[579.420041] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[579.552454] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[579.566179] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[579.696946] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[579.707899] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[579.842077] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[579.853590] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[579.985906] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.142s)
[579.997120] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[580.130808] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.143s)
[580.141661] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[580.252857] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.120s)
[580.305234] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[581.495850] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.196s)
[581.507411] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[581.630078] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[581.641731] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[581.763670] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[581.776053] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[581.907209] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s)
[581.919375] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[582.050612] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[582.062075] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[582.195539] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[582.211566] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[582.329580] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[582.341366] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[582.440313] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[582.452038] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[582.574670] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[582.585429] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[582.718056] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[582.731723] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[582.861559] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[582.873068] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[582.995051] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.131s)
[583.006792] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[583.128883] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[583.140162] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[583.263630] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[583.273399] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[583.373528] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[583.385197] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[583.507078] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.131s)
[583.517533] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[583.650419] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[583.661815] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[583.795283] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[583.805632] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[583.939641] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[583.953798] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[584.085075] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.143s)
[584.097103] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[584.229348] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[584.244014] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[584.350590] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.120s)
[584.369046] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[584.494816] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.142s)
[584.508121] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[584.639508] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.142s)
[584.652832] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[584.772735] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.131s)
[584.783909] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[584.917233] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[584.930470] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[585.061532] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[585.076854] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[585.217618] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.153s)
[585.227855] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[585.339715] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.120s)
[585.351062] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[585.484238] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.142s)
[585.494564] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[585.627956] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[585.640415] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[585.772538] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[585.785953] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[585.916950] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[585.929431] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[586.061889] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.142s)
[586.076399] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[586.206711] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.142s)
[586.220498] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[586.339728] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.131s)
[586.393523] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[587.630459] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.243s)
[587.641930] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[587.730378] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[587.741945] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[587.841370] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.108s)
[587.857489] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[587.952709] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.108s)
[587.963894] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[588.063460] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[588.074299] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[588.163046] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.098s)
[588.174453] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[588.263852] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s)
[588.275022] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[588.363839] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[588.375543] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[588.463538] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[588.474897] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[588.563126] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.098s)
[588.573854] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[588.662802] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.098s)
[588.673558] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[588.762830] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.098s)
[588.773735] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[588.863656] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.099s)
[588.874634] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[588.964026] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[588.975408] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[589.063880] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[589.078070] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[589.174971] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.110s)
[589.185910] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[589.285265] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[589.295917] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[589.396463] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s)
[589.408846] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[589.507596] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.109s)
[589.519897] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[589.607936] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.098s)
[589.618517] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[589.708036] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.097s)
[589.722584] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[589.819213] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.109s)
[589.829699] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[589.929773] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.109s)
[589.940426] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[590.041057] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.109s)
[590.051603] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[590.152152] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.109s)
[590.163204] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[590.252082] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.098s)
[590.262804] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[590.351893] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.099s)
[590.362807] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[590.463136] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.109s)
[590.474095] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[590.574272] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.109s)
[590.585452] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[590.685916] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.109s)
[590.695421] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[590.785095] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.098s)
[590.795900] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[590.896476] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.110s)
[590.907976] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[591.007915] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s)
[591.019218] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[591.118910] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.110s)
[591.129366] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[591.230519] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.109s)
[591.241485] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[591.341581] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.109s)
[591.383063] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[592.586983] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.209s)
[592.598450] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[592.686860] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[592.696851] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[592.787022] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[592.799427] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[592.897555] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.108s)
[592.907066] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[593.008646] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[593.022695] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[593.119648] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.109s)
[593.129984] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[593.242631] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.120s)
[593.254072] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[593.353725] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[593.363534] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[593.453963] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[593.465451] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[593.553238] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.098s)
[593.563509] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[593.664145] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[593.678113] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[593.786472] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.119s)
[593.799439] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[593.897397] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.108s)
[593.910913] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[594.008819] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.109s)
[594.019771] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[594.119805] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[594.134571] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[594.241925] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.119s)
[594.253056] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[594.353365] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[594.368965] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[594.463575] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s)
[594.474908] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[594.575114] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.110s)
[594.586106] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[594.675630] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.098s)
[594.687103] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[594.775646] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.098s)
[594.787437] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[594.886554] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.110s)
[594.897367] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[594.997078] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.109s)
[595.007320] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[595.110445] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.110s)
[595.121571] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[595.208610] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.098s)
[595.220071] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[595.308278] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.099s)
[595.318453] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[595.408136] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.098s)
[595.418067] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[595.519503] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.110s)
[595.529757] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[595.631025] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.109s)
[595.642634] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[595.742123] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.109s)
[595.753588] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[595.841671] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.098s)
[595.852702] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[595.942566] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.099s)
[595.953755] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[596.041851] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.098s)
[596.053040] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[596.153063] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.110s)
[596.164604] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[596.264303] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.109s)
[596.275549] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[596.375606] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.109s)
[596.408406] Subtest flip-change-tiling: SUCCESS (21.206s)
[597.574464] [105/133] (430s left) perf (sysctl-defaults)
[597.638814] Starting subtest: sysctl-defaults
[597.641301] Subtest sysctl-defaults: SUCCESS (0.000s)
[597.713169] [106/133] (429s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[597.805065] Starting subtest: primary-yf-tiled-reflect-x-90
[597.809479] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[597.889173] [107/133] (429s left) gem_exec_schedule (u-fairslice)
[597.971109] Starting subtest: u-fairslice
[597.973095] Starting dynamic subtest: rcs0
[599.988086] Dynamic subtest rcs0: SUCCESS (2.023s)
[599.997688] Starting dynamic subtest: bcs0
[602.003359] Dynamic subtest bcs0: SUCCESS (2.016s)
[602.013187] Starting dynamic subtest: vcs0
[604.024856] Dynamic subtest vcs0: SUCCESS (2.020s)
[604.036645] Starting dynamic subtest: vcs1
[606.044136] Dynamic subtest vcs1: SUCCESS (2.019s)
[606.054402] Starting dynamic subtest: vecs0
[608.068368] Dynamic subtest vecs0: SUCCESS (2.020s)
[608.079240] Starting dynamic subtest: ccs0
[610.089472] Dynamic subtest ccs0: SUCCESS (2.023s)
[610.091369] Subtest u-fairslice: SUCCESS (12.126s)
[610.391093] [108/133] (417s left) gem_exec_flush (basic-uc-set-default)
[610.443504] Starting subtest: basic-uc-set-default
[615.907657] Subtest basic-uc-set-default: SUCCESS (5.465s)
[616.113905] [109/133] (411s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[616.213498] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[623.253754] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.042s)
[623.353617] [110/133] (404s left) gem_exec_suspend (basic-s3-devices)
[623.412695] Starting subtest: basic-S3-devices
[623.415081] Starting dynamic subtest: smem
[634.902027] Dynamic subtest smem: SUCCESS (11.486s)
[634.904950] Subtest basic-S3-devices: SUCCESS (11.489s)
[635.085265] [111/133] (392s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[635.149489] Starting subtest: rel-constants-invalid-rel-gen5
[635.151868] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[635.260326] [112/133] (392s left) kms_properties (crtc-properties-legacy)
[635.351057] Starting subtest: crtc-properties-legacy
[635.353355] Starting dynamic subtest: pipe-A-eDP-1
[635.785068] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.435s)
[635.795501] Starting dynamic subtest: pipe-B-eDP-1
[636.974562] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.187s)
[636.984656] Starting dynamic subtest: pipe-C-eDP-1
[638.104649] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.128s)
[638.114782] Starting dynamic subtest: pipe-D-eDP-1
[639.227868] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.123s)
[639.230208] Subtest crtc-properties-legacy: SUCCESS (3.878s)
[640.037451] [113/133] (387s left) kms_flip (2x-nonexisting-fb-interruptible)
[640.136112] Starting subtest: 2x-nonexisting-fb-interruptible
[640.147552] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.010s)
[640.220888] [114/133] (387s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[640.318991] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[640.323267] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[640.411505] [115/133] (387s left) kms_setmode (invalid-clone-single-crtc)
[640.461743] Starting subtest: invalid-clone-single-crtc
[640.468142] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[640.546858] [116/133] (387s left) gem_create (hog-create)
[640.601629] Starting subtest: hog-create
[640.603819] Starting dynamic subtest: smem0
[673.875277] Dynamic subtest smem0: SUCCESS (33.271s)
[673.877847] Subtest hog-create: SUCCESS (33.273s)
[674.078068] [117/133] (354s left) gem_eio (in-flight-external)
[674.320809] Starting subtest: in-flight-external
[676.005360] Subtest in-flight-external: SUCCESS (1.683s)
[676.158189] [118/133] (352s left) gem_exec_balancer (bonded-chain)
[676.219950] Starting subtest: bonded-chain
[683.215132] Subtest bonded-chain: SUCCESS (6.993s)
[683.551301] [119/133] (344s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[683.657307] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[690.697616] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.042s)
[690.828660] [120/133] (337s left) kms_flip (wf_vblank-ts-check-interruptible)
[690.943088] Starting subtest: wf_vblank-ts-check-interruptible
[690.948449] Starting dynamic subtest: A-eDP1
[699.833700] Dynamic subtest A-eDP1: SUCCESS (8.885s)
[699.847209] Starting dynamic subtest: B-eDP1
[708.771232] Dynamic subtest B-eDP1: SUCCESS (8.934s)
[708.782614] Starting dynamic subtest: C-eDP1
[717.684898] Dynamic subtest C-eDP1: SUCCESS (8.911s)
[717.697048] Starting dynamic subtest: D-eDP1
[726.537056] Dynamic subtest D-eDP1: SUCCESS (8.852s)
[726.542898] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.596s)
[727.767070] [121/133] (300s left) prime_busy (hang-wait)
[727.834930] Starting subtest: hang-wait
[727.837091] Starting dynamic subtest: rcs0
[754.414963] Dynamic subtest rcs0: SUCCESS (26.578s)
[754.424109] Starting dynamic subtest: bcs0
[761.506653] Dynamic subtest bcs0: SUCCESS (7.089s)
[761.515716] Starting dynamic subtest: vcs0
[768.483635] Dynamic subtest vcs0: SUCCESS (6.973s)
[768.492478] Starting dynamic subtest: vcs1
[775.521913] Dynamic subtest vcs1: SUCCESS (7.037s)
[775.532388] Starting dynamic subtest: vecs0
[782.497205] Dynamic subtest vecs0: SUCCESS (6.972s)
[782.508315] Starting dynamic subtest: ccs0
[796.399562] Dynamic subtest ccs0: SUCCESS (13.899s)
[796.402079] Subtest hang-wait: SUCCESS (68.563s)
[796.516102] [122/133] (231s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[796.634584] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[796.639149] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[796.806866] [123/133] (231s left) i915_query (test-query-geometry-subslices)
[796.875667] Starting subtest: test-query-geometry-subslices
[796.878063] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[796.972168] [124/133] (231s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[797.070288] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[797.072612] Starting dynamic subtest: pipe-A-eDP-1
[797.092990] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[797.105666] Starting dynamic subtest: pipe-B-eDP-1
[797.125089] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[797.134342] Starting dynamic subtest: pipe-C-eDP-1
[797.153720] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[797.162513] Starting dynamic subtest: pipe-D-eDP-1
[797.182892] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[797.185467] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[799.346389] [125/133] (229s left) gem_basic (create-fd-close)
[799.410223] Starting subtest: create-fd-close
[799.414646] Subtest create-fd-close: SUCCESS (0.000s)
[799.506781] [126/133] (229s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[799.603625] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[799.607755] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[799.674436] [127/133] (228s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[799.762344] Starting subtest: read-crc-frame-sequence
[799.764673] Starting dynamic subtest: pipe-A-eDP-1
[800.466965] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.704s)
[800.476801] Starting dynamic subtest: pipe-B-eDP-1
[801.807160] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.339s)
[801.820517] Starting dynamic subtest: pipe-C-eDP-1
[803.105658] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.298s)
[803.115472] Starting dynamic subtest: pipe-D-eDP-1
[804.434314] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[804.436719] Subtest read-crc-frame-sequence: SUCCESS (4.674s)
[805.250231] [128/133] (223s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[805.346425] Starting subtest: multiplane-rotation-cropping-bottom
[822.970960] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.627s)
[823.080245] [129/133] (205s left) gem_pwrite (basic-random)
[823.134600] Subtest basic-random: SKIP (0.000s)
[823.193685] [130/133] (205s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[823.256299] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[823.361051] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.104s)
[823.452397] [131/133] (205s left) kms_mmap_write_crc (main)
[823.556266] Starting subtest: main
[823.558694] Starting dynamic subtest: pipe-A-eDP-1
[827.009733] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.451s)
[827.011887] Subtest main: SUCCESS (3.454s)
[827.885399] [132/133] (200s left) kms_chamelium_audio (dp-audio-edid)
[828.287609] Subtest dp-audio-edid: SKIP (0.000s)
[829.104466] [133/133] (199s left) fbdev (unaligned-write)
[829.151420] Starting subtest: unaligned-write
[829.254865] Subtest unaligned-write: SUCCESS (0.101s)
[829.313597] 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.