[57.856356] Initializing watchdogs
[57.856409]   /dev/watchdog0
[57.864994] [001/131] (960s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[57.981153] Starting subtest: psr-modesetfrombusy
[62.053846] Subtest psr-modesetfrombusy: SUCCESS (4.062s)
[62.148223] [002/131] (956s left) gem_softpin (full)
[62.208135] Starting subtest: full
[62.214370] Subtest full: SUCCESS (0.006s)
[62.314281] [003/131] (956s left) gem_readwrite (read-write)
[62.368999] Subtest read-write: SKIP (0.000s)
[62.404255] [004/131] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[62.507936] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[62.511558] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[62.589625] [005/131] (955s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[62.693575] Starting subtest: x-tiled-32bpp-rotate-0
[64.075785] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.378s)
[64.208348] [006/131] (954s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[64.318949] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[64.322630] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[64.420481] [007/131] (954s left) i915_power (sanity)
[64.480135] Starting subtest: sanity
[64.483854] Subtest sanity: SKIP (0.000s)
[64.565768] [008/131] (953s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[64.953514] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[65.751670] [009/131] (952s left) kms_plane_alpha_blend (alpha-opaque-fb)
[65.846762] Starting subtest: alpha-opaque-fb
[66.139423] Starting dynamic subtest: pipe-A-eDP-1
[66.718243] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.576s)
[66.725713] Starting dynamic subtest: pipe-D-eDP-1
[68.016405] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.298s)
[68.018954] Subtest alpha-opaque-fb: SUCCESS (2.165s)
[68.831033] [010/131] (949s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[68.931077] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[68.933602] Starting dynamic subtest: pipe-A-eDP-1
[68.957525] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[68.966585] Starting dynamic subtest: pipe-B-eDP-1
[68.988819] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[68.995221] Starting dynamic subtest: pipe-C-eDP-1
[69.017646] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[69.024204] Starting dynamic subtest: pipe-D-eDP-1
[69.047382] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[69.051639] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.002s)
[71.084639] [011/131] (947s left) kms_chamelium_audio (dp-audio-edid)
[71.646215] Subtest dp-audio-edid: SKIP (0.000s)
[72.390238] [012/131] (946s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[72.528352] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[77.373760] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.845s)
[77.476653] [013/131] (941s left) kms_cursor_crc (cursor-random-max-size)
[77.750951] Starting subtest: cursor-random-max-size
[77.757708] Subtest cursor-random-max-size: SKIP (0.000s)
[77.880149] [014/131] (940s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[77.982074] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[77.984361] Starting dynamic subtest: pipe-A-default-mode
[80.708694] Dynamic subtest pipe-A-default-mode: SUCCESS (2.723s)
[80.710710] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.724s)
[81.535119] [015/131] (937s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[81.601075] Starting subtest: map-fixed-invalidate-overlap
[81.605758] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[81.698382] [016/131] (936s left) gem_userptr_blits (relocations)
[81.779368] Starting subtest: relocations
[81.783664] Subtest relocations: SKIP (0.000s)
[81.910318] [017/131] (936s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[82.014932] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[82.017227] Starting dynamic subtest: pipe-A-eDP-1
[82.039692] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[82.046710] Starting dynamic subtest: pipe-B-eDP-1
[82.068277] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[82.074639] Starting dynamic subtest: pipe-C-eDP-1
[82.096793] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[82.103140] Starting dynamic subtest: pipe-D-eDP-1
[82.124936] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[82.129270] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[84.191659] [018/131] (934s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[84.306361] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[84.310696] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[84.404011] [019/131] (934s left) kms_addfb_basic (bo-too-small)
[84.500983] Starting subtest: bo-too-small
[84.503440] Subtest bo-too-small: SUCCESS (0.000s)
[84.602615] [020/131] (934s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[84.659604] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[84.661604] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[84.735454] [021/131] (934s left) gem_exec_nop (basic-sequential)
[84.803889] Starting subtest: basic-sequential
[101.009990] Subtest basic-sequential: SUCCESS (16.213s)
[101.232829] [022/131] (917s left) gem_exec_params (rsvd2-dirt)
[101.289795] Starting subtest: rsvd2-dirt
[101.294438] Subtest rsvd2-dirt: SKIP (0.000s)
[101.390057] [023/131] (917s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[106.356023] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[106.360485] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[107.196907] [024/131] (911s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[107.256308] Starting subtest: single-wait-all-for-submit-signaled
[107.258752] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[107.328762] [025/131] (911s left) gem_caching (writes)
[107.382740] Subtest writes: SKIP (0.000s)
[107.437945] [026/131] (911s left) gem_exec_flush (basic-wb-set-default)
[107.510477] Starting subtest: basic-wb-set-default
[112.988810] Subtest basic-wb-set-default: SUCCESS (5.478s)
[113.148693] [027/131] (905s left) kms_psr (pr-sprite-render)
[113.261140] Starting subtest: pr-sprite-render
[113.265828] Subtest pr-sprite-render: SKIP (0.000s)
[113.312409] [028/131] (905s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[113.373179] Starting subtest: multi-wait-available-unsubmitted-signaled
[113.375608] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[113.448639] [029/131] (905s left) drm_read (short-buffer-wakeup)
[113.599833] Starting subtest: short-buffer-wakeup
[145.818185] Subtest short-buffer-wakeup: SUCCESS (32.216s)
[145.940488] [030/131] (873s left) kms_vrr (flip-basic)
[146.040822] Starting subtest: flip-basic
[146.047192] Subtest flip-basic: SKIP (0.000s)
[146.094408] [031/131] (872s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[146.159638] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[146.201278] [032/131] (872s left) kms_plane (planar-pixel-format-settings)
[146.295968] Starting subtest: planar-pixel-format-settings
[146.324876] Subtest planar-pixel-format-settings: SUCCESS (0.026s)
[146.380053] [033/131] (872s left) kms_invalid_mode (zero-hdisplay)
[146.477990] Starting subtest: zero-hdisplay
[146.480286] Starting dynamic subtest: pipe-A-eDP-1
[146.759511] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.280s)
[146.766411] Starting dynamic subtest: pipe-B-eDP-1
[146.768656] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[146.775163] Starting dynamic subtest: pipe-C-eDP-1
[146.778043] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[146.784802] Starting dynamic subtest: pipe-D-eDP-1
[146.786689] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[146.788544] Subtest zero-hdisplay: SUCCESS (0.285s)
[147.612381] [034/131] (871s left) kms_vblank (ts-continuation-modeset)
[147.713059] Starting subtest: ts-continuation-modeset
[147.715371] Starting dynamic subtest: pipe-A-eDP-1
[149.189671] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.474s)
[149.202876] Starting dynamic subtest: pipe-D-eDP-1
[151.338683] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.148s)
[151.341059] Subtest ts-continuation-modeset: SUCCESS (3.625s)
[152.116772] [035/131] (866s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[152.227485] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[152.231695] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[152.290572] [036/131] (866s left) kms_pm_rpm (dpms-non-lpsp)
[154.123226] Starting subtest: dpms-non-lpsp
[154.128809] Subtest dpms-non-lpsp: SKIP (0.001s)
[154.549414] [037/131] (864s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[154.654619] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[159.163041] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (4.511s)
[159.266260] [038/131] (859s left) kms_cursor_legacy (single-move)
[159.390239] Starting subtest: single-move
[159.392092] Starting dynamic subtest: pipe-A
[164.774043] Dynamic subtest pipe-A: SUCCESS (5.381s)
[164.783984] Starting dynamic subtest: pipe-B
[170.154875] Dynamic subtest pipe-B: SUCCESS (5.381s)
[170.164464] Starting dynamic subtest: pipe-C
[175.538875] Dynamic subtest pipe-C: SUCCESS (5.383s)
[175.546594] Starting dynamic subtest: pipe-D
[180.921104] Dynamic subtest pipe-D: SUCCESS (5.382s)
[180.928765] Starting dynamic subtest: all-pipes
[186.311670] Dynamic subtest all-pipes: SUCCESS (5.389s)
[186.313959] Subtest single-move: SUCCESS (26.919s)
[186.432891] [039/131] (832s left) gem_sync (basic-store-all)
[186.500114] Starting subtest: basic-store-all
[189.286966] Subtest basic-store-all: SUCCESS (2.797s)
[189.449135] [040/131] (829s left) gem_eio (create-ext)
[189.716279] Starting subtest: create-ext
[190.083081] Subtest create-ext: SUCCESS (0.367s)
[190.216630] [041/131] (828s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[190.312854] Starting subtest: fbc-pr-cursor-mmap-cpu
[190.317334] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[190.364792] [042/131] (828s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[190.436449] Starting subtest: x-tiled-to-vebox-y-tiled
[190.440462] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[190.599514] [043/131] (828s left) gem_userptr_blits (readonly-unsync)
[190.676168] Subtest readonly-unsync: SKIP (0.000s)
[190.797711] [044/131] (828s left) gem_exec_capture (pi)
[190.860337] Starting subtest: pi
[190.862753] Starting dynamic subtest: rcs0
[195.133803] Dynamic subtest rcs0: SUCCESS (4.275s)
[195.143131] Starting dynamic subtest: bcs0
[199.064153] Dynamic subtest bcs0: SUCCESS (3.929s)
[199.073186] Starting dynamic subtest: vcs0
[203.006816] Dynamic subtest vcs0: SUCCESS (3.942s)
[203.017342] Starting dynamic subtest: vcs1
[206.913884] Dynamic subtest vcs1: SUCCESS (3.906s)
[206.924532] Starting dynamic subtest: vecs0
[210.864284] Dynamic subtest vecs0: SUCCESS (3.949s)
[210.878792] Starting dynamic subtest: ccs0
[214.825729] Dynamic subtest ccs0: SUCCESS (3.960s)
[214.828030] Subtest pi: SUCCESS (23.967s)
[214.885600] [045/131] (804s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[215.038336] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[215.042602] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[215.130485] [046/131] (804s left) i915_module_load (resize-bar)
[215.166981] Starting subtest: resize-bar
[215.185941] Subtest resize-bar: SKIP (0.015s)
[215.202922] [047/131] (804s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[215.308733] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[215.313255] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[215.375308] [048/131] (803s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[215.472918] Starting subtest: x-tiled-8bpp-rotate-90
[215.493717] Subtest x-tiled-8bpp-rotate-90: SKIP (0.020s)
[215.588317] [049/131] (803s left) prime_busy (after-wait)
[215.654410] Starting subtest: after-wait
[215.660194] Starting dynamic subtest: rcs0
[215.691769] Dynamic subtest rcs0: SUCCESS (0.033s)
[215.701207] Starting dynamic subtest: bcs0
[215.741782] Dynamic subtest bcs0: SUCCESS (0.050s)
[215.750807] Starting dynamic subtest: vcs0
[215.781344] Dynamic subtest vcs0: SUCCESS (0.040s)
[215.789311] Starting dynamic subtest: vcs1
[215.822971] Dynamic subtest vcs1: SUCCESS (0.041s)
[215.831142] Starting dynamic subtest: vecs0
[215.862493] Dynamic subtest vecs0: SUCCESS (0.039s)
[215.870533] Starting dynamic subtest: ccs0
[215.903949] Dynamic subtest ccs0: SUCCESS (0.041s)
[216.013666] Subtest after-wait: SUCCESS (0.358s)
[216.068284] [050/131] (803s left) dmabuf_sync_file (export-basic)
[216.163753] Starting subtest: export-basic
[216.165671] Subtest export-basic: SUCCESS (0.001s)
[216.200125] [051/131] (803s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[216.308477] Starting subtest: yf-tiled-addfb-size-overflow
[216.312510] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[216.377974] [052/131] (802s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[216.483287] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[216.485677] Starting dynamic subtest: A-eDP1
[220.119673] Dynamic subtest A-eDP1: SUCCESS (3.635s)
[220.129459] Starting dynamic subtest: B-eDP1
[223.300452] Dynamic subtest B-eDP1: SUCCESS (3.179s)
[223.308659] Starting dynamic subtest: C-eDP1
[226.383879] Dynamic subtest C-eDP1: SUCCESS (3.083s)
[226.394805] Starting dynamic subtest: D-eDP1
[229.447678] Dynamic subtest D-eDP1: SUCCESS (3.065s)
[229.450068] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (12.968s)
[230.225972] [053/131] (789s left) kms_feature_discovery (psr1)
[230.336991] Starting subtest: psr1
[230.339251] Subtest psr1: SUCCESS (0.000s)
[230.389836] [054/131] (789s left) kms_cursor_crc (cursor-onscreen-32x32)
[230.524440] Starting subtest: cursor-onscreen-32x32
[230.562575] Subtest cursor-onscreen-32x32: SKIP (0.032s)
[230.809033] [055/131] (788s left) gem_softpin (allocator-basic-reserve)
[230.871408] Starting subtest: allocator-basic-reserve
[230.937986] Subtest allocator-basic-reserve: SUCCESS (0.067s)
[231.074115] [056/131] (788s left) gem_ctx_exec (basic-nohangcheck)
[231.135829] Starting subtest: basic-nohangcheck
[231.384964] Subtest basic-nohangcheck: SUCCESS (0.252s)
[231.489389] [057/131] (787s left) kms_lease (lease-invalid-plane)
[231.583375] Starting subtest: lease-invalid-plane
[231.585730] Starting dynamic subtest: pipe-A-eDP-1
[231.588164] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[231.597155] Starting dynamic subtest: pipe-B-eDP-1
[231.599067] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[231.606930] Starting dynamic subtest: pipe-C-eDP-1
[231.609168] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[231.616951] Starting dynamic subtest: pipe-D-eDP-1
[231.618907] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[231.620829] Subtest lease-invalid-plane: SUCCESS (0.003s)
[231.638971] [058/131] (787s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[231.742660] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[236.479275] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (4.740s)
[236.606183] [059/131] (782s left) api_intel_bb (object-noreloc-keep-cache-simple)
[236.668471] Starting subtest: object-noreloc-keep-cache-simple
[236.673491] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.005s)
[236.791891] [060/131] (782s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[236.890528] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[241.574302] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (4.686s)
[241.688782] [061/131] (777s left) vgem_slow (nohang)
[241.739971] Starting subtest: nohang
[252.040074] Subtest nohang: SUCCESS (10.301s)
[252.085870] [062/131] (767s left) gem_workarounds (reset)
[252.159509] Starting subtest: reset
[252.337780] Subtest reset: SUCCESS (0.178s)
[252.446152] [063/131] (767s left) kms_flip (2x-flip-vs-panning-interruptible)
[252.546644] Starting subtest: 2x-flip-vs-panning-interruptible
[252.559722] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[252.614347] [064/131] (767s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[252.680767] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[252.791095] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.108s)
[252.846061] [065/131] (766s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[252.950316] Starting subtest: psr-1p-pri-indfb-multidraw
[272.575118] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (19.627s)
[272.689824] [066/131] (746s left) gem_exec_parallel (userptr)
[272.761246] Starting subtest: userptr
[272.763337] Starting dynamic subtest: rcs0
[274.226160] Dynamic subtest rcs0: SUCCESS (1.464s)
[274.236814] Starting dynamic subtest: bcs0
[275.727669] Dynamic subtest bcs0: SUCCESS (1.500s)
[275.736820] Starting dynamic subtest: vcs0
[280.904033] Dynamic subtest vcs0: SUCCESS (5.172s)
[280.913960] Starting dynamic subtest: vcs1
[282.922388] Dynamic subtest vcs1: SUCCESS (2.017s)
[282.931463] Starting dynamic subtest: vecs0
[284.919500] Dynamic subtest vecs0: SUCCESS (1.995s)
[284.930554] Starting dynamic subtest: ccs0
[286.421626] Dynamic subtest ccs0: SUCCESS (1.502s)
[286.423901] Subtest userptr: SUCCESS (13.660s)
[286.593698] [067/131] (733s left) kms_cursor_crc (cursor-offscreen-256x85)
[286.849085] Starting subtest: cursor-offscreen-256x85
[286.887363] Subtest cursor-offscreen-256x85: SKIP (0.034s)
[287.061494] [068/131] (732s left) gem_pxp (hw-rejects-pxp-buffer)
[287.188293] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[288.287141] [069/131] (731s left) gen7_exec_parse (oacontrol-tracking)
[288.335678] Subtest oacontrol-tracking: SKIP (0.000s)
[288.375828] [070/131] (731s left) kms_chamelium_audio (hdmi-audio)
[288.756438] Subtest hdmi-audio: SKIP (0.000s)
[289.556896] [071/131] (730s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[289.667786] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[289.672211] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[289.752418] [072/131] (730s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[289.820302] Subtest untiled-to-tiled: SKIP (0.000s)
[289.872896] [073/131] (729s left) gem_lmem_swapping (basic)
[289.917195] Subtest basic: SKIP (0.000s)
[289.939192] [074/131] (729s left) kms_hdr (brightness-with-hdr)
[290.044328] Starting subtest: brightness-with-hdr
[290.051084] Subtest brightness-with-hdr: SKIP (0.000s)
[290.099414] [075/131] (729s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[290.207622] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[290.211614] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[290.305233] [076/131] (729s left) gem_create (create-valid-nonaligned)
[290.363907] Starting subtest: create-valid-nonaligned
[290.366238] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[290.526943] [077/131] (729s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[290.624475] Starting subtest: 4-tiled-32bpp-rotate-270
[290.646570] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.019s)
[290.747098] [078/131] (729s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[290.857847] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[291.481739] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.625s)
[291.611263] [079/131] (728s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[291.659309] Starting subtest: etime-single-wait-for-submit-submitted
[291.767136] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.107s)
[291.823183] [080/131] (728s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[291.922658] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[291.926593] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[291.989870] [081/131] (727s left) kms_fbcon_fbt (fbc-suspend)
[292.054834] Starting subtest: fbc-suspend
[339.624731] Subtest fbc-suspend: SUCCESS (17.661s)
[339.686839] [082/131] (710s left) gem_bad_reloc (negative-reloc-lut)
[339.754278] Subtest negative-reloc-lut: SKIP (0.000s)
[339.817458] [083/131] (710s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[339.916504] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[339.921681] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[339.981137] [084/131] (709s left) perf_pmu (busy-no-semaphores)
[340.024916] Starting subtest: busy-no-semaphores
[340.027893] Starting dynamic subtest: rcs0
[340.608371] Dynamic subtest rcs0: SUCCESS (0.579s)
[340.621511] Starting dynamic subtest: bcs0
[341.159423] Dynamic subtest bcs0: SUCCESS (0.547s)
[341.172752] Starting dynamic subtest: vcs0
[341.713354] Dynamic subtest vcs0: SUCCESS (0.548s)
[341.726906] Starting dynamic subtest: vcs1
[343.253109] Dynamic subtest vcs1: SUCCESS (1.530s)
[343.266219] Starting dynamic subtest: vecs0
[345.236427] Dynamic subtest vecs0: SUCCESS (1.974s)
[345.249238] Starting dynamic subtest: ccs0
[347.220376] Dynamic subtest ccs0: SUCCESS (1.975s)
[347.223434] Subtest busy-no-semaphores: SUCCESS (7.165s)
[347.317804] [085/131] (702s left) syncobj_wait (wait-any-complex)
[347.375182] Starting subtest: wait-any-complex
[347.438175] Subtest wait-any-complex: SUCCESS (0.063s)
[347.499249] [086/131] (702s left) sw_sync (sync_busy)
[347.536785] Starting subtest: sync_busy
[347.539681] Subtest sync_busy: SUCCESS (0.002s)
[347.575140] [087/131] (702s left) gem_mmap_wc (bad-object)
[347.646718] Subtest bad-object: SKIP (0.000s)
[347.691275] [088/131] (702s left) gem_exec_store (dword)
[347.757743] Starting subtest: dword
[347.760760] Starting dynamic subtest: rcs0
[347.865915] Dynamic subtest rcs0: SUCCESS (0.108s)
[347.878554] Starting dynamic subtest: bcs0
[347.911918] Dynamic subtest bcs0: SUCCESS (0.043s)
[347.921771] Starting dynamic subtest: vcs0
[347.955190] Dynamic subtest vcs0: SUCCESS (0.042s)
[347.965332] Starting dynamic subtest: vcs1
[348.000173] Dynamic subtest vcs1: SUCCESS (0.043s)
[348.010190] Starting dynamic subtest: vecs0
[348.044929] Dynamic subtest vecs0: SUCCESS (0.043s)
[348.055763] Starting dynamic subtest: ccs0
[348.091443] Dynamic subtest ccs0: SUCCESS (0.045s)
[348.094176] Subtest dword: SUCCESS (0.333s)
[348.260936] [089/131] (701s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[348.391882] Starting subtest: cursorB-vs-flipA-atomic-transitions
[348.397737] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[348.499577] [090/131] (701s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[348.602658] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[348.605428] Starting dynamic subtest: pipe-A
[348.615473] Dynamic subtest pipe-A: SKIP (0.005s)
[348.625507] Starting dynamic subtest: pipe-B
[348.635171] Dynamic subtest pipe-B: SKIP (0.016s)
[348.645797] Starting dynamic subtest: pipe-C
[348.655833] Dynamic subtest pipe-C: SKIP (0.017s)
[348.665336] Starting dynamic subtest: pipe-D
[348.675381] Dynamic subtest pipe-D: SKIP (0.016s)
[348.680542] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.055s)
[348.733425] [091/131] (701s left) api_intel_bb (intel-bb-blit-x)
[348.794351] Starting subtest: intel-bb-blit-x
[352.269677] Subtest intel-bb-blit-x: SUCCESS (3.470s)
[352.371894] [092/131] (697s left) kms_psr (fbc-pr-sprite-plane-move)
[352.472892] Starting subtest: fbc-pr-sprite-plane-move
[352.478650] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[352.531417] [093/131] (697s left) kms_psr (fbc-psr2-primary-page-flip)
[352.636709] Starting subtest: fbc-psr2-primary-page-flip
[352.639510] Starting dynamic subtest: eDP-1
[352.644553] Dynamic subtest eDP-1: SKIP (0.000s)
[352.649549] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[352.692160] [094/131] (697s left) gem_close (basic)
[352.746625] Starting subtest: basic
[352.749594] Subtest basic: SUCCESS (0.000s)
[352.835182] [095/131] (697s left) sysfs_timeslice_duration (idempotent)
[352.899282] Starting subtest: idempotent
[352.901728] Starting dynamic subtest: vecs0
[352.904101] Dynamic subtest vecs0: SUCCESS (0.000s)
[352.913807] Starting dynamic subtest: ccs0
[352.916637] Dynamic subtest ccs0: SUCCESS (0.000s)
[352.925887] Starting dynamic subtest: vcs0
[352.928584] Dynamic subtest vcs0: SUCCESS (0.000s)
[352.937806] Starting dynamic subtest: bcs0
[352.940654] Dynamic subtest bcs0: SUCCESS (0.000s)
[352.950047] Starting dynamic subtest: rcs0
[352.952460] Dynamic subtest rcs0: SUCCESS (0.000s)
[352.961797] Starting dynamic subtest: vcs1
[352.964791] Dynamic subtest vcs1: SUCCESS (0.000s)
[352.967459] Subtest idempotent: SUCCESS (0.005s)
[352.987218] [096/131] (697s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[353.097927] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[353.102644] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[353.186267] [097/131] (697s left) gem_exec_fence (syncobj-export)
[353.642702] Starting subtest: syncobj-export
[353.648214] Subtest syncobj-export: SUCCESS (0.005s)
[354.778884] [098/131] (695s left) gem_exec_balancer (noheartbeat)
[355.037771] Starting subtest: noheartbeat
[355.043528] Subtest noheartbeat: SKIP (0.000s)
[355.120064] [099/131] (695s left) prime_vgem (coherency-gtt)
[355.190715] Starting subtest: coherency-gtt
[355.196741] Subtest coherency-gtt: SKIP (0.000s)
[355.272932] [100/131] (695s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[355.383500] Starting subtest: cursorA-vs-flipB-varying-size
[355.388620] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[355.476640] [101/131] (694s left) kms_async_flips (async-flip-with-page-flip-events-atomic)
[355.583493] Starting subtest: async-flip-with-page-flip-events-atomic
[355.956471] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs
[356.751807] Dynamic subtest pipe-A-eDP-1-4-mc-ccs: SKIP (0.792s)
[356.763930] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[356.916946] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SKIP (0.164s)
[356.927808] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc
[357.072351] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc: SKIP (0.154s)
[357.082388] Starting dynamic subtest: pipe-A-eDP-1-4
[359.241660] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.170s)
[359.254080] Starting dynamic subtest: pipe-A-eDP-1-x
[361.432480] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.188s)
[361.445883] Starting dynamic subtest: pipe-A-eDP-1-linear
[363.644918] Dynamic subtest pipe-A-eDP-1-linear: SUCCESS (2.211s)
[364.012312] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs
[364.782801] Dynamic subtest pipe-B-eDP-1-4-mc-ccs: SKIP (0.774s)
[364.792900] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[364.944573] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SKIP (0.163s)
[364.954371] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc
[365.109920] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc: SKIP (0.167s)
[365.119708] Starting dynamic subtest: pipe-B-eDP-1-4
[367.303739] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.192s)
[367.317076] Starting dynamic subtest: pipe-B-eDP-1-x
[369.503304] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.200s)
[369.515947] Starting dynamic subtest: pipe-B-eDP-1-linear
[371.724904] Dynamic subtest pipe-B-eDP-1-linear: SUCCESS (2.221s)
[372.101498] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs
[372.901320] Dynamic subtest pipe-C-eDP-1-4-mc-ccs: SKIP (0.806s)
[372.911487] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[373.066906] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SKIP (0.164s)
[373.079611] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc
[373.225187] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc: SKIP (0.156s)
[373.235530] Starting dynamic subtest: pipe-C-eDP-1-4
[375.413816] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.193s)
[375.424170] Starting dynamic subtest: pipe-C-eDP-1-x
[377.602247] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.187s)
[377.614900] Starting dynamic subtest: pipe-C-eDP-1-linear
[379.802846] Dynamic subtest pipe-C-eDP-1-linear: SUCCESS (2.200s)
[380.163375] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs
[380.929035] Dynamic subtest pipe-D-eDP-1-4-mc-ccs: SKIP (0.770s)
[380.939052] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[381.092921] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SKIP (0.165s)
[381.102407] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc
[381.260479] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc: SKIP (0.166s)
[381.271991] Starting dynamic subtest: pipe-D-eDP-1-4
[383.438803] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.181s)
[383.452489] Starting dynamic subtest: pipe-D-eDP-1-x
[385.628290] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.188s)
[385.638699] Starting dynamic subtest: pipe-D-eDP-1-linear
[387.828427] Dynamic subtest pipe-D-eDP-1-linear: SUCCESS (2.199s)
[387.831607] Subtest async-flip-with-page-flip-events-atomic: SUCCESS (32.235s)
[388.974215] [102/131] (661s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[389.031710] Starting subtest: multi-wait-for-submit-unsubmitted
[389.138427] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[389.196117] [103/131] (661s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[389.294777] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[389.299761] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[389.366301] [104/131] (661s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[389.464573] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[389.467221] Starting dynamic subtest: pipe-A-eDP-1
[389.492650] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[389.502666] Starting dynamic subtest: pipe-B-eDP-1
[389.527944] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[389.537327] Starting dynamic subtest: pipe-C-eDP-1
[389.562730] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[389.571803] Starting dynamic subtest: pipe-D-eDP-1
[389.598298] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[389.603158] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.005s)
[391.625304] [105/131] (658s left) kms_selftest (drm_format_helper)
[391.665912] Starting subtest: drm_format_helper
[391.703189] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[391.799814] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.094s)
[391.810500] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[391.943146] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.141s)
[391.953250] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[392.087797] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.143s)
[392.099086] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[392.162748] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.076s)
[392.173086] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[392.302934] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.139s)
[392.313642] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[392.457894] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.152s)
[392.467840] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[392.579783] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.123s)
[392.589885] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[392.674514] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.095s)
[392.689338] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[392.816947] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.141s)
[392.827139] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[392.950948] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.136s)
[392.963793] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[393.082808] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.128s)
[393.095160] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[393.196421] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.114s)
[393.207809] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[393.338775] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.144s)
[393.348817] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[393.420753] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.082s)
[393.430742] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[393.512194] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.088s)
[393.522066] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_build_fourcc_list
[393.621707] Dynamic subtest drm_format_helper_test-drm_test_fb_build_fourcc_list: SUCCESS (0.109s)
[393.631472] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[393.739089] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.117s)
[393.741414] Subtest drm_format_helper: SUCCESS (2.071s)
[393.880072] [106/131] (656s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[393.980720] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[393.985812] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[394.068272] [107/131] (656s left) kms_prime (basic-crc-hybrid)
[396.261072] Subtest basic-crc-hybrid: SKIP (0.000s)
[396.322843] [108/131] (654s left) sriov_basic (bind-unbind-vf)
[396.380529] Starting subtest: bind-unbind-vf
[396.383303] Starting dynamic subtest: vf-1
[396.472790] Dynamic subtest vf-1: FAIL (0.026s)
[396.483486] Starting dynamic subtest: vf-2
[396.572936] Dynamic subtest vf-2: FAIL (0.004s)
[396.584125] Starting dynamic subtest: vf-3
[396.671735] Dynamic subtest vf-3: FAIL (0.003s)
[396.682703] Starting dynamic subtest: vf-4
[396.769633] Dynamic subtest vf-4: FAIL (0.003s)
[396.780380] Starting dynamic subtest: vf-5
[396.872020] Dynamic subtest vf-5: FAIL (0.003s)
[396.883340] Starting dynamic subtest: vf-6
[396.970910] Dynamic subtest vf-6: FAIL (0.003s)
[396.981221] Starting dynamic subtest: vf-7
[397.071506] Dynamic subtest vf-7: FAIL (0.003s)
[397.086444] Starting dynamic subtest: vf-random
[397.174650] Dynamic subtest vf-random: FAIL (0.003s)
[397.185244] Starting dynamic subtest: vf-last
[397.273369] Dynamic subtest vf-last: FAIL (0.614s)
[397.275880] Subtest bind-unbind-vf: FAIL (0.670s)
[397.294322] [109/131] (653s left) gem_userptr_blits (process-exit-busy)
[397.358076] Starting subtest: process-exit-busy
[397.373506] Subtest process-exit-busy: SUCCESS (0.015s)
[397.503373] [110/131] (653s left) gem_eio (in-flight-contexts-1us)
[397.739987] Starting subtest: in-flight-contexts-1us
[411.749573] Subtest in-flight-contexts-1us: SUCCESS (14.003s)
[411.921185] [111/131] (638s left) kms_psr (psr-sprite-mmap-gtt)
[412.022673] Starting subtest: psr-sprite-mmap-gtt
[412.025379] Starting dynamic subtest: eDP-1
[413.475086] Dynamic subtest eDP-1: SKIP (1.447s)
[413.480898] Subtest psr-sprite-mmap-gtt: SKIP (1.448s)
[413.601278] [112/131] (636s left) syncobj_timeline (wait-all-delayed-signal)
[413.664558] Starting subtest: wait-all-delayed-signal
[413.767191] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[413.825314] [113/131] (636s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[413.922589] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[413.925143] Starting dynamic subtest: pipe-A-eDP-1
[413.986502] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[413.995786] Starting dynamic subtest: pipe-B-eDP-1
[414.056103] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[414.065747] Starting dynamic subtest: pipe-C-eDP-1
[414.125924] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[414.135595] Starting dynamic subtest: pipe-D-eDP-1
[414.197261] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[414.202420] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.009s)
[416.120207] [114/131] (634s left) gem_userptr_blits (dmabuf-unsync)
[416.191705] Subtest dmabuf-unsync: SKIP (0.000s)
[416.318451] [115/131] (634s left) prime_mmap (test_correct)
[416.377452] Starting subtest: test_correct
[416.380075] Starting dynamic subtest: test_correct-smem
[416.411982] Dynamic subtest test_correct-smem: SUCCESS (0.035s)
[416.414819] Subtest test_correct: SUCCESS (0.036s)
[416.498998] [116/131] (634s left) kms_chamelium_frames (vga-frame-dump)
[416.887339] Subtest vga-frame-dump: SKIP (0.000s)
[417.721205] [117/131] (632s left) gen7_exec_parse (cmd-crossing-page)
[417.787802] Subtest cmd-crossing-page: SKIP (0.000s)
[417.826994] [118/131] (632s left) syncobj_wait (invalid-signal-one-illegal-handle)
[417.877089] Starting subtest: invalid-signal-one-illegal-handle
[417.879499] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[417.973444] [119/131] (632s left) gem_exec_whisper (basic-queues)
[418.041560] Starting subtest: basic-queues
[424.266602] Subtest basic-queues: SUCCESS (6.222s)
[424.435467] [120/131] (626s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[424.539735] Starting subtest: fbc-dirtyfb-ioctl
[424.542682] Starting dynamic subtest: A-eDP-1
[426.093906] Dynamic subtest A-eDP-1: SUCCESS (1.550s)
[426.096846] Subtest fbc-dirtyfb-ioctl: SUCCESS (1.552s)
[426.867012] [121/131] (623s left) i915_pm_rpm (reg-read-ioctl)
[428.894497] Starting subtest: reg-read-ioctl
[431.202877] Subtest reg-read-ioctl: SUCCESS (2.308s)
[431.551296] [122/131] (619s left) kms_flip (2x-plain-flip-fb-recreate)
[431.643402] Starting subtest: 2x-plain-flip-fb-recreate
[431.657745] Subtest 2x-plain-flip-fb-recreate: SKIP (0.013s)
[431.757504] [123/131] (619s left) kms_pm_dc (dc3co-vpb-simulation)
[432.859538] Starting subtest: dc3co-vpb-simulation
[442.292363] Subtest dc3co-vpb-simulation: SKIP (9.433s)
[442.421334] [124/131] (608s left) gem_mmap_gtt (cpuset-big-copy-odd)
[442.492517] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[442.536174] [125/131] (608s left) gem_exec_schedule (pi-distinct-iova)
[442.738749] Starting subtest: pi-distinct-iova
[442.741039] Starting dynamic subtest: rcs0
[442.813794] Dynamic subtest rcs0: SUCCESS (0.076s)
[442.826582] Starting dynamic subtest: vcs0
[442.861723] Dynamic subtest vcs0: SUCCESS (0.048s)
[442.871708] Starting dynamic subtest: vcs1
[442.919232] Dynamic subtest vcs1: SUCCESS (0.057s)
[442.932572] Starting dynamic subtest: vecs0
[442.976030] Dynamic subtest vecs0: SUCCESS (0.056s)
[442.985500] Starting dynamic subtest: ccs0
[443.038823] Dynamic subtest ccs0: SUCCESS (0.062s)
[443.041824] Subtest pi-distinct-iova: SUCCESS (0.302s)
[444.846292] [126/131] (606s left) kms_force_connector_basic (prune-stale-modes)
[444.929107] Starting subtest: prune-stale-modes
[445.177378] Subtest prune-stale-modes: SKIP (0.245s)
[445.317616] [127/131] (605s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[445.422654] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[445.425420] Starting dynamic subtest: pipe-A-default-mode
[445.720657] Dynamic subtest pipe-A-default-mode: SKIP (0.293s)
[445.725819] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.295s)
[446.553902] [128/131] (604s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[446.665919] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[446.679187] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s)
[446.735144] [129/131] (604s left) gem_ctx_shared (q-in-order)
[446.809439] Starting subtest: Q-in-order
[446.812078] Starting dynamic subtest: rcs0
[446.913189] Dynamic subtest rcs0: SUCCESS (0.103s)
[446.931044] Starting dynamic subtest: vcs0
[446.994805] Dynamic subtest vcs0: SUCCESS (0.081s)
[447.012800] Starting dynamic subtest: vcs1
[447.070906] Dynamic subtest vcs1: SUCCESS (0.074s)
[447.089067] Starting dynamic subtest: vecs0
[447.155450] Dynamic subtest vecs0: SUCCESS (0.085s)
[447.171908] Starting dynamic subtest: ccs0
[447.252479] Dynamic subtest ccs0: SUCCESS (0.096s)
[447.255311] Subtest Q-in-order: SUCCESS (0.444s)
[448.805562] [130/131] (602s left) kms_psr (pr-basic)
[448.897751] Starting subtest: pr-basic
[448.903845] Subtest pr-basic: SKIP (0.000s)
[448.954238] [131/131] (602s left) gem_ctx_persistence (engines-cleanup)
[449.018786] Starting subtest: engines-cleanup
[449.021531] Starting dynamic subtest: rcs0
[449.096274] Dynamic subtest rcs0: SUCCESS (0.076s)
[449.114584] Starting dynamic subtest: bcs0
[449.163199] Dynamic subtest bcs0: SUCCESS (0.065s)
[449.175771] Starting dynamic subtest: vcs0
[449.229204] Dynamic subtest vcs0: SUCCESS (0.064s)
[449.245756] Starting dynamic subtest: vcs1
[449.261830] Dynamic subtest vcs1: SUCCESS (0.031s)
[449.271783] Starting dynamic subtest: vecs0
[449.376040] Dynamic subtest vecs0: SUCCESS (0.113s)
[449.388782] Starting dynamic subtest: ccs0
[449.440086] Dynamic subtest ccs0: SUCCESS (0.062s)
[449.442778] Subtest engines-cleanup: SUCCESS (0.422s)
[449.498245] Closing watchdogs
Done.