[59.034753] Initializing watchdogs
[59.034799]   /dev/watchdog0
[59.048965] [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]
[59.053824] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.056108] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.059860] [001/133] (960s left) api_intel_allocator (gem-pool)
[59.143306] Starting subtest: gem-pool
[59.156973] Subtest gem-pool: SUCCESS (0.015s)
[59.295002] [002/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[59.395434] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[59.399623] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[59.522962] [003/133] (960s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[59.620910] Starting subtest: read-crc-frame-sequence
[59.623417] Starting dynamic subtest: pipe-A-eDP-1
[60.368477] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.745s)
[60.377246] Starting dynamic subtest: pipe-B-eDP-1
[61.723014] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.349s)
[61.731533] Starting dynamic subtest: pipe-C-eDP-1
[63.031440] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.306s)
[63.041859] Starting dynamic subtest: pipe-D-eDP-1
[64.368571] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.333s)
[64.370906] Subtest read-crc-frame-sequence: SUCCESS (4.738s)
[65.203019] [004/133] (954s left) syncobj_timeline (invalid-query-one-illegal-handle)
[65.270178] Starting subtest: invalid-query-one-illegal-handle
[65.272551] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[65.392112] [005/133] (954s left) syncobj_wait (invalid-signal-zero-handles)
[65.449936] Starting subtest: invalid-signal-zero-handles
[65.451866] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[65.570944] [006/133] (954s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[65.681179] Starting subtest: fbcpsr-rgb565-draw-render
[72.777917] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.093s)
[72.939189] [007/133] (946s left) syncobj_timeline (wait-for-submit-snapshot)
[73.002112] Starting subtest: wait-for-submit-snapshot
[73.083522] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[73.166145] [008/133] (946s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[73.263807] Starting subtest: psr-rgb565-draw-blt
[80.292929] Subtest psr-rgb565-draw-blt: SUCCESS (7.030s)
[80.447407] [009/133] (939s left) kms_cursor_crc (cursor-onscreen-32x10)
[80.624560] Starting subtest: cursor-onscreen-32x10
[80.668437] Subtest cursor-onscreen-32x10: SKIP (0.042s)
[80.948902] [010/133] (938s left) syncobj_wait (invalid-signal-illegal-handle)
[81.004955] Starting subtest: invalid-signal-illegal-handle
[81.007503] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[81.116519] [011/133] (938s left) testdisplay
[81.476087] [012/133] (938s left) prime_mmap (test_map_unmap)
[81.535324] Starting subtest: test_map_unmap
[81.537027] Starting dynamic subtest: test_map_unmap-smem
[81.565360] Dynamic subtest test_map_unmap-smem: SUCCESS (0.031s)
[81.567452] Subtest test_map_unmap: SUCCESS (0.032s)
[81.693790] [013/133] (938s left) gem_exec_fence (syncobj-timeline-signal)
[82.253582] Starting subtest: syncobj-timeline-signal
[82.258772] Subtest syncobj-timeline-signal: SUCCESS (0.008s)
[84.027150] [FACT gem_exec_fence (syncobj-timeline-signal)] new: kernel.kmod_is_loaded.vgem: true
[84.029707] [014/133] (936s left) syncobj_timeline (signal-point-0)
[84.089870] Starting subtest: signal-point-0
[84.092216] Subtest signal-point-0: SUCCESS (0.000s)
[84.213871] [015/133] (935s left) kms_psr (psr2-suspend)
[84.310852] Starting subtest: psr2-suspend
[84.313163] Starting dynamic subtest: eDP-1
[102.337164] Dynamic subtest eDP-1: SUCCESS (3.039s)
[102.339284] Subtest psr2-suspend: SUCCESS (3.040s)
[103.151371] [016/133] (916s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[103.262501] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[103.275554] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[103.345947] [017/133] (916s left) gem_softpin (reverse)
[103.414021] Starting subtest: reverse
[103.420443] Subtest reverse: SUCCESS (0.006s)
[103.566882] [018/133] (916s left) gem_exec_balancer (parallel-contexts)
[103.844911] Starting subtest: parallel-contexts
[106.434857] Subtest parallel-contexts: SUCCESS (2.562s)
[106.567362] [019/133] (913s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[106.667758] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[106.669694] Starting dynamic subtest: pipe-A-eDP-1
[108.800544] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.116s)
[108.810040] Starting dynamic subtest: pipe-B-eDP-1
[111.028727] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.212s)
[111.037856] Starting dynamic subtest: pipe-C-eDP-1
[113.168731] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.128s)
[113.178528] Starting dynamic subtest: pipe-D-eDP-1
[115.289824] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.111s)
[115.291811] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.572s)
[116.516409] [020/133] (903s left) kms_lease (lease-unleased-connector)
[116.617452] Starting subtest: lease-unleased-connector
[116.619878] Starting dynamic subtest: pipe-A-eDP-1
[116.622281] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[116.635724] Starting dynamic subtest: pipe-B-eDP-1
[116.638063] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[116.648040] Starting dynamic subtest: pipe-C-eDP-1
[116.650303] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[116.663264] Starting dynamic subtest: pipe-D-eDP-1
[116.665523] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[116.667764] Subtest lease-unleased-connector: SUCCESS (0.031s)
[116.784070] [021/133] (903s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[116.911702] Starting subtest: cursor-vs-flip-atomic-transitions
[146.906067] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.972s)
[147.733332] [022/133] (872s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[147.842533] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[147.844803] Starting dynamic subtest: pipe-A-default-mode
[150.561147] Dynamic subtest pipe-A-default-mode: SUCCESS (2.718s)
[150.563454] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.719s)
[151.416336] [023/133] (869s left) kms_addfb_basic (legacy-format)
[151.474596] Starting subtest: legacy-format
[151.493271] Subtest legacy-format: SUCCESS (0.018s)
[151.667729] [024/133] (868s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[151.771888] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[151.775649] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[151.911624] [025/133] (868s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[152.015561] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[152.019748] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[152.150022] [026/133] (868s left) kms_vblank (query-busy)
[152.250399] Starting subtest: query-busy
[152.252561] Starting dynamic subtest: pipe-A-eDP-1
[154.136627] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.885s)
[154.150493] Starting dynamic subtest: pipe-D-eDP-1
[156.664902] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.527s)
[156.667262] Subtest query-busy: SUCCESS (4.416s)
[157.481142] [027/133] (863s left) gem_wait (invalid-flags)
[157.552700] Starting subtest: invalid-flags
[157.555070] Subtest invalid-flags: SUCCESS (0.000s)
[157.824957] [028/133] (862s left) kms_properties (invalid-properties-atomic)
[157.916758] Starting subtest: invalid-properties-atomic
[158.225874] Subtest invalid-properties-atomic: SUCCESS (0.310s)
[158.313086] [029/133] (862s left) gem_exec_flush (basic-wb-ro-before-default)
[158.388889] Starting subtest: basic-wb-ro-before-default
[163.854344] Subtest basic-wb-ro-before-default: SUCCESS (5.465s)
[164.071699] [030/133] (856s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[164.171439] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[164.175325] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[164.289600] [031/133] (856s left) kms_psr (pr-primary-blt)
[164.377324] Starting subtest: pr-primary-blt
[164.381527] Subtest pr-primary-blt: SKIP (0.000s)
[164.480712] [032/133] (856s left) kms_flip (2x-flip-vs-dpms-on-nop)
[164.585069] Starting subtest: 2x-flip-vs-dpms-on-nop
[164.595925] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[164.714286] [033/133] (856s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[164.825911] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[164.830395] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[164.953658] [034/133] (855s left) kms_chamelium_edid (dp-mode-timings)
[165.336560] Subtest dp-mode-timings: SKIP (0.000s)
[166.176253] [035/133] (854s left) kms_flip (flip-vs-panning-interruptible)
[166.282814] Starting subtest: flip-vs-panning-interruptible
[166.285237] Starting dynamic subtest: A-eDP1
[175.011490] Dynamic subtest A-eDP1: SUCCESS (8.725s)
[175.022149] Starting dynamic subtest: B-eDP1
[183.740262] Dynamic subtest B-eDP1: SUCCESS (8.724s)
[183.750514] Starting dynamic subtest: C-eDP1
[192.458993] Dynamic subtest C-eDP1: SUCCESS (8.714s)
[192.467627] Starting dynamic subtest: D-eDP1
[201.198764] Dynamic subtest D-eDP1: SUCCESS (8.739s)
[201.204164] Subtest flip-vs-panning-interruptible: SUCCESS (34.913s)
[202.480622] [036/133] (818s left) kms_pm_dc (dc5-psr)
[203.593215] Starting subtest: dc5-psr
[206.472244] Subtest dc5-psr: SUCCESS (2.878s)
[207.309793] [037/133] (813s left) gem_userptr_blits (process-exit)
[207.389243] Starting subtest: process-exit
[207.394335] Subtest process-exit: SUCCESS (0.008s)
[207.547627] [038/133] (813s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[207.650986] Starting subtest: plane-lut1d-post-ctm3x4
[207.664032] Starting dynamic subtest: pipe-A-eDP-1
[208.345614] Dynamic subtest pipe-A-eDP-1: FAIL (0.327s)
[209.066724] Starting dynamic subtest: pipe-B-eDP-1
[209.887378] Dynamic subtest pipe-B-eDP-1: FAIL (0.301s)
[210.403412] Starting dynamic subtest: pipe-C-eDP-1
[211.231475] Dynamic subtest pipe-C-eDP-1: FAIL (0.245s)
[211.733014] Starting dynamic subtest: pipe-D-eDP-1
[212.601192] Dynamic subtest pipe-D-eDP-1: FAIL (0.279s)
[212.603239] Subtest plane-lut1d-post-ctm3x4: FAIL (4.658s)
[213.142313] [039/133] (807s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[213.207468] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[213.317660] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.109s)
[213.411908] [040/133] (807s left) gem_mmap_offset (partial-remap)
[213.479116] Starting subtest: partial-remap
[213.481430] Starting dynamic subtest: smem0
[213.490413] Dynamic subtest smem0: SUCCESS (0.003s)
[213.492666] Subtest partial-remap: SUCCESS (0.004s)
[213.626093] [041/133] (807s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[213.730598] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[213.734916] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[213.866064] [042/133] (807s left) gem_userptr_blits (dmabuf-unsync)
[213.931140] Subtest dmabuf-unsync: SKIP (0.000s)
[214.075501] [043/133] (807s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[214.163789] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[214.167808] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[214.294485] [044/133] (807s left) gem_close_race (multigpu-basic-threads)
[214.363646] Starting subtest: multigpu-basic-threads
[214.367451] Subtest multigpu-basic-threads: SKIP (0.000s)
[214.619134] [045/133] (806s left) gem_exec_schedule (preempt)
[214.700808] Starting subtest: preempt
[214.703297] Starting dynamic subtest: rcs0
[214.715374] Dynamic subtest rcs0: SUCCESS (0.024s)
[214.726014] Starting dynamic subtest: bcs0
[214.733936] Dynamic subtest bcs0: SUCCESS (0.018s)
[214.742546] Starting dynamic subtest: vcs0
[214.754753] Dynamic subtest vcs0: SUCCESS (0.020s)
[214.763461] Starting dynamic subtest: vcs1
[214.775377] Dynamic subtest vcs1: SUCCESS (0.020s)
[214.786430] Starting dynamic subtest: vecs0
[214.794324] Dynamic subtest vecs0: SUCCESS (0.018s)
[214.802889] Starting dynamic subtest: ccs0
[214.812222] Dynamic subtest ccs0: SUCCESS (0.017s)
[214.814630] Subtest preempt: SUCCESS (0.121s)
[216.018631] [046/133] (805s left) i915_module_load (reload)
[216.053236] Starting subtest: reload
[222.337195] Subtest reload: SUCCESS (6.288s)
[222.379266] [047/133] (799s left) gem_exec_reloc (basic-wc-cpu-active)
[223.822717] Subtest basic-wc-cpu-active: SKIP (0.000s)
[223.929570] [048/133] (797s left) gen9_exec_parse (valid-registers)
[223.985543] Subtest valid-registers: SKIP (0.000s)
[224.064537] [049/133] (797s left) kms_cursor_edge_walk (64x64-left-edge)
[224.178345] Starting subtest: 64x64-left-edge
[224.180553] Starting dynamic subtest: pipe-A-eDP-1
[227.624503] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.445s)
[227.636091] Starting dynamic subtest: pipe-D-eDP-1
[230.748132] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.124s)
[230.750539] Subtest 64x64-left-edge: SUCCESS (6.571s)
[231.556355] [050/133] (790s left) gem_render_copy_redux (flink)
[231.626628] Starting subtest: flink
[232.342430] Subtest flink: SUCCESS (0.715s)
[232.506405] [051/133] (789s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[232.619187] Starting subtest: psr-2p-primscrn-spr-indfb-move
[232.622690] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[232.747004] [052/133] (788s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[232.851411] Starting subtest: bo-too-small-due-to-tiling
[232.854912] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[232.962519] [053/133] (788s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[233.071823] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[239.646262] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.574s)
[239.775369] [054/133] (781s left) gem_exec_reloc (basic-write-wc-active)
[239.836087] Subtest basic-write-wc-active: SKIP (0.000s)
[239.922591] [055/133] (781s left) gem_fenced_exec_thrash (2-spare-fences)
[239.979141] Subtest 2-spare-fences: SKIP (0.000s)
[240.058875] [056/133] (781s left) kms_hdr (static-toggle-dpms)
[240.156286] Starting subtest: static-toggle-dpms
[240.162581] Subtest static-toggle-dpms: SKIP (0.000s)
[240.256628] [057/133] (781s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[240.352909] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[247.436069] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.087s)
[247.586724] [058/133] (774s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[247.692697] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[251.448000] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.760s)
[252.597419] [059/133] (769s left) gem_lmem_swapping (parallel-random-verify)
[252.641416] Subtest parallel-random-verify: SKIP (0.000s)
[252.687057] [060/133] (769s left) kms_psr (fbc-pr-sprite-plane-move)
[252.778376] Starting subtest: fbc-pr-sprite-plane-move
[252.782803] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[252.864150] [061/133] (769s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[253.270127] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[254.081696] [062/133] (768s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[254.173443] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[254.175803] Starting dynamic subtest: pipe-A-eDP-1
[254.200000] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[254.211140] Starting dynamic subtest: pipe-B-eDP-1
[254.234533] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[254.243079] Starting dynamic subtest: pipe-C-eDP-1
[254.266961] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[254.275316] Starting dynamic subtest: pipe-D-eDP-1
[254.298635] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[254.302450] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[256.392284] [063/133] (765s left) i915_pm_rpm (gem-evict-pwrite)
[258.023112] Starting subtest: gem-evict-pwrite
[258.028078] Subtest gem-evict-pwrite: SKIP (0.000s)
[258.634611] [064/133] (763s left) gem_exec_whisper (basic-sync)
[258.698479] Starting subtest: basic-sync
[265.123442] Subtest basic-sync: SUCCESS (6.421s)
[265.371755] [065/133] (756s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[265.503508] Starting subtest: short-busy-flip-before-cursor-toggle
[265.507787] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[265.669579] [066/133] (756s left) i915_query (hwconfig_table)
[265.734209] Starting subtest: hwconfig_table
[266.034667] Subtest hwconfig_table: SUCCESS (0.001s)
[266.089661] [067/133] (756s left) kms_vrr (flipline)
[266.200772] Starting subtest: flipline
[266.207078] Subtest flipline: SKIP (0.000s)
[266.284335] [068/133] (756s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[266.390458] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[270.684814] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.296s)
[271.828591] [069/133] (750s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[271.938438] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[271.951361] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[272.023608] [070/133] (750s left) kms_prop_blob (invalid-set-prop)
[272.079132] Starting subtest: invalid-set-prop
[272.081296] Subtest invalid-set-prop: SUCCESS (0.000s)
[272.202494] [071/133] (750s left) kms_properties (crtc-properties-legacy)
[272.307036] Starting subtest: crtc-properties-legacy
[272.309231] Starting dynamic subtest: pipe-A-eDP-1
[272.758694] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.451s)
[272.769160] Starting dynamic subtest: pipe-B-eDP-1
[273.958619] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.197s)
[273.968585] Starting dynamic subtest: pipe-C-eDP-1
[275.087778] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.127s)
[275.097428] Starting dynamic subtest: pipe-D-eDP-1
[276.208077] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.118s)
[276.210072] Subtest crtc-properties-legacy: SUCCESS (3.900s)
[277.055505] [072/133] (745s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[277.159731] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[284.103164] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.943s)
[284.289626] [073/133] (738s left) kms_psr (fbc-pr-cursor-render)
[284.406253] Starting subtest: fbc-pr-cursor-render
[284.410334] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[284.478006] [074/133] (738s left) gem_userptr_blits (huge-split)
[284.552960] Starting subtest: huge-split
[284.559453] Subtest huge-split: SUCCESS (0.006s)
[284.748588] [075/133] (737s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[285.020972] Starting subtest: cursor-rapid-movement-256x85
[285.071529] Subtest cursor-rapid-movement-256x85: SKIP (0.042s)
[285.265570] [076/133] (737s left) gem_unref_active_buffers
[285.519032] [077/133] (737s left) gem_caching (reads)
[285.579771] Subtest reads: SKIP (0.000s)
[285.647169] [078/133] (737s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[285.710726] Starting subtest: invalid-multi-wait-all-unsubmitted
[285.712577] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[285.848307] [079/133] (737s left) gem_exec_create (basic)
[285.907473] Starting subtest: basic
[285.909232] Starting dynamic subtest: smem
[288.865195] Dynamic subtest smem: SUCCESS (2.955s)
[288.867675] Subtest basic: SUCCESS (2.957s)
[289.083306] [080/133] (733s left) kms_content_protection (atomic-dpms-hdcp14)
[289.240563] Starting subtest: atomic-dpms-hdcp14
[289.245061] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[289.397565] [081/133] (733s left) sw_sync (timeline_closed)
[289.435445] Starting subtest: timeline_closed
[289.437606] Subtest timeline_closed: SUCCESS (0.000s)
[289.496949] [082/133] (733s left) perf (oa-exponents)
[289.643657] Starting subtest: oa-exponents
[289.645510] Starting dynamic subtest: 0-rcs0
[291.427850] Dynamic subtest 0-rcs0: SUCCESS (1.783s)
[291.437244] Starting dynamic subtest: 1-vecs0
[293.258701] Dynamic subtest 1-vecs0: SUCCESS (1.828s)
[293.261488] Subtest oa-exponents: SUCCESS (3.613s)
[293.306718] [083/133] (729s left) kms_feature_discovery (display-2x)
[293.411869] Starting subtest: display-2x
[293.416138] Subtest display-2x: SKIP (0.000s)
[293.509386] [084/133] (729s left) core_setmaster (master-drop-set-root)
[293.592148] Starting subtest: master-drop-set-root
[293.602038] Subtest master-drop-set-root: SUCCESS (0.010s)
[293.650869] [085/133] (729s left) kms_pm_rpm (i2c)
[295.176012] Starting subtest: i2c
[300.518958] Subtest i2c: SUCCESS (5.340s)
[300.617190] [086/133] (722s left) kms_busy (basic-hang)
[300.725323] Starting subtest: basic-hang
[300.727646] Starting dynamic subtest: flip-pipe-A
[301.327744] Dynamic subtest flip-pipe-A: SUCCESS (0.601s)
[301.338272] Starting dynamic subtest: modeset-pipe-A
[304.712539] Dynamic subtest modeset-pipe-A: SUCCESS (3.382s)
[304.722402] Starting dynamic subtest: flip-pipe-D
[305.911136] Dynamic subtest flip-pipe-D: SUCCESS (1.196s)
[305.921634] Starting dynamic subtest: modeset-pipe-D
[309.328649] Dynamic subtest modeset-pipe-D: SUCCESS (3.418s)
[309.331095] Subtest basic-hang: SUCCESS (8.605s)
[310.140972] [087/133] (713s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[310.251661] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[310.255767] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[310.353214] [088/133] (712s left) kms_flip (nonblocking-read)
[310.453954] Starting subtest: nonblocking-read
[310.456642] Subtest nonblocking-read: SUCCESS (0.000s)
[310.591600] [089/133] (712s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[310.695590] Starting subtest: yf-tiled-16bpp-rotate-270
[310.700054] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[310.816507] [090/133] (712s left) gem_mmap_wc (write-read-distinct)
[310.885623] Subtest write-read-distinct: SKIP (0.000s)
[310.961314] [091/133] (712s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[311.032023] Starting subtest: multi-wait-for-submit-submitted-signaled
[311.034001] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[311.136533] [092/133] (712s left) kms_flip (blocking-wf_vblank)
[311.232313] Starting subtest: blocking-wf_vblank
[311.234241] Starting dynamic subtest: A-eDP1
[320.181817] Dynamic subtest A-eDP1: SUCCESS (8.947s)
[320.193994] Starting dynamic subtest: B-eDP1
[329.113415] Dynamic subtest B-eDP1: SUCCESS (8.929s)
[329.127516] Starting dynamic subtest: C-eDP1
[338.025095] Dynamic subtest C-eDP1: SUCCESS (8.911s)
[338.041385] Starting dynamic subtest: D-eDP1
[346.956003] Dynamic subtest D-eDP1: SUCCESS (8.932s)
[346.961124] Subtest blocking-wf_vblank: SUCCESS (35.730s)
[348.190670] [093/133] (675s left) gem_exec_alignment (pi)
[348.255244] Starting subtest: pi
[399.834371] Subtest pi: SUCCESS (51.577s)
[401.067661] [094/133] (622s left) kms_getfb (getfb-repeated-different-handles)
[401.217213] Starting subtest: getfb-repeated-different-handles
[401.219513] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[401.341623] [095/133] (622s left) syncobj_timeline (etime-multi-wait-submitted)
[401.409878] Starting subtest: etime-multi-wait-submitted
[401.517080] Subtest etime-multi-wait-submitted: SUCCESS (0.105s)
[401.604469] [096/133] (621s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[401.722108] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[402.715116] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.991s)
[403.526529] [097/133] (620s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[403.634970] Starting subtest: primary-yf-tiled-reflect-x-0
[403.694038] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.059s)
[403.810461] [098/133] (619s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[403.882932] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[403.974411] [099/133] (619s left) perf_pmu (rc6)
[404.017015] Starting subtest: rc6
[404.019123] Starting dynamic subtest: gt0
[410.412248] Dynamic subtest gt0: SUCCESS (6.393s)
[410.425139] Starting dynamic subtest: runtime-pm-gt0
[418.215271] Dynamic subtest runtime-pm-gt0: SUCCESS (7.802s)
[418.226507] Starting dynamic subtest: runtime-pm-long-gt0
[430.707727] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.488s)
[430.718410] Starting dynamic subtest: other-idle-gt0
[437.052168] Dynamic subtest other-idle-gt0: SUCCESS (6.341s)
[437.062805] Starting dynamic subtest: gt1
[443.393628] Dynamic subtest gt1: SUCCESS (6.338s)
[443.406607] Starting dynamic subtest: runtime-pm-gt1
[450.815211] Dynamic subtest runtime-pm-gt1: SUCCESS (7.418s)
[450.827951] Starting dynamic subtest: runtime-pm-long-gt1
[463.301978] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.482s)
[463.314966] Starting dynamic subtest: other-idle-gt1
[469.644599] Dynamic subtest other-idle-gt1: SUCCESS (6.340s)
[469.647656] Subtest rc6: SUCCESS (65.619s)
[470.781236] [100/133] (552s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[470.889611] Starting subtest: y-tiled-16bpp-rotate-0
[470.894003] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[470.981360] [101/133] (552s left) kms_flip_tiling (flip-change-tiling)
[471.076702] Starting subtest: flip-change-tiling
[471.078692] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[471.256459] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.181s)
[471.273813] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[471.403203] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.143s)
[471.415226] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[471.536544] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[471.551772] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[471.680048] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s)
[471.692729] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[471.823721] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.141s)
[471.836400] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[471.995972] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.170s)
[472.008679] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[472.129639] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[472.141273] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[472.252121] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.121s)
[472.265823] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[472.397416] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.142s)
[472.411972] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[472.569247] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.170s)
[472.580149] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[472.759761] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.190s)
[472.775027] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[472.950865] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.189s)
[472.965699] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[473.085383] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[473.098147] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[473.219767] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[473.231616] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[473.329759] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[473.340404] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[473.474079] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.143s)
[473.489543] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[473.618311] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[473.633693] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[473.762590] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[473.775623] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[473.907714] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[473.920885] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[474.052198] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[474.065973] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[474.196504] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[474.209927] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[474.318136] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.120s)
[474.329059] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[474.462073] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.142s)
[474.475745] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[474.606660] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.142s)
[474.621514] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[474.750900] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[474.765702] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[474.895935] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[474.907527] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[475.040248] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[475.052955] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[475.184496] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.142s)
[475.199229] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[475.306831] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.120s)
[475.319600] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[475.451878] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.143s)
[475.464904] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[475.595652] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[475.610663] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[475.740042] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[475.755303] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[475.885154] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[475.897495] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[476.029295] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.142s)
[476.043882] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[476.174041] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.142s)
[476.187486] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[476.296425] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.120s)
[476.351204] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[477.579214] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.237s)
[477.592140] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[477.713209] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[477.725837] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[477.858088] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.142s)
[477.870513] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[478.001389] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s)
[478.014577] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[478.172641] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.169s)
[478.188240] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[478.317635] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[478.329581] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[478.450730] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[478.463316] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[478.562363] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[478.575214] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[478.708259] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.142s)
[478.721025] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[478.880096] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.169s)
[478.893130] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[479.022954] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[479.035550] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[479.167392] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[479.180066] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[479.300691] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[479.313783] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[479.435478] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[479.447269] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[479.545526] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[479.561837] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[479.701000] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.154s)
[479.713222] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[479.845435] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[479.858932] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[479.989713] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[480.002523] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[480.134535] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[480.147458] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[480.278938] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[480.291617] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[480.425204] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[480.438858] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[480.545428] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.120s)
[480.561849] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[480.700472] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.153s)
[480.715824] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[480.845400] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.142s)
[480.861295] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[480.989375] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[481.003729] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[481.134012] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[481.147916] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[481.278844] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[481.297524] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[481.450623] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.169s)
[481.468286] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[481.584088] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.131s)
[481.600147] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[481.728484] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.142s)
[481.743298] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[481.900439] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.169s)
[481.915496] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[482.044828] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[482.060698] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[482.189471] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[482.204365] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[482.344937] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.153s)
[482.359649] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[482.501169] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.153s)
[482.516011] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[482.622941] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.119s)
[482.675753] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[483.912243] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.243s)
[483.925140] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[484.012259] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[484.024256] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[484.123588] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.109s)
[484.134678] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[484.234269] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s)
[484.246990] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[484.345331] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[484.357918] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[484.456450] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.109s)
[484.468485] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[484.556615] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s)
[484.568824] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[484.657262] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[484.670108] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[484.773419] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.109s)
[484.785687] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[484.918916] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.147s)
[484.931033] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[485.028565] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[485.040833] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[485.139403] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s)
[485.151220] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[485.239999] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s)
[485.250634] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[485.340279] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[485.350745] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[485.439956] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[485.450571] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[485.550991] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s)
[485.562275] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[485.661905] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[485.674137] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[485.773186] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s)
[485.785407] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[485.884876] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.109s)
[485.897260] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[485.995825] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.109s)
[486.008169] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[486.106851] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s)
[486.118825] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[486.217494] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.109s)
[486.233683] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[486.339399] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.119s)
[486.349401] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[486.450793] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.110s)
[486.461089] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[486.561680] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.109s)
[486.574378] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[486.673346] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.109s)
[486.689257] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[486.783827] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.109s)
[486.796028] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[486.895052] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.109s)
[486.909410] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[487.017274] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.120s)
[487.031761] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[487.140240] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.120s)
[487.153404] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[487.251656] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[487.264050] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[487.362095] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s)
[487.374857] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[487.473155] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s)
[487.485610] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[487.584068] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.109s)
[487.594817] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[487.695393] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.110s)
[487.709864] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[487.807067] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.109s)
[487.859877] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[489.065936] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.213s)
[489.078126] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[489.165910] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.097s)
[489.178154] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[489.278053] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.109s)
[489.290426] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[489.387958] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s)
[489.398869] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[489.498726] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[489.510234] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[489.609875] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.109s)
[489.624629] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[489.721247] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.110s)
[489.736745] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[489.833509] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[489.846206] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[489.933005] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[489.945746] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[490.043365] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.110s)
[490.059395] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[490.193139] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.148s)
[490.209757] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[490.303997] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s)
[490.315737] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[490.404683] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s)
[490.417415] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[490.504482] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[490.516903] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[490.604464] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.099s)
[490.616754] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[490.703945] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.098s)
[490.719270] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[490.815292] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.110s)
[490.826266] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[490.926344] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s)
[490.938454] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[491.037259] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.109s)
[491.050661] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[491.148877] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.109s)
[491.161212] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[491.259819] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s)
[491.271665] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[491.370993] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.109s)
[491.384355] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[491.481910] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.109s)
[491.495541] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[491.593077] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.109s)
[491.604285] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[491.704241] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.110s)
[491.720981] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[491.815432] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.110s)
[491.830351] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[491.926363] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.109s)
[491.937032] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[492.037526] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.110s)
[492.049849] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[492.148707] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.110s)
[492.161267] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[492.260047] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.109s)
[492.272365] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[492.371092] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[492.382084] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[492.482207] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s)
[492.493533] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[492.593219] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s)
[492.605593] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[492.704324] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.110s)
[492.715248] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[492.815509] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.109s)
[492.829032] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[492.926964] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.109s)
[492.960494] Subtest flip-change-tiling: SUCCESS (21.881s)
[494.143636] [102/133] (529s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[494.266338] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[494.270785] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[494.367474] [103/133] (529s left) gem_exec_fence (submit-chain)
[494.549924] Starting subtest: submit-chain
[494.567605] Subtest submit-chain: SUCCESS (0.018s)
[495.965590] [104/133] (527s left) gem_ringfill (engines-basic)
[501.924362] Starting subtest: engines-basic
[501.926814] Starting dynamic subtest: rcs0
[501.993455] Dynamic subtest rcs0: SUCCESS (0.069s)
[502.006676] Starting dynamic subtest: bcs0
[502.039213] Dynamic subtest bcs0: SUCCESS (0.044s)
[502.050670] Starting dynamic subtest: vcs0
[502.081553] Dynamic subtest vcs0: SUCCESS (0.041s)
[502.092373] Starting dynamic subtest: vcs1
[502.121953] Dynamic subtest vcs1: SUCCESS (0.040s)
[502.133569] Starting dynamic subtest: vecs0
[502.164318] Dynamic subtest vecs0: SUCCESS (0.041s)
[502.174419] Starting dynamic subtest: ccs0
[502.213502] Dynamic subtest ccs0: SUCCESS (0.047s)
[502.216040] Subtest engines-basic: SUCCESS (0.292s)
[502.272805] [105/133] (521s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[502.374038] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[502.376289] Starting dynamic subtest: pipe-A-eDP-1
[502.395818] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[502.406263] Starting dynamic subtest: pipe-B-eDP-1
[502.425278] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[502.434710] Starting dynamic subtest: pipe-C-eDP-1
[502.453334] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[502.462763] Starting dynamic subtest: pipe-D-eDP-1
[502.481354] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[502.483496] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[504.603203] [106/133] (519s left) perf_pmu (busy-check-all)
[504.649629] Starting subtest: busy-check-all
[504.651832] Starting dynamic subtest: rcs0
[505.209422] Dynamic subtest rcs0: SUCCESS (0.559s)
[505.222365] Starting dynamic subtest: bcs0
[505.759717] Dynamic subtest bcs0: SUCCESS (0.548s)
[505.775200] Starting dynamic subtest: vcs0
[506.849512] Dynamic subtest vcs0: SUCCESS (1.084s)
[506.861571] Starting dynamic subtest: vcs1
[508.897109] Dynamic subtest vcs1: SUCCESS (2.044s)
[508.909586] Starting dynamic subtest: vecs0
[510.881077] Dynamic subtest vecs0: SUCCESS (1.980s)
[510.893891] Starting dynamic subtest: ccs0
[511.439254] Dynamic subtest ccs0: SUCCESS (0.556s)
[511.441886] Subtest busy-check-all: SUCCESS (6.789s)
[511.531140] [107/133] (512s left) gem_exec_schedule (submit-early-slice)
[511.602973] Starting subtest: submit-early-slice
[511.605338] Starting dynamic subtest: rcs0
[511.653717] Dynamic subtest rcs0: SUCCESS (0.058s)
[511.667001] Starting dynamic subtest: bcs0
[511.709298] Dynamic subtest bcs0: SUCCESS (0.055s)
[511.722811] Starting dynamic subtest: vcs0
[511.761404] Dynamic subtest vcs0: SUCCESS (0.051s)
[511.773099] Starting dynamic subtest: vcs1
[511.818941] Dynamic subtest vcs1: SUCCESS (0.057s)
[511.829286] Starting dynamic subtest: vecs0
[511.864889] Dynamic subtest vecs0: SUCCESS (0.045s)
[511.878040] Starting dynamic subtest: ccs0
[511.915884] Dynamic subtest ccs0: SUCCESS (0.050s)
[511.918228] Subtest submit-early-slice: SUCCESS (0.321s)
[512.951001] [108/133] (511s left) gem_exec_balancer (parallel-bb-first)
[513.206560] Starting subtest: parallel-bb-first
[514.128648] Subtest parallel-bb-first: SUCCESS (0.921s)
[514.928627] [109/133] (509s left) gen9_exec_parse (bb-large)
[514.994780] Subtest bb-large: SKIP (0.000s)
[515.061685] [110/133] (509s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[515.169904] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[515.172119] Starting dynamic subtest: pipe-A-eDP-1
[515.230445] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[515.242492] Starting dynamic subtest: pipe-B-eDP-1
[515.300662] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[515.311958] Starting dynamic subtest: pipe-C-eDP-1
[515.368827] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[515.379898] Starting dynamic subtest: pipe-D-eDP-1
[515.435218] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[515.439323] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.009s)
[517.391249] [111/133] (506s left) api_intel_bb (simple-bb-ctx)
[517.452719] Starting subtest: simple-bb-ctx
[517.462243] Subtest simple-bb-ctx: SUCCESS (0.009s)
[517.564398] [112/133] (506s left) gem_ctx_isolation (preservation-s3)
[517.641594] Starting subtest: preservation-S3
[517.643921] Starting dynamic subtest: rcs0
[533.956547] Dynamic subtest rcs0: SUCCESS (1.336s)
[533.967694] Starting dynamic subtest: bcs0
[549.949943] Dynamic subtest bcs0: SUCCESS (1.344s)
[549.961264] Starting dynamic subtest: vcs0
[565.963396] Dynamic subtest vcs0: SUCCESS (2.661s)
[565.977906] Starting dynamic subtest: vcs1
[583.965554] Dynamic subtest vcs1: SUCCESS (3.973s)
[583.979304] Starting dynamic subtest: vecs0
[601.984713] Dynamic subtest vecs0: SUCCESS (4.879s)
[601.996058] Starting dynamic subtest: ccs0
[619.959495] Dynamic subtest ccs0: SUCCESS (3.178s)
[619.962313] Subtest preservation-S3: SUCCESS (17.377s)
[620.182038] [113/133] (404s left) sriov_basic (enable-vfs-autoprobe-on)
[620.254598] Starting subtest: enable-vfs-autoprobe-on
[620.257060] Starting dynamic subtest: numvfs-1
[620.350177] Dynamic subtest numvfs-1: FAIL (0.027s)
[620.360479] Starting dynamic subtest: numvfs-2
[620.440930] Dynamic subtest numvfs-2: FAIL (0.004s)
[620.451172] Starting dynamic subtest: numvfs-3
[620.533941] Dynamic subtest numvfs-3: FAIL (0.004s)
[620.545686] Starting dynamic subtest: numvfs-4
[620.626594] Dynamic subtest numvfs-4: FAIL (0.003s)
[620.639748] Starting dynamic subtest: numvfs-5
[620.726393] Dynamic subtest numvfs-5: FAIL (0.008s)
[620.739265] Starting dynamic subtest: numvfs-6
[620.822223] Dynamic subtest numvfs-6: FAIL (0.006s)
[620.832467] Starting dynamic subtest: numvfs-7
[620.914215] Dynamic subtest numvfs-7: FAIL (0.004s)
[620.926499] Starting dynamic subtest: numvfs-random
[620.999701] Dynamic subtest numvfs-random: FAIL (0.007s)
[621.010603] Starting dynamic subtest: numvfs-all
[621.080444] Dynamic subtest numvfs-all: FAIL (0.569s)
[621.082183] Subtest enable-vfs-autoprobe-on: FAIL (0.641s)
[621.137631] [114/133] (403s left) perf_pmu (gt-awake)
[621.213412] Starting subtest: gt-awake
[629.711496] Subtest gt-awake: SUCCESS (8.419s)
[629.795194] [115/133] (394s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[629.950587] Subtest no-spare-fences-busy: SKIP (0.000s)
[630.032411] [116/133] (394s left) kms_rotation_crc (primary-rotation-90)
[630.143385] Starting subtest: primary-rotation-90
[630.148445] Subtest primary-rotation-90: SKIP (0.001s)
[630.201976] [117/133] (394s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[630.307635] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[631.135670] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.826s)
[631.277387] [118/133] (393s left) gem_mmap_wc (write-prefaulted)
[631.338973] Subtest write-prefaulted: SKIP (0.000s)
[631.403044] [119/133] (393s left) gem_pxp (reject-modify-context-protection-off-1)
[631.518989] Starting subtest: reject-modify-context-protection-off-1
[631.521706] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[631.607382] [120/133] (393s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[631.694465] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[631.696954] Starting dynamic subtest: pipe-A-eDP-1
[631.719420] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s)
[631.730443] Starting dynamic subtest: pipe-B-eDP-1
[631.752937] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[631.763332] Starting dynamic subtest: pipe-C-eDP-1
[631.785912] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[631.796399] Starting dynamic subtest: pipe-D-eDP-1
[631.818701] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[631.821453] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.093s)
[634.056176] [121/133] (390s left) kms_plane_lowres (tiling-x)
[634.155291] Starting subtest: tiling-x
[634.157542] Starting dynamic subtest: pipe-A-eDP-1
[634.162225] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[634.450414] Starting dynamic subtest: pipe-B-eDP-1
[634.455300] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[634.468425] Starting dynamic subtest: pipe-C-eDP-1
[634.474111] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[634.486764] Starting dynamic subtest: pipe-D-eDP-1
[634.491723] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[634.496584] Subtest tiling-x: SKIP (0.293s)
[635.298858] [122/133] (389s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[635.388464] Starting subtest: multiplane-rotation-cropping-top
[652.833293] Subtest multiplane-rotation-cropping-top: SUCCESS (17.427s)
[652.949728] [123/133] (371s left) gem_mmap_gtt (basic-write-read-distinct)
[653.020369] Subtest basic-write-read-distinct: SKIP (0.000s)
[653.088493] [124/133] (371s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[653.193213] Starting subtest: fbc-psr2-sprite-mmap-gtt
[653.195229] Starting dynamic subtest: eDP-1
[653.199287] Dynamic subtest eDP-1: SKIP (0.000s)
[653.203284] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[653.244755] [125/133] (371s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[653.351461] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[653.355421] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[653.423286] [126/133] (371s left) gem_tiled_partial_pwrite_pread (writes)
[653.483591] Subtest writes: SKIP (0.000s)
[653.574808] [127/133] (371s left) kms_atomic (crtc-invalid-params-fence)
[653.668570] Starting subtest: crtc-invalid-params-fence
[653.670932] Starting dynamic subtest: pipe-A-eDP-1
[654.087921] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.416s)
[654.090554] Subtest crtc-invalid-params-fence: SUCCESS (0.418s)
[654.946219] [128/133] (370s left) gem_busy (parallel)
[655.148969] Starting subtest: parallel
[655.151723] Starting dynamic subtest: rcs0
[656.653555] Dynamic subtest rcs0: SUCCESS (1.504s)
[656.667683] Starting dynamic subtest: bcs0
[658.701518] Dynamic subtest bcs0: SUCCESS (2.045s)
[658.715355] Starting dynamic subtest: vcs0
[660.684858] Dynamic subtest vcs0: SUCCESS (1.980s)
[660.698943] Starting dynamic subtest: vcs1
[662.669233] Dynamic subtest vcs1: SUCCESS (1.982s)
[662.683211] Starting dynamic subtest: vecs0
[664.653594] Dynamic subtest vecs0: SUCCESS (1.981s)
[664.667860] Starting dynamic subtest: ccs0
[666.700841] Dynamic subtest ccs0: SUCCESS (2.044s)
[666.703975] Subtest parallel: SUCCESS (11.553s)
[666.947001] [129/133] (358s left) gem_ctx_persistence (processes)
[667.038280] Starting subtest: processes
[668.652087] Subtest processes: SUCCESS (1.614s)
[668.711890] [130/133] (356s left) kms_big_fb (4-tiled-addfb-size-overflow)
[668.819275] Starting subtest: 4-tiled-addfb-size-overflow
[668.821358] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[668.908782] [131/133] (356s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[669.010430] Starting subtest: x-tiled-64bpp-rotate-270
[669.030235] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s)
[669.134982] [132/133] (356s left) kms_plane_scaling (planes-scaler-unity-scaling)
[669.225463] Starting subtest: planes-scaler-unity-scaling
[669.227987] Starting dynamic subtest: pipe-A
[669.287335] Dynamic subtest pipe-A: SUCCESS (0.064s)
[669.298001] Starting dynamic subtest: pipe-B
[670.392687] Dynamic subtest pipe-B: SUCCESS (1.104s)
[670.405485] Starting dynamic subtest: pipe-C
[671.503319] Dynamic subtest pipe-C: SUCCESS (1.109s)
[671.514705] Starting dynamic subtest: pipe-D
[672.640164] Dynamic subtest pipe-D: SUCCESS (1.135s)
[672.642694] Subtest planes-scaler-unity-scaling: SUCCESS (3.417s)
[673.794496] [133/133] (351s left) gem_exec_whisper (basic-contexts)
[673.860146] Starting subtest: basic-contexts
[679.844378] Subtest basic-contexts: SUCCESS (5.980s)
[680.005257] 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.