[60.242748] Initializing watchdogs
[60.242797]   /dev/watchdog0
[60.256595] [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]
[60.260923] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.263012] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.266209] [001/133] (960s left) api_intel_allocator (gem-pool)
[60.343091] Starting subtest: gem-pool
[60.357147] Subtest gem-pool: SUCCESS (0.016s)
[60.493518] [002/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[60.596592] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[60.600727] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[60.704073] [003/133] (960s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[60.790929] Starting subtest: read-crc-frame-sequence
[60.793300] Starting dynamic subtest: pipe-A-eDP-1
[61.506053] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.718s)
[61.513753] Starting dynamic subtest: pipe-B-eDP-1
[62.921559] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.418s)
[62.929639] Starting dynamic subtest: pipe-C-eDP-1
[64.211640] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.293s)
[64.220244] Starting dynamic subtest: pipe-D-eDP-1
[65.533326] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.323s)
[65.535817] Subtest read-crc-frame-sequence: SUCCESS (4.756s)
[66.382986] [004/133] (954s left) syncobj_timeline (invalid-query-one-illegal-handle)
[66.433834] Starting subtest: invalid-query-one-illegal-handle
[66.436264] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[66.556203] [005/133] (954s left) syncobj_wait (invalid-signal-zero-handles)
[66.607038] Starting subtest: invalid-signal-zero-handles
[66.609289] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[66.726578] [006/133] (954s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[66.878737] Starting subtest: fbcpsr-rgb565-draw-render
[73.917836] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.054s)
[74.082842] [007/133] (946s left) syncobj_timeline (wait-for-submit-snapshot)
[74.146747] Starting subtest: wait-for-submit-snapshot
[74.228927] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[74.311439] [008/133] (946s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[74.404486] Starting subtest: psr-rgb565-draw-blt
[81.371028] Subtest psr-rgb565-draw-blt: SUCCESS (6.971s)
[81.522740] [009/133] (939s left) kms_cursor_crc (cursor-onscreen-32x10)
[81.676935] Starting subtest: cursor-onscreen-32x10
[81.720741] Subtest cursor-onscreen-32x10: SKIP (0.039s)
[82.021265] [010/133] (939s left) syncobj_wait (invalid-signal-illegal-handle)
[82.074596] Starting subtest: invalid-signal-illegal-handle
[82.076725] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[82.180822] [011/133] (938s left) testdisplay
[82.556401] [012/133] (938s left) prime_mmap (test_map_unmap)
[82.607839] Starting subtest: test_map_unmap
[82.609587] Starting dynamic subtest: test_map_unmap-smem
[82.636960] Dynamic subtest test_map_unmap-smem: SUCCESS (0.030s)
[82.639290] Subtest test_map_unmap: SUCCESS (0.030s)
[82.746614] [013/133] (938s left) gem_exec_fence (syncobj-timeline-signal)
[83.289534] Starting subtest: syncobj-timeline-signal
[83.295745] Subtest syncobj-timeline-signal: SUCCESS (0.008s)
[84.953806] [FACT gem_exec_fence (syncobj-timeline-signal)] new: kernel.kmod_is_loaded.vgem: true
[84.957067] [014/133] (936s left) syncobj_timeline (signal-point-0)
[85.008582] Starting subtest: signal-point-0
[85.010457] Subtest signal-point-0: SUCCESS (0.000s)
[85.128208] [015/133] (936s left) kms_psr (psr2-suspend)
[85.213637] Starting subtest: psr2-suspend
[85.215978] Starting dynamic subtest: eDP-1
[103.277592] Dynamic subtest eDP-1: SUCCESS (2.983s)
[103.280228] Subtest psr2-suspend: SUCCESS (2.984s)
[104.140225] [016/133] (917s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[104.260423] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[104.273220] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[104.342092] [017/133] (917s left) gem_softpin (reverse)
[104.415109] Starting subtest: reverse
[104.419818] Subtest reverse: SUCCESS (0.007s)
[104.564225] [018/133] (916s left) gem_exec_balancer (parallel-contexts)
[104.847397] Starting subtest: parallel-contexts
[107.255077] Subtest parallel-contexts: SUCCESS (2.484s)
[108.033051] [019/133] (913s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[108.128156] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[108.130148] Starting dynamic subtest: pipe-A-eDP-1
[110.197810] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.099s)
[110.205314] Starting dynamic subtest: pipe-B-eDP-1
[112.255864] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.077s)
[112.264226] Starting dynamic subtest: pipe-C-eDP-1
[114.238594] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.996s)
[114.247776] Starting dynamic subtest: pipe-D-eDP-1
[116.286925] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.060s)
[116.289203] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.236s)
[117.516533] [020/133] (903s left) kms_lease (lease-unleased-connector)
[117.618697] Starting subtest: lease-unleased-connector
[117.621064] Starting dynamic subtest: pipe-A-eDP-1
[117.628641] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.010s)
[117.637192] Starting dynamic subtest: pipe-B-eDP-1
[117.639406] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[117.648095] Starting dynamic subtest: pipe-C-eDP-1
[117.650345] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[117.658395] Starting dynamic subtest: pipe-D-eDP-1
[117.660365] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.006s)
[117.662255] Subtest lease-unleased-connector: SUCCESS (0.035s)
[117.790893] [021/133] (903s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[117.908290] Starting subtest: cursor-vs-flip-atomic-transitions
[147.774178] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.893s)
[148.615217] [022/133] (872s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[148.724979] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[148.727320] Starting dynamic subtest: pipe-A-default-mode
[151.427072] Dynamic subtest pipe-A-default-mode: SUCCESS (2.704s)
[151.429512] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.706s)
[152.311255] [023/133] (869s left) kms_addfb_basic (legacy-format)
[152.376217] Starting subtest: legacy-format
[152.394748] Subtest legacy-format: SUCCESS (0.016s)
[152.578191] [024/133] (869s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[152.693782] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[152.697498] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[152.820516] [025/133] (868s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[152.917329] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[152.921187] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[153.057145] [026/133] (868s left) kms_vblank (query-busy)
[153.159819] Starting subtest: query-busy
[153.161987] Starting dynamic subtest: pipe-A-eDP-1
[155.038848] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.881s)
[155.052630] Starting dynamic subtest: pipe-D-eDP-1
[157.657953] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.616s)
[157.660353] Subtest query-busy: SUCCESS (4.500s)
[158.464112] [027/133] (863s left) gem_wait (invalid-flags)
[158.532407] Starting subtest: invalid-flags
[158.534327] Subtest invalid-flags: SUCCESS (0.000s)
[158.789006] [028/133] (863s left) kms_properties (invalid-properties-atomic)
[158.885812] Starting subtest: invalid-properties-atomic
[159.189243] Subtest invalid-properties-atomic: SUCCESS (0.304s)
[159.270911] [029/133] (862s left) gem_exec_flush (basic-wb-ro-before-default)
[159.337960] Starting subtest: basic-wb-ro-before-default
[164.788307] Subtest basic-wb-ro-before-default: SUCCESS (5.452s)
[164.999662] [030/133] (856s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[165.109168] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[165.113328] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[165.209784] [031/133] (856s left) kms_psr (pr-primary-blt)
[165.305835] Starting subtest: pr-primary-blt
[165.310152] Subtest pr-primary-blt: SKIP (0.000s)
[165.386826] [032/133] (856s left) kms_flip (2x-flip-vs-dpms-on-nop)
[165.485902] Starting subtest: 2x-flip-vs-dpms-on-nop
[165.493752] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.010s)
[165.581812] [033/133] (856s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[165.686260] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[165.690677] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[165.828825] [034/133] (856s left) kms_chamelium_edid (dp-mode-timings)
[166.234141] Subtest dp-mode-timings: SKIP (0.000s)
[167.071813] [035/133] (855s left) kms_flip (flip-vs-panning-interruptible)
[167.168914] Starting subtest: flip-vs-panning-interruptible
[167.171150] Starting dynamic subtest: A-eDP1
[175.893956] Dynamic subtest A-eDP1: SUCCESS (8.727s)
[175.902074] Starting dynamic subtest: B-eDP1
[184.620735] Dynamic subtest B-eDP1: SUCCESS (8.728s)
[184.632095] Starting dynamic subtest: C-eDP1
[193.338337] Dynamic subtest C-eDP1: SUCCESS (8.720s)
[193.347619] Starting dynamic subtest: D-eDP1
[201.984120] Dynamic subtest D-eDP1: SUCCESS (8.644s)
[201.988371] Subtest flip-vs-panning-interruptible: SUCCESS (34.827s)
[203.253415] [036/133] (818s left) kms_pm_dc (dc5-psr)
[204.368611] Starting subtest: dc5-psr
[207.353325] Subtest dc5-psr: SUCCESS (2.983s)
[208.183963] [037/133] (813s left) gem_userptr_blits (process-exit)
[208.254302] Starting subtest: process-exit
[208.261040] Subtest process-exit: SUCCESS (0.008s)
[208.400168] [038/133] (813s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[208.486731] Starting subtest: plane-lut1d-post-ctm3x4
[208.500812] Starting dynamic subtest: pipe-A-eDP-1
[209.195335] Dynamic subtest pipe-A-eDP-1: FAIL (0.323s)
[209.861612] Starting dynamic subtest: pipe-B-eDP-1
[210.667736] Dynamic subtest pipe-B-eDP-1: FAIL (0.279s)
[211.192808] Starting dynamic subtest: pipe-C-eDP-1
[212.026311] Dynamic subtest pipe-C-eDP-1: FAIL (0.235s)
[212.525319] Starting dynamic subtest: pipe-D-eDP-1
[213.344423] Dynamic subtest pipe-D-eDP-1: FAIL (0.235s)
[213.346481] Subtest plane-lut1d-post-ctm3x4: FAIL (4.555s)
[213.920980] [039/133] (808s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[213.989154] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[214.098233] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.108s)
[214.185033] [040/133] (808s left) gem_mmap_offset (partial-remap)
[214.249116] Starting subtest: partial-remap
[214.251061] Starting dynamic subtest: smem0
[214.259983] Dynamic subtest smem0: SUCCESS (0.004s)
[214.262215] Subtest partial-remap: SUCCESS (0.004s)
[214.401472] [041/133] (807s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[214.494737] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[214.498667] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[214.603575] [042/133] (807s left) gem_userptr_blits (dmabuf-unsync)
[214.689635] Subtest dmabuf-unsync: SKIP (0.000s)
[214.831794] [043/133] (807s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[214.946490] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[214.950700] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[215.060287] [044/133] (807s left) gem_close_race (multigpu-basic-threads)
[215.134254] Starting subtest: multigpu-basic-threads
[215.137925] Subtest multigpu-basic-threads: SKIP (0.000s)
[215.391435] [045/133] (807s left) gem_exec_schedule (preempt)
[215.471479] Starting subtest: preempt
[215.473723] Starting dynamic subtest: rcs0
[215.486174] Dynamic subtest rcs0: SUCCESS (0.022s)
[215.496150] Starting dynamic subtest: bcs0
[215.512278] Dynamic subtest bcs0: SUCCESS (0.025s)
[215.520793] Starting dynamic subtest: vcs0
[215.530898] Dynamic subtest vcs0: SUCCESS (0.018s)
[215.539458] Starting dynamic subtest: vcs1
[215.550350] Dynamic subtest vcs1: SUCCESS (0.019s)
[215.558307] Starting dynamic subtest: vecs0
[215.568620] Dynamic subtest vecs0: SUCCESS (0.018s)
[215.576524] Starting dynamic subtest: ccs0
[215.587283] Dynamic subtest ccs0: SUCCESS (0.018s)
[215.589503] Subtest preempt: SUCCESS (0.124s)
[217.065154] [046/133] (805s left) i915_module_load (reload)
[217.102541] Starting subtest: reload
[222.004070] Subtest reload: SUCCESS (4.905s)
[222.044776] [047/133] (800s left) gem_exec_reloc (basic-wc-cpu-active)
[223.913784] Subtest basic-wc-cpu-active: SKIP (0.000s)
[224.001265] [048/133] (798s left) gen9_exec_parse (valid-registers)
[224.071150] Subtest valid-registers: SKIP (0.000s)
[224.146902] [049/133] (798s left) kms_cursor_edge_walk (64x64-left-edge)
[224.241843] Starting subtest: 64x64-left-edge
[224.243976] Starting dynamic subtest: pipe-A-eDP-1
[227.693626] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.451s)
[227.701933] Starting dynamic subtest: pipe-D-eDP-1
[230.813405] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.116s)
[230.815713] Subtest 64x64-left-edge: SUCCESS (6.570s)
[231.648690] [050/133] (791s left) gem_render_copy_redux (flink)
[231.718012] Starting subtest: flink
[232.420350] Subtest flink: SUCCESS (0.704s)
[232.580474] [051/133] (790s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[232.690268] Starting subtest: psr-2p-primscrn-spr-indfb-move
[232.694791] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[232.820839] [052/133] (789s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[232.911655] Starting subtest: bo-too-small-due-to-tiling
[232.915710] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[233.066599] [053/133] (789s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[233.166112] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[239.713014] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.549s)
[239.861113] [054/133] (782s left) gem_exec_reloc (basic-write-wc-active)
[239.931262] Subtest basic-write-wc-active: SKIP (0.000s)
[240.001667] [055/133] (782s left) gem_fenced_exec_thrash (2-spare-fences)
[240.071157] Subtest 2-spare-fences: SKIP (0.000s)
[240.159951] [056/133] (782s left) kms_hdr (static-toggle-dpms)
[240.257838] Starting subtest: static-toggle-dpms
[240.264171] Subtest static-toggle-dpms: SKIP (0.000s)
[240.342309] [057/133] (782s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[240.443793] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[247.474942] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.036s)
[247.646885] [058/133] (775s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[247.753947] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[251.448364] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.698s)
[252.634405] [059/133] (770s left) gem_lmem_swapping (parallel-random-verify)
[252.680518] Subtest parallel-random-verify: SKIP (0.000s)
[252.717691] [060/133] (770s left) kms_psr (fbc-pr-sprite-plane-move)
[252.807543] Starting subtest: fbc-pr-sprite-plane-move
[252.811392] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[252.895960] [061/133] (770s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[253.285535] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[254.122880] [062/133] (769s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[254.215409] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[254.217644] Starting dynamic subtest: pipe-A-eDP-1
[254.241486] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[254.251334] Starting dynamic subtest: pipe-B-eDP-1
[254.274658] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[254.283016] Starting dynamic subtest: pipe-C-eDP-1
[254.306367] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[254.314793] Starting dynamic subtest: pipe-D-eDP-1
[254.340293] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[254.344496] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[256.440952] [063/133] (766s left) i915_pm_rpm (gem-evict-pwrite)
[258.176637] Starting subtest: gem-evict-pwrite
[258.182514] Subtest gem-evict-pwrite: SKIP (0.000s)
[258.696099] [064/133] (764s left) gem_exec_whisper (basic-sync)
[258.752620] Starting subtest: basic-sync
[265.398787] Subtest basic-sync: SUCCESS (6.645s)
[265.595795] [065/133] (757s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[265.728155] Starting subtest: short-busy-flip-before-cursor-toggle
[265.732872] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[265.884915] [066/133] (757s left) i915_query (hwconfig_table)
[265.951102] Starting subtest: hwconfig_table
[266.255984] Subtest hwconfig_table: SUCCESS (0.001s)
[266.296426] [067/133] (757s left) kms_vrr (flipline)
[266.389444] Starting subtest: flipline
[266.395586] Subtest flipline: SKIP (0.000s)
[266.472226] [068/133] (756s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[266.567625] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[270.829851] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.265s)
[271.990147] [069/133] (751s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[272.093017] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[272.106522] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[272.174903] [070/133] (751s left) kms_prop_blob (invalid-set-prop)
[272.234858] Starting subtest: invalid-set-prop
[272.237132] Subtest invalid-set-prop: SUCCESS (0.000s)
[272.350945] [071/133] (751s left) kms_properties (crtc-properties-legacy)
[272.456890] Starting subtest: crtc-properties-legacy
[272.458792] Starting dynamic subtest: pipe-A-eDP-1
[272.893674] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.434s)
[272.903211] Starting dynamic subtest: pipe-B-eDP-1
[274.021746] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.130s)
[274.030720] Starting dynamic subtest: pipe-C-eDP-1
[275.153186] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.130s)
[275.163330] Starting dynamic subtest: pipe-D-eDP-1
[276.273915] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.120s)
[276.276351] Subtest crtc-properties-legacy: SUCCESS (3.819s)
[277.098749] [072/133] (746s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[277.207540] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[284.148547] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.944s)
[284.334460] [073/133] (739s left) kms_psr (fbc-pr-cursor-render)
[284.439588] Starting subtest: fbc-pr-cursor-render
[284.444002] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[284.525904] [074/133] (739s left) gem_userptr_blits (huge-split)
[284.608356] Starting subtest: huge-split
[284.615692] Subtest huge-split: SUCCESS (0.007s)
[284.750640] [075/133] (738s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[285.009229] Starting subtest: cursor-rapid-movement-256x85
[285.053738] Subtest cursor-rapid-movement-256x85: SKIP (0.039s)
[285.243101] [076/133] (738s left) gem_unref_active_buffers
[285.430823] [077/133] (738s left) gem_caching (reads)
[285.489216] Subtest reads: SKIP (0.000s)
[285.575139] [078/133] (738s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[285.645789] Starting subtest: invalid-multi-wait-all-unsubmitted
[285.647646] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[285.799231] [079/133] (738s left) gem_exec_create (basic)
[285.862418] Starting subtest: basic
[285.864533] Starting dynamic subtest: smem
[287.996467] Dynamic subtest smem: SUCCESS (2.133s)
[287.999280] Subtest basic: SUCCESS (2.135s)
[288.206018] [080/133] (735s left) kms_content_protection (atomic-dpms-hdcp14)
[288.357624] Starting subtest: atomic-dpms-hdcp14
[288.361995] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[288.493528] [081/133] (735s left) sw_sync (timeline_closed)
[288.530018] Starting subtest: timeline_closed
[288.532367] Subtest timeline_closed: SUCCESS (0.000s)
[288.593247] [082/133] (735s left) perf (oa-exponents)
[288.727843] Starting subtest: oa-exponents
[288.729691] Starting dynamic subtest: 0-rcs0
[290.499161] Dynamic subtest 0-rcs0: SUCCESS (1.771s)
[290.509515] Starting dynamic subtest: 1-vcs0
[292.326853] Dynamic subtest 1-vcs0: SUCCESS (1.827s)
[292.329079] Subtest oa-exponents: SUCCESS (3.600s)
[292.375903] [083/133] (731s left) kms_feature_discovery (display-2x)
[292.513404] Starting subtest: display-2x
[292.517795] Subtest display-2x: SKIP (0.000s)
[292.611581] [084/133] (731s left) core_setmaster (master-drop-set-root)
[292.690157] Starting subtest: master-drop-set-root
[292.704521] Subtest master-drop-set-root: SUCCESS (0.014s)
[292.750304] [085/133] (731s left) kms_pm_rpm (i2c)
[294.273766] Starting subtest: i2c
[299.978631] Subtest i2c: SUCCESS (5.705s)
[300.080062] [086/133] (724s left) kms_busy (basic-hang)
[300.176939] Starting subtest: basic-hang
[300.179199] Starting dynamic subtest: flip-pipe-A
[300.767357] Dynamic subtest flip-pipe-A: SUCCESS (0.590s)
[300.776399] Starting dynamic subtest: modeset-pipe-A
[304.184012] Dynamic subtest modeset-pipe-A: SUCCESS (3.418s)
[304.192758] Starting dynamic subtest: flip-pipe-D
[305.373102] Dynamic subtest flip-pipe-D: SUCCESS (1.187s)
[305.382965] Starting dynamic subtest: modeset-pipe-D
[308.826070] Dynamic subtest modeset-pipe-D: SUCCESS (3.451s)
[308.828402] Subtest basic-hang: SUCCESS (8.652s)
[309.633565] [087/133] (714s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[309.731842] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[309.735973] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[309.851778] [088/133] (714s left) kms_flip (nonblocking-read)
[309.945813] Starting subtest: nonblocking-read
[309.947991] Subtest nonblocking-read: SUCCESS (0.000s)
[310.048842] [089/133] (714s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[310.151922] Starting subtest: yf-tiled-16bpp-rotate-270
[310.156253] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[310.285007] [090/133] (714s left) gem_mmap_wc (write-read-distinct)
[310.347693] Subtest write-read-distinct: SKIP (0.000s)
[310.425282] [091/133] (713s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[310.485477] Starting subtest: multi-wait-for-submit-submitted-signaled
[310.487699] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[310.604190] [092/133] (713s left) kms_flip (blocking-wf_vblank)
[310.704898] Starting subtest: blocking-wf_vblank
[310.706539] Starting dynamic subtest: A-eDP1
[319.667986] Dynamic subtest A-eDP1: SUCCESS (8.961s)
[319.680623] Starting dynamic subtest: B-eDP1
[328.595468] Dynamic subtest B-eDP1: SUCCESS (8.930s)
[328.604222] Starting dynamic subtest: C-eDP1
[337.509543] Dynamic subtest C-eDP1: SUCCESS (8.910s)
[337.519169] Starting dynamic subtest: D-eDP1
[346.440750] Dynamic subtest D-eDP1: SUCCESS (8.928s)
[346.446195] Subtest blocking-wf_vblank: SUCCESS (35.740s)
[347.682280] [093/133] (676s left) gem_exec_alignment (pi)
[347.754754] Starting subtest: pi
[397.726507] Subtest pi: SUCCESS (49.964s)
[398.942687] [094/133] (625s left) kms_getfb (getfb-repeated-different-handles)
[399.086533] Starting subtest: getfb-repeated-different-handles
[399.088737] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[399.192935] [095/133] (625s left) syncobj_timeline (etime-multi-wait-submitted)
[399.262309] Starting subtest: etime-multi-wait-submitted
[399.370669] Subtest etime-multi-wait-submitted: SUCCESS (0.106s)
[399.461766] [096/133] (625s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[399.586030] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[400.580391] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.991s)
[401.391905] [097/133] (623s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[401.477333] Starting subtest: primary-yf-tiled-reflect-x-0
[401.536613] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.059s)
[401.650940] [098/133] (622s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[401.731282] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[401.830127] [099/133] (622s left) perf_pmu (rc6)
[401.870811] Starting subtest: rc6
[401.872820] Starting dynamic subtest: gt0
[408.253178] Dynamic subtest gt0: SUCCESS (6.384s)
[408.265674] Starting dynamic subtest: runtime-pm-gt0
[416.008446] Dynamic subtest runtime-pm-gt0: SUCCESS (7.754s)
[416.021171] Starting dynamic subtest: runtime-pm-long-gt0
[428.525510] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.515s)
[428.537678] Starting dynamic subtest: other-idle-gt0
[434.867794] Dynamic subtest other-idle-gt0: SUCCESS (6.341s)
[434.877662] Starting dynamic subtest: gt1
[441.210918] Dynamic subtest gt1: SUCCESS (6.340s)
[441.223080] Starting dynamic subtest: runtime-pm-gt1
[448.703309] Dynamic subtest runtime-pm-gt1: SUCCESS (7.491s)
[448.715070] Starting dynamic subtest: runtime-pm-long-gt1
[461.126498] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.422s)
[461.138246] Starting dynamic subtest: other-idle-gt1
[467.469302] Dynamic subtest other-idle-gt1: SUCCESS (6.341s)
[467.472593] Subtest rc6: SUCCESS (65.607s)
[468.596158] [100/133] (556s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[468.717702] Starting subtest: y-tiled-16bpp-rotate-0
[468.722037] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[468.793774] [101/133] (555s left) kms_flip_tiling (flip-change-tiling)
[468.898138] Starting subtest: flip-change-tiling
[468.900065] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[469.060413] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.163s)
[469.073060] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[469.196826] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.132s)
[469.207499] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[469.328488] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[469.338992] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[469.472049] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s)
[469.486065] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[469.663315] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.188s)
[469.678530] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[469.806614] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[469.817654] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[469.951667] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.142s)
[469.963226] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[470.063291] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[470.075514] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[470.197852] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.132s)
[470.210340] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[470.329949] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.131s)
[470.342392] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[470.473105] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[470.485167] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[470.606418] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.131s)
[470.619495] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[470.740919] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[470.757846] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[470.875352] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[470.888249] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[470.985203] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[470.997154] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[471.129597] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.143s)
[471.141470] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[471.273790] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[471.285708] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[471.407258] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.131s)
[471.423487] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[471.551448] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[471.563610] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[471.696640] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[471.709457] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[471.829796] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.131s)
[471.841313] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[471.951527] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.120s)
[471.963451] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[472.095438] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.142s)
[472.107634] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[472.239338] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.142s)
[472.253648] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[472.384043] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[472.396418] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[472.517236] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.131s)
[472.529414] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[472.650635] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.131s)
[472.665453] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[472.794804] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.142s)
[472.808822] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[472.950938] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.153s)
[472.967066] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[473.096009] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.143s)
[473.108498] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[473.239338] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[473.253616] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[473.383771] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[473.399189] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[473.528816] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[473.539166] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[473.672810] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.142s)
[473.684428] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[473.817620] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.142s)
[473.829093] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[473.939934] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.120s)
[473.992075] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[475.193013] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.207s)
[475.205772] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[475.327349] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[475.339082] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[475.460304] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.130s)
[475.471968] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[475.592303] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.131s)
[475.604217] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[475.764448] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.170s)
[475.776115] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[475.908780] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[475.920424] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[476.042569] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[476.055018] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[476.153551] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[476.165773] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[476.287853] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[476.299979] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[476.443596] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.153s)
[476.455551] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[476.575073] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.131s)
[476.587315] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[476.719554] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[476.731938] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[476.853059] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[476.865223] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[476.988057] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[477.000500] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[477.098038] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[477.108081] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[477.270623] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.170s)
[477.280710] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[477.413884] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[477.425417] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[477.557717] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[477.572481] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[477.691612] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.131s)
[477.704118] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[477.825393] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.131s)
[477.837524] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[477.958895] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.131s)
[477.971523] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[478.080939] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.120s)
[478.093460] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[478.224367] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.142s)
[478.238958] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[478.369214] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.141s)
[478.381111] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[478.513053] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[478.527151] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[478.657544] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[478.672117] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[478.801953] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[478.813910] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[478.946457] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.142s)
[478.958070] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[479.068626] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.120s)
[479.082343] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[479.213192] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.142s)
[479.225231] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[479.357438] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[479.369094] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[479.501657] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[479.516530] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[479.646381] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[479.660651] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[479.818265] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.170s)
[479.830257] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[479.962707] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.142s)
[479.973093] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[480.085089] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.120s)
[480.142614] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[481.326910] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.196s)
[481.339190] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[481.426797] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[481.438788] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[481.526845] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[481.539290] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[481.637631] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s)
[481.650380] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[481.748441] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[481.760552] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[481.859521] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.110s)
[481.869410] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[481.959977] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.099s)
[481.971884] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[482.060257] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[482.071311] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[482.160055] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[482.171607] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[482.270443] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s)
[482.282232] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[482.381586] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[482.393212] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[482.492427] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s)
[482.503689] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[482.592525] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s)
[482.604086] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[482.693088] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[482.704505] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[482.793038] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[482.804643] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[482.944193] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.148s)
[482.955987] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[483.053701] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[483.065593] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[483.164722] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.110s)
[483.176485] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[483.264882] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.099s)
[483.277189] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[483.365598] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.098s)
[483.377850] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[483.465674] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.099s)
[483.477890] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[483.576169] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.109s)
[483.588393] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[483.687063] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.109s)
[483.699597] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[483.797913] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.110s)
[483.810237] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[483.909118] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.109s)
[483.919763] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[484.019520] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.109s)
[484.031032] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[484.130605] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.109s)
[484.142359] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[484.241690] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.109s)
[484.255581] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[484.353305] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.110s)
[484.364716] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[484.464503] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.109s)
[484.476774] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[484.575540] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[484.586800] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[484.686473] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s)
[484.697053] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[484.797390] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.110s)
[484.809756] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[484.948029] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.149s)
[484.961153] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[485.059580] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.109s)
[485.069871] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[485.170438] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.109s)
[485.214321] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[486.449100] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.244s)
[486.461285] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[486.548619] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[486.560474] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[486.659905] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.109s)
[486.671906] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[486.809669] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.148s)
[486.824163] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[486.931441] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.120s)
[486.942434] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[487.031346] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.098s)
[487.042391] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[487.131825] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.099s)
[487.143836] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[487.231847] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[487.242300] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[487.331511] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[487.342052] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[487.431371] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.098s)
[487.441362] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[487.541843] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[487.551833] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[487.641836] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.098s)
[487.651716] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[487.753638] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.110s)
[487.765891] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[487.853546] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.097s)
[487.865227] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[487.953577] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[487.963220] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[488.064210] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s)
[488.076174] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[488.213718] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.148s)
[488.226916] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[488.324919] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s)
[488.336347] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[488.424976] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.098s)
[488.436980] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[488.525103] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.098s)
[488.537673] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[488.625443] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.098s)
[488.637159] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[488.736121] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.109s)
[488.748086] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[488.847063] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.109s)
[488.858330] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[488.958044] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.110s)
[488.969605] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[489.058138] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.098s)
[489.069660] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[489.158246] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.099s)
[489.169630] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[489.258046] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.098s)
[489.269322] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[489.369217] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.110s)
[489.380095] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[489.480544] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.110s)
[489.492398] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[489.591784] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.109s)
[489.603532] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[489.702655] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[489.713959] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[489.802276] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.098s)
[489.814113] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[489.913409] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.110s)
[489.924677] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[490.024617] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.110s)
[490.035156] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[490.135960] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.109s)
[490.147818] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[490.269618] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.131s)
[490.302422] Subtest flip-change-tiling: SUCCESS (21.409s)
[491.523736] [102/133] (533s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[491.629553] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[491.634272] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[491.704806] [103/133] (533s left) gem_exec_fence (submit-chain)
[491.884620] Starting subtest: submit-chain
[491.902044] Subtest submit-chain: SUCCESS (0.018s)
[494.095152] [104/133] (530s left) gem_ringfill (engines-basic)
[499.969485] Starting subtest: engines-basic
[499.971959] Starting dynamic subtest: rcs0
[500.027425] Dynamic subtest rcs0: SUCCESS (0.058s)
[500.039635] Starting dynamic subtest: bcs0
[500.072403] Dynamic subtest bcs0: SUCCESS (0.043s)
[500.084767] Starting dynamic subtest: vcs0
[500.113303] Dynamic subtest vcs0: SUCCESS (0.040s)
[500.123217] Starting dynamic subtest: vcs1
[500.156366] Dynamic subtest vcs1: SUCCESS (0.041s)
[500.167306] Starting dynamic subtest: vecs0
[500.199799] Dynamic subtest vecs0: SUCCESS (0.042s)
[500.210523] Starting dynamic subtest: ccs0
[500.245392] Dynamic subtest ccs0: SUCCESS (0.044s)
[500.247781] Subtest engines-basic: SUCCESS (0.279s)
[500.300481] [105/133] (524s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[500.413333] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[500.415512] Starting dynamic subtest: pipe-A-eDP-1
[500.435157] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[500.446105] Starting dynamic subtest: pipe-B-eDP-1
[500.464831] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[500.473279] Starting dynamic subtest: pipe-C-eDP-1
[500.491786] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[500.500201] Starting dynamic subtest: pipe-D-eDP-1
[500.519273] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[500.521188] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[502.672471] [106/133] (522s left) perf_pmu (busy-check-all)
[502.717928] Starting subtest: busy-check-all
[502.720256] Starting dynamic subtest: rcs0
[503.289930] Dynamic subtest rcs0: SUCCESS (0.571s)
[503.303239] Starting dynamic subtest: bcs0
[503.840106] Dynamic subtest bcs0: SUCCESS (0.549s)
[503.852452] Starting dynamic subtest: vcs0
[505.022589] Dynamic subtest vcs0: SUCCESS (1.179s)
[505.036313] Starting dynamic subtest: vcs1
[507.006607] Dynamic subtest vcs1: SUCCESS (1.981s)
[507.019287] Starting dynamic subtest: vecs0
[508.990526] Dynamic subtest vecs0: SUCCESS (1.981s)
[509.001505] Starting dynamic subtest: ccs0
[509.544679] Dynamic subtest ccs0: SUCCESS (0.553s)
[509.547185] Subtest busy-check-all: SUCCESS (6.829s)
[509.635810] [107/133] (515s left) gem_exec_schedule (submit-early-slice)
[509.704417] Starting subtest: submit-early-slice
[509.706820] Starting dynamic subtest: rcs0
[509.759176] Dynamic subtest rcs0: SUCCESS (0.063s)
[509.772057] Starting dynamic subtest: bcs0
[509.819361] Dynamic subtest bcs0: SUCCESS (0.059s)
[509.832520] Starting dynamic subtest: vcs0
[509.875694] Dynamic subtest vcs0: SUCCESS (0.056s)
[509.887667] Starting dynamic subtest: vcs1
[509.936617] Dynamic subtest vcs1: SUCCESS (0.061s)
[509.949727] Starting dynamic subtest: vecs0
[509.994779] Dynamic subtest vecs0: SUCCESS (0.057s)
[510.006461] Starting dynamic subtest: ccs0
[510.071264] Dynamic subtest ccs0: SUCCESS (0.076s)
[510.073858] Subtest submit-early-slice: SUCCESS (0.376s)
[511.064400] [108/133] (513s left) gem_exec_balancer (parallel-bb-first)
[511.332466] Starting subtest: parallel-bb-first
[512.225191] Subtest parallel-bb-first: SUCCESS (0.893s)
[513.044642] [109/133] (512s left) gen9_exec_parse (bb-large)
[513.122130] Subtest bb-large: SKIP (0.000s)
[513.220921] [110/133] (511s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[513.318258] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[513.320628] Starting dynamic subtest: pipe-A-eDP-1
[513.377414] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[513.386820] Starting dynamic subtest: pipe-B-eDP-1
[513.450163] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[513.461060] Starting dynamic subtest: pipe-C-eDP-1
[513.517682] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[513.528068] Starting dynamic subtest: pipe-D-eDP-1
[513.584612] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[513.588756] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.009s)
[515.456336] [111/133] (509s left) api_intel_bb (simple-bb-ctx)
[515.510709] Starting subtest: simple-bb-ctx
[515.516058] Subtest simple-bb-ctx: SUCCESS (0.007s)
[515.636746] [112/133] (509s left) gem_ctx_isolation (preservation-s3)
[515.691841] Starting subtest: preservation-S3
[515.694192] Starting dynamic subtest: rcs0
[531.903103] Dynamic subtest rcs0: SUCCESS (1.305s)
[531.913372] Starting dynamic subtest: bcs0
[547.915076] Dynamic subtest bcs0: SUCCESS (1.331s)
[547.925323] Starting dynamic subtest: vcs0
[563.902624] Dynamic subtest vcs0: SUCCESS (2.780s)
[563.915348] Starting dynamic subtest: vcs1
[581.902701] Dynamic subtest vcs1: SUCCESS (5.074s)
[581.913817] Starting dynamic subtest: vecs0
[599.894630] Dynamic subtest vecs0: SUCCESS (5.073s)
[599.906385] Starting dynamic subtest: ccs0
[617.913391] Dynamic subtest ccs0: SUCCESS (3.302s)
[617.915995] Subtest preservation-S3: SUCCESS (18.872s)
[618.134065] [113/133] (407s left) sriov_basic (enable-vfs-autoprobe-on)
[618.213360] Starting subtest: enable-vfs-autoprobe-on
[618.216149] Starting dynamic subtest: numvfs-1
[618.302868] Dynamic subtest numvfs-1: FAIL (0.026s)
[618.311923] Starting dynamic subtest: numvfs-2
[618.396791] Dynamic subtest numvfs-2: FAIL (0.004s)
[618.406907] Starting dynamic subtest: numvfs-3
[618.490690] Dynamic subtest numvfs-3: FAIL (0.003s)
[618.500682] Starting dynamic subtest: numvfs-4
[618.584694] Dynamic subtest numvfs-4: FAIL (0.003s)
[618.594996] Starting dynamic subtest: numvfs-5
[618.679302] Dynamic subtest numvfs-5: FAIL (0.003s)
[618.689378] Starting dynamic subtest: numvfs-6
[618.773089] Dynamic subtest numvfs-6: FAIL (0.003s)
[618.783075] Starting dynamic subtest: numvfs-7
[618.866834] Dynamic subtest numvfs-7: FAIL (0.003s)
[618.877412] Starting dynamic subtest: numvfs-random
[618.963634] Dynamic subtest numvfs-random: FAIL (0.004s)
[618.973724] Starting dynamic subtest: numvfs-all
[619.051990] Dynamic subtest numvfs-all: FAIL (0.590s)
[619.054427] Subtest enable-vfs-autoprobe-on: FAIL (0.647s)
[619.094269] [114/133] (406s left) perf_pmu (gt-awake)
[619.130555] Starting subtest: gt-awake
[627.656890] Subtest gt-awake: SUCCESS (8.638s)
[627.753121] [115/133] (397s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[627.816986] Subtest no-spare-fences-busy: SKIP (0.000s)
[627.903752] [116/133] (397s left) kms_rotation_crc (primary-rotation-90)
[628.003930] Starting subtest: primary-rotation-90
[628.008880] Subtest primary-rotation-90: SKIP (0.001s)
[628.054386] [117/133] (397s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[628.148376] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[628.934400] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.792s)
[629.120283] [118/133] (396s left) gem_mmap_wc (write-prefaulted)
[629.183906] Subtest write-prefaulted: SKIP (0.000s)
[629.258969] [119/133] (396s left) gem_pxp (reject-modify-context-protection-off-1)
[629.378919] Starting subtest: reject-modify-context-protection-off-1
[629.381887] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[629.479186] [120/133] (396s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[629.572756] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[629.575291] Starting dynamic subtest: pipe-A-eDP-1
[629.597408] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.023s)
[629.607870] Starting dynamic subtest: pipe-B-eDP-1
[629.631554] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[629.642719] Starting dynamic subtest: pipe-C-eDP-1
[629.664927] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s)
[629.674922] Starting dynamic subtest: pipe-D-eDP-1
[629.697577] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s)
[629.700138] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.093s)
[631.825074] [121/133] (393s left) kms_plane_lowres (tiling-x)
[631.917664] Starting subtest: tiling-x
[631.919978] Starting dynamic subtest: pipe-A-eDP-1
[631.924904] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[632.208869] Starting dynamic subtest: pipe-B-eDP-1
[632.213650] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[632.223698] Starting dynamic subtest: pipe-C-eDP-1
[632.228523] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[632.238005] Starting dynamic subtest: pipe-D-eDP-1
[632.242344] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[632.246796] Subtest tiling-x: SKIP (0.291s)
[633.050256] [122/133] (392s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[633.150289] Starting subtest: multiplane-rotation-cropping-top
[650.511974] Subtest multiplane-rotation-cropping-top: SUCCESS (17.393s)
[650.629149] [123/133] (375s left) gem_mmap_gtt (basic-write-read-distinct)
[650.692572] Subtest basic-write-read-distinct: SKIP (0.000s)
[650.763316] [124/133] (374s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[650.862311] Starting subtest: fbc-psr2-sprite-mmap-gtt
[650.864572] Starting dynamic subtest: eDP-1
[650.868689] Dynamic subtest eDP-1: SKIP (0.000s)
[650.872842] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.002s)
[650.914338] [125/133] (374s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[651.023395] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[651.027653] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[651.068663] [126/133] (374s left) gem_tiled_partial_pwrite_pread (writes)
[651.129980] Subtest writes: SKIP (0.000s)
[651.218555] [127/133] (374s left) kms_atomic (crtc-invalid-params-fence)
[651.313006] Starting subtest: crtc-invalid-params-fence
[651.315339] Starting dynamic subtest: pipe-A-eDP-1
[651.711979] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.398s)
[651.714799] Subtest crtc-invalid-params-fence: SUCCESS (0.400s)
[652.547790] [128/133] (373s left) gem_busy (parallel)
[652.724423] Starting subtest: parallel
[652.727377] Starting dynamic subtest: rcs0
[654.664738] Dynamic subtest rcs0: SUCCESS (1.938s)
[654.679126] Starting dynamic subtest: bcs0
[656.648668] Dynamic subtest bcs0: SUCCESS (1.980s)
[656.661733] Starting dynamic subtest: vcs0
[658.632658] Dynamic subtest vcs0: SUCCESS (1.980s)
[658.645743] Starting dynamic subtest: vcs1
[660.679964] Dynamic subtest vcs1: SUCCESS (2.044s)
[660.692634] Starting dynamic subtest: vecs0
[662.664395] Dynamic subtest vecs0: SUCCESS (1.982s)
[662.676926] Starting dynamic subtest: ccs0
[664.647391] Dynamic subtest ccs0: SUCCESS (1.979s)
[664.649962] Subtest parallel: SUCCESS (11.920s)
[664.872176] [129/133] (361s left) gem_ctx_persistence (processes)
[664.943248] Starting subtest: processes
[666.644991] Subtest processes: SUCCESS (1.702s)
[666.703541] [130/133] (359s left) kms_big_fb (4-tiled-addfb-size-overflow)
[666.807702] Starting subtest: 4-tiled-addfb-size-overflow
[666.810252] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[666.878050] [131/133] (359s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[666.982726] Starting subtest: x-tiled-64bpp-rotate-270
[667.003003] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s)
[667.106736] [132/133] (358s left) kms_plane_scaling (planes-scaler-unity-scaling)
[667.203888] Starting subtest: planes-scaler-unity-scaling
[667.206702] Starting dynamic subtest: pipe-A
[667.267974] Dynamic subtest pipe-A: SUCCESS (0.064s)
[667.279487] Starting dynamic subtest: pipe-B
[668.396139] Dynamic subtest pipe-B: SUCCESS (1.128s)
[668.408677] Starting dynamic subtest: pipe-C
[669.505353] Dynamic subtest pipe-C: SUCCESS (1.108s)
[669.517022] Starting dynamic subtest: pipe-D
[670.641849] Dynamic subtest pipe-D: SUCCESS (1.136s)
[670.644828] Subtest planes-scaler-unity-scaling: SUCCESS (3.439s)
[671.784782] [133/133] (354s left) gem_exec_whisper (basic-contexts)
[671.850717] Starting subtest: basic-contexts
[677.739365] Subtest basic-contexts: SUCCESS (5.887s)
[677.899447] 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.