[122.203063] Initializing watchdogs
[122.203111]   /dev/watchdog0
[122.218146] [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]
[122.222575] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[122.224893] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[122.228333] [001/155] (960s left) kms_flip (2x-plain-flip-ts-check)
[122.358140] Starting subtest: 2x-plain-flip-ts-check
[122.366975] Subtest 2x-plain-flip-ts-check: SKIP (0.011s)
[122.455535] [002/155] (960s left) gem_exec_balancer (bonded-true-hang)
[122.730852] Starting subtest: bonded-true-hang
[122.735548] Subtest bonded-true-hang: SKIP (0.000s)
[122.859266] [003/155] (959s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[122.951389] Starting subtest: 4-tiled-8bpp-rotate-90
[122.990693] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.039s)
[123.116897] [004/155] (959s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[123.207843] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[123.210086] Starting dynamic subtest: pipe-A-eDP-1
[123.269419] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[123.276727] Starting dynamic subtest: pipe-B-eDP-1
[123.334474] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[123.343367] Starting dynamic subtest: pipe-C-eDP-1
[123.401852] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[123.410187] Starting dynamic subtest: pipe-D-eDP-1
[123.468479] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[123.473102] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[125.472760] [005/155] (957s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[125.564228] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[125.568557] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[125.630708] [006/155] (957s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[125.722830] Starting subtest: compare-crc-sanitycheck-xr24
[125.725242] Starting dynamic subtest: pipe-A-eDP-1
[126.329414] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.605s)
[126.338301] Starting dynamic subtest: pipe-B-eDP-1
[127.616730] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.288s)
[127.626589] Starting dynamic subtest: pipe-C-eDP-1
[128.793615] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.175s)
[128.801963] Starting dynamic subtest: pipe-D-eDP-1
[130.026374] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.233s)
[130.028688] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.305s)
[130.879866] [007/155] (952s left) gem_bad_reloc (negative-reloc-lut)
[130.933876] Subtest negative-reloc-lut: SKIP (0.000s)
[131.002643] [008/155] (951s left) gem_exec_parallel (engines)
[131.060998] Starting subtest: engines
[131.063341] Starting dynamic subtest: basic
[133.253338] Dynamic subtest basic: SUCCESS (2.190s)
[133.262741] Starting dynamic subtest: contexts
[137.581036] Dynamic subtest contexts: SUCCESS (4.326s)
[137.592012] Starting dynamic subtest: fds
[141.416760] Dynamic subtest fds: SUCCESS (3.835s)
[141.427304] Starting dynamic subtest: userptr
[143.300240] Dynamic subtest userptr: SUCCESS (1.883s)
[143.302948] Subtest engines: SUCCESS (12.238s)
[143.491037] [009/155] (939s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[143.601051] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[143.605637] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[143.717035] [010/155] (939s left) gem_lmem_swapping (parallel-random-verify)
[143.754886] Subtest parallel-random-verify: SKIP (0.000s)
[143.804953] [011/155] (939s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[143.903531] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[143.905904] Starting dynamic subtest: pipe-A-default-mode
[145.038514] Dynamic subtest pipe-A-default-mode: SKIP (1.133s)
[145.042483] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.134s)
[145.191685] [012/155] (937s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[145.278844] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[145.280641] Starting dynamic subtest: pipe-A-eDP-1
[146.141465] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.856s)
[146.150125] Starting dynamic subtest: pipe-B-eDP-1
[147.768045] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.623s)
[147.777773] Starting dynamic subtest: pipe-C-eDP-1
[149.233273] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.466s)
[149.243332] Starting dynamic subtest: pipe-D-eDP-1
[150.812691] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.577s)
[150.815123] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.526s)
[151.971254] [013/155] (931s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[152.068952] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[152.073206] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[152.164731] [014/155] (931s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[152.537132] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[153.383049] [015/155] (929s left) gem_tiled_pread_pwrite
[153.508114] [016/155] (929s left) gem_exec_reloc (basic-cpu-read-active)
[153.567818] Subtest basic-cpu-read-active: SKIP (0.000s)
[153.626819] [017/155] (929s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[153.728964] Starting subtest: fb-8bpc-vs-panel-8bpc
[153.731249] Starting dynamic subtest: pipe-A-eDP-1
[155.196731] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.467s)
[155.198733] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.468s)
[156.083134] [018/155] (927s left) gem_eio (execbuf)
[156.315529] Starting subtest: execbuf
[156.660347] Subtest execbuf: SUCCESS (0.344s)
[156.803835] [019/155] (926s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[156.907834] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[157.588951] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.683s)
[157.782153] [020/155] (925s left) kms_sequence (get-forked)
[157.876062] Starting subtest: get-forked
[157.878072] Starting dynamic subtest: pipe-A-eDP-1
[159.754947] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.879s)
[159.765784] Starting dynamic subtest: pipe-B-eDP-1
[162.320902] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.564s)
[162.333280] Starting dynamic subtest: pipe-C-eDP-1
[164.825035] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.503s)
[164.835055] Starting dynamic subtest: pipe-D-eDP-1
[167.362492] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.537s)
[167.364388] Subtest get-forked: SUCCESS (9.486s)
[168.191242] [021/155] (915s left) i915_pm_rps (thresholds-idle)
[168.248811] Starting subtest: thresholds-idle
[168.253432] Subtest thresholds-idle: SKIP (0.001s)
[168.355335] [022/155] (915s left) gem_mmap_wc (read-write-distinct)
[168.411066] Subtest read-write-distinct: SKIP (0.000s)
[168.460415] [023/155] (915s left) kms_vblank (ts-continuation-idle)
[168.555080] Starting subtest: ts-continuation-idle
[168.556931] Starting dynamic subtest: pipe-A-eDP-1
[168.954073] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.400s)
[168.967406] Starting dynamic subtest: pipe-D-eDP-1
[170.081083] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.122s)
[170.083063] Subtest ts-continuation-idle: SUCCESS (1.525s)
[170.962922] [024/155] (912s left) gem_sync (basic-all)
[171.038317] Starting subtest: basic-all
[174.275900] Subtest basic-all: SUCCESS (3.246s)
[174.476334] [025/155] (909s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[174.578398] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[179.360811] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.788s)
[180.578758] [026/155] (903s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[180.635726] Starting subtest: saturated-hostile-nopreempt
[180.638033] Starting dynamic subtest: rcs0
[180.689911] Dynamic subtest rcs0: SKIP (0.051s)
[180.700086] Starting dynamic subtest: bcs0
[180.742944] Dynamic subtest bcs0: SKIP (0.053s)
[180.753585] Starting dynamic subtest: vcs0
[180.761181] Dynamic subtest vcs0: SKIP (0.017s)
[180.769188] Starting dynamic subtest: vcs1
[180.778082] Dynamic subtest vcs1: SKIP (0.016s)
[180.786204] Starting dynamic subtest: vecs0
[180.795276] Dynamic subtest vecs0: SKIP (0.016s)
[180.803337] Starting dynamic subtest: ccs0
[180.811133] Dynamic subtest ccs0: SKIP (0.015s)
[180.815366] Subtest saturated-hostile-nopreempt: SKIP (0.173s)
[180.885847] [027/155] (902s left) sw_sync (sync_busy_fork_unixsocket)
[180.919579] Starting subtest: sync_busy_fork_unixsocket
[180.924721] Subtest sync_busy_fork_unixsocket: SUCCESS (0.006s)
[180.971766] [028/155] (902s left) gem_exec_schedule (thriceslice)
[181.033710] Starting subtest: thriceslice
[181.035611] Starting dynamic subtest: rcs0
[181.081913] Dynamic subtest rcs0: SUCCESS (0.057s)
[181.095417] Starting dynamic subtest: bcs0
[181.135117] Dynamic subtest bcs0: SUCCESS (0.052s)
[181.147531] Starting dynamic subtest: vcs0
[181.186776] Dynamic subtest vcs0: SUCCESS (0.050s)
[181.197446] Starting dynamic subtest: vcs1
[181.241091] Dynamic subtest vcs1: SUCCESS (0.052s)
[181.252412] Starting dynamic subtest: vecs0
[181.270904] Dynamic subtest vecs0: SUCCESS (0.029s)
[181.279709] Starting dynamic subtest: ccs0
[181.301727] Dynamic subtest ccs0: SUCCESS (0.030s)
[181.304055] Subtest thriceslice: SUCCESS (0.278s)
[182.313044] [029/155] (901s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-indfb-plflip-blt)
[182.415470] Starting subtest: fbchdr-2p-primscrn-indfb-plflip-blt
[182.420030] Subtest fbchdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[182.512071] [030/155] (901s left) gem_exec_fence (nb-await)
[182.691423] Starting subtest: nb-await
[182.693597] Starting dynamic subtest: rcs0
[182.759494] Dynamic subtest rcs0: SUCCESS (0.067s)
[182.770674] Starting dynamic subtest: bcs0
[182.817744] Dynamic subtest bcs0: SUCCESS (0.057s)
[182.828567] Starting dynamic subtest: vcs0
[182.876697] Dynamic subtest vcs0: SUCCESS (0.058s)
[182.887051] Starting dynamic subtest: vcs1
[182.935834] Dynamic subtest vcs1: SUCCESS (0.057s)
[182.945637] Starting dynamic subtest: vecs0
[182.994849] Dynamic subtest vecs0: SUCCESS (0.058s)
[183.005972] Starting dynamic subtest: ccs0
[183.052710] Dynamic subtest ccs0: SUCCESS (0.056s)
[183.055319] Subtest nb-await: SUCCESS (0.361s)
[185.365836] [FACT gem_exec_fence (nb-await)] new: kernel.kmod_is_loaded.vgem: true
[185.368991] [031/155] (898s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[185.473042] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[185.477698] Subtest fbchdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[185.576055] [032/155] (898s left) gem_exec_basic (basic)
[185.628732] Starting subtest: basic
[185.631182] Starting dynamic subtest: rcs0-smem
[185.635652] Dynamic subtest rcs0-smem: SUCCESS (0.005s)
[185.645667] Starting dynamic subtest: bcs0-smem
[185.648107] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[185.656617] Starting dynamic subtest: vcs0-smem
[185.658494] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[185.666250] Starting dynamic subtest: vcs1-smem
[185.668135] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[185.675889] Starting dynamic subtest: vecs0-smem
[185.677809] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[185.685638] Starting dynamic subtest: ccs0-smem
[185.687540] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[185.689441] Subtest basic: SUCCESS (0.020s)
[187.305430] [033/155] (896s left) gem_eio (suspend)
[187.525321] Starting subtest: suspend
[200.532082] Subtest suspend: SUCCESS (13.005s)
[200.668672] [034/155] (883s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[200.775469] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[200.780164] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[201.951892] [035/155] (882s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[202.052285] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[208.982685] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.934s)
[209.124779] [036/155] (874s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[209.208246] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[209.212680] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[209.283044] [037/155] (874s left) kms_setmode (basic)
[209.334130] Starting subtest: basic
[209.662659] Starting dynamic subtest: pipe-A-eDP-1
[211.811193] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.145s)
[212.153971] Starting dynamic subtest: pipe-B-eDP-1
[214.247044] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.098s)
[214.560788] Subtest basic: SUCCESS (5.224s)
[215.417909] [038/155] (868s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[215.470405] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[215.472681] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[215.584805] [039/155] (868s left) kms_hdmi_inject (inject-4k)
[215.940920] Starting subtest: inject-4k
[216.289895] Subtest inject-4k: SUCCESS (0.349s)
[216.859830] [040/155] (867s left) gem_exec_whisper (basic-normal-all)
[216.916150] Starting subtest: basic-normal-all
[219.305065] Subtest basic-normal-all: SUCCESS (2.386s)
[219.487900] [041/155] (864s left) kms_cursor_crc (cursor-onscreen-128x42)
[219.721327] Starting subtest: cursor-onscreen-128x42
[219.764719] Subtest cursor-onscreen-128x42: SKIP (0.042s)
[219.999930] [042/155] (864s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[220.110896] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[220.115085] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[220.195943] [043/155] (864s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-pwrite)
[220.297190] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-pwrite
[220.301082] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[220.397473] [044/155] (864s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[220.492414] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu
[220.495973] Subtest psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[220.587406] [045/155] (863s left) kms_content_protection (dp-mst-type-1)
[220.729718] Starting subtest: dp-mst-type-1
[220.733756] Subtest dp-mst-type-1: SKIP (0.000s)
[220.860040] [046/155] (863s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[220.958708] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[220.962397] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[221.053743] [047/155] (863s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[221.144255] Starting subtest: fbcpsr-tiling-4
[228.094490] Subtest fbcpsr-tiling-4: SUCCESS (6.954s)
[228.264374] [048/155] (856s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[228.360110] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[228.362357] Starting dynamic subtest: pipe-A-eDP-1
[228.385270] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[228.395379] Starting dynamic subtest: pipe-B-eDP-1
[228.417210] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[228.426661] Starting dynamic subtest: pipe-C-eDP-1
[228.448374] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[228.457885] Starting dynamic subtest: pipe-D-eDP-1
[228.479752] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[228.483793] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[230.614992] [049/155] (854s left) kms_flip (2x-modeset-vs-vblank-race)
[230.704261] Starting subtest: 2x-modeset-vs-vblank-race
[230.716258] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[230.796853] [050/155] (853s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[230.885892] Starting subtest: plane-lut1d-ctm3x4
[231.065694] Starting dynamic subtest: pipe-A-plane-0
[231.254349] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s)
[231.265484] Starting dynamic subtest: pipe-A-plane-1
[231.443411] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s)
[231.456632] Starting dynamic subtest: pipe-A-plane-2
[231.631705] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s)
[232.809260] Starting dynamic subtest: pipe-B-plane-0
[232.997985] Dynamic subtest pipe-B-plane-0: SUCCESS (0.199s)
[233.007992] Starting dynamic subtest: pipe-B-plane-1
[233.131982] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[233.142300] Starting dynamic subtest: pipe-B-plane-2
[233.275669] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[234.522206] Starting dynamic subtest: pipe-C-plane-0
[234.647071] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[234.657256] Starting dynamic subtest: pipe-C-plane-1
[234.802664] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[234.813059] Starting dynamic subtest: pipe-C-plane-2
[234.969180] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[236.191986] Starting dynamic subtest: pipe-D-plane-0
[236.327245] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[236.337817] Starting dynamic subtest: pipe-D-plane-1
[236.460501] Dynamic subtest pipe-D-plane-1: SUCCESS (0.132s)
[236.470848] Starting dynamic subtest: pipe-D-plane-2
[236.593974] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s)
[236.886260] Subtest plane-lut1d-ctm3x4: SUCCESS (5.998s)
[237.725826] [051/155] (846s left) gem_exec_reloc (basic-wc-read)
[237.797041] Subtest basic-wc-read: SKIP (0.000s)
[237.868615] [052/155] (846s left) kms_addfb_basic (unused-modifier)
[237.919893] Starting subtest: unused-modifier
[237.921719] Subtest unused-modifier: SUCCESS (0.000s)
[238.047105] [053/155] (846s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[238.144632] Starting subtest: yf-tiled-64bpp-rotate-0
[238.149075] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[238.237641] [054/155] (846s left) kms_async_flips (crc-atomic)
[238.327034] Starting subtest: crc-atomic
[238.700321] Starting dynamic subtest: pipe-A-eDP-1
[241.640533] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.919s)
[242.002710] Starting dynamic subtest: pipe-B-eDP-1
[244.946907] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.936s)
[245.301298] Starting dynamic subtest: pipe-C-eDP-1
[248.224579] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.892s)
[248.544944] Starting dynamic subtest: pipe-D-eDP-1
[251.539678] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.973s)
[251.541995] Subtest crc-atomic: SUCCESS (13.183s)
[252.721294] [055/155] (832s left) syncobj_basic (bad-pad-fd-to-handle)
[252.777517] Starting subtest: bad-pad-fd-to-handle
[252.779930] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[252.885413] [056/155] (832s left) sriov_basic (enable-vfs-autoprobe-off)
[252.942903] Starting subtest: enable-vfs-autoprobe-off
[252.945245] Starting dynamic subtest: numvfs-1
[252.949944] Dynamic subtest numvfs-1: SKIP (0.001s)
[252.960597] Starting dynamic subtest: numvfs-2
[252.965049] Dynamic subtest numvfs-2: SKIP (0.000s)
[252.974660] Starting dynamic subtest: numvfs-3
[252.979027] Dynamic subtest numvfs-3: SKIP (0.000s)
[252.988473] Starting dynamic subtest: numvfs-4
[252.992593] Dynamic subtest numvfs-4: SKIP (0.000s)
[253.002313] Starting dynamic subtest: numvfs-5
[253.006606] Dynamic subtest numvfs-5: SKIP (0.000s)
[253.016289] Starting dynamic subtest: numvfs-6
[253.020259] Dynamic subtest numvfs-6: SKIP (0.000s)
[253.029779] Starting dynamic subtest: numvfs-7
[253.034236] Dynamic subtest numvfs-7: SKIP (0.000s)
[253.043436] Starting dynamic subtest: numvfs-random
[253.047850] Dynamic subtest numvfs-random: SKIP (0.000s)
[253.057483] Starting dynamic subtest: numvfs-all
[253.061990] Dynamic subtest numvfs-all: SKIP (0.000s)
[253.066507] Subtest enable-vfs-autoprobe-off: SKIP (0.011s)
[253.107296] [057/155] (831s left) kms_flip (modeset-vs-vblank-race-interruptible)
[253.205223] Starting subtest: modeset-vs-vblank-race-interruptible
[253.207546] Starting dynamic subtest: A-eDP1
[257.918949] Dynamic subtest A-eDP1: SUCCESS (4.713s)
[257.934755] Starting dynamic subtest: B-eDP1
[262.608880] Dynamic subtest B-eDP1: SUCCESS (4.686s)
[262.619726] Starting dynamic subtest: C-eDP1
[267.298440] Dynamic subtest C-eDP1: SUCCESS (4.687s)
[267.310293] Starting dynamic subtest: D-eDP1
[271.992050] Dynamic subtest D-eDP1: SUCCESS (4.693s)
[271.997535] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.792s)
[273.226395] [058/155] (811s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[273.330753] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[273.334899] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[273.413729] [059/155] (811s left) core_auth (many-magics)
[273.468945] Starting subtest: many-magics
[274.366613] Subtest many-magics: SUCCESS (0.900s)
[274.506512] [060/155] (810s left) kms_feature_discovery (dp-mst)
[274.590419] Starting subtest: dp-mst
[274.594179] Subtest dp-mst: SKIP (0.000s)
[274.676828] [061/155] (810s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-blt)
[274.766467] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-blt
[274.770194] Subtest psrhdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[274.880321] [062/155] (810s left) gen9_exec_parse (cmd-crossing-page)
[274.936882] Subtest cmd-crossing-page: SKIP (0.000s)
[275.007355] [063/155] (810s left) kms_psr (fbc-pr-sprite-plane-onoff)
[275.096203] Starting subtest: fbc-pr-sprite-plane-onoff
[275.099966] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[275.168666] [064/155] (810s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[275.256269] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[275.259872] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[275.362764] [065/155] (809s left) kms_setmode (invalid-clone-exclusive-crtc)
[275.414704] Starting subtest: invalid-clone-exclusive-crtc
[275.420236] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[275.524078] [066/155] (809s left) i915_drm_fdinfo (all-busy-check-all)
[275.564574] Starting subtest: all-busy-check-all
[275.570205] Subtest all-busy-check-all: SKIP (0.004s)
[275.634835] [067/155] (809s left) kms_plane_scaling (planes-upscale-factor-0-25)
[275.741065] Starting subtest: planes-upscale-factor-0-25
[275.743036] Starting dynamic subtest: pipe-A
[275.806374] Dynamic subtest pipe-A: SUCCESS (0.065s)
[275.818547] Starting dynamic subtest: pipe-B
[276.920689] Dynamic subtest pipe-B: SUCCESS (1.113s)
[276.933521] Starting dynamic subtest: pipe-C
[278.094347] Dynamic subtest pipe-C: SUCCESS (1.172s)
[278.104521] Starting dynamic subtest: pipe-D
[279.210309] Dynamic subtest pipe-D: SUCCESS (1.115s)
[279.212624] Subtest planes-upscale-factor-0-25: SUCCESS (3.470s)
[280.415660] [068/155] (804s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-render)
[280.512136] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-render
[280.516249] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[280.621139] [069/155] (804s left) gem_exec_params (no-bsd)
[280.679321] Starting subtest: no-bsd
[280.684249] Subtest no-bsd: SUCCESS (0.003s)
[282.381437] [070/155] (803s left) sw_sync (timeline_closed_signaled)
[282.414740] Starting subtest: timeline_closed_signaled
[282.416888] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[282.468142] [071/155] (803s left) gem_spin_batch (legacy-resubmit)
[282.532832] Starting subtest: legacy-resubmit
[282.534616] Starting dynamic subtest: default
[282.539183] Dynamic subtest default: SUCCESS (0.006s)
[282.549124] Starting dynamic subtest: render
[282.551420] Dynamic subtest render: SUCCESS (0.001s)
[282.560931] Starting dynamic subtest: bsd
[282.562872] Dynamic subtest bsd: SUCCESS (0.002s)
[282.571972] Starting dynamic subtest: bsd1
[282.573830] Dynamic subtest bsd1: SUCCESS (0.001s)
[282.582808] Starting dynamic subtest: bsd2
[282.584736] Dynamic subtest bsd2: SUCCESS (0.002s)
[282.593835] Starting dynamic subtest: blt
[282.595849] Dynamic subtest blt: SUCCESS (0.002s)
[282.604965] Starting dynamic subtest: vebox
[282.606903] Dynamic subtest vebox: SUCCESS (0.004s)
[282.608829] Subtest legacy-resubmit: SUCCESS (0.024s)
[282.784625] [072/155] (802s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[282.881189] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[289.551845] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.677s)
[289.685395] [073/155] (795s left) gem_ctx_param (invalid-set-ringsize)
[289.733747] Starting subtest: invalid-set-ringsize
[289.736049] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[289.795169] [074/155] (795s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[289.902247] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[289.906473] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[290.017535] [075/155] (795s left) gem_exec_schedule (preempt-contexts)
[290.078973] Starting subtest: preempt-contexts
[290.081279] Starting dynamic subtest: rcs0
[290.125315] Dynamic subtest rcs0: SUCCESS (0.054s)
[290.135164] Starting dynamic subtest: bcs0
[290.180735] Dynamic subtest bcs0: SUCCESS (0.055s)
[290.191575] Starting dynamic subtest: vcs0
[290.232913] Dynamic subtest vcs0: SUCCESS (0.052s)
[290.244387] Starting dynamic subtest: vcs1
[290.275179] Dynamic subtest vcs1: SUCCESS (0.041s)
[290.285533] Starting dynamic subtest: vecs0
[290.315807] Dynamic subtest vecs0: SUCCESS (0.041s)
[290.325879] Starting dynamic subtest: ccs0
[290.369629] Dynamic subtest ccs0: SUCCESS (0.053s)
[290.371964] Subtest preempt-contexts: SUCCESS (0.299s)
[291.416586] [076/155] (794s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[291.512103] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[291.514276] Starting dynamic subtest: pipe-A
[291.852995] Dynamic subtest pipe-A: SUCCESS (0.342s)
[291.869693] Starting dynamic subtest: pipe-B
[293.280360] Dynamic subtest pipe-B: SUCCESS (1.425s)
[293.289945] Starting dynamic subtest: pipe-C
[294.696567] Dynamic subtest pipe-C: SUCCESS (1.415s)
[294.707405] Starting dynamic subtest: pipe-D
[296.100225] Dynamic subtest pipe-D: SUCCESS (1.403s)
[296.102564] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.590s)
[297.319312] [077/155] (788s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-move)
[297.422831] Starting subtest: hdr-1p-primscrn-spr-indfb-move
[297.427119] Subtest hdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[297.535628] [078/155] (788s left) drm_read (empty-block)
[297.687442] Starting subtest: empty-block
[298.687543] Subtest empty-block: SUCCESS (1.000s)
[298.837227] [079/155] (787s left) gem_exec_reloc (basic-gtt-read)
[298.904045] Subtest basic-gtt-read: SKIP (0.000s)
[298.975044] [080/155] (786s left) gem_exec_reloc (basic-cpu-wc)
[299.034387] Subtest basic-cpu-wc: SKIP (0.000s)
[299.103894] [081/155] (786s left) kms_cursor_edge_walk (64x64-top-edge)
[299.204143] Starting subtest: 64x64-top-edge
[299.206457] Starting dynamic subtest: pipe-A-eDP-1
[302.648827] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.444s)
[302.659737] Starting dynamic subtest: pipe-D-eDP-1
[305.846275] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.196s)
[305.848550] Subtest 64x64-top-edge: SUCCESS (6.643s)
[306.723442] [082/155] (779s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[306.827572] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-gtt
[306.831773] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[306.924659] [083/155] (779s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[307.022330] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[307.026178] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[307.093070] [084/155] (778s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-blt)
[307.193883] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-blt
[307.198072] Subtest fbchdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[307.311581] [085/155] (778s left) kms_frontbuffer_tracking (fbchdr-2p-shrfb-fliptrack-mmap-gtt)
[307.407416] Starting subtest: fbchdr-2p-shrfb-fliptrack-mmap-gtt
[307.411925] Subtest fbchdr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[307.508577] [086/155] (778s left) kms_big_fb (y-tiled-addfb-size-overflow)
[307.615453] Starting subtest: y-tiled-addfb-size-overflow
[307.619985] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[307.732295] [087/155] (778s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite)
[307.843236] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite
[307.846800] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[307.936794] [088/155] (778s left) kms_cursor_crc (cursor-random-512x512)
[308.222917] Starting subtest: cursor-random-512x512
[308.226741] Subtest cursor-random-512x512: SKIP (0.001s)
[308.371044] [089/155] (777s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[308.489469] Starting subtest: protected-encrypted-src-copy-not-readible
[308.598489] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.111s)
[308.710253] [090/155] (777s left) i915_getparams_basic (basic-eu-total)
[308.767267] Starting subtest: basic-eu-total
[308.771829] Subtest basic-eu-total: SUCCESS (0.000s)
[308.855778] [091/155] (777s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[308.959275] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[308.963473] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[309.053595] [092/155] (777s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt)
[309.152871] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt
[309.157460] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[309.262150] [093/155] (777s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[309.374120] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[309.378199] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[309.468010] [094/155] (777s left) gem_mmap_gtt (pf-nonblock)
[309.522705] Subtest pf-nonblock: SKIP (0.000s)
[309.575897] [095/155] (776s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[309.625132] Starting subtest: single-wait-all-for-submit-available-submitted
[309.627132] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[309.730787] [096/155] (776s left) kms_plane_multiple (tiling-4)
[309.818822] Starting subtest: tiling-4
[309.820883] Starting dynamic subtest: pipe-A-eDP-1
[313.661694] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.840s)
[313.672190] Starting dynamic subtest: pipe-B-eDP-1
[318.258528] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.596s)
[318.269087] Starting dynamic subtest: pipe-C-eDP-1
[322.843672] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.586s)
[322.854834] Starting dynamic subtest: pipe-D-eDP-1
[327.444592] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.597s)
[327.446710] Subtest tiling-4: SUCCESS (17.625s)
[328.337079] [097/155] (758s left) kms_pm_dc (dc6-psr)
[329.453198] Starting subtest: dc6-psr
[332.326498] Subtest dc6-psr: SUCCESS (2.871s)
[333.230420] [098/155] (753s left) gem_lmem_swapping (parallel-random-verify-ccs)
[333.278441] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[333.320578] [099/155] (753s left) gem_mmap_gtt (basic-wc)
[333.374912] Subtest basic-wc: SKIP (0.000s)
[333.436447] [100/155] (753s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[333.536234] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[333.540743] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[333.640849] [101/155] (753s left) sysfs_preempt_timeout (timeout)
[333.703797] Starting subtest: timeout
[333.706160] Starting dynamic subtest: vecs0
[343.297347] Dynamic subtest vecs0: SUCCESS (9.589s)
[343.307936] Starting dynamic subtest: ccs0
[344.642194] Dynamic subtest ccs0: SUCCESS (1.345s)
[344.653399] Starting dynamic subtest: vcs0
[354.303902] Dynamic subtest vcs0: SUCCESS (9.657s)
[354.316813] Starting dynamic subtest: bcs0
[355.569308] Dynamic subtest bcs0: SUCCESS (1.263s)
[355.584460] Starting dynamic subtest: rcs0
[356.818800] Dynamic subtest rcs0: SUCCESS (1.247s)
[356.830768] Starting dynamic subtest: vcs1
[366.283069] Dynamic subtest vcs1: SUCCESS (9.466s)
[366.285965] Subtest timeout: SUCCESS (32.580s)
[366.369848] [102/155] (720s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[366.475213] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[366.479590] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[366.565237] [103/155] (720s left) syncobj_timeline (signal)
[366.624759] Starting subtest: signal
[366.627041] Subtest signal: SUCCESS (0.000s)
[366.724483] [104/155] (720s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[366.819817] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[366.823689] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[366.919254] [105/155] (720s left) kms_getfb (getfb2-handle-protection)
[367.011807] Starting subtest: getfb2-handle-protection
[367.030264] Subtest getfb2-handle-protection: SUCCESS (0.020s)
[367.151926] [106/155] (719s left) perf_pmu (busy-double-start)
[367.189193] Starting subtest: busy-double-start
[367.191455] Starting dynamic subtest: rcs0
[370.826172] Dynamic subtest rcs0: FAIL (3.579s)
[370.837673] Starting dynamic subtest: bcs0
[374.360812] Dynamic subtest bcs0: SUCCESS (3.592s)
[374.373913] Starting dynamic subtest: vcs0
[378.820035] Dynamic subtest vcs0: SUCCESS (4.457s)
[378.833186] Starting dynamic subtest: vcs1
[382.787134] Dynamic subtest vcs1: SUCCESS (3.965s)
[382.800512] Starting dynamic subtest: vecs0
[386.834771] Dynamic subtest vecs0: SUCCESS (4.045s)
[386.847746] Starting dynamic subtest: ccs0
[390.474844] Dynamic subtest ccs0: FAIL (3.566s)
[390.477232] Subtest busy-double-start: FAIL (23.215s)
[390.524047] [107/155] (696s left) kms_prime (basic-crc-vgem)
[390.612885] Starting subtest: basic-crc-vgem
[390.615255] Starting dynamic subtest: second-to-first
[391.573678] Dynamic subtest second-to-first: SUCCESS (0.965s)
[391.575539] Subtest basic-crc-vgem: SUCCESS (0.966s)
[391.669134] [108/155] (695s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-blt)
[391.761659] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-blt
[391.764977] Subtest hdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[391.855298] [109/155] (695s left) prime_vgem (fence-write-hang)
[391.936470] Subtest fence-write-hang: SKIP (0.000s)
[392.047176] [110/155] (695s left) kms_getfb (getfb-handle-not-fb)
[392.155843] Starting subtest: getfb-handle-not-fb
[392.157739] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[392.255758] [111/155] (694s left) perf_pmu (invalid-open)
[392.294690] Starting subtest: invalid-open
[392.296690] Subtest invalid-open: SUCCESS (0.000s)
[392.398171] [112/155] (694s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[392.500504] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[396.487408] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (3.992s)
[397.729434] [113/155] (689s left) kms_psr (psr2-primary-render)
[397.817257] Starting subtest: psr2-primary-render
[397.819568] Starting dynamic subtest: eDP-1
[399.575897] Dynamic subtest eDP-1: SUCCESS (1.760s)
[399.578260] Subtest psr2-primary-render: SUCCESS (1.761s)
[400.417526] [114/155] (686s left) gem_readwrite (new-obj)
[400.474182] Subtest new-obj: SKIP (0.000s)
[400.543768] [115/155] (686s left) syncobj_basic (bad-flags-handle-to-fd)
[400.602281] Starting subtest: bad-flags-handle-to-fd
[400.604483] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[400.706836] [116/155] (686s left) kms_psr (pr-cursor-blt)
[400.793265] Starting subtest: pr-cursor-blt
[400.797601] Subtest pr-cursor-blt: SKIP (0.001s)
[400.883551] [117/155] (686s left) kms_chamelium_color (ctm-limited-range)
[400.979648] Subtest ctm-limited-range: SKIP (0.000s)
[401.026980] [118/155] (686s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-blt)
[401.129349] Starting subtest: psrhdr-rgb565-draw-blt
[401.133217] Subtest psrhdr-rgb565-draw-blt: SKIP (0.000s)
[401.234120] [119/155] (686s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[401.325219] Starting subtest: nonblocking-crc-frame-sequence
[401.327041] Starting dynamic subtest: pipe-A-eDP-1
[402.055431] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.732s)
[402.066675] Starting dynamic subtest: pipe-B-eDP-1
[403.465591] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.406s)
[403.476209] Starting dynamic subtest: pipe-C-eDP-1
[404.842643] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.378s)
[404.854421] Starting dynamic subtest: pipe-D-eDP-1
[406.229847] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.384s)
[406.232221] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.905s)
[407.112890] [120/155] (680s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[407.213793] Starting subtest: primary-yf-tiled-reflect-x-270
[407.218372] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[407.283343] [121/155] (680s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[407.382215] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[407.386094] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[407.465881] [122/155] (680s left) kms_flip (flip-vs-panning)
[407.549076] Starting subtest: flip-vs-panning
[407.551441] Starting dynamic subtest: A-eDP1
[416.308458] Dynamic subtest A-eDP1: SUCCESS (8.758s)
[416.320084] Starting dynamic subtest: B-eDP1
[424.984401] Dynamic subtest B-eDP1: SUCCESS (8.675s)
[424.996519] Starting dynamic subtest: C-eDP1
[433.679545] Dynamic subtest C-eDP1: SUCCESS (8.694s)
[433.691394] Starting dynamic subtest: D-eDP1
[442.377560] Dynamic subtest D-eDP1: SUCCESS (8.696s)
[442.379741] Subtest flip-vs-panning: SUCCESS (34.832s)
[443.606924] [123/155] (644s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[443.713289] Starting subtest: psr-rgb101010-draw-mmap-wc
[450.818570] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.110s)
[450.925124] [124/155] (636s left) gem_wait (busy)
[450.979417] Starting subtest: busy
[450.981909] Starting dynamic subtest: all-engines
[452.291183] Dynamic subtest all-engines: SUCCESS (1.310s)
[452.305053] Starting dynamic subtest: rcs0
[452.832995] Dynamic subtest rcs0: SUCCESS (0.539s)
[452.846992] Starting dynamic subtest: bcs0
[453.371171] Dynamic subtest bcs0: SUCCESS (0.538s)
[453.384234] Starting dynamic subtest: vcs0
[455.300039] Dynamic subtest vcs0: SUCCESS (1.926s)
[455.313728] Starting dynamic subtest: vcs1
[457.283714] Dynamic subtest vcs1: SUCCESS (1.980s)
[457.296901] Starting dynamic subtest: vecs0
[459.331457] Dynamic subtest vecs0: SUCCESS (2.045s)
[459.343702] Starting dynamic subtest: ccs0
[459.875093] Dynamic subtest ccs0: SUCCESS (0.543s)
[459.877485] Subtest busy: SUCCESS (8.896s)
[460.075148] [125/155] (627s left) dmabuf_sync_file (export-basic)
[460.115114] Starting subtest: export-basic
[460.117442] Subtest export-basic: SUCCESS (0.003s)
[460.170982] [126/155] (627s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[460.272487] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[461.086338] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.815s)
[461.269346] [127/155] (626s left) syncobj_timeline (32bits-limit)
[461.320773] Starting subtest: 32bits-limit
[461.323179] Subtest 32bits-limit: SUCCESS (0.001s)
[461.414693] [128/155] (626s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[461.513292] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[461.517540] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[461.630185] [129/155] (626s left) syncobj_wait (invalid-wait-illegal-handle)
[461.694934] Starting subtest: invalid-wait-illegal-handle
[461.697605] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[461.795360] [130/155] (626s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[461.859045] Starting subtest: y-tiled-to-vebox-x-tiled
[461.863211] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[462.048534] [131/155] (625s left) kms_selftest (drm_dp_mst_helper)
[462.084159] Starting subtest: drm_dp_mst_helper
[462.101200] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[462.221774] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.121s)
[462.234897] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[462.337413] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.113s)
[462.347052] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[462.459141] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.121s)
[462.461094] Subtest drm_dp_mst_helper: SUCCESS (0.375s)
[462.638821] [132/155] (625s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt)
[462.741048] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt
[462.744975] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[462.840594] [133/155] (625s left) kms_flip (bo-too-big-interruptible)
[462.935102] Starting subtest: bo-too-big-interruptible
[462.937271] Starting dynamic subtest: A-eDP1
[464.228279] Dynamic subtest A-eDP1: SUCCESS (1.291s)
[464.243917] Starting dynamic subtest: B-eDP1
[465.519607] Dynamic subtest B-eDP1: SUCCESS (1.290s)
[465.530356] Starting dynamic subtest: C-eDP1
[466.816957] Dynamic subtest C-eDP1: SUCCESS (1.297s)
[466.840543] Starting dynamic subtest: D-eDP1
[468.137639] Dynamic subtest D-eDP1: SUCCESS (1.320s)
[468.140118] Subtest bo-too-big-interruptible: SUCCESS (5.205s)
[469.307626] [134/155] (618s left) i915_pm_rpm (gem-execbuf-stress)
[471.435564] Starting subtest: gem-execbuf-stress
[471.437672] Starting dynamic subtest: smem0
[484.308144] Dynamic subtest smem0: SUCCESS (12.874s)
[484.322280] Starting dynamic subtest: extra-wait-smem0
[547.183957] Dynamic subtest extra-wait-smem0: SUCCESS (62.821s)
[547.187061] Subtest gem-execbuf-stress: SUCCESS (75.701s)
[547.540596] [135/155] (540s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[547.597107] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[547.599531] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s)
[547.689447] [136/155] (540s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-shrfb-msflip-blt)
[547.793618] Starting subtest: hdr-2p-scndscrn-shrfb-msflip-blt
[547.797653] Subtest hdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[547.885150] [137/155] (540s left) gem_render_linear_blits (basic)
[547.956557] Starting subtest: basic
[547.976610] Subtest basic: SUCCESS (0.021s)
[548.063633] [138/155] (540s left) gem_ctx_create (basic-files)
[548.115842] Starting subtest: basic-files
[550.126033] Subtest basic-files: SUCCESS (2.009s)
[551.424891] [139/155] (536s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-wc)
[551.532606] Starting subtest: hdr-rgb101010-draw-mmap-wc
[551.536673] Subtest hdr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[551.635378] [140/155] (536s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[551.728087] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[551.732570] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[551.825750] [141/155] (536s left) kms_lease (empty-lease)
[551.913236] Starting subtest: empty-lease
[551.915628] Starting dynamic subtest: pipe-A-eDP-1
[551.918275] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[551.931125] Starting dynamic subtest: pipe-B-eDP-1
[551.933160] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[551.942999] Starting dynamic subtest: pipe-C-eDP-1
[551.945033] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[551.954933] Starting dynamic subtest: pipe-D-eDP-1
[551.958035] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[551.959974] Subtest empty-lease: SUCCESS (0.009s)
[552.049791] [142/155] (536s left) gem_create (create-massive)
[552.109683] Starting subtest: create-massive
[552.111625] Subtest create-massive: SUCCESS (0.000s)
[552.304994] [143/155] (536s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[552.398630] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[559.041143] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.648s)
[559.166452] [144/155] (529s left) kms_psr (pr-suspend)
[559.252692] Starting subtest: pr-suspend
[559.256735] Subtest pr-suspend: SKIP (0.000s)
[559.322792] [145/155] (529s left) api_intel_bb (lot-of-buffers)
[559.376232] Starting subtest: lot-of-buffers
[560.428951] Subtest lot-of-buffers: SUCCESS (1.054s)
[560.956600] [146/155] (527s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[561.048503] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[565.135901] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.093s)
[566.318393] [147/155] (522s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[566.416871] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[566.420848] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[566.541674] [148/155] (522s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[566.640686] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[567.753615] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.113s)
[567.873900] [149/155] (520s left) gem_pxp (create-regular-context-2)
[567.982919] Starting subtest: create-regular-context-2
[567.986436] Subtest create-regular-context-2: SUCCESS (0.002s)
[568.098768] [150/155] (520s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[568.188379] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[568.190188] Starting dynamic subtest: pipe-A-default-mode
[569.326371] Dynamic subtest pipe-A-default-mode: SKIP (1.134s)
[569.330484] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.135s)
[569.467833] [151/155] (519s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[569.563134] Starting subtest: plane-primary-overlay-mutable-zpos
[572.945765] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.381s)
[574.088425] [152/155] (514s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[574.193925] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[580.508116] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.320s)
[581.698952] [153/155] (507s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[581.790122] Starting subtest: fbc-pr-cursor-mmap-gtt
[581.794656] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[581.860720] [154/155] (507s left) kms_chamelium_edid (hdmi-edid-read)
[582.234237] Subtest hdmi-edid-read: SKIP (0.000s)
[583.077182] [155/155] (505s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-render)
[583.178695] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-render
[583.183063] Subtest fbchdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[583.281951] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: gem_exec_balancer
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: kms_psr2_sf
results: parsing output: 5/ for test: kms_pipe_crc_basic
results: parsing output: 6/ for test: gem_bad_reloc
results: parsing output: 7/ for test: gem_exec_parallel
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_lmem_swapping
results: parsing output: 10/ for test: kms_flip_scaled_crc
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_chamelium_hpd
results: parsing output: 14/ for test: gem_tiled_pread_pwrite
results: parsing output: 15/ for test: gem_exec_reloc
results: parsing output: 16/ for test: kms_dither
results: parsing output: 17/ for test: gem_eio
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_sequence
results: parsing output: 20/ for test: i915_pm_rps
results: parsing output: 21/ for test: gem_mmap_wc
results: parsing output: 22/ for test: kms_vblank
results: parsing output: 23/ for test: gem_sync
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_ctx_persistence
results: parsing output: 26/ for test: sw_sync
results: parsing output: 27/ for test: gem_exec_schedule
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_exec_fence
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_exec_basic
results: parsing output: 32/ for test: gem_eio
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_plane
results: parsing output: 36/ for test: kms_setmode
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: kms_hdmi_inject
results: parsing output: 39/ for test: gem_exec_whisper
results: parsing output: 40/ for test: kms_cursor_crc
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_content_protection
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_color_pipeline
results: parsing output: 50/ for test: gem_exec_reloc
results: parsing output: 51/ for test: kms_addfb_basic
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_async_flips
results: parsing output: 54/ for test: syncobj_basic
results: parsing output: 55/ for test: sriov_basic
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: core_auth
results: parsing output: 59/ for test: kms_feature_discovery
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gen9_exec_parse
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_setmode
results: parsing output: 65/ for test: i915_drm_fdinfo
results: parsing output: 66/ for test: kms_plane_scaling
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_exec_params
results: parsing output: 69/ for test: sw_sync
results: parsing output: 70/ for test: gem_spin_batch
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_ctx_param
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_exec_schedule
results: parsing output: 75/ for test: kms_plane_scaling
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: drm_read
results: parsing output: 78/ for test: gem_exec_reloc
results: parsing output: 79/ for test: gem_exec_reloc
results: parsing output: 80/ for test: kms_cursor_edge_walk
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_psr2_sf
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_cursor_crc
results: parsing output: 88/ for test: gem_pxp
results: parsing output: 89/ for test: i915_getparams_basic
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_mmap_gtt
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: kms_plane_multiple
results: parsing output: 96/ for test: kms_pm_dc
results: parsing output: 97/ for test: gem_lmem_swapping
results: parsing output: 98/ for test: gem_mmap_gtt
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: sysfs_preempt_timeout
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_getfb
results: parsing output: 105/ for test: perf_pmu
results: parsing output: 106/ for test: kms_prime
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: prime_vgem
results: parsing output: 109/ for test: kms_getfb
results: parsing output: 110/ for test: perf_pmu
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: gem_readwrite
results: parsing output: 114/ for test: syncobj_basic
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: kms_chamelium_color
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_pipe_crc_basic
results: parsing output: 119/ for test: kms_rotation_crc
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_flip
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_wait
results: parsing output: 124/ for test: dmabuf_sync_file
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: gem_render_copy
results: parsing output: 130/ for test: kms_selftest
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_flip
results: parsing output: 133/ for test: i915_pm_rpm
results: parsing output: 134/ for test: syncobj_timeline
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: gem_render_linear_blits
results: parsing output: 137/ for test: gem_ctx_create
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: kms_lease
results: parsing output: 141/ for test: gem_create
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: kms_psr
results: parsing output: 144/ for test: api_intel_bb
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: kms_big_fb
results: parsing output: 148/ for test: gem_pxp
results: parsing output: 149/ for test: kms_flip_scaled_crc
results: parsing output: 150/ for test: kms_atomic
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: kms_psr
results: parsing output: 153/ for test: kms_chamelium_edid
results: parsing output: 154/ for test: kms_frontbuffer_tracking
Done.