[57.609974] Initializing watchdogs
[57.610064]   /dev/watchdog0
[57.625034] [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.629382] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.631555] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.634784] [001/133] (960s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[57.705398] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[57.707808] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[57.826432] [002/133] (960s left) kms_color (ctm-max)
[57.921680] Starting subtest: ctm-max
[57.923592] Starting dynamic subtest: pipe-A-eDP-1
[58.650706] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.731s)
[58.659473] Starting dynamic subtest: pipe-B-eDP-1
[60.035580] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.383s)
[60.043773] Starting dynamic subtest: pipe-C-eDP-1
[61.405981] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.370s)
[61.415091] Starting dynamic subtest: pipe-D-eDP-1
[62.734134] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[62.736511] Subtest ctm-max: SUCCESS (4.813s)
[63.527095] [003/133] (954s left) gem_eio (in-flight-1us)
[63.704538] Starting subtest: in-flight-1us
[70.811232] Subtest in-flight-1us: SUCCESS (7.108s)
[70.958932] [FACT gem_eio (in-flight-1us)] new: kernel.kmod_is_loaded.vgem: true
[70.961626] [004/133] (947s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[71.076121] Starting subtest: basic-busy-flip-before-cursor-legacy
[71.079927] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[71.225406] [005/133] (947s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[71.317787] Starting subtest: fbc-psr2-sprite-plane-onoff
[71.319740] Starting dynamic subtest: eDP-1
[71.323187] Dynamic subtest eDP-1: SKIP (0.000s)
[71.326817] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.000s)
[71.388644] [006/133] (946s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[71.499253] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[71.500883] Starting dynamic subtest: pipe-A-eDP-1
[71.654155] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.147s)
[71.666889] Starting dynamic subtest: pipe-B-eDP-1
[71.690546] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s)
[71.699471] Starting dynamic subtest: pipe-C-eDP-1
[71.718547] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[71.726183] Starting dynamic subtest: pipe-D-eDP-1
[71.741791] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[71.743514] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.183s)
[73.993305] [007/133] (944s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[74.083425] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[74.087605] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[74.182279] [008/133] (944s left) kms_flip (flip-vs-panning)
[74.281968] Starting subtest: flip-vs-panning
[74.284245] Starting dynamic subtest: A-eDP1
[83.014960] Dynamic subtest A-eDP1: SUCCESS (8.731s)
[83.025327] Starting dynamic subtest: B-eDP1
[91.749551] Dynamic subtest B-eDP1: SUCCESS (8.733s)
[91.758640] Starting dynamic subtest: C-eDP1
[100.467727] Dynamic subtest C-eDP1: SUCCESS (8.717s)
[100.477065] Starting dynamic subtest: D-eDP1
[109.199291] Dynamic subtest D-eDP1: SUCCESS (8.731s)
[109.203931] Subtest flip-vs-panning: SUCCESS (34.924s)
[110.371145] [009/133] (908s left) gem_exec_fence (submit3)
[110.568975] Starting subtest: submit3
[110.574100] Subtest submit3: SKIP (0.000s)
[111.976225] [010/133] (906s left) api_intel_allocator (gem-pool)
[112.030933] Starting subtest: gem-pool
[112.037577] Subtest gem-pool: SUCCESS (0.009s)
[112.130382] [011/133] (906s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[112.180122] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[112.244899] [012/133] (906s left) i915_pm_rpm (sysfs-read)
[114.070606] Starting subtest: sysfs-read
[115.232682] Subtest sysfs-read: SUCCESS (1.159s)
[115.599181] [013/133] (903s left) kms_cursor_crc (cursor-onscreen-64x64)
[115.777943] Starting subtest: cursor-onscreen-64x64
[115.780422] Starting dynamic subtest: pipe-A-eDP-1
[117.893805] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.112s)
[117.923721] Starting dynamic subtest: pipe-D-eDP-1
[120.666410] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.749s)
[120.668458] Subtest cursor-onscreen-64x64: SUCCESS (4.887s)
[121.466898] [014/133] (897s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[121.567881] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[121.572167] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[121.650351] [015/133] (897s left) gem_userptr_blits (forbidden-operations)
[121.716445] Starting subtest: forbidden-operations
[121.721032] Subtest forbidden-operations: SKIP (0.000s)
[121.841403] [016/133] (896s left) kms_big_fb (linear-64bpp-rotate-270)
[121.945482] Starting subtest: linear-64bpp-rotate-270
[121.965617] Subtest linear-64bpp-rotate-270: SKIP (0.020s)
[122.091233] [017/133] (896s left) kms_atomic_transition (plane-all-transition)
[122.192061] Starting subtest: plane-all-transition
[122.194299] Starting dynamic subtest: pipe-A-eDP-1
[124.686157] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[125.001780] Starting dynamic subtest: pipe-B-eDP-1
[128.202759] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.211s)
[128.504070] Subtest plane-all-transition: SUCCESS (6.310s)
[129.326737] [018/133] (889s left) api_intel_bb (reset-flags)
[129.390196] Starting subtest: reset-flags
[129.395554] Subtest reset-flags: SUCCESS (0.007s)
[129.536237] [019/133] (889s left) gem_sync (basic-many-each)
[129.613286] Starting subtest: basic-many-each
[131.915257] Subtest basic-many-each: SUCCESS (2.312s)
[132.115144] [020/133] (886s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[132.212927] Starting subtest: yf-tiled-8bpp-rotate-0
[132.217672] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[132.308357] [021/133] (886s left) gem_exec_balancer (nohangcheck)
[132.576066] Starting subtest: nohangcheck
[133.486622] Subtest nohangcheck: SUCCESS (0.910s)
[133.616579] [022/133] (885s left) kms_plane_alpha_blend (alpha-7efc)
[133.711853] Starting subtest: alpha-7efc
[133.997582] Starting dynamic subtest: pipe-A-eDP-1
[134.609297] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.609s)
[134.635216] Starting dynamic subtest: pipe-D-eDP-1
[135.959494] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.332s)
[135.961843] Subtest alpha-7efc: SUCCESS (2.250s)
[136.803709] [023/133] (882s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[136.905339] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[136.909252] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[136.997856] [024/133] (882s left) gem_softpin (evict-snoop-interruptible)
[137.055045] Starting subtest: evict-snoop-interruptible
[137.059225] Subtest evict-snoop-interruptible: SKIP (0.000s)
[137.161333] [025/133] (881s left) kms_hdmi_inject (inject-audio)
[137.511909] Starting subtest: inject-audio
[137.789751] Subtest inject-audio: SUCCESS (0.278s)
[138.357690] [026/133] (880s left) gem_bad_reloc (negative-reloc-bltcopy)
[138.416463] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[138.490576] [027/133] (880s left) gem_userptr_blits (unsync-overlap)
[138.546925] Subtest unsync-overlap: SKIP (0.000s)
[138.682827] [028/133] (880s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[138.801856] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[138.806317] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[138.944083] [029/133] (880s left) gem_eio (in-flight-internal-immediate)
[139.177599] Starting subtest: in-flight-internal-immediate
[140.964657] Subtest in-flight-internal-immediate: SUCCESS (1.789s)
[141.100419] [030/133] (878s left) kms_pm_backlight (brightness-with-dpms)
[141.190244] Starting subtest: brightness-with-dpms
[141.240854] Starting dynamic subtest: eDP-1
[143.685630] Dynamic subtest eDP-1: SUCCESS (2.443s)
[143.688097] Subtest brightness-with-dpms: SUCCESS (2.497s)
[144.524633] [031/133] (874s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[144.586773] Starting subtest: y-tiled-ccs-to-yf-tiled
[144.591463] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[144.768282] [032/133] (874s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[144.862688] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[144.866728] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[144.975762] [033/133] (874s left) dmabuf_sync_file (import-multiple-read-only)
[145.015077] Starting subtest: import-multiple-read-only
[145.017347] Subtest import-multiple-read-only: SUCCESS (0.003s)
[145.072784] [034/133] (874s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[145.133233] Starting subtest: framebuffer-vs-set-tiling
[145.137357] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[145.282310] [035/133] (874s left) gem_exec_capture (userptr)
[145.333439] Starting subtest: userptr
[146.169878] Subtest userptr: SUCCESS (0.836s)
[146.274386] [036/133] (873s left) fbdev (nullptr)
[146.319484] Starting subtest: nullptr
[146.321838] Subtest nullptr: SUCCESS (0.000s)
[146.373616] [037/133] (873s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[146.462312] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[151.804740] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.345s)
[152.930893] [038/133] (866s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[153.034328] Starting subtest: x-tiled-64bpp-rotate-270
[153.057035] Subtest x-tiled-64bpp-rotate-270: SKIP (0.020s)
[153.169651] [039/133] (866s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[153.265865] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[153.269780] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[153.349148] [040/133] (866s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[153.453968] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[153.458113] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[153.525762] [041/133] (866s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[153.611942] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[153.616121] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[153.697691] [042/133] (866s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[153.774502] Subtest writes-after-reads-uncached: SKIP (0.000s)
[153.833439] [043/133] (865s left) kms_hdr (static-toggle-dpms)
[153.924294] Starting subtest: static-toggle-dpms
[153.929356] Subtest static-toggle-dpms: SKIP (0.000s)
[154.007388] [044/133] (865s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[154.055032] Starting subtest: etime-multi-wait-for-submit-submitted
[154.162883] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.106s)
[154.241746] [045/133] (865s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[154.353813] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[154.357645] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[154.472628] [046/133] (865s left) perf_pmu (idle)
[154.508724] Starting subtest: idle
[154.511206] Starting dynamic subtest: rcs0
[155.056685] Dynamic subtest rcs0: SUCCESS (0.549s)
[155.069203] Starting dynamic subtest: bcs0
[155.577108] Dynamic subtest bcs0: SUCCESS (0.517s)
[155.588310] Starting dynamic subtest: vcs0
[156.097985] Dynamic subtest vcs0: SUCCESS (0.519s)
[156.109894] Starting dynamic subtest: vcs1
[156.617055] Dynamic subtest vcs1: SUCCESS (0.516s)
[156.628267] Starting dynamic subtest: vecs0
[157.136994] Dynamic subtest vecs0: SUCCESS (0.516s)
[157.148754] Starting dynamic subtest: ccs0
[157.665493] Dynamic subtest ccs0: SUCCESS (0.526s)
[157.668596] Subtest idle: SUCCESS (3.160s)
[157.780275] [047/133] (862s left) kms_chamelium_color (degamma)
[157.881310] Subtest degamma: SKIP (0.000s)
[157.928676] [048/133] (862s left) gem_pxp (create-regular-context-2)
[158.055905] Starting subtest: create-regular-context-2
[158.058371] Subtest create-regular-context-2: SUCCESS (0.002s)
[158.168885] [049/133] (861s left) gem_softpin (allocator-basic-reserve)
[158.229145] Starting subtest: allocator-basic-reserve
[158.301198] Subtest allocator-basic-reserve: SUCCESS (0.072s)
[158.418520] [050/133] (861s left) kms_plane_multiple (2x-tiling-none)
[158.520962] Starting subtest: 2x-tiling-none
[158.525460] Subtest 2x-tiling-none: SKIP (0.000s)
[158.604736] [051/133] (861s left) kms_feature_discovery (psr1)
[158.692018] Starting subtest: psr1
[158.693935] Subtest psr1: SUCCESS (0.000s)
[158.762662] [052/133] (861s left) kms_getfb (getfb-handle-protection)
[158.861250] Starting subtest: getfb-handle-protection
[158.883155] Subtest getfb-handle-protection: SUCCESS (0.022s)
[159.004406] [053/133] (861s left) kms_prop_blob (blob-prop-core)
[159.060750] Starting subtest: blob-prop-core
[159.062702] Subtest blob-prop-core: SUCCESS (0.000s)
[159.145792] [054/133] (861s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[159.249345] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[159.251170] Starting dynamic subtest: pipe-A
[160.297614] Dynamic subtest pipe-A: SUCCESS (1.050s)
[160.306463] Starting dynamic subtest: pipe-B
[162.384480] Dynamic subtest pipe-B: SUCCESS (2.086s)
[162.393111] Starting dynamic subtest: pipe-C
[163.561074] Dynamic subtest pipe-C: SUCCESS (1.175s)
[163.572784] Starting dynamic subtest: pipe-D
[164.758431] Dynamic subtest pipe-D: SUCCESS (1.196s)
[164.760976] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.511s)
[165.911732] [055/133] (854s left) gem_create (create-size-update)
[165.966605] Starting subtest: create-size-update
[165.968929] Subtest create-size-update: SUCCESS (0.000s)
[166.173353] [056/133] (854s left) syncobj_timeline (transfer-timeline-point)
[166.227399] Starting subtest: transfer-timeline-point
[166.229636] Subtest transfer-timeline-point: SUCCESS (0.000s)
[166.336128] [057/133] (854s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[166.423277] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[166.425587] Starting dynamic subtest: pipe-A-eDP-1
[166.911282] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.460s)
[166.920750] Starting dynamic subtest: pipe-B-eDP-1
[168.360124] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.446s)
[168.370528] Starting dynamic subtest: pipe-C-eDP-1
[169.815786] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.456s)
[169.826637] Starting dynamic subtest: pipe-D-eDP-1
[171.186292] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.370s)
[171.188447] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.737s)
[172.325625] [058/133] (848s left) vgem_basic (dmabuf-fence)
[172.376681] Starting subtest: dmabuf-fence
[172.378813] Subtest dmabuf-fence: SUCCESS (0.001s)
[172.434241] [059/133] (848s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[172.528820] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[172.533220] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[172.620898] [060/133] (847s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[172.718267] Starting subtest: random-ccs-data-y-tiled-ccs
[172.720586] Starting dynamic subtest: pipe-A-eDP-1
[172.745160] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[172.756409] Starting dynamic subtest: pipe-B-eDP-1
[172.779102] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[172.787910] Starting dynamic subtest: pipe-C-eDP-1
[172.810635] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[172.819456] Starting dynamic subtest: pipe-D-eDP-1
[172.842406] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[172.846211] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.005s)
[175.024929] [061/133] (845s left) kms_addfb_basic (bad-pitch-63)
[175.085949] Starting subtest: bad-pitch-63
[175.088262] Subtest bad-pitch-63: SUCCESS (0.000s)
[175.242294] [062/133] (845s left) gem_exec_schedule (u-semaphore-user)
[175.315305] Starting subtest: u-semaphore-user
[175.367872] Subtest u-semaphore-user: SUCCESS (0.061s)
[176.954907] [063/133] (843s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[177.048417] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[177.050606] Starting dynamic subtest: pipe-A-eDP-1
[177.145584] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[177.155035] Starting dynamic subtest: pipe-B-eDP-1
[178.265219] Dynamic subtest pipe-B-eDP-1: SKIP (1.117s)
[178.269329] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.220s)
[179.518377] [064/133] (841s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[179.621908] Starting subtest: extended-modeset-hang-oldfb-with-reset
[179.624213] Starting dynamic subtest: pipe-A
[191.470044] Dynamic subtest pipe-A: SUCCESS (11.845s)
[191.480241] Starting dynamic subtest: pipe-D
[203.667677] Dynamic subtest pipe-D: SUCCESS (12.198s)
[203.669941] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.047s)
[204.518970] [065/133] (816s left) gem_mmap_gtt (cpuset-big-copy-xy)
[204.580237] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[204.646740] [066/133] (816s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[204.777381] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[215.943764] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.164s)
[216.836423] [067/133] (803s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[216.939246] Starting subtest: basic-modeset-with-all-modifiers-formats
[217.319741] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[218.061954] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.742s)
[218.071954] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[218.084053] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[218.093078] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[218.106239] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.021s)
[218.115969] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[218.250742] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.144s)
[218.260844] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[218.272986] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[218.282335] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[218.295172] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.021s)
[218.304243] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[218.317528] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.021s)
[218.326554] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[218.339861] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[218.349076] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[218.361607] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[218.370795] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[218.384223] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[218.393685] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[218.406264] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[218.415214] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[218.428692] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.021s)
[218.437927] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[218.584098] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s)
[218.593624] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[218.606282] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[218.615442] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[218.628672] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s)
[218.637921] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[218.650618] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.021s)
[218.659640] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[218.673131] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.021s)
[218.682512] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[218.695271] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.021s)
[218.704597] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[218.717272] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.021s)
[218.726830] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[218.739837] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[218.749616] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[218.761878] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.021s)
[218.771392] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[218.917885] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s)
[218.928470] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[218.940080] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[218.953070] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[218.962281] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.021s)
[218.975030] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[218.984622] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.021s)
[218.998367] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[219.006314] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.021s)
[219.014857] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[219.028713] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[219.037366] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[219.050904] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.021s)
[219.059517] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[219.072989] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.021s)
[219.081687] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[219.095190] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.021s)
[219.480015] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.543s)
[220.342114] [068/133] (800s left) i915_query (query-regions-sanity-check)
[220.397357] Starting subtest: query-regions-sanity-check
[220.407218] Subtest query-regions-sanity-check: SUCCESS (0.012s)
[220.525526] [069/133] (800s left) gem_exec_whisper (basic-normal-all)
[220.583743] Starting subtest: basic-normal-all
[223.026629] Subtest basic-normal-all: SUCCESS (2.440s)
[223.210943] [070/133] (797s left) gem_mmap_offset (blt-coherency)
[223.269544] Starting subtest: blt-coherency
[223.279570] Subtest blt-coherency: SUCCESS (0.012s)
[223.402281] [071/133] (797s left) kms_flip (flip-vs-suspend)
[223.499075] Starting subtest: flip-vs-suspend
[223.501414] Starting dynamic subtest: A-eDP1
[272.726126] Dynamic subtest A-eDP1: SUCCESS (4.707s)
[272.739463] Starting dynamic subtest: B-eDP1
[321.717679] Dynamic subtest B-eDP1: SUCCESS (4.459s)
[321.732099] Starting dynamic subtest: C-eDP1
[370.717010] Dynamic subtest C-eDP1: SUCCESS (4.459s)
[370.731554] Starting dynamic subtest: D-eDP1
[419.710096] Dynamic subtest D-eDP1: SUCCESS (4.487s)
[419.713269] Subtest flip-vs-suspend: SUCCESS (18.122s)
[420.891016] [072/133] (600s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[421.010738] Starting subtest: basic-busy-flip-before-cursor-atomic
[421.016197] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[421.156426] [073/133] (599s left) kms_psr (psr-cursor-blt)
[421.240917] Starting subtest: psr-cursor-blt
[421.243600] Starting dynamic subtest: eDP-1
[422.961379] Dynamic subtest eDP-1: SUCCESS (1.719s)
[422.964147] Subtest psr-cursor-blt: SUCCESS (1.720s)
[423.792566] [074/133] (597s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[423.882345] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[423.884841] Starting dynamic subtest: pipe-A-eDP-1
[435.212671] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.331s)
[435.224615] Starting dynamic subtest: pipe-B-eDP-1
[447.211639] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.994s)
[447.214528] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.327s)
[448.031864] [075/133] (573s left) gem_exec_reloc (basic-write-read-active)
[448.094954] Subtest basic-write-read-active: SKIP (0.000s)
[448.167805] [076/133] (573s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[448.262956] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[452.873100] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.615s)
[454.018607] [077/133] (567s left) kms_flip (2x-nonexisting-fb)
[454.119160] Starting subtest: 2x-nonexisting-fb
[454.130399] Subtest 2x-nonexisting-fb: SKIP (0.010s)
[454.225032] [078/133] (567s left) gem_ctx_isolation (preservation-reset)
[454.393054] Starting subtest: preservation-reset
[454.395826] Starting dynamic subtest: rcs0
[454.698073] Dynamic subtest rcs0: SUCCESS (0.308s)
[454.711786] Starting dynamic subtest: bcs0
[455.036161] Dynamic subtest bcs0: SUCCESS (0.336s)
[455.049086] Starting dynamic subtest: vcs0
[455.382109] Dynamic subtest vcs0: SUCCESS (0.345s)
[455.393343] Starting dynamic subtest: vcs1
[457.310160] Dynamic subtest vcs1: SUCCESS (1.927s)
[457.322987] Starting dynamic subtest: vecs0
[459.305174] Dynamic subtest vecs0: SUCCESS (1.993s)
[459.315589] Starting dynamic subtest: ccs0
[461.299947] Dynamic subtest ccs0: SUCCESS (1.992s)
[461.302637] Subtest preservation-reset: SUCCESS (6.911s)
[461.435304] [079/133] (559s left) syncobj_eventfd (invalid-bad-pad)
[461.490060] Starting subtest: invalid-bad-pad
[461.493445] Subtest invalid-bad-pad: SUCCESS (0.000s)
[461.580227] [080/133] (559s left) kms_universal_plane (cursor-fb-leak)
[461.671978] Starting subtest: cursor-fb-leak
[461.674194] Starting dynamic subtest: pipe-A-eDP-1
[462.068495] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.397s)
[462.081758] Starting dynamic subtest: pipe-B-eDP-1
[463.503397] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.432s)
[463.517008] Starting dynamic subtest: pipe-C-eDP-1
[464.885763] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.379s)
[464.904338] Starting dynamic subtest: pipe-D-eDP-1
[466.274753] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.385s)
[466.277859] Subtest cursor-fb-leak: SUCCESS (4.604s)
[467.504528] [081/133] (553s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[467.622664] Starting subtest: cursor-vs-flip-varying-size
[498.963840] Subtest cursor-vs-flip-varying-size: SUCCESS (31.338s)
[499.807788] [082/133] (521s left) prime_busy (hang)
[499.881174] Starting subtest: hang
[499.884462] Starting dynamic subtest: rcs0
[526.480056] Dynamic subtest rcs0: SUCCESS (26.592s)
[526.491196] Starting dynamic subtest: bcs0
[533.636017] Dynamic subtest bcs0: SUCCESS (7.152s)
[533.646275] Starting dynamic subtest: vcs0
[540.671470] Dynamic subtest vcs0: SUCCESS (7.036s)
[540.682486] Starting dynamic subtest: vcs1
[547.649157] Dynamic subtest vcs1: SUCCESS (6.976s)
[547.662120] Starting dynamic subtest: vecs0
[554.618215] Dynamic subtest vecs0: SUCCESS (6.970s)
[554.630987] Starting dynamic subtest: ccs0
[568.525541] Dynamic subtest ccs0: SUCCESS (13.904s)
[568.528032] Subtest hang: SUCCESS (68.636s)
[568.637857] [083/133] (452s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[568.689849] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[568.692577] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[568.805635] [084/133] (452s left) gem_exec_balancer (parallel-keep-in-fence)
[569.089476] Starting subtest: parallel-keep-in-fence
[570.502334] Subtest parallel-keep-in-fence: SUCCESS (1.413s)
[570.609112] [085/133] (450s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[570.712091] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[570.717170] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[570.785454] [086/133] (450s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[570.899016] Starting subtest: flip-vs-cursor-legacy
[578.392715] Subtest flip-vs-cursor-legacy: SUCCESS (7.495s)
[579.197524] [087/133] (442s left) i915_hangman (gt-engine-error)
[579.265033] Starting subtest: gt-engine-error
[579.267500] Starting dynamic subtest: rcs0
[580.945629] Dynamic subtest rcs0: SUCCESS (1.681s)
[580.959030] Starting dynamic subtest: bcs0
[582.928565] Dynamic subtest bcs0: SUCCESS (1.980s)
[582.942053] Starting dynamic subtest: vcs0
[584.913676] Dynamic subtest vcs0: SUCCESS (1.982s)
[584.928099] Starting dynamic subtest: vcs1
[586.961612] Dynamic subtest vcs1: SUCCESS (2.045s)
[586.976557] Starting dynamic subtest: vecs0
[588.945771] Dynamic subtest vecs0: SUCCESS (1.981s)
[588.961813] Starting dynamic subtest: ccs0
[590.928538] Dynamic subtest ccs0: SUCCESS (1.980s)
[590.931561] Subtest gt-engine-error: SUCCESS (11.665s)
[591.044719] [088/133] (430s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[591.140693] Starting subtest: 4-tiled-64bpp-rotate-0
[592.799050] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.660s)
[592.972713] [089/133] (428s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[593.079914] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[593.084575] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[593.191593] [090/133] (428s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[593.294698] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[594.198283] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.904s)
[594.351348] [091/133] (427s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[594.422084] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[594.540594] [092/133] (427s left) prime_self_import (basic-with_one_bo_two_files)
[594.581866] Starting subtest: basic-with_one_bo_two_files
[594.590160] Subtest basic-with_one_bo_two_files: SUCCESS (0.013s)
[594.676670] [093/133] (427s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[594.722784] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[594.772574] [094/133] (427s left) gem_exec_params (invalid-batch-start-offset)
[594.826445] Starting subtest: invalid-batch-start-offset
[594.829039] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[594.939066] [095/133] (427s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[595.049311] Starting subtest: y-tiled-8bpp-rotate-270
[595.054455] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[595.139390] [096/133] (426s left) gem_eio (create)
[595.346781] Starting subtest: create
[595.656506] Subtest create: SUCCESS (0.309s)
[595.792372] [097/133] (426s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[595.879492] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[595.881728] Starting dynamic subtest: pipe-A-eDP-1
[595.902321] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[595.914107] Starting dynamic subtest: pipe-B-eDP-1
[595.934833] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[595.943977] Starting dynamic subtest: pipe-C-eDP-1
[595.965711] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[595.975023] Starting dynamic subtest: pipe-D-eDP-1
[595.996940] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[596.001386] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[598.109926] [098/133] (424s left) kms_psr (pr-primary-blt)
[598.195999] Starting subtest: pr-primary-blt
[598.200984] Subtest pr-primary-blt: SKIP (0.000s)
[598.275026] [099/133] (423s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[598.535808] Starting subtest: cursor-rapid-movement-256x256
[598.538465] Starting dynamic subtest: pipe-A-eDP-1
[599.095155] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.555s)
[599.125306] Starting dynamic subtest: pipe-D-eDP-1
[600.283851] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.168s)
[600.285876] Subtest cursor-rapid-movement-256x256: SUCCESS (1.749s)
[601.101552] [100/133] (421s left) gem_exec_params (sol-reset-invalid)
[601.161969] Starting subtest: sol-reset-invalid
[601.163935] Subtest sol-reset-invalid: SUCCESS (0.003s)
[603.013684] [101/133] (419s left) gem_exec_params (invalid-fence-in)
[603.081682] Starting subtest: invalid-fence-in
[603.084337] Subtest invalid-fence-in: SUCCESS (0.000s)
[603.183575] [102/133] (419s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[603.278208] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[603.283650] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[603.384071] [103/133] (419s left) syncobj_wait (wait-all-complex)
[603.438058] Starting subtest: wait-all-complex
[603.655116] Subtest wait-all-complex: SUCCESS (0.217s)
[603.732395] [104/133] (418s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[603.842054] Starting subtest: fbcpsr-rgb101010-draw-render
[610.522120] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.685s)
[610.616139] [105/133] (411s left) kms_lease (lease-unleased-connector)
[610.710352] Starting subtest: lease-unleased-connector
[610.712952] Starting dynamic subtest: pipe-A-eDP-1
[610.715581] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[610.726643] Starting dynamic subtest: pipe-B-eDP-1
[610.729236] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[610.740568] Starting dynamic subtest: pipe-C-eDP-1
[610.743673] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[610.754106] Starting dynamic subtest: pipe-D-eDP-1
[610.756808] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[610.759046] Subtest lease-unleased-connector: SUCCESS (0.035s)
[610.871616] [106/133] (411s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[611.271968] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[612.084785] [107/133] (410s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[612.185832] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[616.096923] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (3.915s)
[617.321229] [108/133] (405s left) kms_fbcon_fbt (fbc)
[617.379978] Starting subtest: fbc
[623.837642] Subtest fbc: SUCCESS (6.455s)
[624.992912] [109/133] (397s left) kms_vblank (wait-idle-hang)
[625.091166] Starting subtest: wait-idle-hang
[625.093448] Starting dynamic subtest: pipe-A-eDP-1
[651.756092] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.661s)
[651.772158] Starting dynamic subtest: pipe-D-eDP-1
[676.731079] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.969s)
[676.734027] Subtest wait-idle-hang: SUCCESS (51.634s)
[677.595830] [110/133] (345s left) kms_cursor_edge_walk (256x256-top-edge)
[677.689156] Starting subtest: 256x256-top-edge
[677.692043] Starting dynamic subtest: pipe-A-eDP-1
[681.142116] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.455s)
[681.152743] Starting dynamic subtest: pipe-D-eDP-1
[684.329781] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.186s)
[684.332522] Subtest 256x256-top-edge: SUCCESS (6.644s)
[685.197425] [111/133] (337s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[685.256015] Starting subtest: multi-wait-all-for-submit-available-signaled
[685.258741] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[685.348568] [112/133] (337s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[685.447151] Starting subtest: fbc-psr2-cursor-plane-onoff
[685.449994] Starting dynamic subtest: eDP-1
[685.455679] Dynamic subtest eDP-1: SKIP (0.000s)
[685.461025] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[685.522457] [113/133] (337s left) kms_pm_rpm (modeset-lpsp)
[687.149665] Starting subtest: modeset-lpsp
[688.600050] Subtest modeset-lpsp: SUCCESS (1.450s)
[688.703561] [114/133] (334s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[688.817901] Starting subtest: cursorB-vs-flipB-atomic
[688.823177] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[688.963546] [115/133] (333s left) kms_vrr (seamless-rr-switch-drrs)
[689.050588] Starting subtest: seamless-rr-switch-drrs
[689.058119] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[689.124701] [116/133] (333s left) gem_exec_params (dr4-dirt)
[689.183918] Starting subtest: DR4-dirt
[689.186794] Subtest DR4-dirt: SUCCESS (0.000s)
[689.289129] [117/133] (333s left) gem_exec_schedule (preempt-other-chain)
[689.360947] Starting subtest: preempt-other-chain
[689.363404] Starting dynamic subtest: rcs0
[689.446922] Dynamic subtest rcs0: SUCCESS (0.094s)
[689.457147] Starting dynamic subtest: bcs0
[689.539191] Dynamic subtest bcs0: SUCCESS (0.091s)
[689.555170] Starting dynamic subtest: vcs0
[689.620498] Dynamic subtest vcs0: SUCCESS (0.081s)
[689.637309] Starting dynamic subtest: vcs1
[689.701267] Dynamic subtest vcs1: SUCCESS (0.080s)
[689.717294] Starting dynamic subtest: vecs0
[689.778450] Dynamic subtest vecs0: SUCCESS (0.076s)
[689.792899] Starting dynamic subtest: ccs0
[689.868364] Dynamic subtest ccs0: SUCCESS (0.090s)
[689.870194] Subtest preempt-other-chain: SUCCESS (0.517s)
[691.012998] [118/133] (332s left) i915_drm_fdinfo (memory-info-shared)
[691.062463] Starting subtest: memory-info-shared
[691.065003] Starting dynamic subtest: smem0
[691.124785] Dynamic subtest smem0: SUCCESS (0.066s)
[691.127714] Subtest memory-info-shared: SUCCESS (0.067s)
[691.201058] [119/133] (331s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[691.307212] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[697.885889] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.582s)
[698.015117] [120/133] (325s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[698.110870] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[705.169176] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.062s)
[705.272004] [121/133] (317s left) gem_ctx_persistence (legacy-engines-hostile)
[705.337034] Starting subtest: legacy-engines-hostile
[705.340028] Starting dynamic subtest: render
[705.458907] Dynamic subtest render: SUCCESS (0.121s)
[705.471228] Starting dynamic subtest: bsd1
[705.549472] Dynamic subtest bsd1: SUCCESS (0.088s)
[705.562580] Starting dynamic subtest: bsd2
[705.646705] Dynamic subtest bsd2: SUCCESS (0.095s)
[705.657261] Starting dynamic subtest: blt
[705.757442] Dynamic subtest blt: SUCCESS (0.108s)
[705.770746] Starting dynamic subtest: vebox
[705.846438] Dynamic subtest vebox: SUCCESS (0.087s)
[705.849339] Subtest legacy-engines-hostile: SUCCESS (0.510s)
[705.928494] [122/133] (317s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[706.015766] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[706.017991] Starting dynamic subtest: pipe-A-eDP-1
[706.042866] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[706.053443] Starting dynamic subtest: pipe-B-eDP-1
[706.075274] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[706.084776] Starting dynamic subtest: pipe-C-eDP-1
[706.103819] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[706.113211] Starting dynamic subtest: pipe-D-eDP-1
[706.132812] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[706.136643] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.005s)
[708.302410] [123/133] (314s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[708.351566] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[708.455422] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.104s)
[708.534604] [124/133] (314s left) gem_sync (basic-each)
[708.615866] Starting subtest: basic-each
[710.943432] Subtest basic-each: SUCCESS (2.342s)
[711.136105] [125/133] (312s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[711.255567] Starting subtest: cursor-vs-flip-atomic-transitions
[741.605763] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.349s)
[742.407715] [126/133] (281s left) gem_mmap_gtt (basic-small-copy-xy)
[742.460609] Subtest basic-small-copy-XY: SKIP (0.000s)
[742.529720] [127/133] (280s left) gem_pxp (reject-modify-context-protection-off-3)
[742.625715] Starting subtest: reject-modify-context-protection-off-3
[742.627985] Subtest reject-modify-context-protection-off-3: SUCCESS (0.001s)
[742.745337] [128/133] (280s left) sysfs_heartbeat_interval (nopreempt)
[742.798710] Starting subtest: nopreempt
[742.801237] Starting dynamic subtest: vecs0
[751.986206] Dynamic subtest vecs0: SUCCESS (9.183s)
[751.999359] Starting dynamic subtest: ccs0
[755.975904] Dynamic subtest ccs0: SUCCESS (3.989s)
[755.987197] Starting dynamic subtest: vcs0
[765.999159] Dynamic subtest vcs0: SUCCESS (10.020s)
[766.016182] Starting dynamic subtest: bcs0
[769.909000] Dynamic subtest bcs0: SUCCESS (3.909s)
[769.926022] Starting dynamic subtest: rcs0
[773.904159] Dynamic subtest rcs0: SUCCESS (3.995s)
[773.916619] Starting dynamic subtest: vcs1
[782.951739] Dynamic subtest vcs1: SUCCESS (9.043s)
[782.954742] Subtest nopreempt: SUCCESS (40.148s)
[783.042554] [129/133] (240s left) kms_content_protection (content-type-change)
[783.206053] Starting subtest: content-type-change
[783.210992] Subtest content-type-change: SKIP (0.000s)
[783.325074] [130/133] (240s left) kms_psr (psr-suspend)
[783.408043] Starting subtest: psr-suspend
[783.410877] Starting dynamic subtest: eDP-1
[801.135928] Dynamic subtest eDP-1: SUCCESS (2.976s)
[801.138601] Subtest psr-suspend: SUCCESS (2.978s)
[801.982042] [131/133] (221s left) gen9_exec_parse (batch-invalid-length)
[802.055383] Subtest batch-invalid-length: SKIP (0.000s)
[802.124951] [132/133] (221s left) kms_atomic_transition (modeset-transition)
[802.221407] Starting subtest: modeset-transition
[802.223791] Starting dynamic subtest: 1x-outputs
[813.139110] Dynamic subtest 1x-outputs: SUCCESS (10.925s)
[813.141330] Subtest modeset-transition: SUCCESS (10.927s)
[813.970826] [133/133] (209s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[814.069190] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[814.071778] Starting dynamic subtest: pipe-A-default-mode
[816.730489] Dynamic subtest pipe-A-default-mode: SUCCESS (2.662s)
[816.733589] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.664s)
[817.574250] 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.