[57.406749] Initializing watchdogs
[57.406799]   /dev/watchdog0
[57.421969] [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.426420] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.428735] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.432164] [001/133] (960s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[57.842562] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[58.640724] [002/133] (959s left) device_reset (unbind-reset-rebind)
[58.695461] Starting subtest: unbind-reset-rebind
[63.620307] Subtest unbind-reset-rebind: SUCCESS (4.927s)
[63.663923] [003/133] (954s left) kms_pipe_stress (stress-xrgb8888-4tiled)
[63.769874] Starting subtest: stress-xrgb8888-4tiled
[69.681672] Subtest stress-xrgb8888-4tiled: SUCCESS (5.912s)
[69.754654] [004/133] (948s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[69.949118] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[69.952881] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[70.160107] [005/133] (947s left) syncobj_wait (multi-wait-submitted)
[70.286282] Starting subtest: multi-wait-submitted
[70.396093] Subtest multi-wait-submitted: SUCCESS (0.108s)
[70.468922] [006/133] (947s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[70.856188] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[71.683314] [007/133] (946s left) i915_drm_fdinfo (virtual-busy-all)
[71.725215] Starting subtest: virtual-busy-all
[71.729806] Subtest virtual-busy-all: SKIP (0.000s)
[71.790544] [008/133] (946s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[71.909584] Starting subtest: cursorA-vs-flipA-toggle
[83.051099] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.142s)
[83.846591] [009/133] (934s left) kms_psr (psr2-dpms)
[83.937970] Starting subtest: psr2-dpms
[83.940274] Starting dynamic subtest: eDP-1
[86.795280] Dynamic subtest eDP-1: SUCCESS (2.858s)
[86.797433] Subtest psr2-dpms: SUCCESS (2.859s)
[87.648630] [010/133] (930s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[87.760472] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[87.762804] Starting dynamic subtest: pipe-A
[87.785295] Dynamic subtest pipe-A: SKIP (0.019s)
[87.793590] Starting dynamic subtest: pipe-B
[87.820733] Dynamic subtest pipe-B: SKIP (0.036s)
[87.831865] Starting dynamic subtest: pipe-C
[87.858451] Dynamic subtest pipe-C: SKIP (0.036s)
[87.867889] Starting dynamic subtest: pipe-D
[87.894102] Dynamic subtest pipe-D: SKIP (0.035s)
[87.897890] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.128s)
[88.001075] [011/133] (930s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[88.059960] Starting subtest: multi-wait-all-for-submit-signaled
[88.062270] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[88.193832] [012/133] (930s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[88.251258] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[88.354143] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[88.435325] [013/133] (930s left) kms_vblank (query-busy-hang)
[88.533942] Starting subtest: query-busy-hang
[88.536270] Starting dynamic subtest: pipe-A-eDP-1
[114.721977] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.187s)
[114.735852] Starting dynamic subtest: pipe-D-eDP-1
[129.700476] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.976s)
[129.703082] Subtest query-busy-hang: SUCCESS (41.167s)
[130.503295] [014/133] (887s left) perf_pmu (all-busy-idle-check-all)
[130.552611] Starting subtest: all-busy-idle-check-all
[131.927598] Subtest all-busy-idle-check-all: SUCCESS (1.374s)
[132.019805] [015/133] (886s left) gem_softpin (evict-prime-sanity-check)
[132.073317] Starting subtest: evict-prime-sanity-check
[132.075788] Starting dynamic subtest: rcs0
[133.206749] Dynamic subtest rcs0: SUCCESS (1.133s)
[133.217687] Starting dynamic subtest: bcs0
[134.323259] Dynamic subtest bcs0: SUCCESS (1.115s)
[134.334252] Starting dynamic subtest: vcs0
[135.893783] Dynamic subtest vcs0: SUCCESS (1.568s)
[135.903872] Starting dynamic subtest: vcs1
[137.853932] Dynamic subtest vcs1: SUCCESS (1.958s)
[137.866127] Starting dynamic subtest: vecs0
[139.904574] Dynamic subtest vecs0: SUCCESS (2.049s)
[139.915934] Starting dynamic subtest: ccs0
[141.073338] Dynamic subtest ccs0: SUCCESS (1.168s)
[141.084897] Starting dynamic subtest: all
[142.191871] Dynamic subtest all: SUCCESS (1.117s)
[142.194368] Subtest evict-prime-sanity-check: SUCCESS (10.119s)
[142.280752] [016/133] (876s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[142.381167] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[142.383378] Starting dynamic subtest: pipe-A-eDP-1
[142.405850] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[142.415529] Starting dynamic subtest: pipe-B-eDP-1
[142.436929] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[142.445118] Starting dynamic subtest: pipe-C-eDP-1
[142.466202] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[142.474292] Starting dynamic subtest: pipe-D-eDP-1
[142.496257] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[142.500728] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[144.679393] [017/133] (873s left) kms_hdr (static-swap)
[144.774960] Starting subtest: static-swap
[144.781129] Subtest static-swap: SKIP (0.000s)
[144.862032] [018/133] (873s left) core_auth (basic-auth)
[144.919839] Starting subtest: basic-auth
[144.922239] Subtest basic-auth: SUCCESS (0.001s)
[145.033261] [019/133] (873s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[145.133458] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[145.137877] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[145.215111] [020/133] (873s left) gem_exec_schedule (submit-golden-slice)
[145.283769] Starting subtest: submit-golden-slice
[145.285726] Starting dynamic subtest: rcs0
[145.318402] Dynamic subtest rcs0: SUCCESS (0.041s)
[145.327822] Starting dynamic subtest: bcs0
[145.346488] Dynamic subtest bcs0: SUCCESS (0.028s)
[145.355219] Starting dynamic subtest: vcs0
[145.378681] Dynamic subtest vcs0: SUCCESS (0.032s)
[145.387662] Starting dynamic subtest: vcs1
[145.407134] Dynamic subtest vcs1: SUCCESS (0.028s)
[145.415596] Starting dynamic subtest: vecs0
[145.434566] Dynamic subtest vecs0: SUCCESS (0.027s)
[145.443204] Starting dynamic subtest: ccs0
[145.471864] Dynamic subtest ccs0: SUCCESS (0.037s)
[145.474071] Subtest submit-golden-slice: SUCCESS (0.195s)
[146.996918] [021/133] (871s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[147.082979] Starting subtest: plane-lut1d-ctm3x4
[147.229155] Starting dynamic subtest: pipe-A-plane-0
[147.395569] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[147.404553] Starting dynamic subtest: pipe-A-plane-1
[147.562417] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[147.571340] Starting dynamic subtest: pipe-A-plane-2
[147.729189] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[148.978661] Starting dynamic subtest: pipe-B-plane-0
[149.138988] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[149.148472] Starting dynamic subtest: pipe-B-plane-1
[149.271602] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[149.280270] Starting dynamic subtest: pipe-B-plane-2
[149.460528] Dynamic subtest pipe-B-plane-2: SUCCESS (0.188s)
[150.682090] Starting dynamic subtest: pipe-C-plane-0
[150.819490] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[150.828473] Starting dynamic subtest: pipe-C-plane-1
[150.974492] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[150.983771] Starting dynamic subtest: pipe-C-plane-2
[151.121927] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[152.304440] Starting dynamic subtest: pipe-D-plane-0
[152.441766] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[152.450603] Starting dynamic subtest: pipe-D-plane-1
[152.608428] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[152.617987] Starting dynamic subtest: pipe-D-plane-2
[152.753159] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[153.040284] Subtest plane-lut1d-ctm3x4: SUCCESS (5.958s)
[153.868050] [022/133] (864s left) kms_psr (psr-primary-page-flip)
[153.964700] Starting subtest: psr-primary-page-flip
[153.966865] Starting dynamic subtest: eDP-1
[155.669168] Dynamic subtest eDP-1: SUCCESS (1.702s)
[155.671631] Subtest psr-primary-page-flip: SUCCESS (1.703s)
[156.526529] [023/133] (862s left) gen7_exec_parse (basic-offset)
[156.586985] Subtest basic-offset: SKIP (0.000s)
[156.646116] [024/133] (862s left) kms_cursor_crc (cursor-sliding-256x256)
[156.909385] Starting subtest: cursor-sliding-256x256
[156.914587] Starting dynamic subtest: pipe-A-eDP-1
[160.133168] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.217s)
[160.173639] Starting dynamic subtest: pipe-D-eDP-1
[164.019865] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.859s)
[164.022693] Subtest cursor-sliding-256x256: SUCCESS (7.112s)
[164.890047] [025/133] (854s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[164.994481] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[171.775627] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.784s)
[171.900129] [026/133] (847s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[172.002349] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[172.006833] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[172.099357] [027/133] (846s left) gem_ctx_isolation (dirty-switch)
[172.161559] Starting subtest: dirty-switch
[172.163911] Starting dynamic subtest: rcs0
[172.347612] Dynamic subtest rcs0: SUCCESS (0.186s)
[172.356518] Starting dynamic subtest: bcs0
[172.563550] Dynamic subtest bcs0: SUCCESS (0.215s)
[172.574681] Starting dynamic subtest: vcs0
[172.768670] Dynamic subtest vcs0: SUCCESS (0.205s)
[172.779107] Starting dynamic subtest: vcs1
[174.084795] Dynamic subtest vcs1: SUCCESS (1.315s)
[174.095612] Starting dynamic subtest: vecs0
[176.093267] Dynamic subtest vecs0: SUCCESS (2.007s)
[176.102408] Starting dynamic subtest: ccs0
[178.169248] Dynamic subtest ccs0: SUCCESS (2.075s)
[178.171777] Subtest dirty-switch: SUCCESS (6.008s)
[178.411739] [028/133] (840s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[178.507118] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[178.888699] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[181.678270] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.788s)
[181.690297] Starting dynamic subtest: pipe-A-eDP-1-4
[183.877423] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.197s)
[183.891328] Starting dynamic subtest: pipe-A-eDP-1-4
[185.885692] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.007s)
[185.897842] Starting dynamic subtest: pipe-A-eDP-1-x
[188.074810] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.188s)
[188.456506] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[191.199673] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.751s)
[191.213558] Starting dynamic subtest: pipe-B-eDP-1-4
[193.396000] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.195s)
[193.404797] Starting dynamic subtest: pipe-B-eDP-1-4
[195.406831] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[195.418797] Starting dynamic subtest: pipe-B-eDP-1-x
[197.595984] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.188s)
[197.965779] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[200.717973] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.758s)
[200.728783] Starting dynamic subtest: pipe-C-eDP-1-4
[202.892596] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[202.904133] Starting dynamic subtest: pipe-C-eDP-1-4
[204.903111] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[204.912136] Starting dynamic subtest: pipe-C-eDP-1-x
[207.081370] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[207.442090] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[210.250750] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.814s)
[210.261527] Starting dynamic subtest: pipe-D-eDP-1-4
[212.445508] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.192s)
[212.460873] Starting dynamic subtest: pipe-D-eDP-1-4
[214.455632] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[214.469423] Starting dynamic subtest: pipe-D-eDP-1-x
[216.645264] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.187s)
[216.648151] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.138s)
[217.831219] [029/133] (801s left) gen3_render_linear_blits
[217.944841] [030/133] (801s left) kms_prime (d3hot)
[218.033215] Subtest D3hot: SKIP (0.000s)
[218.184420] [FACT kms_prime (d3hot)] new: kernel.kmod_is_loaded.vgem: true
[218.188133] [031/133] (800s left) gem_userptr_blits (input-checking)
[218.260505] Starting subtest: input-checking
[218.262789] Subtest input-checking: SUCCESS (0.000s)
[218.385542] [032/133] (800s left) perf (rc6-disable)
[218.523138] Starting subtest: rc6-disable
[218.704320] Subtest rc6-disable: SUCCESS (0.182s)
[218.752663] [033/133] (800s left) kms_flip (absolute-wf_vblank-interruptible)
[218.848751] Starting subtest: absolute-wf_vblank-interruptible
[218.854311] Starting dynamic subtest: A-eDP1
[227.584678] Dynamic subtest A-eDP1: SUCCESS (8.730s)
[227.596680] Starting dynamic subtest: B-eDP1
[236.316923] Dynamic subtest B-eDP1: SUCCESS (8.730s)
[236.330258] Starting dynamic subtest: C-eDP1
[245.035155] Dynamic subtest C-eDP1: SUCCESS (8.715s)
[245.044998] Starting dynamic subtest: D-eDP1
[253.765662] Dynamic subtest D-eDP1: SUCCESS (8.730s)
[253.770963] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.918s)
[254.977500] [034/133] (764s left) gem_exec_reloc (basic-cpu-gtt-active)
[255.038084] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[255.117405] [035/133] (764s left) perf_pmu (busy-accuracy-2)
[255.160948] Starting subtest: busy-accuracy-2
[255.162907] Starting dynamic subtest: rcs0
[258.206960] Dynamic subtest rcs0: SUCCESS (3.044s)
[258.215803] Starting dynamic subtest: bcs0
[261.264895] Dynamic subtest bcs0: SUCCESS (3.055s)
[261.275592] Starting dynamic subtest: vcs0
[264.309994] Dynamic subtest vcs0: SUCCESS (3.043s)
[264.320559] Starting dynamic subtest: vcs1
[267.354980] Dynamic subtest vcs1: SUCCESS (3.042s)
[267.365764] Starting dynamic subtest: vecs0
[270.401517] Dynamic subtest vecs0: SUCCESS (3.043s)
[270.412501] Starting dynamic subtest: ccs0
[273.458740] Dynamic subtest ccs0: SUCCESS (3.056s)
[273.461287] Subtest busy-accuracy-2: SUCCESS (18.297s)
[273.574122] [036/133] (745s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[273.687829] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[273.692072] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[273.820803] [037/133] (745s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[273.936739] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[277.669671] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.736s)
[278.815840] [038/133] (740s left) sw_sync (sync_busy)
[278.857567] Starting subtest: sync_busy
[278.862806] Subtest sync_busy: SUCCESS (0.003s)
[278.930271] [039/133] (740s left) sysfs_timeslice_duration (idempotent)
[279.000410] Starting subtest: idempotent
[279.002578] Starting dynamic subtest: vecs0
[279.004839] Dynamic subtest vecs0: SUCCESS (0.000s)
[279.014068] Starting dynamic subtest: ccs0
[279.015843] Dynamic subtest ccs0: SUCCESS (0.000s)
[279.024186] Starting dynamic subtest: vcs0
[279.026323] Dynamic subtest vcs0: SUCCESS (0.000s)
[279.034405] Starting dynamic subtest: bcs0
[279.036271] Dynamic subtest bcs0: SUCCESS (0.000s)
[279.043969] Starting dynamic subtest: rcs0
[279.045833] Dynamic subtest rcs0: SUCCESS (0.000s)
[279.053954] Starting dynamic subtest: vcs1
[279.055864] Dynamic subtest vcs1: SUCCESS (0.000s)
[279.057804] Subtest idempotent: SUCCESS (0.006s)
[279.094729] [040/133] (740s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[279.191729] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[279.195969] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[279.276712] [041/133] (740s left) i915_pm_rps (thresholds-park)
[279.350540] Starting subtest: thresholds-park
[279.355190] Subtest thresholds-park: SKIP (0.001s)
[279.470849] [042/133] (740s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[279.573775] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[279.578275] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[279.666418] [043/133] (740s left) gem_softpin (softpin)
[279.717205] Starting subtest: softpin
[312.016061] Subtest softpin: SUCCESS (32.291s)
[312.119828] [044/133] (707s left) kms_flip (flip-vs-blocking-wf-vblank)
[312.215891] Starting subtest: flip-vs-blocking-wf-vblank
[312.218199] Starting dynamic subtest: A-eDP1
[321.135325] Dynamic subtest A-eDP1: SUCCESS (8.921s)
[321.145344] Starting dynamic subtest: B-eDP1
[330.077031] Dynamic subtest B-eDP1: SUCCESS (8.940s)
[330.086464] Starting dynamic subtest: C-eDP1
[338.991519] Dynamic subtest C-eDP1: SUCCESS (8.913s)
[339.001605] Starting dynamic subtest: D-eDP1
[347.921646] Dynamic subtest D-eDP1: SUCCESS (8.927s)
[347.924065] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.709s)
[349.151323] [045/133] (670s left) kms_psr (pr-cursor-render)
[349.255722] Starting subtest: pr-cursor-render
[349.260241] Subtest pr-cursor-render: SKIP (0.000s)
[349.384108] [046/133] (670s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[349.485303] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[349.489211] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[349.583323] [047/133] (670s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[349.682261] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[349.686582] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[349.772250] [048/133] (670s left) gem_ringfill (engines-basic)
[355.930061] Starting subtest: engines-basic
[355.932832] Starting dynamic subtest: rcs0
[355.999993] Dynamic subtest rcs0: SUCCESS (0.070s)
[356.011893] Starting dynamic subtest: bcs0
[356.046450] Dynamic subtest bcs0: SUCCESS (0.044s)
[356.057711] Starting dynamic subtest: vcs0
[356.090219] Dynamic subtest vcs0: SUCCESS (0.041s)
[356.100479] Starting dynamic subtest: vcs1
[356.132140] Dynamic subtest vcs1: SUCCESS (0.040s)
[356.142445] Starting dynamic subtest: vecs0
[356.175028] Dynamic subtest vecs0: SUCCESS (0.041s)
[356.184745] Starting dynamic subtest: ccs0
[356.224893] Dynamic subtest ccs0: SUCCESS (0.047s)
[356.227325] Subtest engines-basic: SUCCESS (0.297s)
[356.308594] [049/133] (663s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[356.434175] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[357.258429] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.826s)
[357.411202] [050/133] (662s left) kms_legacy_colorkey (invalid-plane)
[357.519107] Starting subtest: invalid-plane
[357.521340] Starting dynamic subtest: zero-id
[357.523227] Dynamic subtest zero-id: SUCCESS (0.000s)
[357.532903] Starting dynamic subtest: outrange-id
[357.535175] Dynamic subtest outrange-id: SUCCESS (0.000s)
[357.537400] Subtest invalid-plane: SUCCESS (0.001s)
[357.592168] [051/133] (662s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[357.679351] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[357.705716] Starting dynamic subtest: pipe-A-plane-0
[357.994244] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[358.003222] Starting dynamic subtest: pipe-A-plane-3
[358.227275] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[359.344554] Starting dynamic subtest: pipe-B-plane-0
[359.637723] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[359.649590] Starting dynamic subtest: pipe-B-plane-3
[359.868474] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[360.181197] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.503s)
[361.018728] [052/133] (659s left) kms_dp_linktrain_fallback (dp-fallback)
[361.110417] Starting subtest: dp-fallback
[361.117121] Subtest dp-fallback: SKIP (0.000s)
[361.186412] [053/133] (658s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[361.273176] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[361.277419] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[361.366804] [054/133] (658s left) gem_eio (wait-immediate)
[361.605678] Starting subtest: wait-immediate
[361.995455] Subtest wait-immediate: SUCCESS (0.392s)
[362.110472] [055/133] (658s left) prime_mmap (test_refcounting)
[362.160272] Starting subtest: test_refcounting
[362.161846] Starting dynamic subtest: test_refcounting-smem
[362.192257] Dynamic subtest test_refcounting-smem: SUCCESS (0.033s)
[362.194269] Subtest test_refcounting: SUCCESS (0.034s)
[362.300274] [056/133] (658s left) kms_cursor_crc (cursor-onscreen-32x32)
[362.431232] Starting subtest: cursor-onscreen-32x32
[362.478119] Subtest cursor-onscreen-32x32: SKIP (0.043s)
[362.780501] [057/133] (657s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[362.897499] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[362.899365] Starting dynamic subtest: A-eDP1
[366.540385] Dynamic subtest A-eDP1: SUCCESS (3.639s)
[366.550471] Starting dynamic subtest: B-eDP1
[369.750816] Dynamic subtest B-eDP1: SUCCESS (3.211s)
[369.760892] Starting dynamic subtest: C-eDP1
[372.861442] Dynamic subtest C-eDP1: SUCCESS (3.108s)
[372.871805] Starting dynamic subtest: D-eDP1
[375.964899] Dynamic subtest D-eDP1: SUCCESS (3.102s)
[375.967126] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.067s)
[376.768942] [058/133] (643s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[376.865675] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[376.868040] Starting dynamic subtest: pipe-A-eDP-1
[376.951989] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[376.962264] Starting dynamic subtest: pipe-B-eDP-1
[378.146757] Dynamic subtest pipe-B-eDP-1: SKIP (1.194s)
[378.151337] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.287s)
[379.435721] [059/133] (640s left) gem_exec_params (invalid-ring2)
[379.490130] Starting subtest: invalid-ring2
[379.492328] Subtest invalid-ring2: SUCCESS (0.000s)
[379.596589] [060/133] (640s left) gem_exec_store (pages)
[379.658120] Starting subtest: pages
[379.660408] Starting dynamic subtest: rcs0
[379.742698] Dynamic subtest rcs0: SUCCESS (0.084s)
[379.754108] Starting dynamic subtest: bcs0
[379.812259] Dynamic subtest bcs0: SUCCESS (0.068s)
[379.822082] Starting dynamic subtest: vcs0
[379.886834] Dynamic subtest vcs0: SUCCESS (0.073s)
[379.897711] Starting dynamic subtest: vcs1
[379.959216] Dynamic subtest vcs1: SUCCESS (0.071s)
[379.970479] Starting dynamic subtest: vecs0
[380.025239] Dynamic subtest vecs0: SUCCESS (0.065s)
[380.036156] Starting dynamic subtest: ccs0
[380.092994] Dynamic subtest ccs0: SUCCESS (0.066s)
[380.095632] Subtest pages: SUCCESS (0.435s)
[380.276118] [061/133] (640s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[380.383690] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[380.388091] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[380.477747] [062/133] (640s left) gem_tiled_pread_basic (basic)
[380.531545] Subtest basic: SKIP (0.000s)
[380.587386] [063/133] (639s left) gem_ctx_engines (execute-one)
[380.650068] Starting subtest: execute-one
[383.437138] Subtest execute-one: SUCCESS (2.788s)
[383.621731] [064/133] (637s left) gem_exec_reloc (basic-gtt-cpu-active)
[383.689477] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[383.768209] [065/133] (636s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[383.880208] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[384.537786] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.659s)
[384.692777] [066/133] (636s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[384.910801] Starting subtest: cursor-rapid-movement-128x128
[384.915677] Starting dynamic subtest: pipe-A-eDP-1
[385.470110] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.555s)
[385.501999] Starting dynamic subtest: pipe-D-eDP-1
[386.646487] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.153s)
[386.648770] Subtest cursor-rapid-movement-128x128: SUCCESS (1.736s)
[387.528498] [067/133] (633s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[387.629392] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[387.633709] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[387.730561] [068/133] (633s left) i915_drm_fdinfo (virtual-idle)
[387.773893] Starting subtest: virtual-idle
[390.840563] Subtest virtual-idle: SUCCESS (3.065s)
[390.933192] [069/133] (629s left) kms_async_flips (test-time-stamp-atomic)
[391.034542] Starting subtest: test-time-stamp-atomic
[391.408698] Starting dynamic subtest: pipe-A-eDP-1
[392.203115] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.792s)
[392.585441] Starting dynamic subtest: pipe-B-eDP-1
[393.342708] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.761s)
[393.717039] Starting dynamic subtest: pipe-C-eDP-1
[394.478054] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.766s)
[394.848663] Starting dynamic subtest: pipe-D-eDP-1
[395.614942] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.771s)
[395.617436] Subtest test-time-stamp-atomic: SUCCESS (4.580s)
[396.791776] [070/133] (624s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[396.890587] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[396.894717] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[397.001514] [071/133] (623s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[397.099638] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[397.102007] Starting dynamic subtest: pipe-A-eDP-1
[397.127285] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[397.148096] Starting dynamic subtest: pipe-B-eDP-1
[397.173278] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[397.184066] Starting dynamic subtest: pipe-C-eDP-1
[397.207967] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[397.218963] Starting dynamic subtest: pipe-D-eDP-1
[397.242537] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[397.246607] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[399.323851] [072/133] (621s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[399.420663] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[399.425296] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[399.530176] [073/133] (621s left) kms_concurrent (multi-plane-atomic-lowres)
[399.628512] Starting subtest: multi-plane-atomic-lowres
[399.630840] Starting dynamic subtest: pipe-A-eDP-1
[400.141168] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.509s)
[400.151071] Starting dynamic subtest: pipe-B-eDP-1
[401.378701] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.238s)
[401.388580] Starting dynamic subtest: pipe-C-eDP-1
[402.578404] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.195s)
[402.587679] Starting dynamic subtest: pipe-D-eDP-1
[403.819730] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.240s)
[403.822077] Subtest multi-plane-atomic-lowres: SUCCESS (4.189s)
[404.664246] [074/133] (616s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[404.766708] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[404.768845] Starting dynamic subtest: pipe-A-eDP-1
[404.787674] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.020s)
[404.798685] Starting dynamic subtest: pipe-B-eDP-1
[404.817528] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[404.826726] Starting dynamic subtest: pipe-C-eDP-1
[404.845309] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[404.854677] Starting dynamic subtest: pipe-D-eDP-1
[404.874052] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.026s)
[404.876191] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.092s)
[407.123996] [075/133] (613s left) gem_mmap_offset (blt-coherency)
[407.181321] Starting subtest: blt-coherency
[407.186441] Subtest blt-coherency: SUCCESS (0.007s)
[407.320433] [076/133] (613s left) syncobj_wait (multi-wait-submitted-signaled)
[407.379715] Starting subtest: multi-wait-submitted-signaled
[407.381992] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[407.522946] [077/133] (613s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[407.618717] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[407.622678] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[407.688166] [078/133] (613s left) prime_busy (before)
[407.747396] Starting subtest: before
[407.752440] Starting dynamic subtest: rcs0
[407.781520] Dynamic subtest rcs0: SUCCESS (0.030s)
[407.792566] Starting dynamic subtest: bcs0
[407.833852] Dynamic subtest bcs0: SUCCESS (0.051s)
[407.844468] Starting dynamic subtest: vcs0
[407.875089] Dynamic subtest vcs0: SUCCESS (0.041s)
[407.884631] Starting dynamic subtest: vcs1
[407.916651] Dynamic subtest vcs1: SUCCESS (0.041s)
[407.925420] Starting dynamic subtest: vecs0
[407.957720] Dynamic subtest vecs0: SUCCESS (0.040s)
[407.967148] Starting dynamic subtest: ccs0
[407.999162] Dynamic subtest ccs0: SUCCESS (0.040s)
[408.107264] Subtest before: SUCCESS (0.358s)
[408.197652] [079/133] (613s left) kms_psr (fbc-psr-no-drrs)
[408.289899] Starting subtest: fbc-psr-no-drrs
[408.292145] Starting dynamic subtest: eDP-1
[408.296217] Dynamic subtest eDP-1: SKIP (0.000s)
[408.300217] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[408.366613] [080/133] (612s left) prime_vgem (fence-flip-hang)
[408.449510] Subtest fence-flip-hang: SKIP (0.000s)
[408.552995] [081/133] (612s left) gem_exec_fence (basic-wait)
[408.734774] Starting subtest: basic-wait
[408.737298] Starting dynamic subtest: rcs0
[408.818958] Dynamic subtest rcs0: SUCCESS (0.084s)
[408.830364] Starting dynamic subtest: bcs0
[408.884772] Dynamic subtest bcs0: SUCCESS (0.063s)
[408.895311] Starting dynamic subtest: vcs0
[408.949233] Dynamic subtest vcs0: SUCCESS (0.062s)
[408.961237] Starting dynamic subtest: vcs1
[409.005402] Dynamic subtest vcs1: SUCCESS (0.054s)
[409.016860] Starting dynamic subtest: vecs0
[409.062438] Dynamic subtest vecs0: SUCCESS (0.055s)
[409.073840] Starting dynamic subtest: ccs0
[409.125587] Dynamic subtest ccs0: SUCCESS (0.061s)
[409.128073] Subtest basic-wait: SUCCESS (0.392s)
[410.962676] [082/133] (610s left) gem_eio (in-flight-internal-1us)
[411.217805] Starting subtest: in-flight-internal-1us
[412.981501] Subtest in-flight-internal-1us: SUCCESS (1.763s)
[413.125039] [083/133] (608s left) gem_partial_pwrite_pread (reads-display)
[413.183261] Subtest reads-display: SKIP (0.000s)
[413.258357] [084/133] (608s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[413.357080] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[413.361541] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[413.458306] [085/133] (608s left) kms_vblank (query-forked-busy)
[413.556847] Starting subtest: query-forked-busy
[413.559056] Starting dynamic subtest: pipe-A-eDP-1
[415.441984] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.886s)
[415.457213] Starting dynamic subtest: pipe-D-eDP-1
[417.991421] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.544s)
[417.993800] Subtest query-forked-busy: SUCCESS (4.434s)
[418.805762] [086/133] (602s left) gem_exec_params (invalid-flag)
[418.854431] Starting subtest: invalid-flag
[418.856878] Subtest invalid-flag: SUCCESS (0.000s)
[418.964687] [087/133] (602s left) gem_exec_balancer (nop)
[419.020492] Starting subtest: nop
[465.639559] Subtest nop: SUCCESS (46.618s)
[465.942784] [088/133] (555s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[466.040522] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[466.044673] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[466.162597] [089/133] (555s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[466.277706] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[466.410691] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.135s)
[466.525955] [090/133] (555s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[466.624594] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[466.636711] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s)
[466.719770] [091/133] (555s left) kms_pm_dc (dc5-retention-flops)
[467.817232] Starting subtest: dc5-retention-flops
[467.821768] Subtest dc5-retention-flops: SKIP (0.000s)
[467.890851] [092/133] (553s left) gem_exec_fence (basic-wait-all)
[467.953258] Starting subtest: basic-wait-all
[468.044644] Subtest basic-wait-all: SUCCESS (0.092s)
[469.994169] [093/133] (551s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[470.113244] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[470.117634] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[470.211024] [094/133] (551s left) fbdev (write)
[470.260466] Starting subtest: write
[470.646946] Subtest write: SUCCESS (0.384s)
[470.712888] [095/133] (551s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[470.767786] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[470.875443] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.108s)
[470.951786] [096/133] (551s left) api_intel_bb (delta-check)
[471.015700] Starting subtest: delta-check
[471.019839] Subtest delta-check: SUCCESS (0.007s)
[471.155280] [097/133] (550s left) gem_eio (in-flight-contexts-1us)
[471.362811] Starting subtest: in-flight-contexts-1us
[484.909745] Subtest in-flight-contexts-1us: SUCCESS (13.545s)
[485.028115] [098/133] (537s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[485.125166] Starting subtest: psr2-overlay-plane-update-continuous-sf
[485.127508] Starting dynamic subtest: pipe-A-eDP-1
[486.255475] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.136s)
[486.267165] Starting dynamic subtest: pipe-B-eDP-1
[488.057290] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.798s)
[488.059659] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (2.938s)
[488.869628] [099/133] (533s left) syncobj_timeline (single-wait-all-signaled)
[488.928321] Starting subtest: single-wait-all-signaled
[488.930271] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[489.015660] [100/133] (533s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[489.115937] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[489.118200] Starting dynamic subtest: pipe-A-default-mode
[490.236468] Dynamic subtest pipe-A-default-mode: SKIP (1.119s)
[490.240570] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.121s)
[490.391780] [101/133] (531s left) kms_psr (fbc-pr-sprite-render)
[490.476000] Starting subtest: fbc-pr-sprite-render
[490.480323] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[490.556716] [102/133] (531s left) gem_exec_gttfill (all-engines)
[490.612940] Starting subtest: all-engines
[513.684043] Subtest all-engines: SUCCESS (23.069s)
[513.877441] [103/133] (508s left) gem_ctx_persistence (processes)
[513.989178] Starting subtest: processes
[515.949379] Subtest processes: SUCCESS (1.960s)
[516.035216] [104/133] (506s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[516.145733] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[516.149760] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[516.239671] [105/133] (506s left) kms_dsc (dsc-with-output-formats)
[516.325942] Starting subtest: dsc-with-output-formats
[516.347497] Subtest dsc-with-output-formats: SKIP (0.000s)
[516.400560] [106/133] (506s left) gem_render_copy (y-tiled)
[516.464936] Starting subtest: y-tiled
[516.469390] Subtest y-tiled: SKIP (0.000s)
[516.654143] [107/133] (505s left) gem_ctx_exec (basic)
[516.719629] Starting subtest: basic
[516.725524] Subtest basic: SUCCESS (0.005s)
[516.868264] [108/133] (505s left) i915_pm_rpm (system-suspend-execbuf)
[519.034934] Starting subtest: system-suspend-execbuf
[577.347339] Subtest system-suspend-execbuf: SUCCESS (43.015s)
[577.726157] [109/133] (444s left) vgem_basic (dmabuf-export)
[577.774116] Starting subtest: dmabuf-export
[577.812501] Subtest dmabuf-export: SUCCESS (0.041s)
[577.929269] [110/133] (444s left) gem_eio (kms)
[578.185457] Starting subtest: kms
[597.798533] Subtest kms: SUCCESS (19.611s)
[598.990186] [111/133] (423s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[599.088673] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[599.093742] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[599.191985] [112/133] (423s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[599.249670] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[599.296390] [113/133] (423s left) gem_exec_fence (submit67)
[599.473766] Starting subtest: submit67
[599.479637] Subtest submit67: SKIP (0.000s)
[601.232108] [114/133] (421s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[601.327111] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[601.331744] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[601.411761] [115/133] (421s left) kms_big_fb (linear-32bpp-rotate-180)
[601.513612] Starting subtest: linear-32bpp-rotate-180
[603.061074] Subtest linear-32bpp-rotate-180: SUCCESS (1.547s)
[603.184202] [116/133] (419s left) perf_pmu (faulting-read)
[603.236950] Starting subtest: faulting-read
[603.239603] Starting dynamic subtest: wb
[603.242162] Dynamic subtest wb: SUCCESS (0.001s)
[603.253585] Starting dynamic subtest: wc
[603.256298] Dynamic subtest wc: SUCCESS (0.000s)
[603.266795] Starting dynamic subtest: uc
[603.268969] Dynamic subtest uc: SUCCESS (0.000s)
[603.270885] Subtest faulting-read: SUCCESS (0.004s)
[603.336163] [117/133] (419s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[603.435755] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[610.559537] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.126s)
[610.695862] [118/133] (412s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[610.792881] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[610.798048] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[610.878786] [119/133] (412s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[610.976391] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[610.978938] Starting dynamic subtest: pipe-A-eDP-1
[611.003233] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[611.014608] Starting dynamic subtest: pipe-B-eDP-1
[611.039365] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[611.049640] Starting dynamic subtest: pipe-C-eDP-1
[611.075373] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[611.085728] Starting dynamic subtest: pipe-D-eDP-1
[611.111754] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[611.116564] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[613.280765] [120/133] (409s left) gem_partial_pwrite_pread (write-display)
[613.340964] Subtest write-display: SKIP (0.000s)
[613.411366] [121/133] (409s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[613.502746] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[613.507611] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[613.587259] [122/133] (409s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[613.648640] Starting subtest: mixed-tiled-to-y-tiled-ccs
[613.654208] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[613.836160] [123/133] (409s left) syncobj_timeline (invalid-transfer-illegal-handle)
[613.897149] Starting subtest: invalid-transfer-illegal-handle
[613.899793] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[613.989030] [124/133] (409s left) perf_pmu (rc6)
[614.035224] Starting subtest: rc6
[614.037898] Starting dynamic subtest: gt0
[620.406547] Dynamic subtest gt0: SUCCESS (6.371s)
[620.419725] Starting dynamic subtest: runtime-pm-gt0
[628.143341] Dynamic subtest runtime-pm-gt0: SUCCESS (7.733s)
[628.156818] Starting dynamic subtest: runtime-pm-long-gt0
[640.644990] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.500s)
[640.658875] Starting dynamic subtest: other-idle-gt0
[646.988729] Dynamic subtest other-idle-gt0: SUCCESS (6.342s)
[647.002286] Starting dynamic subtest: gt1
[653.331057] Dynamic subtest gt1: SUCCESS (6.340s)
[653.344473] Starting dynamic subtest: runtime-pm-gt1
[660.850783] Dynamic subtest runtime-pm-gt1: SUCCESS (7.517s)
[660.862744] Starting dynamic subtest: runtime-pm-long-gt1
[673.278823] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.424s)
[673.290687] Starting dynamic subtest: other-idle-gt1
[679.622124] Dynamic subtest other-idle-gt1: SUCCESS (6.340s)
[679.624777] Subtest rc6: SUCCESS (65.586s)
[680.793254] [125/133] (342s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[680.892485] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[680.894528] Starting dynamic subtest: pipe-A-eDP-1
[683.044249] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.154s)
[683.057782] Starting dynamic subtest: pipe-B-eDP-1
[685.444709] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.397s)
[685.462510] Starting dynamic subtest: pipe-C-eDP-1
[687.658153] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.211s)
[687.669227] Starting dynamic subtest: pipe-D-eDP-1
[689.705713] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.046s)
[689.707986] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.816s)
[690.912429] [126/133] (332s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[690.977743] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[691.039859] [127/133] (332s left) gem_exec_schedule (preempt-hang)
[691.227019] Starting subtest: preempt-hang
[691.229748] Starting dynamic subtest: rcs0
[691.478761] Dynamic subtest rcs0: SUCCESS (0.254s)
[691.491570] Starting dynamic subtest: bcs0
[691.710977] Dynamic subtest bcs0: SUCCESS (0.230s)
[691.722374] Starting dynamic subtest: vcs0
[691.937007] Dynamic subtest vcs0: SUCCESS (0.225s)
[691.952460] Starting dynamic subtest: vcs1
[692.161869] Dynamic subtest vcs1: SUCCESS (0.224s)
[692.173524] Starting dynamic subtest: vecs0
[692.388277] Dynamic subtest vecs0: SUCCESS (0.228s)
[692.399780] Starting dynamic subtest: ccs0
[692.624518] Dynamic subtest ccs0: SUCCESS (0.234s)
[692.626961] Subtest preempt-hang: SUCCESS (1.401s)
[693.257278] [128/133] (330s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[693.356760] Starting subtest: sprite-rotation-90-pos-100-0
[693.362326] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[693.411682] [129/133] (330s left) syncobj_wait (wait-any-complex)
[693.468618] Starting subtest: wait-any-complex
[693.528872] Subtest wait-any-complex: SUCCESS (0.063s)
[693.593674] [130/133] (329s left) kms_plane_lowres (tiling-yf)
[693.700598] Starting subtest: tiling-yf
[693.706309] Subtest tiling-yf: SKIP (0.000s)
[693.755137] [131/133] (329s left) gem_readwrite (read-write)
[693.808427] Subtest read-write: SKIP (0.000s)
[693.871630] [132/133] (329s left) api_intel_allocator (reopen)
[693.928404] Starting subtest: reopen
[693.931178] Subtest reopen: SUCCESS (0.004s)
[694.036610] [133/133] (329s left) kms_flip (2x-flip-vs-suspend)
[694.129369] Starting subtest: 2x-flip-vs-suspend
[694.140778] Subtest 2x-flip-vs-suspend: SKIP (0.011s)
[694.195635] Closing watchdogs
results: parsing output: 0/ for test: kms_chamelium_frames
results: parsing output: 1/ for test: device_reset
results: parsing output: 2/ for test: kms_pipe_stress
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: syncobj_wait
results: parsing output: 5/ for test: kms_chamelium_hpd
results: parsing output: 6/ for test: i915_drm_fdinfo
results: parsing output: 7/ for test: kms_cursor_legacy
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: kms_plane_scaling
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: kms_vblank
results: parsing output: 13/ for test: perf_pmu
results: parsing output: 14/ for test: gem_softpin
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: kms_hdr
results: parsing output: 17/ for test: core_auth
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: gem_exec_schedule
results: parsing output: 20/ for test: kms_color_pipeline
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: gen7_exec_parse
results: parsing output: 23/ for test: kms_cursor_crc
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_ctx_isolation
results: parsing output: 27/ for test: kms_async_flips
results: parsing output: 28/ for test: gen3_render_linear_blits
results: parsing output: 29/ for test: kms_prime
results: parsing output: 30/ for test: gem_userptr_blits
results: parsing output: 31/ for test: perf
results: parsing output: 32/ for test: kms_flip
results: parsing output: 33/ for test: gem_exec_reloc
results: parsing output: 34/ for test: perf_pmu
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: sw_sync
results: parsing output: 38/ for test: sysfs_timeslice_duration
results: parsing output: 39/ for test: kms_plane
results: parsing output: 40/ for test: i915_pm_rps
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: gem_softpin
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_ringfill
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: kms_legacy_colorkey
results: parsing output: 50/ for test: kms_plane
results: parsing output: 51/ for test: kms_dp_linktrain_fallback
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_eio
results: parsing output: 54/ for test: prime_mmap
results: parsing output: 55/ for test: kms_cursor_crc
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: kms_psr2_sf
results: parsing output: 58/ for test: gem_exec_params
results: parsing output: 59/ for test: gem_exec_store
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: gem_tiled_pread_basic
results: parsing output: 62/ for test: gem_ctx_engines
results: parsing output: 63/ for test: gem_exec_reloc
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: kms_cursor_crc
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: i915_drm_fdinfo
results: parsing output: 68/ for test: kms_async_flips
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_concurrent
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: gem_mmap_offset
results: parsing output: 75/ for test: syncobj_wait
results: parsing output: 76/ for test: kms_psr2_sf
results: parsing output: 77/ for test: prime_busy
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: prime_vgem
results: parsing output: 80/ for test: gem_exec_fence
results: parsing output: 81/ for test: gem_eio
results: parsing output: 82/ for test: gem_partial_pwrite_pread
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_vblank
results: parsing output: 85/ for test: gem_exec_params
results: parsing output: 86/ for test: gem_exec_balancer
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_pxp
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: kms_pm_dc
results: parsing output: 91/ for test: gem_exec_fence
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: fbdev
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: api_intel_bb
results: parsing output: 96/ for test: gem_eio
results: parsing output: 97/ for test: kms_psr2_sf
results: parsing output: 98/ for test: syncobj_timeline
results: parsing output: 99/ for test: kms_flip_scaled_crc
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: gem_exec_gttfill
results: parsing output: 102/ for test: gem_ctx_persistence
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_dsc
results: parsing output: 105/ for test: gem_render_copy
results: parsing output: 106/ for test: gem_ctx_exec
results: parsing output: 107/ for test: i915_pm_rpm
results: parsing output: 108/ for test: vgem_basic
results: parsing output: 109/ for test: gem_eio
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: gem_lmem_swapping
results: parsing output: 112/ for test: gem_exec_fence
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: perf_pmu
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: gem_partial_pwrite_pread
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_render_copy
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: perf_pmu
results: parsing output: 124/ for test: kms_ccs
results: parsing output: 125/ for test: gem_mmap_gtt
results: parsing output: 126/ for test: gem_exec_schedule
results: parsing output: 127/ for test: kms_rotation_crc
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: kms_plane_lowres
results: parsing output: 130/ for test: gem_readwrite
results: parsing output: 131/ for test: api_intel_allocator
results: parsing output: 132/ for test: kms_flip
Done.