[57.125856] Initializing watchdogs
[57.125910]   /dev/watchdog0
[57.140536] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.145817] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.148104] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.151587] [001/133] (960s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[57.225100] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[57.227456] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[57.338181] [002/133] (960s left) kms_color (ctm-max)
[57.432134] Starting subtest: ctm-max
[57.434069] Starting dynamic subtest: pipe-A-eDP-1
[58.176074] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.748s)
[58.185977] Starting dynamic subtest: pipe-B-eDP-1
[59.557954] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.384s)
[59.567178] Starting dynamic subtest: pipe-C-eDP-1
[60.928091] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.374s)
[60.936237] Starting dynamic subtest: pipe-D-eDP-1
[62.268816] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.342s)
[62.271087] Subtest ctm-max: SUCCESS (4.850s)
[63.069750] [003/133] (954s left) gem_eio (in-flight-1us)
[63.235859] Starting subtest: in-flight-1us
[70.757222] Subtest in-flight-1us: SUCCESS (7.528s)
[70.882528] [FACT gem_eio (in-flight-1us)] new: kernel.kmod_is_loaded.vgem: true
[70.885909] [004/133] (946s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[71.013642] Starting subtest: basic-busy-flip-before-cursor-legacy
[71.018669] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[71.163784] [005/133] (946s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[71.249923] Starting subtest: fbc-psr2-sprite-plane-onoff
[71.252281] Starting dynamic subtest: eDP-1
[71.256458] Dynamic subtest eDP-1: SKIP (0.000s)
[71.260667] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.000s)
[71.325373] [006/133] (946s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[71.438989] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[71.440973] Starting dynamic subtest: pipe-A-eDP-1
[71.594618] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.146s)
[71.604767] Starting dynamic subtest: pipe-B-eDP-1
[71.622492] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s)
[71.631829] Starting dynamic subtest: pipe-C-eDP-1
[71.648519] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[71.659525] Starting dynamic subtest: pipe-D-eDP-1
[71.675821] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[71.677631] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.183s)
[73.912930] [007/133] (943s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[74.013089] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[74.017457] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[74.117933] [008/133] (943s left) kms_flip (flip-vs-panning)
[74.207437] Starting subtest: flip-vs-panning
[74.209784] Starting dynamic subtest: A-eDP1
[82.927715] Dynamic subtest A-eDP1: SUCCESS (8.725s)
[82.937571] Starting dynamic subtest: B-eDP1
[91.658172] Dynamic subtest B-eDP1: SUCCESS (8.730s)
[91.667946] Starting dynamic subtest: C-eDP1
[100.372859] Dynamic subtest C-eDP1: SUCCESS (8.711s)
[100.383492] Starting dynamic subtest: D-eDP1
[109.106501] Dynamic subtest D-eDP1: SUCCESS (8.736s)
[109.109630] Subtest flip-vs-panning: SUCCESS (34.910s)
[110.272824] [009/133] (907s left) gem_exec_fence (submit3)
[110.448054] Starting subtest: submit3
[110.452302] Subtest submit3: SKIP (0.000s)
[111.949256] [010/133] (906s left) api_intel_allocator (gem-pool)
[112.009131] Starting subtest: gem-pool
[112.014431] Subtest gem-pool: SUCCESS (0.008s)
[112.131920] [011/133] (905s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[112.201683] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[112.271774] [012/133] (905s left) i915_pm_rpm (sysfs-read)
[114.013398] Starting subtest: sysfs-read
[115.185092] Subtest sysfs-read: SUCCESS (1.170s)
[115.568725] [013/133] (902s left) kms_cursor_crc (cursor-onscreen-64x64)
[115.747608] Starting subtest: cursor-onscreen-64x64
[115.752387] Starting dynamic subtest: pipe-A-eDP-1
[117.865354] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.114s)
[117.895276] Starting dynamic subtest: pipe-D-eDP-1
[120.639774] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.750s)
[120.642130] Subtest cursor-onscreen-64x64: SUCCESS (4.891s)
[121.438671] [014/133] (896s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[121.555445] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[121.559644] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[121.652684] [015/133] (896s left) gem_userptr_blits (forbidden-operations)
[121.710725] Starting subtest: forbidden-operations
[121.715279] Subtest forbidden-operations: SKIP (0.000s)
[121.848799] [016/133] (896s left) kms_big_fb (linear-64bpp-rotate-270)
[121.946579] Starting subtest: linear-64bpp-rotate-270
[121.968625] Subtest linear-64bpp-rotate-270: SKIP (0.022s)
[122.083898] [017/133] (896s left) kms_atomic_transition (plane-all-transition)
[122.177563] Starting subtest: plane-all-transition
[122.179681] Starting dynamic subtest: pipe-A-eDP-1
[124.670065] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[124.987867] Starting dynamic subtest: pipe-B-eDP-1
[128.175344] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.196s)
[128.478261] Subtest plane-all-transition: SUCCESS (6.301s)
[129.300575] [018/133] (889s left) api_intel_bb (reset-flags)
[129.364977] Starting subtest: reset-flags
[129.376592] Subtest reset-flags: SUCCESS (0.012s)
[129.508861] [019/133] (888s left) gem_sync (basic-many-each)
[129.592626] Starting subtest: basic-many-each
[131.882089] Subtest basic-many-each: SUCCESS (2.300s)
[132.065408] [020/133] (886s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[132.169921] Starting subtest: yf-tiled-8bpp-rotate-0
[132.174126] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[132.265838] [021/133] (886s left) gem_exec_balancer (nohangcheck)
[132.534991] Starting subtest: nohangcheck
[133.461519] Subtest nohangcheck: SUCCESS (0.925s)
[133.589762] [022/133] (884s left) kms_plane_alpha_blend (alpha-7efc)
[133.682948] Starting subtest: alpha-7efc
[133.957761] Starting dynamic subtest: pipe-A-eDP-1
[134.564074] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.604s)
[134.594426] Starting dynamic subtest: pipe-D-eDP-1
[135.931284] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.345s)
[135.933727] Subtest alpha-7efc: SUCCESS (2.250s)
[136.761990] [023/133] (881s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[136.860432] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[136.864614] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[136.970392] [024/133] (881s left) gem_softpin (evict-snoop-interruptible)
[137.026589] Starting subtest: evict-snoop-interruptible
[137.031411] Subtest evict-snoop-interruptible: SKIP (0.000s)
[137.150367] [025/133] (881s left) kms_hdmi_inject (inject-audio)
[137.484983] Starting subtest: inject-audio
[137.762157] Subtest inject-audio: SUCCESS (0.279s)
[138.320338] [026/133] (880s left) gem_bad_reloc (negative-reloc-bltcopy)
[138.380307] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[138.449878] [027/133] (880s left) gem_userptr_blits (unsync-overlap)
[138.515127] Subtest unsync-overlap: SKIP (0.000s)
[138.626466] [028/133] (880s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[138.736392] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[138.740987] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[138.885215] [029/133] (879s left) gem_eio (in-flight-internal-immediate)
[139.125448] Starting subtest: in-flight-internal-immediate
[140.963017] Subtest in-flight-internal-immediate: SUCCESS (1.838s)
[141.106822] [030/133] (877s left) kms_pm_backlight (brightness-with-dpms)
[141.203213] Starting subtest: brightness-with-dpms
[141.252126] Starting dynamic subtest: eDP-1
[143.683824] Dynamic subtest eDP-1: SUCCESS (2.429s)
[143.686620] Subtest brightness-with-dpms: SUCCESS (2.481s)
[144.499018] [031/133] (874s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[144.554778] Starting subtest: y-tiled-ccs-to-yf-tiled
[144.558854] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[144.737948] [032/133] (874s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[144.840218] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[144.844358] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[144.926014] [033/133] (874s left) dmabuf_sync_file (import-multiple-read-only)
[144.968206] Starting subtest: import-multiple-read-only
[144.970737] Subtest import-multiple-read-only: SUCCESS (0.003s)
[145.030504] [034/133] (873s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[145.083372] Starting subtest: framebuffer-vs-set-tiling
[145.087972] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[145.218203] [035/133] (873s left) gem_exec_capture (userptr)
[145.268196] Starting subtest: userptr
[146.102143] Subtest userptr: SUCCESS (0.835s)
[146.211597] [036/133] (872s left) fbdev (nullptr)
[146.252834] Starting subtest: nullptr
[146.255536] Subtest nullptr: SUCCESS (0.000s)
[146.308833] [037/133] (872s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[146.412374] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[151.762964] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.352s)
[152.899165] [038/133] (866s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[152.997109] Starting subtest: x-tiled-64bpp-rotate-270
[153.017749] Subtest x-tiled-64bpp-rotate-270: SKIP (0.020s)
[153.133883] [039/133] (866s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[153.237507] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[153.241680] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[153.326322] [040/133] (865s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[153.409784] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[153.414196] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[153.492348] [041/133] (865s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[153.582670] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[153.587042] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[153.665480] [042/133] (865s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[153.742278] Subtest writes-after-reads-uncached: SKIP (0.000s)
[153.819800] [043/133] (865s left) kms_hdr (static-toggle-dpms)
[153.904396] Starting subtest: static-toggle-dpms
[153.909800] Subtest static-toggle-dpms: SKIP (0.000s)
[153.983345] [044/133] (865s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[154.042688] Starting subtest: etime-multi-wait-for-submit-submitted
[154.143929] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.101s)
[154.236039] [045/133] (865s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[154.329829] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[154.333452] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[154.431848] [046/133] (865s left) perf_pmu (idle)
[154.477542] Starting subtest: idle
[154.479339] Starting dynamic subtest: rcs0
[155.031515] Dynamic subtest rcs0: SUCCESS (0.551s)
[155.043578] Starting dynamic subtest: bcs0
[155.547248] Dynamic subtest bcs0: SUCCESS (0.513s)
[155.558682] Starting dynamic subtest: vcs0
[156.071214] Dynamic subtest vcs0: SUCCESS (0.521s)
[156.082635] Starting dynamic subtest: vcs1
[156.589749] Dynamic subtest vcs1: SUCCESS (0.516s)
[156.601063] Starting dynamic subtest: vecs0
[157.111309] Dynamic subtest vecs0: SUCCESS (0.515s)
[157.122199] Starting dynamic subtest: ccs0
[157.630986] Dynamic subtest ccs0: SUCCESS (0.521s)
[157.633933] Subtest idle: SUCCESS (3.153s)
[157.747896] [047/133] (861s left) kms_chamelium_color (degamma)
[157.848952] Subtest degamma: SKIP (0.000s)
[157.894507] [048/133] (861s left) gem_pxp (create-regular-context-2)
[158.009762] Starting subtest: create-regular-context-2
[158.012439] Subtest create-regular-context-2: SUCCESS (0.002s)
[158.114292] [049/133] (861s left) gem_softpin (allocator-basic-reserve)
[158.165318] Starting subtest: allocator-basic-reserve
[158.237232] Subtest allocator-basic-reserve: SUCCESS (0.070s)
[158.355034] [050/133] (861s left) kms_plane_multiple (2x-tiling-none)
[158.448621] Starting subtest: 2x-tiling-none
[158.452772] Subtest 2x-tiling-none: SKIP (0.000s)
[158.537425] [051/133] (861s left) kms_feature_discovery (psr1)
[158.647355] Starting subtest: psr1
[158.649179] Subtest psr1: SUCCESS (0.000s)
[158.721127] [052/133] (861s left) kms_getfb (getfb-handle-protection)
[158.818469] Starting subtest: getfb-handle-protection
[158.842032] Subtest getfb-handle-protection: SUCCESS (0.025s)
[158.950298] [053/133] (860s left) kms_prop_blob (blob-prop-core)
[159.003039] Starting subtest: blob-prop-core
[159.004930] Subtest blob-prop-core: SUCCESS (0.000s)
[159.107720] [054/133] (860s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[159.192918] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[159.194714] Starting dynamic subtest: pipe-A
[160.242294] Dynamic subtest pipe-A: SUCCESS (1.050s)
[160.252038] Starting dynamic subtest: pipe-B
[162.364512] Dynamic subtest pipe-B: SUCCESS (2.120s)
[162.373181] Starting dynamic subtest: pipe-C
[163.532069] Dynamic subtest pipe-C: SUCCESS (1.166s)
[163.541425] Starting dynamic subtest: pipe-D
[164.731457] Dynamic subtest pipe-D: SUCCESS (1.198s)
[164.733850] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.540s)
[165.883826] [055/133] (853s left) gem_create (create-size-update)
[165.936641] Starting subtest: create-size-update
[165.938939] Subtest create-size-update: SUCCESS (0.000s)
[166.141483] [056/133] (853s left) syncobj_timeline (transfer-timeline-point)
[166.190806] Starting subtest: transfer-timeline-point
[166.193074] Subtest transfer-timeline-point: SUCCESS (0.000s)
[166.270597] [057/133] (853s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[166.370978] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[166.373342] Starting dynamic subtest: pipe-A-eDP-1
[166.872528] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.472s)
[166.882518] Starting dynamic subtest: pipe-B-eDP-1
[168.316698] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.442s)
[168.327737] Starting dynamic subtest: pipe-C-eDP-1
[169.647716] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.332s)
[169.659075] Starting dynamic subtest: pipe-D-eDP-1
[171.050258] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.401s)
[171.052144] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.652s)
[172.197013] [058/133] (847s left) vgem_basic (dmabuf-fence)
[172.239406] Starting subtest: dmabuf-fence
[172.241352] Subtest dmabuf-fence: SUCCESS (0.001s)
[172.297813] [059/133] (847s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[172.388360] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[172.392648] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[172.491262] [060/133] (847s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[172.585202] Starting subtest: random-ccs-data-y-tiled-ccs
[172.588512] Starting dynamic subtest: pipe-A-eDP-1
[172.614630] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[172.629058] Starting dynamic subtest: pipe-B-eDP-1
[172.653043] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[172.661498] Starting dynamic subtest: pipe-C-eDP-1
[172.685655] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[172.695955] Starting dynamic subtest: pipe-D-eDP-1
[172.722022] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[172.726630] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.005s)
[174.790539] [061/133] (845s left) kms_addfb_basic (bad-pitch-63)
[174.846865] Starting subtest: bad-pitch-63
[174.848761] Subtest bad-pitch-63: SUCCESS (0.000s)
[174.999877] [062/133] (845s left) gem_exec_schedule (u-semaphore-user)
[175.072401] Starting subtest: u-semaphore-user
[175.123970] Subtest u-semaphore-user: SUCCESS (0.058s)
[176.956622] [063/133] (843s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[177.061579] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[177.063998] Starting dynamic subtest: pipe-A-eDP-1
[177.158071] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[177.167517] Starting dynamic subtest: pipe-B-eDP-1
[178.331631] Dynamic subtest pipe-B-eDP-1: SKIP (1.171s)
[178.336357] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.274s)
[179.598502] [064/133] (840s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[179.701957] Starting subtest: extended-modeset-hang-oldfb-with-reset
[179.704289] Starting dynamic subtest: pipe-A
[191.432322] Dynamic subtest pipe-A: SUCCESS (11.729s)
[191.441310] Starting dynamic subtest: pipe-D
[203.737027] Dynamic subtest pipe-D: SUCCESS (12.300s)
[203.739339] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.034s)
[204.586207] [065/133] (815s left) gem_mmap_gtt (cpuset-big-copy-xy)
[204.644581] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[204.716143] [066/133] (815s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[204.841696] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[216.028157] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.185s)
[216.889608] [067/133] (803s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[217.004896] Starting subtest: basic-modeset-with-all-modifiers-formats
[217.393735] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[218.125843] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.735s)
[218.135140] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[218.147781] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[218.156582] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[218.170044] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.021s)
[218.184334] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[218.325713] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.155s)
[218.335868] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[218.347839] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[218.356903] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[218.370196] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.021s)
[218.379092] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[218.392357] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.021s)
[218.401441] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[218.414507] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[218.423268] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[218.438049] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[218.446630] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[218.461617] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[218.470330] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[218.481993] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[218.490708] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[218.505232] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.021s)
[218.515537] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[218.659081] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s)
[218.668218] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[218.681283] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[218.690074] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[218.703418] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s)
[218.712204] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[218.725427] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.021s)
[218.734922] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[218.747841] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.021s)
[218.757349] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[218.770134] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.021s)
[218.779223] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[218.792311] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.021s)
[218.801304] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[218.814607] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.021s)
[218.831931] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[218.838654] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.021s)
[218.856401] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[219.003941] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.166s)
[219.013283] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[219.025852] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[219.035126] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[219.048475] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.021s)
[219.060228] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[219.070306] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.019s)
[219.081544] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[219.092394] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.020s)
[219.103195] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[219.114591] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.021s)
[219.125112] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[219.137031] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.020s)
[219.148954] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[219.158994] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.021s)
[219.167299] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[219.181335] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.021s)
[219.572344] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.568s)
[220.387790] [068/133] (800s left) i915_query (query-regions-sanity-check)
[220.438069] Starting subtest: query-regions-sanity-check
[220.444811] Subtest query-regions-sanity-check: SUCCESS (0.010s)
[220.552881] [069/133] (799s left) gem_exec_whisper (basic-normal-all)
[220.622096] Starting subtest: basic-normal-all
[223.099703] Subtest basic-normal-all: SUCCESS (2.475s)
[223.286792] [070/133] (797s left) gem_mmap_offset (blt-coherency)
[223.347535] Starting subtest: blt-coherency
[223.357101] Subtest blt-coherency: SUCCESS (0.012s)
[223.491850] [071/133] (797s left) kms_flip (flip-vs-suspend)
[223.587973] Starting subtest: flip-vs-suspend
[223.590252] Starting dynamic subtest: A-eDP1
[273.019679] Dynamic subtest A-eDP1: SUCCESS (4.713s)
[273.034888] Starting dynamic subtest: B-eDP1
[322.049615] Dynamic subtest B-eDP1: SUCCESS (4.468s)
[322.060527] Starting dynamic subtest: C-eDP1
[356.694408] Dynamic subtest C-eDP1: SUCCESS (5.130s)
[356.714783] Starting dynamic subtest: D-eDP1
[406.039826] Dynamic subtest D-eDP1: SUCCESS (4.658s)
[406.045749] Subtest flip-vs-suspend: SUCCESS (18.980s)
[407.250734] [072/133] (613s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[407.391353] Starting subtest: basic-busy-flip-before-cursor-atomic
[407.396138] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[407.537567] [073/133] (613s left) kms_psr (psr-cursor-blt)
[407.634331] Starting subtest: psr-cursor-blt
[407.636754] Starting dynamic subtest: eDP-1
[409.304569] Dynamic subtest eDP-1: SUCCESS (1.689s)
[409.307004] Subtest psr-cursor-blt: SUCCESS (1.690s)
[410.128539] [074/133] (610s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[410.234261] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[410.236746] Starting dynamic subtest: pipe-A-eDP-1
[421.519227] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.341s)
[421.530609] Starting dynamic subtest: pipe-B-eDP-1
[433.556204] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.053s)
[433.558783] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.398s)
[434.360953] [075/133] (586s left) gem_exec_reloc (basic-write-read-active)
[434.430464] Subtest basic-write-read-active: SKIP (0.000s)
[434.496238] [076/133] (586s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[434.602489] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[439.190099] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.593s)
[440.362673] [077/133] (580s left) kms_flip (2x-nonexisting-fb)
[440.464003] Starting subtest: 2x-nonexisting-fb
[440.473393] Subtest 2x-nonexisting-fb: SKIP (0.010s)
[440.563413] [078/133] (580s left) gem_ctx_isolation (preservation-reset)
[440.735543] Starting subtest: preservation-reset
[440.738114] Starting dynamic subtest: rcs0
[441.016423] Dynamic subtest rcs0: SUCCESS (0.284s)
[441.028583] Starting dynamic subtest: bcs0
[441.342051] Dynamic subtest bcs0: SUCCESS (0.324s)
[441.354662] Starting dynamic subtest: vcs0
[441.663098] Dynamic subtest vcs0: SUCCESS (0.320s)
[441.678910] Starting dynamic subtest: vcs1
[442.835288] Dynamic subtest vcs1: SUCCESS (1.171s)
[442.848045] Starting dynamic subtest: vecs0
[444.833928] Dynamic subtest vecs0: SUCCESS (1.997s)
[444.844526] Starting dynamic subtest: ccs0
[446.841368] Dynamic subtest ccs0: SUCCESS (2.005s)
[446.844314] Subtest preservation-reset: SUCCESS (6.109s)
[446.978679] [079/133] (573s left) syncobj_eventfd (invalid-bad-pad)
[447.034937] Starting subtest: invalid-bad-pad
[447.037673] Subtest invalid-bad-pad: SUCCESS (0.000s)
[447.136009] [080/133] (573s left) kms_universal_plane (cursor-fb-leak)
[447.233344] Starting subtest: cursor-fb-leak
[447.235499] Starting dynamic subtest: pipe-A-eDP-1
[447.596749] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.365s)
[447.612055] Starting dynamic subtest: pipe-B-eDP-1
[448.952105] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.351s)
[448.964814] Starting dynamic subtest: pipe-C-eDP-1
[450.339913] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.386s)
[450.351754] Starting dynamic subtest: pipe-D-eDP-1
[451.727912] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.386s)
[451.730641] Subtest cursor-fb-leak: SUCCESS (4.497s)
[452.945839] [081/133] (568s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[453.074986] Starting subtest: cursor-vs-flip-varying-size
[484.411648] Subtest cursor-vs-flip-varying-size: SUCCESS (31.343s)
[485.245174] [082/133] (535s left) prime_busy (hang)
[485.295348] Starting subtest: hang
[485.297798] Starting dynamic subtest: rcs0
[511.059418] Dynamic subtest rcs0: SUCCESS (25.761s)
[511.068936] Starting dynamic subtest: bcs0
[518.211911] Dynamic subtest bcs0: SUCCESS (7.151s)
[518.224755] Starting dynamic subtest: vcs0
[525.190392] Dynamic subtest vcs0: SUCCESS (6.974s)
[525.200324] Starting dynamic subtest: vcs1
[532.161875] Dynamic subtest vcs1: SUCCESS (6.973s)
[532.171634] Starting dynamic subtest: vecs0
[539.202588] Dynamic subtest vecs0: SUCCESS (7.035s)
[539.214170] Starting dynamic subtest: ccs0
[553.039283] Dynamic subtest ccs0: SUCCESS (13.837s)
[553.042082] Subtest hang: SUCCESS (67.738s)
[553.146670] [083/133] (467s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[553.221772] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[553.224634] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[553.330502] [084/133] (467s left) gem_exec_balancer (parallel-keep-in-fence)
[553.587767] Starting subtest: parallel-keep-in-fence
[555.022359] Subtest parallel-keep-in-fence: SUCCESS (1.438s)
[555.133489] [085/133] (466s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[555.226419] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[555.231531] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[555.309003] [086/133] (465s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[555.428554] Starting subtest: flip-vs-cursor-legacy
[562.957591] Subtest flip-vs-cursor-legacy: SUCCESS (7.530s)
[563.835406] [087/133] (457s left) i915_hangman (gt-engine-error)
[563.893627] Starting subtest: gt-engine-error
[563.896604] Starting dynamic subtest: rcs0
[565.527698] Dynamic subtest rcs0: SUCCESS (1.632s)
[565.541532] Starting dynamic subtest: bcs0
[567.509096] Dynamic subtest bcs0: SUCCESS (1.979s)
[567.523064] Starting dynamic subtest: vcs0
[569.494420] Dynamic subtest vcs0: SUCCESS (1.982s)
[569.508190] Starting dynamic subtest: vcs1
[571.477121] Dynamic subtest vcs1: SUCCESS (1.980s)
[571.490731] Starting dynamic subtest: vecs0
[573.525036] Dynamic subtest vecs0: SUCCESS (2.046s)
[573.538347] Starting dynamic subtest: ccs0
[575.446926] Dynamic subtest ccs0: SUCCESS (1.919s)
[575.449794] Subtest gt-engine-error: SUCCESS (11.556s)
[575.569942] [088/133] (445s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[575.685571] Starting subtest: 4-tiled-64bpp-rotate-0
[577.243363] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.558s)
[577.425366] [089/133] (443s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[577.529597] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[577.534574] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[577.627516] [090/133] (443s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[577.727475] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[578.628909] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.903s)
[578.780644] [091/133] (442s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[578.854581] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[578.984836] [092/133] (442s left) prime_self_import (basic-with_one_bo_two_files)
[579.029667] Starting subtest: basic-with_one_bo_two_files
[579.047015] Subtest basic-with_one_bo_two_files: SUCCESS (0.022s)
[579.154913] [093/133] (442s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[579.203998] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[579.257043] [094/133] (442s left) gem_exec_params (invalid-batch-start-offset)
[579.311514] Starting subtest: invalid-batch-start-offset
[579.314200] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[579.439259] [095/133] (442s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[579.540554] Starting subtest: y-tiled-8bpp-rotate-270
[579.545102] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[579.639271] [096/133] (442s left) gem_eio (create)
[579.855340] Starting subtest: create
[580.173874] Subtest create: SUCCESS (0.318s)
[580.294116] [097/133] (441s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[580.392092] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[580.394051] Starting dynamic subtest: pipe-A-eDP-1
[580.413744] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[580.423918] Starting dynamic subtest: pipe-B-eDP-1
[580.444057] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[580.453739] Starting dynamic subtest: pipe-C-eDP-1
[580.474507] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[580.484064] Starting dynamic subtest: pipe-D-eDP-1
[580.505096] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[580.508435] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[582.663033] [098/133] (439s left) kms_psr (pr-primary-blt)
[582.755703] Starting subtest: pr-primary-blt
[582.760773] Subtest pr-primary-blt: SKIP (0.000s)
[582.832509] [099/133] (438s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[583.079450] Starting subtest: cursor-rapid-movement-256x256
[583.084813] Starting dynamic subtest: pipe-A-eDP-1
[583.636113] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.553s)
[583.667166] Starting dynamic subtest: pipe-D-eDP-1
[584.807601] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.149s)
[584.810528] Subtest cursor-rapid-movement-256x256: SUCCESS (1.728s)
[585.624694] [100/133] (436s left) gem_exec_params (sol-reset-invalid)
[585.683601] Starting subtest: sol-reset-invalid
[585.689690] Subtest sol-reset-invalid: SUCCESS (0.003s)
[587.561130] [101/133] (434s left) gem_exec_params (invalid-fence-in)
[587.627259] Starting subtest: invalid-fence-in
[587.629638] Subtest invalid-fence-in: SUCCESS (0.000s)
[587.727592] [102/133] (434s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[587.824274] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[587.828983] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[587.906997] [103/133] (434s left) syncobj_wait (wait-all-complex)
[587.974604] Starting subtest: wait-all-complex
[588.190960] Subtest wait-all-complex: SUCCESS (0.217s)
[588.268804] [104/133] (433s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[588.362659] Starting subtest: fbcpsr-rgb101010-draw-render
[595.068763] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.711s)
[595.183270] [105/133] (426s left) kms_lease (lease-unleased-connector)
[595.282539] Starting subtest: lease-unleased-connector
[595.285304] Starting dynamic subtest: pipe-A-eDP-1
[595.292297] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[595.315799] Starting dynamic subtest: pipe-B-eDP-1
[595.318533] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s)
[595.339225] Starting dynamic subtest: pipe-C-eDP-1
[595.341578] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[595.352144] Starting dynamic subtest: pipe-D-eDP-1
[595.354740] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.006s)
[595.357445] Subtest lease-unleased-connector: SUCCESS (0.031s)
[595.415687] [106/133] (426s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[595.802345] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[596.606077] [107/133] (425s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[596.699232] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[600.626685] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (3.934s)
[601.830491] [108/133] (420s left) kms_fbcon_fbt (fbc)
[601.895652] Starting subtest: fbc
[608.357797] Subtest fbc: SUCCESS (6.465s)
[609.503331] [109/133] (412s left) kms_vblank (wait-idle-hang)
[609.603702] Starting subtest: wait-idle-hang
[609.606225] Starting dynamic subtest: pipe-A-eDP-1
[636.289781] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.689s)
[636.307431] Starting dynamic subtest: pipe-D-eDP-1
[651.263066] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.963s)
[651.265928] Subtest wait-idle-hang: SUCCESS (41.658s)
[652.104800] [110/133] (370s left) kms_cursor_edge_walk (256x256-top-edge)
[652.201325] Starting subtest: 256x256-top-edge
[652.203699] Starting dynamic subtest: pipe-A-eDP-1
[655.655487] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.452s)
[655.666666] Starting dynamic subtest: pipe-D-eDP-1
[658.841899] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.187s)
[658.844555] Subtest 256x256-top-edge: SUCCESS (6.641s)
[659.750008] [111/133] (362s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[659.807888] Starting subtest: multi-wait-all-for-submit-available-signaled
[659.810541] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[659.892434] [112/133] (362s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[659.980630] Starting subtest: fbc-psr2-cursor-plane-onoff
[659.983075] Starting dynamic subtest: eDP-1
[659.987514] Dynamic subtest eDP-1: SKIP (0.000s)
[659.991999] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[660.072539] [113/133] (362s left) kms_pm_rpm (modeset-lpsp)
[661.697603] Starting subtest: modeset-lpsp
[663.172483] Subtest modeset-lpsp: SUCCESS (1.478s)
[663.259166] [114/133] (359s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[663.381613] Starting subtest: cursorB-vs-flipB-atomic
[663.386653] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[663.536971] [115/133] (358s left) kms_vrr (seamless-rr-switch-drrs)
[663.635529] Starting subtest: seamless-rr-switch-drrs
[663.642866] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[663.708557] [116/133] (358s left) gem_exec_params (dr4-dirt)
[663.762296] Starting subtest: DR4-dirt
[663.766701] Subtest DR4-dirt: SUCCESS (0.000s)
[663.867279] [117/133] (358s left) gem_exec_schedule (preempt-other-chain)
[663.941618] Starting subtest: preempt-other-chain
[663.944083] Starting dynamic subtest: rcs0
[664.026254] Dynamic subtest rcs0: SUCCESS (0.087s)
[664.038269] Starting dynamic subtest: bcs0
[664.103622] Dynamic subtest bcs0: SUCCESS (0.076s)
[664.119145] Starting dynamic subtest: vcs0
[664.189615] Dynamic subtest vcs0: SUCCESS (0.086s)
[664.201223] Starting dynamic subtest: vcs1
[664.273480] Dynamic subtest vcs1: SUCCESS (0.083s)
[664.284449] Starting dynamic subtest: vecs0
[664.355661] Dynamic subtest vecs0: SUCCESS (0.082s)
[664.367390] Starting dynamic subtest: ccs0
[664.436764] Dynamic subtest ccs0: SUCCESS (0.080s)
[664.439207] Subtest preempt-other-chain: SUCCESS (0.500s)
[665.604501] [118/133] (357s left) i915_drm_fdinfo (memory-info-shared)
[665.657786] Starting subtest: memory-info-shared
[665.660621] Starting dynamic subtest: smem0
[665.700744] Dynamic subtest smem0: SUCCESS (0.046s)
[665.703630] Subtest memory-info-shared: SUCCESS (0.046s)
[665.789433] [119/133] (356s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[665.882994] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[672.498530] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.617s)
[672.630549] [120/133] (350s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[672.734606] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[679.667215] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (6.937s)
[679.770561] [121/133] (342s left) gem_ctx_persistence (legacy-engines-hostile)
[679.838138] Starting subtest: legacy-engines-hostile
[679.840607] Starting dynamic subtest: render
[679.964783] Dynamic subtest render: SUCCESS (0.128s)
[679.982753] Starting dynamic subtest: bsd1
[680.057055] Dynamic subtest bsd1: SUCCESS (0.088s)
[680.072692] Starting dynamic subtest: bsd2
[680.148959] Dynamic subtest bsd2: SUCCESS (0.089s)
[680.162732] Starting dynamic subtest: blt
[680.238734] Dynamic subtest blt: SUCCESS (0.087s)
[680.250712] Starting dynamic subtest: vebox
[680.329890] Dynamic subtest vebox: SUCCESS (0.089s)
[680.332490] Subtest legacy-engines-hostile: SUCCESS (0.495s)
[680.414843] [122/133] (342s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[680.502314] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[680.504565] Starting dynamic subtest: pipe-A-eDP-1
[680.526394] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[680.537387] Starting dynamic subtest: pipe-B-eDP-1
[680.560063] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[680.569688] Starting dynamic subtest: pipe-C-eDP-1
[680.592639] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[680.602075] Starting dynamic subtest: pipe-D-eDP-1
[680.621417] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[680.625325] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s)
[682.719880] [123/133] (340s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[682.773924] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[682.875659] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.103s)
[682.954978] [124/133] (339s left) gem_sync (basic-each)
[683.040559] Starting subtest: basic-each
[685.752744] Subtest basic-each: SUCCESS (2.724s)
[685.959067] [125/133] (336s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[686.090794] Starting subtest: cursor-vs-flip-atomic-transitions
[716.472778] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.382s)
[717.314336] [126/133] (305s left) gem_mmap_gtt (basic-small-copy-xy)
[717.369170] Subtest basic-small-copy-XY: SKIP (0.000s)
[717.428053] [127/133] (305s left) gem_pxp (reject-modify-context-protection-off-3)
[717.536021] Starting subtest: reject-modify-context-protection-off-3
[717.538691] Subtest reject-modify-context-protection-off-3: SUCCESS (0.001s)
[717.641832] [128/133] (305s left) sysfs_heartbeat_interval (nopreempt)
[717.703021] Starting subtest: nopreempt
[717.705629] Starting dynamic subtest: vecs0
[727.545979] Dynamic subtest vecs0: SUCCESS (9.839s)
[727.561673] Starting dynamic subtest: ccs0
[731.596314] Dynamic subtest ccs0: SUCCESS (4.052s)
[731.608689] Starting dynamic subtest: vcs0
[741.492264] Dynamic subtest vcs0: SUCCESS (9.892s)
[741.503739] Starting dynamic subtest: bcs0
[745.429767] Dynamic subtest bcs0: SUCCESS (3.938s)
[745.441527] Starting dynamic subtest: rcs0
[749.523910] Dynamic subtest rcs0: SUCCESS (4.094s)
[749.537332] Starting dynamic subtest: vcs1
[759.556124] Dynamic subtest vcs1: SUCCESS (10.032s)
[759.559393] Subtest nopreempt: SUCCESS (41.857s)
[759.642143] [129/133] (263s left) kms_content_protection (content-type-change)
[759.796191] Starting subtest: content-type-change
[759.801578] Subtest content-type-change: SKIP (0.000s)
[759.921487] [130/133] (263s left) kms_psr (psr-suspend)
[760.021201] Starting subtest: psr-suspend
[760.023653] Starting dynamic subtest: eDP-1
[777.453079] Dynamic subtest eDP-1: SUCCESS (2.942s)
[777.455439] Subtest psr-suspend: SUCCESS (2.944s)
[778.322398] [131/133] (244s left) gen9_exec_parse (batch-invalid-length)
[778.388719] Subtest batch-invalid-length: SKIP (0.000s)
[778.470900] [132/133] (244s left) kms_atomic_transition (modeset-transition)
[778.569952] Starting subtest: modeset-transition
[778.572229] Starting dynamic subtest: 1x-outputs
[789.495843] Dynamic subtest 1x-outputs: SUCCESS (10.897s)
[789.498627] Subtest modeset-transition: SUCCESS (10.899s)
[790.351097] [133/133] (232s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[790.460613] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[790.462738] Starting dynamic subtest: pipe-A-default-mode
[793.229253] Dynamic subtest pipe-A-default-mode: SUCCESS (2.763s)
[793.231450] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.765s)
[794.042014] Closing watchdogs
results: parsing output: 0/ for test: syncobj_wait
results: parsing output: 1/ for test: kms_color
results: parsing output: 2/ for test: gem_eio
results: parsing output: 3/ for test: kms_cursor_legacy
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: gem_exec_fence
results: parsing output: 9/ for test: api_intel_allocator
results: parsing output: 10/ for test: kms_pipe_b_c_ivb
results: parsing output: 11/ for test: i915_pm_rpm
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_big_fb
results: parsing output: 16/ for test: kms_atomic_transition
results: parsing output: 17/ for test: api_intel_bb
results: parsing output: 18/ for test: gem_sync
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: gem_exec_balancer
results: parsing output: 21/ for test: kms_plane_alpha_blend
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_softpin
results: parsing output: 24/ for test: kms_hdmi_inject
results: parsing output: 25/ for test: gem_bad_reloc
results: parsing output: 26/ for test: gem_userptr_blits
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: gem_eio
results: parsing output: 29/ for test: kms_pm_backlight
results: parsing output: 30/ for test: gem_render_copy
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: dmabuf_sync_file
results: parsing output: 33/ for test: kms_addfb_basic
results: parsing output: 34/ for test: gem_exec_capture
results: parsing output: 35/ for test: fbdev
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_plane
results: parsing output: 40/ for test: kms_flip_scaled_crc
results: parsing output: 41/ for test: gem_partial_pwrite_pread
results: parsing output: 42/ for test: kms_hdr
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: perf_pmu
results: parsing output: 46/ for test: kms_chamelium_color
results: parsing output: 47/ for test: gem_pxp
results: parsing output: 48/ for test: gem_softpin
results: parsing output: 49/ for test: kms_plane_multiple
results: parsing output: 50/ for test: kms_feature_discovery
results: parsing output: 51/ for test: kms_getfb
results: parsing output: 52/ for test: kms_prop_blob
results: parsing output: 53/ for test: kms_plane_scaling
results: parsing output: 54/ for test: gem_create
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: vgem_basic
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: kms_addfb_basic
results: parsing output: 61/ for test: gem_exec_schedule
results: parsing output: 62/ for test: kms_psr2_sf
results: parsing output: 63/ for test: kms_busy
results: parsing output: 64/ for test: gem_mmap_gtt
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: kms_async_flips
results: parsing output: 67/ for test: i915_query
results: parsing output: 68/ for test: gem_exec_whisper
results: parsing output: 69/ for test: gem_mmap_offset
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: kms_cursor_legacy
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: kms_psr2_sf
results: parsing output: 74/ for test: gem_exec_reloc
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_flip
results: parsing output: 77/ for test: gem_ctx_isolation
results: parsing output: 78/ for test: syncobj_eventfd
results: parsing output: 79/ for test: kms_universal_plane
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: prime_busy
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: gem_exec_balancer
results: parsing output: 84/ for test: kms_plane
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: i915_hangman
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: gem_userptr_blits
results: parsing output: 91/ for test: prime_self_import
results: parsing output: 92/ for test: gem_lmem_swapping
results: parsing output: 93/ for test: gem_exec_params
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: gem_eio
results: parsing output: 96/ for test: kms_ccs
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: kms_cursor_crc
results: parsing output: 99/ for test: gem_exec_params
results: parsing output: 100/ for test: gem_exec_params
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: syncobj_wait
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_lease
results: parsing output: 105/ for test: kms_chamelium_hpd
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_fbcon_fbt
results: parsing output: 108/ for test: kms_vblank
results: parsing output: 109/ for test: kms_cursor_edge_walk
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: kms_pm_rpm
results: parsing output: 113/ for test: kms_cursor_legacy
results: parsing output: 114/ for test: kms_vrr
results: parsing output: 115/ for test: gem_exec_params
results: parsing output: 116/ for test: gem_exec_schedule
results: parsing output: 117/ for test: i915_drm_fdinfo
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gem_ctx_persistence
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: gem_sync
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: gem_mmap_gtt
results: parsing output: 126/ for test: gem_pxp
results: parsing output: 127/ for test: sysfs_heartbeat_interval
results: parsing output: 128/ for test: kms_content_protection
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: gen9_exec_parse
results: parsing output: 131/ for test: kms_atomic_transition
results: parsing output: 132/ for test: kms_flip_scaled_crc
Done.