[57.758749] Initializing watchdogs
[57.758794]   /dev/watchdog0
[57.772862] [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.777550] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.780520] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.784151] [001/133] (960s left) vgem_basic (second-client)
[57.868303] Starting subtest: second-client
[57.892263] Subtest second-client: SUCCESS (0.021s)
[57.944514] [FACT vgem_basic (second-client)] new: kernel.kmod_is_loaded.vgem: true
[57.947582] [002/133] (960s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[58.068974] Starting subtest: cursorA-vs-flipB-atomic-transitions
[58.073491] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[58.213104] [003/133] (960s left) syncobj_timeline (multi-wait-available-submitted)
[58.273116] Starting subtest: multi-wait-available-submitted
[58.275469] Subtest multi-wait-available-submitted: SUCCESS (0.001s)
[58.360240] [004/133] (960s left) kms_invalid_mode (bad-vsync-end)
[58.447594] Starting subtest: bad-vsync-end
[58.449946] Starting dynamic subtest: pipe-A-eDP-1
[58.739615] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[58.746649] Starting dynamic subtest: pipe-B-eDP-1
[58.748546] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[58.754706] Starting dynamic subtest: pipe-C-eDP-1
[58.756628] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[58.763116] Starting dynamic subtest: pipe-D-eDP-1
[58.765209] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[58.767357] Subtest bad-vsync-end: SUCCESS (0.293s)
[59.591076] [005/133] (958s left) kms_pm_backlight (fade-with-dpms)
[59.686394] Starting subtest: fade-with-dpms
[61.885559] Starting dynamic subtest: eDP-1
[64.393425] Dynamic subtest eDP-1: SUCCESS (2.496s)
[64.395971] Subtest fade-with-dpms: SUCCESS (4.684s)
[65.186235] [006/133] (953s left) kms_flip (bo-too-big-interruptible)
[65.284978] Starting subtest: bo-too-big-interruptible
[65.287451] Starting dynamic subtest: A-eDP1
[66.549394] Dynamic subtest A-eDP1: SUCCESS (1.260s)
[66.558094] Starting dynamic subtest: B-eDP1
[67.788046] Dynamic subtest B-eDP1: SUCCESS (1.234s)
[67.800445] Starting dynamic subtest: C-eDP1
[69.111058] Dynamic subtest C-eDP1: SUCCESS (1.319s)
[69.120714] Starting dynamic subtest: D-eDP1
[70.356249] Dynamic subtest D-eDP1: SUCCESS (1.242s)
[70.358561] Subtest bo-too-big-interruptible: SUCCESS (5.063s)
[71.566744] [007/133] (946s left) gem_mmap_gtt (basic-read)
[71.618657] Subtest basic-read: SKIP (0.000s)
[71.677376] [008/133] (946s left) gem_softpin (allocator-evict)
[71.730127] Starting subtest: allocator-evict
[71.732561] Starting dynamic subtest: rcs0
[95.196189] Dynamic subtest rcs0: SUCCESS (23.448s)
[95.203753] Starting dynamic subtest: bcs0
[118.962498] Dynamic subtest bcs0: SUCCESS (23.759s)
[118.972147] Starting dynamic subtest: vcs0
[142.465016] Dynamic subtest vcs0: SUCCESS (23.497s)
[142.477673] Starting dynamic subtest: vcs1
[165.964104] Dynamic subtest vcs1: SUCCESS (23.499s)
[165.973626] Starting dynamic subtest: vecs0
[189.661905] Dynamic subtest vecs0: SUCCESS (23.696s)
[189.672555] Starting dynamic subtest: ccs0
[213.692679] Dynamic subtest ccs0: SUCCESS (24.029s)
[213.695083] Subtest allocator-evict: SUCCESS (141.932s)
[213.773936] [009/133] (804s left) gem_render_linear_blits (basic)
[213.874126] Starting subtest: basic
[213.916936] Subtest basic: SUCCESS (0.043s)
[214.000079] [010/133] (804s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[214.099970] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[214.104195] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[214.194187] [011/133] (804s left) kms_psr (psr-primary-mmap-cpu)
[214.290113] Starting subtest: psr-primary-mmap-cpu
[214.292402] Starting dynamic subtest: eDP-1
[216.065168] Dynamic subtest eDP-1: SUCCESS (1.776s)
[216.067590] Subtest psr-primary-mmap-cpu: SUCCESS (1.777s)
[216.933379] [012/133] (801s left) kms_chamelium_edid (hdmi-mode-timings)
[217.314489] Subtest hdmi-mode-timings: SKIP (0.000s)
[218.147021] [013/133] (800s left) gen7_exec_parse (load-register-reg)
[218.205756] Subtest load-register-reg: SKIP (0.000s)
[218.284538] [014/133] (800s left) syncobj_eventfd (invalid-bad-flags)
[218.347454] Starting subtest: invalid-bad-flags
[218.349893] Subtest invalid-bad-flags: SUCCESS (0.000s)
[218.458831] [015/133] (800s left) gem_ctx_exec (basic-invalid-context)
[218.511919] Starting subtest: basic-invalid-context
[218.516649] Subtest basic-invalid-context: SUCCESS (0.005s)
[218.654106] [016/133] (800s left) gem_exec_reloc (basic-write-read-active)
[218.708415] Subtest basic-write-read-active: SKIP (0.000s)
[218.785836] [017/133] (800s left) kms_vblank (wait-busy-hang)
[218.873993] Starting subtest: wait-busy-hang
[218.875892] Starting dynamic subtest: pipe-A-eDP-1
[245.715191] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.839s)
[245.731624] Starting dynamic subtest: pipe-D-eDP-1
[260.695305] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.976s)
[260.697660] Subtest wait-busy-hang: SUCCESS (41.820s)
[261.506704] [018/133] (757s left) kms_chamelium_color (ctm-0-50)
[261.603693] Subtest ctm-0-50: SKIP (0.000s)
[261.646963] [019/133] (757s left) gem_exec_flush (basic-uc-prw-default)
[261.712587] Starting subtest: basic-uc-prw-default
[267.197271] Subtest basic-uc-prw-default: SUCCESS (5.460s)
[267.356789] [020/133] (751s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[267.448725] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[273.910378] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.462s)
[274.025085] [021/133] (745s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[274.136382] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[274.140668] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[274.209478] [022/133] (744s left) kms_plane_scaling (planes-upscale-factor-0-25)
[274.306175] Starting subtest: planes-upscale-factor-0-25
[274.308467] Starting dynamic subtest: pipe-A
[274.365751] Dynamic subtest pipe-A: SUCCESS (0.062s)
[274.374086] Starting dynamic subtest: pipe-B
[275.543519] Dynamic subtest pipe-B: SUCCESS (1.177s)
[275.553499] Starting dynamic subtest: pipe-C
[276.659386] Dynamic subtest pipe-C: SUCCESS (1.115s)
[276.667159] Starting dynamic subtest: pipe-D
[277.788173] Dynamic subtest pipe-D: SUCCESS (1.128s)
[277.790443] Subtest planes-upscale-factor-0-25: SUCCESS (3.484s)
[278.938097] [023/133] (740s left) i915_selftest (perf)
[282.227377] Starting subtest: perf
[282.233362] Starting dynamic subtest: engine_cs
[285.001479] Dynamic subtest engine_cs: SUCCESS (2.773s)
[285.010080] Starting dynamic subtest: request
[290.289255] Dynamic subtest request: SUCCESS (5.286s)
[290.298635] Starting dynamic subtest: migrate
[294.559036] Dynamic subtest migrate: SUCCESS (4.269s)
[294.568412] Starting dynamic subtest: region
[300.166155] Dynamic subtest region: SUCCESS (5.607s)
[300.168645] Subtest perf: SUCCESS (17.939s)
[300.196520] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[300.197320] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[300.200272] [024/133] (719s left) kms_color (legacy-gamma)
[301.723439] Starting subtest: legacy-gamma
[301.725661] Starting dynamic subtest: pipe-A-eDP-1
[302.460656] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.737s)
[302.469720] Starting dynamic subtest: pipe-B-eDP-1
[303.846087] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.385s)
[303.854752] Starting dynamic subtest: pipe-C-eDP-1
[305.163916] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.318s)
[305.174536] Starting dynamic subtest: pipe-D-eDP-1
[306.537914] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.372s)
[306.540062] Subtest legacy-gamma: SUCCESS (4.815s)
[307.442928] [FACT kms_color (legacy-gamma)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[307.444124] [FACT kms_color (legacy-gamma)] new: kernel.kmod_is_loaded.i915: true
[307.448046] [025/133] (711s left) perf (gen12-mi-rpc)
[307.595411] Starting subtest: gen12-mi-rpc
[307.597318] Starting dynamic subtest: rcs0
[307.611793] Dynamic subtest rcs0: SUCCESS (0.017s)
[307.614035] Subtest gen12-mi-rpc: SUCCESS (0.017s)
[307.648639] [026/133] (711s left) syncobj_timeline (invalid-wait-bad-flags)
[307.701930] Starting subtest: invalid-wait-bad-flags
[307.704144] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[307.802359] [027/133] (711s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[307.928261] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[307.933096] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[308.084241] [028/133] (711s left) gem_eio (kms)
[308.278045] Starting subtest: kms
[324.897409] Subtest kms: SUCCESS (16.618s)
[326.080185] [029/133] (693s left) gem_exec_fence (long-history)
[326.495597] Starting subtest: long-history
[333.636608] Subtest long-history: SUCCESS (7.142s)
[334.099474] [030/133] (685s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[334.200546] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[334.204838] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[334.311828] [031/133] (685s left) gem_render_copy (y-tiled)
[334.372045] Starting subtest: y-tiled
[334.376204] Subtest y-tiled: SKIP (0.000s)
[334.563910] [032/133] (684s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[334.663052] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[334.665277] Starting dynamic subtest: pipe-A-default-mode
[335.830740] Dynamic subtest pipe-A-default-mode: SKIP (1.166s)
[335.835190] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.168s)
[335.985943] [033/133] (683s left) sw_sync (sync_multi_consumer)
[336.024612] Starting subtest: sync_multi_consumer
[336.450817] Subtest sync_multi_consumer: SUCCESS (0.427s)
[336.509878] [034/133] (683s left) gem_exec_schedule (noreorder-priority)
[336.686640] Starting subtest: noreorder-priority
[336.689127] Starting dynamic subtest: rcs0
[337.818398] Dynamic subtest rcs0: SUCCESS (1.131s)
[337.833370] Starting dynamic subtest: vcs0
[340.886536] Dynamic subtest vcs0: SUCCESS (3.066s)
[340.897859] Starting dynamic subtest: vcs1
[342.926479] Dynamic subtest vcs1: SUCCESS (2.038s)
[342.937931] Starting dynamic subtest: vecs0
[344.915490] Dynamic subtest vecs0: SUCCESS (1.986s)
[344.926864] Starting dynamic subtest: ccs0
[346.059640] Dynamic subtest ccs0: SUCCESS (1.144s)
[346.062208] Subtest noreorder-priority: SUCCESS (9.372s)
[346.251741] [035/133] (673s left) gem_tiled_fence_blits (basic)
[346.313589] Subtest basic: SKIP (0.000s)
[346.387097] [036/133] (673s left) i915_pm_rpm (gem-execbuf-stress)
[348.119326] Starting subtest: gem-execbuf-stress
[348.121539] Starting dynamic subtest: smem0
[361.057096] Dynamic subtest smem0: SUCCESS (12.941s)
[361.068661] Starting dynamic subtest: extra-wait-smem0
[423.073978] Dynamic subtest extra-wait-smem0: SUCCESS (62.008s)
[423.076877] Subtest gem-execbuf-stress: SUCCESS (74.954s)
[423.449989] [037/133] (596s left) kms_addfb_basic (basic-y-tiled-legacy)
[423.514830] Starting subtest: basic-y-tiled-legacy
[423.519595] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[423.661958] [038/133] (596s left) kms_concurrent (multi-plane-atomic-lowres)
[423.758218] Starting subtest: multi-plane-atomic-lowres
[423.760087] Starting dynamic subtest: pipe-A-eDP-1
[424.303743] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.545s)
[424.312489] Starting dynamic subtest: pipe-B-eDP-1
[425.598285] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.293s)
[425.607618] Starting dynamic subtest: pipe-C-eDP-1
[426.776441] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.178s)
[426.784699] Starting dynamic subtest: pipe-D-eDP-1
[428.031732] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.251s)
[428.034133] Subtest multi-plane-atomic-lowres: SUCCESS (4.272s)
[428.862546] [039/133] (590s left) gem_exec_balancer (bonded-true-hang)
[429.123069] Starting subtest: bonded-true-hang
[429.128123] Subtest bonded-true-hang: SKIP (0.000s)
[429.229934] [040/133] (590s left) prime_self_import (basic-with_two_bos)
[429.270442] Starting subtest: basic-with_two_bos
[429.293292] Subtest basic-with_two_bos: SUCCESS (0.024s)
[429.386217] [041/133] (590s left) gem_partial_pwrite_pread (reads)
[429.437509] Subtest reads: SKIP (0.000s)
[429.509553] [042/133] (590s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[429.570487] Starting subtest: invalid-multi-wait-unsubmitted
[429.572417] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[429.665360] [043/133] (590s left) sysfs_timeslice_duration (idempotent)
[429.720702] Starting subtest: idempotent
[429.722936] Starting dynamic subtest: vecs0
[429.725280] Dynamic subtest vecs0: SUCCESS (0.000s)
[429.733530] Starting dynamic subtest: ccs0
[429.735394] Dynamic subtest ccs0: SUCCESS (0.000s)
[429.743514] Starting dynamic subtest: vcs0
[429.745631] Dynamic subtest vcs0: SUCCESS (0.000s)
[429.753782] Starting dynamic subtest: bcs0
[429.755643] Dynamic subtest bcs0: SUCCESS (0.000s)
[429.763249] Starting dynamic subtest: rcs0
[429.765114] Dynamic subtest rcs0: SUCCESS (0.001s)
[429.772615] Starting dynamic subtest: vcs1
[429.774492] Dynamic subtest vcs1: SUCCESS (0.000s)
[429.776332] Subtest idempotent: SUCCESS (0.006s)
[429.812277] [044/133] (590s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[429.904740] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[429.908809] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[429.984298] [045/133] (590s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[430.081171] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[437.137816] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.059s)
[437.273556] [046/133] (582s left) kms_vblank (query-busy)
[437.373145] Starting subtest: query-busy
[437.375059] Starting dynamic subtest: pipe-A-eDP-1
[439.264312] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.891s)
[439.283705] Starting dynamic subtest: pipe-D-eDP-1
[441.858909] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.592s)
[441.861301] Subtest query-busy: SUCCESS (4.487s)
[442.661821] [047/133] (577s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[442.720136] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[442.722920] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[442.845607] [048/133] (577s left) gem_render_copy (y-tiled-to-vebox-linear)
[442.903633] Starting subtest: y-tiled-to-vebox-linear
[442.907972] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[443.082426] [049/133] (577s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[443.184495] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[443.188944] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[443.285374] [050/133] (577s left) perf_pmu (interrupts)
[443.323382] Starting subtest: interrupts
[444.396226] Subtest interrupts: SUCCESS (1.071s)
[444.515436] [051/133] (575s left) gem_mmap (basic)
[444.580427] Subtest basic: SKIP (0.000s)
[444.645507] [052/133] (575s left) syncobj_timeline (single-wait-all-available-submitted)
[444.704422] Starting subtest: single-wait-all-available-submitted
[444.706392] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[444.811016] [053/133] (575s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[447.031803] Starting subtest: modeset-lpsp-stress-no-wait
[456.853488] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.823s)
[456.933201] [054/133] (563s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[456.992629] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[457.060848] [055/133] (563s left) gem_exec_fence (syncobj-unused-fence)
[457.483863] Starting subtest: syncobj-unused-fence
[457.489772] Subtest syncobj-unused-fence: SUCCESS (0.005s)
[458.972791] [056/133] (561s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[459.081840] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[459.086472] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[459.191558] [057/133] (561s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[459.299077] Starting subtest: yf-tiled-16bpp-rotate-270
[459.303581] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[459.392537] [058/133] (561s left) gem_exec_fence (basic-wait)
[459.564491] Starting subtest: basic-wait
[459.566425] Starting dynamic subtest: rcs0
[459.638666] Dynamic subtest rcs0: SUCCESS (0.077s)
[459.650198] Starting dynamic subtest: bcs0
[459.701522] Dynamic subtest bcs0: SUCCESS (0.060s)
[459.712608] Starting dynamic subtest: vcs0
[459.764551] Dynamic subtest vcs0: SUCCESS (0.060s)
[459.775887] Starting dynamic subtest: vcs1
[459.822048] Dynamic subtest vcs1: SUCCESS (0.056s)
[459.835817] Starting dynamic subtest: vecs0
[459.874533] Dynamic subtest vecs0: SUCCESS (0.049s)
[459.885462] Starting dynamic subtest: ccs0
[459.931721] Dynamic subtest ccs0: SUCCESS (0.055s)
[459.934163] Subtest basic-wait: SUCCESS (0.371s)
[461.994245] [059/133] (558s left) prime_mmap_coherency (ioctl-errors)
[462.054628] Starting subtest: ioctl-errors
[480.117726] Subtest ioctl-errors: SUCCESS (18.061s)
[480.258577] [060/133] (540s left) kms_busy (basic)
[480.389416] Starting subtest: basic
[480.391064] Starting dynamic subtest: flip
[481.008888] Dynamic subtest flip: SUCCESS (0.618s)
[481.022296] Starting dynamic subtest: modeset
[484.452587] Dynamic subtest modeset: SUCCESS (3.442s)
[484.454981] Subtest basic: SUCCESS (4.062s)
[485.249897] [061/133] (535s left) gem_exec_store (cachelines)
[485.322331] Starting subtest: cachelines
[485.324710] Starting dynamic subtest: rcs0
[485.385783] Dynamic subtest rcs0: SUCCESS (0.066s)
[485.397067] Starting dynamic subtest: bcs0
[485.436647] Dynamic subtest bcs0: SUCCESS (0.049s)
[485.448515] Starting dynamic subtest: vcs0
[485.495513] Dynamic subtest vcs0: SUCCESS (0.057s)
[485.508629] Starting dynamic subtest: vcs1
[485.545556] Dynamic subtest vcs1: SUCCESS (0.048s)
[485.554940] Starting dynamic subtest: vecs0
[485.597604] Dynamic subtest vecs0: SUCCESS (0.050s)
[485.609653] Starting dynamic subtest: ccs0
[485.647707] Dynamic subtest ccs0: SUCCESS (0.049s)
[485.650032] Subtest cachelines: SUCCESS (0.329s)
[485.829918] [062/133] (534s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[485.923408] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[486.889419] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.967s)
[487.001012] [063/133] (533s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[487.097048] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[487.099342] Starting dynamic subtest: pipe-A-eDP-1
[487.121766] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[487.131833] Starting dynamic subtest: pipe-B-eDP-1
[487.152787] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[487.161242] Starting dynamic subtest: pipe-C-eDP-1
[487.180838] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[487.189743] Starting dynamic subtest: pipe-D-eDP-1
[487.207460] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[487.210945] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[489.330808] [064/133] (531s left) prime_busy (hang-wait)
[489.398601] Starting subtest: hang-wait
[489.401157] Starting dynamic subtest: rcs0
[515.391424] Dynamic subtest rcs0: SUCCESS (25.980s)
[515.401469] Starting dynamic subtest: bcs0
[522.538821] Dynamic subtest bcs0: SUCCESS (7.148s)
[522.550400] Starting dynamic subtest: vcs0
[529.570315] Dynamic subtest vcs0: SUCCESS (7.034s)
[529.579264] Starting dynamic subtest: vcs1
[536.488964] Dynamic subtest vcs1: SUCCESS (6.916s)
[536.498070] Starting dynamic subtest: vecs0
[543.523099] Dynamic subtest vecs0: SUCCESS (7.033s)
[543.532335] Starting dynamic subtest: ccs0
[557.358889] Dynamic subtest ccs0: SUCCESS (13.833s)
[557.361377] Subtest hang-wait: SUCCESS (67.958s)
[557.495645] [065/133] (463s left) kms_flip (flip-vs-panning-vs-hang)
[557.591295] Starting subtest: flip-vs-panning-vs-hang
[557.593248] Starting dynamic subtest: A-eDP1
[608.385220] Dynamic subtest A-eDP1: SUCCESS (50.797s)
[608.399324] Starting dynamic subtest: D-eDP1
[658.366954] Dynamic subtest D-eDP1: SUCCESS (49.980s)
[658.369485] Subtest flip-vs-panning-vs-hang: SUCCESS (100.780s)
[659.601859] [066/133] (361s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[659.705781] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[659.708066] Starting dynamic subtest: pipe-A-eDP-1
[659.942263] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.206s)
[659.952550] Starting dynamic subtest: pipe-B-eDP-1
[661.158087] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.214s)
[661.169134] Starting dynamic subtest: pipe-C-eDP-1
[662.376197] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.217s)
[662.387291] Starting dynamic subtest: pipe-D-eDP-1
[663.624416] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.247s)
[663.626870] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.890s)
[664.850828] [067/133] (356s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[664.914603] Subtest tiled-to-tiled: SKIP (0.000s)
[664.994423] [068/133] (356s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[665.086073] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[665.090438] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[665.161026] [069/133] (355s left) gem_ctx_isolation (clean)
[665.215531] Starting subtest: clean
[665.217824] Starting dynamic subtest: rcs0
[665.256782] Dynamic subtest rcs0: SUCCESS (0.041s)
[665.267778] Starting dynamic subtest: bcs0
[665.306752] Dynamic subtest bcs0: SUCCESS (0.049s)
[665.319117] Starting dynamic subtest: vcs0
[665.385099] Dynamic subtest vcs0: SUCCESS (0.077s)
[665.396565] Starting dynamic subtest: vcs1
[666.898230] Dynamic subtest vcs1: SUCCESS (1.512s)
[666.909771] Starting dynamic subtest: vecs0
[668.886031] Dynamic subtest vecs0: SUCCESS (1.987s)
[668.898565] Starting dynamic subtest: ccs0
[670.871787] Dynamic subtest ccs0: SUCCESS (1.985s)
[670.874271] Subtest clean: SUCCESS (5.657s)
[671.094705] [070/133] (350s left) perf_pmu (init-sema)
[671.142783] Starting subtest: init-sema
[671.145162] Starting dynamic subtest: rcs0
[671.147402] Dynamic subtest rcs0: SUCCESS (0.002s)
[671.158220] Starting dynamic subtest: bcs0
[671.160653] Dynamic subtest bcs0: SUCCESS (0.000s)
[671.169375] Starting dynamic subtest: vcs0
[671.171597] Dynamic subtest vcs0: SUCCESS (0.000s)
[671.180534] Starting dynamic subtest: vcs1
[671.182673] Dynamic subtest vcs1: SUCCESS (0.000s)
[671.191577] Starting dynamic subtest: vecs0
[671.193896] Dynamic subtest vecs0: SUCCESS (0.001s)
[671.202186] Starting dynamic subtest: ccs0
[671.204067] Dynamic subtest ccs0: SUCCESS (0.001s)
[671.206393] Subtest init-sema: SUCCESS (0.008s)
[671.266877] [071/133] (349s left) kms_force_connector_basic (prune-stale-modes)
[671.349170] Starting subtest: prune-stale-modes
[671.804139] Subtest prune-stale-modes: SUCCESS (0.455s)
[671.944700] [072/133] (349s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[671.997454] Subtest no-spare-fences-busy: SKIP (0.000s)
[672.069411] [073/133] (349s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[672.163556] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[672.167218] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[673.269187] [074/133] (348s left) i915_pm_freq_api (freq-suspend)
[673.335585] Starting subtest: freq-suspend
[673.337950] Starting dynamic subtest: gt0
[689.250120] Dynamic subtest gt0: SUCCESS (2.169s)
[689.264279] Starting dynamic subtest: gt1
[705.244689] Dynamic subtest gt1: SUCCESS (1.214s)
[705.246922] Subtest freq-suspend: SUCCESS (3.385s)
[705.327909] [075/133] (316s left) kms_cursor_edge_walk (256x256-top-bottom)
[705.420703] Starting subtest: 256x256-top-bottom
[705.423361] Starting dynamic subtest: pipe-A-eDP-1
[709.054304] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.501s)
[709.065112] Starting dynamic subtest: pipe-D-eDP-1
[712.320226] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.183s)
[712.323280] Subtest 256x256-top-bottom: SUCCESS (6.689s)
[713.122963] [076/133] (308s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[713.243557] Starting subtest: psr-rgb565-draw-pwrite
[720.176284] Subtest psr-rgb565-draw-pwrite: SUCCESS (6.853s)
[720.282201] [077/133] (301s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[720.464974] Starting subtest: cursor-rapid-movement-64x64
[720.467713] Starting dynamic subtest: pipe-A-eDP-1
[721.019978] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.548s)
[721.050178] Starting dynamic subtest: pipe-D-eDP-1
[722.220314] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.172s)
[722.223073] Subtest cursor-rapid-movement-64x64: SUCCESS (1.746s)
[723.031025] [078/133] (298s left) gem_ctx_persistence (legacy-engines-queued)
[723.087949] Starting subtest: legacy-engines-queued
[723.090507] Starting dynamic subtest: render
[723.166843] Dynamic subtest render: SUCCESS (0.078s)
[723.180614] Starting dynamic subtest: bsd1
[724.373292] Dynamic subtest bsd1: SUCCESS (1.197s)
[724.387725] Starting dynamic subtest: bsd2
[726.356577] Dynamic subtest bsd2: SUCCESS (1.971s)
[726.371269] Starting dynamic subtest: blt
[726.388564] Dynamic subtest blt: SUCCESS (0.030s)
[726.398413] Starting dynamic subtest: vebox
[728.402905] Dynamic subtest vebox: SUCCESS (2.005s)
[728.406095] Subtest legacy-engines-queued: SUCCESS (5.295s)
[728.498271] [079/133] (293s left) kms_flip (2x-flip-vs-fences-interruptible)
[728.598630] Starting subtest: 2x-flip-vs-fences-interruptible
[728.603846] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[728.693995] [080/133] (292s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[728.793032] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[728.795480] Starting dynamic subtest: pipe-A-eDP-1
[728.899529] Dynamic subtest pipe-A-eDP-1: SKIP (0.110s)
[728.910435] Starting dynamic subtest: pipe-B-eDP-1
[730.089818] Dynamic subtest pipe-B-eDP-1: SKIP (1.183s)
[730.094948] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.296s)
[731.367642] [081/133] (290s left) syncobj_timeline (etime-multi-wait-submitted)
[731.430865] Starting subtest: etime-multi-wait-submitted
[731.536283] Subtest etime-multi-wait-submitted: SUCCESS (0.106s)
[731.614969] [082/133] (290s left) gem_render_copy (linear-to-vebox-yf-tiled)
[731.679318] Starting subtest: linear-to-vebox-yf-tiled
[731.684350] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[731.865773] [083/133] (289s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[731.959524] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[731.961991] Starting dynamic subtest: pipe-A-eDP-1
[731.986112] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.023s)
[731.997055] Starting dynamic subtest: pipe-B-eDP-1
[732.020939] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.021s)
[732.031801] Starting dynamic subtest: pipe-C-eDP-1
[732.055190] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s)
[732.065629] Starting dynamic subtest: pipe-D-eDP-1
[732.087604] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s)
[732.089944] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.091s)
[734.242839] [084/133] (287s left) kms_psr (psr-cursor-render)
[734.343100] Starting subtest: psr-cursor-render
[734.345718] Starting dynamic subtest: eDP-1
[736.126340] Dynamic subtest eDP-1: SUCCESS (1.780s)
[736.128878] Subtest psr-cursor-render: SUCCESS (1.781s)
[736.957118] [085/133] (284s left) kms_atomic (atomic-invalid-params)
[737.053609] Starting subtest: atomic-invalid-params
[737.056283] Starting dynamic subtest: pipe-A-eDP-1
[737.451164] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.398s)
[737.454204] Subtest atomic-invalid-params: SUCCESS (0.400s)
[738.264482] [086/133] (283s left) gem_exec_schedule (semaphore-power)
[738.443986] Subtest semaphore-power: SKIP (0.000s)
[738.622739] [087/133] (283s left) api_intel_allocator (default-alignment)
[738.676175] Starting subtest: default-alignment
[738.679256] Subtest default-alignment: SUCCESS (0.003s)
[738.805635] [088/133] (283s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[738.901736] Starting subtest: yf-tiled-32bpp-rotate-90
[738.906198] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[738.999061] [089/133] (282s left) gem_mmap_wc (copy)
[739.061848] Subtest copy: SKIP (0.000s)
[739.124190] [090/133] (282s left) gem_exec_whisper (basic-queues-forked-all)
[739.186502] Starting subtest: basic-queues-forked-all
[760.586126] Subtest basic-queues-forked-all: SUCCESS (21.385s)
[760.768527] [091/133] (261s left) kms_plane_scaling (intel-max-src-size)
[760.876305] Starting subtest: intel-max-src-size
[760.884068] Subtest intel-max-src-size: SKIP (0.000s)
[760.969787] [092/133] (261s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[761.062579] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[767.980826] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (6.919s)
[768.116903] [093/133] (253s left) kms_psr (fbc-psr2-sprite-render)
[768.210216] Starting subtest: fbc-psr2-sprite-render
[768.213066] Starting dynamic subtest: eDP-1
[768.218059] Dynamic subtest eDP-1: SKIP (0.000s)
[768.223157] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[768.281965] [094/133] (253s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[768.385909] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[768.390863] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[768.483157] [095/133] (253s left) gem_pread (self)
[768.550049] Subtest self: SKIP (0.000s)
[768.612928] [096/133] (253s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[768.704830] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[768.710117] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[768.806976] [097/133] (253s left) kms_prop_blob (invalid-set-prop)
[768.865131] Starting subtest: invalid-set-prop
[768.867661] Subtest invalid-set-prop: SUCCESS (0.000s)
[768.962612] [098/133] (253s left) fbdev (unaligned-write)
[769.002053] Starting subtest: unaligned-write
[769.099508] Subtest unaligned-write: SUCCESS (0.099s)
[769.163774] [099/133] (253s left) kms_plane (pixel-format-x-tiled-modifier)
[769.260658] Starting subtest: pixel-format-x-tiled-modifier
[769.287655] Starting dynamic subtest: pipe-A-plane-0
[769.987650] Dynamic subtest pipe-A-plane-0: SUCCESS (0.700s)
[769.999259] Starting dynamic subtest: pipe-A-plane-3
[770.421289] Dynamic subtest pipe-A-plane-3: SUCCESS (0.433s)
[770.431879] Starting dynamic subtest: pipe-A-plane-5
[770.435769] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[771.531070] Starting dynamic subtest: pipe-B-plane-0
[772.210645] Dynamic subtest pipe-B-plane-0: SUCCESS (0.688s)
[772.221060] Starting dynamic subtest: pipe-B-plane-3
[772.665989] Dynamic subtest pipe-B-plane-3: SUCCESS (0.453s)
[772.676701] Starting dynamic subtest: pipe-B-plane-5
[772.681139] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[772.986216] Subtest pixel-format-x-tiled-modifier: SUCCESS (3.723s)
[773.874892] [100/133] (248s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[773.940853] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[774.015549] [101/133] (248s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[774.100261] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[777.871041] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.772s)
[779.074501] [102/133] (243s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[779.165632] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[779.176006] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.010s)
[779.253889] [103/133] (243s left) core_getversion (all-cards)
[779.292730] Starting subtest: all-cards
[779.301549] Subtest all-cards: SUCCESS (0.011s)
[779.351635] [104/133] (243s left) gem_exec_reloc (basic-wc-read-noreloc)
[779.405148] Subtest basic-wc-read-noreloc: SKIP (0.000s)
[779.479587] [105/133] (243s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[779.577006] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[779.582108] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[779.662927] [106/133] (242s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[779.754222] Starting subtest: x-tiled-16bpp-rotate-90
[779.774568] Subtest x-tiled-16bpp-rotate-90: SKIP (0.019s)
[779.876906] [107/133] (242s left) kms_feature_discovery (display-1x)
[779.968167] Starting subtest: display-1x
[779.970869] Subtest display-1x: SUCCESS (0.000s)
[780.066550] [108/133] (242s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[780.188802] Starting subtest: cursorA-vs-flipB-varying-size
[780.193875] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[780.338593] [109/133] (242s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[780.432029] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[780.436499] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[780.510945] [110/133] (242s left) kms_psr2_su (page_flip-xrgb8888)
[780.565805] Subtest page_flip-XRGB8888: SKIP (0.000s)
[780.629794] [111/133] (242s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[780.719979] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[780.723988] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[780.814016] [112/133] (242s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[780.914191] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[785.428198] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.514s)
[786.591906] [113/133] (236s left) i915_drm_fdinfo (isolation)
[786.633054] Starting subtest: isolation
[786.635922] Starting dynamic subtest: rcs0
[786.666518] Dynamic subtest rcs0: SKIP (0.035s)
[786.679304] Starting dynamic subtest: bcs0
[786.684569] Dynamic subtest bcs0: SKIP (0.001s)
[786.695444] Starting dynamic subtest: vcs0
[786.700286] Dynamic subtest vcs0: SKIP (0.000s)
[786.718566] Starting dynamic subtest: vcs1
[786.724451] Dynamic subtest vcs1: SKIP (0.000s)
[786.747074] Starting dynamic subtest: vecs0
[786.752949] Dynamic subtest vecs0: SKIP (0.000s)
[786.770397] Starting dynamic subtest: ccs0
[786.775270] Dynamic subtest ccs0: SKIP (0.000s)
[786.780295] Subtest isolation: SKIP (0.042s)
[786.821287] [114/133] (236s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[786.928069] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[786.933109] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[787.025012] [115/133] (236s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[787.133059] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[791.583305] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.453s)
[792.706679] [116/133] (230s left) kms_big_fb (4-tiled-addfb)
[792.828468] Starting subtest: 4-tiled-addfb
[792.831194] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[792.929255] [117/133] (230s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[793.025046] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[793.030296] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[793.123698] [118/133] (230s left) kms_cursor_crc (cursor-offscreen-512x512)
[793.416220] Starting subtest: cursor-offscreen-512x512
[793.421415] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[793.568770] [119/133] (229s left) gem_mmap (bad-size)
[793.618985] Subtest bad-size: SKIP (0.000s)
[793.690438] [120/133] (229s left) gem_mmap_offset (blt-coherency)
[793.743091] Starting subtest: blt-coherency
[793.747942] Subtest blt-coherency: SUCCESS (0.008s)
[793.858369] [121/133] (229s left) api_intel_bb (simple-bb-ctx)
[793.916607] Starting subtest: simple-bb-ctx
[793.926114] Subtest simple-bb-ctx: SUCCESS (0.012s)
[794.052519] [122/133] (229s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[794.145064] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[794.149572] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[794.249163] [123/133] (229s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[794.343671] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[794.347915] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[794.415769] [124/133] (229s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[794.504823] Starting subtest: fbc-pr-sprite-mmap-gtt
[794.508981] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[794.579660] [125/133] (228s left) kms_psr (pr-primary-mmap-gtt)
[794.675743] Starting subtest: pr-primary-mmap-gtt
[794.680172] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[794.775757] [126/133] (228s left) kms_pipe_crc_basic (suspend-read-crc)
[794.863517] Starting subtest: suspend-read-crc
[794.865469] Starting dynamic subtest: pipe-A-eDP-1
[812.201237] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.562s)
[812.213501] Starting dynamic subtest: pipe-B-eDP-1
[830.209286] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.190s)
[830.221166] Starting dynamic subtest: pipe-C-eDP-1
[848.128861] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.038s)
[848.143540] Starting dynamic subtest: pipe-D-eDP-1
[866.148172] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.010s)
[866.150195] Subtest suspend-read-crc: SUCCESS (11.807s)
[866.952634] [127/133] (156s left) kms_chamelium_hpd (hdmi-hpd-storm)
[867.363172] Subtest hdmi-hpd-storm: SKIP (0.000s)
[868.167075] [128/133] (155s left) gem_wait (write-busy)
[868.243864] Starting subtest: write-busy
[868.246250] Starting dynamic subtest: all-engines
[868.859661] Dynamic subtest all-engines: SUCCESS (0.602s)
[868.879091] Starting dynamic subtest: rcs0
[869.416845] Dynamic subtest rcs0: SUCCESS (0.544s)
[869.435522] Starting dynamic subtest: bcs0
[869.978136] Dynamic subtest bcs0: SUCCESS (0.550s)
[869.998129] Starting dynamic subtest: vcs0
[871.625888] Dynamic subtest vcs0: SUCCESS (1.619s)
[871.644107] Starting dynamic subtest: vcs1
[873.673736] Dynamic subtest vcs1: SUCCESS (2.019s)
[873.691599] Starting dynamic subtest: vecs0
[875.658088] Dynamic subtest vecs0: SUCCESS (1.962s)
[875.675097] Starting dynamic subtest: ccs0
[876.214498] Dynamic subtest ccs0: SUCCESS (0.550s)
[876.217092] Subtest write-busy: SUCCESS (7.860s)
[876.412960] [129/133] (147s left) gem_userptr_blits (relocations)
[876.484757] Starting subtest: relocations
[876.489211] Subtest relocations: SKIP (0.000s)
[876.619438] [130/133] (147s left) gem_eio (wait-immediate)
[876.831661] Starting subtest: wait-immediate
[877.183070] Subtest wait-immediate: SUCCESS (0.350s)
[877.301077] [131/133] (146s left) gem_userptr_blits (create-destroy-unsync)
[877.382949] Subtest create-destroy-unsync: SKIP (0.000s)
[877.500991] [132/133] (146s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[877.605741] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[884.854213] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.219s)
[884.980638] [133/133] (138s left) gem_exec_reloc (basic-wc)
[885.039851] Subtest basic-wc: SKIP (0.000s)
[885.103432] Closing watchdogs
results: parsing output: 0/ for test: vgem_basic
results: parsing output: 1/ for test: kms_cursor_legacy
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: kms_invalid_mode
results: parsing output: 4/ for test: kms_pm_backlight
results: parsing output: 5/ for test: kms_flip
results: parsing output: 6/ for test: gem_mmap_gtt
results: parsing output: 7/ for test: gem_softpin
results: parsing output: 8/ for test: gem_render_linear_blits
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: kms_chamelium_edid
results: parsing output: 12/ for test: gen7_exec_parse
results: parsing output: 13/ for test: syncobj_eventfd
results: parsing output: 14/ for test: gem_ctx_exec
results: parsing output: 15/ for test: gem_exec_reloc
results: parsing output: 16/ for test: kms_vblank
results: parsing output: 17/ for test: kms_chamelium_color
results: parsing output: 18/ for test: gem_exec_flush
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_plane
results: parsing output: 21/ for test: kms_plane_scaling
results: parsing output: 22/ for test: i915_selftest
results: parsing output: 23/ for test: kms_color
results: parsing output: 24/ for test: perf
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_cursor_legacy
results: parsing output: 27/ for test: gem_eio
results: parsing output: 28/ for test: gem_exec_fence
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_render_copy
results: parsing output: 31/ for test: kms_flip_scaled_crc
results: parsing output: 32/ for test: sw_sync
results: parsing output: 33/ for test: gem_exec_schedule
results: parsing output: 34/ for test: gem_tiled_fence_blits
results: parsing output: 35/ for test: i915_pm_rpm
results: parsing output: 36/ for test: kms_addfb_basic
results: parsing output: 37/ for test: kms_concurrent
results: parsing output: 38/ for test: gem_exec_balancer
results: parsing output: 39/ for test: prime_self_import
results: parsing output: 40/ for test: gem_partial_pwrite_pread
results: parsing output: 41/ for test: syncobj_wait
results: parsing output: 42/ for test: sysfs_timeslice_duration
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_vblank
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: gem_render_copy
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: perf_pmu
results: parsing output: 50/ for test: gem_mmap
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: kms_pm_rpm
results: parsing output: 53/ for test: gem_exec_reloc
results: parsing output: 54/ for test: gem_exec_fence
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: gem_exec_fence
results: parsing output: 58/ for test: prime_mmap_coherency
results: parsing output: 59/ for test: kms_busy
results: parsing output: 60/ for test: gem_exec_store
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: prime_busy
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: kms_ccs
results: parsing output: 66/ for test: gem_set_tiling_vs_blt
results: parsing output: 67/ for test: kms_flip_scaled_crc
results: parsing output: 68/ for test: gem_ctx_isolation
results: parsing output: 69/ for test: perf_pmu
results: parsing output: 70/ for test: kms_force_connector_basic
results: parsing output: 71/ for test: gem_fenced_exec_thrash
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: i915_pm_freq_api
results: parsing output: 74/ for test: kms_cursor_edge_walk
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_cursor_crc
results: parsing output: 77/ for test: gem_ctx_persistence
results: parsing output: 78/ for test: kms_flip
results: parsing output: 79/ for test: kms_psr2_sf
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: gem_render_copy
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: kms_atomic
results: parsing output: 85/ for test: gem_exec_schedule
results: parsing output: 86/ for test: api_intel_allocator
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: gem_mmap_wc
results: parsing output: 89/ for test: gem_exec_whisper
results: parsing output: 90/ for test: kms_plane_scaling
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_pread
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_prop_blob
results: parsing output: 97/ for test: fbdev
results: parsing output: 98/ for test: kms_plane
results: parsing output: 99/ for test: gem_exec_reloc
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_flip
results: parsing output: 102/ for test: core_getversion
results: parsing output: 103/ for test: gem_exec_reloc
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_feature_discovery
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: kms_flip_scaled_crc
results: parsing output: 109/ for test: kms_psr2_su
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: i915_drm_fdinfo
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_cursor_crc
results: parsing output: 118/ for test: gem_mmap
results: parsing output: 119/ for test: gem_mmap_offset
results: parsing output: 120/ for test: api_intel_bb
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_joiner
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: kms_pipe_crc_basic
results: parsing output: 126/ for test: kms_chamelium_hpd
results: parsing output: 127/ for test: gem_wait
results: parsing output: 128/ for test: gem_userptr_blits
results: parsing output: 129/ for test: gem_eio
results: parsing output: 130/ for test: gem_userptr_blits
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_exec_reloc
Done.