[57.575225] Initializing watchdogs
[57.575321]   /dev/watchdog0
[57.590853] [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]
[57.595431] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.597934] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.600198] [001/133] (960s left) api_intel_allocator (gem-pool)
[57.654318] Starting subtest: gem-pool
[57.661368] Subtest gem-pool: SUCCESS (0.008s)
[57.802325] [002/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[57.901877] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[57.903545] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[58.024604] [003/133] (960s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[58.110346] Starting subtest: read-crc-frame-sequence
[58.111443] Starting dynamic subtest: pipe-A-eDP-1
[58.848560] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.738s)
[58.854023] Starting dynamic subtest: pipe-B-eDP-1
[60.202684] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.353s)
[60.208687] Starting dynamic subtest: pipe-C-eDP-1
[61.507323] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.303s)
[61.513662] Starting dynamic subtest: pipe-D-eDP-1
[62.830409] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.322s)
[62.831464] Subtest read-crc-frame-sequence: SUCCESS (4.722s)
[63.661980] [004/133] (954s left) syncobj_timeline (invalid-query-one-illegal-handle)
[63.710016] Starting subtest: invalid-query-one-illegal-handle
[63.710951] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[63.825276] [005/133] (954s left) syncobj_wait (invalid-signal-zero-handles)
[63.891201] Starting subtest: invalid-signal-zero-handles
[63.892353] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[64.009210] [006/133] (954s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[64.109374] Starting subtest: fbcpsr-rgb565-draw-render
[71.296162] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.187s)
[71.456589] [007/133] (946s left) syncobj_timeline (wait-for-submit-snapshot)
[71.504066] Starting subtest: wait-for-submit-snapshot
[71.586709] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[71.665580] [008/133] (946s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[71.786160] Starting subtest: psr-rgb565-draw-blt
[78.932879] Subtest psr-rgb565-draw-blt: SUCCESS (7.147s)
[79.108053] [009/133] (939s left) kms_cursor_crc (cursor-onscreen-32x10)
[79.259066] Starting subtest: cursor-onscreen-32x10
[79.302019] Subtest cursor-onscreen-32x10: SKIP (0.042s)
[79.591710] [010/133] (938s left) syncobj_wait (invalid-signal-illegal-handle)
[79.652532] Starting subtest: invalid-signal-illegal-handle
[79.653566] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[79.759421] [011/133] (938s left) testdisplay
[80.091802] [012/133] (938s left) prime_mmap (test_map_unmap)
[80.144343] Starting subtest: test_map_unmap
[80.145292] Starting dynamic subtest: test_map_unmap-smem
[80.175330] Dynamic subtest test_map_unmap-smem: SUCCESS (0.032s)
[80.176363] Subtest test_map_unmap: SUCCESS (0.032s)
[80.287589] [013/133] (938s left) gem_exec_fence (syncobj-timeline-signal)
[80.853581] Starting subtest: syncobj-timeline-signal
[80.856852] Subtest syncobj-timeline-signal: SUCCESS (0.009s)
[81.948523] [FACT gem_exec_fence (syncobj-timeline-signal)] new: kernel.kmod_is_loaded.vgem: true
[81.950227] [014/133] (936s left) syncobj_timeline (signal-point-0)
[82.017585] Starting subtest: signal-point-0
[82.018803] Subtest signal-point-0: SUCCESS (0.000s)
[82.134802] [015/133] (936s left) kms_psr (psr2-suspend)
[82.218443] Starting subtest: psr2-suspend
[82.219453] Starting dynamic subtest: eDP-1
[100.729250] Dynamic subtest eDP-1: SUCCESS (3.416s)
[100.730139] Subtest psr2-suspend: SUCCESS (3.417s)
[107.595660] [016/133] (917s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[107.695827] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[107.701125] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[107.790806] [017/133] (916s left) gem_softpin (reverse)
[107.864950] Starting subtest: reverse
[107.871773] Subtest reverse: SUCCESS (0.007s)
[107.988673] [018/133] (916s left) gem_exec_balancer (parallel-contexts)
[108.266779] Starting subtest: parallel-contexts
[110.876313] Subtest parallel-contexts: SUCCESS (2.608s)
[110.994771] [019/133] (913s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[111.088734] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[111.089668] Starting dynamic subtest: pipe-A-eDP-1
[113.183709] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.095s)
[113.191481] Starting dynamic subtest: pipe-B-eDP-1
[115.483322] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.298s)
[115.490262] Starting dynamic subtest: pipe-C-eDP-1
[117.545474] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.060s)
[117.552478] Starting dynamic subtest: pipe-D-eDP-1
[119.546865] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.001s)
[119.547791] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.458s)
[120.790194] [020/133] (903s left) kms_lease (lease-unleased-connector)
[120.881240] Starting subtest: lease-unleased-connector
[120.882308] Starting dynamic subtest: pipe-A-eDP-1
[120.889172] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.008s)
[120.899109] Starting dynamic subtest: pipe-B-eDP-1
[120.900309] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[120.914147] Starting dynamic subtest: pipe-C-eDP-1
[120.915172] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[120.930241] Starting dynamic subtest: pipe-D-eDP-1
[120.931288] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s)
[120.932261] Subtest lease-unleased-connector: SUCCESS (0.036s)
[121.088507] [021/133] (903s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[121.210807] Starting subtest: cursor-vs-flip-atomic-transitions
[151.202407] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.992s)
[152.032958] [022/133] (872s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[152.139417] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[152.140317] Starting dynamic subtest: pipe-A-default-mode
[154.824030] Dynamic subtest pipe-A-default-mode: SUCCESS (2.684s)
[154.824933] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.685s)
[155.721286] [023/133] (869s left) kms_addfb_basic (legacy-format)
[155.786364] Starting subtest: legacy-format
[155.806780] Subtest legacy-format: SUCCESS (0.018s)
[155.972624] [024/133] (868s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[156.068317] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[156.070060] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[156.202025] [025/133] (868s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[156.296568] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[156.298356] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[156.412158] [026/133] (868s left) kms_vblank (query-busy)
[156.513105] Starting subtest: query-busy
[156.514017] Starting dynamic subtest: pipe-A-eDP-1
[158.392402] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.880s)
[158.402108] Starting dynamic subtest: pipe-D-eDP-1
[160.963636] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.568s)
[160.964594] Subtest query-busy: SUCCESS (4.451s)
[161.783363] [027/133] (863s left) gem_wait (invalid-flags)
[161.842214] Starting subtest: invalid-flags
[161.843082] Subtest invalid-flags: SUCCESS (0.000s)
[162.081574] [028/133] (862s left) kms_properties (invalid-properties-atomic)
[162.181967] Starting subtest: invalid-properties-atomic
[162.514506] Subtest invalid-properties-atomic: SUCCESS (0.323s)
[162.586215] [029/133] (862s left) gem_exec_flush (basic-wb-ro-before-default)
[162.646912] Starting subtest: basic-wb-ro-before-default
[168.103130] Subtest basic-wb-ro-before-default: SUCCESS (5.456s)
[168.284351] [030/133] (856s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[168.381620] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[168.390499] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[168.513522] [031/133] (856s left) kms_psr (pr-primary-blt)
[168.595853] Starting subtest: pr-primary-blt
[168.597861] Subtest pr-primary-blt: SKIP (0.000s)
[168.674343] [032/133] (856s left) kms_flip (2x-flip-vs-dpms-on-nop)
[168.763632] Starting subtest: 2x-flip-vs-dpms-on-nop
[168.775034] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[168.913661] [033/133] (856s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[168.997273] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[168.998905] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[169.124706] [034/133] (856s left) kms_chamelium_edid (dp-mode-timings)
[169.505969] Subtest dp-mode-timings: SKIP (0.000s)
[170.281367] [035/133] (855s left) kms_flip (flip-vs-panning-interruptible)
[170.375287] Starting subtest: flip-vs-panning-interruptible
[170.377501] Starting dynamic subtest: A-eDP1
[179.110621] Dynamic subtest A-eDP1: SUCCESS (8.733s)
[179.119760] Starting dynamic subtest: B-eDP1
[187.848320] Dynamic subtest B-eDP1: SUCCESS (8.736s)
[187.859138] Starting dynamic subtest: C-eDP1
[196.577238] Dynamic subtest C-eDP1: SUCCESS (8.727s)
[196.584941] Starting dynamic subtest: D-eDP1
[205.301529] Dynamic subtest D-eDP1: SUCCESS (8.723s)
[205.303760] Subtest flip-vs-panning-interruptible: SUCCESS (34.927s)
[206.581697] [036/133] (818s left) kms_pm_dc (dc5-psr)
[207.688798] Starting subtest: dc5-psr
[210.688790] Subtest dc5-psr: SUCCESS (3.000s)
[211.494928] [037/133] (813s left) gem_userptr_blits (process-exit)
[211.567099] Starting subtest: process-exit
[211.574309] Subtest process-exit: SUCCESS (0.007s)
[211.721096] [038/133] (813s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[211.817461] Starting subtest: plane-lut1d-post-ctm3x4
[211.831413] Starting dynamic subtest: pipe-A-eDP-1
[212.286598] Dynamic subtest pipe-A-eDP-1: FAIL (0.303s)
[213.171198] Starting dynamic subtest: pipe-B-eDP-1
[213.657609] Dynamic subtest pipe-B-eDP-1: FAIL (0.302s)
[214.518692] Starting dynamic subtest: pipe-C-eDP-1
[214.968083] Dynamic subtest pipe-C-eDP-1: FAIL (0.246s)
[215.850830] Starting dynamic subtest: pipe-D-eDP-1
[216.292298] Dynamic subtest pipe-D-eDP-1: FAIL (0.235s)
[216.376732] Subtest plane-lut1d-post-ctm3x4: FAIL (4.558s)
[217.240865] [039/133] (808s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[217.298585] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[217.406672] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.107s)
[217.491944] [040/133] (807s left) gem_mmap_offset (partial-remap)
[217.542886] Starting subtest: partial-remap
[217.543794] Starting dynamic subtest: smem0
[217.550275] Dynamic subtest smem0: SUCCESS (0.005s)
[217.551221] Subtest partial-remap: SUCCESS (0.006s)
[217.677635] [041/133] (807s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[217.764907] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[217.766617] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[217.876335] [042/133] (807s left) gem_userptr_blits (dmabuf-unsync)
[217.935700] Subtest dmabuf-unsync: SKIP (0.000s)
[218.106296] [043/133] (807s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[218.202923] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[218.204722] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[218.337274] [044/133] (807s left) gem_close_race (multigpu-basic-threads)
[218.398266] Starting subtest: multigpu-basic-threads
[218.399937] Subtest multigpu-basic-threads: SKIP (0.000s)
[218.644950] [045/133] (806s left) gem_exec_schedule (preempt)
[218.704477] Starting subtest: preempt
[218.705530] Starting dynamic subtest: rcs0
[218.727198] Dynamic subtest rcs0: SUCCESS (0.023s)
[218.736660] Starting dynamic subtest: bcs0
[218.747560] Dynamic subtest bcs0: SUCCESS (0.020s)
[218.754430] Starting dynamic subtest: vcs0
[218.767498] Dynamic subtest vcs0: SUCCESS (0.019s)
[218.776294] Starting dynamic subtest: vcs1
[218.786740] Dynamic subtest vcs1: SUCCESS (0.019s)
[218.793656] Starting dynamic subtest: vecs0
[218.805252] Dynamic subtest vecs0: SUCCESS (0.018s)
[218.812734] Starting dynamic subtest: ccs0
[218.849865] Dynamic subtest ccs0: SUCCESS (0.043s)
[218.852552] Subtest preempt: SUCCESS (0.147s)
[220.124352] [046/133] (805s left) i915_module_load (reload)
[220.151991] Starting subtest: reload
[223.602920] Subtest reload: SUCCESS (3.451s)
[223.646441] [047/133] (802s left) gem_exec_reloc (basic-wc-cpu-active)
[224.952512] Subtest basic-wc-cpu-active: SKIP (0.000s)
[225.067570] [048/133] (800s left) gen9_exec_parse (valid-registers)
[225.127586] Subtest valid-registers: SKIP (0.000s)
[225.213476] [049/133] (800s left) kms_cursor_edge_walk (64x64-left-edge)
[225.307018] Starting subtest: 64x64-left-edge
[225.307837] Starting dynamic subtest: pipe-A-eDP-1
[228.785216] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.477s)
[228.792505] Starting dynamic subtest: pipe-D-eDP-1
[231.919763] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.134s)
[231.920524] Subtest 64x64-left-edge: SUCCESS (6.614s)
[232.752567] [050/133] (793s left) gem_render_copy_redux (flink)
[232.808016] Starting subtest: flink
[233.551176] Subtest flink: SUCCESS (0.743s)
[233.714922] [051/133] (792s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[233.829040] Starting subtest: psr-2p-primscrn-spr-indfb-move
[233.830624] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[233.937335] [052/133] (791s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[234.033123] Starting subtest: bo-too-small-due-to-tiling
[234.034824] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[234.151708] [053/133] (791s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[234.237044] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[241.164242] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.926s)
[241.285517] [054/133] (784s left) gem_exec_reloc (basic-write-wc-active)
[241.332861] Subtest basic-write-wc-active: SKIP (0.000s)
[241.392482] [055/133] (784s left) gem_fenced_exec_thrash (2-spare-fences)
[241.453601] Subtest 2-spare-fences: SKIP (0.000s)
[241.539188] [056/133] (784s left) kms_hdr (static-toggle-dpms)
[241.631471] Starting subtest: static-toggle-dpms
[241.634614] Subtest static-toggle-dpms: SKIP (0.000s)
[241.709785] [057/133] (784s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[241.807192] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[248.940987] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.134s)
[249.071336] [058/133] (777s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[249.172716] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[252.941383] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.768s)
[254.131921] [059/133] (772s left) gem_lmem_swapping (parallel-random-verify)
[254.167804] Subtest parallel-random-verify: SKIP (0.000s)
[254.203186] [060/133] (771s left) kms_psr (fbc-pr-sprite-plane-move)
[254.299150] Starting subtest: fbc-pr-sprite-plane-move
[254.300797] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[254.377649] [061/133] (771s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[254.755215] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[255.591439] [062/133] (770s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[255.687116] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[255.688758] Starting dynamic subtest: pipe-A-eDP-1
[255.697943] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[255.705177] Starting dynamic subtest: pipe-B-eDP-1
[255.714592] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[255.721709] Starting dynamic subtest: pipe-C-eDP-1
[255.730542] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[255.737849] Starting dynamic subtest: pipe-D-eDP-1
[255.747762] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[255.749500] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s)
[258.012127] [063/133] (768s left) i915_pm_rpm (gem-evict-pwrite)
[260.142776] Starting subtest: gem-evict-pwrite
[260.145305] Subtest gem-evict-pwrite: SKIP (0.000s)
[260.530122] [064/133] (765s left) gem_exec_whisper (basic-sync)
[260.605104] Starting subtest: basic-sync
[267.564818] Subtest basic-sync: SUCCESS (6.950s)
[267.745631] [065/133] (758s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[267.881533] Starting subtest: short-busy-flip-before-cursor-toggle
[267.883262] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[268.036155] [066/133] (758s left) i915_query (hwconfig_table)
[268.093770] Starting subtest: hwconfig_table
[268.205636] Subtest hwconfig_table: SUCCESS (0.001s)
[268.237431] [067/133] (758s left) kms_vrr (flipline)
[268.326326] Starting subtest: flipline
[268.328902] Subtest flipline: SKIP (0.000s)
[268.410630] [068/133] (758s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[268.523410] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[272.899955] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.377s)
[274.027483] [069/133] (752s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[274.126998] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[274.131491] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[274.218039] [070/133] (752s left) kms_prop_blob (invalid-set-prop)
[274.263740] Starting subtest: invalid-set-prop
[274.264731] Subtest invalid-set-prop: SUCCESS (0.000s)
[274.374642] [071/133] (752s left) kms_properties (crtc-properties-legacy)
[274.460832] Starting subtest: crtc-properties-legacy
[274.461565] Starting dynamic subtest: pipe-A-eDP-1
[274.894523] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.433s)
[274.902184] Starting dynamic subtest: pipe-B-eDP-1
[276.069885] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.174s)
[276.077423] Starting dynamic subtest: pipe-C-eDP-1
[277.181318] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.110s)
[277.188833] Starting dynamic subtest: pipe-D-eDP-1
[278.322742] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.140s)
[278.323904] Subtest crtc-properties-legacy: SUCCESS (3.863s)
[279.127959] [072/133] (747s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[279.233210] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[286.283952] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (7.051s)
[286.428511] [073/133] (740s left) kms_psr (fbc-pr-cursor-render)
[286.517217] Starting subtest: fbc-pr-cursor-render
[286.518954] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[286.595798] [074/133] (740s left) gem_userptr_blits (huge-split)
[286.673325] Starting subtest: huge-split
[286.680825] Subtest huge-split: SUCCESS (0.007s)
[286.838257] [075/133] (739s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[287.074106] Starting subtest: cursor-rapid-movement-256x85
[287.118520] Subtest cursor-rapid-movement-256x85: SKIP (0.042s)
[287.335797] [076/133] (739s left) gem_unref_active_buffers
[287.574815] [077/133] (739s left) gem_caching (reads)
[287.632281] Subtest reads: SKIP (0.000s)
[287.690312] [078/133] (739s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[287.752849] Starting subtest: invalid-multi-wait-all-unsubmitted
[287.753791] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[287.862290] [079/133] (738s left) gem_exec_create (basic)
[287.916379] Starting subtest: basic
[287.917234] Starting dynamic subtest: smem
[291.988244] Dynamic subtest smem: SUCCESS (4.061s)
[291.989460] Subtest basic: SUCCESS (4.063s)
[292.174990] [080/133] (734s left) kms_content_protection (atomic-dpms-hdcp14)
[292.316372] Starting subtest: atomic-dpms-hdcp14
[292.318241] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[292.474023] [081/133] (734s left) sw_sync (timeline_closed)
[292.508590] Starting subtest: timeline_closed
[292.509447] Subtest timeline_closed: SUCCESS (0.000s)
[292.573176] [082/133] (734s left) perf (oa-exponents)
[292.710623] Starting subtest: oa-exponents
[292.711926] Starting dynamic subtest: 0-rcs0
[294.482302] Dynamic subtest 0-rcs0: SUCCESS (1.763s)
[294.490618] Starting dynamic subtest: 1-vcs0
[296.312160] Dynamic subtest 1-vcs0: SUCCESS (1.829s)
[296.312997] Subtest oa-exponents: SUCCESS (3.594s)
[296.346515] [083/133] (730s left) kms_feature_discovery (display-2x)
[296.439283] Starting subtest: display-2x
[296.441168] Subtest display-2x: SKIP (0.000s)
[296.518723] [084/133] (730s left) core_setmaster (master-drop-set-root)
[296.597341] Starting subtest: master-drop-set-root
[296.608270] Subtest master-drop-set-root: SUCCESS (0.011s)
[296.651067] [085/133] (730s left) kms_pm_rpm (i2c)
[298.176214] Starting subtest: i2c
[303.570210] Subtest i2c: SUCCESS (5.395s)
[303.665833] [086/133] (723s left) kms_busy (basic-hang)
[303.767961] Starting subtest: basic-hang
[303.768760] Starting dynamic subtest: flip-pipe-A
[304.379906] Dynamic subtest flip-pipe-A: SUCCESS (0.610s)
[304.387880] Starting dynamic subtest: modeset-pipe-A
[307.992616] Dynamic subtest modeset-pipe-A: SUCCESS (3.612s)
[308.001737] Starting dynamic subtest: flip-pipe-D
[309.195225] Dynamic subtest flip-pipe-D: SUCCESS (1.200s)
[309.203055] Starting dynamic subtest: modeset-pipe-D
[312.619763] Dynamic subtest modeset-pipe-D: SUCCESS (3.422s)
[312.620973] Subtest basic-hang: SUCCESS (8.851s)
[313.424286] [087/133] (713s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[313.526345] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[313.528135] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[313.652082] [088/133] (713s left) kms_flip (nonblocking-read)
[313.738170] Starting subtest: nonblocking-read
[313.738993] Subtest nonblocking-read: SUCCESS (0.000s)
[313.856844] [089/133] (713s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[313.955288] Starting subtest: yf-tiled-16bpp-rotate-270
[313.957131] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[314.073211] [090/133] (713s left) gem_mmap_wc (write-read-distinct)
[314.132519] Subtest write-read-distinct: SKIP (0.000s)
[314.199241] [091/133] (713s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[314.260797] Starting subtest: multi-wait-for-submit-submitted-signaled
[314.261691] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[314.385068] [092/133] (712s left) kms_flip (blocking-wf_vblank)
[314.475257] Starting subtest: blocking-wf_vblank
[314.476127] Starting dynamic subtest: A-eDP1
[323.368918] Dynamic subtest A-eDP1: SUCCESS (8.892s)
[323.384245] Starting dynamic subtest: B-eDP1
[332.330938] Dynamic subtest B-eDP1: SUCCESS (8.930s)
[332.343364] Starting dynamic subtest: C-eDP1
[341.257798] Dynamic subtest C-eDP1: SUCCESS (8.914s)
[341.267540] Starting dynamic subtest: D-eDP1
[350.159701] Dynamic subtest D-eDP1: SUCCESS (8.937s)
[350.162711] Subtest blocking-wf_vblank: SUCCESS (35.687s)
[351.393697] [093/133] (675s left) gem_exec_alignment (pi)
[351.464988] Starting subtest: pi
[406.016198] Subtest pi: SUCCESS (54.548s)
[407.051477] [094/133] (620s left) kms_getfb (getfb-repeated-different-handles)
[407.205703] Starting subtest: getfb-repeated-different-handles
[407.206725] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[407.327186] [095/133] (620s left) syncobj_timeline (etime-multi-wait-submitted)
[407.387993] Starting subtest: etime-multi-wait-submitted
[407.494787] Subtest etime-multi-wait-submitted: SUCCESS (0.106s)
[407.589710] [096/133] (619s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[407.708416] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[408.710383] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (1.001s)
[409.524856] [097/133] (617s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[409.619019] Starting subtest: primary-yf-tiled-reflect-x-0
[409.678467] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.060s)
[409.786624] [098/133] (617s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[409.844581] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[409.915864] [099/133] (617s left) perf_pmu (rc6)
[409.951201] Starting subtest: rc6
[409.952223] Starting dynamic subtest: gt0
[416.360571] Dynamic subtest gt0: SUCCESS (6.363s)
[416.369736] Starting dynamic subtest: runtime-pm-gt0
[424.094644] Dynamic subtest runtime-pm-gt0: SUCCESS (7.768s)
[424.103725] Starting dynamic subtest: runtime-pm-long-gt0
[436.609673] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.512s)
[436.618979] Starting dynamic subtest: other-idle-gt0
[442.952517] Dynamic subtest other-idle-gt0: SUCCESS (6.340s)
[442.962257] Starting dynamic subtest: gt1
[449.294087] Dynamic subtest gt1: SUCCESS (6.339s)
[449.305030] Starting dynamic subtest: runtime-pm-gt1
[456.796630] Dynamic subtest runtime-pm-gt1: SUCCESS (7.500s)
[456.807652] Starting dynamic subtest: runtime-pm-long-gt1
[469.286454] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.487s)
[469.297576] Starting dynamic subtest: other-idle-gt1
[475.628513] Dynamic subtest other-idle-gt1: SUCCESS (6.340s)
[475.629579] Subtest rc6: SUCCESS (65.667s)
[476.248136] [100/133] (551s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[476.358222] Starting subtest: y-tiled-16bpp-rotate-0
[476.359927] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[476.451952] [101/133] (551s left) kms_flip_tiling (flip-change-tiling)
[476.548369] Starting subtest: flip-change-tiling
[476.549540] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[476.749348] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.202s)
[476.761676] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[476.894248] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.142s)
[476.911099] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[477.047764] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.142s)
[477.058714] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[477.182774] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s)
[477.195266] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[477.327292] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[477.338740] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[477.471618] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[477.483168] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[477.605968] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[477.619352] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[477.716773] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.108s)
[477.730000] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[477.849931] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[477.863215] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[477.994186] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[478.007178] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[478.138077] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[478.150298] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[478.282981] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[478.294663] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[478.416662] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[478.429663] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[478.550997] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[478.561119] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[478.661002] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[478.671576] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[478.805018] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s)
[478.819963] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[478.949244] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.141s)
[478.964412] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[479.094089] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.143s)
[479.107974] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[479.238205] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.143s)
[479.250247] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[479.383206] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[479.401627] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[479.527555] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[479.540428] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[479.649648] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.120s)
[479.663613] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[479.793530] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.142s)
[479.805662] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[479.938033] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.142s)
[479.950761] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[480.082552] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[480.095459] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[480.226949] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[480.239035] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[480.371486] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[480.383534] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[480.515890] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.142s)
[480.527597] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[480.638515] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.120s)
[480.649785] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[480.783038] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.142s)
[480.795084] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[480.927061] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[480.938182] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[481.071797] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[481.088107] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[481.216520] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[481.228239] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[481.360291] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.142s)
[481.371994] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[481.505471] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.142s)
[481.518330] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[481.655060] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.147s)
[481.707051] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[482.968645] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.268s)
[482.980535] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[483.103343] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[483.114163] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[483.255562] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.142s)
[483.265807] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[483.390711] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s)
[483.407677] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[483.534790] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[483.546801] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[483.679345] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[483.691553] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[483.824279] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.142s)
[483.837323] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[483.935239] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[483.947224] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[484.068829] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[484.081290] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[484.213250] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[484.225691] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[484.357028] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[484.369421] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[484.501652] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[484.513650] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[484.635522] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[484.648423] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[484.769815] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[484.781070] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[484.880193] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[484.893046] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[485.024363] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s)
[485.037614] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[485.168148] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[485.181122] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[485.313188] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[485.325342] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[485.457512] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[485.470701] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[485.591036] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.131s)
[485.603257] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[485.724654] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.131s)
[485.736787] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[485.846488] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.120s)
[485.858984] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[485.990448] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.142s)
[486.001980] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[486.135012] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.143s)
[486.146773] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[486.279349] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[486.291327] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[486.423661] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[486.432809] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[486.568375] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.144s)
[486.580811] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[486.713023] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.142s)
[486.725499] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[486.835325] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.120s)
[486.847358] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[486.980203] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.142s)
[486.993104] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[487.124659] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[487.136833] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[487.268219] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[487.286494] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[487.412765] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[487.425092] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[487.557288] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.142s)
[487.569647] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[487.701846] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.142s)
[487.714110] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[487.824370] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.120s)
[487.877289] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[489.097134] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.227s)
[489.109958] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[489.196943] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[489.208205] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[489.296818] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[489.309112] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[489.408143] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s)
[489.421170] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[489.557214] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.148s)
[489.568784] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[489.668235] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.109s)
[489.680075] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[489.769027] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.098s)
[489.780321] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[489.868703] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[489.880190] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[489.968670] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[489.979775] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[490.068789] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.098s)
[490.081496] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[490.190550] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.120s)
[490.202344] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[490.343930] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.151s)
[490.357958] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[490.443817] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.099s)
[490.456643] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[490.544162] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[490.557495] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[490.644174] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[490.660047] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[490.766109] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.120s)
[490.778910] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[490.876923] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.108s)
[490.891094] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[490.988819] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s)
[490.999618] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[491.088586] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.099s)
[491.099774] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[491.188645] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.099s)
[491.198620] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[491.299774] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.110s)
[491.310414] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[491.410814] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.109s)
[491.423785] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[491.521499] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.109s)
[491.533043] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[491.632566] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.109s)
[491.644355] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[491.743769] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.110s)
[491.755198] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[491.855058] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.109s)
[491.866578] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[491.966041] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.110s)
[491.978355] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[492.077063] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.109s)
[492.089174] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[492.228838] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.149s)
[492.241360] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[492.339929] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.108s)
[492.351695] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[492.450541] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[492.465212] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[492.561703] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s)
[492.573719] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[492.672839] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s)
[492.684823] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[492.783795] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.109s)
[492.795695] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[492.895359] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.110s)
[492.908721] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[493.007073] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.109s)
[493.047835] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[494.225573] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.185s)
[494.238097] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[494.336573] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[494.349174] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[494.436415] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.097s)
[494.447366] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[494.547718] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.110s)
[494.558734] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[494.658002] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[494.669818] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[494.769162] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.110s)
[494.780967] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[494.870163] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.099s)
[494.881773] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[494.969824] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[494.982465] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[495.070056] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[495.081614] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[495.169623] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.098s)
[495.182280] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[495.280298] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[495.292088] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[495.430252] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.148s)
[495.441786] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[495.530670] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s)
[495.543308] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[495.630570] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[495.643092] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[495.730674] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[495.742223] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[495.842016] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s)
[495.854452] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[495.952388] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[495.964640] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[496.063500] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s)
[496.074988] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[496.163837] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.098s)
[496.176490] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[496.263845] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.098s)
[496.276639] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[496.363848] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.098s)
[496.376291] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[496.474836] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.110s)
[496.488359] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[496.602005] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.125s)
[496.613464] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[496.690911] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.088s)
[496.701111] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[496.768735] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.077s)
[496.779134] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[496.868814] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.099s)
[496.880638] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[496.979904] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.109s)
[496.992566] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[497.090888] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.109s)
[497.102731] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[497.202542] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.110s)
[497.215260] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[497.352459] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.147s)
[497.365611] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[497.462914] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[497.474834] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[497.574173] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s)
[497.586371] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[497.685276] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s)
[497.699851] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[497.836452] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.149s)
[497.848209] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[497.948110] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.109s)
[497.959607] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[498.059100] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.109s)
[498.091699] Subtest flip-change-tiling: SUCCESS (21.545s)
[499.283112] [102/133] (528s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[499.383713] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[499.385694] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[499.466879] [103/133] (528s left) gem_exec_fence (submit-chain)
[499.656363] Starting subtest: submit-chain
[499.672594] Subtest submit-chain: SUCCESS (0.017s)
[501.060111] [104/133] (526s left) gem_ringfill (engines-basic)
[507.029979] Starting subtest: engines-basic
[507.031058] Starting dynamic subtest: rcs0
[507.097581] Dynamic subtest rcs0: SUCCESS (0.075s)
[507.110739] Starting dynamic subtest: bcs0
[507.143595] Dynamic subtest bcs0: SUCCESS (0.044s)
[507.154243] Starting dynamic subtest: vcs0
[507.186342] Dynamic subtest vcs0: SUCCESS (0.041s)
[507.196590] Starting dynamic subtest: vcs1
[507.229505] Dynamic subtest vcs1: SUCCESS (0.041s)
[507.239998] Starting dynamic subtest: vecs0
[507.274546] Dynamic subtest vecs0: SUCCESS (0.043s)
[507.285468] Starting dynamic subtest: ccs0
[507.321075] Dynamic subtest ccs0: SUCCESS (0.045s)
[507.323834] Subtest engines-basic: SUCCESS (0.301s)
[507.369898] [105/133] (520s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[507.460856] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[507.461674] Starting dynamic subtest: pipe-A-eDP-1
[507.469578] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[507.478104] Starting dynamic subtest: pipe-B-eDP-1
[507.485478] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[507.496320] Starting dynamic subtest: pipe-C-eDP-1
[507.503795] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[507.511614] Starting dynamic subtest: pipe-D-eDP-1
[507.518922] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[507.519804] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[509.647444] [106/133] (518s left) perf_pmu (busy-check-all)
[509.685860] Starting subtest: busy-check-all
[509.686802] Starting dynamic subtest: rcs0
[510.256539] Dynamic subtest rcs0: SUCCESS (0.570s)
[510.269654] Starting dynamic subtest: bcs0
[510.805926] Dynamic subtest bcs0: SUCCESS (0.548s)
[510.818722] Starting dynamic subtest: vcs0
[512.019131] Dynamic subtest vcs0: SUCCESS (1.202s)
[512.028045] Starting dynamic subtest: vcs1
[514.002570] Dynamic subtest vcs1: SUCCESS (1.981s)
[514.013779] Starting dynamic subtest: vecs0
[515.987194] Dynamic subtest vecs0: SUCCESS (1.982s)
[515.998131] Starting dynamic subtest: ccs0
[516.533488] Dynamic subtest ccs0: SUCCESS (0.553s)
[516.536190] Subtest busy-check-all: SUCCESS (6.849s)
[516.622540] [107/133] (511s left) gem_exec_schedule (submit-early-slice)
[516.688364] Starting subtest: submit-early-slice
[516.689194] Starting dynamic subtest: rcs0
[516.749611] Dynamic subtest rcs0: SUCCESS (0.061s)
[516.761283] Starting dynamic subtest: bcs0
[516.797792] Dynamic subtest bcs0: SUCCESS (0.047s)
[516.808091] Starting dynamic subtest: vcs0
[516.852752] Dynamic subtest vcs0: SUCCESS (0.054s)
[516.865891] Starting dynamic subtest: vcs1
[516.900182] Dynamic subtest vcs1: SUCCESS (0.047s)
[516.909407] Starting dynamic subtest: vecs0
[516.954325] Dynamic subtest vecs0: SUCCESS (0.053s)
[516.968133] Starting dynamic subtest: ccs0
[517.011496] Dynamic subtest ccs0: SUCCESS (0.056s)
[517.012647] Subtest submit-early-slice: SUCCESS (0.323s)
[518.048028] [108/133] (509s left) gem_exec_balancer (parallel-bb-first)
[518.323767] Starting subtest: parallel-bb-first
[519.316154] Subtest parallel-bb-first: SUCCESS (0.992s)
[519.963565] [109/133] (507s left) gen9_exec_parse (bb-large)
[520.015890] Subtest bb-large: SKIP (0.000s)
[520.071138] [110/133] (507s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[520.157304] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[520.158214] Starting dynamic subtest: pipe-A-eDP-1
[520.179687] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[520.193101] Starting dynamic subtest: pipe-B-eDP-1
[520.216548] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[520.226247] Starting dynamic subtest: pipe-C-eDP-1
[520.255938] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[520.264385] Starting dynamic subtest: pipe-D-eDP-1
[520.288109] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[520.289916] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.009s)
[522.330567] [111/133] (505s left) api_intel_bb (simple-bb-ctx)
[522.389447] Starting subtest: simple-bb-ctx
[522.396330] Subtest simple-bb-ctx: SUCCESS (0.008s)
[522.483582] [112/133] (505s left) gem_ctx_isolation (preservation-s3)
[522.536666] Starting subtest: preservation-S3
[522.537658] Starting dynamic subtest: rcs0
[539.345918] Dynamic subtest rcs0: SUCCESS (1.728s)
[539.357752] Starting dynamic subtest: bcs0
[556.372146] Dynamic subtest bcs0: SUCCESS (1.725s)
[556.382203] Starting dynamic subtest: vcs0
[573.355038] Dynamic subtest vcs0: SUCCESS (3.425s)
[573.366890] Starting dynamic subtest: vcs1
[591.359870] Dynamic subtest vcs1: SUCCESS (5.056s)
[591.370862] Starting dynamic subtest: vecs0
[609.367207] Dynamic subtest vecs0: SUCCESS (5.008s)
[609.376856] Starting dynamic subtest: ccs0
[627.342950] Dynamic subtest ccs0: SUCCESS (3.140s)
[627.343816] Subtest preservation-S3: SUCCESS (20.088s)
[634.599488] [113/133] (400s left) sriov_basic (enable-vfs-autoprobe-on)
[634.651716] Starting subtest: enable-vfs-autoprobe-on
[634.653078] Starting dynamic subtest: numvfs-1
[634.684906] Dynamic subtest numvfs-1: FAIL (0.014s)
[634.694288] Starting dynamic subtest: numvfs-2
[634.721592] Dynamic subtest numvfs-2: FAIL (0.004s)
[634.730515] Starting dynamic subtest: numvfs-3
[634.756206] Dynamic subtest numvfs-3: FAIL (0.003s)
[634.764533] Starting dynamic subtest: numvfs-4
[634.790483] Dynamic subtest numvfs-4: FAIL (0.003s)
[634.798206] Starting dynamic subtest: numvfs-5
[634.823303] Dynamic subtest numvfs-5: FAIL (0.003s)
[634.831283] Starting dynamic subtest: numvfs-6
[634.858006] Dynamic subtest numvfs-6: FAIL (0.004s)
[634.865868] Starting dynamic subtest: numvfs-7
[634.892916] Dynamic subtest numvfs-7: FAIL (0.003s)
[634.900662] Starting dynamic subtest: numvfs-random
[634.926093] Dynamic subtest numvfs-random: FAIL (0.003s)
[634.933810] Starting dynamic subtest: numvfs-all
[634.959487] Dynamic subtest numvfs-all: FAIL (0.003s)
[634.960272] Subtest enable-vfs-autoprobe-on: FAIL (0.049s)
[634.989368] [114/133] (400s left) perf_pmu (gt-awake)
[635.030539] Starting subtest: gt-awake
[643.716177] Subtest gt-awake: SUCCESS (8.659s)
[643.794374] [115/133] (391s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[643.875196] Subtest no-spare-fences-busy: SKIP (0.000s)
[643.951722] [116/133] (391s left) kms_rotation_crc (primary-rotation-90)
[644.054838] Starting subtest: primary-rotation-90
[644.057704] Subtest primary-rotation-90: SKIP (0.001s)
[644.103839] [117/133] (391s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[644.195772] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[644.988872] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.792s)
[645.135838] [118/133] (390s left) gem_mmap_wc (write-prefaulted)
[645.183400] Subtest write-prefaulted: SKIP (0.000s)
[645.249425] [119/133] (389s left) gem_pxp (reject-modify-context-protection-off-1)
[645.374063] Starting subtest: reject-modify-context-protection-off-1
[645.375009] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[645.468331] [120/133] (389s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[645.561135] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[645.562122] Starting dynamic subtest: pipe-A-eDP-1
[645.582370] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s)
[645.592199] Starting dynamic subtest: pipe-B-eDP-1
[645.605516] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[645.615253] Starting dynamic subtest: pipe-C-eDP-1
[645.628764] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[645.638244] Starting dynamic subtest: pipe-D-eDP-1
[645.651549] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[645.652334] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.093s)
[647.940520] [121/133] (387s left) kms_plane_lowres (tiling-x)
[648.055684] Starting subtest: tiling-x
[648.056529] Starting dynamic subtest: pipe-A-eDP-1
[648.058419] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[648.360886] Starting dynamic subtest: pipe-B-eDP-1
[648.362549] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[648.373331] Starting dynamic subtest: pipe-C-eDP-1
[648.375052] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[648.385663] Starting dynamic subtest: pipe-D-eDP-1
[648.387439] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[648.389208] Subtest tiling-x: SKIP (0.303s)
[649.168489] [122/133] (386s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[649.255670] Starting subtest: multiplane-rotation-cropping-top
[666.624134] Subtest multiplane-rotation-cropping-top: SUCCESS (17.360s)
[666.725182] [123/133] (368s left) gem_mmap_gtt (basic-write-read-distinct)
[666.780396] Subtest basic-write-read-distinct: SKIP (0.000s)
[666.855925] [124/133] (368s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[666.948992] Starting subtest: fbc-psr2-sprite-mmap-gtt
[666.949889] Starting dynamic subtest: eDP-1
[666.951680] Dynamic subtest eDP-1: SKIP (0.000s)
[666.953399] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[666.997233] [125/133] (368s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[667.095595] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[667.097288] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[667.138303] [126/133] (368s left) gem_tiled_partial_pwrite_pread (writes)
[667.189304] Subtest writes: SKIP (0.000s)
[667.258879] [127/133] (368s left) kms_atomic (crtc-invalid-params-fence)
[667.343484] Starting subtest: crtc-invalid-params-fence
[667.344418] Starting dynamic subtest: pipe-A-eDP-1
[667.756093] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.412s)
[667.757013] Subtest crtc-invalid-params-fence: SUCCESS (0.413s)
[668.609683] [128/133] (366s left) gem_busy (parallel)
[668.798988] Starting subtest: parallel
[668.799994] Starting dynamic subtest: rcs0
[670.722444] Dynamic subtest rcs0: SUCCESS (1.921s)
[670.734333] Starting dynamic subtest: bcs0
[672.706391] Dynamic subtest bcs0: SUCCESS (1.982s)
[672.717942] Starting dynamic subtest: vcs0
[674.753603] Dynamic subtest vcs0: SUCCESS (2.045s)
[674.764986] Starting dynamic subtest: vcs1
[676.738199] Dynamic subtest vcs1: SUCCESS (1.983s)
[676.747352] Starting dynamic subtest: vecs0
[678.723777] Dynamic subtest vecs0: SUCCESS (1.983s)
[678.733315] Starting dynamic subtest: ccs0
[680.705365] Dynamic subtest ccs0: SUCCESS (1.979s)
[680.706583] Subtest parallel: SUCCESS (11.910s)
[680.926083] [129/133] (354s left) gem_ctx_persistence (processes)
[680.979757] Starting subtest: processes
[682.672444] Subtest processes: SUCCESS (1.693s)
[682.720786] [130/133] (352s left) kms_big_fb (4-tiled-addfb-size-overflow)
[682.830288] Starting subtest: 4-tiled-addfb-size-overflow
[682.831199] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[682.895303] [131/133] (352s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[682.988293] Starting subtest: x-tiled-64bpp-rotate-270
[683.008103] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s)
[683.109830] [132/133] (352s left) kms_plane_scaling (planes-scaler-unity-scaling)
[683.202803] Starting subtest: planes-scaler-unity-scaling
[683.203727] Starting dynamic subtest: pipe-A
[683.266660] Dynamic subtest pipe-A: SUCCESS (0.064s)
[683.276998] Starting dynamic subtest: pipe-B
[684.450322] Dynamic subtest pipe-B: SUCCESS (1.183s)
[684.463369] Starting dynamic subtest: pipe-C
[685.559544] Dynamic subtest pipe-C: SUCCESS (1.107s)
[685.570998] Starting dynamic subtest: pipe-D
[686.707601] Dynamic subtest pipe-D: SUCCESS (1.147s)
[686.708665] Subtest planes-scaler-unity-scaling: SUCCESS (3.506s)
[687.832531] [133/133] (347s left) gem_exec_whisper (basic-contexts)
[687.907979] Starting subtest: basic-contexts
[695.713788] Subtest basic-contexts: SUCCESS (7.794s)
[695.854791] 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.