[64.266671] Initializing watchdogs
[64.266714]   /dev/watchdog0
[64.281046] [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]
[64.285491] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[64.287743] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[64.291083] [001/133] (960s left) api_intel_allocator (gem-pool)
[64.365518] Starting subtest: gem-pool
[64.378158] Subtest gem-pool: SUCCESS (0.015s)
[64.558755] [002/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[64.661666] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[64.665710] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[64.774913] [003/133] (960s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[64.869762] Starting subtest: read-crc-frame-sequence
[64.872088] Starting dynamic subtest: pipe-A-eDP-1
[65.611113] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.740s)
[65.619930] Starting dynamic subtest: pipe-B-eDP-1
[66.959948] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.346s)
[66.969596] Starting dynamic subtest: pipe-C-eDP-1
[68.286105] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.322s)
[68.294704] Starting dynamic subtest: pipe-D-eDP-1
[69.595356] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.307s)
[69.597813] Subtest read-crc-frame-sequence: SUCCESS (4.719s)
[70.440388] [004/133] (954s left) syncobj_timeline (invalid-query-one-illegal-handle)
[70.519216] Starting subtest: invalid-query-one-illegal-handle
[70.521569] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[70.643739] [005/133] (954s left) syncobj_wait (invalid-signal-zero-handles)
[70.698932] Starting subtest: invalid-signal-zero-handles
[70.701039] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[70.826364] [006/133] (954s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[70.936015] Starting subtest: fbcpsr-rgb565-draw-render
[78.067911] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.132s)
[78.224227] [007/133] (946s left) syncobj_timeline (wait-for-submit-snapshot)
[78.286962] Starting subtest: wait-for-submit-snapshot
[78.368242] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[78.451603] [008/133] (946s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[78.568675] Starting subtest: psr-rgb565-draw-blt
[85.602886] Subtest psr-rgb565-draw-blt: SUCCESS (7.034s)
[85.757896] [009/133] (939s left) kms_cursor_crc (cursor-onscreen-32x10)
[85.931580] Starting subtest: cursor-onscreen-32x10
[85.984889] Subtest cursor-onscreen-32x10: SKIP (0.050s)
[86.273139] [010/133] (938s left) syncobj_wait (invalid-signal-illegal-handle)
[86.333221] Starting subtest: invalid-signal-illegal-handle
[86.335591] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[86.436276] [011/133] (938s left) testdisplay
[86.810573] [012/133] (938s left) prime_mmap (test_map_unmap)
[86.867930] Starting subtest: test_map_unmap
[86.869703] Starting dynamic subtest: test_map_unmap-smem
[86.900436] Dynamic subtest test_map_unmap-smem: SUCCESS (0.034s)
[86.902265] Subtest test_map_unmap: SUCCESS (0.035s)
[87.033964] [013/133] (938s left) gem_exec_fence (syncobj-timeline-signal)
[87.591586] Starting subtest: syncobj-timeline-signal
[87.598785] Subtest syncobj-timeline-signal: SUCCESS (0.008s)
[89.016450] [FACT gem_exec_fence (syncobj-timeline-signal)] new: kernel.kmod_is_loaded.vgem: true
[89.019726] [014/133] (936s left) syncobj_timeline (signal-point-0)
[89.079979] Starting subtest: signal-point-0
[89.082384] Subtest signal-point-0: SUCCESS (0.000s)
[89.198101] [015/133] (936s left) kms_psr (psr2-suspend)
[89.291882] Starting subtest: psr2-suspend
[89.294218] Starting dynamic subtest: eDP-1
[107.334853] Dynamic subtest eDP-1: SUCCESS (2.949s)
[107.337235] Subtest psr2-suspend: SUCCESS (2.950s)
[108.147655] [016/133] (917s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[108.268530] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[108.281430] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[108.355163] [017/133] (917s left) gem_softpin (reverse)
[108.415841] Starting subtest: reverse
[108.420766] Subtest reverse: SUCCESS (0.007s)
[108.573190] [018/133] (916s left) gem_exec_balancer (parallel-contexts)
[108.846864] Starting subtest: parallel-contexts
[111.487836] Subtest parallel-contexts: SUCCESS (2.592s)
[112.096274] [019/133] (913s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[112.199912] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[112.201871] Starting dynamic subtest: pipe-A-eDP-1
[114.398126] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.172s)
[114.407655] Starting dynamic subtest: pipe-B-eDP-1
[116.701869] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.280s)
[116.714105] Starting dynamic subtest: pipe-C-eDP-1
[118.741224] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.024s)
[118.750532] Starting dynamic subtest: pipe-D-eDP-1
[120.780164] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.025s)
[120.782445] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.505s)
[122.005300] [020/133] (903s left) kms_lease (lease-unleased-connector)
[122.115942] Starting subtest: lease-unleased-connector
[122.118300] Starting dynamic subtest: pipe-A-eDP-1
[122.124606] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[122.135252] Starting dynamic subtest: pipe-B-eDP-1
[122.137526] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[122.146532] Starting dynamic subtest: pipe-C-eDP-1
[122.148771] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s)
[122.157689] Starting dynamic subtest: pipe-D-eDP-1
[122.159575] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s)
[122.161510] Subtest lease-unleased-connector: SUCCESS (0.040s)
[122.274892] [021/133] (903s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[122.393337] Starting subtest: cursor-vs-flip-atomic-transitions
[152.352520] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.926s)
[153.159157] [022/133] (872s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[153.263015] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[153.265233] Starting dynamic subtest: pipe-A-default-mode
[156.009439] Dynamic subtest pipe-A-default-mode: SUCCESS (2.744s)
[156.011431] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.745s)
[156.843085] [023/133] (868s left) kms_addfb_basic (legacy-format)
[156.907133] Starting subtest: legacy-format
[156.930836] Subtest legacy-format: SUCCESS (0.019s)
[157.104398] [024/133] (868s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[157.213908] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[157.218233] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[157.345056] [025/133] (868s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[157.454953] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[157.459040] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[157.584969] [026/133] (868s left) kms_vblank (query-busy)
[157.683625] Starting subtest: query-busy
[157.685447] Starting dynamic subtest: pipe-A-eDP-1
[159.569862] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.884s)
[159.586084] Starting dynamic subtest: pipe-D-eDP-1
[162.083691] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.513s)
[162.086274] Subtest query-busy: SUCCESS (4.402s)
[162.897004] [027/133] (862s left) gem_wait (invalid-flags)
[162.973218] Starting subtest: invalid-flags
[162.975600] Subtest invalid-flags: SUCCESS (0.000s)
[163.237066] [028/133] (862s left) kms_properties (invalid-properties-atomic)
[163.337179] Starting subtest: invalid-properties-atomic
[163.646159] Subtest invalid-properties-atomic: SUCCESS (0.307s)
[163.732384] [029/133] (862s left) gem_exec_flush (basic-wb-ro-before-default)
[163.808933] Starting subtest: basic-wb-ro-before-default
[169.282488] Subtest basic-wb-ro-before-default: SUCCESS (5.471s)
[169.496194] [030/133] (856s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[169.618963] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[169.623186] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[169.724841] [031/133] (856s left) kms_psr (pr-primary-blt)
[169.814525] Starting subtest: pr-primary-blt
[169.818653] Subtest pr-primary-blt: SKIP (0.000s)
[169.899595] [032/133] (856s left) kms_flip (2x-flip-vs-dpms-on-nop)
[169.992126] Starting subtest: 2x-flip-vs-dpms-on-nop
[170.004587] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.012s)
[170.139869] [033/133] (855s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[170.244138] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[170.248606] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[170.387678] [034/133] (855s left) kms_chamelium_edid (dp-mode-timings)
[170.776603] Subtest dp-mode-timings: SKIP (0.000s)
[171.593046] [035/133] (854s left) kms_flip (flip-vs-panning-interruptible)
[171.694739] Starting subtest: flip-vs-panning-interruptible
[171.697005] Starting dynamic subtest: A-eDP1
[180.429044] Dynamic subtest A-eDP1: SUCCESS (8.731s)
[180.439198] Starting dynamic subtest: B-eDP1
[189.165085] Dynamic subtest B-eDP1: SUCCESS (8.731s)
[189.174837] Starting dynamic subtest: C-eDP1
[197.895088] Dynamic subtest C-eDP1: SUCCESS (8.725s)
[197.904095] Starting dynamic subtest: D-eDP1
[206.631947] Dynamic subtest D-eDP1: SUCCESS (8.736s)
[206.635930] Subtest flip-vs-panning-interruptible: SUCCESS (34.932s)
[207.903576] [036/133] (818s left) kms_pm_dc (dc5-psr)
[209.008603] Starting subtest: dc5-psr
[211.891616] Subtest dc5-psr: SUCCESS (2.883s)
[212.724241] [037/133] (813s left) gem_userptr_blits (process-exit)
[212.791408] Starting subtest: process-exit
[212.798024] Subtest process-exit: SUCCESS (0.009s)
[212.944133] [038/133] (813s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[213.046497] Starting subtest: plane-lut1d-post-ctm3x4
[213.060879] Starting dynamic subtest: pipe-A-eDP-1
[213.780448] Dynamic subtest pipe-A-eDP-1: FAIL (0.365s)
[214.491021] Starting dynamic subtest: pipe-B-eDP-1
[215.335933] Dynamic subtest pipe-B-eDP-1: FAIL (0.323s)
[215.918980] Starting dynamic subtest: pipe-C-eDP-1
[216.778475] Dynamic subtest pipe-C-eDP-1: FAIL (0.267s)
[217.241167] Starting dynamic subtest: pipe-D-eDP-1
[218.111701] Dynamic subtest pipe-D-eDP-1: FAIL (0.289s)
[218.113609] Subtest plane-lut1d-post-ctm3x4: FAIL (4.781s)
[218.648101] [039/133] (807s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[218.716625] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[218.816550] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.102s)
[218.907927] [040/133] (807s left) gem_mmap_offset (partial-remap)
[218.968151] Starting subtest: partial-remap
[218.970571] Starting dynamic subtest: smem0
[218.979338] Dynamic subtest smem0: SUCCESS (0.003s)
[218.981286] Subtest partial-remap: SUCCESS (0.004s)
[219.084048] [041/133] (807s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[219.192196] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[219.196172] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[219.298586] [042/133] (807s left) gem_userptr_blits (dmabuf-unsync)
[219.371524] Subtest dmabuf-unsync: SKIP (0.000s)
[219.516688] [043/133] (806s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[219.615931] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[219.619841] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[219.747240] [044/133] (806s left) gem_close_race (multigpu-basic-threads)
[219.817089] Starting subtest: multigpu-basic-threads
[219.821126] Subtest multigpu-basic-threads: SKIP (0.000s)
[220.090635] [045/133] (806s left) gem_exec_schedule (preempt)
[220.169007] Starting subtest: preempt
[220.171382] Starting dynamic subtest: rcs0
[220.181625] Dynamic subtest rcs0: SUCCESS (0.021s)
[220.192690] Starting dynamic subtest: bcs0
[220.199605] Dynamic subtest bcs0: SUCCESS (0.017s)
[220.209514] Starting dynamic subtest: vcs0
[220.227697] Dynamic subtest vcs0: SUCCESS (0.027s)
[220.243628] Starting dynamic subtest: vcs1
[220.249103] Dynamic subtest vcs1: SUCCESS (0.019s)
[220.258002] Starting dynamic subtest: vecs0
[220.263886] Dynamic subtest vecs0: SUCCESS (0.016s)
[220.272620] Starting dynamic subtest: ccs0
[220.290640] Dynamic subtest ccs0: SUCCESS (0.026s)
[220.293174] Subtest preempt: SUCCESS (0.131s)
[222.153497] [046/133] (804s left) i915_module_load (reload)
[222.188776] Starting subtest: reload
[227.217622] Subtest reload: SUCCESS (5.029s)
[227.262787] [047/133] (799s left) gem_exec_reloc (basic-wc-cpu-active)
[228.927482] Subtest basic-wc-cpu-active: SKIP (0.000s)
[228.994715] [048/133] (797s left) gen9_exec_parse (valid-registers)
[229.061023] Subtest valid-registers: SKIP (0.000s)
[229.140690] [049/133] (797s left) kms_cursor_edge_walk (64x64-left-edge)
[229.237944] Starting subtest: 64x64-left-edge
[229.240174] Starting dynamic subtest: pipe-A-eDP-1
[232.726387] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.487s)
[232.735279] Starting dynamic subtest: pipe-D-eDP-1
[235.916854] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.189s)
[235.919139] Subtest 64x64-left-edge: SUCCESS (6.678s)
[236.734921] [050/133] (790s left) gem_render_copy_redux (flink)
[236.798025] Starting subtest: flink
[237.536312] Subtest flink: SUCCESS (0.740s)
[237.687223] [051/133] (789s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[237.785676] Starting subtest: psr-2p-primscrn-spr-indfb-move
[237.789056] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[237.911024] [052/133] (788s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[238.011343] Starting subtest: bo-too-small-due-to-tiling
[238.014979] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[238.125707] [053/133] (788s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[238.217882] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[244.836536] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.620s)
[244.988800] [054/133] (781s left) gem_exec_reloc (basic-write-wc-active)
[245.047557] Subtest basic-write-wc-active: SKIP (0.000s)
[245.138330] [055/133] (781s left) gem_fenced_exec_thrash (2-spare-fences)
[245.198163] Subtest 2-spare-fences: SKIP (0.000s)
[245.267430] [056/133] (781s left) kms_hdr (static-toggle-dpms)
[245.365737] Starting subtest: static-toggle-dpms
[245.372453] Subtest static-toggle-dpms: SKIP (0.000s)
[245.451179] [057/133] (781s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[245.545430] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[252.616069] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.072s)
[252.774981] [058/133] (774s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[252.879193] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[256.630699] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.757s)
[257.808827] [059/133] (769s left) gem_lmem_swapping (parallel-random-verify)
[257.854669] Subtest parallel-random-verify: SKIP (0.000s)
[257.903298] [060/133] (769s left) kms_psr (fbc-pr-sprite-plane-move)
[258.002324] Starting subtest: fbc-pr-sprite-plane-move
[258.006442] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[258.102010] [061/133] (769s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[258.481488] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[259.292092] [062/133] (767s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[259.399706] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[259.401985] Starting dynamic subtest: pipe-A-eDP-1
[259.426036] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[259.437121] Starting dynamic subtest: pipe-B-eDP-1
[259.461927] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[259.470395] Starting dynamic subtest: pipe-C-eDP-1
[259.494291] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[259.502680] Starting dynamic subtest: pipe-D-eDP-1
[259.526450] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[259.531283] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[261.690089] [063/133] (765s left) i915_pm_rpm (gem-evict-pwrite)
[263.214076] Starting subtest: gem-evict-pwrite
[263.219145] Subtest gem-evict-pwrite: SKIP (0.000s)
[263.930596] [064/133] (763s left) gem_exec_whisper (basic-sync)
[263.999512] Starting subtest: basic-sync
[270.459671] Subtest basic-sync: SUCCESS (6.456s)
[270.658311] [065/133] (756s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[270.790699] Starting subtest: short-busy-flip-before-cursor-toggle
[270.795328] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[270.956936] [066/133] (756s left) i915_query (hwconfig_table)
[271.017418] Starting subtest: hwconfig_table
[271.316613] Subtest hwconfig_table: SUCCESS (0.001s)
[271.357191] [067/133] (756s left) kms_vrr (flipline)
[271.457784] Starting subtest: flipline
[271.464037] Subtest flipline: SKIP (0.000s)
[271.556950] [068/133] (755s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[271.651652] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[275.887447] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.238s)
[277.020033] [069/133] (750s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[277.117847] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[277.131397] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[277.204028] [070/133] (750s left) kms_prop_blob (invalid-set-prop)
[277.269636] Starting subtest: invalid-set-prop
[277.271767] Subtest invalid-set-prop: SUCCESS (0.000s)
[277.380762] [071/133] (750s left) kms_properties (crtc-properties-legacy)
[277.477471] Starting subtest: crtc-properties-legacy
[277.479560] Starting dynamic subtest: pipe-A-eDP-1
[277.927031] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.448s)
[277.936801] Starting dynamic subtest: pipe-B-eDP-1
[279.065994] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.139s)
[279.076420] Starting dynamic subtest: pipe-C-eDP-1
[280.189798] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.121s)
[280.199586] Starting dynamic subtest: pipe-D-eDP-1
[281.311521] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.122s)
[281.314099] Subtest crtc-properties-legacy: SUCCESS (3.835s)
[282.154008] [072/133] (745s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[282.260513] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[289.193502] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.933s)
[289.356120] [073/133] (738s left) kms_psr (fbc-pr-cursor-render)
[289.458428] Starting subtest: fbc-pr-cursor-render
[289.462606] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[289.558062] [074/133] (738s left) gem_userptr_blits (huge-split)
[289.637324] Starting subtest: huge-split
[289.644902] Subtest huge-split: SUCCESS (0.008s)
[289.796559] [075/133] (738s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[290.067019] Starting subtest: cursor-rapid-movement-256x85
[290.112027] Subtest cursor-rapid-movement-256x85: SKIP (0.042s)
[290.298750] [076/133] (737s left) gem_unref_active_buffers
[290.537986] [077/133] (737s left) gem_caching (reads)
[290.599418] Subtest reads: SKIP (0.000s)
[290.662978] [078/133] (737s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[290.721719] Starting subtest: invalid-multi-wait-all-unsubmitted
[290.723638] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[290.836380] [079/133] (737s left) gem_exec_create (basic)
[290.911475] Starting subtest: basic
[290.913529] Starting dynamic subtest: smem
[293.003152] Dynamic subtest smem: SUCCESS (2.090s)
[293.005614] Subtest basic: SUCCESS (2.092s)
[293.203597] [080/133] (734s left) kms_content_protection (atomic-dpms-hdcp14)
[293.347753] Starting subtest: atomic-dpms-hdcp14
[293.352429] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[293.499111] [081/133] (734s left) sw_sync (timeline_closed)
[293.534942] Starting subtest: timeline_closed
[293.537337] Subtest timeline_closed: SUCCESS (0.000s)
[293.619693] [082/133] (734s left) perf (oa-exponents)
[293.759980] Starting subtest: oa-exponents
[293.762261] Starting dynamic subtest: 0-rcs0
[295.536109] Dynamic subtest 0-rcs0: SUCCESS (1.775s)
[295.546076] Starting dynamic subtest: 1-vcs0
[297.341215] Dynamic subtest 1-vcs0: SUCCESS (1.803s)
[297.343834] Subtest oa-exponents: SUCCESS (3.580s)
[297.390602] [083/133] (730s left) kms_feature_discovery (display-2x)
[297.502866] Starting subtest: display-2x
[297.507188] Subtest display-2x: SKIP (0.000s)
[297.592425] [084/133] (730s left) core_setmaster (master-drop-set-root)
[297.669554] Starting subtest: master-drop-set-root
[297.682189] Subtest master-drop-set-root: SUCCESS (0.013s)
[297.730856] [085/133] (730s left) kms_pm_rpm (i2c)
[299.261864] Starting subtest: i2c
[304.650549] Subtest i2c: SUCCESS (5.386s)
[304.788220] [086/133] (723s left) kms_busy (basic-hang)
[304.906606] Starting subtest: basic-hang
[304.908768] Starting dynamic subtest: flip-pipe-A
[305.506329] Dynamic subtest flip-pipe-A: SUCCESS (0.600s)
[305.525331] Starting dynamic subtest: modeset-pipe-A
[308.934589] Dynamic subtest modeset-pipe-A: SUCCESS (3.423s)
[308.946226] Starting dynamic subtest: flip-pipe-D
[310.126887] Dynamic subtest flip-pipe-D: SUCCESS (1.191s)
[310.137480] Starting dynamic subtest: modeset-pipe-D
[313.541025] Dynamic subtest modeset-pipe-D: SUCCESS (3.412s)
[313.543201] Subtest basic-hang: SUCCESS (8.634s)
[314.367108] [087/133] (713s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[314.467959] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[314.471944] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[314.598491] [088/133] (713s left) kms_flip (nonblocking-read)
[314.697765] Starting subtest: nonblocking-read
[314.699620] Subtest nonblocking-read: SUCCESS (0.000s)
[314.830154] [089/133] (713s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[314.924687] Starting subtest: yf-tiled-16bpp-rotate-270
[314.928962] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[315.080373] [090/133] (713s left) gem_mmap_wc (write-read-distinct)
[315.154870] Subtest write-read-distinct: SKIP (0.000s)
[315.226336] [091/133] (713s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[315.284382] Starting subtest: multi-wait-for-submit-submitted-signaled
[315.286379] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[315.402676] [092/133] (713s left) kms_flip (blocking-wf_vblank)
[315.502611] Starting subtest: blocking-wf_vblank
[315.506762] Starting dynamic subtest: A-eDP1
[324.493410] Dynamic subtest A-eDP1: SUCCESS (8.984s)
[324.508611] Starting dynamic subtest: B-eDP1
[333.428051] Dynamic subtest B-eDP1: SUCCESS (8.932s)
[333.446652] Starting dynamic subtest: C-eDP1
[342.350858] Dynamic subtest C-eDP1: SUCCESS (8.922s)
[342.361514] Starting dynamic subtest: D-eDP1
[351.282446] Dynamic subtest D-eDP1: SUCCESS (8.933s)
[351.284742] Subtest blocking-wf_vblank: SUCCESS (35.784s)
[352.523670] [093/133] (676s left) gem_exec_alignment (pi)
[352.592280] Starting subtest: pi
[404.047373] Subtest pi: SUCCESS (51.457s)
[404.871709] [094/133] (623s left) kms_getfb (getfb-repeated-different-handles)
[405.047858] Starting subtest: getfb-repeated-different-handles
[405.050009] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[405.191421] [095/133] (623s left) syncobj_timeline (etime-multi-wait-submitted)
[405.267328] Starting subtest: etime-multi-wait-submitted
[405.377281] Subtest etime-multi-wait-submitted: SUCCESS (0.108s)
[405.468582] [096/133] (623s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[405.609415] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[406.612413] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (1.002s)
[407.452281] [097/133] (621s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[407.552659] Starting subtest: primary-yf-tiled-reflect-x-0
[407.612713] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.059s)
[407.726038] [098/133] (621s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[407.786767] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[407.873556] [099/133] (621s left) perf_pmu (rc6)
[407.911942] Starting subtest: rc6
[407.914301] Starting dynamic subtest: gt0
[414.295060] Dynamic subtest gt0: SUCCESS (6.384s)
[414.307867] Starting dynamic subtest: runtime-pm-gt0
[422.077247] Dynamic subtest runtime-pm-gt0: SUCCESS (7.780s)
[422.090430] Starting dynamic subtest: runtime-pm-long-gt0
[434.582556] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.501s)
[434.592706] Starting dynamic subtest: other-idle-gt0
[440.926124] Dynamic subtest other-idle-gt0: SUCCESS (6.341s)
[440.936472] Starting dynamic subtest: gt1
[447.268139] Dynamic subtest gt1: SUCCESS (6.339s)
[447.279156] Starting dynamic subtest: runtime-pm-gt1
[454.757366] Dynamic subtest runtime-pm-gt1: SUCCESS (7.485s)
[454.770323] Starting dynamic subtest: runtime-pm-long-gt1
[467.191747] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.430s)
[467.202794] Starting dynamic subtest: other-idle-gt1
[473.536660] Dynamic subtest other-idle-gt1: SUCCESS (6.340s)
[473.539425] Subtest rc6: SUCCESS (65.618s)
[474.752063] [100/133] (554s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[474.852523] Starting subtest: y-tiled-16bpp-rotate-0
[474.856519] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[474.942992] [101/133] (554s left) kms_flip_tiling (flip-change-tiling)
[475.037156] Starting subtest: flip-change-tiling
[475.038701] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[475.211648] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.175s)
[475.223859] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[475.346328] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[475.358556] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[475.479498] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[475.491763] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[475.622845] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s)
[475.635572] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[475.767300] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[475.778447] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[475.911598] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[475.923628] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[476.045265] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[476.056873] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[476.167677] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.120s)
[476.179716] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[476.302062] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[476.314131] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[476.445661] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[476.457360] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[476.589441] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[476.600701] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[476.733910] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[476.745388] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[476.867490] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[476.884651] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[477.012714] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.142s)
[477.025577] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[477.123889] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[477.136745] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[477.268009] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s)
[477.280766] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[477.423139] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.153s)
[477.436306] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[477.567490] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[477.579683] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[477.711944] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[477.724942] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[477.856612] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[477.868912] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[478.001421] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[478.013287] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[478.123040] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.120s)
[478.134407] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[478.266963] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.142s)
[478.281796] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[478.423068] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.154s)
[478.437866] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[478.578637] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.152s)
[478.593149] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[478.723391] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[478.736266] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[478.867108] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[478.881757] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[479.011884] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.142s)
[479.024277] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[479.134290] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.120s)
[479.145005] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[479.306328] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.170s)
[479.322464] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[479.450308] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.143s)
[479.466321] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[479.595083] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[479.607686] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[479.739971] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[479.751825] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[479.883853] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.142s)
[479.899463] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[480.029298] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.142s)
[480.049859] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[480.151277] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.120s)
[480.203921] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[481.382007] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.185s)
[481.395570] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[481.516389] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[481.536769] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[481.660539] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.142s)
[481.672846] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[481.804319] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s)
[481.816589] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[481.959595] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.153s)
[481.971642] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[482.103899] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[482.117331] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[482.237519] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[482.250570] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[482.359971] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.120s)
[482.372845] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[482.494457] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[482.507610] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[482.637696] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[482.650533] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[482.781607] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[482.794751] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[482.925715] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[482.941178] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[483.060378] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[483.072716] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[483.194562] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[483.206997] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[483.304297] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[483.316475] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[483.461531] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.154s)
[483.476475] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[483.604071] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[483.617133] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[483.748143] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[483.764203] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[483.893546] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[483.906223] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[484.037839] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[484.051928] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[484.182374] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[484.195647] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[484.304288] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.120s)
[484.315532] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[484.448387] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.142s)
[484.461691] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[484.592183] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.142s)
[484.607144] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[484.736710] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[484.751133] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[484.881127] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[484.896102] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[485.026405] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[485.038765] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[485.170138] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.142s)
[485.185505] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[485.292841] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.120s)
[485.305283] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[485.437365] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.142s)
[485.449345] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[485.581579] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[485.594255] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[485.725855] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[485.741329] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[485.870326] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[485.885762] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[486.015046] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.142s)
[486.029931] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[486.189384] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.171s)
[486.202155] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[486.311688] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.120s)
[486.365358] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[487.611577] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.254s)
[487.624449] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[487.711524] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.099s)
[487.723548] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[487.811711] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[487.824449] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[487.922269] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s)
[487.935420] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[488.033320] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[488.045672] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[488.144490] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.109s)
[488.156423] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[488.244509] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s)
[488.257010] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[488.355790] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[488.368682] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[488.456374] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.097s)
[488.468833] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[488.566881] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s)
[488.579159] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[488.677567] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[488.689471] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[488.788696] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s)
[488.800949] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[488.889308] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s)
[488.901880] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[488.989251] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[489.002019] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[489.089456] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[489.101693] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[489.200529] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s)
[489.213377] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[489.310988] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[489.322946] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[489.422143] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s)
[489.434065] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[489.533480] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.110s)
[489.548385] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[489.633739] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.098s)
[489.646243] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[489.733875] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.098s)
[489.745637] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[489.844739] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.109s)
[489.857287] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[489.966582] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.120s)
[489.978271] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[490.077792] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.109s)
[490.089638] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[490.188920] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.110s)
[490.199578] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[490.288730] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.098s)
[490.301027] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[490.400132] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.110s)
[490.412090] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[490.511057] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.109s)
[490.523330] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[490.622857] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.110s)
[490.635474] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[490.733693] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.109s)
[490.745791] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[490.844710] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[490.856860] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[490.955715] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s)
[490.967746] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[491.066965] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s)
[491.079214] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[491.189234] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.120s)
[491.200127] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[491.300489] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.109s)
[491.311583] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[491.412095] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.109s)
[491.453350] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[492.651049] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.204s)
[492.663713] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[492.750535] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[492.762860] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[492.850364] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[492.862716] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[492.962189] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s)
[492.975171] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[493.072591] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[493.083508] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[493.183602] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.110s)
[493.198979] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[493.295345] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.109s)
[493.308537] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[493.406831] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.108s)
[493.419950] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[493.506321] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[493.519564] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[493.617205] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s)
[493.630034] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[493.727786] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[493.739996] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[493.839198] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s)
[493.851550] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[493.939196] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s)
[493.954088] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[494.039379] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[494.051480] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[494.139669] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.099s)
[494.151878] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[494.290838] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.148s)
[494.303518] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[494.400239] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.108s)
[494.412903] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[494.511418] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.110s)
[494.523881] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[494.623451] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.109s)
[494.636339] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[494.734609] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.108s)
[494.746579] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[494.845769] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.108s)
[494.856844] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[494.956314] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.109s)
[494.968630] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[495.067181] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.109s)
[495.078544] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[495.178353] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.110s)
[495.189397] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[495.289430] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.109s)
[495.300692] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[495.389578] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.098s)
[495.401338] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[495.500380] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.110s)
[495.513562] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[495.622875] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.119s)
[495.633556] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[495.745168] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.121s)
[495.756695] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[495.856386] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.109s)
[495.866408] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[495.967279] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[495.978299] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[496.078529] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.110s)
[496.094646] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[496.189368] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s)
[496.201221] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[496.311735] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.120s)
[496.323860] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[496.422731] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.109s)
[496.436377] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[496.534278] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.109s)
[496.567125] Subtest flip-change-tiling: SUCCESS (21.528s)
[497.725087] [102/133] (531s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[497.835873] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[497.840339] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[497.909784] [103/133] (531s left) gem_exec_fence (submit-chain)
[498.088890] Starting subtest: submit-chain
[498.105858] Subtest submit-chain: SUCCESS (0.017s)
[500.068372] [104/133] (529s left) gem_ringfill (engines-basic)
[506.000852] Starting subtest: engines-basic
[506.003626] Starting dynamic subtest: rcs0
[506.077826] Dynamic subtest rcs0: SUCCESS (0.077s)
[506.090480] Starting dynamic subtest: bcs0
[506.122943] Dynamic subtest bcs0: SUCCESS (0.043s)
[506.137498] Starting dynamic subtest: vcs0
[506.168780] Dynamic subtest vcs0: SUCCESS (0.044s)
[506.180874] Starting dynamic subtest: vcs1
[506.213755] Dynamic subtest vcs1: SUCCESS (0.044s)
[506.224627] Starting dynamic subtest: vecs0
[506.257857] Dynamic subtest vecs0: SUCCESS (0.042s)
[506.271365] Starting dynamic subtest: ccs0
[506.303456] Dynamic subtest ccs0: SUCCESS (0.044s)
[506.305702] Subtest engines-basic: SUCCESS (0.305s)
[506.358045] [105/133] (522s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[506.454532] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[506.456660] Starting dynamic subtest: pipe-A-eDP-1
[506.475919] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[506.487117] Starting dynamic subtest: pipe-B-eDP-1
[506.504695] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[506.514534] Starting dynamic subtest: pipe-C-eDP-1
[506.533601] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[506.544826] Starting dynamic subtest: pipe-D-eDP-1
[506.564002] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[506.565898] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[508.687446] [106/133] (520s left) perf_pmu (busy-check-all)
[508.733587] Starting subtest: busy-check-all
[508.735587] Starting dynamic subtest: rcs0
[509.298750] Dynamic subtest rcs0: SUCCESS (0.567s)
[509.311436] Starting dynamic subtest: bcs0
[509.848509] Dynamic subtest bcs0: SUCCESS (0.547s)
[509.861609] Starting dynamic subtest: vcs0
[510.990076] Dynamic subtest vcs0: SUCCESS (1.137s)
[511.002772] Starting dynamic subtest: vcs1
[513.038238] Dynamic subtest vcs1: SUCCESS (2.045s)
[513.050850] Starting dynamic subtest: vecs0
[515.022268] Dynamic subtest vecs0: SUCCESS (1.980s)
[515.034922] Starting dynamic subtest: ccs0
[515.575199] Dynamic subtest ccs0: SUCCESS (0.552s)
[515.577796] Subtest busy-check-all: SUCCESS (6.843s)
[515.651568] [107/133] (513s left) gem_exec_schedule (submit-early-slice)
[515.726557] Starting subtest: submit-early-slice
[515.728913] Starting dynamic subtest: rcs0
[515.788693] Dynamic subtest rcs0: SUCCESS (0.066s)
[515.805677] Starting dynamic subtest: bcs0
[515.853711] Dynamic subtest bcs0: SUCCESS (0.062s)
[515.864643] Starting dynamic subtest: vcs0
[515.912254] Dynamic subtest vcs0: SUCCESS (0.058s)
[515.922575] Starting dynamic subtest: vcs1
[515.971352] Dynamic subtest vcs1: SUCCESS (0.058s)
[515.981321] Starting dynamic subtest: vecs0
[516.018518] Dynamic subtest vecs0: SUCCESS (0.047s)
[516.029458] Starting dynamic subtest: ccs0
[516.071382] Dynamic subtest ccs0: SUCCESS (0.053s)
[516.073930] Subtest submit-early-slice: SUCCESS (0.349s)
[517.093023] [108/133] (512s left) gem_exec_balancer (parallel-bb-first)
[517.351892] Starting subtest: parallel-bb-first
[518.266344] Subtest parallel-bb-first: SUCCESS (0.914s)
[519.011088] [109/133] (510s left) gen9_exec_parse (bb-large)
[519.076628] Subtest bb-large: SKIP (0.000s)
[519.160932] [110/133] (510s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[519.260952] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[519.263252] Starting dynamic subtest: pipe-A-eDP-1
[519.321341] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[519.332588] Starting dynamic subtest: pipe-B-eDP-1
[519.388903] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[519.400600] Starting dynamic subtest: pipe-C-eDP-1
[519.459209] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[519.470491] Starting dynamic subtest: pipe-D-eDP-1
[519.528347] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[519.532496] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.009s)
[521.544269] [111/133] (507s left) api_intel_bb (simple-bb-ctx)
[521.607912] Starting subtest: simple-bb-ctx
[521.616953] Subtest simple-bb-ctx: SUCCESS (0.010s)
[521.742769] [112/133] (507s left) gem_ctx_isolation (preservation-s3)
[521.817701] Starting subtest: preservation-S3
[521.820233] Starting dynamic subtest: rcs0
[537.946555] Dynamic subtest rcs0: SUCCESS (1.345s)
[537.957155] Starting dynamic subtest: bcs0
[553.952367] Dynamic subtest bcs0: SUCCESS (1.311s)
[553.963709] Starting dynamic subtest: vcs0
[569.960761] Dynamic subtest vcs0: SUCCESS (2.502s)
[569.978533] Starting dynamic subtest: vcs1
[587.953230] Dynamic subtest vcs1: SUCCESS (4.943s)
[587.964930] Starting dynamic subtest: vecs0
[605.944040] Dynamic subtest vecs0: SUCCESS (4.919s)
[605.956808] Starting dynamic subtest: ccs0
[623.962988] Dynamic subtest ccs0: SUCCESS (3.142s)
[623.966217] Subtest preservation-S3: SUCCESS (18.167s)
[624.182463] [113/133] (405s left) sriov_basic (enable-vfs-autoprobe-on)
[624.258640] Starting subtest: enable-vfs-autoprobe-on
[624.261351] Starting dynamic subtest: numvfs-1
[624.354128] Dynamic subtest numvfs-1: FAIL (0.026s)
[624.370437] Starting dynamic subtest: numvfs-2
[624.462469] Dynamic subtest numvfs-2: FAIL (0.004s)
[624.474510] Starting dynamic subtest: numvfs-3
[624.567753] Dynamic subtest numvfs-3: FAIL (0.003s)
[624.579069] Starting dynamic subtest: numvfs-4
[624.665970] Dynamic subtest numvfs-4: FAIL (0.003s)
[624.676590] Starting dynamic subtest: numvfs-5
[624.766538] Dynamic subtest numvfs-5: FAIL (0.003s)
[624.778428] Starting dynamic subtest: numvfs-6
[624.869633] Dynamic subtest numvfs-6: FAIL (0.004s)
[624.881076] Starting dynamic subtest: numvfs-7
[624.964881] Dynamic subtest numvfs-7: FAIL (0.004s)
[624.974875] Starting dynamic subtest: numvfs-random
[625.048916] Dynamic subtest numvfs-random: FAIL (0.003s)
[625.059918] Starting dynamic subtest: numvfs-all
[625.135894] Dynamic subtest numvfs-all: FAIL (0.617s)
[625.138124] Subtest enable-vfs-autoprobe-on: FAIL (0.675s)
[625.179836] [114/133] (404s left) perf_pmu (gt-awake)
[625.224030] Starting subtest: gt-awake
[633.703119] Subtest gt-awake: SUCCESS (8.357s)
[633.796828] [115/133] (395s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[633.857376] Subtest no-spare-fences-busy: SKIP (0.000s)
[633.935762] [116/133] (395s left) kms_rotation_crc (primary-rotation-90)
[634.027951] Starting subtest: primary-rotation-90
[634.032992] Subtest primary-rotation-90: SKIP (0.001s)
[634.078306] [117/133] (395s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[634.174828] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[634.983323] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.804s)
[635.138610] [118/133] (394s left) gem_mmap_wc (write-prefaulted)
[635.204008] Subtest write-prefaulted: SKIP (0.000s)
[635.266238] [119/133] (394s left) gem_pxp (reject-modify-context-protection-off-1)
[635.382631] Starting subtest: reject-modify-context-protection-off-1
[635.385702] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[635.492119] [120/133] (394s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[635.597898] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[635.600663] Starting dynamic subtest: pipe-A-eDP-1
[635.631954] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.036s)
[635.645840] Starting dynamic subtest: pipe-B-eDP-1
[635.668759] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.024s)
[635.679620] Starting dynamic subtest: pipe-C-eDP-1
[635.703907] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s)
[635.716105] Starting dynamic subtest: pipe-D-eDP-1
[635.739586] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[635.741920] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.109s)
[638.002719] [121/133] (391s left) kms_plane_lowres (tiling-x)
[638.095897] Starting subtest: tiling-x
[638.098740] Starting dynamic subtest: pipe-A-eDP-1
[638.103853] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[638.397042] Starting dynamic subtest: pipe-B-eDP-1
[638.402981] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[638.415274] Starting dynamic subtest: pipe-C-eDP-1
[638.421006] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[638.430749] Starting dynamic subtest: pipe-D-eDP-1
[638.435884] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[638.440940] Subtest tiling-x: SKIP (0.298s)
[639.241304] [122/133] (390s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[639.343477] Starting subtest: multiplane-rotation-cropping-top
[656.874873] Subtest multiplane-rotation-cropping-top: SUCCESS (17.505s)
[656.999351] [123/133] (372s left) gem_mmap_gtt (basic-write-read-distinct)
[657.067418] Subtest basic-write-read-distinct: SKIP (0.000s)
[657.141091] [124/133] (372s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[657.258924] Starting subtest: fbc-psr2-sprite-mmap-gtt
[657.261386] Starting dynamic subtest: eDP-1
[657.265310] Dynamic subtest eDP-1: SKIP (0.000s)
[657.269516] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[657.316858] [125/133] (372s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[657.411677] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[657.415708] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[657.459363] [126/133] (372s left) gem_tiled_partial_pwrite_pread (writes)
[657.520152] Subtest writes: SKIP (0.000s)
[657.607929] [127/133] (372s left) kms_atomic (crtc-invalid-params-fence)
[657.702483] Starting subtest: crtc-invalid-params-fence
[657.704464] Starting dynamic subtest: pipe-A-eDP-1
[658.132165] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.428s)
[658.135102] Subtest crtc-invalid-params-fence: SUCCESS (0.430s)
[658.910569] [128/133] (371s left) gem_busy (parallel)
[659.097339] Starting subtest: parallel
[659.100135] Starting dynamic subtest: rcs0
[660.646101] Dynamic subtest rcs0: SUCCESS (1.546s)
[660.659936] Starting dynamic subtest: bcs0
[662.693583] Dynamic subtest bcs0: SUCCESS (2.044s)
[662.707421] Starting dynamic subtest: vcs0
[664.677774] Dynamic subtest vcs0: SUCCESS (1.981s)
[664.691282] Starting dynamic subtest: vcs1
[666.661884] Dynamic subtest vcs1: SUCCESS (1.980s)
[666.676120] Starting dynamic subtest: vecs0
[668.645920] Dynamic subtest vecs0: SUCCESS (1.980s)
[668.659362] Starting dynamic subtest: ccs0
[670.692496] Dynamic subtest ccs0: SUCCESS (2.043s)
[670.695524] Subtest parallel: SUCCESS (11.593s)
[670.938700] [129/133] (359s left) gem_ctx_persistence (processes)
[671.020529] Starting subtest: processes
[672.707386] Subtest processes: SUCCESS (1.686s)
[672.768664] [130/133] (357s left) kms_big_fb (4-tiled-addfb-size-overflow)
[672.886014] Starting subtest: 4-tiled-addfb-size-overflow
[672.888823] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[672.990003] [131/133] (357s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[673.100080] Starting subtest: x-tiled-64bpp-rotate-270
[673.119739] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s)
[673.240881] [132/133] (357s left) kms_plane_scaling (planes-scaler-unity-scaling)
[673.343964] Starting subtest: planes-scaler-unity-scaling
[673.346376] Starting dynamic subtest: pipe-A
[673.406831] Dynamic subtest pipe-A: SUCCESS (0.064s)
[673.418644] Starting dynamic subtest: pipe-B
[674.540093] Dynamic subtest pipe-B: SUCCESS (1.132s)
[674.552117] Starting dynamic subtest: pipe-C
[675.657114] Dynamic subtest pipe-C: SUCCESS (1.115s)
[675.668091] Starting dynamic subtest: pipe-D
[676.777134] Dynamic subtest pipe-D: SUCCESS (1.119s)
[676.779722] Subtest planes-scaler-unity-scaling: SUCCESS (3.435s)
[677.941255] [133/133] (352s left) gem_exec_whisper (basic-contexts)
[678.003880] Starting subtest: basic-contexts
[685.638494] Subtest basic-contexts: SUCCESS (7.629s)
[685.796900] 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.