[63.419743] Initializing watchdogs
[63.419823]   /dev/watchdog0
[63.451036] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[63.465788] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[63.470718] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.473809] [001/156] (960s left) kms_pm_dc (dc5-dpms)
[65.971678] Starting subtest: dc5-dpms
[67.282358] Subtest dc5-dpms: SUCCESS (1.312s)
[67.395565] [002/156] (956s left) i915_query (query-regions-unallocated)
[67.453430] Starting subtest: query-regions-unallocated
[67.942656] Subtest query-regions-unallocated: SUCCESS (0.491s)
[68.042482] [003/156] (956s left) kms_frontbuffer_tracking (psrhdr-shrfb-scaledprimary)
[69.531413] Starting subtest: psrhdr-shrfb-scaledprimary
[69.533108] Subtest psrhdr-shrfb-scaledprimary: SKIP (0.000s)
[69.678842] [004/156] (954s left) i915_fb_tiling (basic-x-tiling)
[69.736972] Subtest basic-x-tiling: SKIP (0.000s)
[69.811107] [005/156] (954s left) gem_exec_whisper (basic-contexts-forked)
[69.872995] Starting subtest: basic-contexts-forked
[84.063191] Subtest basic-contexts-forked: SUCCESS (14.206s)
[84.389484] [006/156] (939s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[85.880683] Starting subtest: flip-vs-cursor-busy-crc-legacy
[86.525048] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.645s)
[86.715275] [007/156] (937s left) syncobj_wait (invalid-wait-illegal-handle)
[86.762181] Starting subtest: invalid-wait-illegal-handle
[86.762986] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[86.863791] [008/156] (937s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[88.357118] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[88.376250] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.019s)
[88.490753] [009/156] (936s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[90.000440] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[90.002184] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[90.191755] [010/156] (934s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-move)
[91.704803] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-move
[91.706841] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[91.902412] [011/156] (932s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[93.403320] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[93.405060] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[93.576966] [012/156] (931s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[95.072907] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[95.075196] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[95.263840] [013/156] (929s left) kms_cursor_crc (cursor-offscreen-64x21)
[96.914226] Starting subtest: cursor-offscreen-64x21
[96.920170] Starting dynamic subtest: pipe-A-HDMI-A-3
[99.425550] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.505s)
[99.460103] Starting dynamic subtest: pipe-D-HDMI-A-3
[101.856977] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.406s)
[101.857867] Subtest cursor-offscreen-64x21: SUCCESS (4.942s)
[102.324388] [014/156] (922s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[103.820110] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[103.822127] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[104.001697] [015/156] (921s left) gem_userptr_blits (sd-probe)
[104.054540] Starting subtest: sd-probe
[104.056213] Subtest sd-probe: SKIP (0.000s)
[104.299092] [016/156] (921s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[105.784555] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[105.786381] Starting dynamic subtest: pipe-A-HDMI-A-3
[105.795988] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s)
[105.805422] Starting dynamic subtest: pipe-B-HDMI-A-3
[105.814966] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s)
[105.824152] Starting dynamic subtest: pipe-C-HDMI-A-3
[105.833495] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s)
[105.842510] Starting dynamic subtest: pipe-D-HDMI-A-3
[105.851864] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s)
[105.853689] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SKIP (0.008s)
[106.080858] [017/156] (919s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[107.582760] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc
[107.584505] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[107.740945] [018/156] (917s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[109.289769] Starting subtest: dp-mst-lic-type-0-hdcp14
[109.292273] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[109.502440] [019/156] (916s left) gem_shrink (reclaim)
[109.555472] Starting subtest: reclaim
[111.801257] Subtest reclaim: SUCCESS (2.239s)
[111.903642] [020/156] (913s left) gem_ctx_engines (independent)
[111.968891] Starting subtest: independent
[111.969829] Starting dynamic subtest: rcs0
[112.161440] Dynamic subtest rcs0: SUCCESS (0.193s)
[112.170871] Starting dynamic subtest: bcs0
[112.347248] Dynamic subtest bcs0: SUCCESS (0.186s)
[112.356437] Starting dynamic subtest: vcs0
[112.541813] Dynamic subtest vcs0: SUCCESS (0.194s)
[112.551358] Starting dynamic subtest: vcs1
[112.738485] Dynamic subtest vcs1: SUCCESS (0.196s)
[112.747965] Starting dynamic subtest: vecs0
[112.930798] Dynamic subtest vecs0: SUCCESS (0.192s)
[112.940365] Starting dynamic subtest: all-engines
[113.221496] Dynamic subtest all-engines: SUCCESS (0.289s)
[113.222677] Subtest independent: SUCCESS (1.252s)
[113.838742] [021/156] (911s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[115.328309] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[115.402265] [022/156] (910s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-blt)
[116.897415] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-blt
[116.899059] Subtest hdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[117.110783] [023/156] (908s left) gem_mmap_gtt (cpuset-basic-small-copy)
[117.157506] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[117.230124] [024/156] (908s left) i915_drm_fdinfo (busy-hang)
[117.280912] Starting subtest: busy-hang
[117.281834] Starting dynamic subtest: rcs0
[117.283547] Dynamic subtest rcs0: SKIP (0.001s)
[117.293106] Starting dynamic subtest: bcs0
[117.294903] Dynamic subtest bcs0: SKIP (0.001s)
[117.304481] Starting dynamic subtest: vcs0
[117.306580] Dynamic subtest vcs0: SKIP (0.001s)
[117.316148] Starting dynamic subtest: vcs1
[117.318200] Dynamic subtest vcs1: SKIP (0.001s)
[117.328920] Starting dynamic subtest: vecs0
[117.330850] Dynamic subtest vecs0: SKIP (0.001s)
[117.333088] Subtest busy-hang: SKIP (0.005s)
[117.388942] [025/156] (908s left) gem_mmap_gtt (big-copy-xy)
[117.434202] Subtest big-copy-XY: SKIP (0.000s)
[117.512581] [026/156] (908s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[119.082611] Starting subtest: cursor-rapid-movement-32x32
[119.134909] Subtest cursor-rapid-movement-32x32: SKIP (0.050s)
[119.524028] [027/156] (906s left) kms_frontbuffer_tracking (hdr-2p-primscrn-indfb-pgflip-blt)
[121.018596] Starting subtest: hdr-2p-primscrn-indfb-pgflip-blt
[121.020636] Subtest hdr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[121.177110] [028/156] (905s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[122.677397] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[122.679183] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[122.805454] [029/156] (903s left) syncobj_timeline (reset-multiple-signaled)
[122.867942] Starting subtest: reset-multiple-signaled
[122.870113] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[122.969583] [030/156] (903s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-render)
[124.462566] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-render
[124.464762] Subtest psrhdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[124.626440] [031/156] (901s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[126.129623] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[126.131344] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[126.288700] [032/156] (900s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[127.812606] Starting subtest: x-tiled-64bpp-rotate-90
[127.882898] Subtest x-tiled-64bpp-rotate-90: SKIP (0.069s)
[128.073604] [033/156] (898s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[129.562951] Starting subtest: basic-busy-flip-before-cursor-atomic
[129.564664] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[129.684559] [034/156] (897s left) gem_ctx_sseu (mmap-args)
[129.749501] Subtest mmap-args: SKIP (0.000s)
[129.814142] [035/156] (897s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[131.301654] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[131.303636] Starting dynamic subtest: pipe-A-HDMI-A-3
[131.313161] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s)
[131.322482] Starting dynamic subtest: pipe-B-HDMI-A-3
[131.331517] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s)
[131.340972] Starting dynamic subtest: pipe-C-HDMI-A-3
[131.351090] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s)
[131.360488] Starting dynamic subtest: pipe-D-HDMI-A-3
[131.373122] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s)
[131.374705] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SKIP (0.009s)
[131.563730] [036/156] (895s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[133.058964] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[133.061344] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[133.220512] [037/156] (893s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[134.719246] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[134.720944] Subtest hdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[134.891891] [038/156] (892s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-move)
[136.389914] Starting subtest: fbchdr-2p-primscrn-cur-indfb-move
[136.392221] Subtest fbchdr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[136.533509] [039/156] (890s left) gem_ctx_persistence (heartbeat-hang)
[136.585251] Starting subtest: heartbeat-hang
[136.587207] Subtest heartbeat-hang: SKIP (0.000s)
[136.708879] [040/156] (890s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[138.215979] Starting subtest: 4-tiled-8bpp-rotate-0
[138.218108] Subtest 4-tiled-8bpp-rotate-0: SKIP (0.000s)
[138.406738] [041/156] (889s left) gem_exec_reloc (basic-cpu-noreloc)
[138.458168] Subtest basic-cpu-noreloc: SKIP (0.000s)
[138.541616] [042/156] (888s left) gem_exec_balancer (sliced)
[138.597503] Starting subtest: sliced
[138.599496] Subtest sliced: SKIP (0.000s)
[139.012175] [043/156] (888s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[140.506619] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[143.021214] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (2.516s)
[143.219510] [044/156] (884s left) gem_lmem_swapping (parallel-multi)
[147.565698] Starting subtest: parallel-multi
[147.566619] Starting dynamic subtest: lmem0
[202.214743] Dynamic subtest lmem0: SUCCESS (54.656s)
[202.215850] Subtest parallel-multi: SUCCESS (54.657s)
[203.141192] [FACT gem_lmem_swapping (parallel-multi)] deleted: kernel.kmod_is_loaded.i915: true
[203.143561] [045/156] (824s left) gem_ppgtt (blt-vs-render-ctx0)
[206.517102] Starting subtest: blt-vs-render-ctx0
[239.417734] Subtest blt-vs-render-ctx0: SUCCESS (32.899s)
[239.600503] [FACT gem_ppgtt (blt-vs-render-ctx0)] new: kernel.kmod_is_loaded.i915: true
[239.608397] [046/156] (788s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[241.153821] Starting subtest: plane-scaler-unity-scaling-with-rotation
[241.154786] Starting dynamic subtest: pipe-A
[241.574814] Dynamic subtest pipe-A: SKIP (0.419s)
[241.585174] Starting dynamic subtest: pipe-B
[242.028230] Dynamic subtest pipe-B: SKIP (0.453s)
[242.038557] Starting dynamic subtest: pipe-C
[242.487229] Dynamic subtest pipe-C: SKIP (0.458s)
[242.497651] Starting dynamic subtest: pipe-D
[242.944138] Dynamic subtest pipe-D: SKIP (0.456s)
[242.946030] Subtest plane-scaler-unity-scaling-with-rotation: SKIP (1.789s)
[243.141258] [047/156] (784s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[243.199440] Starting subtest: single-wait-for-submit-unsubmitted
[243.310128] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[243.407315] [048/156] (784s left) kms_frontbuffer_tracking (hdr-rgb565-draw-render)
[244.903630] Starting subtest: hdr-rgb565-draw-render
[244.905225] Subtest hdr-rgb565-draw-render: SKIP (0.000s)
[245.113954] [049/156] (782s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[246.669434] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[246.799827] [050/156] (781s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[248.295038] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc
[248.296853] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[248.459923] [051/156] (779s left) gem_busy (parallel)
[248.717694] Starting subtest: parallel
[248.718640] Starting dynamic subtest: rcs0
[248.819715] Dynamic subtest rcs0: SUCCESS (0.101s)
[248.839821] Starting dynamic subtest: bcs0
[248.884962] Dynamic subtest bcs0: SUCCESS (0.063s)
[248.909979] Starting dynamic subtest: vcs0
[248.953840] Dynamic subtest vcs0: SUCCESS (0.067s)
[248.980304] Starting dynamic subtest: vcs1
[249.023231] Dynamic subtest vcs1: SUCCESS (0.067s)
[249.047160] Starting dynamic subtest: vecs0
[249.092888] Dynamic subtest vecs0: SUCCESS (0.068s)
[249.094079] Subtest parallel: SUCCESS (0.376s)
[249.405652] [052/156] (778s left) syncobj_eventfd (invalid-illegal-eventfd)
[249.452910] Starting subtest: invalid-illegal-eventfd
[249.453903] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[249.553411] [053/156] (778s left) syncobj_wait (wait-any-interrupted)
[249.599901] Starting subtest: wait-any-interrupted
[249.711616] Subtest wait-any-interrupted: SUCCESS (0.107s)
[249.830671] [054/156] (778s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[251.323779] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[251.325501] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[251.515221] [055/156] (777s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[253.011595] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[253.014058] Subtest fbchdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[253.159808] [056/156] (775s left) kms_color_pipeline (plane-lut1d-lut1d)
[254.652904] Starting subtest: plane-lut1d-lut1d
[254.877961] Starting dynamic subtest: pipe-A-plane-0
[255.125883] Dynamic subtest pipe-A-plane-0: SUCCESS (0.248s)
[255.166508] Starting dynamic subtest: pipe-A-plane-1
[255.325877] Dynamic subtest pipe-A-plane-1: SUCCESS (0.195s)
[255.362686] Starting dynamic subtest: pipe-A-plane-2
[255.525887] Dynamic subtest pipe-A-plane-2: SUCCESS (0.195s)
[255.833529] Starting dynamic subtest: pipe-B-plane-0
[255.989233] Dynamic subtest pipe-B-plane-0: SUCCESS (0.167s)
[256.024487] Starting dynamic subtest: pipe-B-plane-1
[256.190775] Dynamic subtest pipe-B-plane-1: SUCCESS (0.195s)
[256.223691] Starting dynamic subtest: pipe-B-plane-2
[256.389302] Dynamic subtest pipe-B-plane-2: SUCCESS (0.195s)
[256.728573] Starting dynamic subtest: pipe-C-plane-0
[256.912545] Dynamic subtest pipe-C-plane-0: SUCCESS (0.214s)
[256.951630] Starting dynamic subtest: pipe-C-plane-1
[257.129155] Dynamic subtest pipe-C-plane-1: SUCCESS (0.211s)
[257.160263] Starting dynamic subtest: pipe-C-plane-2
[257.345911] Dynamic subtest pipe-C-plane-2: SUCCESS (0.211s)
[257.696975] Starting dynamic subtest: pipe-D-plane-0
[257.879249] Dynamic subtest pipe-D-plane-0: SUCCESS (0.199s)
[257.910568] Starting dynamic subtest: pipe-D-plane-1
[258.095998] Dynamic subtest pipe-D-plane-1: SUCCESS (0.211s)
[258.129860] Starting dynamic subtest: pipe-D-plane-2
[258.311647] Dynamic subtest pipe-D-plane-2: SUCCESS (0.211s)
[258.349988] Subtest plane-lut1d-lut1d: SUCCESS (3.697s)
[258.550814] [057/156] (770s left) kms_flip (plain-flip-ts-check)
[260.041653] Starting subtest: plain-flip-ts-check
[260.048861] Starting dynamic subtest: A-HDMI-A3
[268.133263] Dynamic subtest A-HDMI-A3: SUCCESS (8.085s)
[268.147233] Starting dynamic subtest: B-HDMI-A3
[276.130987] Dynamic subtest B-HDMI-A3: SUCCESS (7.995s)
[276.145967] Starting dynamic subtest: C-HDMI-A3
[284.131518] Dynamic subtest C-HDMI-A3: SUCCESS (7.996s)
[284.144176] Starting dynamic subtest: D-HDMI-A3
[292.135662] Dynamic subtest D-HDMI-A3: SUCCESS (8.002s)
[292.144863] Subtest plain-flip-ts-check: SUCCESS (32.104s)
[292.372934] [058/156] (736s left) kms_chamelium_frames (hdmi-crc-single)
[293.915439] Subtest hdmi-crc-single: SKIP (0.000s)
[294.044781] [059/156] (734s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[295.534301] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[295.535211] Starting dynamic subtest: pipe-A-HDMI-A-3
[295.543450] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[295.554363] Starting dynamic subtest: pipe-B-HDMI-A-3
[295.563041] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[295.573815] Starting dynamic subtest: pipe-C-HDMI-A-3
[295.582273] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[295.592878] Starting dynamic subtest: pipe-D-HDMI-A-3
[295.601570] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[295.603187] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SKIP (0.009s)
[295.836124] [060/156] (733s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[297.349094] Starting subtest: yf-tiled-8bpp-rotate-180
[297.350844] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[297.516271] [061/156] (731s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-pwrite)
[299.011431] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-pwrite
[299.013183] Subtest hdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[299.206360] [062/156] (729s left) kms_plane_multiple (tiling-4)
[300.695135] Starting subtest: tiling-4
[300.697288] Subtest tiling-4: SKIP (0.000s)
[300.843424] [063/156] (728s left) sysfs_timeslice_duration (invalid)
[300.909886] Starting subtest: invalid
[300.912469] Starting dynamic subtest: vecs0
[300.913464] Dynamic subtest vecs0: SUCCESS (0.000s)
[300.924850] Starting dynamic subtest: vcs0
[300.926108] Dynamic subtest vcs0: SUCCESS (0.000s)
[300.936716] Starting dynamic subtest: bcs0
[300.937675] Dynamic subtest bcs0: SUCCESS (0.000s)
[300.948072] Starting dynamic subtest: rcs0
[300.949058] Dynamic subtest rcs0: SUCCESS (0.001s)
[300.959814] Starting dynamic subtest: vcs1
[300.961134] Dynamic subtest vcs1: SUCCESS (0.001s)
[300.962432] Subtest invalid: SUCCESS (0.010s)
[301.042991] [064/156] (728s left) gem_ctx_param (set-priority-range)
[301.088971] Starting subtest: set-priority-range
[301.111831] Subtest set-priority-range: SUCCESS (0.024s)
[301.282463] [065/156] (728s left) api_intel_bb (add-remove-objects)
[301.328974] Starting subtest: add-remove-objects
[301.351351] Subtest add-remove-objects: SUCCESS (0.023s)
[301.512166] [066/156] (728s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[303.021508] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[303.581551] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.561s)
[303.868431] [067/156] (725s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[305.359217] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[305.360123] Starting dynamic subtest: pipe-A
[305.539185] Dynamic subtest pipe-A: SUCCESS (0.180s)
[305.564089] Starting dynamic subtest: pipe-B
[305.731960] Dynamic subtest pipe-B: SUCCESS (0.191s)
[305.744124] Starting dynamic subtest: pipe-C
[305.889833] Dynamic subtest pipe-C: SUCCESS (0.157s)
[305.901820] Starting dynamic subtest: pipe-D
[306.047330] Dynamic subtest pipe-D: SUCCESS (0.156s)
[306.048248] Subtest planes-unity-scaling-downscale-factor-0-5: SUCCESS (0.689s)
[306.259548] [068/156] (723s left) gem_ctx_isolation (preservation-s3)
[306.318196] Starting subtest: preservation-S3
[306.319135] Starting dynamic subtest: rcs0
[332.635819] Dynamic subtest rcs0: SUCCESS (10.763s)
[332.650223] Starting dynamic subtest: bcs0
[359.597197] Dynamic subtest bcs0: SUCCESS (10.511s)
[359.609835] Starting dynamic subtest: vcs0
[386.591188] Dynamic subtest vcs0: SUCCESS (10.452s)
[386.607950] Starting dynamic subtest: vcs1
[413.557147] Dynamic subtest vcs1: SUCCESS (10.460s)
[413.571892] Starting dynamic subtest: vecs0
[440.551879] Dynamic subtest vecs0: SUCCESS (10.472s)
[440.552741] Subtest preservation-S3: SUCCESS (52.665s)
[446.879779] [069/156] (588s left) kms_cursor_crc (cursor-sliding-256x85)
[448.658125] Starting subtest: cursor-sliding-256x85
[448.663422] Starting dynamic subtest: pipe-A-HDMI-A-3
[453.259363] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.501s)
[453.297349] Starting dynamic subtest: pipe-D-HDMI-A-3
[457.640197] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.303s)
[457.641336] Subtest cursor-sliding-256x85: SUCCESS (8.837s)
[457.968066] [070/156] (577s left) kms_draw_crc (draw-method-blt)
[459.470673] Starting subtest: draw-method-blt
[459.471534] Starting dynamic subtest: xrgb8888-untiled
[459.870622] Dynamic subtest xrgb8888-untiled: SUCCESS (0.396s)
[459.918007] Starting dynamic subtest: rgb565-untiled
[460.242199] Dynamic subtest rgb565-untiled: SUCCESS (0.362s)
[460.286819] Starting dynamic subtest: xrgb2101010-untiled
[460.541539] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.290s)
[460.558622] Starting dynamic subtest: xbgr16161616f-untiled
[460.860205] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.311s)
[460.908648] Starting dynamic subtest: xrgb8888-xtiled
[461.044651] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.176s)
[461.094024] Starting dynamic subtest: rgb565-xtiled
[461.230219] Dynamic subtest rgb565-xtiled: SUCCESS (0.176s)
[461.276132] Starting dynamic subtest: xrgb2101010-xtiled
[461.396464] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.159s)
[461.442529] Starting dynamic subtest: xbgr16161616f-xtiled
[461.564348] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.159s)
[461.612760] Starting dynamic subtest: xrgb8888-ytiled
[461.748655] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.176s)
[461.798112] Starting dynamic subtest: rgb565-ytiled
[461.933049] Dynamic subtest rgb565-ytiled: SUCCESS (0.176s)
[461.976588] Starting dynamic subtest: xrgb2101010-ytiled
[462.100535] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.159s)
[462.150016] Starting dynamic subtest: xbgr16161616f-ytiled
[462.266347] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.159s)
[462.267489] Subtest draw-method-blt: SUCCESS (2.780s)
[462.454101] [071/156] (573s left) core_getclient (basic)
[462.504924] Starting subtest: basic
[462.505776] Subtest basic: SUCCESS (0.000s)
[462.628503] [072/156] (573s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[464.124675] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[464.125562] Starting dynamic subtest: pipe-A-valid-mode
[465.126283] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.996s)
[465.127193] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SUCCESS (0.999s)
[465.334068] [073/156] (570s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[466.835317] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[466.837558] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[467.004986] [074/156] (569s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-mmap-wc)
[468.508882] Starting subtest: psrhdr-rgb101010-draw-mmap-wc
[468.510640] Subtest psrhdr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[468.696720] [075/156] (567s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[468.744433] Starting subtest: invalid-multi-wait-unsubmitted
[468.745333] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[468.866661] [076/156] (567s left) gem_pxp (reject-modify-context-protection-off-2)
[471.441300] Starting subtest: reject-modify-context-protection-off-2
[471.443400] Subtest reject-modify-context-protection-off-2: SKIP (0.000s)
[471.546179] [077/156] (564s left) prime_vgem (basic-fence-flip)
[471.685518] Starting subtest: basic-fence-flip
[473.146547] Subtest basic-fence-flip: SKIP (1.458s)
[473.316647] [FACT prime_vgem (basic-fence-flip)] new: kernel.kmod_is_loaded.vgem: true
[473.319689] [078/156] (563s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[473.374517] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[473.375560] Starting dynamic subtest: smem
[473.471175] Dynamic subtest smem: SUCCESS (0.096s)
[473.485884] Starting dynamic subtest: lmem0
[474.407958] Dynamic subtest lmem0: SUCCESS (0.930s)
[474.409086] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SUCCESS (1.028s)
[474.687528] [079/156] (561s left) kms_joiner (invalid-modeset-ultra-joiner)
[476.180730] Starting subtest: invalid-modeset-ultra-joiner
[476.182511] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[476.336969] [080/156] (560s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-blt)
[477.836516] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-blt
[477.838202] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[478.024816] [081/156] (558s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[479.537056] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[480.788238] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.250s)
[481.069925] [082/156] (555s left) dumb_buffer (invalid-bpp)
[481.116509] Starting subtest: invalid-bpp
[481.117441] Subtest invalid-bpp: SUCCESS (0.000s)
[481.224388] [083/156] (555s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[482.717523] Starting subtest: multiplane-rotation-cropping-top
[531.200483] Subtest multiplane-rotation-cropping-top: SUCCESS (48.457s)
[531.378903] [084/156] (505s left) gem_mmap_offset (clear)
[531.433820] Starting subtest: clear
[531.434884] Starting dynamic subtest: lmem0
[553.213380] Dynamic subtest lmem0: SUCCESS (21.764s)
[553.226500] Starting dynamic subtest: smem0
[579.361591] Dynamic subtest smem0: SUCCESS (26.182s)
[579.363685] Subtest clear: SUCCESS (47.949s)
[579.736698] [085/156] (457s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[581.279168] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[581.281701] Starting dynamic subtest: pipe-A-HDMI-A-3
[581.291193] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[581.304738] Starting dynamic subtest: pipe-B-HDMI-A-3
[581.314167] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[581.327486] Starting dynamic subtest: pipe-C-HDMI-A-3
[581.337346] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[581.350579] Starting dynamic subtest: pipe-D-HDMI-A-3
[581.360387] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[581.362289] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.010s)
[581.628923] [086/156] (455s left) kms_psr (psr2-cursor-render)
[583.121699] Subtest psr2-cursor-render: SKIP (0.000s)
[583.200343] [087/156] (454s left) gen7_exec_parse (cmd-crossing-page)
[583.254046] Subtest cmd-crossing-page: SKIP (0.000s)
[583.333496] [088/156] (454s left) gem_exec_fence (syncobj-export)
[583.810857] Starting subtest: syncobj-export
[583.831158] Subtest syncobj-export: SUCCESS (0.022s)
[584.262305] [089/156] (453s left) kms_busy (extended-pageflip-hang-newfb)
[585.757946] Starting subtest: extended-pageflip-hang-newfb
[585.759080] Starting dynamic subtest: pipe-A
[593.602442] Dynamic subtest pipe-A: SUCCESS (7.848s)
[593.619888] Starting dynamic subtest: pipe-D
[601.401377] Dynamic subtest pipe-D: SUCCESS (7.796s)
[601.402310] Subtest extended-pageflip-hang-newfb: SUCCESS (15.652s)
[601.643382] [090/156] (435s left) syncobj_timeline (wait-for-submit-snapshot)
[601.704936] Starting subtest: wait-for-submit-snapshot
[601.787003] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[601.953747] [091/156] (435s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-msflip-blt)
[603.450899] Starting subtest: psrhdr-2p-scndscrn-indfb-msflip-blt
[603.453061] Subtest psrhdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[603.625751] [092/156] (434s left) kms_flip (basic-plain-flip)
[605.118066] Starting subtest: basic-plain-flip
[605.124576] Starting dynamic subtest: A-HDMI-A3
[605.875199] Dynamic subtest A-HDMI-A3: SUCCESS (0.751s)
[605.890515] Starting dynamic subtest: B-HDMI-A3
[606.589506] Dynamic subtest B-HDMI-A3: SUCCESS (0.713s)
[606.605587] Starting dynamic subtest: C-HDMI-A3
[607.306449] Dynamic subtest C-HDMI-A3: SUCCESS (0.715s)
[607.322348] Starting dynamic subtest: D-HDMI-A3
[608.024832] Dynamic subtest D-HDMI-A3: SUCCESS (0.716s)
[608.027574] Subtest basic-plain-flip: SUCCESS (2.911s)
[608.275043] [093/156] (429s left) gem_exec_schedule (preempt-other)
[608.340819] Starting subtest: preempt-other
[608.341725] Starting dynamic subtest: rcs0
[608.472429] Dynamic subtest rcs0: SUCCESS (0.128s)
[608.486250] Starting dynamic subtest: bcs0
[608.578411] Dynamic subtest bcs0: SUCCESS (0.109s)
[608.593921] Starting dynamic subtest: vcs0
[608.689993] Dynamic subtest vcs0: SUCCESS (0.110s)
[608.705096] Starting dynamic subtest: vcs1
[608.801360] Dynamic subtest vcs1: SUCCESS (0.110s)
[608.816427] Starting dynamic subtest: vecs0
[608.911903] Dynamic subtest vecs0: SUCCESS (0.109s)
[608.912885] Subtest preempt-other: SUCCESS (0.573s)
[609.411553] [094/156] (428s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[610.916160] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[610.917878] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[611.115230] [095/156] (427s left) kms_flip (flip-vs-panning-interruptible)
[612.615875] Starting subtest: flip-vs-panning-interruptible
[612.623375] Starting dynamic subtest: A-HDMI-A3
[620.378033] Dynamic subtest A-HDMI-A3: SUCCESS (7.755s)
[620.412292] Starting dynamic subtest: B-HDMI-A3
[628.091887] Dynamic subtest B-HDMI-A3: SUCCESS (7.709s)
[628.130365] Starting dynamic subtest: C-HDMI-A3
[635.858480] Dynamic subtest C-HDMI-A3: SUCCESS (7.762s)
[635.894111] Starting dynamic subtest: D-HDMI-A3
[643.574834] Dynamic subtest D-HDMI-A3: SUCCESS (7.710s)
[643.582776] Subtest flip-vs-panning-interruptible: SUCCESS (30.969s)
[643.862345] [096/156] (394s left) gem_madvise (dontneed-before-exec)
[643.906152] Starting subtest: dontneed-before-exec
[643.909278] Subtest dontneed-before-exec: SKIP (0.003s)
[644.015585] [097/156] (394s left) gem_sync (basic-store-each)
[644.074951] Starting subtest: basic-store-each
[646.231326] Subtest basic-store-each: SUCCESS (2.156s)
[646.550035] [098/156] (391s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[648.044060] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[648.128401] [099/156] (390s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-blt)
[649.623527] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-blt
[649.625284] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[649.831534] [100/156] (388s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-render)
[651.334551] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-render
[651.337280] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[651.520403] [101/156] (387s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[653.016170] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[653.017960] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[653.194720] [102/156] (385s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[654.685192] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[654.760695] [103/156] (384s left) gem_tiled_blits (basic)
[654.813999] Subtest basic: SKIP (0.000s)
[654.894981] [104/156] (384s left) gem_softpin (noreloc-interruptible)
[654.951275] Starting subtest: noreloc-interruptible
[660.411090] Subtest noreloc-interruptible: SUCCESS (5.456s)
[660.615228] [105/156] (378s left) gem_exec_flush (basic-wb-rw-default)
[660.667799] Subtest basic-wb-rw-default: SKIP (0.000s)
[660.760725] [106/156] (378s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[660.815465] Subtest tiled-to-tiled: SKIP (0.000s)
[660.893940] [107/156] (378s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-pwrite)
[662.390160] Starting subtest: fbcpsrhdr-rgb101010-draw-pwrite
[662.392023] Subtest fbcpsrhdr-rgb101010-draw-pwrite: SKIP (0.000s)
[662.560641] [108/156] (376s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[664.055287] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[664.057291] Subtest fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[664.221188] [109/156] (375s left) gem_softpin (evict-snoop-interruptible)
[664.278109] Starting subtest: evict-snoop-interruptible
[664.280438] Subtest evict-snoop-interruptible: SKIP (0.000s)
[664.408703] [110/156] (375s left) kms_cdclk (plane-scaling)
[664.456063] Subtest plane-scaling: SKIP (0.000s)
[664.550846] [111/156] (375s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[666.041543] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[666.043391] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[666.155850] [112/156] (373s left) kms_lease (simple-lease)
[667.652595] Starting subtest: simple-lease
[667.653526] Starting dynamic subtest: pipe-A-HDMI-A-3
[668.068276] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.414s)
[668.083350] Starting dynamic subtest: pipe-B-HDMI-A-3
[668.372037] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.301s)
[668.387291] Starting dynamic subtest: pipe-C-HDMI-A-3
[668.690010] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.316s)
[668.705178] Starting dynamic subtest: pipe-D-HDMI-A-3
[669.011693] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.320s)
[669.012539] Subtest simple-lease: SUCCESS (1.361s)
[669.238290] [113/156] (370s left) syncobj_timeline (invalid-signal-bad-pad)
[669.286883] Starting subtest: invalid-signal-bad-pad
[669.287785] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[669.395097] [114/156] (370s left) kms_atomic (atomic-invalid-params)
[670.886594] Starting subtest: atomic-invalid-params
[670.887513] Starting dynamic subtest: pipe-A-HDMI-A-3
[671.281276] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.394s)
[671.282184] Subtest atomic-invalid-params: SUCCESS (0.397s)
[671.500431] [115/156] (368s left) kms_plane_lowres (tiling-x)
[672.991032] Starting subtest: tiling-x
[672.993551] Starting dynamic subtest: pipe-A-HDMI-A-3
[682.972478] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (9.980s)
[683.059399] Starting dynamic subtest: pipe-B-HDMI-A-3
[692.753365] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (9.707s)
[692.857139] Starting dynamic subtest: pipe-C-HDMI-A-3
[702.672933] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (9.829s)
[702.758723] Starting dynamic subtest: pipe-D-HDMI-A-3
[712.633415] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (9.887s)
[712.722883] Subtest tiling-x: SUCCESS (39.731s)
[712.941042] [116/156] (327s left) kms_psr (psr-cursor-plane-move)
[714.432788] Subtest psr-cursor-plane-move: SKIP (0.000s)
[714.512535] [117/156] (325s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[716.008048] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[716.009806] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[716.213045] [118/156] (324s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[717.716836] Starting subtest: fbc-shrfb-scaledprimary
[719.165923] Subtest fbc-shrfb-scaledprimary: SUCCESS (1.449s)
[719.456113] [119/156] (320s left) gem_eio (wait-1us)
[719.656731] Starting subtest: wait-1us
[720.147479] Subtest wait-1us: SUCCESS (0.491s)
[721.746037] [120/156] (318s left) kms_sequence (queue-idle)
[723.237718] Starting subtest: queue-idle
[723.238645] Starting dynamic subtest: pipe-A-HDMI-A-3
[725.639155] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.399s)
[725.653748] Starting dynamic subtest: pipe-B-HDMI-A-3
[727.867034] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (2.226s)
[727.884685] Starting dynamic subtest: pipe-C-HDMI-A-3
[730.097723] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (2.228s)
[730.113805] Starting dynamic subtest: pipe-D-HDMI-A-3
[732.356709] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.256s)
[732.357640] Subtest queue-idle: SUCCESS (9.120s)
[732.568628] [121/156] (307s left) kms_big_fb (linear-32bpp-rotate-90)
[734.085073] Starting subtest: linear-32bpp-rotate-90
[734.195171] Subtest linear-32bpp-rotate-90: SKIP (0.109s)
[734.343143] [122/156] (306s left) gem_fence_thrash (bo-write-verify-y)
[734.387759] Starting subtest: bo-write-verify-y
[734.392756] Subtest bo-write-verify-y: SKIP (0.003s)
[734.482950] [123/156] (306s left) kms_pm_rpm (system-suspend-modeset)
[738.601451] Starting subtest: system-suspend-modeset
[766.815410] Subtest system-suspend-modeset: SUCCESS (12.915s)
[770.815876] [124/156] (272s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[770.867519] Starting subtest: invalid-multi-wait-all-unsubmitted
[770.868461] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[770.989247] [125/156] (272s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[773.138382] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[773.219655] [126/156] (270s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-render)
[774.724751] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-render
[774.726587] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[774.966919] [127/156] (269s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[776.459886] Starting subtest: basic-flip-after-cursor-atomic
[777.459610] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.999s)
[777.663322] [128/156] (266s left) gem_fence_thrash (bo-copy)
[777.707613] Starting subtest: bo-copy
[777.712386] Subtest bo-copy: SKIP (0.002s)
[777.791527] [129/156] (266s left) syncobj_eventfd (binary-wait-signaled)
[777.840918] Starting subtest: binary-wait-signaled
[777.841831] Subtest binary-wait-signaled: SUCCESS (0.000s)
[778.027239] [130/156] (266s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[780.115152] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[780.140981] Starting dynamic subtest: pipe-A-plane-0
[780.857983] Dynamic subtest pipe-A-plane-0: SUCCESS (0.716s)
[780.881553] Starting dynamic subtest: pipe-A-plane-3
[781.357859] Dynamic subtest pipe-A-plane-3: SUCCESS (0.495s)
[781.411217] Starting dynamic subtest: pipe-A-plane-5
[781.840832] Dynamic subtest pipe-A-plane-5: SUCCESS (0.478s)
[782.026445] Starting dynamic subtest: pipe-B-plane-0
[782.578969] Dynamic subtest pipe-B-plane-0: SUCCESS (0.566s)
[782.628578] Starting dynamic subtest: pipe-B-plane-3
[783.061745] Dynamic subtest pipe-B-plane-3: SUCCESS (0.478s)
[783.099092] Starting dynamic subtest: pipe-B-plane-5
[783.561960] Dynamic subtest pipe-B-plane-5: SUCCESS (0.497s)
[783.635936] Subtest pixel-format-y-tiled-modifier-source-clamping: SUCCESS (3.521s)
[783.865051] [131/156] (260s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[785.361905] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[785.363962] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[785.551897] [132/156] (258s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-pwrite)
[787.049259] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-pwrite
[787.050951] Subtest hdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[787.225060] [133/156] (257s left) gem_mmap_gtt (big-bo)
[787.272794] Subtest big-bo: SKIP (0.000s)
[787.359178] [134/156] (257s left) gem_userptr_blits (coherency-sync)
[787.420543] Starting subtest: coherency-sync
[787.745560] Subtest coherency-sync: SKIP (0.308s)
[787.938732] [135/156] (256s left) vgem_basic (sysfs)
[788.062756] Starting subtest: sysfs
[788.063680] Subtest sysfs: SUCCESS (0.001s)
[788.189344] [136/156] (256s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[788.244290] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[788.245314] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[788.369304] [137/156] (256s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-blt)
[789.869600] Starting subtest: fbchdr-rgb565-draw-blt
[789.871716] Subtest fbchdr-rgb565-draw-blt: SKIP (0.000s)
[790.041889] [138/156] (255s left) i915_pm_rpm (reg-read-ioctl)
[793.906196] Starting subtest: reg-read-ioctl
[795.863074] Subtest reg-read-ioctl: SUCCESS (1.956s)
[796.874068] [139/156] (248s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[798.365976] Starting subtest: primary-y-tiled-reflect-x-270
[808.705628] Subtest primary-y-tiled-reflect-x-270: SUCCESS (10.341s)
[808.987058] [140/156] (236s left) gem_exec_balancer (invalid-bonds)
[809.050865] Starting subtest: invalid-bonds
[809.052935] Subtest invalid-bonds: SKIP (0.000s)
[809.555848] [141/156] (235s left) gem_ctx_param (invalid-size-set)
[809.603359] Starting subtest: invalid-size-set
[809.604363] Subtest invalid-size-set: SUCCESS (0.001s)
[809.729297] [142/156] (235s left) syncobj_wait (multi-wait-all-signaled)
[809.776295] Starting subtest: multi-wait-all-signaled
[809.777314] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[809.907233] [143/156] (235s left) gem_ppgtt (shrink-vs-evict-pinned)
[809.959969] Starting subtest: shrink-vs-evict-pinned
[817.726210] Subtest shrink-vs-evict-pinned: SUCCESS (7.762s)
[817.840923] [144/156] (227s left) perf_pmu (init-busy)
[817.891908] Starting subtest: init-busy
[817.892882] Starting dynamic subtest: rcs0
[817.895448] Dynamic subtest rcs0: SUCCESS (0.001s)
[817.910653] Starting dynamic subtest: bcs0
[817.911915] Dynamic subtest bcs0: SUCCESS (0.001s)
[817.926518] Starting dynamic subtest: vcs0
[817.927645] Dynamic subtest vcs0: SUCCESS (0.001s)
[817.942083] Starting dynamic subtest: vcs1
[817.943187] Dynamic subtest vcs1: SUCCESS (0.001s)
[817.957996] Starting dynamic subtest: vecs0
[817.959228] Dynamic subtest vecs0: SUCCESS (0.001s)
[817.960559] Subtest init-busy: SUCCESS (0.011s)
[818.041891] [145/156] (227s left) kms_psr (fbc-psr-basic)
[819.532615] Subtest fbc-psr-basic: SKIP (0.000s)
[819.623331] [146/156] (226s left) kms_addfb_basic (master-rmfb)
[819.672090] Starting subtest: master-rmfb
[819.672941] Subtest master-rmfb: SUCCESS (0.001s)
[821.311379] [147/156] (224s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[822.806521] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[822.808562] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[822.994629] [148/156] (222s left) gem_exec_reloc (basic-write-wc-active)
[823.046454] Subtest basic-write-wc-active: SKIP (0.000s)
[823.164059] [149/156] (222s left) gem_exec_schedule (timeslicing)
[823.224846] Starting subtest: timeslicing
[823.225757] Starting dynamic subtest: rcs0
[823.245947] Dynamic subtest rcs0: SUCCESS (0.020s)
[823.262601] Starting dynamic subtest: bcs0
[823.268702] Dynamic subtest bcs0: SUCCESS (0.021s)
[823.285058] Starting dynamic subtest: vcs0
[823.292416] Dynamic subtest vcs0: SUCCESS (0.022s)
[823.308881] Starting dynamic subtest: vcs1
[823.315879] Dynamic subtest vcs1: SUCCESS (0.021s)
[823.356839] Starting dynamic subtest: vecs0
[823.357861] Dynamic subtest vecs0: SUCCESS (0.033s)
[823.358935] Subtest timeslicing: SUCCESS (0.131s)
[823.726297] [150/156] (222s left) kms_vblank (wait-busy-hang)
[825.217311] Starting subtest: wait-busy-hang
[825.218525] Starting dynamic subtest: pipe-A-HDMI-A-3
[851.329040] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (26.111s)
[851.347706] Starting dynamic subtest: pipe-D-HDMI-A-3
[876.339409] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (25.006s)
[876.340391] Subtest wait-busy-hang: SUCCESS (51.124s)
[876.552414] [151/156] (169s left) kms_addfb_basic (bad-pitch-256)
[876.599793] Starting subtest: bad-pitch-256
[876.600697] Subtest bad-pitch-256: SUCCESS (0.000s)
[878.252544] [152/156] (168s left) gem_spin_batch (spin-all-new)
[878.328349] Starting subtest: spin-all-new
[878.366964] Subtest spin-all-new: SUCCESS (0.039s)
[878.679335] [153/156] (167s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[880.188671] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[880.190677] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[880.418001] [154/156] (166s left) gem_exec_schedule (fairslice)
[880.477881] Starting subtest: fairslice
[880.478802] Starting dynamic subtest: rcs0
[882.515803] Dynamic subtest rcs0: SUCCESS (2.036s)
[882.531316] Starting dynamic subtest: bcs0
[884.538873] Dynamic subtest bcs0: SUCCESS (2.021s)
[884.554237] Starting dynamic subtest: vcs0
[886.560173] Dynamic subtest vcs0: SUCCESS (2.019s)
[886.576147] Starting dynamic subtest: vcs1
[888.580176] Dynamic subtest vcs1: SUCCESS (2.018s)
[888.595659] Starting dynamic subtest: vecs0
[890.601385] Dynamic subtest vecs0: SUCCESS (2.020s)
[890.602536] Subtest fairslice: SUCCESS (10.122s)
[890.978537] [155/156] (155s left) perf (gen12-group-exclusive-stream-sample-oa)
[891.123387] Starting subtest: gen12-group-exclusive-stream-sample-oa
[891.150678] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.026s)
[891.224203] [156/156] (155s left) kms_dp_link_training (uhbr-sst)
[892.715861] Starting subtest: uhbr-sst
[892.717590] Subtest uhbr-sst: SKIP (0.000s)
[892.838880] Closing watchdogs
results: parsing output: 0/ for test: kms_pm_dc
results: parsing output: 1/ for test: i915_query
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: i915_fb_tiling
results: parsing output: 4/ for test: gem_exec_whisper
results: parsing output: 5/ for test: kms_cursor_legacy
results: parsing output: 6/ for test: syncobj_wait
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_cursor_crc
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_userptr_blits
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_content_protection
results: parsing output: 18/ for test: gem_shrink
results: parsing output: 19/ for test: gem_ctx_engines
results: parsing output: 20/ for test: kms_psr2_sf
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_mmap_gtt
results: parsing output: 23/ for test: i915_drm_fdinfo
results: parsing output: 24/ for test: gem_mmap_gtt
results: parsing output: 25/ for test: kms_cursor_crc
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: kms_cursor_legacy
results: parsing output: 33/ for test: gem_ctx_sseu
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_ctx_persistence
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: gem_exec_reloc
results: parsing output: 41/ for test: gem_exec_balancer
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_lmem_swapping
results: parsing output: 44/ for test: gem_ppgtt
results: parsing output: 45/ for test: kms_plane_scaling
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_chamelium_hpd
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_busy
results: parsing output: 51/ for test: syncobj_eventfd
results: parsing output: 52/ for test: syncobj_wait
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_color_pipeline
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: kms_chamelium_frames
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_plane_multiple
results: parsing output: 62/ for test: sysfs_timeslice_duration
results: parsing output: 63/ for test: gem_ctx_param
results: parsing output: 64/ for test: api_intel_bb
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: kms_plane_scaling
results: parsing output: 67/ for test: gem_ctx_isolation
results: parsing output: 68/ for test: kms_cursor_crc
results: parsing output: 69/ for test: kms_draw_crc
results: parsing output: 70/ for test: core_getclient
results: parsing output: 71/ for test: kms_flip_scaled_crc
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: gem_pxp
results: parsing output: 76/ for test: prime_vgem
results: parsing output: 77/ for test: gem_render_copy
results: parsing output: 78/ for test: kms_joiner
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: dumb_buffer
results: parsing output: 82/ for test: kms_rotation_crc
results: parsing output: 83/ for test: gem_mmap_offset
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: gen7_exec_parse
results: parsing output: 87/ for test: gem_exec_fence
results: parsing output: 88/ for test: kms_busy
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: gem_exec_schedule
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_flip
results: parsing output: 95/ for test: gem_madvise
results: parsing output: 96/ for test: gem_sync
results: parsing output: 97/ for test: kms_psr2_sf
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: gem_tiled_blits
results: parsing output: 103/ for test: gem_softpin
results: parsing output: 104/ for test: gem_exec_flush
results: parsing output: 105/ for test: gem_set_tiling_vs_blt
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_softpin
results: parsing output: 109/ for test: kms_cdclk
results: parsing output: 110/ for test: kms_flip_scaled_crc
results: parsing output: 111/ for test: kms_lease
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: kms_atomic
results: parsing output: 114/ for test: kms_plane_lowres
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_eio
results: parsing output: 119/ for test: kms_sequence
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: gem_fence_thrash
results: parsing output: 122/ for test: kms_pm_rpm
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: kms_psr2_sf
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_cursor_legacy
results: parsing output: 127/ for test: gem_fence_thrash
results: parsing output: 128/ for test: syncobj_eventfd
results: parsing output: 129/ for test: kms_plane
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_mmap_gtt
results: parsing output: 133/ for test: gem_userptr_blits
results: parsing output: 134/ for test: vgem_basic
results: parsing output: 135/ for test: syncobj_wait
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: i915_pm_rpm
results: parsing output: 138/ for test: kms_rotation_crc
results: parsing output: 139/ for test: gem_exec_balancer
results: parsing output: 140/ for test: gem_ctx_param
results: parsing output: 141/ for test: syncobj_wait
results: parsing output: 142/ for test: gem_ppgtt
results: parsing output: 143/ for test: perf_pmu
results: parsing output: 144/ for test: kms_psr
results: parsing output: 145/ for test: kms_addfb_basic
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: gem_exec_reloc
results: parsing output: 148/ for test: gem_exec_schedule
results: parsing output: 149/ for test: kms_vblank
results: parsing output: 150/ for test: kms_addfb_basic
results: parsing output: 151/ for test: gem_spin_batch
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: gem_exec_schedule
results: parsing output: 154/ for test: perf
results: parsing output: 155/ for test: kms_dp_link_training
Done.