[60.639857] Initializing watchdogs
[60.639904]   /dev/watchdog0
[60.652936] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[60.657036] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.659137] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.662316] [001/133] (960s left) api_intel_allocator (gem-pool)
[60.744801] Starting subtest: gem-pool
[60.755075] Subtest gem-pool: SUCCESS (0.012s)
[60.863987] [002/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[60.967587] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[60.971881] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[61.082953] [003/133] (960s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[61.165135] Starting subtest: read-crc-frame-sequence
[61.167547] Starting dynamic subtest: pipe-A-eDP-1
[61.903582] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.735s)
[61.911906] Starting dynamic subtest: pipe-B-eDP-1
[63.235466] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.335s)
[63.244134] Starting dynamic subtest: pipe-C-eDP-1
[64.511089] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.277s)
[64.521397] Starting dynamic subtest: pipe-D-eDP-1
[65.854867] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.342s)
[65.857326] Subtest read-crc-frame-sequence: SUCCESS (4.692s)
[66.699128] [004/133] (954s left) syncobj_timeline (invalid-query-one-illegal-handle)
[66.831876] Starting subtest: invalid-query-one-illegal-handle
[66.834183] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[67.051060] [005/133] (954s left) syncobj_wait (invalid-signal-zero-handles)
[67.206329] Starting subtest: invalid-signal-zero-handles
[67.208815] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[67.570686] [006/133] (953s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[67.698439] Starting subtest: fbcpsr-rgb565-draw-render
[74.651971] Subtest fbcpsr-rgb565-draw-render: SUCCESS (6.960s)
[74.808862] [007/133] (946s left) syncobj_timeline (wait-for-submit-snapshot)
[74.866758] Starting subtest: wait-for-submit-snapshot
[74.948040] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[75.031391] [008/133] (946s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[75.143920] Starting subtest: psr-rgb565-draw-blt
[82.132973] Subtest psr-rgb565-draw-blt: SUCCESS (6.996s)
[82.297066] [009/133] (939s left) kms_cursor_crc (cursor-onscreen-32x10)
[82.452540] Starting subtest: cursor-onscreen-32x10
[82.499425] Subtest cursor-onscreen-32x10: SKIP (0.042s)
[82.793760] [010/133] (938s left) syncobj_wait (invalid-signal-illegal-handle)
[82.861210] Starting subtest: invalid-signal-illegal-handle
[82.863196] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[82.984010] [011/133] (938s left) testdisplay
[83.355577] [012/133] (938s left) prime_mmap (test_map_unmap)
[83.413180] Starting subtest: test_map_unmap
[83.414868] Starting dynamic subtest: test_map_unmap-smem
[83.441704] Dynamic subtest test_map_unmap-smem: SUCCESS (0.029s)
[83.443761] Subtest test_map_unmap: SUCCESS (0.030s)
[83.554632] [013/133] (938s left) gem_exec_fence (syncobj-timeline-signal)
[84.098078] Starting subtest: syncobj-timeline-signal
[84.106509] Subtest syncobj-timeline-signal: SUCCESS (0.009s)
[86.009972] [FACT gem_exec_fence (syncobj-timeline-signal)] new: kernel.kmod_is_loaded.vgem: true
[86.013124] [014/133] (935s left) syncobj_timeline (signal-point-0)
[86.070880] Starting subtest: signal-point-0
[86.073212] Subtest signal-point-0: SUCCESS (0.000s)
[86.197359] [015/133] (935s left) kms_psr (psr2-suspend)
[86.294940] Starting subtest: psr2-suspend
[86.297275] Starting dynamic subtest: eDP-1
[104.514058] Dynamic subtest eDP-1: SUCCESS (4.031s)
[104.516964] Subtest psr2-suspend: SUCCESS (4.032s)
[105.397929] [016/133] (916s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[105.519469] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[105.542108] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[105.615517] [017/133] (916s left) gem_softpin (reverse)
[105.676232] Starting subtest: reverse
[105.683431] Subtest reverse: SUCCESS (0.007s)
[105.814493] [018/133] (916s left) gem_exec_balancer (parallel-contexts)
[106.066225] Starting subtest: parallel-contexts
[108.471484] Subtest parallel-contexts: SUCCESS (2.426s)
[108.586401] [019/133] (913s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[108.699558] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[108.701797] Starting dynamic subtest: pipe-A-eDP-1
[110.775864] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.092s)
[110.788062] Starting dynamic subtest: pipe-B-eDP-1
[112.918666] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.151s)
[112.926826] Starting dynamic subtest: pipe-C-eDP-1
[115.004908] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.092s)
[115.014159] Starting dynamic subtest: pipe-D-eDP-1
[117.060095] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.055s)
[117.064060] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.394s)
[118.275561] [020/133] (903s left) kms_lease (lease-unleased-connector)
[118.382082] Starting subtest: lease-unleased-connector
[118.384933] Starting dynamic subtest: pipe-A-eDP-1
[118.387536] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[118.397674] Starting dynamic subtest: pipe-B-eDP-1
[118.400075] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[118.408585] Starting dynamic subtest: pipe-C-eDP-1
[118.410918] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[118.418971] Starting dynamic subtest: pipe-D-eDP-1
[118.421742] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[118.424084] Subtest lease-unleased-connector: SUCCESS (0.032s)
[118.524337] [021/133] (903s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[118.641611] Starting subtest: cursor-vs-flip-atomic-transitions
[148.401264] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.784s)
[149.243375] [022/133] (872s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[149.337502] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[149.340195] Starting dynamic subtest: pipe-A-default-mode
[152.121497] Dynamic subtest pipe-A-default-mode: SUCCESS (2.787s)
[152.124066] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.788s)
[152.968097] [023/133] (869s left) kms_addfb_basic (legacy-format)
[153.019320] Starting subtest: legacy-format
[153.038965] Subtest legacy-format: SUCCESS (0.016s)
[153.215609] [024/133] (868s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[153.316376] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[153.320649] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[153.425135] [025/133] (868s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[153.530217] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[153.534016] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[153.667298] [026/133] (868s left) kms_vblank (query-busy)
[153.748301] Starting subtest: query-busy
[153.750562] Starting dynamic subtest: pipe-A-eDP-1
[155.627901] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.878s)
[155.641780] Starting dynamic subtest: pipe-D-eDP-1
[158.209460] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.580s)
[158.211961] Subtest query-busy: SUCCESS (4.461s)
[159.026222] [027/133] (863s left) gem_wait (invalid-flags)
[159.078478] Starting subtest: invalid-flags
[159.081075] Subtest invalid-flags: SUCCESS (0.000s)
[159.334426] [028/133] (862s left) kms_properties (invalid-properties-atomic)
[159.429932] Starting subtest: invalid-properties-atomic
[159.767085] Subtest invalid-properties-atomic: SUCCESS (0.339s)
[159.841405] [029/133] (862s left) gem_exec_flush (basic-wb-ro-before-default)
[159.905591] Starting subtest: basic-wb-ro-before-default
[165.370638] Subtest basic-wb-ro-before-default: SUCCESS (5.471s)
[165.571523] [030/133] (856s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[165.671995] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[165.676960] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[165.800260] [031/133] (856s left) kms_psr (pr-primary-blt)
[165.900882] Starting subtest: pr-primary-blt
[165.905929] Subtest pr-primary-blt: SKIP (0.000s)
[165.985422] [032/133] (856s left) kms_flip (2x-flip-vs-dpms-on-nop)
[166.079220] Starting subtest: 2x-flip-vs-dpms-on-nop
[166.088252] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.010s)
[166.216986] [033/133] (856s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[166.312111] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[166.316764] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[166.438831] [034/133] (856s left) kms_chamelium_edid (dp-mode-timings)
[166.825928] Subtest dp-mode-timings: SKIP (0.000s)
[167.615854] [035/133] (854s left) kms_flip (flip-vs-panning-interruptible)
[167.721931] Starting subtest: flip-vs-panning-interruptible
[167.724749] Starting dynamic subtest: A-eDP1
[176.433314] Dynamic subtest A-eDP1: SUCCESS (8.716s)
[176.442467] Starting dynamic subtest: B-eDP1
[185.157445] Dynamic subtest B-eDP1: SUCCESS (8.727s)
[185.167075] Starting dynamic subtest: C-eDP1
[193.887542] Dynamic subtest C-eDP1: SUCCESS (8.734s)
[193.896454] Starting dynamic subtest: D-eDP1
[202.621559] Dynamic subtest D-eDP1: SUCCESS (8.733s)
[202.623576] Subtest flip-vs-panning-interruptible: SUCCESS (34.916s)
[203.805000] [036/133] (818s left) kms_pm_dc (dc5-psr)
[204.907286] Starting subtest: dc5-psr
[207.802931] Subtest dc5-psr: SUCCESS (2.892s)
[208.639400] [037/133] (814s left) gem_userptr_blits (process-exit)
[208.707357] Starting subtest: process-exit
[208.715909] Subtest process-exit: SUCCESS (0.008s)
[208.869068] [038/133] (813s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[208.960421] Starting subtest: plane-lut1d-post-ctm3x4
[208.973063] Starting dynamic subtest: pipe-A-eDP-1
[209.741718] Dynamic subtest pipe-A-eDP-1: FAIL (0.335s)
[210.424823] Starting dynamic subtest: pipe-B-eDP-1
[211.322688] Dynamic subtest pipe-B-eDP-1: FAIL (0.313s)
[211.859535] Starting dynamic subtest: pipe-C-eDP-1
[212.779079] Dynamic subtest pipe-C-eDP-1: FAIL (0.255s)
[213.189727] Starting dynamic subtest: pipe-D-eDP-1
[214.091164] Dynamic subtest pipe-D-eDP-1: FAIL (0.246s)
[214.093780] Subtest plane-lut1d-post-ctm3x4: FAIL (4.770s)
[214.585334] [039/133] (808s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[214.640789] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[214.748498] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.107s)
[214.850405] [040/133] (807s left) gem_mmap_offset (partial-remap)
[214.910921] Starting subtest: partial-remap
[214.913707] Starting dynamic subtest: smem0
[214.923644] Dynamic subtest smem0: SUCCESS (0.004s)
[214.925907] Subtest partial-remap: SUCCESS (0.004s)
[215.057834] [041/133] (807s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[215.162139] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[215.166884] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[215.270331] [042/133] (807s left) gem_userptr_blits (dmabuf-unsync)
[215.331123] Subtest dmabuf-unsync: SKIP (0.000s)
[215.474583] [043/133] (807s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[215.574886] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[215.580057] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[215.666719] [044/133] (807s left) gem_close_race (multigpu-basic-threads)
[215.726958] Starting subtest: multigpu-basic-threads
[215.732625] Subtest multigpu-basic-threads: SKIP (0.000s)
[215.987483] [045/133] (807s left) gem_exec_schedule (preempt)
[216.066869] Starting subtest: preempt
[216.069574] Starting dynamic subtest: rcs0
[216.084582] Dynamic subtest rcs0: SUCCESS (0.027s)
[216.095064] Starting dynamic subtest: bcs0
[216.105097] Dynamic subtest bcs0: SUCCESS (0.021s)
[216.114896] Starting dynamic subtest: vcs0
[216.127303] Dynamic subtest vcs0: SUCCESS (0.021s)
[216.136682] Starting dynamic subtest: vcs1
[216.148587] Dynamic subtest vcs1: SUCCESS (0.020s)
[216.156514] Starting dynamic subtest: vecs0
[216.168761] Dynamic subtest vecs0: SUCCESS (0.019s)
[216.176967] Starting dynamic subtest: ccs0
[216.188453] Dynamic subtest ccs0: SUCCESS (0.019s)
[216.190902] Subtest preempt: SUCCESS (0.132s)
[218.209558] [046/133] (804s left) i915_module_load (reload)
[218.247111] Starting subtest: reload
[224.515117] Subtest reload: SUCCESS (6.268s)
[224.555216] [047/133] (798s left) gem_exec_reloc (basic-wc-cpu-active)
[226.094391] Subtest basic-wc-cpu-active: SKIP (0.000s)
[226.176456] [048/133] (796s left) gen9_exec_parse (valid-registers)
[226.241067] Subtest valid-registers: SKIP (0.000s)
[226.310831] [049/133] (796s left) kms_cursor_edge_walk (64x64-left-edge)
[226.417276] Starting subtest: 64x64-left-edge
[226.419864] Starting dynamic subtest: pipe-A-eDP-1
[229.872285] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.455s)
[229.881114] Starting dynamic subtest: pipe-D-eDP-1
[233.076290] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.201s)
[233.078786] Subtest 64x64-left-edge: SUCCESS (6.660s)
[233.885111] [050/133] (789s left) gem_render_copy_redux (flink)
[233.954995] Starting subtest: flink
[234.676680] Subtest flink: SUCCESS (0.722s)
[234.832323] [051/133] (788s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[234.930771] Starting subtest: psr-2p-primscrn-spr-indfb-move
[234.935340] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[235.047914] [052/133] (788s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[235.145053] Starting subtest: bo-too-small-due-to-tiling
[235.149824] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[235.262221] [053/133] (788s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[235.364964] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[242.083480] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.721s)
[242.220575] [054/133] (781s left) gem_exec_reloc (basic-write-wc-active)
[242.293329] Subtest basic-write-wc-active: SKIP (0.000s)
[242.362321] [055/133] (781s left) gem_fenced_exec_thrash (2-spare-fences)
[242.430107] Subtest 2-spare-fences: SKIP (0.000s)
[242.521804] [056/133] (780s left) kms_hdr (static-toggle-dpms)
[242.619008] Starting subtest: static-toggle-dpms
[242.626538] Subtest static-toggle-dpms: SKIP (0.000s)
[242.708456] [057/133] (780s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[242.820750] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[249.864010] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.047s)
[249.998718] [058/133] (773s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[250.102814] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[253.885634] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.789s)
[255.035122] [059/133] (768s left) gem_lmem_swapping (parallel-random-verify)
[255.075957] Subtest parallel-random-verify: SKIP (0.000s)
[255.115231] [060/133] (768s left) kms_psr (fbc-pr-sprite-plane-move)
[255.212930] Starting subtest: fbc-pr-sprite-plane-move
[255.218076] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[255.296128] [061/133] (768s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[255.687051] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[256.537550] [062/133] (767s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[256.635781] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[256.638559] Starting dynamic subtest: pipe-A-eDP-1
[256.669495] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[256.686085] Starting dynamic subtest: pipe-B-eDP-1
[256.716064] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[256.726071] Starting dynamic subtest: pipe-C-eDP-1
[256.755782] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[256.765080] Starting dynamic subtest: pipe-D-eDP-1
[256.795092] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[256.800662] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[258.859811] [063/133] (764s left) i915_pm_rpm (gem-evict-pwrite)
[260.380313] Starting subtest: gem-evict-pwrite
[260.385983] Subtest gem-evict-pwrite: SKIP (0.000s)
[261.094585] [064/133] (762s left) gem_exec_whisper (basic-sync)
[261.158769] Starting subtest: basic-sync
[268.843107] Subtest basic-sync: SUCCESS (7.682s)
[269.036329] [065/133] (754s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[269.153124] Starting subtest: short-busy-flip-before-cursor-toggle
[269.158110] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[269.328347] [066/133] (754s left) i915_query (hwconfig_table)
[269.384472] Starting subtest: hwconfig_table
[269.735779] Subtest hwconfig_table: SUCCESS (0.001s)
[269.775548] [067/133] (754s left) kms_vrr (flipline)
[269.869935] Starting subtest: flipline
[269.877114] Subtest flipline: SKIP (0.000s)
[269.954615] [068/133] (753s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[270.058053] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[274.310662] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.257s)
[275.486798] [069/133] (748s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[275.587874] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[275.605173] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[275.677545] [070/133] (748s left) kms_prop_blob (invalid-set-prop)
[275.734757] Starting subtest: invalid-set-prop
[275.736930] Subtest invalid-set-prop: SUCCESS (0.000s)
[275.851468] [071/133] (748s left) kms_properties (crtc-properties-legacy)
[275.947725] Starting subtest: crtc-properties-legacy
[275.949974] Starting dynamic subtest: pipe-A-eDP-1
[276.388726] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.442s)
[276.399905] Starting dynamic subtest: pipe-B-eDP-1
[277.530387] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.140s)
[277.539053] Starting dynamic subtest: pipe-C-eDP-1
[278.647847] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.115s)
[278.657102] Starting dynamic subtest: pipe-D-eDP-1
[279.781183] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s)
[279.783964] Subtest crtc-properties-legacy: SUCCESS (3.837s)
[280.589839] [072/133] (743s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[280.691064] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[287.559665] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.873s)
[287.743130] [073/133] (736s left) kms_psr (fbc-pr-cursor-render)
[287.843805] Starting subtest: fbc-pr-cursor-render
[287.848640] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[287.927599] [074/133] (736s left) gem_userptr_blits (huge-split)
[288.009005] Starting subtest: huge-split
[288.015800] Subtest huge-split: SUCCESS (0.007s)
[288.172693] [075/133] (736s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[288.428632] Starting subtest: cursor-rapid-movement-256x85
[288.469462] Subtest cursor-rapid-movement-256x85: SKIP (0.038s)
[288.671636] [076/133] (735s left) gem_unref_active_buffers
[288.915958] [077/133] (735s left) gem_caching (reads)
[288.967999] Subtest reads: SKIP (0.000s)
[289.050090] [078/133] (735s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[289.118823] Starting subtest: invalid-multi-wait-all-unsubmitted
[289.121752] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[289.265439] [079/133] (735s left) gem_exec_create (basic)
[289.328970] Starting subtest: basic
[289.331301] Starting dynamic subtest: smem
[293.120611] Dynamic subtest smem: SUCCESS (3.791s)
[293.123619] Subtest basic: SUCCESS (3.792s)
[293.320389] [080/133] (731s left) kms_content_protection (atomic-dpms-hdcp14)
[293.495640] Starting subtest: atomic-dpms-hdcp14
[293.500735] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[293.643108] [081/133] (730s left) sw_sync (timeline_closed)
[293.680877] Starting subtest: timeline_closed
[293.683717] Subtest timeline_closed: SUCCESS (0.000s)
[293.773444] [082/133] (730s left) perf (oa-exponents)
[293.899611] Starting subtest: oa-exponents
[293.901904] Starting dynamic subtest: 0-rcs0
[295.686093] Dynamic subtest 0-rcs0: SUCCESS (1.786s)
[295.696426] Starting dynamic subtest: 1-vecs0
[297.519303] Dynamic subtest 1-vecs0: SUCCESS (1.832s)
[297.522176] Subtest oa-exponents: SUCCESS (3.620s)
[297.569335] [083/133] (727s left) kms_feature_discovery (display-2x)
[297.666779] Starting subtest: display-2x
[297.671919] Subtest display-2x: SKIP (0.000s)
[297.751490] [084/133] (726s left) core_setmaster (master-drop-set-root)
[297.832356] Starting subtest: master-drop-set-root
[297.845394] Subtest master-drop-set-root: SUCCESS (0.013s)
[297.892725] [085/133] (726s left) kms_pm_rpm (i2c)
[299.433745] Starting subtest: i2c
[305.106947] Subtest i2c: SUCCESS (5.677s)
[305.219556] [086/133] (719s left) kms_busy (basic-hang)
[305.323726] Starting subtest: basic-hang
[305.326668] Starting dynamic subtest: flip-pipe-A
[305.915941] Dynamic subtest flip-pipe-A: SUCCESS (0.591s)
[305.928032] Starting dynamic subtest: modeset-pipe-A
[309.551090] Dynamic subtest modeset-pipe-A: SUCCESS (3.635s)
[309.561836] Starting dynamic subtest: flip-pipe-D
[310.744829] Dynamic subtest flip-pipe-D: SUCCESS (1.196s)
[310.754227] Starting dynamic subtest: modeset-pipe-D
[314.187691] Dynamic subtest modeset-pipe-D: SUCCESS (3.443s)
[314.190201] Subtest basic-hang: SUCCESS (8.872s)
[314.999374] [087/133] (709s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[315.100070] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[315.104949] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[315.207017] [088/133] (709s left) kms_flip (nonblocking-read)
[315.302726] Starting subtest: nonblocking-read
[315.304619] Subtest nonblocking-read: SUCCESS (0.000s)
[315.434959] [089/133] (709s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[315.549704] Starting subtest: yf-tiled-16bpp-rotate-270
[315.554086] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[315.677459] [090/133] (709s left) gem_mmap_wc (write-read-distinct)
[315.738755] Subtest write-read-distinct: SKIP (0.000s)
[315.808003] [091/133] (709s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[315.868985] Starting subtest: multi-wait-for-submit-submitted-signaled
[315.871832] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[315.974873] [092/133] (709s left) kms_flip (blocking-wf_vblank)
[316.066392] Starting subtest: blocking-wf_vblank
[316.068846] Starting dynamic subtest: A-eDP1
[325.026418] Dynamic subtest A-eDP1: SUCCESS (8.965s)
[325.037150] Starting dynamic subtest: B-eDP1
[333.962304] Dynamic subtest B-eDP1: SUCCESS (8.932s)
[333.972268] Starting dynamic subtest: C-eDP1
[342.889605] Dynamic subtest C-eDP1: SUCCESS (8.922s)
[342.899731] Starting dynamic subtest: D-eDP1
[351.812846] Dynamic subtest D-eDP1: SUCCESS (8.917s)
[351.818693] Subtest blocking-wf_vblank: SUCCESS (35.749s)
[353.075429] [093/133] (671s left) gem_exec_alignment (pi)
[353.148092] Starting subtest: pi
[403.698425] Subtest pi: SUCCESS (50.541s)
[404.749834] [094/133] (620s left) kms_getfb (getfb-repeated-different-handles)
[404.899391] Starting subtest: getfb-repeated-different-handles
[404.901948] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[405.027839] [095/133] (620s left) syncobj_timeline (etime-multi-wait-submitted)
[405.100688] Starting subtest: etime-multi-wait-submitted
[405.203910] Subtest etime-multi-wait-submitted: SUCCESS (0.106s)
[405.340187] [096/133] (619s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[405.471088] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[406.470243] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.998s)
[407.301234] [097/133] (617s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[407.399647] Starting subtest: primary-yf-tiled-reflect-x-0
[407.471104] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.071s)
[407.585178] [098/133] (617s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[407.653091] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[407.727730] [099/133] (617s left) perf_pmu (rc6)
[407.766985] Starting subtest: rc6
[407.769739] Starting dynamic subtest: gt0
[414.149411] Dynamic subtest gt0: SUCCESS (6.386s)
[414.162417] Starting dynamic subtest: runtime-pm-gt0
[421.872568] Dynamic subtest runtime-pm-gt0: SUCCESS (7.722s)
[421.886245] Starting dynamic subtest: runtime-pm-long-gt0
[434.376086] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.502s)
[434.389689] Starting dynamic subtest: other-idle-gt0
[440.719675] Dynamic subtest other-idle-gt0: SUCCESS (6.341s)
[440.732252] Starting dynamic subtest: gt1
[447.062054] Dynamic subtest gt1: SUCCESS (6.341s)
[447.075082] Starting dynamic subtest: runtime-pm-gt1
[454.552883] Dynamic subtest runtime-pm-gt1: SUCCESS (7.489s)
[454.563816] Starting dynamic subtest: runtime-pm-long-gt1
[467.034685] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.481s)
[467.045053] Starting dynamic subtest: other-idle-gt1
[473.378885] Dynamic subtest other-idle-gt1: SUCCESS (6.342s)
[473.381712] Subtest rc6: SUCCESS (65.624s)
[474.715467] [100/133] (550s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[474.819589] Starting subtest: y-tiled-16bpp-rotate-0
[474.824006] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[474.914734] [101/133] (550s left) kms_flip_tiling (flip-change-tiling)
[475.004878] Starting subtest: flip-change-tiling
[475.007011] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[475.183677] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.179s)
[475.195892] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[475.329595] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.142s)
[475.341871] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[475.462730] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[475.475133] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[475.654512] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.189s)
[475.669770] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[475.797821] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[475.809432] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[475.941643] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[475.953560] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[476.075044] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[476.087240] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[476.186468] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[476.197624] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[476.332049] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.143s)
[476.344673] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[476.475274] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[476.488901] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[476.619732] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[476.631689] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[476.763905] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[476.776640] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[476.897491] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[476.910768] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[477.031914] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[477.045088] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[477.152990] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.120s)
[477.166127] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[477.326056] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.170s)
[477.338882] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[477.469628] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[477.482640] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[477.613828] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[477.626622] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[477.758304] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[477.771860] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[477.902842] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[477.916099] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[478.058328] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.153s)
[478.072108] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[478.180371] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.120s)
[478.194157] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[478.325071] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.143s)
[478.337926] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[478.468769] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.142s)
[478.481395] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[478.613192] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[478.628709] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[478.757850] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[478.770546] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[478.902139] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[478.913668] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[479.046421] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.142s)
[479.063755] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[479.209279] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.160s)
[479.222080] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[479.364972] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.153s)
[479.378535] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[479.509376] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[479.527735] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[479.665106] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.153s)
[479.678562] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[479.809585] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[479.822656] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[479.953738] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.142s)
[479.966006] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[480.098050] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.142s)
[480.110961] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[480.258936] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.159s)
[480.311600] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[481.520894] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.217s)
[481.534776] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[481.655466] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[481.668617] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[481.788769] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[481.801675] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[481.932064] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s)
[481.945301] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[482.075923] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[482.088068] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[482.220103] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[482.233378] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[482.353897] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[482.366105] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[482.465305] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[482.476869] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[482.599274] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[482.610853] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[482.744420] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.143s)
[482.757772] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[482.914520] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.170s)
[482.928682] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[483.058690] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[483.072238] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[483.192309] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[483.204741] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[483.326736] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[483.339924] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[483.436889] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[483.450078] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[483.609533] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.170s)
[483.623058] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[483.753055] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[483.766073] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[483.897393] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[483.909059] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[484.041981] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[484.055019] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[484.186059] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[484.199126] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[484.330763] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[484.343943] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[484.492080] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.159s)
[484.505735] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[484.647076] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.153s)
[484.660600] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[484.803468] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.154s)
[484.827843] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[484.969078] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.164s)
[484.981442] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[485.113660] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[485.125816] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[485.258295] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[485.269097] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[485.402877] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.142s)
[485.413532] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[485.535719] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.130s)
[485.547943] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[485.680353] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.142s)
[485.693454] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[485.824531] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[485.836616] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[485.969344] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[485.981916] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[486.113591] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[486.126697] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[486.258079] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.142s)
[486.276771] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[486.413850] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.152s)
[486.426767] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[486.535613] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.120s)
[486.590595] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[487.841306] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.260s)
[487.854220] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[487.941227] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[487.953481] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[488.041186] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[488.054481] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[488.153230] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s)
[488.165360] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[488.263654] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[488.275791] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[488.374365] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.110s)
[488.386743] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[488.473987] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.099s)
[488.486111] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[488.574342] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[488.586660] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[488.674309] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[488.686359] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[488.784901] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s)
[488.796850] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[488.895701] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[488.907465] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[489.007066] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.110s)
[489.019067] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[489.106728] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.099s)
[489.119078] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[489.206548] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.099s)
[489.217723] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[489.306720] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.099s)
[489.317277] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[489.458472] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.149s)
[489.470883] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[489.568374] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[489.580485] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[489.678794] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.110s)
[489.690157] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[489.789986] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.110s)
[489.801368] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[489.901534] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.110s)
[489.913035] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[490.012472] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s)
[490.027683] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[490.123479] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.109s)
[490.136215] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[490.274085] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.149s)
[490.284663] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[490.385527] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.110s)
[490.398584] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[490.496204] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.109s)
[490.508741] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[490.606982] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.110s)
[490.618403] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[490.718479] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.110s)
[490.730656] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[490.829519] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.110s)
[490.840549] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[490.940548] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.110s)
[490.952466] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[491.051976] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.110s)
[491.064778] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[491.162612] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.108s)
[491.176999] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[491.273729] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.108s)
[491.286924] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[491.385017] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.109s)
[491.397515] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[491.496074] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.109s)
[491.507772] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[491.607122] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.110s)
[491.619989] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[491.718305] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.110s)
[491.760095] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[492.973412] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.220s)
[492.986789] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[493.073260] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[493.086057] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[493.173330] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[493.188807] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[493.284037] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.110s)
[493.298552] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[493.394650] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[493.405920] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[493.505722] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.110s)
[493.516959] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[493.606041] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.099s)
[493.617977] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[493.706306] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[493.718151] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[493.806136] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[493.817895] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[493.905735] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.099s)
[493.918356] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[494.016604] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.110s)
[494.028470] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[494.127764] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.110s)
[494.139549] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[494.227512] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.099s)
[494.239477] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[494.327918] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.099s)
[494.340452] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[494.427768] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.099s)
[494.439199] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[494.538957] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.110s)
[494.550631] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[494.650271] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[494.661636] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[494.761048] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.110s)
[494.773208] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[494.871990] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.110s)
[494.884637] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[494.972478] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.098s)
[494.985383] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[495.083748] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s)
[495.096259] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[495.194721] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.109s)
[495.207369] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[495.305386] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.109s)
[495.317122] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[495.416545] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.110s)
[495.426651] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[495.527727] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.110s)
[495.543728] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[495.638798] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.109s)
[495.651021] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[495.738569] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.099s)
[495.750728] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[495.860788] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.121s)
[495.872399] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[495.983084] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.121s)
[495.996754] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[496.094368] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.109s)
[496.106790] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[496.205243] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.110s)
[496.216880] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[496.316286] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.110s)
[496.327104] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[496.427718] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.110s)
[496.439942] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[496.538652] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.110s)
[496.550306] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[496.649813] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.110s)
[496.659932] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[496.760792] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.110s)
[496.793852] Subtest flip-change-tiling: SUCCESS (21.795s)
[498.056941] [102/133] (527s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[498.167316] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[498.172314] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[498.271736] [103/133] (527s left) gem_exec_fence (submit-chain)
[498.459564] Starting subtest: submit-chain
[498.478846] Subtest submit-chain: SUCCESS (0.022s)
[500.181085] [104/133] (525s left) gem_ringfill (engines-basic)
[506.115641] Starting subtest: engines-basic
[506.118626] Starting dynamic subtest: rcs0
[506.185389] Dynamic subtest rcs0: SUCCESS (0.070s)
[506.196959] Starting dynamic subtest: bcs0
[506.232009] Dynamic subtest bcs0: SUCCESS (0.044s)
[506.244821] Starting dynamic subtest: vcs0
[506.276060] Dynamic subtest vcs0: SUCCESS (0.042s)
[506.288399] Starting dynamic subtest: vcs1
[506.320355] Dynamic subtest vcs1: SUCCESS (0.043s)
[506.331936] Starting dynamic subtest: vecs0
[506.362891] Dynamic subtest vecs0: SUCCESS (0.041s)
[506.373116] Starting dynamic subtest: ccs0
[506.409955] Dynamic subtest ccs0: SUCCESS (0.045s)
[506.412799] Subtest engines-basic: SUCCESS (0.296s)
[506.481735] [105/133] (519s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[506.584217] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[506.586556] Starting dynamic subtest: pipe-A-eDP-1
[506.607653] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[506.617974] Starting dynamic subtest: pipe-B-eDP-1
[506.638838] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[506.648180] Starting dynamic subtest: pipe-C-eDP-1
[506.668252] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[506.677485] Starting dynamic subtest: pipe-D-eDP-1
[506.698096] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[506.700100] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[508.717638] [106/133] (516s left) perf_pmu (busy-check-all)
[508.758130] Starting subtest: busy-check-all
[508.760477] Starting dynamic subtest: rcs0
[509.330699] Dynamic subtest rcs0: SUCCESS (0.574s)
[509.344177] Starting dynamic subtest: bcs0
[509.883091] Dynamic subtest bcs0: SUCCESS (0.549s)
[509.896508] Starting dynamic subtest: vcs0
[511.104451] Dynamic subtest vcs0: SUCCESS (1.219s)
[511.118220] Starting dynamic subtest: vcs1
[513.088363] Dynamic subtest vcs1: SUCCESS (1.981s)
[513.101461] Starting dynamic subtest: vecs0
[515.072982] Dynamic subtest vecs0: SUCCESS (1.982s)
[515.088087] Starting dynamic subtest: ccs0
[515.631960] Dynamic subtest ccs0: SUCCESS (0.557s)
[515.634969] Subtest busy-check-all: SUCCESS (6.878s)
[515.718107] [107/133] (509s left) gem_exec_schedule (submit-early-slice)
[515.795936] Starting subtest: submit-early-slice
[515.798761] Starting dynamic subtest: rcs0
[515.853207] Dynamic subtest rcs0: SUCCESS (0.068s)
[515.868151] Starting dynamic subtest: bcs0
[515.906658] Dynamic subtest bcs0: SUCCESS (0.053s)
[515.917961] Starting dynamic subtest: vcs0
[515.964629] Dynamic subtest vcs0: SUCCESS (0.057s)
[515.978281] Starting dynamic subtest: vcs1
[516.012737] Dynamic subtest vcs1: SUCCESS (0.048s)
[516.026119] Starting dynamic subtest: vecs0
[516.071110] Dynamic subtest vecs0: SUCCESS (0.057s)
[516.084896] Starting dynamic subtest: ccs0
[516.125451] Dynamic subtest ccs0: SUCCESS (0.054s)
[516.128434] Subtest submit-early-slice: SUCCESS (0.342s)
[517.130171] [108/133] (508s left) gem_exec_balancer (parallel-bb-first)
[517.400092] Starting subtest: parallel-bb-first
[518.379596] Subtest parallel-bb-first: SUCCESS (0.980s)
[519.061133] [109/133] (506s left) gen9_exec_parse (bb-large)
[519.129922] Subtest bb-large: SKIP (0.000s)
[519.237572] [110/133] (506s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[519.333764] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[519.336269] Starting dynamic subtest: pipe-A-eDP-1
[519.405301] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[519.416255] Starting dynamic subtest: pipe-B-eDP-1
[519.486884] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[519.497975] Starting dynamic subtest: pipe-C-eDP-1
[519.566219] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[519.576989] Starting dynamic subtest: pipe-D-eDP-1
[519.648634] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[519.654054] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.008s)
[521.499374] [111/133] (504s left) api_intel_bb (simple-bb-ctx)
[521.563301] Starting subtest: simple-bb-ctx
[521.569965] Subtest simple-bb-ctx: SUCCESS (0.009s)
[521.714550] [112/133] (504s left) gem_ctx_isolation (preservation-s3)
[521.782690] Starting subtest: preservation-S3
[521.785477] Starting dynamic subtest: rcs0
[537.921521] Dynamic subtest rcs0: SUCCESS (1.357s)
[537.937687] Starting dynamic subtest: bcs0
[553.925363] Dynamic subtest bcs0: SUCCESS (1.283s)
[553.938006] Starting dynamic subtest: vcs0
[569.927845] Dynamic subtest vcs0: SUCCESS (2.721s)
[569.938994] Starting dynamic subtest: vcs1
[587.918201] Dynamic subtest vcs1: SUCCESS (5.030s)
[587.931825] Starting dynamic subtest: vecs0
[605.921902] Dynamic subtest vecs0: SUCCESS (5.023s)
[605.932282] Starting dynamic subtest: ccs0
[623.910377] Dynamic subtest ccs0: SUCCESS (3.278s)
[623.913115] Subtest preservation-S3: SUCCESS (18.697s)
[624.148869] [113/133] (401s left) sriov_basic (enable-vfs-autoprobe-on)
[624.216202] Starting subtest: enable-vfs-autoprobe-on
[624.218900] Starting dynamic subtest: numvfs-1
[624.312275] Dynamic subtest numvfs-1: FAIL (0.032s)
[624.323760] Starting dynamic subtest: numvfs-2
[624.413885] Dynamic subtest numvfs-2: FAIL (0.004s)
[624.425682] Starting dynamic subtest: numvfs-3
[624.511903] Dynamic subtest numvfs-3: FAIL (0.004s)
[624.522282] Starting dynamic subtest: numvfs-4
[624.608600] Dynamic subtest numvfs-4: FAIL (0.003s)
[624.619845] Starting dynamic subtest: numvfs-5
[624.705619] Dynamic subtest numvfs-5: FAIL (0.004s)
[624.715831] Starting dynamic subtest: numvfs-6
[624.801834] Dynamic subtest numvfs-6: FAIL (0.003s)
[624.814659] Starting dynamic subtest: numvfs-7
[624.899628] Dynamic subtest numvfs-7: FAIL (0.004s)
[624.909268] Starting dynamic subtest: numvfs-random
[624.984059] Dynamic subtest numvfs-random: FAIL (0.003s)
[624.993582] Starting dynamic subtest: numvfs-all
[625.060719] Dynamic subtest numvfs-all: FAIL (0.610s)
[625.062674] Subtest enable-vfs-autoprobe-on: FAIL (0.676s)
[625.100629] [114/133] (400s left) perf_pmu (gt-awake)
[625.142859] Starting subtest: gt-awake
[633.613268] Subtest gt-awake: SUCCESS (8.520s)
[633.695617] [115/133] (392s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[633.760212] Subtest no-spare-fences-busy: SKIP (0.000s)
[633.843410] [116/133] (392s left) kms_rotation_crc (primary-rotation-90)
[633.949215] Starting subtest: primary-rotation-90
[633.954090] Subtest primary-rotation-90: SKIP (0.001s)
[634.002407] [117/133] (392s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[634.098982] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[634.954568] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.859s)
[635.085073] [118/133] (391s left) gem_mmap_wc (write-prefaulted)
[635.151076] Subtest write-prefaulted: SKIP (0.000s)
[635.217722] [119/133] (391s left) gem_pxp (reject-modify-context-protection-off-1)
[635.346005] Starting subtest: reject-modify-context-protection-off-1
[635.349079] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[635.447306] [120/133] (390s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[635.538949] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[635.541718] Starting dynamic subtest: pipe-A-eDP-1
[635.565084] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[635.576511] Starting dynamic subtest: pipe-B-eDP-1
[635.599507] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[635.609808] Starting dynamic subtest: pipe-C-eDP-1
[635.632846] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[635.643067] Starting dynamic subtest: pipe-D-eDP-1
[635.666580] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[635.668921] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.092s)
[637.951270] [121/133] (388s left) kms_plane_lowres (tiling-x)
[638.048720] Starting subtest: tiling-x
[638.051491] Starting dynamic subtest: pipe-A-eDP-1
[638.056720] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[638.345875] Starting dynamic subtest: pipe-B-eDP-1
[638.351249] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[638.361503] Starting dynamic subtest: pipe-C-eDP-1
[638.366658] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[638.377073] Starting dynamic subtest: pipe-D-eDP-1
[638.382753] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[638.387881] Subtest tiling-x: SKIP (0.294s)
[639.164550] [122/133] (387s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[639.263910] Starting subtest: multiplane-rotation-cropping-top
[656.773578] Subtest multiplane-rotation-cropping-top: SUCCESS (17.528s)
[656.880916] [123/133] (369s left) gem_mmap_gtt (basic-write-read-distinct)
[656.933505] Subtest basic-write-read-distinct: SKIP (0.000s)
[656.998718] [124/133] (369s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[657.114711] Starting subtest: fbc-psr2-sprite-mmap-gtt
[657.116558] Starting dynamic subtest: eDP-1
[657.120314] Dynamic subtest eDP-1: SKIP (0.000s)
[657.123788] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.003s)
[657.171405] [125/133] (369s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[657.274278] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[657.278560] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[657.323256] [126/133] (369s left) gem_tiled_partial_pwrite_pread (writes)
[657.390069] Subtest writes: SKIP (0.000s)
[657.467410] [127/133] (369s left) kms_atomic (crtc-invalid-params-fence)
[657.568723] Starting subtest: crtc-invalid-params-fence
[657.570623] Starting dynamic subtest: pipe-A-eDP-1
[657.979093] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.410s)
[657.982096] Subtest crtc-invalid-params-fence: SUCCESS (0.411s)
[658.765661] [128/133] (367s left) gem_busy (parallel)
[658.957850] Starting subtest: parallel
[658.960876] Starting dynamic subtest: rcs0
[660.619749] Dynamic subtest rcs0: SUCCESS (1.660s)
[660.634145] Starting dynamic subtest: bcs0
[662.603917] Dynamic subtest bcs0: SUCCESS (1.982s)
[662.616776] Starting dynamic subtest: vcs0
[664.651335] Dynamic subtest vcs0: SUCCESS (2.045s)
[664.662831] Starting dynamic subtest: vcs1
[666.636803] Dynamic subtest vcs1: SUCCESS (1.983s)
[666.649532] Starting dynamic subtest: vecs0
[668.620819] Dynamic subtest vecs0: SUCCESS (1.982s)
[668.633789] Starting dynamic subtest: ccs0
[670.604551] Dynamic subtest ccs0: SUCCESS (1.981s)
[670.607552] Subtest parallel: SUCCESS (11.648s)
[670.820211] [129/133] (355s left) gem_ctx_persistence (processes)
[670.881092] Starting subtest: processes
[672.667455] Subtest processes: SUCCESS (1.786s)
[672.729368] [130/133] (354s left) kms_big_fb (4-tiled-addfb-size-overflow)
[672.827723] Starting subtest: 4-tiled-addfb-size-overflow
[672.830248] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[672.909221] [131/133] (353s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[673.014396] Starting subtest: x-tiled-64bpp-rotate-270
[673.034669] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s)
[673.169217] [132/133] (353s left) kms_plane_scaling (planes-scaler-unity-scaling)
[673.287822] Starting subtest: planes-scaler-unity-scaling
[673.290463] Starting dynamic subtest: pipe-A
[673.349566] Dynamic subtest pipe-A: SUCCESS (0.064s)
[673.360731] Starting dynamic subtest: pipe-B
[674.504336] Dynamic subtest pipe-B: SUCCESS (1.154s)
[674.516830] Starting dynamic subtest: pipe-C
[675.612568] Dynamic subtest pipe-C: SUCCESS (1.108s)
[675.626630] Starting dynamic subtest: pipe-D
[676.739816] Dynamic subtest pipe-D: SUCCESS (1.126s)
[676.742445] Subtest planes-scaler-unity-scaling: SUCCESS (3.456s)
[677.885267] [133/133] (349s left) gem_exec_whisper (basic-contexts)
[677.969999] Starting subtest: basic-contexts
[685.614070] Subtest basic-contexts: SUCCESS (7.642s)
[685.780267] 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.