[61.269336] Initializing watchdogs
[61.269387]   /dev/watchdog0
[61.283895] [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]
[61.288751] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.291195] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.293047] [001/133] (960s left) api_intel_allocator (gem-pool)
[61.354591] Starting subtest: gem-pool
[61.361515] Subtest gem-pool: SUCCESS (0.008s)
[61.517375] [002/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[61.623338] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[61.624822] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[61.750063] [003/133] (960s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[61.829017] Starting subtest: read-crc-frame-sequence
[61.830031] Starting dynamic subtest: pipe-A-eDP-1
[62.568790] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.740s)
[62.575348] Starting dynamic subtest: pipe-B-eDP-1
[63.931422] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.362s)
[63.937902] Starting dynamic subtest: pipe-C-eDP-1
[65.235388] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.305s)
[65.241687] Starting dynamic subtest: pipe-D-eDP-1
[66.565096] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.330s)
[66.566040] Subtest read-crc-frame-sequence: SUCCESS (4.741s)
[67.455678] [004/133] (954s left) syncobj_timeline (invalid-query-one-illegal-handle)
[67.598240] Starting subtest: invalid-query-one-illegal-handle
[67.599593] Subtest invalid-query-one-illegal-handle: SUCCESS (0.001s)
[67.842220] [005/133] (954s left) syncobj_wait (invalid-signal-zero-handles)
[67.946965] Starting subtest: invalid-signal-zero-handles
[67.947992] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[68.130733] [006/133] (953s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[68.239276] Starting subtest: fbcpsr-rgb565-draw-render
[75.388651] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.153s)
[75.552951] [007/133] (946s left) syncobj_timeline (wait-for-submit-snapshot)
[75.619991] Starting subtest: wait-for-submit-snapshot
[75.702743] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[75.779426] [008/133] (946s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[75.875696] Starting subtest: psr-rgb565-draw-blt
[83.011760] Subtest psr-rgb565-draw-blt: SUCCESS (7.137s)
[83.173076] [009/133] (938s left) kms_cursor_crc (cursor-onscreen-32x10)
[83.327224] Starting subtest: cursor-onscreen-32x10
[83.383801] Subtest cursor-onscreen-32x10: SKIP (0.055s)
[83.666545] [010/133] (938s left) syncobj_wait (invalid-signal-illegal-handle)
[83.724301] Starting subtest: invalid-signal-illegal-handle
[83.725375] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[83.830731] [011/133] (938s left) testdisplay
[84.180785] [012/133] (938s left) prime_mmap (test_map_unmap)
[84.235328] Starting subtest: test_map_unmap
[84.236392] Starting dynamic subtest: test_map_unmap-smem
[84.269332] Dynamic subtest test_map_unmap-smem: SUCCESS (0.034s)
[84.270427] Subtest test_map_unmap: SUCCESS (0.035s)
[84.391742] [013/133] (937s left) gem_exec_fence (syncobj-timeline-signal)
[84.948711] Starting subtest: syncobj-timeline-signal
[84.949874] Subtest syncobj-timeline-signal: SUCCESS (0.008s)
[85.976061] [FACT gem_exec_fence (syncobj-timeline-signal)] new: kernel.kmod_is_loaded.vgem: true
[85.977784] [014/133] (936s left) syncobj_timeline (signal-point-0)
[86.041256] Starting subtest: signal-point-0
[86.042222] Subtest signal-point-0: SUCCESS (0.000s)
[86.146825] [015/133] (936s left) kms_psr (psr2-suspend)
[86.235223] Starting subtest: psr2-suspend
[86.236092] Starting dynamic subtest: eDP-1
[104.194683] Dynamic subtest eDP-1: SUCCESS (3.414s)
[104.195913] Subtest psr2-suspend: SUCCESS (3.415s)
[113.093911] [016/133] (917s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[113.186964] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[113.193425] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[113.273896] [017/133] (917s left) gem_softpin (reverse)
[113.325086] Starting subtest: reverse
[113.330020] Subtest reverse: SUCCESS (0.006s)
[113.469493] [018/133] (916s left) gem_exec_balancer (parallel-contexts)
[113.737000] Starting subtest: parallel-contexts
[116.353580] Subtest parallel-contexts: SUCCESS (2.642s)
[117.524625] [019/133] (912s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[117.620755] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[117.621757] Starting dynamic subtest: pipe-A-eDP-1
[119.777334] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.171s)
[119.784518] Starting dynamic subtest: pipe-B-eDP-1
[121.929741] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.162s)
[121.937119] Starting dynamic subtest: pipe-C-eDP-1
[123.978720] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.056s)
[123.986712] Starting dynamic subtest: pipe-D-eDP-1
[126.041303] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.068s)
[126.042764] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.462s)
[127.222568] [020/133] (903s left) kms_lease (lease-unleased-connector)
[127.307750] Starting subtest: lease-unleased-connector
[127.309051] Starting dynamic subtest: pipe-A-eDP-1
[127.314174] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[127.321931] Starting dynamic subtest: pipe-B-eDP-1
[127.323097] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[127.330494] Starting dynamic subtest: pipe-C-eDP-1
[127.335388] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[127.342776] Starting dynamic subtest: pipe-D-eDP-1
[127.346134] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s)
[127.347695] Subtest lease-unleased-connector: SUCCESS (0.040s)
[127.464979] [021/133] (903s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[127.571029] Starting subtest: cursor-vs-flip-atomic-transitions
[157.590734] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.031s)
[158.444740] [022/133] (872s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[158.531629] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[158.532923] Starting dynamic subtest: pipe-A-default-mode
[161.309471] Dynamic subtest pipe-A-default-mode: SUCCESS (2.776s)
[161.310887] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.778s)
[162.147049] [023/133] (868s left) kms_addfb_basic (legacy-format)
[162.212206] Starting subtest: legacy-format
[162.233068] Subtest legacy-format: SUCCESS (0.019s)
[162.383823] [024/133] (868s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[162.481944] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[162.483918] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[162.617301] [025/133] (868s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[162.711115] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[162.713738] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[162.800145] [026/133] (867s left) kms_vblank (query-busy)
[162.891087] Starting subtest: query-busy
[162.895096] Starting dynamic subtest: pipe-A-eDP-1
[164.776713] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.884s)
[164.785583] Starting dynamic subtest: pipe-D-eDP-1
[167.311810] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.532s)
[167.312650] Subtest query-busy: SUCCESS (4.420s)
[168.114130] [027/133] (862s left) gem_wait (invalid-flags)
[168.172078] Starting subtest: invalid-flags
[168.173159] Subtest invalid-flags: SUCCESS (0.000s)
[168.403607] [028/133] (862s left) kms_properties (invalid-properties-atomic)
[168.494302] Starting subtest: invalid-properties-atomic
[168.824132] Subtest invalid-properties-atomic: SUCCESS (0.322s)
[168.897529] [029/133] (861s left) gem_exec_flush (basic-wb-ro-before-default)
[168.963094] Starting subtest: basic-wb-ro-before-default
[174.419750] Subtest basic-wb-ro-before-default: SUCCESS (5.449s)
[174.604132] [030/133] (856s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[174.694520] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[174.696575] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[174.801112] [031/133] (856s left) kms_psr (pr-primary-blt)
[174.898104] Starting subtest: pr-primary-blt
[174.900583] Subtest pr-primary-blt: SKIP (0.000s)
[174.977095] [032/133] (855s left) kms_flip (2x-flip-vs-dpms-on-nop)
[175.063788] Starting subtest: 2x-flip-vs-dpms-on-nop
[175.074688] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[175.157661] [033/133] (855s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[175.249885] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[175.251812] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[175.364666] [034/133] (855s left) kms_chamelium_edid (dp-mode-timings)
[175.740567] Subtest dp-mode-timings: SKIP (0.000s)
[176.514242] [035/133] (854s left) kms_flip (flip-vs-panning-interruptible)
[176.620229] Starting subtest: flip-vs-panning-interruptible
[176.622914] Starting dynamic subtest: A-eDP1
[185.364961] Dynamic subtest A-eDP1: SUCCESS (8.744s)
[185.373048] Starting dynamic subtest: B-eDP1
[194.088571] Dynamic subtest B-eDP1: SUCCESS (8.725s)
[194.096959] Starting dynamic subtest: C-eDP1
[202.812320] Dynamic subtest C-eDP1: SUCCESS (8.726s)
[202.820484] Starting dynamic subtest: D-eDP1
[211.537650] Dynamic subtest D-eDP1: SUCCESS (8.724s)
[211.540646] Subtest flip-vs-panning-interruptible: SUCCESS (34.926s)
[212.800629] [036/133] (818s left) kms_pm_dc (dc5-psr)
[213.900676] Starting subtest: dc5-psr
[216.787187] Subtest dc5-psr: SUCCESS (2.885s)
[217.653863] [037/133] (813s left) gem_userptr_blits (process-exit)
[217.720054] Starting subtest: process-exit
[217.726691] Subtest process-exit: SUCCESS (0.008s)
[217.872707] [038/133] (813s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[217.969792] Starting subtest: plane-lut1d-post-ctm3x4
[217.984350] Starting dynamic subtest: pipe-A-eDP-1
[218.483872] Dynamic subtest pipe-A-eDP-1: FAIL (0.315s)
[219.413565] Starting dynamic subtest: pipe-B-eDP-1
[219.906133] Dynamic subtest pipe-B-eDP-1: FAIL (0.279s)
[220.741906] Starting dynamic subtest: pipe-C-eDP-1
[221.224225] Dynamic subtest pipe-C-eDP-1: FAIL (0.257s)
[222.081016] Starting dynamic subtest: pipe-D-eDP-1
[222.573586] Dynamic subtest pipe-D-eDP-1: FAIL (0.257s)
[222.609726] Subtest plane-lut1d-post-ctm3x4: FAIL (4.638s)
[223.458636] [039/133] (807s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[223.517336] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[223.624052] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.107s)
[223.707271] [040/133] (807s left) gem_mmap_offset (partial-remap)
[223.769470] Starting subtest: partial-remap
[223.770810] Starting dynamic subtest: smem0
[223.777748] Dynamic subtest smem0: SUCCESS (0.007s)
[223.778824] Subtest partial-remap: SUCCESS (0.008s)
[223.903306] [041/133] (807s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[223.994117] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[223.996071] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[224.112508] [042/133] (807s left) gem_userptr_blits (dmabuf-unsync)
[224.186156] Subtest dmabuf-unsync: SKIP (0.000s)
[224.340115] [043/133] (806s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[224.446730] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[224.448721] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[224.574938] [044/133] (806s left) gem_close_race (multigpu-basic-threads)
[224.638970] Starting subtest: multigpu-basic-threads
[224.641705] Subtest multigpu-basic-threads: SKIP (0.000s)
[224.892808] [045/133] (806s left) gem_exec_schedule (preempt)
[224.961786] Starting subtest: preempt
[224.962770] Starting dynamic subtest: rcs0
[224.987313] Dynamic subtest rcs0: SUCCESS (0.025s)
[224.996170] Starting dynamic subtest: bcs0
[225.007826] Dynamic subtest bcs0: SUCCESS (0.020s)
[225.014871] Starting dynamic subtest: vcs0
[225.030025] Dynamic subtest vcs0: SUCCESS (0.021s)
[225.038041] Starting dynamic subtest: vcs1
[225.052999] Dynamic subtest vcs1: SUCCESS (0.021s)
[225.060202] Starting dynamic subtest: vecs0
[225.071580] Dynamic subtest vecs0: SUCCESS (0.018s)
[225.078700] Starting dynamic subtest: ccs0
[225.090332] Dynamic subtest ccs0: SUCCESS (0.018s)
[225.091828] Subtest preempt: SUCCESS (0.129s)
[226.583617] [046/133] (804s left) i915_module_load (reload)
[226.616806] Starting subtest: reload
[231.437778] Subtest reload: SUCCESS (4.822s)
[231.484522] [047/133] (799s left) gem_exec_reloc (basic-wc-cpu-active)
[233.426592] Subtest basic-wc-cpu-active: SKIP (0.000s)
[233.508488] [048/133] (797s left) gen9_exec_parse (valid-registers)
[233.567966] Subtest valid-registers: SKIP (0.000s)
[233.650443] [049/133] (797s left) kms_cursor_edge_walk (64x64-left-edge)
[233.744743] Starting subtest: 64x64-left-edge
[233.746013] Starting dynamic subtest: pipe-A-eDP-1
[237.248965] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.504s)
[237.256011] Starting dynamic subtest: pipe-D-eDP-1
[240.369724] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.119s)
[240.370886] Subtest 64x64-left-edge: SUCCESS (6.626s)
[241.179665] [050/133] (790s left) gem_render_copy_redux (flink)
[241.232169] Starting subtest: flink
[241.962747] Subtest flink: SUCCESS (0.730s)
[242.118190] [051/133] (789s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[242.210605] Starting subtest: psr-2p-primscrn-spr-indfb-move
[242.212598] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[242.332007] [052/133] (789s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[242.424547] Starting subtest: bo-too-small-due-to-tiling
[242.426040] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[242.535347] [053/133] (789s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[242.629778] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[249.290187] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.660s)
[249.409675] [054/133] (782s left) gem_exec_reloc (basic-write-wc-active)
[249.465019] Subtest basic-write-wc-active: SKIP (0.000s)
[249.534413] [055/133] (782s left) gem_fenced_exec_thrash (2-spare-fences)
[249.595904] Subtest 2-spare-fences: SKIP (0.000s)
[249.657450] [056/133] (782s left) kms_hdr (static-toggle-dpms)
[249.748176] Starting subtest: static-toggle-dpms
[249.752067] Subtest static-toggle-dpms: SKIP (0.000s)
[249.825150] [057/133] (781s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[249.927926] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[256.958176] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.032s)
[257.098558] [058/133] (774s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[257.191718] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[260.978899] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.789s)
[262.151288] [059/133] (769s left) gem_lmem_swapping (parallel-random-verify)
[262.193056] Subtest parallel-random-verify: SKIP (0.000s)
[262.236282] [060/133] (769s left) kms_psr (fbc-pr-sprite-plane-move)
[262.321688] Starting subtest: fbc-pr-sprite-plane-move
[262.323759] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[262.402631] [061/133] (769s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[262.776054] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[263.542980] [062/133] (768s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[263.640534] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[263.641592] Starting dynamic subtest: pipe-A-eDP-1
[263.651911] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[263.659740] Starting dynamic subtest: pipe-B-eDP-1
[263.671555] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[263.678738] Starting dynamic subtest: pipe-C-eDP-1
[263.688608] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[263.695582] Starting dynamic subtest: pipe-D-eDP-1
[263.705602] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[263.707796] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[265.922657] [063/133] (766s left) i915_pm_rpm (gem-evict-pwrite)
[267.544784] Starting subtest: gem-evict-pwrite
[267.547702] Subtest gem-evict-pwrite: SKIP (0.000s)
[268.169381] [064/133] (763s left) gem_exec_whisper (basic-sync)
[268.233123] Starting subtest: basic-sync
[275.901203] Subtest basic-sync: SUCCESS (7.657s)
[276.082258] [065/133] (755s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[276.208017] Starting subtest: short-busy-flip-before-cursor-toggle
[276.210300] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[276.358042] [066/133] (755s left) i915_query (hwconfig_table)
[276.417982] Starting subtest: hwconfig_table
[276.534439] Subtest hwconfig_table: SUCCESS (0.001s)
[276.566167] [067/133] (755s left) kms_vrr (flipline)
[276.667694] Starting subtest: flipline
[276.670898] Subtest flipline: SKIP (0.000s)
[276.754734] [068/133] (755s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[276.858907] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[281.268528] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.411s)
[282.484789] [069/133] (749s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[282.583340] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[282.589526] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[282.661487] [070/133] (749s left) kms_prop_blob (invalid-set-prop)
[282.719340] Starting subtest: invalid-set-prop
[282.720843] Subtest invalid-set-prop: SUCCESS (0.000s)
[282.829328] [071/133] (749s left) kms_properties (crtc-properties-legacy)
[282.920219] Starting subtest: crtc-properties-legacy
[282.921578] Starting dynamic subtest: pipe-A-eDP-1
[283.375076] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.454s)
[283.382764] Starting dynamic subtest: pipe-B-eDP-1
[284.516203] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.141s)
[284.524371] Starting dynamic subtest: pipe-C-eDP-1
[285.628323] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.111s)
[285.636680] Starting dynamic subtest: pipe-D-eDP-1
[286.779452] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.150s)
[286.780699] Subtest crtc-properties-legacy: SUCCESS (3.861s)
[287.592790] [072/133] (744s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[287.685702] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[294.662689] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.979s)
[294.832913] [073/133] (737s left) kms_psr (fbc-pr-cursor-render)
[294.934019] Starting subtest: fbc-pr-cursor-render
[294.936573] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[295.012957] [074/133] (737s left) gem_userptr_blits (huge-split)
[295.090771] Starting subtest: huge-split
[295.096313] Subtest huge-split: SUCCESS (0.007s)
[295.231362] [075/133] (737s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[295.473076] Starting subtest: cursor-rapid-movement-256x85
[295.518196] Subtest cursor-rapid-movement-256x85: SKIP (0.043s)
[295.698150] [076/133] (736s left) gem_unref_active_buffers
[295.920635] [077/133] (736s left) gem_caching (reads)
[295.977930] Subtest reads: SKIP (0.000s)
[296.036424] [078/133] (736s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[296.088965] Starting subtest: invalid-multi-wait-all-unsubmitted
[296.090272] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[296.186957] [079/133] (736s left) gem_exec_create (basic)
[296.244041] Starting subtest: basic
[296.245455] Starting dynamic subtest: smem
[299.437641] Dynamic subtest smem: SUCCESS (3.184s)
[299.439073] Subtest basic: SUCCESS (3.186s)
[299.626194] [080/133] (732s left) kms_content_protection (atomic-dpms-hdcp14)
[299.767943] Starting subtest: atomic-dpms-hdcp14
[299.770131] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[299.913058] [081/133] (732s left) sw_sync (timeline_closed)
[299.945721] Starting subtest: timeline_closed
[299.946943] Subtest timeline_closed: SUCCESS (0.000s)
[300.010263] [082/133] (732s left) perf (oa-exponents)
[300.127008] Starting subtest: oa-exponents
[300.128111] Starting dynamic subtest: 0-rcs0
[301.923105] Dynamic subtest 0-rcs0: SUCCESS (1.788s)
[301.932069] Starting dynamic subtest: 1-vecs0
[303.753051] Dynamic subtest 1-vecs0: SUCCESS (1.829s)
[303.754339] Subtest oa-exponents: SUCCESS (3.619s)
[303.788771] [083/133] (728s left) kms_feature_discovery (display-2x)
[303.870200] Starting subtest: display-2x
[303.872271] Subtest display-2x: SKIP (0.000s)
[303.954357] [084/133] (728s left) core_setmaster (master-drop-set-root)
[304.025676] Starting subtest: master-drop-set-root
[304.039247] Subtest master-drop-set-root: SUCCESS (0.013s)
[304.079866] [085/133] (728s left) kms_pm_rpm (i2c)
[305.606631] Starting subtest: i2c
[311.275141] Subtest i2c: SUCCESS (5.672s)
[311.370700] [086/133] (721s left) kms_busy (basic-hang)
[311.460727] Starting subtest: basic-hang
[311.461861] Starting dynamic subtest: flip-pipe-A
[312.084789] Dynamic subtest flip-pipe-A: SUCCESS (0.622s)
[312.093149] Starting dynamic subtest: modeset-pipe-A
[315.474357] Dynamic subtest modeset-pipe-A: SUCCESS (3.391s)
[315.483902] Starting dynamic subtest: flip-pipe-D
[316.690812] Dynamic subtest flip-pipe-D: SUCCESS (1.214s)
[316.699576] Starting dynamic subtest: modeset-pipe-D
[320.120730] Dynamic subtest modeset-pipe-D: SUCCESS (3.429s)
[320.121826] Subtest basic-hang: SUCCESS (8.663s)
[320.919928] [087/133] (711s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[321.013234] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[321.015641] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[321.129786] [088/133] (711s left) kms_flip (nonblocking-read)
[321.242925] Starting subtest: nonblocking-read
[321.243932] Subtest nonblocking-read: SUCCESS (0.000s)
[321.347487] [089/133] (711s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[321.454750] Starting subtest: yf-tiled-16bpp-rotate-270
[321.457140] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[321.572437] [090/133] (711s left) gem_mmap_wc (write-read-distinct)
[321.638132] Subtest write-read-distinct: SKIP (0.000s)
[321.703458] [091/133] (711s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[321.764148] Starting subtest: multi-wait-for-submit-submitted-signaled
[321.765563] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[321.879668] [092/133] (711s left) kms_flip (blocking-wf_vblank)
[321.973710] Starting subtest: blocking-wf_vblank
[321.974734] Starting dynamic subtest: A-eDP1
[330.890627] Dynamic subtest A-eDP1: SUCCESS (8.894s)
[330.898985] Starting dynamic subtest: B-eDP1
[339.813550] Dynamic subtest B-eDP1: SUCCESS (8.919s)
[339.822788] Starting dynamic subtest: C-eDP1
[348.751654] Dynamic subtest C-eDP1: SUCCESS (8.922s)
[348.764604] Starting dynamic subtest: D-eDP1
[357.697543] Dynamic subtest D-eDP1: SUCCESS (8.939s)
[357.698898] Subtest blocking-wf_vblank: SUCCESS (35.689s)
[358.891184] [093/133] (674s left) gem_exec_alignment (pi)
[358.959054] Starting subtest: pi
[410.960677] Subtest pi: SUCCESS (51.992s)
[412.848578] [094/133] (620s left) kms_getfb (getfb-repeated-different-handles)
[412.988007] Starting subtest: getfb-repeated-different-handles
[412.989136] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[413.109687] [095/133] (620s left) syncobj_timeline (etime-multi-wait-submitted)
[413.172593] Starting subtest: etime-multi-wait-submitted
[413.280176] Subtest etime-multi-wait-submitted: SUCCESS (0.107s)
[413.366708] [096/133] (619s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[413.477708] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[414.467621] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.991s)
[415.325911] [097/133] (617s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[415.418099] Starting subtest: primary-yf-tiled-reflect-x-0
[415.477870] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.060s)
[415.585820] [098/133] (617s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[415.645648] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[415.725955] [099/133] (617s left) perf_pmu (rc6)
[415.765878] Starting subtest: rc6
[415.766806] Starting dynamic subtest: gt0
[422.182573] Dynamic subtest gt0: SUCCESS (6.370s)
[422.193596] Starting dynamic subtest: runtime-pm-gt0
[429.859336] Dynamic subtest runtime-pm-gt0: SUCCESS (7.710s)
[429.870727] Starting dynamic subtest: runtime-pm-long-gt0
[442.309316] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.448s)
[442.321114] Starting dynamic subtest: other-idle-gt0
[448.652333] Dynamic subtest other-idle-gt0: SUCCESS (6.341s)
[448.664072] Starting dynamic subtest: gt1
[454.993171] Dynamic subtest gt1: SUCCESS (6.339s)
[455.003765] Starting dynamic subtest: runtime-pm-gt1
[462.462379] Dynamic subtest runtime-pm-gt1: SUCCESS (7.467s)
[462.474159] Starting dynamic subtest: runtime-pm-long-gt1
[474.952553] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.489s)
[474.963733] Starting dynamic subtest: other-idle-gt1
[481.296123] Dynamic subtest other-idle-gt1: SUCCESS (6.342s)
[481.297640] Subtest rc6: SUCCESS (65.525s)
[481.931848] [100/133] (551s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[482.045642] Starting subtest: y-tiled-16bpp-rotate-0
[482.048012] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[482.128931] [101/133] (551s left) kms_flip_tiling (flip-change-tiling)
[482.224686] Starting subtest: flip-change-tiling
[482.225802] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[482.402703] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (0.178s)
[482.415234] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[482.557531] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.142s)
[482.567309] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[482.680707] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[482.694056] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[482.824866] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s)
[482.839814] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[482.969681] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[482.981170] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[483.114087] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.143s)
[483.127433] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[483.247179] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[483.263340] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[483.369420] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.119s)
[483.387057] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[483.524335] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.142s)
[483.535208] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[483.658623] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[483.674807] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[483.830014] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.170s)
[483.844075] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[483.974708] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[483.987568] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[484.119444] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.142s)
[484.132825] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[484.273642] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.142s)
[484.285307] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[484.385642] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.120s)
[484.399026] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[484.530105] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.143s)
[484.542669] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[484.674347] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[484.687690] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[484.819125] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[484.832330] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[484.963486] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[484.977045] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[485.107986] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[485.122095] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[485.252716] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[485.265923] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[485.374200] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.119s)
[485.385341] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[485.526362] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.143s)
[485.537485] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[485.663455] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.142s)
[485.676613] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[485.807768] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[485.819637] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[485.952131] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.143s)
[485.964827] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[486.096616] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[486.109118] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[486.242517] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.143s)
[486.256005] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[486.403827] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.159s)
[486.415409] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[486.548316] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.143s)
[486.562659] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[486.692641] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[486.708234] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[486.837310] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[486.851149] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[486.982193] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[486.993072] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[487.126235] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.142s)
[487.138723] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[487.281710] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.153s)
[487.295066] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[487.414980] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.131s)
[487.467071] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[488.720248] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.260s)
[488.733076] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[488.854555] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.132s)
[488.867565] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[488.987211] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.130s)
[489.000609] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[489.167718] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.170s)
[489.179110] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[489.303514] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[489.316641] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[489.447946] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.142s)
[489.461186] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[489.581308] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[489.594890] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[489.692151] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[489.704957] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[489.835945] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[489.846060] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[489.970006] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[489.983742] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[490.114319] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[490.125981] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[490.258693] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[490.270701] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[490.391965] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[490.404107] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[490.527553] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[490.538187] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[490.636692] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[490.650256] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[490.808354] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.169s)
[490.826984] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[490.953113] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[490.966102] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[491.097539] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[491.116024] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[491.242015] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[491.255679] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[491.386621] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[491.400032] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[491.530726] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[491.547259] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[491.653105] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.118s)
[491.665101] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[491.797854] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.143s)
[491.810756] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[491.941749] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.141s)
[491.954024] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[492.086546] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[492.099159] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[492.230620] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[492.244054] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[492.375065] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[492.390792] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[492.530320] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.153s)
[492.545923] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[492.652757] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.120s)
[492.665694] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[492.797173] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.142s)
[492.810320] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[492.941621] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[492.954583] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[493.086298] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.142s)
[493.104042] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[493.268361] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.179s)
[493.281616] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[493.424169] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.153s)
[493.437139] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[493.579328] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.153s)
[493.592160] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[493.712727] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.131s)
[493.791215] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[495.055222] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.272s)
[495.067697] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[495.155191] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[495.166069] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[495.255089] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.099s)
[495.266850] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[495.366105] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.110s)
[495.378151] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[495.477325] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.110s)
[495.488303] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[495.588021] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.110s)
[495.602823] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[495.699192] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.109s)
[495.712016] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[495.810464] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[495.822707] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[495.921609] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.109s)
[495.933001] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[496.032550] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s)
[496.043631] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[496.144223] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[496.154753] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[496.254941] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.110s)
[496.269654] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[496.365884] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.109s)
[496.379046] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[496.477023] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.109s)
[496.489357] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[496.588343] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[496.599874] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[496.699257] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.109s)
[496.714685] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[496.810976] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[496.823137] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[496.921221] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s)
[496.932155] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[497.032633] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.110s)
[497.044172] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[497.143844] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.109s)
[497.156591] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[497.254781] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.110s)
[497.265738] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[497.376990] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.119s)
[497.388673] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[497.498791] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.121s)
[497.509133] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[497.621794] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.121s)
[497.632971] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[497.732675] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.109s)
[497.749396] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[497.882068] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.147s)
[497.893320] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[497.993934] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.110s)
[498.005775] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[498.104872] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.110s)
[498.114392] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[498.215962] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.109s)
[498.228084] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[498.326957] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.110s)
[498.337211] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[498.438318] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.109s)
[498.449301] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[498.549340] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.110s)
[498.559572] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[498.660541] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.110s)
[498.670204] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[498.771321] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.110s)
[498.783369] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[498.882240] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.110s)
[498.893234] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[498.993757] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.110s)
[499.034513] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[500.299143] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.272s)
[500.312055] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[500.399191] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[500.417852] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[500.510380] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.109s)
[500.524049] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[500.621503] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s)
[500.632595] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[500.732373] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.109s)
[500.742848] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[500.843264] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.110s)
[500.853854] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[500.943318] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.099s)
[500.954169] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[501.043605] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.099s)
[501.055076] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[501.143305] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[501.154341] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[501.254512] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.110s)
[501.266267] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[501.365724] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.110s)
[501.377224] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[501.476765] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.110s)
[501.487115] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[501.576866] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.099s)
[501.588066] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[501.676664] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.099s)
[501.688348] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[501.776935] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.099s)
[501.787885] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[501.887693] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.110s)
[501.898903] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[501.998849] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.110s)
[502.009801] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[502.110122] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.110s)
[502.121116] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[502.210171] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.099s)
[502.221147] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[502.321243] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.110s)
[502.333178] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[502.432215] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.109s)
[502.444192] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[502.543251] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.109s)
[502.554767] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[502.654537] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.109s)
[502.664512] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[502.765212] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.110s)
[502.774378] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[502.876673] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.110s)
[502.887811] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[502.987631] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.110s)
[502.998814] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[503.098969] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.110s)
[503.110226] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[503.209823] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.110s)
[503.220220] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[503.359475] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.148s)
[503.372837] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[503.470695] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.109s)
[503.482800] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[503.620243] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.148s)
[503.632216] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[503.731213] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.109s)
[503.743362] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[503.842981] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.110s)
[503.855590] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[503.965011] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.119s)
[503.976250] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[504.076051] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.110s)
[504.087149] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[504.186871] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.109s)
[504.219983] Subtest flip-change-tiling: SUCCESS (21.999s)
[505.375127] [102/133] (527s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[505.467036] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[505.469694] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[505.549476] [103/133] (527s left) gem_exec_fence (submit-chain)
[505.729254] Starting subtest: submit-chain
[505.755190] Subtest submit-chain: SUCCESS (0.027s)
[507.504740] [104/133] (525s left) gem_ringfill (engines-basic)
[513.455713] Starting subtest: engines-basic
[513.457051] Starting dynamic subtest: rcs0
[513.524306] Dynamic subtest rcs0: SUCCESS (0.076s)
[513.537327] Starting dynamic subtest: bcs0
[513.572064] Dynamic subtest bcs0: SUCCESS (0.045s)
[513.583259] Starting dynamic subtest: vcs0
[513.616989] Dynamic subtest vcs0: SUCCESS (0.043s)
[513.625975] Starting dynamic subtest: vcs1
[513.661029] Dynamic subtest vcs1: SUCCESS (0.043s)
[513.672132] Starting dynamic subtest: vecs0
[513.705229] Dynamic subtest vecs0: SUCCESS (0.042s)
[513.714784] Starting dynamic subtest: ccs0
[513.752077] Dynamic subtest ccs0: SUCCESS (0.045s)
[513.753756] Subtest engines-basic: SUCCESS (0.305s)
[513.799890] [105/133] (519s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[513.925219] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[513.928862] Starting dynamic subtest: pipe-A-eDP-1
[513.938593] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[513.947602] Starting dynamic subtest: pipe-B-eDP-1
[513.955926] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[513.967100] Starting dynamic subtest: pipe-C-eDP-1
[513.976627] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[513.984625] Starting dynamic subtest: pipe-D-eDP-1
[513.992872] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[513.993804] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.016s)
[516.232612] [106/133] (517s left) perf_pmu (busy-check-all)
[516.269805] Starting subtest: busy-check-all
[516.270961] Starting dynamic subtest: rcs0
[516.838448] Dynamic subtest rcs0: SUCCESS (0.568s)
[516.852086] Starting dynamic subtest: bcs0
[517.388233] Dynamic subtest bcs0: SUCCESS (0.548s)
[517.401125] Starting dynamic subtest: vcs0
[519.470044] Dynamic subtest vcs0: SUCCESS (2.069s)
[519.479584] Starting dynamic subtest: vcs1
[521.454046] Dynamic subtest vcs1: SUCCESS (1.982s)
[521.463460] Starting dynamic subtest: vecs0
[523.438892] Dynamic subtest vecs0: SUCCESS (1.982s)
[523.448160] Starting dynamic subtest: ccs0
[523.986213] Dynamic subtest ccs0: SUCCESS (0.555s)
[523.987879] Subtest busy-check-all: SUCCESS (7.719s)
[524.074852] [107/133] (509s left) gem_exec_schedule (submit-early-slice)
[524.133808] Starting subtest: submit-early-slice
[524.134830] Starting dynamic subtest: rcs0
[524.192324] Dynamic subtest rcs0: SUCCESS (0.057s)
[524.204122] Starting dynamic subtest: bcs0
[524.245144] Dynamic subtest bcs0: SUCCESS (0.052s)
[524.259146] Starting dynamic subtest: vcs0
[524.313866] Dynamic subtest vcs0: SUCCESS (0.067s)
[524.325674] Starting dynamic subtest: vcs1
[524.371842] Dynamic subtest vcs1: SUCCESS (0.057s)
[524.383168] Starting dynamic subtest: vecs0
[524.431710] Dynamic subtest vecs0: SUCCESS (0.059s)
[524.443257] Starting dynamic subtest: ccs0
[524.480806] Dynamic subtest ccs0: SUCCESS (0.048s)
[524.482328] Subtest submit-early-slice: SUCCESS (0.347s)
[525.577232] [108/133] (507s left) gem_exec_balancer (parallel-bb-first)
[525.846805] Starting subtest: parallel-bb-first
[526.823569] Subtest parallel-bb-first: SUCCESS (0.979s)
[527.474611] [109/133] (506s left) gen9_exec_parse (bb-large)
[527.527123] Subtest bb-large: SKIP (0.000s)
[527.615786] [110/133] (506s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[527.712514] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[527.713589] Starting dynamic subtest: pipe-A-eDP-1
[527.737536] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[527.748201] Starting dynamic subtest: pipe-B-eDP-1
[527.770374] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[527.779454] Starting dynamic subtest: pipe-C-eDP-1
[527.802879] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[527.812072] Starting dynamic subtest: pipe-D-eDP-1
[527.838166] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[527.839881] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.009s)
[529.995861] [111/133] (503s left) api_intel_bb (simple-bb-ctx)
[530.063977] Starting subtest: simple-bb-ctx
[530.070954] Subtest simple-bb-ctx: SUCCESS (0.008s)
[530.140778] [112/133] (503s left) gem_ctx_isolation (preservation-s3)
[530.206075] Starting subtest: preservation-S3
[530.207733] Starting dynamic subtest: rcs0
[546.806437] Dynamic subtest rcs0: SUCCESS (1.761s)
[546.823343] Starting dynamic subtest: bcs0
[563.805825] Dynamic subtest bcs0: SUCCESS (1.706s)
[563.817376] Starting dynamic subtest: vcs0
[580.822491] Dynamic subtest vcs0: SUCCESS (3.272s)
[580.832586] Starting dynamic subtest: vcs1
[598.806918] Dynamic subtest vcs1: SUCCESS (4.927s)
[598.816774] Starting dynamic subtest: vecs0
[616.820960] Dynamic subtest vecs0: SUCCESS (5.048s)
[616.831091] Starting dynamic subtest: ccs0
[634.804728] Dynamic subtest ccs0: SUCCESS (3.135s)
[634.805583] Subtest preservation-S3: SUCCESS (19.856s)
[642.056921] [113/133] (398s left) sriov_basic (enable-vfs-autoprobe-on)
[642.113787] Starting subtest: enable-vfs-autoprobe-on
[642.115016] Starting dynamic subtest: numvfs-1
[642.145834] Dynamic subtest numvfs-1: FAIL (0.013s)
[642.154987] Starting dynamic subtest: numvfs-2
[642.181861] Dynamic subtest numvfs-2: FAIL (0.004s)
[642.190496] Starting dynamic subtest: numvfs-3
[642.216512] Dynamic subtest numvfs-3: FAIL (0.004s)
[642.224825] Starting dynamic subtest: numvfs-4
[642.250385] Dynamic subtest numvfs-4: FAIL (0.004s)
[642.258899] Starting dynamic subtest: numvfs-5
[642.287799] Dynamic subtest numvfs-5: FAIL (0.004s)
[642.296897] Starting dynamic subtest: numvfs-6
[642.322601] Dynamic subtest numvfs-6: FAIL (0.004s)
[642.330248] Starting dynamic subtest: numvfs-7
[642.357479] Dynamic subtest numvfs-7: FAIL (0.004s)
[642.366687] Starting dynamic subtest: numvfs-random
[642.392735] Dynamic subtest numvfs-random: FAIL (0.004s)
[642.400825] Starting dynamic subtest: numvfs-all
[642.429334] Dynamic subtest numvfs-all: FAIL (0.004s)
[642.430183] Subtest enable-vfs-autoprobe-on: FAIL (0.049s)
[642.460386] [114/133] (398s left) perf_pmu (gt-awake)
[642.497254] Starting subtest: gt-awake
[651.194950] Subtest gt-awake: SUCCESS (8.732s)
[651.257592] [115/133] (389s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[651.329628] Subtest no-spare-fences-busy: SKIP (0.000s)
[651.404783] [116/133] (389s left) kms_rotation_crc (primary-rotation-90)
[651.493680] Starting subtest: primary-rotation-90
[651.495354] Subtest primary-rotation-90: SKIP (0.001s)
[651.545968] [117/133] (389s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[651.660008] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[652.450200] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.792s)
[652.594058] [118/133] (388s left) gem_mmap_wc (write-prefaulted)
[652.650342] Subtest write-prefaulted: SKIP (0.000s)
[652.716150] [119/133] (388s left) gem_pxp (reject-modify-context-protection-off-1)
[652.843898] Starting subtest: reject-modify-context-protection-off-1
[652.844930] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[652.923523] [120/133] (388s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[653.006716] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[653.007591] Starting dynamic subtest: pipe-A-eDP-1
[653.029057] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.023s)
[653.038934] Starting dynamic subtest: pipe-B-eDP-1
[653.051840] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[653.061708] Starting dynamic subtest: pipe-C-eDP-1
[653.074849] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[653.084765] Starting dynamic subtest: pipe-D-eDP-1
[653.097999] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[653.098976] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.093s)
[655.222830] [121/133] (385s left) kms_plane_lowres (tiling-x)
[655.305744] Starting subtest: tiling-x
[655.306537] Starting dynamic subtest: pipe-A-eDP-1
[655.308103] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[655.599906] Starting dynamic subtest: pipe-B-eDP-1
[655.601365] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[655.609109] Starting dynamic subtest: pipe-C-eDP-1
[655.610744] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[655.620866] Starting dynamic subtest: pipe-D-eDP-1
[655.622464] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[655.624235] Subtest tiling-x: SKIP (0.294s)
[656.370895] [122/133] (384s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[656.466533] Starting subtest: multiplane-rotation-cropping-top
[673.831053] Subtest multiplane-rotation-cropping-top: SUCCESS (17.382s)
[673.920123] [123/133] (367s left) gem_mmap_gtt (basic-write-read-distinct)
[673.980976] Subtest basic-write-read-distinct: SKIP (0.000s)
[674.055659] [124/133] (367s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[674.139872] Starting subtest: fbc-psr2-sprite-mmap-gtt
[674.140831] Starting dynamic subtest: eDP-1
[674.142729] Dynamic subtest eDP-1: SKIP (0.000s)
[674.144547] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[674.186436] [125/133] (366s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[674.298716] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[674.300343] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[674.348005] [126/133] (366s left) gem_tiled_partial_pwrite_pread (writes)
[674.412907] Subtest writes: SKIP (0.000s)
[674.469805] [127/133] (366s left) kms_atomic (crtc-invalid-params-fence)
[674.561943] Starting subtest: crtc-invalid-params-fence
[674.562977] Starting dynamic subtest: pipe-A-eDP-1
[674.984895] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.422s)
[674.985729] Subtest crtc-invalid-params-fence: SUCCESS (0.423s)
[675.775220] [128/133] (365s left) gem_busy (parallel)
[675.971675] Starting subtest: parallel
[675.972752] Starting dynamic subtest: rcs0
[677.176637] Dynamic subtest rcs0: SUCCESS (1.202s)
[677.188109] Starting dynamic subtest: bcs0
[679.224830] Dynamic subtest bcs0: SUCCESS (2.045s)
[679.236173] Starting dynamic subtest: vcs0
[681.208882] Dynamic subtest vcs0: SUCCESS (1.981s)
[681.220268] Starting dynamic subtest: vcs1
[683.192960] Dynamic subtest vcs1: SUCCESS (1.981s)
[683.204220] Starting dynamic subtest: vecs0
[685.176944] Dynamic subtest vecs0: SUCCESS (1.981s)
[685.187946] Starting dynamic subtest: ccs0
[687.225159] Dynamic subtest ccs0: SUCCESS (2.045s)
[687.226522] Subtest parallel: SUCCESS (11.252s)
[687.422418] [129/133] (353s left) gem_ctx_persistence (processes)
[687.470360] Starting subtest: processes
[689.187865] Subtest processes: SUCCESS (1.716s)
[689.273501] [130/133] (352s left) kms_big_fb (4-tiled-addfb-size-overflow)
[689.368311] Starting subtest: 4-tiled-addfb-size-overflow
[689.369177] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[689.448806] [131/133] (351s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[689.544724] Starting subtest: x-tiled-64bpp-rotate-270
[689.567688] Subtest x-tiled-64bpp-rotate-270: SKIP (0.022s)
[689.665771] [132/133] (351s left) kms_plane_scaling (planes-scaler-unity-scaling)
[689.752933] Starting subtest: planes-scaler-unity-scaling
[689.753883] Starting dynamic subtest: pipe-A
[689.816012] Dynamic subtest pipe-A: SUCCESS (0.064s)
[689.827477] Starting dynamic subtest: pipe-B
[690.930202] Dynamic subtest pipe-B: SUCCESS (1.113s)
[690.945971] Starting dynamic subtest: pipe-C
[692.044524] Dynamic subtest pipe-C: SUCCESS (1.112s)
[692.053734] Starting dynamic subtest: pipe-D
[693.180026] Dynamic subtest pipe-D: SUCCESS (1.135s)
[693.180975] Subtest planes-scaler-unity-scaling: SUCCESS (3.429s)
[694.331723] [133/133] (347s left) gem_exec_whisper (basic-contexts)
[694.382034] Starting subtest: basic-contexts
[700.317310] Subtest basic-contexts: SUCCESS (5.935s)
[700.474693] 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.