[58.587615] Initializing watchdogs
[58.587724]   /dev/watchdog0
[58.602139] [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.606510] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.608712] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.611988] [001/133] (960s left) api_intel_allocator (gem-pool)
[58.698279] Starting subtest: gem-pool
[58.712001] Subtest gem-pool: SUCCESS (0.016s)
[58.863037] [002/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[58.978546] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[58.982989] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[59.076830] [003/133] (960s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[59.184994] Starting subtest: read-crc-frame-sequence
[59.187485] Starting dynamic subtest: pipe-A-eDP-1
[59.932798] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.741s)
[59.942174] Starting dynamic subtest: pipe-B-eDP-1
[61.281591] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.340s)
[61.288728] Starting dynamic subtest: pipe-C-eDP-1
[62.593229] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.304s)
[62.601919] Starting dynamic subtest: pipe-D-eDP-1
[63.924967] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.326s)
[63.927323] Subtest read-crc-frame-sequence: SUCCESS (4.717s)
[64.768269] [004/133] (954s left) syncobj_timeline (invalid-query-one-illegal-handle)
[64.827825] Starting subtest: invalid-query-one-illegal-handle
[64.830165] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[64.951482] [005/133] (954s left) syncobj_wait (invalid-signal-zero-handles)
[65.007172] Starting subtest: invalid-signal-zero-handles
[65.009486] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[65.114961] [006/133] (954s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[65.211228] Starting subtest: fbcpsr-rgb565-draw-render
[72.469945] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.248s)
[72.617931] [007/133] (946s left) syncobj_timeline (wait-for-submit-snapshot)
[72.677959] Starting subtest: wait-for-submit-snapshot
[72.760650] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[72.845732] [008/133] (946s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[72.952426] Starting subtest: psr-rgb565-draw-blt
[80.081073] Subtest psr-rgb565-draw-blt: SUCCESS (7.126s)
[80.237709] [009/133] (939s left) kms_cursor_crc (cursor-onscreen-32x10)
[80.400602] Starting subtest: cursor-onscreen-32x10
[80.443631] Subtest cursor-onscreen-32x10: SKIP (0.040s)
[80.743936] [010/133] (938s left) syncobj_wait (invalid-signal-illegal-handle)
[80.805990] Starting subtest: invalid-signal-illegal-handle
[80.808365] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[80.919562] [011/133] (938s left) testdisplay
[81.277651] [012/133] (938s left) prime_mmap (test_map_unmap)
[81.343041] Starting subtest: test_map_unmap
[81.345180] Starting dynamic subtest: test_map_unmap-smem
[81.376692] Dynamic subtest test_map_unmap-smem: SUCCESS (0.034s)
[81.378838] Subtest test_map_unmap: SUCCESS (0.034s)
[81.493190] [013/133] (938s left) gem_exec_fence (syncobj-timeline-signal)
[82.055923] Starting subtest: syncobj-timeline-signal
[82.065125] Subtest syncobj-timeline-signal: SUCCESS (0.009s)
[84.025488] [FACT gem_exec_fence (syncobj-timeline-signal)] new: kernel.kmod_is_loaded.vgem: true
[84.028444] [014/133] (935s left) syncobj_timeline (signal-point-0)
[84.101760] Starting subtest: signal-point-0
[84.104132] Subtest signal-point-0: SUCCESS (0.000s)
[84.222136] [015/133] (935s left) kms_psr (psr2-suspend)
[84.333358] Starting subtest: psr2-suspend
[84.335485] Starting dynamic subtest: eDP-1
[101.602903] Dynamic subtest eDP-1: SUCCESS (3.070s)
[101.605220] Subtest psr2-suspend: SUCCESS (3.071s)
[102.448996] [016/133] (917s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[102.556982] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[102.572098] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[102.645003] [017/133] (917s left) gem_softpin (reverse)
[102.709871] Starting subtest: reverse
[102.716827] Subtest reverse: SUCCESS (0.006s)
[102.881106] [018/133] (916s left) gem_exec_balancer (parallel-contexts)
[103.153661] Starting subtest: parallel-contexts
[105.748607] Subtest parallel-contexts: SUCCESS (2.522s)
[105.873763] [019/133] (913s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[105.975187] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[105.977449] Starting dynamic subtest: pipe-A-eDP-1
[108.155529] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.138s)
[108.164647] Starting dynamic subtest: pipe-B-eDP-1
[110.405612] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.215s)
[110.414390] Starting dynamic subtest: pipe-C-eDP-1
[112.513348] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.083s)
[112.522544] Starting dynamic subtest: pipe-D-eDP-1
[114.601495] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.069s)
[114.603542] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.509s)
[115.788635] [020/133] (904s left) kms_lease (lease-unleased-connector)
[115.888333] Starting subtest: lease-unleased-connector
[115.890587] Starting dynamic subtest: pipe-A-eDP-1
[115.892928] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[115.905258] Starting dynamic subtest: pipe-B-eDP-1
[115.907578] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[115.920032] Starting dynamic subtest: pipe-C-eDP-1
[115.921942] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[115.929910] Starting dynamic subtest: pipe-D-eDP-1
[115.931856] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[115.933773] Subtest lease-unleased-connector: SUCCESS (0.032s)
[116.051550] [021/133] (903s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[116.185454] Starting subtest: cursor-vs-flip-atomic-transitions
[146.112547] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.878s)
[146.967711] [022/133] (872s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[147.054003] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[147.056433] Starting dynamic subtest: pipe-A-default-mode
[149.798578] Dynamic subtest pipe-A-default-mode: SUCCESS (2.743s)
[149.800775] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.745s)
[150.675001] [023/133] (869s left) kms_addfb_basic (legacy-format)
[150.731920] Starting subtest: legacy-format
[150.765679] Subtest legacy-format: SUCCESS (0.028s)
[150.918409] [024/133] (869s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[151.020857] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[151.025010] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[151.155674] [025/133] (868s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[151.249524] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[151.253665] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[151.384501] [026/133] (868s left) kms_vblank (query-busy)
[151.481171] Starting subtest: query-busy
[151.483450] Starting dynamic subtest: pipe-A-eDP-1
[153.353252] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.873s)
[153.367148] Starting dynamic subtest: pipe-D-eDP-1
[155.934342] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.575s)
[155.936704] Subtest query-busy: SUCCESS (4.451s)
[156.750393] [027/133] (863s left) gem_wait (invalid-flags)
[156.822343] Starting subtest: invalid-flags
[156.824751] Subtest invalid-flags: SUCCESS (0.000s)
[157.078341] [028/133] (863s left) kms_properties (invalid-properties-atomic)
[157.173236] Starting subtest: invalid-properties-atomic
[157.474676] Subtest invalid-properties-atomic: SUCCESS (0.301s)
[157.558153] [029/133] (862s left) gem_exec_flush (basic-wb-ro-before-default)
[157.626897] Starting subtest: basic-wb-ro-before-default
[163.115514] Subtest basic-wb-ro-before-default: SUCCESS (5.468s)
[163.305093] [030/133] (856s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[163.403788] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[163.408133] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[163.548268] [031/133] (856s left) kms_psr (pr-primary-blt)
[163.639237] Starting subtest: pr-primary-blt
[163.643659] Subtest pr-primary-blt: SKIP (0.000s)
[163.732030] [032/133] (856s left) kms_flip (2x-flip-vs-dpms-on-nop)
[163.825637] Starting subtest: 2x-flip-vs-dpms-on-nop
[163.832812] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[163.934995] [033/133] (856s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[164.039603] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[164.042923] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[164.156205] [034/133] (856s left) kms_chamelium_edid (dp-mode-timings)
[164.549788] Subtest dp-mode-timings: SKIP (0.000s)
[165.345617] [035/133] (855s left) kms_flip (flip-vs-panning-interruptible)
[165.444211] Starting subtest: flip-vs-panning-interruptible
[165.446584] Starting dynamic subtest: A-eDP1
[174.180309] Dynamic subtest A-eDP1: SUCCESS (8.731s)
[174.189162] Starting dynamic subtest: B-eDP1
[182.921775] Dynamic subtest B-eDP1: SUCCESS (8.736s)
[182.930882] Starting dynamic subtest: C-eDP1
[191.639727] Dynamic subtest C-eDP1: SUCCESS (8.713s)
[191.650710] Starting dynamic subtest: D-eDP1
[200.273353] Dynamic subtest D-eDP1: SUCCESS (8.633s)
[200.277265] Subtest flip-vs-panning-interruptible: SUCCESS (34.821s)
[201.448116] [036/133] (819s left) kms_pm_dc (dc5-psr)
[202.564375] Starting subtest: dc5-psr
[205.439623] Subtest dc5-psr: SUCCESS (2.876s)
[206.280163] [037/133] (814s left) gem_userptr_blits (process-exit)
[206.357153] Starting subtest: process-exit
[206.362943] Subtest process-exit: SUCCESS (0.007s)
[206.503629] [038/133] (814s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[206.601970] Starting subtest: plane-lut1d-post-ctm3x4
[206.615067] Starting dynamic subtest: pipe-A-eDP-1
[207.310442] Dynamic subtest pipe-A-eDP-1: FAIL (0.334s)
[208.042995] Starting dynamic subtest: pipe-B-eDP-1
[208.836536] Dynamic subtest pipe-B-eDP-1: FAIL (0.290s)
[209.376324] Starting dynamic subtest: pipe-C-eDP-1
[210.189378] Dynamic subtest pipe-C-eDP-1: FAIL (0.235s)
[210.706811] Starting dynamic subtest: pipe-D-eDP-1
[211.524373] Dynamic subtest pipe-D-eDP-1: FAIL (0.245s)
[211.526687] Subtest plane-lut1d-post-ctm3x4: FAIL (4.634s)
[212.092170] [039/133] (808s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[212.160601] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[212.268156] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.106s)
[212.358348] [040/133] (808s left) gem_mmap_offset (partial-remap)
[212.406827] Starting subtest: partial-remap
[212.409257] Starting dynamic subtest: smem0
[212.418162] Dynamic subtest smem0: SUCCESS (0.003s)
[212.420175] Subtest partial-remap: SUCCESS (0.004s)
[212.549285] [041/133] (808s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[212.646889] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[212.651076] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[212.758903] [042/133] (808s left) gem_userptr_blits (dmabuf-unsync)
[212.831362] Subtest dmabuf-unsync: SKIP (0.000s)
[212.957446] [043/133] (807s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[213.061692] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[213.065750] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[213.198633] [044/133] (807s left) gem_close_race (multigpu-basic-threads)
[213.268417] Starting subtest: multigpu-basic-threads
[213.272976] Subtest multigpu-basic-threads: SKIP (0.000s)
[213.513325] [045/133] (807s left) gem_exec_schedule (preempt)
[213.577168] Starting subtest: preempt
[213.579646] Starting dynamic subtest: rcs0
[213.592638] Dynamic subtest rcs0: SUCCESS (0.025s)
[213.601068] Starting dynamic subtest: bcs0
[213.610162] Dynamic subtest bcs0: SUCCESS (0.017s)
[213.618424] Starting dynamic subtest: vcs0
[213.628762] Dynamic subtest vcs0: SUCCESS (0.018s)
[213.637040] Starting dynamic subtest: vcs1
[213.649311] Dynamic subtest vcs1: SUCCESS (0.020s)
[213.657776] Starting dynamic subtest: vecs0
[213.669699] Dynamic subtest vecs0: SUCCESS (0.020s)
[213.681847] Starting dynamic subtest: ccs0
[213.699148] Dynamic subtest ccs0: SUCCESS (0.028s)
[213.701463] Subtest preempt: SUCCESS (0.132s)
[215.223213] [046/133] (805s left) i915_module_load (reload)
[215.261292] Starting subtest: reload
[218.633422] Subtest reload: SUCCESS (3.371s)
[218.682681] [047/133] (802s left) gem_exec_reloc (basic-wc-cpu-active)
[220.089007] Subtest basic-wc-cpu-active: SKIP (0.000s)
[220.193197] [048/133] (800s left) gen9_exec_parse (valid-registers)
[220.251479] Subtest valid-registers: SKIP (0.000s)
[220.344557] [049/133] (800s left) kms_cursor_edge_walk (64x64-left-edge)
[220.438077] Starting subtest: 64x64-left-edge
[220.440241] Starting dynamic subtest: pipe-A-eDP-1
[223.980472] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.541s)
[223.988495] Starting dynamic subtest: pipe-D-eDP-1
[227.160759] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.181s)
[227.163074] Subtest 64x64-left-edge: SUCCESS (6.725s)
[227.987730] [050/133] (793s left) gem_render_copy_redux (flink)
[228.045843] Starting subtest: flink
[228.778586] Subtest flink: SUCCESS (0.733s)
[228.906573] [051/133] (792s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[229.007377] Starting subtest: psr-2p-primscrn-spr-indfb-move
[229.010918] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[229.152360] [052/133] (792s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[229.248385] Starting subtest: bo-too-small-due-to-tiling
[229.251686] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[229.383556] [053/133] (791s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[229.479757] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[236.089580] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.609s)
[236.242844] [054/133] (785s left) gem_exec_reloc (basic-write-wc-active)
[236.315496] Subtest basic-write-wc-active: SKIP (0.000s)
[236.400734] [055/133] (784s left) gem_fenced_exec_thrash (2-spare-fences)
[236.459406] Subtest 2-spare-fences: SKIP (0.000s)
[236.538900] [056/133] (784s left) kms_hdr (static-toggle-dpms)
[236.636263] Starting subtest: static-toggle-dpms
[236.642720] Subtest static-toggle-dpms: SKIP (0.000s)
[236.743374] [057/133] (784s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[236.843382] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[243.805477] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.964s)
[243.931536] [058/133] (777s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[244.046598] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[247.776294] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.732s)
[248.947583] [059/133] (772s left) gem_lmem_swapping (parallel-random-verify)
[248.995082] Subtest parallel-random-verify: SKIP (0.000s)
[249.042455] [060/133] (772s left) kms_psr (fbc-pr-sprite-plane-move)
[249.145529] Starting subtest: fbc-pr-sprite-plane-move
[249.149931] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[249.231217] [061/133] (772s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[249.617640] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[250.433609] [062/133] (771s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[250.534257] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[250.536504] Starting dynamic subtest: pipe-A-eDP-1
[250.562104] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[250.570923] Starting dynamic subtest: pipe-B-eDP-1
[250.594378] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[250.602612] Starting dynamic subtest: pipe-C-eDP-1
[250.625778] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[250.633605] Starting dynamic subtest: pipe-D-eDP-1
[250.656241] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[250.660146] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[252.833084] [063/133] (768s left) i915_pm_rpm (gem-evict-pwrite)
[254.359449] Starting subtest: gem-evict-pwrite
[254.364593] Subtest gem-evict-pwrite: SKIP (0.000s)
[255.076896] [064/133] (766s left) gem_exec_whisper (basic-sync)
[255.135041] Starting subtest: basic-sync
[261.618747] Subtest basic-sync: SUCCESS (6.455s)
[261.790872] [065/133] (759s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[261.928650] Starting subtest: short-busy-flip-before-cursor-toggle
[261.933040] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[262.087867] [066/133] (759s left) i915_query (hwconfig_table)
[262.149591] Starting subtest: hwconfig_table
[262.440651] Subtest hwconfig_table: SUCCESS (0.001s)
[262.478535] [067/133] (759s left) kms_vrr (flipline)
[262.560825] Starting subtest: flipline
[262.567113] Subtest flipline: SKIP (0.000s)
[262.658875] [068/133] (759s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[262.757331] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[267.045021] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.289s)
[268.177546] [069/133] (753s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[268.281397] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[268.294204] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[268.365060] [070/133] (753s left) kms_prop_blob (invalid-set-prop)
[268.425323] Starting subtest: invalid-set-prop
[268.427651] Subtest invalid-set-prop: SUCCESS (0.000s)
[268.562924] [071/133] (753s left) kms_properties (crtc-properties-legacy)
[268.662209] Starting subtest: crtc-properties-legacy
[268.664540] Starting dynamic subtest: pipe-A-eDP-1
[269.097040] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.434s)
[269.106017] Starting dynamic subtest: pipe-B-eDP-1
[270.231632] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.134s)
[270.240418] Starting dynamic subtest: pipe-C-eDP-1
[271.360477] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.125s)
[271.369830] Starting dynamic subtest: pipe-D-eDP-1
[272.493481] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s)
[272.495386] Subtest crtc-properties-legacy: SUCCESS (3.831s)
[273.321362] [072/133] (748s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[273.434052] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[280.276688] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.842s)
[280.441242] [073/133] (741s left) kms_psr (fbc-pr-cursor-render)
[280.543373] Starting subtest: fbc-pr-cursor-render
[280.552769] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[280.628083] [074/133] (741s left) gem_userptr_blits (huge-split)
[280.696309] Starting subtest: huge-split
[280.702796] Subtest huge-split: SUCCESS (0.007s)
[280.844286] [075/133] (741s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[281.101881] Starting subtest: cursor-rapid-movement-256x85
[281.153237] Subtest cursor-rapid-movement-256x85: SKIP (0.046s)
[281.359550] [076/133] (740s left) gem_unref_active_buffers
[281.571386] [077/133] (740s left) gem_caching (reads)
[281.625147] Subtest reads: SKIP (0.000s)
[281.679237] [078/133] (740s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[281.735012] Starting subtest: invalid-multi-wait-all-unsubmitted
[281.736976] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[281.848765] [079/133] (740s left) gem_exec_create (basic)
[281.910978] Starting subtest: basic
[281.913002] Starting dynamic subtest: smem
[285.065390] Dynamic subtest smem: SUCCESS (3.154s)
[285.068079] Subtest basic: SUCCESS (3.155s)
[285.267323] [080/133] (737s left) kms_content_protection (atomic-dpms-hdcp14)
[285.418079] Starting subtest: atomic-dpms-hdcp14
[285.422788] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[285.578601] [081/133] (736s left) sw_sync (timeline_closed)
[285.617309] Starting subtest: timeline_closed
[285.619500] Subtest timeline_closed: SUCCESS (0.000s)
[285.674269] [082/133] (736s left) perf (oa-exponents)
[285.837678] Starting subtest: oa-exponents
[285.839927] Starting dynamic subtest: 0-rcs0
[287.616693] Dynamic subtest 0-rcs0: SUCCESS (1.777s)
[287.627365] Starting dynamic subtest: 1-vecs0
[289.443802] Dynamic subtest 1-vecs0: SUCCESS (1.825s)
[289.446442] Subtest oa-exponents: SUCCESS (3.604s)
[289.493257] [083/133] (732s left) kms_feature_discovery (display-2x)
[289.605158] Starting subtest: display-2x
[289.609669] Subtest display-2x: SKIP (0.000s)
[289.708987] [084/133] (732s left) core_setmaster (master-drop-set-root)
[289.782151] Starting subtest: master-drop-set-root
[289.795070] Subtest master-drop-set-root: SUCCESS (0.013s)
[289.844996] [085/133] (732s left) kms_pm_rpm (i2c)
[291.379753] Starting subtest: i2c
[297.045488] Subtest i2c: SUCCESS (5.667s)
[297.145309] [086/133] (725s left) kms_busy (basic-hang)
[297.248575] Starting subtest: basic-hang
[297.250856] Starting dynamic subtest: flip-pipe-A
[297.841677] Dynamic subtest flip-pipe-A: SUCCESS (0.592s)
[297.851880] Starting dynamic subtest: modeset-pipe-A
[301.252796] Dynamic subtest modeset-pipe-A: SUCCESS (3.409s)
[301.262600] Starting dynamic subtest: flip-pipe-D
[302.465173] Dynamic subtest flip-pipe-D: SUCCESS (1.211s)
[302.479178] Starting dynamic subtest: modeset-pipe-D
[305.891889] Dynamic subtest modeset-pipe-D: SUCCESS (3.423s)
[305.894115] Subtest basic-hang: SUCCESS (8.642s)
[306.707932] [087/133] (715s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[306.813966] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[306.818320] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[306.925872] [088/133] (715s left) kms_flip (nonblocking-read)
[307.025227] Starting subtest: nonblocking-read
[307.027059] Subtest nonblocking-read: SUCCESS (0.000s)
[307.155976] [089/133] (715s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[307.270709] Starting subtest: yf-tiled-16bpp-rotate-270
[307.275299] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[307.401947] [090/133] (715s left) gem_mmap_wc (write-read-distinct)
[307.473856] Subtest write-read-distinct: SKIP (0.000s)
[307.545266] [091/133] (715s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[307.611414] Starting subtest: multi-wait-for-submit-submitted-signaled
[307.613772] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[307.744445] [092/133] (715s left) kms_flip (blocking-wf_vblank)
[307.843842] Starting subtest: blocking-wf_vblank
[307.845823] Starting dynamic subtest: A-eDP1
[316.774921] Dynamic subtest A-eDP1: SUCCESS (8.893s)
[316.785966] Starting dynamic subtest: B-eDP1
[325.679583] Dynamic subtest B-eDP1: SUCCESS (8.935s)
[325.693792] Starting dynamic subtest: C-eDP1
[334.645134] Dynamic subtest C-eDP1: SUCCESS (8.922s)
[334.658636] Starting dynamic subtest: D-eDP1
[343.568481] Dynamic subtest D-eDP1: SUCCESS (8.924s)
[343.570783] Subtest blocking-wf_vblank: SUCCESS (35.683s)
[344.764371] [093/133] (678s left) gem_exec_alignment (pi)
[344.832979] Starting subtest: pi
[395.378305] Subtest pi: SUCCESS (50.544s)
[396.463621] [094/133] (626s left) kms_getfb (getfb-repeated-different-handles)
[396.609136] Starting subtest: getfb-repeated-different-handles
[396.611506] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[396.721251] [095/133] (626s left) syncobj_timeline (etime-multi-wait-submitted)
[396.789902] Starting subtest: etime-multi-wait-submitted
[396.900482] Subtest etime-multi-wait-submitted: SUCCESS (0.108s)
[397.003485] [096/133] (626s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[397.130343] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[398.124984] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.991s)
[398.978194] [097/133] (624s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[399.087054] Starting subtest: primary-yf-tiled-reflect-x-0
[399.146931] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.059s)
[399.276325] [098/133] (623s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[399.334531] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[399.408851] [099/133] (623s left) perf_pmu (rc6)
[399.448520] Starting subtest: rc6
[399.450389] Starting dynamic subtest: gt0
[405.869049] Dynamic subtest gt0: SUCCESS (6.368s)
[405.878963] Starting dynamic subtest: runtime-pm-gt0
[413.592472] Dynamic subtest runtime-pm-gt0: SUCCESS (7.772s)
[413.605539] Starting dynamic subtest: runtime-pm-long-gt0
[426.097266] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.501s)
[426.108052] Starting dynamic subtest: other-idle-gt0
[432.441062] Dynamic subtest other-idle-gt0: SUCCESS (6.340s)
[432.453818] Starting dynamic subtest: gt1
[438.783171] Dynamic subtest gt1: SUCCESS (6.338s)
[438.795887] Starting dynamic subtest: runtime-pm-gt1
[446.283083] Dynamic subtest runtime-pm-gt1: SUCCESS (7.495s)
[446.296141] Starting dynamic subtest: runtime-pm-long-gt1
[458.767015] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.479s)
[458.780332] Starting dynamic subtest: other-idle-gt1
[465.110701] Dynamic subtest other-idle-gt1: SUCCESS (6.340s)
[465.113875] Subtest rc6: SUCCESS (65.654s)
[466.270911] [100/133] (556s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[466.394375] Starting subtest: y-tiled-16bpp-rotate-0
[466.398408] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[466.463831] [101/133] (556s left) kms_flip_tiling (flip-change-tiling)
[466.574496] Starting subtest: flip-change-tiling
[466.576482] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[466.749125] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.175s)
[466.761335] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[466.895049] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.142s)
[466.907665] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[467.028692] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[467.040853] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[467.171780] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s)
[467.184162] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[467.315574] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[467.327690] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[467.471158] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.153s)
[467.483166] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[467.604940] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[467.617150] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[467.716292] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[467.727844] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[467.851225] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[467.864028] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[467.994388] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[468.007168] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[468.165560] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.170s)
[468.177676] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[468.355096] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.187s)
[468.366305] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[468.488862] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[468.501374] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[468.623315] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[468.635677] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[468.733663] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[468.746133] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[468.866892] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.132s)
[468.879447] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[469.010563] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[469.025695] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[469.154858] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.143s)
[469.169730] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[469.299994] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.143s)
[469.312778] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[469.455785] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.153s)
[469.468168] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[469.600071] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[469.613200] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[469.721968] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.120s)
[469.734677] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[469.865981] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.143s)
[469.880605] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[470.010589] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.142s)
[470.024990] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[470.154767] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[470.170449] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[470.299927] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[470.313179] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[470.443824] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.143s)
[470.458526] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[470.588501] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.142s)
[470.603528] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[470.722148] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.131s)
[470.735157] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[470.866798] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.142s)
[470.878821] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[471.010585] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[471.025198] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[471.155037] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[471.169976] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[471.300181] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[471.312178] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[471.444195] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.142s)
[471.456083] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[471.588831] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.142s)
[471.601499] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[471.711092] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.120s)
[471.764123] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[472.944171] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.187s)
[472.956791] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[473.078474] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[473.089392] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[473.211567] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[473.224011] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[473.355161] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.141s)
[473.368073] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[473.504948] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.147s)
[473.516021] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[473.627169] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.120s)
[473.639987] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[473.738021] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.109s)
[473.750926] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[473.837986] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[473.850512] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[473.972573] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.132s)
[473.985160] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[474.116140] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[474.129076] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[474.260070] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[474.272777] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[474.406007] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[474.418320] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[474.538378] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[474.553132] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[474.684328] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.143s)
[474.699667] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[474.805499] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.120s)
[474.818418] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[474.977113] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.170s)
[474.989739] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[475.120863] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[475.136975] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[475.265281] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[475.277723] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[475.410225] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[475.426775] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[475.554746] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[475.570350] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[475.715304] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.157s)
[475.729441] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[475.815080] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.097s)
[475.826554] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[475.970622] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.154s)
[475.985438] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[476.103716] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.131s)
[476.118378] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[476.248451] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[476.263279] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[476.392999] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[476.405354] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[476.537480] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[476.550522] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[476.681998] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.142s)
[476.697496] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[476.804700] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.120s)
[476.816928] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[476.948997] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.142s)
[476.961589] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[477.093612] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[477.105858] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[477.237341] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[477.252776] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[477.381795] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[477.396760] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[477.526500] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.142s)
[477.541495] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[477.671750] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.142s)
[477.684558] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[477.793837] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.120s)
[477.846404] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[479.082537] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.242s)
[479.094940] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[479.182445] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[479.195315] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[479.282491] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[479.295282] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[479.393709] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s)
[479.406515] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[479.503952] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[479.516245] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[479.653509] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.148s)
[479.666016] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[479.753874] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s)
[479.766298] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[479.854066] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[479.866613] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[479.965754] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.109s)
[479.976268] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[480.087448] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.120s)
[480.099560] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[480.198386] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[480.211177] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[480.320410] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.120s)
[480.334366] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[480.431689] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.108s)
[480.444127] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[480.531615] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[480.543192] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[480.643043] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[480.655240] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[480.753895] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s)
[480.765777] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[480.864571] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[480.876886] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[480.975980] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s)
[480.988280] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[481.076180] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.098s)
[481.088887] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[481.187455] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.109s)
[481.199180] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[481.298880] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s)
[481.311671] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[481.448693] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.148s)
[481.461074] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[481.559261] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.109s)
[481.571286] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[481.670204] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.109s)
[481.681877] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[481.781587] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.110s)
[481.793840] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[481.892282] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.110s)
[481.904592] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[482.004451] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.110s)
[482.016832] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[482.114755] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.110s)
[482.127555] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[482.226239] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.109s)
[482.237261] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[482.337492] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.109s)
[482.349184] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[482.447951] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[482.460594] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[482.559356] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s)
[482.572059] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[482.670416] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s)
[482.681970] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[482.781291] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.110s)
[482.793062] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[482.892782] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.110s)
[482.905483] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[483.004529] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.109s)
[483.045706] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[484.308468] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.269s)
[484.321188] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[484.408170] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[484.418896] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[484.508345] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[484.518808] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[484.618959] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s)
[484.631293] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[484.729933] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[484.742247] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[484.841119] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.109s)
[484.854554] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[484.941540] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s)
[484.954013] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[485.042137] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[485.054872] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[485.141609] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[485.153806] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[485.252813] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s)
[485.265085] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[485.363369] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[485.375357] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[485.474010] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s)
[485.488195] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[485.574176] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s)
[485.586878] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[485.674439] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[485.687131] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[485.774661] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[485.786909] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[485.885680] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s)
[485.897926] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[485.996585] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[486.008866] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[486.146438] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.148s)
[486.158423] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[486.257667] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.109s)
[486.270227] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[486.357697] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.098s)
[486.369877] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[486.457658] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.098s)
[486.469658] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[486.580329] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.121s)
[486.592978] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[486.690706] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.109s)
[486.702718] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[486.802223] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.110s)
[486.814127] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[486.902176] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.098s)
[486.914055] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[487.013270] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.110s)
[487.031989] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[487.124535] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.108s)
[487.136918] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[487.235501] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.110s)
[487.247742] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[487.346713] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.109s)
[487.358546] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[487.457795] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.109s)
[487.470078] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[487.568657] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[487.580039] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[487.680339] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.110s)
[487.695611] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[487.790911] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s)
[487.805808] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[487.902046] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.109s)
[487.915836] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[488.013502] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.109s)
[488.026023] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[488.124788] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.109s)
[488.157776] Subtest flip-change-tiling: SUCCESS (21.581s)
[489.295119] [102/133] (533s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[489.406612] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[489.410686] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[489.479472] [103/133] (533s left) gem_exec_fence (submit-chain)
[489.666946] Starting subtest: submit-chain
[489.684477] Subtest submit-chain: SUCCESS (0.018s)
[491.125528] [104/133] (532s left) gem_ringfill (engines-basic)
[497.099449] Starting subtest: engines-basic
[497.102075] Starting dynamic subtest: rcs0
[497.180044] Dynamic subtest rcs0: SUCCESS (0.081s)
[497.192899] Starting dynamic subtest: bcs0
[497.226032] Dynamic subtest bcs0: SUCCESS (0.044s)
[497.236539] Starting dynamic subtest: vcs0
[497.269937] Dynamic subtest vcs0: SUCCESS (0.042s)
[497.280758] Starting dynamic subtest: vcs1
[497.312935] Dynamic subtest vcs1: SUCCESS (0.041s)
[497.323627] Starting dynamic subtest: vecs0
[497.356162] Dynamic subtest vecs0: SUCCESS (0.041s)
[497.366821] Starting dynamic subtest: ccs0
[497.401768] Dynamic subtest ccs0: SUCCESS (0.044s)
[497.404088] Subtest engines-basic: SUCCESS (0.305s)
[497.457553] [105/133] (525s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[497.564996] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[497.567301] Starting dynamic subtest: pipe-A-eDP-1
[497.587724] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[497.599486] Starting dynamic subtest: pipe-B-eDP-1
[497.618897] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[497.628086] Starting dynamic subtest: pipe-C-eDP-1
[497.647429] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[497.656776] Starting dynamic subtest: pipe-D-eDP-1
[497.675899] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[497.678172] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[499.795834] [106/133] (523s left) perf_pmu (busy-check-all)
[499.841764] Starting subtest: busy-check-all
[499.844052] Starting dynamic subtest: rcs0
[500.390633] Dynamic subtest rcs0: SUCCESS (0.551s)
[500.404004] Starting dynamic subtest: bcs0
[500.940748] Dynamic subtest bcs0: SUCCESS (0.548s)
[500.953353] Starting dynamic subtest: vcs0
[502.088496] Dynamic subtest vcs0: SUCCESS (1.143s)
[502.100775] Starting dynamic subtest: vcs1
[504.072392] Dynamic subtest vcs1: SUCCESS (1.981s)
[504.084148] Starting dynamic subtest: vecs0
[506.120193] Dynamic subtest vecs0: SUCCESS (2.045s)
[506.132085] Starting dynamic subtest: ccs0
[506.675337] Dynamic subtest ccs0: SUCCESS (0.553s)
[506.678057] Subtest busy-check-all: SUCCESS (6.836s)
[506.759285] [107/133] (516s left) gem_exec_schedule (submit-early-slice)
[506.838109] Starting subtest: submit-early-slice
[506.840566] Starting dynamic subtest: rcs0
[506.891463] Dynamic subtest rcs0: SUCCESS (0.059s)
[506.902264] Starting dynamic subtest: bcs0
[506.942542] Dynamic subtest bcs0: SUCCESS (0.051s)
[506.953728] Starting dynamic subtest: vcs0
[506.991190] Dynamic subtest vcs0: SUCCESS (0.048s)
[507.002094] Starting dynamic subtest: vcs1
[507.040043] Dynamic subtest vcs1: SUCCESS (0.048s)
[507.051703] Starting dynamic subtest: vecs0
[507.083988] Dynamic subtest vecs0: SUCCESS (0.043s)
[507.096076] Starting dynamic subtest: ccs0
[507.134721] Dynamic subtest ccs0: SUCCESS (0.050s)
[507.137172] Subtest submit-early-slice: SUCCESS (0.303s)
[508.183336] [108/133] (515s left) gem_exec_balancer (parallel-bb-first)
[508.449973] Starting subtest: parallel-bb-first
[509.360998] Subtest parallel-bb-first: SUCCESS (0.911s)
[510.108185] [109/133] (513s left) gen9_exec_parse (bb-large)
[510.175916] Subtest bb-large: SKIP (0.000s)
[510.255393] [110/133] (513s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[510.358980] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[510.361484] Starting dynamic subtest: pipe-A-eDP-1
[510.419341] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[510.430728] Starting dynamic subtest: pipe-B-eDP-1
[510.486700] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[510.498618] Starting dynamic subtest: pipe-C-eDP-1
[510.554879] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[510.566086] Starting dynamic subtest: pipe-D-eDP-1
[510.623515] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[510.627679] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.009s)
[512.640081] [111/133] (511s left) api_intel_bb (simple-bb-ctx)
[512.706752] Starting subtest: simple-bb-ctx
[512.713703] Subtest simple-bb-ctx: SUCCESS (0.008s)
[512.834463] [112/133] (510s left) gem_ctx_isolation (preservation-s3)
[512.894199] Starting subtest: preservation-S3
[512.896600] Starting dynamic subtest: rcs0
[529.112344] Dynamic subtest rcs0: SUCCESS (1.330s)
[529.122679] Starting dynamic subtest: bcs0
[545.111696] Dynamic subtest bcs0: SUCCESS (1.303s)
[545.125275] Starting dynamic subtest: vcs0
[561.125071] Dynamic subtest vcs0: SUCCESS (2.605s)
[561.139857] Starting dynamic subtest: vcs1
[579.126290] Dynamic subtest vcs1: SUCCESS (4.848s)
[579.143581] Starting dynamic subtest: vecs0
[597.128794] Dynamic subtest vecs0: SUCCESS (4.839s)
[597.139743] Starting dynamic subtest: ccs0
[615.111618] Dynamic subtest ccs0: SUCCESS (3.037s)
[615.114131] Subtest preservation-S3: SUCCESS (17.967s)
[615.381285] [113/133] (408s left) sriov_basic (enable-vfs-autoprobe-on)
[615.454577] Starting subtest: enable-vfs-autoprobe-on
[615.457456] Starting dynamic subtest: numvfs-1
[615.537881] Dynamic subtest numvfs-1: FAIL (0.027s)
[615.548596] Starting dynamic subtest: numvfs-2
[615.625844] Dynamic subtest numvfs-2: FAIL (0.004s)
[615.637591] Starting dynamic subtest: numvfs-3
[615.712973] Dynamic subtest numvfs-3: FAIL (0.004s)
[615.724595] Starting dynamic subtest: numvfs-4
[615.799215] Dynamic subtest numvfs-4: FAIL (0.004s)
[615.810565] Starting dynamic subtest: numvfs-5
[615.884764] Dynamic subtest numvfs-5: FAIL (0.004s)
[615.895616] Starting dynamic subtest: numvfs-6
[615.967123] Dynamic subtest numvfs-6: FAIL (0.004s)
[615.977044] Starting dynamic subtest: numvfs-7
[616.048799] Dynamic subtest numvfs-7: FAIL (0.004s)
[616.058692] Starting dynamic subtest: numvfs-random
[616.133805] Dynamic subtest numvfs-random: FAIL (0.004s)
[616.146009] Starting dynamic subtest: numvfs-all
[616.221043] Dynamic subtest numvfs-all: FAIL (0.505s)
[616.223496] Subtest enable-vfs-autoprobe-on: FAIL (0.566s)
[616.264417] [114/133] (407s left) perf_pmu (gt-awake)
[616.306626] Starting subtest: gt-awake
[624.906004] Subtest gt-awake: SUCCESS (8.413s)
[624.990100] [115/133] (398s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[625.071895] Subtest no-spare-fences-busy: SKIP (0.000s)
[625.153848] [116/133] (398s left) kms_rotation_crc (primary-rotation-90)
[625.260592] Starting subtest: primary-rotation-90
[625.265039] Subtest primary-rotation-90: SKIP (0.001s)
[625.311527] [117/133] (398s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[625.417340] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[626.205314] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.781s)
[626.374909] [118/133] (397s left) gem_mmap_wc (write-prefaulted)
[626.437325] Subtest write-prefaulted: SKIP (0.000s)
[626.499109] [119/133] (397s left) gem_pxp (reject-modify-context-protection-off-1)
[626.623265] Starting subtest: reject-modify-context-protection-off-1
[626.625847] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[626.709427] [120/133] (397s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[626.795543] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[626.797695] Starting dynamic subtest: pipe-A-eDP-1
[626.817677] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s)
[626.829116] Starting dynamic subtest: pipe-B-eDP-1
[626.848692] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.023s)
[626.858979] Starting dynamic subtest: pipe-C-eDP-1
[626.879655] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.023s)
[626.890094] Starting dynamic subtest: pipe-D-eDP-1
[626.911227] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[626.913634] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.095s)
[629.080435] [121/133] (395s left) kms_plane_lowres (tiling-x)
[629.169607] Starting subtest: tiling-x
[629.171905] Starting dynamic subtest: pipe-A-eDP-1
[629.176546] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[629.468169] Starting dynamic subtest: pipe-B-eDP-1
[629.474410] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[629.488693] Starting dynamic subtest: pipe-C-eDP-1
[629.493782] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[629.503454] Starting dynamic subtest: pipe-D-eDP-1
[629.507630] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[629.511699] Subtest tiling-x: SKIP (0.296s)
[630.312226] [122/133] (393s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[630.408702] Starting subtest: multiplane-rotation-cropping-top
[647.842006] Subtest multiplane-rotation-cropping-top: SUCCESS (17.393s)
[647.934613] [123/133] (376s left) gem_mmap_gtt (basic-write-read-distinct)
[648.006306] Subtest basic-write-read-distinct: SKIP (0.000s)
[648.080062] [124/133] (376s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[648.181818] Starting subtest: fbc-psr2-sprite-mmap-gtt
[648.183752] Starting dynamic subtest: eDP-1
[648.187034] Dynamic subtest eDP-1: SKIP (0.000s)
[648.190347] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[648.230030] [125/133] (376s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[648.334246] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[648.337753] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[648.379430] [126/133] (375s left) gem_tiled_partial_pwrite_pread (writes)
[648.442636] Subtest writes: SKIP (0.000s)
[648.513049] [127/133] (375s left) kms_atomic (crtc-invalid-params-fence)
[648.612185] Starting subtest: crtc-invalid-params-fence
[648.614242] Starting dynamic subtest: pipe-A-eDP-1
[649.028671] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.417s)
[649.030958] Subtest crtc-invalid-params-fence: SUCCESS (0.419s)
[649.892733] [128/133] (374s left) gem_busy (parallel)
[650.080070] Starting subtest: parallel
[650.082563] Starting dynamic subtest: rcs0
[651.848436] Dynamic subtest rcs0: SUCCESS (1.768s)
[651.862069] Starting dynamic subtest: bcs0
[653.896726] Dynamic subtest bcs0: SUCCESS (2.046s)
[653.911168] Starting dynamic subtest: vcs0
[655.880986] Dynamic subtest vcs0: SUCCESS (1.981s)
[655.897166] Starting dynamic subtest: vcs1
[657.865229] Dynamic subtest vcs1: SUCCESS (1.981s)
[657.879632] Starting dynamic subtest: vecs0
[659.849395] Dynamic subtest vecs0: SUCCESS (1.981s)
[659.862550] Starting dynamic subtest: ccs0
[661.949689] Dynamic subtest ccs0: SUCCESS (2.044s)
[661.951843] Subtest parallel: SUCCESS (11.819s)
[662.154831] [129/133] (362s left) gem_ctx_persistence (processes)
[662.215656] Starting subtest: processes
[663.899045] Subtest processes: SUCCESS (1.683s)
[663.960184] [130/133] (360s left) kms_big_fb (4-tiled-addfb-size-overflow)
[664.073743] Starting subtest: 4-tiled-addfb-size-overflow
[664.076155] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[664.161717] [131/133] (360s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[664.286234] Starting subtest: x-tiled-64bpp-rotate-270
[664.315086] Subtest x-tiled-64bpp-rotate-270: SKIP (0.025s)
[664.422774] [132/133] (360s left) kms_plane_scaling (planes-scaler-unity-scaling)
[664.525519] Starting subtest: planes-scaler-unity-scaling
[664.527868] Starting dynamic subtest: pipe-A
[664.587211] Dynamic subtest pipe-A: SUCCESS (0.064s)
[664.599993] Starting dynamic subtest: pipe-B
[665.732119] Dynamic subtest pipe-B: SUCCESS (1.144s)
[665.752215] Starting dynamic subtest: pipe-C
[666.840388] Dynamic subtest pipe-C: SUCCESS (1.107s)
[666.857298] Starting dynamic subtest: pipe-D
[667.975687] Dynamic subtest pipe-D: SUCCESS (1.133s)
[667.978100] Subtest planes-scaler-unity-scaling: SUCCESS (3.453s)
[669.147169] [133/133] (355s left) gem_exec_whisper (basic-contexts)
[669.201311] Starting subtest: basic-contexts
[675.303004] Subtest basic-contexts: SUCCESS (6.098s)
[675.464601] Closing watchdogs
results: parsing output: 0/ for test: api_intel_allocator
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_pipe_crc_basic
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: syncobj_wait
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_cursor_crc
results: parsing output: 9/ for test: syncobj_wait
results: parsing output: 10/ for test: testdisplay
results: parsing output: 11/ for test: prime_mmap
results: parsing output: 12/ for test: gem_exec_fence
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: kms_plane
results: parsing output: 16/ for test: gem_softpin
results: parsing output: 17/ for test: gem_exec_balancer
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: kms_lease
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: kms_flip_scaled_crc
results: parsing output: 22/ for test: kms_addfb_basic
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_vblank
results: parsing output: 26/ for test: gem_wait
results: parsing output: 27/ for test: kms_properties
results: parsing output: 28/ for test: gem_exec_flush
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_chamelium_edid
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: kms_pm_dc
results: parsing output: 36/ for test: gem_userptr_blits
results: parsing output: 37/ for test: kms_color_pipeline
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: gem_mmap_offset
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_userptr_blits
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_close_race
results: parsing output: 44/ for test: gem_exec_schedule
results: parsing output: 45/ for test: i915_module_load
results: parsing output: 46/ for test: gem_exec_reloc
results: parsing output: 47/ for test: gen9_exec_parse
results: parsing output: 48/ for test: kms_cursor_edge_walk
results: parsing output: 49/ for test: gem_render_copy_redux
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_addfb_basic
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_exec_reloc
results: parsing output: 54/ for test: gem_fenced_exec_thrash
results: parsing output: 55/ for test: kms_hdr
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_lmem_swapping
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: kms_chamelium_hpd
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: i915_pm_rpm
results: parsing output: 63/ for test: gem_exec_whisper
results: parsing output: 64/ for test: kms_cursor_legacy
results: parsing output: 65/ for test: i915_query
results: parsing output: 66/ for test: kms_vrr
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_plane
results: parsing output: 69/ for test: kms_prop_blob
results: parsing output: 70/ for test: kms_properties
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: gem_userptr_blits
results: parsing output: 74/ for test: kms_cursor_crc
results: parsing output: 75/ for test: gem_unref_active_buffers
results: parsing output: 76/ for test: gem_caching
results: parsing output: 77/ for test: syncobj_wait
results: parsing output: 78/ for test: gem_exec_create
results: parsing output: 79/ for test: kms_content_protection
results: parsing output: 80/ for test: sw_sync
results: parsing output: 81/ for test: perf
results: parsing output: 82/ for test: kms_feature_discovery
results: parsing output: 83/ for test: core_setmaster
results: parsing output: 84/ for test: kms_pm_rpm
results: parsing output: 85/ for test: kms_busy
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_flip
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: gem_mmap_wc
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: gem_exec_alignment
results: parsing output: 93/ for test: kms_getfb
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: kms_cursor_legacy
results: parsing output: 96/ for test: kms_rotation_crc
results: parsing output: 97/ for test: gem_exec_reloc
results: parsing output: 98/ for test: perf_pmu
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_flip_tiling
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: gem_exec_fence
results: parsing output: 103/ for test: gem_ringfill
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: perf_pmu
results: parsing output: 106/ for test: gem_exec_schedule
results: parsing output: 107/ for test: gem_exec_balancer
results: parsing output: 108/ for test: gen9_exec_parse
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: api_intel_bb
results: parsing output: 111/ for test: gem_ctx_isolation
results: parsing output: 112/ for test: sriov_basic
results: parsing output: 113/ for test: perf_pmu
results: parsing output: 114/ for test: gem_fenced_exec_thrash
results: parsing output: 115/ for test: kms_rotation_crc
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: gem_mmap_wc
results: parsing output: 118/ for test: gem_pxp
results: parsing output: 119/ for test: kms_ccs
results: parsing output: 120/ for test: kms_plane_lowres
results: parsing output: 121/ for test: kms_rotation_crc
results: parsing output: 122/ for test: gem_mmap_gtt
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: kms_psr2_sf
results: parsing output: 125/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 126/ for test: kms_atomic
results: parsing output: 127/ for test: gem_busy
results: parsing output: 128/ for test: gem_ctx_persistence
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: kms_plane_scaling
results: parsing output: 132/ for test: gem_exec_whisper
Done.