[57.562223] Initializing watchdogs
[57.562297]   /dev/watchdog0
[57.576364] [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.580621] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.582766] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.585984] [001/133] (960s left) prime_self_import (basic-llseek-size)
[57.636781] Starting subtest: basic-llseek-size
[57.660849] Subtest basic-llseek-size: SUCCESS (0.023s)
[57.774211] [002/133] (960s left) syncobj_wait (single-wait-all-submitted)
[57.832665] Starting subtest: single-wait-all-submitted
[57.938777] Subtest single-wait-all-submitted: SUCCESS (0.104s)
[58.011697] [003/133] (960s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[58.070509] Starting subtest: yf-tiled-to-vebox-y-tiled
[58.075098] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[58.255609] [004/133] (959s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[58.368345] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[59.419611] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.045s)
[59.552141] [005/133] (958s left) kms_psr (psr2-sprite-plane-move)
[59.647533] Starting subtest: psr2-sprite-plane-move
[59.649561] Starting dynamic subtest: eDP-1
[61.408920] Dynamic subtest eDP-1: SUCCESS (1.750s)
[61.411026] Subtest psr2-sprite-plane-move: SUCCESS (1.751s)
[62.249305] [006/133] (956s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[62.360169] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[62.362626] Starting dynamic subtest: pipe-A-eDP-1
[62.432726] Dynamic subtest pipe-A-eDP-1: SKIP (0.076s)
[62.442494] Starting dynamic subtest: pipe-B-eDP-1
[63.533277] Dynamic subtest pipe-B-eDP-1: SKIP (1.094s)
[63.537935] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.174s)
[64.725641] [007/133] (953s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[64.828255] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[72.541287] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.700s)
[72.660519] [008/133] (945s left) kms_rotation_crc (exhaust-fences)
[72.753085] Starting subtest: exhaust-fences
[72.757492] Subtest exhaust-fences: SKIP (0.000s)
[72.822684] [009/133] (945s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[72.876964] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[72.985948] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[73.057591] [010/133] (945s left) gem_tiled_blits (interruptible)
[73.131408] Subtest interruptible: SKIP (0.000s)
[73.194204] [011/133] (945s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[73.299359] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[73.301641] Starting dynamic subtest: pipe-A-eDP-1
[79.898523] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.598s)
[79.907212] Starting dynamic subtest: pipe-B-eDP-1
[86.624792] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.724s)
[86.627160] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.324s)
[87.489363] [012/133] (931s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[87.593815] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[94.875069] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.282s)
[95.010577] [013/133] (923s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[95.097100] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[95.099467] Starting dynamic subtest: pipe-A-eDP-1
[95.122605] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[95.131629] Starting dynamic subtest: pipe-B-eDP-1
[95.153372] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[95.159984] Starting dynamic subtest: pipe-C-eDP-1
[95.181607] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[95.188595] Starting dynamic subtest: pipe-D-eDP-1
[95.210369] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[95.214723] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[97.300375] [014/133] (921s left) sriov_basic (bind-unbind-vf)
[97.357891] Starting subtest: bind-unbind-vf
[97.360240] Starting dynamic subtest: vf-1
[97.435170] Dynamic subtest vf-1: FAIL (0.016s)
[97.444603] Starting dynamic subtest: vf-2
[97.516467] Dynamic subtest vf-2: FAIL (0.004s)
[97.525498] Starting dynamic subtest: vf-3
[97.598595] Dynamic subtest vf-3: FAIL (0.004s)
[97.607065] Starting dynamic subtest: vf-4
[97.681278] Dynamic subtest vf-4: FAIL (0.004s)
[97.689932] Starting dynamic subtest: vf-5
[97.764866] Dynamic subtest vf-5: FAIL (0.004s)
[97.773350] Starting dynamic subtest: vf-6
[97.847262] Dynamic subtest vf-6: FAIL (0.004s)
[97.856208] Starting dynamic subtest: vf-7
[97.931177] Dynamic subtest vf-7: FAIL (0.004s)
[97.940096] Starting dynamic subtest: vf-random
[98.011120] Dynamic subtest vf-random: FAIL (0.003s)
[98.019967] Starting dynamic subtest: vf-last
[98.092979] Dynamic subtest vf-last: FAIL (0.508s)
[98.095440] Subtest bind-unbind-vf: FAIL (0.553s)
[98.130626] [015/133] (920s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[98.223152] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[98.227272] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[98.337765] [016/133] (920s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[98.444473] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[98.446441] Starting dynamic subtest: A-eDP1
[102.019503] Dynamic subtest A-eDP1: SUCCESS (3.573s)
[102.026873] Starting dynamic subtest: B-eDP1
[105.221256] Dynamic subtest B-eDP1: SUCCESS (3.198s)
[105.231844] Starting dynamic subtest: C-eDP1
[108.341555] Dynamic subtest C-eDP1: SUCCESS (3.120s)
[108.350901] Starting dynamic subtest: D-eDP1
[111.459325] Dynamic subtest D-eDP1: SUCCESS (3.115s)
[111.461556] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.015s)
[112.248785] [017/133] (906s left) kms_vblank (wait-forked-busy)
[112.354222] Starting subtest: wait-forked-busy
[112.356157] Starting dynamic subtest: pipe-A-eDP-1
[114.236887] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.882s)
[114.250092] Starting dynamic subtest: pipe-D-eDP-1
[116.804998] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.567s)
[116.807421] Subtest wait-forked-busy: SUCCESS (4.453s)
[117.598584] [018/133] (901s left) syncobj_eventfd (invalid-illegal-handle)
[117.646220] Starting subtest: invalid-illegal-handle
[117.648525] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[117.753795] [019/133] (901s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[117.844925] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[117.849479] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[117.948706] [020/133] (900s left) kms_vrr (flip-suspend)
[118.039186] Starting subtest: flip-suspend
[118.045769] Subtest flip-suspend: SKIP (0.000s)
[118.118501] [021/133] (900s left) kms_setmode (basic)
[118.182399] Starting subtest: basic
[118.522364] Starting dynamic subtest: pipe-A-eDP-1
[120.627927] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.101s)
[120.971071] Starting dynamic subtest: pipe-B-eDP-1
[123.052719] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.083s)
[123.360771] Subtest basic: SUCCESS (5.175s)
[124.197671] [022/133] (894s left) kms_plane_alpha_blend (coverage-7efc)
[124.299263] Starting subtest: coverage-7efc
[124.574157] Starting dynamic subtest: pipe-A-eDP-1
[125.140204] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.563s)
[125.163721] Starting dynamic subtest: pipe-D-eDP-1
[126.403842] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.246s)
[126.406342] Subtest coverage-7efc: SUCCESS (2.106s)
[127.273478] [023/133] (891s left) kms_invalid_mode (overflow-vrefresh)
[127.369834] Starting subtest: overflow-vrefresh
[127.372243] Starting dynamic subtest: pipe-A-eDP-1
[127.658977] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[127.667885] Starting dynamic subtest: pipe-B-eDP-1
[127.669971] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[127.678492] Starting dynamic subtest: pipe-C-eDP-1
[127.680911] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[127.687974] Starting dynamic subtest: pipe-D-eDP-1
[127.690332] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[127.692676] Subtest overflow-vrefresh: SUCCESS (0.293s)
[128.512057] [024/133] (890s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[128.614442] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[128.626717] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.011s)
[128.696400] [025/133] (890s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[128.796030] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[128.807226] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[128.877454] [026/133] (890s left) kms_cursor_crc (cursor-offscreen-128x42)
[129.093066] Starting subtest: cursor-offscreen-128x42
[129.134141] Subtest cursor-offscreen-128x42: SKIP (0.039s)
[129.330501] [027/133] (889s left) gem_exec_schedule (timeslicing)
[129.399700] Starting subtest: timeslicing
[129.401506] Starting dynamic subtest: rcs0
[129.411649] Dynamic subtest rcs0: SUCCESS (0.021s)
[129.420388] Starting dynamic subtest: bcs0
[129.432022] Dynamic subtest bcs0: SUCCESS (0.020s)
[129.438747] Starting dynamic subtest: vcs0
[129.452894] Dynamic subtest vcs0: SUCCESS (0.021s)
[129.459622] Starting dynamic subtest: vcs1
[129.472966] Dynamic subtest vcs1: SUCCESS (0.020s)
[129.479855] Starting dynamic subtest: vecs0
[129.493992] Dynamic subtest vecs0: SUCCESS (0.020s)
[129.502089] Starting dynamic subtest: ccs0
[129.512459] Dynamic subtest ccs0: SUCCESS (0.018s)
[129.514671] Subtest timeslicing: SUCCESS (0.122s)
[130.939172] [028/133] (888s left) i915_query (hwconfig_table)
[130.987566] Starting subtest: hwconfig_table
[131.286916] Subtest hwconfig_table: SUCCESS (0.001s)
[131.325140] [029/133] (887s left) kms_lease (lease-revoke)
[131.417033] Starting subtest: lease-revoke
[131.420853] Starting dynamic subtest: pipe-A-eDP-1
[131.446575] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.031s)
[131.457590] Starting dynamic subtest: pipe-B-eDP-1
[131.475872] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.026s)
[131.483586] Starting dynamic subtest: pipe-C-eDP-1
[131.502916] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.026s)
[131.511098] Starting dynamic subtest: pipe-D-eDP-1
[131.531065] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.026s)
[131.532982] Subtest lease-revoke: SUCCESS (0.115s)
[131.648862] [030/133] (887s left) gem_exec_schedule (preempt-other-chain)
[131.722261] Starting subtest: preempt-other-chain
[131.724243] Starting dynamic subtest: rcs0
[131.802464] Dynamic subtest rcs0: SUCCESS (0.088s)
[131.810174] Starting dynamic subtest: bcs0
[131.891219] Dynamic subtest bcs0: SUCCESS (0.088s)
[131.898652] Starting dynamic subtest: vcs0
[131.976705] Dynamic subtest vcs0: SUCCESS (0.084s)
[131.988348] Starting dynamic subtest: vcs1
[132.060782] Dynamic subtest vcs1: SUCCESS (0.083s)
[132.074140] Starting dynamic subtest: vecs0
[132.136632] Dynamic subtest vecs0: SUCCESS (0.075s)
[132.150936] Starting dynamic subtest: ccs0
[132.212091] Dynamic subtest ccs0: SUCCESS (0.075s)
[132.214506] Subtest preempt-other-chain: SUCCESS (0.497s)
[132.939988] [031/133] (886s left) dmabuf_sync_file (export-multiwait)
[133.038255] Starting subtest: export-multiwait
[133.040191] Subtest export-multiwait: SUCCESS (0.001s)
[133.095054] [FACT dmabuf_sync_file (export-multiwait)] new: kernel.kmod_is_loaded.vgem: true
[133.098729] [032/133] (886s left) kms_flip (busy-flip)
[133.188433] Starting subtest: busy-flip
[133.190680] Starting dynamic subtest: A-eDP1
[134.915308] Dynamic subtest A-eDP1: SUCCESS (1.726s)
[134.923592] Starting dynamic subtest: B-eDP1
[136.544237] Dynamic subtest B-eDP1: SUCCESS (1.626s)
[136.552556] Starting dynamic subtest: C-eDP1
[138.267807] Dynamic subtest C-eDP1: SUCCESS (1.721s)
[138.277299] Starting dynamic subtest: D-eDP1
[139.913224] Dynamic subtest D-eDP1: SUCCESS (1.643s)
[139.918728] Subtest busy-flip: SUCCESS (6.730s)
[141.079697] [033/133] (878s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[141.176097] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[141.180299] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[141.303493] [034/133] (878s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[141.411742] Starting subtest: yf-tiled-32bpp-rotate-180
[141.416223] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[141.493569] [035/133] (877s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[141.603831] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[141.608203] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[141.728322] [036/133] (877s left) kms_color (legacy-gamma-reset)
[141.827146] Starting subtest: legacy-gamma-reset
[141.829253] Starting dynamic subtest: pipe-A-eDP-1
[142.204487] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.380s)
[142.212677] Starting dynamic subtest: pipe-B-eDP-1
[142.217581] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s)
[142.226048] Starting dynamic subtest: pipe-C-eDP-1
[142.230672] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[142.237720] Starting dynamic subtest: pipe-D-eDP-1
[142.242310] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[142.244678] Subtest legacy-gamma-reset: SUCCESS (0.417s)
[143.022236] [037/133] (876s left) kms_sequence (get-forked)
[143.118969] Starting subtest: get-forked
[143.121303] Starting dynamic subtest: pipe-A-eDP-1
[145.058064] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.939s)
[145.065988] Starting dynamic subtest: pipe-B-eDP-1
[147.554126] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.494s)
[147.563047] Starting dynamic subtest: pipe-C-eDP-1
[150.091929] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.536s)
[150.100384] Starting dynamic subtest: pipe-D-eDP-1
[152.601059] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.510s)
[152.603443] Subtest get-forked: SUCCESS (9.484s)
[153.447640] [038/133] (866s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[153.543047] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[153.545348] Starting dynamic subtest: pipe-A-eDP-1
[153.640705] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[153.648775] Starting dynamic subtest: pipe-B-eDP-1
[154.827443] Dynamic subtest pipe-B-eDP-1: SKIP (1.183s)
[154.831862] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.287s)
[156.109290] [039/133] (863s left) kms_hdr (bpc-switch-dpms)
[156.211812] Starting subtest: bpc-switch-dpms
[157.280881] Starting dynamic subtest: pipe-A-eDP-1
[161.802646] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.523s)
[161.805039] Subtest bpc-switch-dpms: SUCCESS (5.593s)
[161.927591] [040/133] (857s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[162.030485] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[162.034809] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[162.123607] [041/133] (857s left) gem_ctx_param (set-priority-range)
[162.185955] Starting subtest: set-priority-range
[162.200760] Subtest set-priority-range: SUCCESS (0.015s)
[162.307430] [042/133] (857s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[162.368133] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[162.370457] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[162.493961] [043/133] (857s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[162.597435] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[166.141818] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.548s)
[167.289755] [044/133] (852s left) syncobj_wait (invalid-signal-bad-pad)
[167.350663] Starting subtest: invalid-signal-bad-pad
[167.353049] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[167.469667] [045/133] (852s left) gem_exec_balancer (hog)
[167.525137] Starting subtest: hog
[167.529511] Subtest hog: SKIP (0.000s)
[167.824739] [046/133] (852s left) gem_mmap_gtt (basic-read-write-distinct)
[167.888311] Subtest basic-read-write-distinct: SKIP (0.000s)
[167.951848] [047/133] (851s left) kms_chamelium_color (ctm-red-to-blue)
[168.049312] Subtest ctm-red-to-blue: SKIP (0.000s)
[168.094221] [048/133] (851s left) gen9_exec_parse (allowed-all)
[168.152186] Subtest allowed-all: SKIP (0.000s)
[168.210262] [049/133] (851s left) i915_pm_rpm (gem-execbuf-stress)
[170.137030] Starting subtest: gem-execbuf-stress
[170.139224] Starting dynamic subtest: smem0
[182.960846] Dynamic subtest smem0: SUCCESS (12.827s)
[182.971288] Starting dynamic subtest: extra-wait-smem0
[244.926654] Dynamic subtest extra-wait-smem0: SUCCESS (61.958s)
[244.929772] Subtest gem-execbuf-stress: SUCCESS (74.791s)
[245.297151] [050/133] (774s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[245.401072] Starting subtest: psr-rgb565-draw-blt
[252.340811] Subtest psr-rgb565-draw-blt: SUCCESS (6.942s)
[252.452385] [051/133] (767s left) kms_big_fb (linear-16bpp-rotate-180)
[252.554971] Starting subtest: linear-16bpp-rotate-180
[253.955397] Subtest linear-16bpp-rotate-180: SUCCESS (1.401s)
[254.077153] [052/133] (766s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[254.201505] Starting subtest: flip-vs-cursor-atomic-transitions
[262.108507] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.904s)
[262.931194] [053/133] (757s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[263.030907] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[263.033151] Starting dynamic subtest: pipe-A
[263.139410] Dynamic subtest pipe-A: SKIP (0.106s)
[263.147846] Starting dynamic subtest: pipe-B
[264.291968] Dynamic subtest pipe-B: SKIP (1.150s)
[264.300743] Starting dynamic subtest: pipe-C
[265.432239] Dynamic subtest pipe-C: SUCCESS (1.146s)
[265.439814] Starting dynamic subtest: pipe-D
[266.659303] Dynamic subtest pipe-D: SUCCESS (1.226s)
[266.661553] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.631s)
[267.857989] [054/133] (752s left) gem_wait (wait)
[267.931677] Starting subtest: wait
[267.934083] Starting dynamic subtest: all-engines
[269.909320] Dynamic subtest all-engines: SUCCESS (1.976s)
[269.920328] Starting dynamic subtest: rcs0
[270.955330] Dynamic subtest rcs0: SUCCESS (1.044s)
[270.966187] Starting dynamic subtest: bcs0
[272.004747] Dynamic subtest bcs0: SUCCESS (1.046s)
[272.013745] Starting dynamic subtest: vcs0
[273.050146] Dynamic subtest vcs0: SUCCESS (1.043s)
[273.059192] Starting dynamic subtest: vcs1
[274.096322] Dynamic subtest vcs1: SUCCESS (1.044s)
[274.105142] Starting dynamic subtest: vecs0
[275.141266] Dynamic subtest vecs0: SUCCESS (1.043s)
[275.152303] Starting dynamic subtest: ccs0
[276.189273] Dynamic subtest ccs0: SUCCESS (1.046s)
[276.191936] Subtest wait: SUCCESS (8.259s)
[276.389339] [055/133] (743s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[276.503550] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[276.507839] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[276.610869] [056/133] (743s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[276.728279] Starting subtest: flip-vs-cursor-crc-legacy
[277.368330] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.641s)
[278.185988] [057/133] (742s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[278.287692] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[284.976774] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.691s)
[285.103685] [058/133] (735s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[285.198168] Starting subtest: fbc-rgb565-draw-render
[289.383320] Subtest fbc-rgb565-draw-render: SUCCESS (4.188s)
[290.539219] [059/133] (729s left) kms_content_protection (dp-mst-type-0-hdcp14)
[290.671756] Starting subtest: dp-mst-type-0-hdcp14
[290.676152] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[290.783288] [060/133] (729s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[290.880884] Starting subtest: yf-tiled-8bpp-rotate-90
[290.885223] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[290.983323] [061/133] (729s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[291.078752] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[291.083082] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[291.171031] [062/133] (729s left) kms_flip (flip-vs-suspend-interruptible)
[291.256436] Starting subtest: flip-vs-suspend-interruptible
[291.258729] Starting dynamic subtest: A-eDP1
[324.114950] Dynamic subtest A-eDP1: SUCCESS (4.327s)
[324.124047] Starting dynamic subtest: B-eDP1
[373.136591] Dynamic subtest B-eDP1: SUCCESS (4.474s)
[373.149754] Starting dynamic subtest: C-eDP1
[422.128857] Dynamic subtest C-eDP1: SUCCESS (4.504s)
[422.144743] Starting dynamic subtest: D-eDP1
[471.124636] Dynamic subtest D-eDP1: SUCCESS (4.430s)
[471.127684] Subtest flip-vs-suspend-interruptible: SUCCESS (17.745s)
[472.335773] [063/133] (548s left) gem_ctx_engines (independent)
[472.393881] Starting subtest: independent
[472.396844] Starting dynamic subtest: rcs0
[472.546994] Dynamic subtest rcs0: SUCCESS (0.147s)
[472.557597] Starting dynamic subtest: bcs0
[472.659701] Dynamic subtest bcs0: SUCCESS (0.111s)
[472.670618] Starting dynamic subtest: vcs0
[472.793422] Dynamic subtest vcs0: SUCCESS (0.128s)
[472.806789] Starting dynamic subtest: vcs1
[472.916557] Dynamic subtest vcs1: SUCCESS (0.119s)
[472.929559] Starting dynamic subtest: vecs0
[473.032416] Dynamic subtest vecs0: SUCCESS (0.113s)
[473.041699] Starting dynamic subtest: ccs0
[473.162751] Dynamic subtest ccs0: SUCCESS (0.125s)
[473.171943] Starting dynamic subtest: all-engines
[473.817335] Dynamic subtest all-engines: SUCCESS (0.638s)
[473.820274] Subtest independent: SUCCESS (1.388s)
[474.854261] [064/133] (545s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[474.975646] Starting subtest: short-busy-flip-before-cursor-toggle
[474.981538] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[475.122220] [065/133] (545s left) fbdev (unaligned-read)
[475.165847] Starting subtest: unaligned-read
[475.177834] Subtest unaligned-read: SUCCESS (0.015s)
[475.246386] [066/133] (545s left) kms_cursor_crc (cursor-sliding-32x32)
[475.398172] Starting subtest: cursor-sliding-32x32
[475.442862] Subtest cursor-sliding-32x32: SKIP (0.040s)
[475.707923] [067/133] (545s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[475.817147] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[475.822073] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[475.914171] [068/133] (544s left) gen3_render_tiledx_blits
[476.034611] [069/133] (544s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[476.135601] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[476.139630] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[477.269235] [070/133] (543s left) gem_set_tiling_vs_pwrite
[477.395567] [071/133] (543s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[477.496420] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[477.498812] Starting dynamic subtest: pipe-A-eDP-1
[477.526021] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[477.535346] Starting dynamic subtest: pipe-B-eDP-1
[477.563599] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[477.572773] Starting dynamic subtest: pipe-C-eDP-1
[477.601350] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[477.612757] Starting dynamic subtest: pipe-D-eDP-1
[477.643667] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[477.648881] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[479.683399] [072/133] (541s left) perf_pmu (init-wait)
[479.731366] Starting subtest: init-wait
[479.734046] Starting dynamic subtest: rcs0
[479.736652] Dynamic subtest rcs0: SUCCESS (0.002s)
[479.746967] Starting dynamic subtest: bcs0
[479.749692] Dynamic subtest bcs0: SUCCESS (0.000s)
[479.758654] Starting dynamic subtest: vcs0
[479.761471] Dynamic subtest vcs0: SUCCESS (0.000s)
[479.770322] Starting dynamic subtest: vcs1
[479.772859] Dynamic subtest vcs1: SUCCESS (0.000s)
[479.782537] Starting dynamic subtest: vecs0
[479.784706] Dynamic subtest vecs0: SUCCESS (0.001s)
[479.793666] Starting dynamic subtest: ccs0
[479.796719] Dynamic subtest ccs0: SUCCESS (0.000s)
[479.799410] Subtest init-wait: SUCCESS (0.008s)
[479.845536] [073/133] (541s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[479.947644] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[479.952765] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[480.046698] [074/133] (541s left) kms_rotation_crc (sprite-rotation-90)
[480.137831] Starting subtest: sprite-rotation-90
[480.143611] Subtest sprite-rotation-90: SKIP (0.001s)
[480.223675] [075/133] (540s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[480.326548] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[480.337547] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.010s)
[480.422955] [076/133] (540s left) gem_softpin (allocator-nopin-reserve)
[480.483825] Starting subtest: allocator-nopin-reserve
[480.561240] Subtest allocator-nopin-reserve: SUCCESS (0.077s)
[480.682697] [077/133] (540s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[480.770268] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[480.773846] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[480.867236] [078/133] (540s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[482.901062] Starting subtest: dpms-mode-unset-non-lpsp
[484.057772] Subtest dpms-mode-unset-non-lpsp: SKIP (1.149s)
[484.451379] [079/133] (536s left) gem_reg_read (timestamp-moving)
[484.513562] Starting subtest: timestamp-moving
[485.514948] Subtest timestamp-moving: SUCCESS (0.995s)
[485.607295] [080/133] (535s left) kms_addfb_basic (bad-pitch-128)
[485.661932] Starting subtest: bad-pitch-128
[485.664229] Subtest bad-pitch-128: SUCCESS (0.000s)
[485.812492] [081/133] (535s left) syncobj_timeline (signal)
[485.861681] Starting subtest: signal
[485.864602] Subtest signal: SUCCESS (0.000s)
[485.966801] [082/133] (535s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[486.072606] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[486.077575] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[486.172491] [083/133] (535s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[486.263690] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[486.266564] Starting dynamic subtest: pipe-A-eDP-1
[486.293591] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[486.304477] Starting dynamic subtest: pipe-B-eDP-1
[486.330634] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[486.339992] Starting dynamic subtest: pipe-C-eDP-1
[486.366248] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[486.377976] Starting dynamic subtest: pipe-D-eDP-1
[486.404433] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[486.409536] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[488.516151] [084/133] (532s left) gem_exec_reloc (basic-write-gtt)
[488.577461] Subtest basic-write-gtt: SKIP (0.000s)
[488.676043] [085/133] (532s left) kms_psr (pr-sprite-plane-onoff)
[488.773822] Starting subtest: pr-sprite-plane-onoff
[488.778637] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[488.848547] [086/133] (532s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[489.232525] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[490.038188] [087/133] (531s left) gem_exec_schedule (implicit-boths)
[490.116486] Starting subtest: implicit-boths
[490.118989] Starting dynamic subtest: rcs0
[490.235607] Dynamic subtest rcs0: SUCCESS (0.130s)
[490.246763] Starting dynamic subtest: vcs0
[490.322484] Dynamic subtest vcs0: SUCCESS (0.085s)
[490.335767] Starting dynamic subtest: vcs1
[490.399318] Dynamic subtest vcs1: SUCCESS (0.076s)
[490.411596] Starting dynamic subtest: vecs0
[490.489979] Dynamic subtest vecs0: SUCCESS (0.090s)
[490.503081] Starting dynamic subtest: ccs0
[490.580822] Dynamic subtest ccs0: SUCCESS (0.090s)
[490.583850] Subtest implicit-boths: SUCCESS (0.475s)
[491.785060] [088/133] (529s left) kms_atomic_interruptible (universal-setplane-primary)
[491.874571] Starting subtest: universal-setplane-primary
[491.877007] Starting dynamic subtest: pipe-A-eDP-1
[499.293846] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.405s)
[499.296768] Subtest universal-setplane-primary: SUCCESS (7.407s)
[500.141830] [089/133] (521s left) kms_psr (psr-sprite-render)
[500.231609] Starting subtest: psr-sprite-render
[500.234281] Starting dynamic subtest: eDP-1
[501.961193] Dynamic subtest eDP-1: SUCCESS (1.730s)
[501.964092] Subtest psr-sprite-render: SUCCESS (1.731s)
[502.804911] [090/133] (518s left) sw_sync (sync_busy)
[502.844328] Starting subtest: sync_busy
[502.847019] Subtest sync_busy: SUCCESS (0.002s)
[502.906241] [091/133] (518s left) gem_exec_fence (syncobj-invalid-flags)
[503.341436] Starting subtest: syncobj-invalid-flags
[503.344137] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[504.793328] [092/133] (517s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[504.859651] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[504.960351] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[505.046278] [093/133] (516s left) api_intel_allocator (reloc-allocator)
[505.098173] Starting subtest: reloc-allocator
[505.100684] Starting dynamic subtest: basic
[505.103382] Dynamic subtest basic: SUCCESS (0.004s)
[505.117245] Starting dynamic subtest: parallel-one
[505.119616] Dynamic subtest parallel-one: SUCCESS (0.008s)
[505.129379] Starting dynamic subtest: print
[505.131602] Dynamic subtest print: SUCCESS (0.000s)
[505.140026] Starting dynamic subtest: reuse
[505.142209] Dynamic subtest reuse: SUCCESS (0.000s)
[505.150945] Starting dynamic subtest: fork-reopen-allocator
[505.153229] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s)
[505.155468] Subtest reloc-allocator: SUCCESS (0.026s)
[505.237497] [094/133] (516s left) gem_lmem_swapping (massive-random)
[505.280266] Subtest massive-random: SKIP (0.000s)
[505.326689] [095/133] (516s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[505.424523] Starting subtest: fbc-psr2-sprite-mmap-gtt
[505.426802] Starting dynamic subtest: eDP-1
[505.431430] Dynamic subtest eDP-1: SKIP (0.000s)
[505.435965] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[505.499620] [096/133] (516s left) gem_mmap_gtt (hang-busy)
[505.558761] Subtest hang-busy: SKIP (0.000s)
[505.632612] [097/133] (516s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[505.763401] Starting subtest: flip-vs-cursor-atomic
[513.265598] Subtest flip-vs-cursor-atomic: SUCCESS (7.502s)
[514.139626] [098/133] (507s left) gem_ctx_persistence (engines-hang)
[514.209731] Starting subtest: engines-hang
[514.212241] Starting dynamic subtest: rcs0
[514.253176] Dynamic subtest rcs0: SUCCESS (0.044s)
[514.264113] Starting dynamic subtest: bcs0
[514.383081] Dynamic subtest bcs0: SUCCESS (0.129s)
[514.394830] Starting dynamic subtest: vcs0
[514.475015] Dynamic subtest vcs0: SUCCESS (0.090s)
[514.485808] Starting dynamic subtest: vcs1
[514.572034] Dynamic subtest vcs1: SUCCESS (0.095s)
[514.583988] Starting dynamic subtest: vecs0
[514.672082] Dynamic subtest vecs0: SUCCESS (0.098s)
[514.684840] Starting dynamic subtest: ccs0
[514.764982] Dynamic subtest ccs0: SUCCESS (0.091s)
[514.767666] Subtest engines-hang: SUCCESS (0.558s)
[514.848970] [099/133] (507s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[514.944672] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[514.949684] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[515.017138] [100/133] (507s left) gem_media_vme
[515.139884] [101/133] (507s left) vgem_basic (busy-fence)
[515.183181] Starting subtest: busy-fence
[515.184795] Subtest busy-fence: SUCCESS (0.000s)
[515.240042] [102/133] (507s left) kms_plane_multiple (2x-tiling-none)
[515.332705] Starting subtest: 2x-tiling-none
[515.337516] Subtest 2x-tiling-none: SKIP (0.000s)
[515.405715] [103/133] (506s left) prime_mmap (test_forked_cpu_write)
[515.459672] Starting subtest: test_forked_cpu_write
[515.461814] Starting dynamic subtest: test_forked_cpu_write-smem
[515.467323] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.009s)
[515.469974] Subtest test_forked_cpu_write: SUCCESS (0.010s)
[515.565161] [104/133] (506s left) syncobj_wait (multi-wait-submitted-signaled)
[515.619963] Starting subtest: multi-wait-submitted-signaled
[515.622515] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[515.713277] [105/133] (506s left) gem_bad_reloc (negative-reloc-bltcopy)
[515.771534] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[515.835700] [106/133] (506s left) kms_cursor_crc (cursor-random-64x21)
[516.023468] Starting subtest: cursor-random-64x21
[516.071435] Subtest cursor-random-64x21: SKIP (0.043s)
[516.291032] [107/133] (506s left) kms_psr (fbc-pr-sprite-render)
[516.377395] Starting subtest: fbc-pr-sprite-render
[516.382110] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[516.452628] [108/133] (506s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[516.509170] Starting subtest: invalid-signal-one-illegal-handle
[516.511385] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[516.601055] [109/133] (505s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[516.659690] Starting subtest: invalid-bsd1-flag-on-blt
[516.661808] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[516.773330] [110/133] (505s left) kms_pm_rpm (universal-planes-dpms)
[518.895650] Starting subtest: universal-planes-dpms
[518.898262] Starting dynamic subtest: plane-35
[527.182085] Dynamic subtest plane-35: SUCCESS (8.288s)
[527.194031] Starting dynamic subtest: plane-65
[535.594023] Dynamic subtest plane-65: SUCCESS (8.406s)
[535.605629] Starting dynamic subtest: plane-95
[543.909292] Dynamic subtest plane-95: SUCCESS (8.309s)
[543.920811] Starting dynamic subtest: plane-125
[552.140275] Dynamic subtest plane-125: SUCCESS (8.225s)
[552.152960] Starting dynamic subtest: plane-135
[560.884687] Dynamic subtest plane-135: SUCCESS (8.738s)
[560.896273] Starting dynamic subtest: plane-145
[569.539602] Dynamic subtest plane-145: SUCCESS (8.651s)
[569.542654] Subtest universal-planes-dpms: SUCCESS (50.637s)
[569.917594] [111/133] (452s left) kms_flip (dpms-vs-vblank-race)
[570.007519] Starting subtest: dpms-vs-vblank-race
[570.010242] Starting dynamic subtest: A-eDP1
[573.887576] Dynamic subtest A-eDP1: SUCCESS (3.877s)
[573.897807] Starting dynamic subtest: B-eDP1
[578.533756] Dynamic subtest B-eDP1: SUCCESS (4.645s)
[578.543814] Starting dynamic subtest: C-eDP1
[583.162341] Dynamic subtest C-eDP1: SUCCESS (4.628s)
[583.171817] Starting dynamic subtest: D-eDP1
[587.798806] Dynamic subtest D-eDP1: SUCCESS (4.635s)
[587.801568] Subtest dpms-vs-vblank-race: SUCCESS (17.798s)
[588.672685] [112/133] (434s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[588.774413] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[588.779603] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[588.872402] [113/133] (433s left) i915_drm_fdinfo (busy-check-all)
[588.918104] Starting subtest: busy-check-all
[588.920632] Starting dynamic subtest: rcs0
[588.925732] Dynamic subtest rcs0: SKIP (0.004s)
[588.937033] Starting dynamic subtest: bcs0
[588.941653] Dynamic subtest bcs0: SKIP (0.000s)
[588.950501] Starting dynamic subtest: vcs0
[588.955633] Dynamic subtest vcs0: SKIP (0.000s)
[588.964634] Starting dynamic subtest: vcs1
[588.969577] Dynamic subtest vcs1: SKIP (0.000s)
[588.978620] Starting dynamic subtest: vecs0
[588.983429] Dynamic subtest vecs0: SKIP (0.000s)
[588.991716] Starting dynamic subtest: ccs0
[588.996589] Dynamic subtest ccs0: SKIP (0.000s)
[589.001588] Subtest busy-check-all: SKIP (0.010s)
[589.040300] [114/133] (433s left) gem_pread (snoop)
[589.124601] Subtest snoop: SKIP (0.000s)
[589.194014] [115/133] (433s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[589.287025] Starting subtest: addfb25-y-tiled-small-legacy
[589.292064] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[589.385324] [116/133] (433s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[589.508973] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[589.640316] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.135s)
[589.756250] [117/133] (433s left) kms_async_flips (crc-atomic)
[589.849547] Starting subtest: crc-atomic
[590.226094] Starting dynamic subtest: pipe-A-eDP-1
[593.097663] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.872s)
[593.484688] Starting dynamic subtest: pipe-B-eDP-1
[596.420693] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.944s)
[596.788673] Starting dynamic subtest: pipe-C-eDP-1
[599.632633] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.854s)
[599.997867] Starting dynamic subtest: pipe-D-eDP-1
[602.869119] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.881s)
[602.871672] Subtest crc-atomic: SUCCESS (13.020s)
[604.053258] [118/133] (418s left) gem_ctx_persistence (file)
[604.130842] Starting subtest: file
[604.258184] Subtest file: SUCCESS (0.127s)
[604.381030] [119/133] (418s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[604.474847] Starting subtest: crc-primary-suspend-y-tiled-ccs
[604.477107] Starting dynamic subtest: pipe-A-eDP-1
[604.486121] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[604.495385] Starting dynamic subtest: pipe-B-eDP-1
[604.504482] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[604.515430] Starting dynamic subtest: pipe-C-eDP-1
[604.524815] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[604.533175] Starting dynamic subtest: pipe-D-eDP-1
[604.542816] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[604.547608] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.004s)
[606.709751] [120/133] (416s left) gem_render_copy (linear-to-vebox-yf-tiled)
[606.782416] Starting subtest: linear-to-vebox-yf-tiled
[606.787261] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[606.967338] [121/133] (416s left) gem_exec_schedule (u-submit-golden-slice)
[607.045360] Starting subtest: u-submit-golden-slice
[607.047629] Starting dynamic subtest: rcs0
[607.073391] Dynamic subtest rcs0: SUCCESS (0.038s)
[607.083800] Starting dynamic subtest: bcs0
[607.107503] Dynamic subtest bcs0: SUCCESS (0.033s)
[607.116857] Starting dynamic subtest: vcs0
[607.142462] Dynamic subtest vcs0: SUCCESS (0.034s)
[607.154363] Starting dynamic subtest: vcs1
[607.169532] Dynamic subtest vcs1: SUCCESS (0.027s)
[607.180820] Starting dynamic subtest: vecs0
[607.201825] Dynamic subtest vecs0: SUCCESS (0.032s)
[607.213201] Starting dynamic subtest: ccs0
[607.232699] Dynamic subtest ccs0: SUCCESS (0.029s)
[607.235715] Subtest u-submit-golden-slice: SUCCESS (0.198s)
[608.833568] [122/133] (414s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[608.922590] Starting subtest: primary-yf-tiled-reflect-x-270
[608.927429] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[608.995541] [123/133] (414s left) gem_exec_balancer (parallel-ordering)
[609.253644] Starting subtest: parallel-ordering
[610.211667] Subtest parallel-ordering: SUCCESS (0.958s)
[610.339097] [124/133] (412s left) i915_hangman (gt-engine-error)
[610.406495] Starting subtest: gt-engine-error
[610.408862] Starting dynamic subtest: rcs0
[611.709559] Dynamic subtest rcs0: SUCCESS (1.303s)
[611.721718] Starting dynamic subtest: bcs0
[613.692413] Dynamic subtest bcs0: SUCCESS (1.980s)
[613.708932] Starting dynamic subtest: vcs0
[615.676486] Dynamic subtest vcs0: SUCCESS (1.980s)
[615.689402] Starting dynamic subtest: vcs1
[617.659353] Dynamic subtest vcs1: SUCCESS (1.980s)
[617.673808] Starting dynamic subtest: vecs0
[619.645814] Dynamic subtest vecs0: SUCCESS (1.983s)
[619.658830] Starting dynamic subtest: ccs0
[621.628766] Dynamic subtest ccs0: SUCCESS (1.980s)
[621.631760] Subtest gt-engine-error: SUCCESS (11.223s)
[621.827419] [125/133] (401s left) api_intel_bb (render-ccs)
[621.890246] Starting subtest: render-ccs
[622.250393] Subtest render-ccs: SUCCESS (0.361s)
[622.368860] [126/133] (400s left) gem_eio (create-ext)
[622.566832] Starting subtest: create-ext
[622.856720] Subtest create-ext: SUCCESS (0.287s)
[622.997205] [127/133] (400s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[623.086828] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[629.874832] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.791s)
[629.999207] [128/133] (393s left) gem_flink_basic (double-flink)
[630.055652] Starting subtest: double-flink
[630.057967] Subtest double-flink: SUCCESS (0.000s)
[630.145090] [129/133] (393s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[630.242705] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[630.245546] Starting dynamic subtest: pipe-A
[630.305441] Dynamic subtest pipe-A: SUCCESS (0.065s)
[630.315275] Starting dynamic subtest: pipe-B
[631.453557] Dynamic subtest pipe-B: SUCCESS (1.146s)
[631.465807] Starting dynamic subtest: pipe-C
[632.579308] Dynamic subtest pipe-C: SUCCESS (1.124s)
[632.589828] Starting dynamic subtest: pipe-D
[633.713497] Dynamic subtest pipe-D: SUCCESS (1.133s)
[633.716484] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.473s)
[634.891411] [130/133] (388s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[634.990075] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[634.995429] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[635.090212] [131/133] (388s left) gem_exec_reloc (basic-cpu-gtt)
[635.156652] Subtest basic-cpu-gtt: SKIP (0.000s)
[635.234447] [132/133] (388s left) kms_feature_discovery (psr1)
[635.329391] Starting subtest: psr1
[635.332379] Subtest psr1: SUCCESS (0.000s)
[635.416699] [133/133] (388s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[635.529755] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[635.535222] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s)
[635.623514] Closing watchdogs
results: parsing output: 0/ for test: prime_self_import
results: parsing output: 1/ for test: syncobj_wait
results: parsing output: 2/ for test: gem_render_copy
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: kms_psr2_sf
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_rotation_crc
results: parsing output: 8/ for test: syncobj_wait
results: parsing output: 9/ for test: gem_tiled_blits
results: parsing output: 10/ for test: kms_psr2_sf
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: sriov_basic
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_flip
results: parsing output: 16/ for test: kms_vblank
results: parsing output: 17/ for test: syncobj_eventfd
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_vrr
results: parsing output: 20/ for test: kms_setmode
results: parsing output: 21/ for test: kms_plane_alpha_blend
results: parsing output: 22/ for test: kms_invalid_mode
results: parsing output: 23/ for test: kms_flip
results: parsing output: 24/ for test: kms_flip
results: parsing output: 25/ for test: kms_cursor_crc
results: parsing output: 26/ for test: gem_exec_schedule
results: parsing output: 27/ for test: i915_query
results: parsing output: 28/ for test: kms_lease
results: parsing output: 29/ for test: gem_exec_schedule
results: parsing output: 30/ for test: dmabuf_sync_file
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_color
results: parsing output: 36/ for test: kms_sequence
results: parsing output: 37/ for test: kms_psr2_sf
results: parsing output: 38/ for test: kms_hdr
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_ctx_param
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: syncobj_wait
results: parsing output: 44/ for test: gem_exec_balancer
results: parsing output: 45/ for test: gem_mmap_gtt
results: parsing output: 46/ for test: kms_chamelium_color
results: parsing output: 47/ for test: gen9_exec_parse
results: parsing output: 48/ for test: i915_pm_rpm
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: kms_cursor_legacy
results: parsing output: 52/ for test: kms_plane_scaling
results: parsing output: 53/ for test: gem_wait
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_cursor_legacy
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_content_protection
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_flip
results: parsing output: 62/ for test: gem_ctx_engines
results: parsing output: 63/ for test: kms_cursor_legacy
results: parsing output: 64/ for test: fbdev
results: parsing output: 65/ for test: kms_cursor_crc
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gen3_render_tiledx_blits
results: parsing output: 68/ for test: kms_ccs
results: parsing output: 69/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: perf_pmu
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_rotation_crc
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: gem_softpin
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_pm_rpm
results: parsing output: 78/ for test: gem_reg_read
results: parsing output: 79/ for test: kms_addfb_basic
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: gem_exec_reloc
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: kms_chamelium_hpd
results: parsing output: 86/ for test: gem_exec_schedule
results: parsing output: 87/ for test: kms_atomic_interruptible
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: sw_sync
results: parsing output: 90/ for test: gem_exec_fence
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: api_intel_allocator
results: parsing output: 93/ for test: gem_lmem_swapping
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: gem_mmap_gtt
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: gem_ctx_persistence
results: parsing output: 98/ for test: kms_flip_scaled_crc
results: parsing output: 99/ for test: gem_media_vme
results: parsing output: 100/ for test: vgem_basic
results: parsing output: 101/ for test: kms_plane_multiple
results: parsing output: 102/ for test: prime_mmap
results: parsing output: 103/ for test: syncobj_wait
results: parsing output: 104/ for test: gem_bad_reloc
results: parsing output: 105/ for test: kms_cursor_crc
results: parsing output: 106/ for test: kms_psr
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: gem_exec_params
results: parsing output: 109/ for test: kms_pm_rpm
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: i915_drm_fdinfo
results: parsing output: 113/ for test: gem_pread
results: parsing output: 114/ for test: kms_addfb_basic
results: parsing output: 115/ for test: gem_pxp
results: parsing output: 116/ for test: kms_async_flips
results: parsing output: 117/ for test: gem_ctx_persistence
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: gem_render_copy
results: parsing output: 120/ for test: gem_exec_schedule
results: parsing output: 121/ for test: kms_rotation_crc
results: parsing output: 122/ for test: gem_exec_balancer
results: parsing output: 123/ for test: i915_hangman
results: parsing output: 124/ for test: api_intel_bb
results: parsing output: 125/ for test: gem_eio
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_flink_basic
results: parsing output: 128/ for test: kms_plane_scaling
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: gem_exec_reloc
results: parsing output: 131/ for test: kms_feature_discovery
results: parsing output: 132/ for test: kms_plane
Done.