[57.518621] Initializing watchdogs
[57.518666]   /dev/watchdog0
[57.532071] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.536238] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.538896] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.542351] [001/133] (960s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[57.671432] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[57.675874] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[57.732754] [002/133] (960s left) syncobj_timeline (single-wait-signaled)
[57.790683] Starting subtest: single-wait-signaled
[57.793073] Subtest single-wait-signaled: SUCCESS (0.000s)
[57.875315] [003/133] (960s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[57.975295] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[58.976421] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.002s)
[59.086370] [004/133] (959s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[59.141560] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[59.250346] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.108s)
[59.323620] [005/133] (958s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[59.419515] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[59.423801] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[59.524731] [006/133] (958s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[59.614204] Starting subtest: fbc-pr-cursor-mmap-cpu
[59.618578] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[59.679681] [007/133] (958s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[59.779596] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[66.338921] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.565s)
[66.461301] [008/133] (951s left) kms_sequence (get-forked-busy)
[66.555757] Starting subtest: get-forked-busy
[66.558180] Starting dynamic subtest: pipe-A-eDP-1
[68.487580] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.933s)
[68.497617] Starting dynamic subtest: pipe-B-eDP-1
[71.086816] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.601s)
[71.093767] Starting dynamic subtest: pipe-C-eDP-1
[73.695520] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.608s)
[73.704900] Starting dynamic subtest: pipe-D-eDP-1
[76.317419] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.621s)
[76.319835] Subtest get-forked-busy: SUCCESS (9.766s)
[77.102457] [009/133] (941s left) i915_drm_fdinfo (memory-info-purgeable)
[77.149347] Starting subtest: memory-info-purgeable
[77.151773] Starting dynamic subtest: smem0
[79.987460] Dynamic subtest smem0: SUCCESS (2.839s)
[79.989579] Subtest memory-info-purgeable: SUCCESS (2.839s)
[80.058450] [010/133] (938s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[80.120207] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[80.122274] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[80.223212] [011/133] (938s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[80.330901] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[80.334549] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[80.410770] [012/133] (938s left) gem_lmem_swapping (verify-ccs)
[80.454596] Subtest verify-ccs: SKIP (0.000s)
[80.491835] [013/133] (938s left) perf_pmu (busy-idle-check-all)
[80.531107] Starting subtest: busy-idle-check-all
[80.533120] Starting dynamic subtest: rcs0
[81.197268] Dynamic subtest rcs0: SUCCESS (0.666s)
[81.206276] Starting dynamic subtest: bcs0
[81.846559] Dynamic subtest bcs0: SUCCESS (0.649s)
[81.857228] Starting dynamic subtest: vcs0
[83.925604] Dynamic subtest vcs0: SUCCESS (2.076s)
[83.935663] Starting dynamic subtest: vcs1
[85.910066] Dynamic subtest vcs1: SUCCESS (1.984s)
[85.920705] Starting dynamic subtest: vecs0
[87.893508] Dynamic subtest vecs0: SUCCESS (1.983s)
[87.903592] Starting dynamic subtest: ccs0
[88.549308] Dynamic subtest ccs0: SUCCESS (0.656s)
[88.551850] Subtest busy-idle-check-all: SUCCESS (8.020s)
[88.653686] [014/133] (929s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[88.767231] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[88.771502] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[88.852748] [015/133] (929s left) gem_exec_flush (basic-wb-ro-default)
[88.927606] Starting subtest: basic-wb-ro-default
[94.376415] Subtest basic-wb-ro-default: SUCCESS (5.451s)
[94.554464] [016/133] (924s left) kms_psr (psr2-sprite-plane-move)
[94.642409] Starting subtest: psr2-sprite-plane-move
[94.644634] Starting dynamic subtest: eDP-1
[96.424853] Dynamic subtest eDP-1: SUCCESS (1.781s)
[96.427254] Subtest psr2-sprite-plane-move: SUCCESS (1.782s)
[97.261333] [017/133] (921s left) syncobj_eventfd (binary-wait-signaled)
[97.314752] Starting subtest: binary-wait-signaled
[97.316676] Subtest binary-wait-signaled: SUCCESS (0.000s)
[97.409971] [018/133] (921s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[97.499301] Starting subtest: fbc-psr2-sprite-plane-onoff
[97.501575] Starting dynamic subtest: eDP-1
[97.506120] Dynamic subtest eDP-1: SKIP (0.000s)
[97.510642] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.000s)
[97.567168] [019/133] (921s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[97.669905] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[97.674212] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[97.779825] [020/133] (920s left) kms_flip (2x-flip-vs-panning-interruptible)
[97.869068] Starting subtest: 2x-flip-vs-panning-interruptible
[97.880263] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.010s)
[97.953875] [021/133] (920s left) gem_pxp (reject-modify-context-protection-on)
[98.075707] Starting subtest: reject-modify-context-protection-on
[98.078485] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[98.178720] [022/133] (920s left) kms_chamelium_frames (dp-frame-dump)
[98.568328] Subtest dp-frame-dump: SKIP (0.000s)
[99.366115] [023/133] (919s left) syncobj_basic (bad-pad-handle-to-fd)
[99.455185] Starting subtest: bad-pad-handle-to-fd
[99.457562] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[99.564147] [024/133] (919s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[99.662288] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[103.684810] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (4.027s)
[104.885436] [025/133] (914s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[107.014381] Starting subtest: dpms-mode-unset-lpsp
[111.072277] Subtest dpms-mode-unset-lpsp: SUCCESS (4.058s)
[111.449924] [026/133] (907s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[111.557641] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[111.561757] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[111.643386] [027/133] (907s left) kms_addfb_basic (bad-pitch-0)
[111.697817] Starting subtest: bad-pitch-0
[111.700061] Subtest bad-pitch-0: SUCCESS (0.000s)
[111.832884] [028/133] (907s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[111.928252] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[111.932184] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[112.012269] [029/133] (907s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[112.121586] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[112.125630] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[112.213278] [030/133] (906s left) gem_mmap_gtt (basic-wc)
[112.271610] Subtest basic-wc: SKIP (0.000s)
[112.336657] [031/133] (906s left) kms_async_flips (test-cursor)
[112.431806] Starting subtest: test-cursor
[112.435227] Subtest test-cursor: SKIP (0.000s)
[113.652306] [032/133] (905s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[113.749259] Starting subtest: 2x-flip-vs-modeset-vs-hang
[113.757421] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.010s)
[113.832795] [033/133] (905s left) gem_exec_schedule (u-semaphore-user)
[113.897174] Starting subtest: u-semaphore-user
[113.950051] Subtest u-semaphore-user: SUCCESS (0.058s)
[115.960417] [034/133] (903s left) kms_big_fb (x-tiled-addfb-size-overflow)
[116.076278] Starting subtest: x-tiled-addfb-size-overflow
[116.078536] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[116.166430] [035/133] (903s left) kms_vblank (wait-forked-hang)
[116.249496] Starting subtest: wait-forked-hang
[116.251673] Starting dynamic subtest: pipe-A-eDP-1
[142.686323] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.431s)
[142.699913] Starting dynamic subtest: pipe-D-eDP-1
[168.663080] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.969s)
[168.665230] Subtest wait-forked-hang: SUCCESS (52.405s)
[169.513687] [036/133] (849s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[169.609062] Starting subtest: psr-shrfb-scaledprimary
[175.415110] Subtest psr-shrfb-scaledprimary: SUCCESS (5.810s)
[175.527412] [037/133] (843s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[175.578885] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[175.581257] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[175.670312] [038/133] (843s left) perf (blocking-parameterized)
[175.806812] Starting subtest: blocking-parameterized
[195.829680] Subtest blocking-parameterized: SUCCESS (20.021s)
[195.880641] [039/133] (823s left) kms_addfb_basic (bad-pitch-256)
[195.946405] Starting subtest: bad-pitch-256
[195.948419] Subtest bad-pitch-256: SUCCESS (0.000s)
[196.096229] [040/133] (823s left) gem_eio (in-flight-contexts-1us)
[196.289430] Starting subtest: in-flight-contexts-1us
[207.929545] Subtest in-flight-contexts-1us: SUCCESS (11.641s)
[208.057202] [041/133] (811s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[208.161744] Starting subtest: fbc-rgb565-draw-mmap-wc
[212.150922] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (3.994s)
[213.340980] [042/133] (806s left) kms_draw_crc (draw-method-pwrite)
[213.429188] Starting subtest: draw-method-pwrite
[213.431149] Starting dynamic subtest: xrgb8888-untiled
[213.971748] Dynamic subtest xrgb8888-untiled: SUCCESS (0.544s)
[213.988618] Starting dynamic subtest: rgb565-untiled
[214.415416] Dynamic subtest rgb565-untiled: SUCCESS (0.444s)
[214.424292] Starting dynamic subtest: xrgb2101010-untiled
[214.960155] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.544s)
[214.969373] Starting dynamic subtest: xbgr16161616f-untiled
[215.726514] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.765s)
[215.736099] Starting dynamic subtest: xrgb8888-xtiled
[217.515502] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.788s)
[217.524785] Starting dynamic subtest: rgb565-xtiled
[218.593592] Dynamic subtest rgb565-xtiled: SUCCESS (1.077s)
[218.601792] Starting dynamic subtest: xrgb2101010-xtiled
[220.326721] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.732s)
[220.336175] Starting dynamic subtest: xbgr16161616f-xtiled
[223.538084] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.211s)
[223.546772] Starting dynamic subtest: xrgb8888-4tiled
[224.649826] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.110s)
[224.660746] Starting dynamic subtest: rgb565-4tiled
[225.193488] Dynamic subtest rgb565-4tiled: SUCCESS (0.543s)
[225.201765] Starting dynamic subtest: xrgb2101010-4tiled
[226.260319] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.066s)
[226.270667] Starting dynamic subtest: xbgr16161616f-4tiled
[229.183642] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.922s)
[229.186294] Subtest draw-method-pwrite: SUCCESS (15.757s)
[229.274760] [043/133] (790s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[229.396608] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[229.401294] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[229.541551] [044/133] (790s left) gem_pipe_control_store_loop (fresh-buffer)
[229.595132] Starting subtest: fresh-buffer
[231.747882] Subtest fresh-buffer: SUCCESS (2.151s)
[231.881037] [045/133] (787s left) syncobj_basic (test-valid-cycle)
[231.946234] Starting subtest: test-valid-cycle
[231.948364] Subtest test-valid-cycle: SUCCESS (0.000s)
[232.059591] [046/133] (787s left) kms_flip (basic-flip-vs-wf_vblank)
[232.144257] Starting subtest: basic-flip-vs-wf_vblank
[232.146582] Starting dynamic subtest: A-eDP1
[234.084424] Dynamic subtest A-eDP1: SUCCESS (1.939s)
[234.096560] Starting dynamic subtest: B-eDP1
[236.017444] Dynamic subtest B-eDP1: SUCCESS (1.931s)
[236.026322] Starting dynamic subtest: C-eDP1
[237.942969] Dynamic subtest C-eDP1: SUCCESS (1.923s)
[237.952025] Starting dynamic subtest: D-eDP1
[239.879105] Dynamic subtest D-eDP1: SUCCESS (1.934s)
[239.881549] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.738s)
[241.105293] [047/133] (778s left) gem_mmap_wc (bad-object)
[241.162844] Subtest bad-object: SKIP (0.000s)
[241.217397] [048/133] (778s left) kms_atomic_interruptible (universal-setplane-cursor)
[241.315171] Starting subtest: universal-setplane-cursor
[241.317444] Starting dynamic subtest: pipe-A-eDP-1
[248.724285] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.409s)
[248.726687] Subtest universal-setplane-cursor: SUCCESS (7.411s)
[249.558953] [049/133] (770s left) prime_self_import (reimport-vs-gem_close-race)
[249.595078] Starting subtest: reimport-vs-gem_close-race
[254.689163] Subtest reimport-vs-gem_close-race: SUCCESS (5.093s)
[254.775705] [050/133] (765s left) sw_sync (timeline_closed)
[254.819829] Starting subtest: timeline_closed
[254.822085] Subtest timeline_closed: SUCCESS (0.000s)
[254.873252] [051/133] (765s left) kms_psr (pr-primary-blt)
[254.969064] Starting subtest: pr-primary-blt
[254.973192] Subtest pr-primary-blt: SKIP (0.000s)
[255.037684] [052/133] (764s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[255.130019] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[255.134186] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[255.197059] [053/133] (764s left) syncobj_wait (invalid-signal-zero-handles)
[255.244179] Starting subtest: invalid-signal-zero-handles
[255.246085] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[255.336134] [054/133] (764s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[255.442668] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[259.444368] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.004s)
[260.554192] [055/133] (759s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[260.656761] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[261.771816] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.115s)
[261.896227] [056/133] (758s left) gen7_exec_parse (basic-rejected)
[261.951896] Subtest basic-rejected: SKIP (0.000s)
[262.031605] [057/133] (758s left) prime_mmap (test_userptr)
[262.088859] Starting subtest: test_userptr
[262.091025] Starting dynamic subtest: test_userptr-smem
[262.092981] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[262.094937] Subtest test_userptr: SUCCESS (0.001s)
[262.184999] [058/133] (758s left) i915_pm_rc6_residency (media-rc6-accuracy)
[262.242713] Starting subtest: media-rc6-accuracy
[262.246928] Subtest media-rc6-accuracy: SKIP (0.000s)
[262.351204] [059/133] (757s left) gem_softpin (allocator-fork)
[262.421314] Starting subtest: allocator-fork
[264.633225] Subtest allocator-fork: SUCCESS (2.213s)
[264.779985] [060/133] (755s left) gem_busy (busy)
[264.829046] Starting subtest: busy
[264.831253] Starting dynamic subtest: all-engines
[264.877807] Dynamic subtest all-engines: SUCCESS (0.051s)
[264.886849] Starting dynamic subtest: rcs0
[266.845630] Dynamic subtest rcs0: SUCCESS (1.967s)
[266.857438] Starting dynamic subtest: bcs0
[266.903470] Dynamic subtest bcs0: SUCCESS (0.056s)
[266.913217] Starting dynamic subtest: vcs0
[266.942894] Dynamic subtest vcs0: SUCCESS (0.039s)
[266.950997] Starting dynamic subtest: vcs1
[268.891390] Dynamic subtest vcs1: SUCCESS (1.945s)
[268.900828] Starting dynamic subtest: vecs0
[270.939178] Dynamic subtest vecs0: SUCCESS (2.045s)
[270.949718] Starting dynamic subtest: ccs0
[272.924519] Dynamic subtest ccs0: SUCCESS (1.984s)
[272.926901] Subtest busy: SUCCESS (8.095s)
[273.275494] [061/133] (747s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[273.369881] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[273.372238] Starting dynamic subtest: pipe-A-eDP-1
[273.428165] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[273.435776] Starting dynamic subtest: pipe-B-eDP-1
[273.491900] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[273.501574] Starting dynamic subtest: pipe-C-eDP-1
[273.558161] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[273.567284] Starting dynamic subtest: pipe-D-eDP-1
[273.623045] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[273.627067] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.008s)
[275.616346] [062/133] (744s left) drm_read (short-buffer-block)
[275.749667] Starting subtest: short-buffer-block
[275.752083] Subtest short-buffer-block: SUCCESS (0.000s)
[275.860466] [063/133] (744s left) kms_getfb (getfb-handle-not-fb)
[275.970084] Starting subtest: getfb-handle-not-fb
[275.972380] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[276.073784] [064/133] (744s left) kms_pm_rpm (modeset-lpsp-stress)
[278.092083] Starting subtest: modeset-lpsp-stress
[294.238098] Subtest modeset-lpsp-stress: SUCCESS (16.148s)
[294.337892] [065/133] (726s left) i915_drm_fdinfo (virtual-busy-idle-all)
[294.384891] Starting subtest: virtual-busy-idle-all
[294.389332] Subtest virtual-busy-idle-all: SKIP (0.000s)
[294.454881] [066/133] (726s left) gem_workarounds (basic-read)
[294.511254] Starting subtest: basic-read
[294.534041] Subtest basic-read: SUCCESS (0.023s)
[294.647878] [067/133] (725s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[294.788805] Starting subtest: dp-mst-type-0-suspend-resume
[294.793257] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[294.924554] [068/133] (725s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[295.014091] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[295.018573] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s)
[295.100670] [069/133] (725s left) kms_prop_blob (invalid-set-prop)
[295.161384] Starting subtest: invalid-set-prop
[295.163633] Subtest invalid-set-prop: SUCCESS (0.000s)
[295.260400] [070/133] (725s left) kms_hdr (static-toggle-dpms)
[295.347070] Starting subtest: static-toggle-dpms
[295.352184] Subtest static-toggle-dpms: SKIP (0.000s)
[295.426174] [071/133] (725s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[295.533478] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[295.535427] Starting dynamic subtest: pipe-A-eDP-1
[295.553905] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[295.563934] Starting dynamic subtest: pipe-B-eDP-1
[295.581613] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[295.589393] Starting dynamic subtest: pipe-C-eDP-1
[295.606924] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[295.614536] Starting dynamic subtest: pipe-D-eDP-1
[295.632400] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[295.635764] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[297.769203] [072/133] (723s left) prime_vgem (shrink)
[297.916060] Starting subtest: shrink
[297.928415] Subtest shrink: SUCCESS (0.013s)
[298.032513] [FACT prime_vgem (shrink)] new: kernel.kmod_is_loaded.vgem: true
[298.036000] [073/133] (722s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[298.101095] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[298.168866] [074/133] (722s left) gem_create (busy-create)
[298.228877] Starting subtest: busy-create
[298.231199] Starting dynamic subtest: smem0
[330.913942] Dynamic subtest smem0: SUCCESS (32.683s)
[330.916392] Subtest busy-create: SUCCESS (32.685s)
[331.120700] [075/133] (689s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[331.242702] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[331.247020] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[331.332254] [076/133] (689s left) gem_exec_whisper (basic-contexts-forked)
[331.396884] Starting subtest: basic-contexts-forked
[356.359567] Subtest basic-contexts-forked: SUCCESS (24.961s)
[356.558463] [077/133] (664s left) gem_ctx_persistence (many-contexts)
[356.632110] Starting subtest: many-contexts
[394.334076] Subtest many-contexts: SUCCESS (37.701s)
[394.425977] [078/133] (626s left) gem_softpin (evict-active)
[394.491349] Starting subtest: evict-active
[394.500298] Subtest evict-active: SUCCESS (0.009s)
[394.626598] [079/133] (626s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[394.744138] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[403.405858] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.664s)
[403.518536] [080/133] (617s left) kms_plane (plane-panning-top-left)
[403.610295] Starting subtest: plane-panning-top-left
[403.612529] Starting dynamic subtest: pipe-A
[405.326911] Dynamic subtest pipe-A: SUCCESS (1.714s)
[405.336557] Starting dynamic subtest: pipe-B
[407.694657] Dynamic subtest pipe-B: SUCCESS (2.367s)
[407.696834] Subtest plane-panning-top-left: SUCCESS (4.083s)
[408.502294] [081/133] (612s left) gem_exec_schedule (preempt-contexts)
[408.577241] Starting subtest: preempt-contexts
[408.579191] Starting dynamic subtest: rcs0
[408.622864] Dynamic subtest rcs0: SUCCESS (0.054s)
[408.636741] Starting dynamic subtest: bcs0
[408.684569] Dynamic subtest bcs0: SUCCESS (0.061s)
[408.699279] Starting dynamic subtest: vcs0
[408.742521] Dynamic subtest vcs0: SUCCESS (0.056s)
[408.752107] Starting dynamic subtest: vcs1
[408.786626] Dynamic subtest vcs1: SUCCESS (0.043s)
[408.795663] Starting dynamic subtest: vecs0
[408.830036] Dynamic subtest vecs0: SUCCESS (0.043s)
[408.838759] Starting dynamic subtest: ccs0
[408.883574] Dynamic subtest ccs0: SUCCESS (0.053s)
[408.885886] Subtest preempt-contexts: SUCCESS (0.315s)
[409.990395] [082/133] (611s left) gem_exec_fence (syncobj-repeat)
[410.462996] Starting subtest: syncobj-repeat
[410.641656] Subtest syncobj-repeat: SUCCESS (0.177s)
[412.014771] [083/133] (609s left) gem_exec_reloc (basic-gtt-cpu)
[412.071998] Subtest basic-gtt-cpu: SKIP (0.000s)
[412.161849] [084/133] (609s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[412.220726] Starting subtest: rel-constants-invalid-rel-gen5
[412.223682] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[412.337060] [085/133] (609s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[412.432993] Starting subtest: plane-upscale-20x20-with-modifiers
[412.435658] Starting dynamic subtest: pipe-A
[412.770354] Dynamic subtest pipe-A: SUCCESS (0.337s)
[412.778925] Starting dynamic subtest: pipe-B
[414.188399] Dynamic subtest pipe-B: SUCCESS (1.417s)
[414.198259] Starting dynamic subtest: pipe-C
[415.621670] Dynamic subtest pipe-C: SUCCESS (1.433s)
[415.631586] Starting dynamic subtest: pipe-D
[417.064176] Dynamic subtest pipe-D: SUCCESS (1.442s)
[417.066411] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.632s)
[418.233867] [086/133] (603s left) gem_exec_fence (syncobj-timeline-unused-fence)
[418.747880] Starting subtest: syncobj-timeline-unused-fence
[418.754332] Subtest syncobj-timeline-unused-fence: SUCCESS (0.008s)
[420.022827] [087/133] (601s left) gem_ctx_param (invalid-get-no-zeromap)
[420.070951] Starting subtest: invalid-get-no-zeromap
[420.073440] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[420.166950] [088/133] (601s left) kms_cursor_edge_walk (256x256-right-edge)
[420.261892] Starting subtest: 256x256-right-edge
[420.264047] Starting dynamic subtest: pipe-A-eDP-1
[423.725674] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.461s)
[423.735263] Starting dynamic subtest: pipe-D-eDP-1
[426.910376] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.184s)
[426.912336] Subtest 256x256-right-edge: SUCCESS (6.648s)
[427.720260] [089/133] (593s left) core_auth (getclient-simple)
[427.762150] Starting subtest: getclient-simple
[427.783582] Subtest getclient-simple: SUCCESS (0.022s)
[427.890557] [090/133] (593s left) gem_exec_balancer (parallel-keep-in-fence)
[428.133592] Starting subtest: parallel-keep-in-fence
[429.355480] Subtest parallel-keep-in-fence: SUCCESS (1.222s)
[429.458245] [091/133] (592s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[429.547092] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[429.549325] Starting dynamic subtest: pipe-A-eDP-1
[429.571693] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[429.582176] Starting dynamic subtest: pipe-B-eDP-1
[429.603451] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[429.611748] Starting dynamic subtest: pipe-C-eDP-1
[429.633223] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[429.641548] Starting dynamic subtest: pipe-D-eDP-1
[429.663110] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[429.667428] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[431.783163] [092/133] (589s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[431.879879] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[431.884328] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[431.968581] [093/133] (589s left) sw_sync (sync_busy_fork)
[432.000830] Starting subtest: sync_busy_fork
[433.011336] Subtest sync_busy_fork: SUCCESS (1.011s)
[433.104921] [094/133] (588s left) kms_chamelium_color (ctm-max)
[433.194175] Subtest ctm-max: SKIP (0.000s)
[433.237028] [095/133] (588s left) kms_flip (2x-plain-flip-fb-recreate)
[433.339318] Starting subtest: 2x-plain-flip-fb-recreate
[433.349880] Subtest 2x-plain-flip-fb-recreate: SKIP (0.010s)
[433.428063] [096/133] (588s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[433.522925] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[440.384998] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.864s)
[440.541364] [097/133] (581s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[440.644388] Starting subtest: 4-tiled-64bpp-rotate-180
[442.323814] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.679s)
[442.485821] [098/133] (579s left) kms_lease (lease-unleased-connector)
[442.586311] Starting subtest: lease-unleased-connector
[442.588142] Starting dynamic subtest: pipe-A-eDP-1
[442.592392] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[442.601451] Starting dynamic subtest: pipe-B-eDP-1
[442.603207] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s)
[442.612170] Starting dynamic subtest: pipe-C-eDP-1
[442.613943] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[442.622483] Starting dynamic subtest: pipe-D-eDP-1
[442.624256] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.006s)
[442.625953] Subtest lease-unleased-connector: SUCCESS (0.030s)
[442.731368] [099/133] (579s left) sw_sync (sync_multi_consumer_producer)
[442.768484] Starting subtest: sync_multi_consumer_producer
[443.082736] Subtest sync_multi_consumer_producer: SUCCESS (0.314s)
[443.145136] [100/133] (578s left) kms_cursor_crc (cursor-offscreen-64x64)
[443.352437] Starting subtest: cursor-offscreen-64x64
[443.357447] Starting dynamic subtest: pipe-A-eDP-1
[445.297029] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.941s)
[445.325300] Starting dynamic subtest: pipe-D-eDP-1
[447.902684] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.582s)
[447.904934] Subtest cursor-offscreen-64x64: SUCCESS (4.548s)
[448.761497] [101/133] (573s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[448.862198] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[448.864335] Starting dynamic subtest: pipe-A-eDP-1
[448.886757] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[448.896987] Starting dynamic subtest: pipe-B-eDP-1
[448.918254] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[448.926715] Starting dynamic subtest: pipe-C-eDP-1
[448.949069] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[448.958755] Starting dynamic subtest: pipe-D-eDP-1
[448.979646] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[448.983871] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[451.027773] [102/133] (571s left) gem_mmap_gtt (flink-race)
[451.090124] Subtest flink-race: SKIP (0.000s)
[451.143388] [103/133] (570s left) kms_addfb_basic (legacy-format)
[451.199446] Starting subtest: legacy-format
[451.228973] Subtest legacy-format: SUCCESS (0.025s)
[451.374636] [104/133] (570s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[451.467960] Starting subtest: invalidate-primary-flip-overlay
[462.302118] Subtest invalidate-primary-flip-overlay: SUCCESS (10.835s)
[462.410931] [105/133] (559s left) gem_wait (busy)
[462.479684] Starting subtest: busy
[462.481311] Starting dynamic subtest: all-engines
[463.894395] Dynamic subtest all-engines: SUCCESS (1.414s)
[463.906541] Starting dynamic subtest: rcs0
[464.434394] Dynamic subtest rcs0: SUCCESS (0.539s)
[464.445943] Starting dynamic subtest: bcs0
[464.973962] Dynamic subtest bcs0: SUCCESS (0.539s)
[464.985282] Starting dynamic subtest: vcs0
[466.901194] Dynamic subtest vcs0: SUCCESS (1.925s)
[466.913210] Starting dynamic subtest: vcs1
[468.885540] Dynamic subtest vcs1: SUCCESS (1.982s)
[468.898068] Starting dynamic subtest: vecs0
[470.932833] Dynamic subtest vecs0: SUCCESS (2.044s)
[470.944744] Starting dynamic subtest: ccs0
[471.474259] Dynamic subtest ccs0: SUCCESS (0.541s)
[471.476768] Subtest busy: SUCCESS (8.997s)
[471.684138] [106/133] (550s left) api_intel_allocator (reloc-allocator)
[471.736981] Starting subtest: reloc-allocator
[471.739748] Starting dynamic subtest: basic
[471.741944] Dynamic subtest basic: SUCCESS (0.004s)
[471.753200] Starting dynamic subtest: parallel-one
[471.755355] Dynamic subtest parallel-one: SUCCESS (0.007s)
[471.764332] Starting dynamic subtest: print
[471.766155] Dynamic subtest print: SUCCESS (0.000s)
[471.774432] Starting dynamic subtest: reuse
[471.776316] Dynamic subtest reuse: SUCCESS (0.000s)
[471.784249] Starting dynamic subtest: fork-reopen-allocator
[471.786097] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s)
[471.787936] Subtest reloc-allocator: SUCCESS (0.025s)
[471.896312] [107/133] (550s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[472.011388] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[472.015585] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[472.109220] [108/133] (550s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[472.201100] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[472.203329] Starting dynamic subtest: pipe-A-default-mode
[473.385682] Dynamic subtest pipe-A-default-mode: SKIP (1.183s)
[473.389612] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.185s)
[473.531241] [109/133] (548s left) i915_query (hwconfig_table)
[473.592512] Starting subtest: hwconfig_table
[473.878196] Subtest hwconfig_table: SUCCESS (0.001s)
[473.918282] [110/133] (548s left) vgem_basic (bad-flag)
[473.975373] Starting subtest: bad-flag
[473.977610] Subtest bad-flag: SUCCESS (0.000s)
[474.031240] [111/133] (548s left) kms_flip (wf_vblank-ts-check)
[474.121502] Starting subtest: wf_vblank-ts-check
[474.123308] Starting dynamic subtest: A-eDP1
[483.005944] Dynamic subtest A-eDP1: SUCCESS (8.883s)
[483.019054] Starting dynamic subtest: B-eDP1
[491.939687] Dynamic subtest B-eDP1: SUCCESS (8.933s)
[491.950339] Starting dynamic subtest: C-eDP1
[500.856894] Dynamic subtest C-eDP1: SUCCESS (8.913s)
[500.869020] Starting dynamic subtest: D-eDP1
[509.793438] Dynamic subtest D-eDP1: SUCCESS (8.936s)
[509.798751] Subtest wf_vblank-ts-check: SUCCESS (35.675s)
[511.018896] [112/133] (511s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[511.124679] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[511.128717] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[511.243121] [113/133] (511s left) kms_plane_multiple (tiling-none)
[511.328103] Starting subtest: tiling-none
[511.330425] Starting dynamic subtest: pipe-A-eDP-1
[514.949092] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.619s)
[514.958570] Starting dynamic subtest: pipe-B-eDP-1
[519.280343] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.330s)
[519.290719] Starting dynamic subtest: pipe-C-eDP-1
[523.586484] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.305s)
[523.596560] Starting dynamic subtest: pipe-D-eDP-1
[527.961787] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.376s)
[527.964249] Subtest tiling-none: SUCCESS (16.634s)
[528.786407] [114/133] (493s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[528.872373] Starting subtest: basic-max-pipe-crc-check
[528.877044] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[528.926528] [115/133] (493s left) gem_exec_alignment (many)
[528.983464] Starting subtest: many
[551.353258] Subtest many: SUCCESS (22.366s)
[553.939529] [116/133] (468s left) kms_cursor_legacy (forked-bo)
[554.097518] Starting subtest: forked-bo
[554.099471] Starting dynamic subtest: pipe-A
[559.549146] Dynamic subtest pipe-A: SUCCESS (5.449s)
[559.562704] Starting dynamic subtest: pipe-B
[565.022073] Dynamic subtest pipe-B: SUCCESS (5.470s)
[565.033771] Starting dynamic subtest: pipe-C
[570.504851] Dynamic subtest pipe-C: SUCCESS (5.480s)
[570.516497] Starting dynamic subtest: pipe-D
[575.978662] Dynamic subtest pipe-D: SUCCESS (5.471s)
[575.990970] Starting dynamic subtest: all-pipes
[581.487977] Dynamic subtest all-pipes: SUCCESS (5.506s)
[581.490598] Subtest forked-bo: SUCCESS (27.387s)
[581.637855] [117/133] (441s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[581.722789] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[581.800343] [118/133] (440s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[581.917729] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[586.573958] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.660s)
[587.702072] [119/133] (435s left) kms_rotation_crc (exhaust-fences)
[587.808406] Starting subtest: exhaust-fences
[587.812752] Subtest exhaust-fences: SKIP (0.000s)
[587.895423] [120/133] (434s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[588.001578] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[588.006046] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[588.107827] [121/133] (434s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[588.206641] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[595.272194] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.068s)
[595.371977] [122/133] (427s left) gem_ringfill (legacy-basic)
[600.858963] Starting subtest: legacy-basic
[600.861863] Starting dynamic subtest: default
[600.943716] Dynamic subtest default: SUCCESS (0.084s)
[600.965116] Starting dynamic subtest: render
[600.989084] Dynamic subtest render: SUCCESS (0.043s)
[601.012170] Starting dynamic subtest: bsd
[601.035991] Dynamic subtest bsd: SUCCESS (0.043s)
[601.047179] Starting dynamic subtest: bsd1
[601.076608] Dynamic subtest bsd1: SUCCESS (0.038s)
[601.087586] Starting dynamic subtest: bsd2
[601.118813] Dynamic subtest bsd2: SUCCESS (0.040s)
[601.127552] Starting dynamic subtest: blt
[601.166506] Dynamic subtest blt: SUCCESS (0.045s)
[601.182961] Starting dynamic subtest: vebox
[601.211265] Dynamic subtest vebox: SUCCESS (0.042s)
[601.213752] Subtest legacy-basic: SUCCESS (0.355s)
[601.289981] [123/133] (421s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[601.390374] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[601.394706] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[601.489554] [124/133] (421s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[601.822950] Starting subtest: cursor-rapid-movement-max-size
[601.829448] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[601.955085] [125/133] (421s left) core_getversion (all-cards)
[601.996287] Starting subtest: all-cards
[602.009691] Subtest all-cards: SUCCESS (0.020s)
[602.048513] [126/133] (420s left) gem_exec_reloc (basic-write-gtt)
[602.110867] Subtest basic-write-gtt: SKIP (0.000s)
[602.169822] [127/133] (420s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[602.544789] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[603.341851] [128/133] (419s left) kms_psr (fbc-pr-suspend)
[603.434067] Starting subtest: fbc-pr-suspend
[603.438360] Subtest fbc-pr-suspend: SKIP (0.000s)
[603.537705] [129/133] (419s left) kms_color_pipeline (plane-ctm3x4)
[603.631023] Starting subtest: plane-ctm3x4
[603.754988] Starting dynamic subtest: pipe-A-plane-0
[604.068704] Dynamic subtest pipe-A-plane-0: FAIL (0.148s)
[604.079603] Starting dynamic subtest: pipe-A-plane-1
[604.289016] Dynamic subtest pipe-A-plane-1: FAIL (0.136s)
[604.299645] Starting dynamic subtest: pipe-A-plane-2
[604.501992] Dynamic subtest pipe-A-plane-2: FAIL (0.144s)
[605.351947] Starting dynamic subtest: pipe-B-plane-0
[605.730076] Dynamic subtest pipe-B-plane-0: FAIL (0.119s)
[605.741502] Starting dynamic subtest: pipe-B-plane-1
[606.042329] Dynamic subtest pipe-B-plane-1: FAIL (0.145s)
[606.053615] Starting dynamic subtest: pipe-B-plane-2
[606.350950] Dynamic subtest pipe-B-plane-2: FAIL (0.145s)
[607.380026] Starting dynamic subtest: pipe-C-plane-0
[607.820708] Dynamic subtest pipe-C-plane-0: FAIL (0.107s)
[607.831455] Starting dynamic subtest: pipe-C-plane-1
[608.218809] Dynamic subtest pipe-C-plane-1: FAIL (0.133s)
[608.230420] Starting dynamic subtest: pipe-C-plane-2
[608.577483] Dynamic subtest pipe-C-plane-2: FAIL (0.601s)
[609.416546] Starting dynamic subtest: pipe-D-plane-0
[609.957449] Dynamic subtest pipe-D-plane-0: FAIL (0.117s)
[609.967550] Starting dynamic subtest: pipe-D-plane-1
[610.413140] Dynamic subtest pipe-D-plane-1: FAIL (0.569s)
[610.424085] Starting dynamic subtest: pipe-D-plane-2
[610.843650] Dynamic subtest pipe-D-plane-2: FAIL (0.538s)
[610.931221] Subtest plane-ctm3x4: FAIL (7.301s)
[611.792773] [130/133] (411s left) gem_lmem_swapping (heavy-verify-random-ccs)
[611.833982] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[611.879164] [131/133] (411s left) gem_exec_balancer (bonded-true-hang)
[612.143271] Starting subtest: bonded-true-hang
[612.148239] Subtest bonded-true-hang: SKIP (0.000s)
[612.228210] [132/133] (411s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[612.328439] Starting subtest: y-tiled-16bpp-rotate-270
[612.332891] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[612.437627] [133/133] (410s left) gem_exec_nop (basic-series)
[612.517856] Starting subtest: basic-series
[627.928802] Subtest basic-series: SUCCESS (15.417s)
[628.134860] Closing watchdogs
results: parsing output: 0/ for test: kms_psr2_sf
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_psr
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_sequence
results: parsing output: 8/ for test: i915_drm_fdinfo
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_lmem_swapping
results: parsing output: 12/ for test: perf_pmu
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_exec_flush
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: syncobj_eventfd
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: gem_pxp
results: parsing output: 21/ for test: kms_chamelium_frames
results: parsing output: 22/ for test: syncobj_basic
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_pm_rpm
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_addfb_basic
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: gem_mmap_gtt
results: parsing output: 30/ for test: kms_async_flips
results: parsing output: 31/ for test: kms_flip
results: parsing output: 32/ for test: gem_exec_schedule
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: kms_vblank
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: perf
results: parsing output: 38/ for test: kms_addfb_basic
results: parsing output: 39/ for test: gem_eio
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_draw_crc
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: gem_pipe_control_store_loop
results: parsing output: 44/ for test: syncobj_basic
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: gem_mmap_wc
results: parsing output: 47/ for test: kms_atomic_interruptible
results: parsing output: 48/ for test: prime_self_import
results: parsing output: 49/ for test: sw_sync
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: kms_flip_scaled_crc
results: parsing output: 52/ for test: syncobj_wait
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: gen7_exec_parse
results: parsing output: 56/ for test: prime_mmap
results: parsing output: 57/ for test: i915_pm_rc6_residency
results: parsing output: 58/ for test: gem_softpin
results: parsing output: 59/ for test: gem_busy
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: drm_read
results: parsing output: 62/ for test: kms_getfb
results: parsing output: 63/ for test: kms_pm_rpm
results: parsing output: 64/ for test: i915_drm_fdinfo
results: parsing output: 65/ for test: gem_workarounds
results: parsing output: 66/ for test: kms_content_protection
results: parsing output: 67/ for test: kms_plane
results: parsing output: 68/ for test: kms_prop_blob
results: parsing output: 69/ for test: kms_hdr
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: prime_vgem
results: parsing output: 72/ for test: gem_exec_reloc
results: parsing output: 73/ for test: gem_create
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_exec_whisper
results: parsing output: 76/ for test: gem_ctx_persistence
results: parsing output: 77/ for test: gem_softpin
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_plane
results: parsing output: 80/ for test: gem_exec_schedule
results: parsing output: 81/ for test: gem_exec_fence
results: parsing output: 82/ for test: gem_exec_reloc
results: parsing output: 83/ for test: gem_exec_params
results: parsing output: 84/ for test: kms_plane_scaling
results: parsing output: 85/ for test: gem_exec_fence
results: parsing output: 86/ for test: gem_ctx_param
results: parsing output: 87/ for test: kms_cursor_edge_walk
results: parsing output: 88/ for test: core_auth
results: parsing output: 89/ for test: gem_exec_balancer
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: sw_sync
results: parsing output: 93/ for test: kms_chamelium_color
results: parsing output: 94/ for test: kms_flip
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: kms_lease
results: parsing output: 98/ for test: sw_sync
results: parsing output: 99/ for test: kms_cursor_crc
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: gem_mmap_gtt
results: parsing output: 102/ for test: kms_addfb_basic
results: parsing output: 103/ for test: kms_psr_stress_test
results: parsing output: 104/ for test: gem_wait
results: parsing output: 105/ for test: api_intel_allocator
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_flip_scaled_crc
results: parsing output: 108/ for test: i915_query
results: parsing output: 109/ for test: vgem_basic
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_plane_multiple
results: parsing output: 113/ for test: kms_multipipe_modeset
results: parsing output: 114/ for test: gem_exec_alignment
results: parsing output: 115/ for test: kms_cursor_legacy
results: parsing output: 116/ for test: gem_exec_reloc
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_rotation_crc
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_ringfill
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_cursor_crc
results: parsing output: 124/ for test: core_getversion
results: parsing output: 125/ for test: gem_exec_reloc
results: parsing output: 126/ for test: kms_chamelium_hpd
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_color_pipeline
results: parsing output: 129/ for test: gem_lmem_swapping
results: parsing output: 130/ for test: gem_exec_balancer
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: gem_exec_nop
Done.