[57.080740] Initializing watchdogs
[57.080788]   /dev/watchdog0
[57.095752] [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.100376] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.102771] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.106539] [001/133] (960s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[57.190108] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[57.192848] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[57.298900] [002/133] (960s left) kms_color (ctm-max)
[57.399684] Starting subtest: ctm-max
[57.401991] Starting dynamic subtest: pipe-A-eDP-1
[58.147956] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.747s)
[58.156896] Starting dynamic subtest: pipe-B-eDP-1
[59.569917] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.420s)
[59.578263] Starting dynamic subtest: pipe-C-eDP-1
[60.953061] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.382s)
[60.962877] Starting dynamic subtest: pipe-D-eDP-1
[62.283221] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.327s)
[62.285596] Subtest ctm-max: SUCCESS (4.877s)
[63.093650] [003/133] (954s left) gem_eio (in-flight-1us)
[63.274578] Starting subtest: in-flight-1us
[70.830655] Subtest in-flight-1us: SUCCESS (7.551s)
[70.952539] [FACT gem_eio (in-flight-1us)] new: kernel.kmod_is_loaded.vgem: true
[70.955679] [004/133] (946s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[71.060064] Starting subtest: basic-busy-flip-before-cursor-legacy
[71.063796] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[71.203630] [005/133] (946s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[71.291134] Starting subtest: fbc-psr2-sprite-plane-onoff
[71.292810] Starting dynamic subtest: eDP-1
[71.296377] Dynamic subtest eDP-1: SKIP (0.000s)
[71.299873] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.000s)
[71.362809] [006/133] (946s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[71.476109] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[71.478148] Starting dynamic subtest: pipe-A-eDP-1
[71.676300] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.191s)
[71.684173] Starting dynamic subtest: pipe-B-eDP-1
[71.700553] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.014s)
[71.707934] Starting dynamic subtest: pipe-C-eDP-1
[71.724519] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.012s)
[71.737136] Starting dynamic subtest: pipe-D-eDP-1
[71.752022] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[71.753543] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.232s)
[73.958703] [007/133] (943s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[74.069518] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[74.073731] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[74.169174] [008/133] (943s left) kms_flip (flip-vs-panning)
[74.262210] Starting subtest: flip-vs-panning
[74.272276] Starting dynamic subtest: A-eDP1
[83.087759] Dynamic subtest A-eDP1: SUCCESS (8.819s)
[83.099125] Starting dynamic subtest: B-eDP1
[91.809175] Dynamic subtest B-eDP1: SUCCESS (8.720s)
[91.818945] Starting dynamic subtest: C-eDP1
[100.532841] Dynamic subtest C-eDP1: SUCCESS (8.722s)
[100.540948] Starting dynamic subtest: D-eDP1
[109.271574] Dynamic subtest D-eDP1: SUCCESS (8.737s)
[109.275951] Subtest flip-vs-panning: SUCCESS (35.010s)
[110.427340] [009/133] (907s left) gem_exec_fence (submit3)
[110.624759] Starting subtest: submit3
[110.629571] Subtest submit3: SKIP (0.000s)
[111.992755] [010/133] (905s left) api_intel_allocator (gem-pool)
[112.055074] Starting subtest: gem-pool
[112.062240] Subtest gem-pool: SUCCESS (0.008s)
[112.185773] [011/133] (905s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[112.250316] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[112.307815] [012/133] (905s left) i915_pm_rpm (sysfs-read)
[114.045337] Starting subtest: sysfs-read
[115.194879] Subtest sysfs-read: SUCCESS (1.149s)
[115.579215] [013/133] (902s left) kms_cursor_crc (cursor-onscreen-64x64)
[115.761726] Starting subtest: cursor-onscreen-64x64
[115.766480] Starting dynamic subtest: pipe-A-eDP-1
[117.886237] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.119s)
[117.914287] Starting dynamic subtest: pipe-D-eDP-1
[120.686912] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.778s)
[120.689365] Subtest cursor-onscreen-64x64: SUCCESS (4.923s)
[121.548243] [014/133] (896s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[121.655597] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[121.660069] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[121.740214] [015/133] (896s left) gem_userptr_blits (forbidden-operations)
[121.803284] Starting subtest: forbidden-operations
[121.807324] Subtest forbidden-operations: SKIP (0.000s)
[121.921313] [016/133] (896s left) kms_big_fb (linear-64bpp-rotate-270)
[122.021787] Starting subtest: linear-64bpp-rotate-270
[122.042079] Subtest linear-64bpp-rotate-270: SKIP (0.019s)
[122.156310] [017/133] (896s left) kms_atomic_transition (plane-all-transition)
[122.248801] Starting subtest: plane-all-transition
[122.251060] Starting dynamic subtest: pipe-A-eDP-1
[124.742696] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[125.053956] Starting dynamic subtest: pipe-B-eDP-1
[128.279052] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.232s)
[128.574618] Subtest plane-all-transition: SUCCESS (6.326s)
[129.407268] [018/133] (888s left) api_intel_bb (reset-flags)
[129.475781] Starting subtest: reset-flags
[129.482416] Subtest reset-flags: SUCCESS (0.007s)
[129.600857] [019/133] (888s left) gem_sync (basic-many-each)
[129.681714] Starting subtest: basic-many-each
[131.980103] Subtest basic-many-each: SUCCESS (2.308s)
[132.175077] [020/133] (886s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[132.279016] Starting subtest: yf-tiled-8bpp-rotate-0
[132.283491] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[132.399917] [021/133] (886s left) gem_exec_balancer (nohangcheck)
[132.663169] Starting subtest: nohangcheck
[133.570338] Subtest nohangcheck: SUCCESS (0.906s)
[133.677663] [022/133] (884s left) kms_plane_alpha_blend (alpha-7efc)
[133.773242] Starting subtest: alpha-7efc
[134.056795] Starting dynamic subtest: pipe-A-eDP-1
[134.656887] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.597s)
[134.682319] Starting dynamic subtest: pipe-D-eDP-1
[136.032597] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.354s)
[136.035212] Subtest alpha-7efc: SUCCESS (2.259s)
[136.858958] [023/133] (881s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[136.953089] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[136.957284] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[137.056538] [024/133] (881s left) gem_softpin (evict-snoop-interruptible)
[137.116303] Starting subtest: evict-snoop-interruptible
[137.120890] Subtest evict-snoop-interruptible: SKIP (0.000s)
[137.241693] [025/133] (881s left) kms_hdmi_inject (inject-audio)
[137.579013] Starting subtest: inject-audio
[137.862279] Subtest inject-audio: SUCCESS (0.283s)
[138.414419] [026/133] (880s left) gem_bad_reloc (negative-reloc-bltcopy)
[138.467694] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[138.544045] [027/133] (880s left) gem_userptr_blits (unsync-overlap)
[138.603691] Subtest unsync-overlap: SKIP (0.000s)
[138.721444] [028/133] (879s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[138.847600] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[138.852070] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[139.001303] [029/133] (879s left) gem_eio (in-flight-internal-immediate)
[139.242514] Starting subtest: in-flight-internal-immediate
[140.968839] Subtest in-flight-internal-immediate: SUCCESS (1.726s)
[141.096312] [030/133] (877s left) kms_pm_backlight (brightness-with-dpms)
[141.184995] Starting subtest: brightness-with-dpms
[141.237432] Starting dynamic subtest: eDP-1
[143.673891] Dynamic subtest eDP-1: SUCCESS (2.436s)
[143.676245] Subtest brightness-with-dpms: SUCCESS (2.488s)
[144.498671] [031/133] (874s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[144.545475] Starting subtest: y-tiled-ccs-to-yf-tiled
[144.549869] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[144.741129] [032/133] (874s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[144.828336] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[144.832369] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[144.920140] [033/133] (873s left) dmabuf_sync_file (import-multiple-read-only)
[144.975606] Starting subtest: import-multiple-read-only
[144.977563] Subtest import-multiple-read-only: SUCCESS (0.003s)
[145.029769] [034/133] (873s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[145.079968] Starting subtest: framebuffer-vs-set-tiling
[145.084304] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[145.233798] [035/133] (873s left) gem_exec_capture (userptr)
[145.290757] Starting subtest: userptr
[146.130063] Subtest userptr: SUCCESS (0.840s)
[146.267736] [036/133] (872s left) fbdev (nullptr)
[146.314290] Starting subtest: nullptr
[146.316537] Subtest nullptr: SUCCESS (0.000s)
[146.371397] [037/133] (872s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[146.466124] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[151.816321] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.354s)
[153.011574] [038/133] (866s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[153.117189] Starting subtest: x-tiled-64bpp-rotate-270
[153.137405] Subtest x-tiled-64bpp-rotate-270: SKIP (0.020s)
[153.242606] [039/133] (865s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[153.337040] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[153.341176] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[153.428501] [040/133] (865s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[153.517102] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[153.521242] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[153.589826] [041/133] (865s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[153.693571] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[153.697753] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[153.780209] [042/133] (865s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[153.838310] Subtest writes-after-reads-uncached: SKIP (0.000s)
[153.902902] [043/133] (865s left) kms_hdr (static-toggle-dpms)
[154.008060] Starting subtest: static-toggle-dpms
[154.013264] Subtest static-toggle-dpms: SKIP (0.000s)
[154.079368] [044/133] (865s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[154.136442] Starting subtest: etime-multi-wait-for-submit-submitted
[154.244800] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.107s)
[154.319410] [045/133] (865s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[154.423150] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[154.427397] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[154.516060] [046/133] (864s left) perf_pmu (idle)
[154.566807] Starting subtest: idle
[154.569358] Starting dynamic subtest: rcs0
[155.114927] Dynamic subtest rcs0: SUCCESS (0.548s)
[155.126700] Starting dynamic subtest: bcs0
[155.642646] Dynamic subtest bcs0: SUCCESS (0.525s)
[155.653258] Starting dynamic subtest: vcs0
[156.168683] Dynamic subtest vcs0: SUCCESS (0.523s)
[156.179890] Starting dynamic subtest: vcs1
[156.684089] Dynamic subtest vcs1: SUCCESS (0.514s)
[156.695752] Starting dynamic subtest: vecs0
[157.207809] Dynamic subtest vecs0: SUCCESS (0.521s)
[157.219226] Starting dynamic subtest: ccs0
[157.724796] Dynamic subtest ccs0: SUCCESS (0.514s)
[157.727465] Subtest idle: SUCCESS (3.159s)
[157.826318] [047/133] (861s left) kms_chamelium_color (degamma)
[157.923784] Subtest degamma: SKIP (0.000s)
[157.967646] [048/133] (861s left) gem_pxp (create-regular-context-2)
[158.095825] Starting subtest: create-regular-context-2
[158.098489] Subtest create-regular-context-2: SUCCESS (0.002s)
[158.212222] [049/133] (861s left) gem_softpin (allocator-basic-reserve)
[158.274786] Starting subtest: allocator-basic-reserve
[158.360071] Subtest allocator-basic-reserve: SUCCESS (0.085s)
[158.491894] [050/133] (861s left) kms_plane_multiple (2x-tiling-none)
[158.598247] Starting subtest: 2x-tiling-none
[158.602578] Subtest 2x-tiling-none: SKIP (0.000s)
[158.672402] [051/133] (860s left) kms_feature_discovery (psr1)
[158.757467] Starting subtest: psr1
[158.759442] Subtest psr1: SUCCESS (0.000s)
[158.830212] [052/133] (860s left) kms_getfb (getfb-handle-protection)
[158.917458] Starting subtest: getfb-handle-protection
[158.938148] Subtest getfb-handle-protection: SUCCESS (0.022s)
[159.055938] [053/133] (860s left) kms_prop_blob (blob-prop-core)
[159.110678] Starting subtest: blob-prop-core
[159.112502] Subtest blob-prop-core: SUCCESS (0.000s)
[159.203281] [054/133] (860s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[159.293692] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[159.295749] Starting dynamic subtest: pipe-A
[160.341455] Dynamic subtest pipe-A: SUCCESS (1.050s)
[160.350501] Starting dynamic subtest: pipe-B
[162.486835] Dynamic subtest pipe-B: SUCCESS (2.144s)
[162.496099] Starting dynamic subtest: pipe-C
[163.728206] Dynamic subtest pipe-C: SUCCESS (1.240s)
[163.741985] Starting dynamic subtest: pipe-D
[164.935263] Dynamic subtest pipe-D: SUCCESS (1.205s)
[164.937480] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.644s)
[166.099533] [055/133] (853s left) gem_create (create-size-update)
[166.157703] Starting subtest: create-size-update
[166.160241] Subtest create-size-update: SUCCESS (0.000s)
[166.377020] [056/133] (853s left) syncobj_timeline (transfer-timeline-point)
[166.436565] Starting subtest: transfer-timeline-point
[166.438846] Subtest transfer-timeline-point: SUCCESS (0.000s)
[166.548743] [057/133] (853s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[166.633579] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[166.635782] Starting dynamic subtest: pipe-A-eDP-1
[167.178252] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.516s)
[167.187607] Starting dynamic subtest: pipe-B-eDP-1
[168.580869] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.402s)
[168.593490] Starting dynamic subtest: pipe-C-eDP-1
[169.956969] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.374s)
[169.968290] Starting dynamic subtest: pipe-D-eDP-1
[171.364469] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.407s)
[171.366716] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.705s)
[172.503689] [058/133] (847s left) vgem_basic (dmabuf-fence)
[172.553262] Starting subtest: dmabuf-fence
[172.555577] Subtest dmabuf-fence: SUCCESS (0.000s)
[172.623464] [059/133] (847s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[172.731288] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[172.735235] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[172.825465] [060/133] (847s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[172.932261] Starting subtest: random-ccs-data-y-tiled-ccs
[172.934534] Starting dynamic subtest: pipe-A-eDP-1
[172.959035] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[172.970583] Starting dynamic subtest: pipe-B-eDP-1
[172.993233] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[173.001732] Starting dynamic subtest: pipe-C-eDP-1
[173.025293] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[173.033963] Starting dynamic subtest: pipe-D-eDP-1
[173.057547] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[173.061641] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.005s)
[175.203109] [061/133] (844s left) kms_addfb_basic (bad-pitch-63)
[175.264363] Starting subtest: bad-pitch-63
[175.266678] Subtest bad-pitch-63: SUCCESS (0.000s)
[175.399733] [062/133] (844s left) gem_exec_schedule (u-semaphore-user)
[175.466199] Starting subtest: u-semaphore-user
[175.516815] Subtest u-semaphore-user: SUCCESS (0.058s)
[176.961513] [063/133] (843s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[177.066384] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[177.068697] Starting dynamic subtest: pipe-A-eDP-1
[177.161415] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[177.171520] Starting dynamic subtest: pipe-B-eDP-1
[178.334176] Dynamic subtest pipe-B-eDP-1: SKIP (1.171s)
[178.338636] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.274s)
[179.603292] [064/133] (840s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[179.706726] Starting subtest: extended-modeset-hang-oldfb-with-reset
[179.708873] Starting dynamic subtest: pipe-A
[191.424408] Dynamic subtest pipe-A: SUCCESS (11.716s)
[191.433632] Starting dynamic subtest: pipe-D
[203.728794] Dynamic subtest pipe-D: SUCCESS (12.301s)
[203.731181] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.021s)
[204.599843] [065/133] (815s left) gem_mmap_gtt (cpuset-big-copy-xy)
[204.661486] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[204.720537] [066/133] (815s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[204.845491] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[216.020476] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.177s)
[216.891597] [067/133] (803s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[217.004486] Starting subtest: basic-modeset-with-all-modifiers-formats
[217.382187] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[218.137270] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.755s)
[218.150843] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[218.159444] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[218.172901] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[218.181665] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.021s)
[218.193356] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[218.348593] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.165s)
[218.360013] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[218.370728] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[218.381122] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[218.393031] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.021s)
[218.404505] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[218.415222] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.021s)
[218.424059] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[218.438075] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[218.446718] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[218.459367] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.022s)
[218.468078] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[218.484579] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[218.493057] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[218.505063] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[218.513579] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[218.528087] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.021s)
[218.536643] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[218.681849] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s)
[218.691453] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[218.704351] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[218.717742] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[218.726370] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s)
[218.739902] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[218.748415] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.021s)
[218.759724] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[218.770826] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.021s)
[218.781558] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[218.792852] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.020s)
[218.801609] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[218.815137] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.021s)
[218.823903] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[218.837386] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.021s)
[218.846118] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[218.859805] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[218.868686] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[219.015229] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s)
[219.025189] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[219.037737] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[219.046591] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[219.059503] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.021s)
[219.070168] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[219.081800] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.020s)
[219.090298] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[219.104047] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.021s)
[219.112168] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[219.126452] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[219.134722] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[219.148506] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.021s)
[219.156871] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[219.170827] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.021s)
[219.179039] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[219.192859] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.021s)
[219.588298] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.585s)
[220.389330] [068/133] (799s left) i915_query (query-regions-sanity-check)
[220.438173] Starting subtest: query-regions-sanity-check
[220.448267] Subtest query-regions-sanity-check: SUCCESS (0.012s)
[220.576381] [069/133] (799s left) gem_exec_whisper (basic-normal-all)
[220.654571] Starting subtest: basic-normal-all
[223.165274] Subtest basic-normal-all: SUCCESS (2.508s)
[223.355089] [070/133] (797s left) gem_mmap_offset (blt-coherency)
[223.411664] Starting subtest: blt-coherency
[223.423533] Subtest blt-coherency: SUCCESS (0.015s)
[223.563480] [071/133] (796s left) kms_flip (flip-vs-suspend)
[223.658198] Starting subtest: flip-vs-suspend
[223.660594] Starting dynamic subtest: A-eDP1
[273.063258] Dynamic subtest A-eDP1: SUCCESS (4.720s)
[273.075099] Starting dynamic subtest: B-eDP1
[323.068806] Dynamic subtest B-eDP1: SUCCESS (4.844s)
[323.084177] Starting dynamic subtest: C-eDP1
[372.055564] Dynamic subtest C-eDP1: SUCCESS (4.566s)
[372.066201] Starting dynamic subtest: D-eDP1
[421.064713] Dynamic subtest D-eDP1: SUCCESS (4.516s)
[421.070555] Subtest flip-vs-suspend: SUCCESS (18.655s)
[422.308087] [072/133] (598s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[422.424052] Starting subtest: basic-busy-flip-before-cursor-atomic
[422.428701] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[422.567211] [073/133] (597s left) kms_psr (psr-cursor-blt)
[422.660111] Starting subtest: psr-cursor-blt
[422.662403] Starting dynamic subtest: eDP-1
[424.373369] Dynamic subtest eDP-1: SUCCESS (1.707s)
[424.375578] Subtest psr-cursor-blt: SUCCESS (1.708s)
[425.204707] [074/133] (595s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[425.305640] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[425.307847] Starting dynamic subtest: pipe-A-eDP-1
[436.643098] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.323s)
[436.656780] Starting dynamic subtest: pipe-B-eDP-1
[448.616016] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.965s)
[448.618209] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.292s)
[449.444896] [075/133] (571s left) gem_exec_reloc (basic-write-read-active)
[449.506823] Subtest basic-write-read-active: SKIP (0.000s)
[449.576148] [076/133] (571s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[449.678637] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[454.317880] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.636s)
[455.453954] [077/133] (565s left) kms_flip (2x-nonexisting-fb)
[455.548162] Starting subtest: 2x-nonexisting-fb
[455.559709] Subtest 2x-nonexisting-fb: SKIP (0.011s)
[455.691100] [078/133] (565s left) gem_ctx_isolation (preservation-reset)
[455.856013] Starting subtest: preservation-reset
[455.859005] Starting dynamic subtest: rcs0
[456.143972] Dynamic subtest rcs0: SUCCESS (0.288s)
[456.155281] Starting dynamic subtest: bcs0
[456.472180] Dynamic subtest bcs0: SUCCESS (0.326s)
[456.484624] Starting dynamic subtest: vcs0
[456.788167] Dynamic subtest vcs0: SUCCESS (0.314s)
[456.797989] Starting dynamic subtest: vcs1
[457.887187] Dynamic subtest vcs1: SUCCESS (1.095s)
[457.897730] Starting dynamic subtest: vecs0
[459.907709] Dynamic subtest vecs0: SUCCESS (2.015s)
[459.917968] Starting dynamic subtest: ccs0
[461.894578] Dynamic subtest ccs0: SUCCESS (1.982s)
[461.896986] Subtest preservation-reset: SUCCESS (6.029s)
[462.037297] [079/133] (558s left) syncobj_eventfd (invalid-bad-pad)
[462.086081] Starting subtest: invalid-bad-pad
[462.088311] Subtest invalid-bad-pad: SUCCESS (0.000s)
[462.192812] [080/133] (558s left) kms_universal_plane (cursor-fb-leak)
[462.291960] Starting subtest: cursor-fb-leak
[462.294165] Starting dynamic subtest: pipe-A-eDP-1
[462.635328] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.345s)
[462.649281] Starting dynamic subtest: pipe-B-eDP-1
[464.072507] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.432s)
[464.084499] Starting dynamic subtest: pipe-C-eDP-1
[465.429569] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.353s)
[465.442201] Starting dynamic subtest: pipe-D-eDP-1
[466.835200] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.403s)
[466.837686] Subtest cursor-fb-leak: SUCCESS (4.541s)
[467.990797] [081/133] (552s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[468.108795] Starting subtest: cursor-vs-flip-varying-size
[499.425122] Subtest cursor-vs-flip-varying-size: SUCCESS (31.306s)
[500.271361] [082/133] (520s left) prime_busy (hang)
[500.334343] Starting subtest: hang
[500.336277] Starting dynamic subtest: rcs0
[526.115273] Dynamic subtest rcs0: SUCCESS (25.774s)
[526.124635] Starting dynamic subtest: bcs0
[533.264980] Dynamic subtest bcs0: SUCCESS (7.148s)
[533.277131] Starting dynamic subtest: vcs0
[540.243406] Dynamic subtest vcs0: SUCCESS (6.976s)
[540.255659] Starting dynamic subtest: vcs1
[547.217545] Dynamic subtest vcs1: SUCCESS (6.967s)
[547.228625] Starting dynamic subtest: vecs0
[554.256879] Dynamic subtest vecs0: SUCCESS (7.041s)
[554.273494] Starting dynamic subtest: ccs0
[568.090768] Dynamic subtest ccs0: SUCCESS (13.839s)
[568.093215] Subtest hang: SUCCESS (67.753s)
[568.197932] [083/133] (452s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[568.250519] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[568.252965] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[568.343441] [084/133] (452s left) gem_exec_balancer (parallel-keep-in-fence)
[568.623786] Starting subtest: parallel-keep-in-fence
[569.869445] Subtest parallel-keep-in-fence: SUCCESS (1.249s)
[569.989415] [085/133] (451s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[570.107096] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[570.111447] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[570.182616] [086/133] (450s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[570.305615] Starting subtest: flip-vs-cursor-legacy
[577.856481] Subtest flip-vs-cursor-legacy: SUCCESS (7.553s)
[578.693596] [087/133] (442s left) i915_hangman (gt-engine-error)
[578.758281] Starting subtest: gt-engine-error
[578.760505] Starting dynamic subtest: rcs0
[580.580241] Dynamic subtest rcs0: SUCCESS (1.822s)
[580.593605] Starting dynamic subtest: bcs0
[582.563284] Dynamic subtest bcs0: SUCCESS (1.980s)
[582.576206] Starting dynamic subtest: vcs0
[584.547567] Dynamic subtest vcs0: SUCCESS (1.981s)
[584.560594] Starting dynamic subtest: vcs1
[586.531597] Dynamic subtest vcs1: SUCCESS (1.981s)
[586.546039] Starting dynamic subtest: vecs0
[588.515578] Dynamic subtest vecs0: SUCCESS (1.981s)
[588.528608] Starting dynamic subtest: ccs0
[590.564430] Dynamic subtest ccs0: SUCCESS (2.046s)
[590.567541] Subtest gt-engine-error: SUCCESS (11.809s)
[590.713342] [088/133] (430s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[590.820786] Starting subtest: 4-tiled-64bpp-rotate-0
[592.365800] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.546s)
[592.558349] [089/133] (428s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[592.677869] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[592.682201] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[592.770891] [090/133] (428s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[592.866402] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[593.746501] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.881s)
[593.909043] [091/133] (427s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[593.967680] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[594.108487] [092/133] (427s left) prime_self_import (basic-with_one_bo_two_files)
[594.150905] Starting subtest: basic-with_one_bo_two_files
[594.173128] Subtest basic-with_one_bo_two_files: SUCCESS (0.023s)
[594.287672] [093/133] (427s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[594.334762] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[594.381666] [094/133] (427s left) gem_exec_params (invalid-batch-start-offset)
[594.440889] Starting subtest: invalid-batch-start-offset
[594.446718] Subtest invalid-batch-start-offset: SUCCESS (0.003s)
[594.578176] [095/133] (426s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[594.684246] Starting subtest: y-tiled-8bpp-rotate-270
[594.687899] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[594.790101] [096/133] (426s left) gem_eio (create)
[595.013857] Starting subtest: create
[595.321817] Subtest create: SUCCESS (0.308s)
[595.453648] [097/133] (426s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[595.548150] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[595.550529] Starting dynamic subtest: pipe-A-eDP-1
[595.570990] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[595.583381] Starting dynamic subtest: pipe-B-eDP-1
[595.600921] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[595.612590] Starting dynamic subtest: pipe-C-eDP-1
[595.630715] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[595.641122] Starting dynamic subtest: pipe-D-eDP-1
[595.658913] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[595.662295] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[597.776042] [098/133] (423s left) kms_psr (pr-primary-blt)
[597.868852] Starting subtest: pr-primary-blt
[597.873191] Subtest pr-primary-blt: SKIP (0.000s)
[597.943495] [099/133] (423s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[598.188903] Starting subtest: cursor-rapid-movement-256x256
[598.193693] Starting dynamic subtest: pipe-A-eDP-1
[598.758791] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.564s)
[598.797702] Starting dynamic subtest: pipe-D-eDP-1
[599.953359] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.162s)
[599.955585] Subtest cursor-rapid-movement-256x256: SUCCESS (1.762s)
[600.769478] [100/133] (420s left) gem_exec_params (sol-reset-invalid)
[600.839856] Starting subtest: sol-reset-invalid
[600.841797] Subtest sol-reset-invalid: SUCCESS (0.003s)
[602.628704] [101/133] (419s left) gem_exec_params (invalid-fence-in)
[602.687359] Starting subtest: invalid-fence-in
[602.689708] Subtest invalid-fence-in: SUCCESS (0.000s)
[602.787383] [102/133] (419s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[602.892301] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[602.896585] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[602.994860] [103/133] (418s left) syncobj_wait (wait-all-complex)
[603.062510] Starting subtest: wait-all-complex
[603.278550] Subtest wait-all-complex: SUCCESS (0.216s)
[603.362535] [104/133] (418s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[603.454582] Starting subtest: fbcpsr-rgb101010-draw-render
[610.091314] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.639s)
[610.217014] [105/133] (411s left) kms_lease (lease-unleased-connector)
[610.325653] Starting subtest: lease-unleased-connector
[610.327829] Starting dynamic subtest: pipe-A-eDP-1
[610.333422] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[610.348058] Starting dynamic subtest: pipe-B-eDP-1
[610.350236] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s)
[610.360662] Starting dynamic subtest: pipe-C-eDP-1
[610.362710] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[610.372310] Starting dynamic subtest: pipe-D-eDP-1
[610.374430] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.006s)
[610.376554] Subtest lease-unleased-connector: SUCCESS (0.031s)
[610.450139] [106/133] (411s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[610.829408] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[611.637167] [107/133] (410s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[611.745379] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[615.717601] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (3.975s)
[616.866840] [108/133] (405s left) kms_fbcon_fbt (fbc)
[616.931617] Starting subtest: fbc
[623.386559] Subtest fbc: SUCCESS (6.454s)
[624.538489] [109/133] (397s left) kms_vblank (wait-idle-hang)
[624.629632] Starting subtest: wait-idle-hang
[624.631786] Starting dynamic subtest: pipe-A-eDP-1
[651.398436] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.762s)
[651.413807] Starting dynamic subtest: pipe-D-eDP-1
[666.329349] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.925s)
[666.331350] Subtest wait-idle-hang: SUCCESS (41.692s)
[667.207825] [110/133] (355s left) kms_cursor_edge_walk (256x256-top-edge)
[667.312855] Starting subtest: 256x256-top-edge
[667.315587] Starting dynamic subtest: pipe-A-eDP-1
[670.789560] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.476s)
[670.799586] Starting dynamic subtest: pipe-D-eDP-1
[673.986442] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.195s)
[673.988373] Subtest 256x256-top-edge: SUCCESS (6.673s)
[674.856580] [111/133] (347s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[674.922995] Starting subtest: multi-wait-all-for-submit-available-signaled
[674.925180] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[675.022190] [112/133] (347s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[675.117489] Starting subtest: fbc-psr2-cursor-plane-onoff
[675.119642] Starting dynamic subtest: eDP-1
[675.123603] Dynamic subtest eDP-1: SKIP (0.000s)
[675.127502] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[675.191865] [113/133] (347s left) kms_pm_rpm (modeset-lpsp)
[676.811718] Starting subtest: modeset-lpsp
[678.279408] Subtest modeset-lpsp: SUCCESS (1.470s)
[678.370009] [114/133] (344s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[678.489157] Starting subtest: cursorB-vs-flipB-atomic
[678.493538] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[678.635946] [115/133] (343s left) kms_vrr (seamless-rr-switch-drrs)
[678.723765] Starting subtest: seamless-rr-switch-drrs
[678.729714] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[678.797588] [116/133] (343s left) gem_exec_params (dr4-dirt)
[678.855057] Starting subtest: DR4-dirt
[678.857178] Subtest DR4-dirt: SUCCESS (0.000s)
[678.947234] [117/133] (343s left) gem_exec_schedule (preempt-other-chain)
[679.020209] Starting subtest: preempt-other-chain
[679.022562] Starting dynamic subtest: rcs0
[679.116818] Dynamic subtest rcs0: SUCCESS (0.096s)
[679.131289] Starting dynamic subtest: bcs0
[679.202399] Dynamic subtest bcs0: SUCCESS (0.084s)
[679.215743] Starting dynamic subtest: vcs0
[679.285121] Dynamic subtest vcs0: SUCCESS (0.082s)
[679.298042] Starting dynamic subtest: vcs1
[679.364567] Dynamic subtest vcs1: SUCCESS (0.079s)
[679.374310] Starting dynamic subtest: vecs0
[679.443295] Dynamic subtest vecs0: SUCCESS (0.078s)
[679.458302] Starting dynamic subtest: ccs0
[679.521670] Dynamic subtest ccs0: SUCCESS (0.077s)
[679.523965] Subtest preempt-other-chain: SUCCESS (0.502s)
[680.598601] [118/133] (341s left) i915_drm_fdinfo (memory-info-shared)
[680.645191] Starting subtest: memory-info-shared
[680.647420] Starting dynamic subtest: smem0
[680.704682] Dynamic subtest smem0: SUCCESS (0.060s)
[680.707200] Subtest memory-info-shared: SUCCESS (0.060s)
[680.779805] [119/133] (341s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[680.876862] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[687.435862] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.561s)
[687.614409] [120/133] (335s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[687.717684] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[694.812046] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.100s)
[694.917267] [121/133] (327s left) gem_ctx_persistence (legacy-engines-hostile)
[694.979216] Starting subtest: legacy-engines-hostile
[694.981621] Starting dynamic subtest: render
[695.109505] Dynamic subtest render: SUCCESS (0.130s)
[695.125051] Starting dynamic subtest: bsd1
[695.210474] Dynamic subtest bsd1: SUCCESS (0.098s)
[695.225838] Starting dynamic subtest: bsd2
[695.316954] Dynamic subtest bsd2: SUCCESS (0.103s)
[695.330440] Starting dynamic subtest: blt
[695.339559] Dynamic subtest blt: SUCCESS (0.020s)
[695.349658] Starting dynamic subtest: vebox
[695.459575] Dynamic subtest vebox: SUCCESS (0.119s)
[695.462343] Subtest legacy-engines-hostile: SUCCESS (0.481s)
[695.558857] [122/133] (327s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[695.655957] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[695.658208] Starting dynamic subtest: pipe-A-eDP-1
[695.680208] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[695.690954] Starting dynamic subtest: pipe-B-eDP-1
[695.712466] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[695.722051] Starting dynamic subtest: pipe-C-eDP-1
[695.743778] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[695.752973] Starting dynamic subtest: pipe-D-eDP-1
[695.771122] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[695.774696] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.005s)
[697.865777] [123/133] (324s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[697.927231] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[698.032999] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s)
[698.111180] [124/133] (324s left) gem_sync (basic-each)
[698.203396] Starting subtest: basic-each
[700.891373] Subtest basic-each: SUCCESS (2.699s)
[701.079240] [125/133] (321s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[701.200513] Starting subtest: cursor-vs-flip-atomic-transitions
[731.520185] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.317s)
[732.359635] [126/133] (290s left) gem_mmap_gtt (basic-small-copy-xy)
[732.418462] Subtest basic-small-copy-XY: SKIP (0.000s)
[732.481865] [127/133] (290s left) gem_pxp (reject-modify-context-protection-off-3)
[732.577906] Starting subtest: reject-modify-context-protection-off-3
[732.580107] Subtest reject-modify-context-protection-off-3: SUCCESS (0.001s)
[732.705185] [128/133] (290s left) sysfs_heartbeat_interval (nopreempt)
[732.760072] Starting subtest: nopreempt
[732.762310] Starting dynamic subtest: vecs0
[742.596989] Dynamic subtest vecs0: SUCCESS (9.832s)
[742.609972] Starting dynamic subtest: ccs0
[746.630409] Dynamic subtest ccs0: SUCCESS (4.033s)
[746.643356] Starting dynamic subtest: vcs0
[756.541115] Dynamic subtest vcs0: SUCCESS (9.907s)
[756.554964] Starting dynamic subtest: bcs0
[760.444590] Dynamic subtest bcs0: SUCCESS (3.902s)
[760.457013] Starting dynamic subtest: rcs0
[764.555155] Dynamic subtest rcs0: SUCCESS (4.110s)
[764.567443] Starting dynamic subtest: vcs1
[773.575914] Dynamic subtest vcs1: SUCCESS (9.016s)
[773.578554] Subtest nopreempt: SUCCESS (40.809s)
[773.652867] [129/133] (249s left) kms_content_protection (content-type-change)
[773.802991] Starting subtest: content-type-change
[773.807578] Subtest content-type-change: SKIP (0.000s)
[773.928680] [130/133] (249s left) kms_psr (psr-suspend)
[774.032713] Starting subtest: psr-suspend
[774.035141] Starting dynamic subtest: eDP-1
[791.474973] Dynamic subtest eDP-1: SUCCESS (2.877s)
[791.477868] Subtest psr-suspend: SUCCESS (2.879s)
[792.353709] [131/133] (230s left) gen9_exec_parse (batch-invalid-length)
[792.428597] Subtest batch-invalid-length: SKIP (0.000s)
[792.505334] [132/133] (230s left) kms_atomic_transition (modeset-transition)
[792.597967] Starting subtest: modeset-transition
[792.600327] Starting dynamic subtest: 1x-outputs
[803.410807] Dynamic subtest 1x-outputs: SUCCESS (10.820s)
[803.413835] Subtest modeset-transition: SUCCESS (10.822s)
[804.256144] [133/133] (218s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[804.368947] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[804.371569] Starting dynamic subtest: pipe-A-default-mode
[807.141808] Dynamic subtest pipe-A-default-mode: SUCCESS (2.774s)
[807.144452] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.776s)
[807.942300] 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.