[57.913313] Initializing watchdogs
[57.913358]   /dev/watchdog0
[57.926990] [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.931487] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.933732] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.937122] [001/132] (960s left) kms_cursor_crc (cursor-random-32x10)
[58.117376] Starting subtest: cursor-random-32x10
[58.164995] Subtest cursor-random-32x10: SKIP (0.045s)
[58.421565] [002/132] (960s left) gem_exec_gttfill (multigpu-basic)
[58.601402] Starting subtest: multigpu-basic
[73.992202] Subtest multigpu-basic: SUCCESS (15.415s)
[74.041889] [003/132] (944s left) gem_exec_balancer (smoke)
[74.139702] Starting subtest: smoke
[96.689815] Subtest smoke: SUCCESS (22.549s)
[97.743377] [004/132] (920s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[97.850874] Starting subtest: fb-8bpc-vs-panel-6bpc
[97.853243] Starting dynamic subtest: pipe-A-eDP-1
[99.203273] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.352s)
[99.205456] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.352s)
[99.997818] [005/132] (918s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[100.085638] Starting subtest: 2x-flip-vs-modeset-vs-hang
[100.096832] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.010s)
[100.170329] [006/132] (918s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[100.255077] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[100.265796] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.010s)
[100.335493] [007/132] (918s left) gem_exec_fence (parallel)
[100.514740] Starting subtest: parallel
[100.517082] Starting dynamic subtest: rcs0
[102.663067] Dynamic subtest rcs0: SUCCESS (2.149s)
[102.672930] Starting dynamic subtest: bcs0
[104.812898] Dynamic subtest bcs0: SUCCESS (2.150s)
[104.823074] Starting dynamic subtest: vcs0
[106.963445] Dynamic subtest vcs0: SUCCESS (2.150s)
[106.972246] Starting dynamic subtest: vcs1
[109.114640] Dynamic subtest vcs1: SUCCESS (2.151s)
[109.126178] Starting dynamic subtest: vecs0
[111.268122] Dynamic subtest vecs0: SUCCESS (2.153s)
[111.278238] Starting dynamic subtest: ccs0
[113.417096] Dynamic subtest ccs0: SUCCESS (2.148s)
[113.419065] Subtest parallel: SUCCESS (12.903s)
[114.034555] [FACT gem_exec_fence (parallel)] new: kernel.kmod_is_loaded.vgem: true
[114.038013] [008/132] (904s left) kms_async_flips (crc)
[114.135608] Starting subtest: crc
[114.515604] Starting dynamic subtest: pipe-A-eDP-1
[117.405947] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.891s)
[117.783171] Starting dynamic subtest: pipe-B-eDP-1
[120.736536] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.962s)
[121.124837] Starting dynamic subtest: pipe-C-eDP-1
[124.051581] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.939s)
[124.412360] Starting dynamic subtest: pipe-D-eDP-1
[127.267312] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.863s)
[127.269924] Subtest crc: SUCCESS (13.133s)
[128.430540] [009/132] (890s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[128.496077] Starting subtest: multi-wait-all-for-submit-available-submitted
[128.500850] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.003s)
[128.610266] [010/132] (890s left) gem_ctx_isolation (clean)
[128.682732] Starting subtest: clean
[128.685278] Starting dynamic subtest: rcs0
[128.720574] Dynamic subtest rcs0: SUCCESS (0.038s)
[128.730156] Starting dynamic subtest: bcs0
[128.778838] Dynamic subtest bcs0: SUCCESS (0.058s)
[128.788143] Starting dynamic subtest: vcs0
[128.813935] Dynamic subtest vcs0: SUCCESS (0.035s)
[128.822352] Starting dynamic subtest: vcs1
[129.949147] Dynamic subtest vcs1: SUCCESS (1.135s)
[129.959225] Starting dynamic subtest: vecs0
[131.860892] Dynamic subtest vecs0: SUCCESS (1.911s)
[131.870971] Starting dynamic subtest: ccs0
[133.913419] Dynamic subtest ccs0: SUCCESS (2.052s)
[133.915904] Subtest clean: SUCCESS (5.231s)
[134.150434] [011/132] (884s left) kms_getfb (getfb2-handle-zero)
[134.246804] Starting subtest: getfb2-handle-zero
[134.249154] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[134.365311] [012/132] (884s left) gem_exec_store (cachelines)
[134.427645] Starting subtest: cachelines
[134.429796] Starting dynamic subtest: rcs0
[134.491601] Dynamic subtest rcs0: SUCCESS (0.064s)
[134.501811] Starting dynamic subtest: bcs0
[134.542666] Dynamic subtest bcs0: SUCCESS (0.050s)
[134.552536] Starting dynamic subtest: vcs0
[134.592261] Dynamic subtest vcs0: SUCCESS (0.049s)
[134.601279] Starting dynamic subtest: vcs1
[134.644801] Dynamic subtest vcs1: SUCCESS (0.052s)
[134.654467] Starting dynamic subtest: vecs0
[134.693823] Dynamic subtest vecs0: SUCCESS (0.049s)
[134.703461] Starting dynamic subtest: ccs0
[134.748537] Dynamic subtest ccs0: SUCCESS (0.054s)
[134.750999] Subtest cachelines: SUCCESS (0.321s)
[134.942150] [013/132] (883s left) gem_exec_schedule (submit-late-slice)
[135.024627] Starting subtest: submit-late-slice
[135.026691] Starting dynamic subtest: rcs0
[135.058071] Dynamic subtest rcs0: SUCCESS (0.036s)
[135.066389] Starting dynamic subtest: bcs0
[135.093445] Dynamic subtest bcs0: SUCCESS (0.035s)
[135.101760] Starting dynamic subtest: vcs0
[135.127719] Dynamic subtest vcs0: SUCCESS (0.034s)
[135.136343] Starting dynamic subtest: vcs1
[135.161845] Dynamic subtest vcs1: SUCCESS (0.034s)
[135.170643] Starting dynamic subtest: vecs0
[135.189711] Dynamic subtest vecs0: SUCCESS (0.028s)
[135.197153] Starting dynamic subtest: ccs0
[135.222827] Dynamic subtest ccs0: SUCCESS (0.032s)
[135.225790] Subtest submit-late-slice: SUCCESS (0.201s)
[137.000838] [014/132] (881s left) syncobj_wait (single-wait-all-signaled)
[137.056720] Starting subtest: single-wait-all-signaled
[137.058935] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[137.189905] [015/132] (881s left) kms_pm_rpm (dpms-lpsp)
[139.056147] Starting subtest: dpms-lpsp
[139.411937] Subtest dpms-lpsp: SUCCESS (0.358s)
[139.498407] [016/132] (879s left) gem_eio (in-flight-contexts-immediate)
[139.727863] Starting subtest: in-flight-contexts-immediate
[150.961630] Subtest in-flight-contexts-immediate: SUCCESS (11.232s)
[151.119967] [017/132] (867s left) gem_partial_pwrite_pread (writes-after-reads-display)
[151.171107] Subtest writes-after-reads-display: SKIP (0.000s)
[151.235534] [018/132] (867s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[151.344816] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[151.349064] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[151.442291] [019/132] (867s left) perf_pmu (enable-race)
[151.486599] Starting subtest: enable-race
[151.488809] Starting dynamic subtest: rcs0
[164.256769] Dynamic subtest rcs0: SUCCESS (12.769s)
[164.265741] Starting dynamic subtest: bcs0
[176.997749] Dynamic subtest bcs0: SUCCESS (12.739s)
[177.007119] Starting dynamic subtest: vcs0
[192.917486] Dynamic subtest vcs0: SUCCESS (15.916s)
[192.930540] Starting dynamic subtest: vcs1
[208.855389] Dynamic subtest vcs1: SUCCESS (15.935s)
[208.864192] Starting dynamic subtest: vecs0
[224.853583] Dynamic subtest vecs0: SUCCESS (15.998s)
[224.862689] Starting dynamic subtest: ccs0
[237.599315] Dynamic subtest ccs0: SUCCESS (12.746s)
[237.602232] Subtest enable-race: SUCCESS (86.110s)
[237.701705] [020/132] (781s left) i915_query (query-topology-garbage-items)
[237.759717] Starting subtest: query-topology-garbage-items
[237.761897] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[237.857676] [021/132] (781s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[237.964780] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[237.967219] Starting dynamic subtest: pipe-A-eDP-1
[237.990143] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[238.000415] Starting dynamic subtest: pipe-B-eDP-1
[238.021550] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[238.029230] Starting dynamic subtest: pipe-C-eDP-1
[238.050283] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[238.057813] Starting dynamic subtest: pipe-D-eDP-1
[238.079433] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[238.083775] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[240.230119] [022/132] (779s left) gem_exec_schedule (pi-ringfull)
[240.423696] Starting subtest: pi-ringfull
[240.426128] Starting dynamic subtest: rcs0
[240.457591] Dynamic subtest rcs0: SUCCESS (0.036s)
[240.466740] Starting dynamic subtest: bcs0
[240.494868] Dynamic subtest bcs0: SUCCESS (0.037s)
[240.507486] Starting dynamic subtest: vcs0
[240.526856] Dynamic subtest vcs0: SUCCESS (0.032s)
[240.539263] Starting dynamic subtest: vcs1
[240.557662] Dynamic subtest vcs1: SUCCESS (0.030s)
[240.569610] Starting dynamic subtest: vecs0
[240.586497] Dynamic subtest vecs0: SUCCESS (0.028s)
[240.597445] Starting dynamic subtest: ccs0
[240.613471] Dynamic subtest ccs0: SUCCESS (0.027s)
[240.615645] Subtest pi-ringfull: SUCCESS (0.192s)
[240.867895] [023/132] (778s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[240.963159] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[247.656329] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.697s)
[247.792665] [024/132] (771s left) kms_cursor_crc (cursor-offscreen-128x42)
[248.033560] Starting subtest: cursor-offscreen-128x42
[248.079454] Subtest cursor-offscreen-128x42: SKIP (0.040s)
[248.285271] [025/132] (771s left) kms_dp_link_training (uhbr-sst)
[248.380972] Starting subtest: uhbr-sst
[248.389612] Subtest uhbr-sst: SKIP (0.000s)
[248.454560] [026/132] (770s left) kms_getfb (getfb-handle-zero)
[248.539930] Starting subtest: getfb-handle-zero
[248.542222] Subtest getfb-handle-zero: SUCCESS (0.000s)
[248.631952] [027/132] (770s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[248.734501] Starting subtest: y-tiled-16bpp-rotate-0
[248.738191] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[248.830496] [028/132] (770s left) gem_partial_pwrite_pread (write-snoop)
[248.880555] Subtest write-snoop: SKIP (0.000s)
[248.954890] [029/132] (770s left) kms_selftest (drm_damage_helper)
[248.992520] Starting subtest: drm_damage_helper
[249.000013] Starting dynamic subtest: drm_test_damage_iter_no_damage
[249.081872] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.082s)
[249.095592] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[249.172106] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.087s)
[249.180891] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[249.259551] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.088s)
[249.267072] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[249.348520] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.088s)
[249.357785] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[249.434645] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.086s)
[249.443291] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[249.510551] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.076s)
[249.520109] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[249.594508] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.083s)
[249.603542] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[249.681693] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.086s)
[249.690513] Starting dynamic subtest: drm_test_damage_iter_single_damage
[249.759459] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.078s)
[249.767022] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[249.844061] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.083s)
[249.851282] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[249.927959] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.083s)
[249.936611] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[250.017289] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.090s)
[250.024772] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[250.100364] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.083s)
[250.107976] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[250.190064] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.088s)
[250.197484] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[250.283953] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.093s)
[250.291533] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[250.373751] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.090s)
[250.383089] Starting dynamic subtest: drm_test_damage_iter_damage
[250.451150] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.077s)
[250.458545] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[250.543615] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.091s)
[250.551063] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[250.634318] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.091s)
[250.641740] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[250.726768] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.091s)
[250.735643] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[250.811256] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.085s)
[250.813183] Subtest drm_damage_helper: SUCCESS (1.820s)
[250.979523] [030/132] (768s left) kms_content_protection (atomic-dpms-hdcp14)
[251.117486] Starting subtest: atomic-dpms-hdcp14
[251.121438] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[251.225779] [031/132] (768s left) gen9_exec_parse (bb-large)
[251.299239] Subtest bb-large: SKIP (0.000s)
[251.361776] [032/132] (768s left) kms_setmode (invalid-clone-single-crtc-stealing)
[251.411976] Starting subtest: invalid-clone-single-crtc-stealing
[251.417164] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[251.508788] [033/132] (768s left) kms_cursor_crc (cursor-size-change)
[251.604525] Starting subtest: cursor-size-change
[251.606682] Starting dynamic subtest: pipe-A-eDP-1
[252.380928] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.775s)
[252.391738] Starting dynamic subtest: pipe-D-eDP-1
[253.814164] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.431s)
[253.816649] Subtest cursor-size-change: SUCCESS (2.208s)
[254.614622] [034/132] (765s left) perf (mi-rpc)
[254.774151] Starting subtest: mi-rpc
[254.778429] Subtest mi-rpc: SKIP (0.000s)
[254.816969] [035/132] (765s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[254.909191] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[254.911464] Starting dynamic subtest: pipe-A-eDP-1
[265.888082] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.983s)
[265.896262] Starting dynamic subtest: pipe-B-eDP-1
[277.620876] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.729s)
[277.622848] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.714s)
[278.478756] [036/132] (741s left) perf_pmu (all-busy-check-all)
[278.520803] Starting subtest: all-busy-check-all
[279.895044] Subtest all-busy-check-all: SUCCESS (1.374s)
[279.996477] [037/132] (739s left) gem_exec_async (forked-writes)
[280.056717] Starting subtest: forked-writes
[280.058889] Starting dynamic subtest: rcs0
[280.084967] Dynamic subtest rcs0: SUCCESS (0.030s)
[280.094193] Starting dynamic subtest: bcs0
[280.110100] Dynamic subtest bcs0: SUCCESS (0.024s)
[280.119734] Starting dynamic subtest: vcs0
[280.135023] Dynamic subtest vcs0: SUCCESS (0.024s)
[280.143784] Starting dynamic subtest: vcs1
[280.158612] Dynamic subtest vcs1: SUCCESS (0.023s)
[280.168257] Starting dynamic subtest: vecs0
[280.182478] Dynamic subtest vecs0: SUCCESS (0.024s)
[280.193775] Starting dynamic subtest: ccs0
[280.209296] Dynamic subtest ccs0: SUCCESS (0.026s)
[280.211542] Subtest forked-writes: SUCCESS (0.155s)
[280.428768] [038/132] (739s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[280.477146] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[280.479586] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[280.569260] [039/132] (739s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[280.678224] Starting subtest: cursorA-vs-flipB-legacy
[280.682771] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[280.821896] [040/132] (739s left) kms_frontbuffer_tracking (psr-slowdraw)
[280.919590] Starting subtest: psr-slowdraw
[306.049796] Subtest psr-slowdraw: SUCCESS (25.132s)
[306.177956] [041/132] (713s left) gem_mmap_offset (blt-coherency)
[306.237706] Starting subtest: blt-coherency
[306.242230] Subtest blt-coherency: SUCCESS (0.007s)
[306.365601] [042/132] (713s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[306.458206] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[306.462413] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[306.569326] [043/132] (713s left) i915_drm_fdinfo (most-busy-idle-check-all)
[306.611603] Starting subtest: most-busy-idle-check-all
[306.613847] Starting dynamic subtest: rcs0
[306.618304] Dynamic subtest rcs0: SKIP (0.004s)
[306.626958] Starting dynamic subtest: bcs0
[306.631073] Dynamic subtest bcs0: SKIP (0.000s)
[306.640275] Starting dynamic subtest: vcs0
[306.644518] Dynamic subtest vcs0: SKIP (0.000s)
[306.652160] Starting dynamic subtest: vcs1
[306.656076] Dynamic subtest vcs1: SKIP (0.001s)
[306.663665] Starting dynamic subtest: vecs0
[306.667588] Dynamic subtest vecs0: SKIP (0.000s)
[306.675155] Starting dynamic subtest: ccs0
[306.679080] Dynamic subtest ccs0: SKIP (0.000s)
[306.682997] Subtest most-busy-idle-check-all: SKIP (0.007s)
[306.718832] [044/132] (713s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[306.838085] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[306.841695] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[306.909227] [045/132] (713s left) kms_flip (flip-vs-dpms-on-nop)
[307.006079] Starting subtest: flip-vs-dpms-on-nop
[307.007840] Starting dynamic subtest: A-eDP1
[308.887674] Dynamic subtest A-eDP1: SUCCESS (1.882s)
[308.898601] Starting dynamic subtest: B-eDP1
[310.715406] Dynamic subtest B-eDP1: SUCCESS (1.826s)
[310.726283] Starting dynamic subtest: C-eDP1
[312.525970] Dynamic subtest C-eDP1: SUCCESS (1.809s)
[312.535901] Starting dynamic subtest: D-eDP1
[314.359937] Dynamic subtest D-eDP1: SUCCESS (1.833s)
[314.365108] Subtest flip-vs-dpms-on-nop: SUCCESS (7.360s)
[315.553926] [046/132] (704s left) kms_atomic_interruptible (atomic-setmode)
[315.664859] Starting subtest: atomic-setmode
[315.667156] Starting dynamic subtest: pipe-A-eDP-1
[322.581274] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.915s)
[322.583145] Subtest atomic-setmode: SUCCESS (6.916s)
[323.457724] [047/132] (696s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[323.553272] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[323.557494] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[323.644464] [048/132] (696s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[323.751521] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[324.795906] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.045s)
[324.916387] [049/132] (695s left) prime_busy (after)
[324.969463] Starting subtest: after
[324.974286] Starting dynamic subtest: rcs0
[325.000155] Dynamic subtest rcs0: SUCCESS (0.028s)
[325.008676] Starting dynamic subtest: bcs0
[325.048613] Dynamic subtest bcs0: SUCCESS (0.048s)
[325.059144] Starting dynamic subtest: vcs0
[325.088872] Dynamic subtest vcs0: SUCCESS (0.040s)
[325.097514] Starting dynamic subtest: vcs1
[325.129163] Dynamic subtest vcs1: SUCCESS (0.040s)
[325.137964] Starting dynamic subtest: vecs0
[325.170450] Dynamic subtest vecs0: SUCCESS (0.041s)
[325.180361] Starting dynamic subtest: ccs0
[325.210818] Dynamic subtest ccs0: SUCCESS (0.040s)
[325.319578] Subtest after: SUCCESS (0.348s)
[325.394955] [050/132] (695s left) gem_ccs (suspend-resume)
[325.459525] Starting subtest: suspend-resume
[325.464356] Subtest suspend-resume: SKIP (0.000s)
[325.564406] [051/132] (694s left) kms_plane_alpha_blend (constant-alpha-mid)
[325.660840] Starting subtest: constant-alpha-mid
[325.942743] Starting dynamic subtest: pipe-A-eDP-1
[326.818233] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.875s)
[326.828487] Starting dynamic subtest: pipe-D-eDP-1
[328.337222] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.518s)
[328.339628] Subtest constant-alpha-mid: SUCCESS (2.679s)
[329.146941] [052/132] (691s left) kms_prop_blob (invalid-set-prop-any)
[329.198528] Starting subtest: invalid-set-prop-any
[329.200832] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[329.286410] [053/132] (691s left) i915_pm_freq_api (freq-suspend)
[329.342804] Starting subtest: freq-suspend
[329.345175] Starting dynamic subtest: gt0
[346.141723] Dynamic subtest gt0: SUCCESS (2.127s)
[346.154400] Starting dynamic subtest: gt1
[362.160351] Dynamic subtest gt1: SUCCESS (1.219s)
[362.162667] Subtest freq-suspend: SUCCESS (3.348s)
[363.246946] [054/132] (658s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[363.363566] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[363.368735] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[363.443571] [055/132] (658s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[363.534349] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[363.537050] Starting dynamic subtest: pipe-A-default-mode
[366.233160] Dynamic subtest pipe-A-default-mode: SUCCESS (2.733s)
[366.235610] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.734s)
[367.090029] [056/132] (654s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[367.190356] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[373.855830] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.712s)
[373.968652] [057/132] (647s left) kms_psr (fbc-psr-primary-page-flip)
[374.064473] Starting subtest: fbc-psr-primary-page-flip
[374.066844] Starting dynamic subtest: eDP-1
[374.070936] Dynamic subtest eDP-1: SKIP (0.000s)
[374.075192] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[374.136926] [058/132] (647s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[374.189309] Starting subtest: mixed-tiled-to-y-tiled-ccs
[374.194063] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[374.385990] [059/132] (647s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[374.473315] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[381.725643] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.274s)
[381.842194] [060/132] (640s left) kms_chamelium_color (ctm-green-to-red)
[381.938467] Subtest ctm-green-to-red: SKIP (0.000s)
[381.988230] [061/132] (639s left) gem_exec_reloc (basic-wc-cpu)
[382.052237] Subtest basic-wc-cpu: SKIP (0.000s)
[382.130308] [062/132] (639s left) api_intel_bb (misplaced-blitter)
[382.182109] Starting subtest: misplaced-blitter
[382.188203] Subtest misplaced-blitter: SUCCESS (0.009s)
[382.309643] [063/132] (639s left) sysfs_defaults (readonly)
[382.375376] Starting subtest: readonly
[382.378085] Starting dynamic subtest: vecs0
[382.380654] Dynamic subtest vecs0: SUCCESS (0.000s)
[382.391612] Starting dynamic subtest: ccs0
[382.394036] Dynamic subtest ccs0: SUCCESS (0.000s)
[382.403586] Starting dynamic subtest: vcs0
[382.405985] Dynamic subtest vcs0: SUCCESS (0.000s)
[382.415479] Starting dynamic subtest: bcs0
[382.417875] Dynamic subtest bcs0: SUCCESS (0.000s)
[382.428132] Starting dynamic subtest: rcs0
[382.430528] Dynamic subtest rcs0: SUCCESS (0.000s)
[382.442421] Starting dynamic subtest: vcs1
[382.444824] Dynamic subtest vcs1: SUCCESS (0.000s)
[382.447010] Subtest readonly: SUCCESS (0.005s)
[382.486152] [064/132] (639s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[382.590351] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[382.595365] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[382.691204] [065/132] (639s left) kms_chamelium_frames (hdmi-crc-single)
[383.077475] Subtest hdmi-crc-single: SKIP (0.000s)
[383.863904] [066/132] (638s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[384.255479] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[385.098282] [067/132] (637s left) kms_big_fb (linear-64bpp-rotate-180)
[385.191416] Starting subtest: linear-64bpp-rotate-180
[386.824357] Subtest linear-64bpp-rotate-180: SUCCESS (1.637s)
[387.003369] [068/132] (635s left) gem_wait (busy)
[387.075051] Starting subtest: busy
[387.077745] Starting dynamic subtest: all-engines
[388.395619] Dynamic subtest all-engines: SUCCESS (1.320s)
[388.412125] Starting dynamic subtest: rcs0
[388.937825] Dynamic subtest rcs0: SUCCESS (0.541s)
[388.950617] Starting dynamic subtest: bcs0
[389.477074] Dynamic subtest bcs0: SUCCESS (0.538s)
[389.489403] Starting dynamic subtest: vcs0
[391.402905] Dynamic subtest vcs0: SUCCESS (1.926s)
[391.416327] Starting dynamic subtest: vcs1
[393.387351] Dynamic subtest vcs1: SUCCESS (1.982s)
[393.399629] Starting dynamic subtest: vecs0
[395.371243] Dynamic subtest vecs0: SUCCESS (1.980s)
[395.383917] Starting dynamic subtest: ccs0
[395.913589] Dynamic subtest ccs0: SUCCESS (0.541s)
[395.916810] Subtest busy: SUCCESS (8.842s)
[396.114382] [069/132] (626s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[396.179637] Starting subtest: legacy-engines-hostile-preempt
[396.182462] Starting dynamic subtest: render
[396.258939] Dynamic subtest render: SUCCESS (0.082s)
[396.271059] Starting dynamic subtest: bsd1
[397.351374] Dynamic subtest bsd1: SUCCESS (1.088s)
[397.364036] Starting dynamic subtest: bsd2
[399.390538] Dynamic subtest bsd2: SUCCESS (2.035s)
[399.402893] Starting dynamic subtest: blt
[399.425242] Dynamic subtest blt: SUCCESS (0.032s)
[399.435603] Starting dynamic subtest: vebox
[401.383958] Dynamic subtest vebox: SUCCESS (1.955s)
[401.386904] Subtest legacy-engines-hostile-preempt: SUCCESS (5.206s)
[401.468137] [070/132] (620s left) kms_lease (lease-revoke)
[401.573148] Starting subtest: lease-revoke
[401.575527] Starting dynamic subtest: pipe-A-eDP-1
[401.606137] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.033s)
[401.616605] Starting dynamic subtest: pipe-B-eDP-1
[401.633297] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.028s)
[401.643173] Starting dynamic subtest: pipe-C-eDP-1
[401.660886] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.027s)
[401.670515] Starting dynamic subtest: pipe-D-eDP-1
[401.689411] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.027s)
[401.692483] Subtest lease-revoke: SUCCESS (0.119s)
[401.800308] [071/132] (620s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[401.894523] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[401.900040] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[403.037974] [072/132] (619s left) prime_self_import (basic-with_one_bo)
[403.081514] Starting subtest: basic-with_one_bo
[403.103732] Subtest basic-with_one_bo: SUCCESS (0.021s)
[403.209269] [073/132] (619s left) gem_ctx_param (invalid-size-set)
[403.259806] Starting subtest: invalid-size-set
[403.262429] Subtest invalid-size-set: SUCCESS (0.001s)
[403.361346] [074/132] (619s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[403.463412] Starting subtest: 4-tiled-addfb-size-offset-overflow
[403.465314] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[403.555817] [075/132] (618s left) i915_pm_rpm (gem-execbuf)
[405.493593] Starting subtest: gem-execbuf
[405.496451] Starting dynamic subtest: smem0
[407.215539] Dynamic subtest smem0: SUCCESS (1.723s)
[407.218300] Subtest gem-execbuf: SUCCESS (1.724s)
[407.311933] [076/132] (615s left) gem_sync (basic-each)
[407.399498] Starting subtest: basic-each
[409.697022] Subtest basic-each: SUCCESS (2.312s)
[409.885461] [077/132] (612s left) gem_exec_reloc (basic-wc-read-active)
[409.963295] Subtest basic-wc-read-active: SKIP (0.000s)
[410.038636] [078/132] (612s left) kms_getfb (getfb-handle-closed)
[410.126373] Starting subtest: getfb-handle-closed
[410.129193] Subtest getfb-handle-closed: SUCCESS (0.000s)
[410.214189] [079/132] (612s left) gem_mmap_gtt (basic-small-copy-xy)
[410.271184] Subtest basic-small-copy-XY: SKIP (0.000s)
[410.333220] [080/132] (612s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[410.446845] Starting subtest: flip-vs-cursor-busy-crc-legacy
[411.238385] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.793s)
[412.102476] [081/132] (610s left) kms_vblank (wait-busy)
[412.197481] Starting subtest: wait-busy
[412.199856] Starting dynamic subtest: pipe-A-eDP-1
[414.083748] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.888s)
[414.098886] Starting dynamic subtest: pipe-D-eDP-1
[416.678135] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.592s)
[416.680614] Subtest wait-busy: SUCCESS (4.484s)
[417.477693] [082/132] (605s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[417.557861] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[417.563235] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s)
[417.634915] [083/132] (605s left) kms_addfb_basic (bad-pitch-0)
[417.697115] Starting subtest: bad-pitch-0
[417.699381] Subtest bad-pitch-0: SUCCESS (0.000s)
[417.825865] [084/132] (605s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[417.895386] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[417.971939] [085/132] (604s left) gem_exec_balancer (full)
[418.029334] Starting subtest: full
[422.207016] Subtest full: SUCCESS (4.178s)
[422.538496] [086/132] (600s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[422.643340] Starting subtest: x-tiled-16bpp-rotate-270
[422.663171] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[422.780592] [087/132] (600s left) kms_psr (psr2-cursor-mmap-cpu)
[422.868124] Starting subtest: psr2-cursor-mmap-cpu
[422.870576] Starting dynamic subtest: eDP-1
[424.548227] Dynamic subtest eDP-1: SUCCESS (1.681s)
[424.550885] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.682s)
[425.347920] [088/132] (597s left) kms_color_pipeline (plane-lut1d)
[425.455352] Starting subtest: plane-lut1d
[425.614025] Starting dynamic subtest: pipe-A-plane-0
[425.969260] Dynamic subtest pipe-A-plane-0: FAIL (0.159s)
[425.980220] Starting dynamic subtest: pipe-A-plane-1
[426.210323] Dynamic subtest pipe-A-plane-1: FAIL (0.170s)
[426.221293] Starting dynamic subtest: pipe-A-plane-2
[426.465938] Dynamic subtest pipe-A-plane-2: FAIL (0.168s)
[427.366105] Starting dynamic subtest: pipe-B-plane-0
[427.814547] Dynamic subtest pipe-B-plane-0: FAIL (0.163s)
[427.824354] Starting dynamic subtest: pipe-B-plane-1
[428.166277] Dynamic subtest pipe-B-plane-1: FAIL (0.157s)
[428.181101] Starting dynamic subtest: pipe-B-plane-2
[428.527601] Dynamic subtest pipe-B-plane-2: FAIL (0.174s)
[429.080484] Starting dynamic subtest: pipe-C-plane-0
[429.626919] Dynamic subtest pipe-C-plane-0: FAIL (0.128s)
[429.641445] Starting dynamic subtest: pipe-C-plane-1
[430.082132] Dynamic subtest pipe-C-plane-1: FAIL (0.705s)
[430.094644] Starting dynamic subtest: pipe-C-plane-2
[430.503856] Dynamic subtest pipe-C-plane-2: FAIL (0.158s)
[431.211259] Starting dynamic subtest: pipe-D-plane-0
[431.831456] Dynamic subtest pipe-D-plane-0: FAIL (0.140s)
[431.843235] Starting dynamic subtest: pipe-D-plane-1
[432.350173] Dynamic subtest pipe-D-plane-1: FAIL (0.676s)
[432.360867] Starting dynamic subtest: pipe-D-plane-2
[432.861070] Dynamic subtest pipe-D-plane-2: FAIL (0.625s)
[432.946123] Subtest plane-lut1d: FAIL (7.495s)
[433.779926] [089/132] (589s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[433.881311] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[433.883943] Starting dynamic subtest: pipe-A-eDP-1
[433.909954] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[433.921213] Starting dynamic subtest: pipe-B-eDP-1
[433.946387] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[433.957193] Starting dynamic subtest: pipe-C-eDP-1
[433.982386] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[433.991905] Starting dynamic subtest: pipe-D-eDP-1
[434.017429] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[434.022244] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[436.139253] [090/132] (587s left) kms_invalid_mode (zero-vdisplay)
[436.229579] Starting subtest: zero-vdisplay
[436.232148] Starting dynamic subtest: pipe-A-eDP-1
[436.516468] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[436.527870] Starting dynamic subtest: pipe-B-eDP-1
[436.530485] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[436.541127] Starting dynamic subtest: pipe-C-eDP-1
[436.543651] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[436.553581] Starting dynamic subtest: pipe-D-eDP-1
[436.556308] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[436.559082] Subtest zero-vdisplay: SUCCESS (0.293s)
[437.358116] [091/132] (585s left) kms_getfb (getfb-handle-valid)
[437.457372] Starting subtest: getfb-handle-valid
[437.460016] Subtest getfb-handle-valid: SUCCESS (0.000s)
[437.548294] [092/132] (585s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[437.650457] Starting subtest: yf-tiled-64bpp-rotate-0
[437.655596] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[437.753839] [093/132] (585s left) gem_exec_reloc (basic-gtt-noreloc)
[437.812444] Subtest basic-gtt-noreloc: SKIP (0.000s)
[437.889203] [094/132] (585s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[437.941938] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[438.049251] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.107s)
[438.124720] [095/132] (585s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[438.222073] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[438.224501] Starting dynamic subtest: pipe-A
[438.247617] Dynamic subtest pipe-A: SKIP (0.020s)
[438.258130] Starting dynamic subtest: pipe-B
[438.284609] Dynamic subtest pipe-B: SKIP (0.036s)
[438.293987] Starting dynamic subtest: pipe-C
[438.312979] Dynamic subtest pipe-C: SKIP (0.029s)
[438.322308] Starting dynamic subtest: pipe-D
[438.344209] Dynamic subtest pipe-D: SKIP (0.029s)
[438.349351] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.117s)
[438.448006] [096/132] (584s left) kms_vrr (lobf)
[438.541462] Starting subtest: lobf
[438.547401] Subtest lobf: SKIP (0.000s)
[438.621599] [097/132] (584s left) kms_psr (psr2-sprite-mmap-cpu)
[438.719942] Starting subtest: psr2-sprite-mmap-cpu
[438.723005] Starting dynamic subtest: eDP-1
[440.495227] Dynamic subtest eDP-1: SUCCESS (1.774s)
[440.497930] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.775s)
[441.330259] [098/132] (582s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[441.430587] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[441.435836] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[441.519003] [099/132] (582s left) sw_sync (alloc_fence)
[441.559327] Starting subtest: alloc_fence
[441.561878] Subtest alloc_fence: SUCCESS (0.000s)
[441.618581] [100/132] (581s left) gem_mmap_wc (invalid-flags)
[441.676360] Subtest invalid-flags: SKIP (0.000s)
[441.733215] [101/132] (581s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[441.791194] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[441.848221] [102/132] (581s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[441.939396] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[441.943649] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[442.032770] [103/132] (581s left) kms_plane_multiple (tiling-yf)
[442.125719] Starting subtest: tiling-yf
[442.131042] Subtest tiling-yf: SKIP (0.000s)
[442.205819] [104/132] (581s left) gem_exec_whisper (basic-sync)
[442.276845] Starting subtest: basic-sync
[449.912640] Subtest basic-sync: SUCCESS (7.636s)
[450.098820] [105/132] (573s left) gem_close_race (basic-process)
[450.174293] Starting subtest: basic-process
[450.214783] Subtest basic-process: SUCCESS (0.044s)
[450.396451] [106/132] (573s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[450.493951] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[450.496322] Starting dynamic subtest: pipe-A
[450.519211] Dynamic subtest pipe-A: SKIP (0.016s)
[450.530101] Starting dynamic subtest: pipe-B
[450.542598] Dynamic subtest pipe-B: SKIP (0.029s)
[450.552332] Starting dynamic subtest: pipe-C
[450.572483] Dynamic subtest pipe-C: SKIP (0.028s)
[450.582096] Starting dynamic subtest: pipe-D
[450.599793] Dynamic subtest pipe-D: SKIP (0.028s)
[450.604167] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.104s)
[450.697283] [107/132] (573s left) api_intel_allocator (reopen-fork)
[450.764447] Starting subtest: reopen-fork
[454.046988] Subtest reopen-fork: SUCCESS (3.284s)
[454.124864] [108/132] (569s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[454.239960] Starting subtest: fbc-psr2-primary-mmap-cpu
[454.242482] Starting dynamic subtest: eDP-1
[454.247851] Dynamic subtest eDP-1: SKIP (0.000s)
[454.252611] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[454.314267] [109/132] (569s left) kms_flip (flip-vs-blocking-wf-vblank)
[454.405332] Starting subtest: flip-vs-blocking-wf-vblank
[454.407841] Starting dynamic subtest: A-eDP1
[463.361299] Dynamic subtest A-eDP1: SUCCESS (8.956s)
[463.372885] Starting dynamic subtest: B-eDP1
[472.293065] Dynamic subtest B-eDP1: SUCCESS (8.926s)
[472.302374] Starting dynamic subtest: C-eDP1
[481.216609] Dynamic subtest C-eDP1: SUCCESS (8.920s)
[481.226651] Starting dynamic subtest: D-eDP1
[490.152238] Dynamic subtest D-eDP1: SUCCESS (8.931s)
[490.154630] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.744s)
[491.380520] [110/132] (532s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[491.432980] Starting subtest: single-wait-all-for-submit-signaled
[491.435598] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[491.537161] [111/132] (532s left) gem_basic (multigpu-create-close)
[491.604877] Starting subtest: multigpu-create-close
[491.610437] Subtest multigpu-create-close: SKIP (0.000s)
[491.696905] [112/132] (532s left) kms_addfb_basic (unused-pitches)
[491.754774] Starting subtest: unused-pitches
[491.757136] Subtest unused-pitches: SUCCESS (0.000s)
[491.888976] [113/132] (532s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[491.982371] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[498.530483] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.550s)
[498.654993] [114/132] (525s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[498.753474] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[498.758951] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[498.851897] [115/132] (525s left) gem_exec_nop (basic-parallel)
[498.930382] Starting subtest: basic-parallel
[514.347617] Subtest basic-parallel: SUCCESS (15.433s)
[514.577841] [116/132] (509s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[514.679317] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[514.681849] Starting dynamic subtest: pipe-A-eDP-1
[514.707085] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[514.718420] Starting dynamic subtest: pipe-B-eDP-1
[514.743485] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[514.753124] Starting dynamic subtest: pipe-C-eDP-1
[514.778336] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[514.787744] Starting dynamic subtest: pipe-D-eDP-1
[514.813618] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[514.818990] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[516.959868] [117/132] (507s left) core_setmaster (master-drop-set-shared-fd)
[517.054270] Starting subtest: master-drop-set-shared-fd
[517.076072] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[517.116988] [118/132] (507s left) gem_pxp (create-protected-buffer)
[517.234592] Starting subtest: create-protected-buffer
[517.237573] Subtest create-protected-buffer: SUCCESS (0.000s)
[517.348393] [119/132] (507s left) kms_psr2_su (page_flip-xrgb8888)
[517.414456] Subtest page_flip-XRGB8888: SKIP (0.000s)
[517.476066] [120/132] (506s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[517.563622] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[517.568250] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[517.656216] [121/132] (506s left) kms_atomic_transition (modeset-transition-fencing)
[517.751895] Starting subtest: modeset-transition-fencing
[517.754334] Starting dynamic subtest: 1x-outputs
[528.682359] Dynamic subtest 1x-outputs: SUCCESS (10.930s)
[528.685444] Subtest modeset-transition-fencing: SUCCESS (10.932s)
[529.542063] [122/132] (494s left) gem_softpin (evict-prime-sanity-check)
[529.596476] Starting subtest: evict-prime-sanity-check
[529.599097] Starting dynamic subtest: rcs0
[530.725246] Dynamic subtest rcs0: SUCCESS (1.132s)
[530.735394] Starting dynamic subtest: bcs0
[531.846446] Dynamic subtest bcs0: SUCCESS (1.121s)
[531.856500] Starting dynamic subtest: vcs0
[533.331640] Dynamic subtest vcs0: SUCCESS (1.482s)
[533.342615] Starting dynamic subtest: vcs1
[535.396961] Dynamic subtest vcs1: SUCCESS (2.063s)
[535.409864] Starting dynamic subtest: vecs0
[537.319931] Dynamic subtest vecs0: SUCCESS (1.919s)
[537.340622] Starting dynamic subtest: ccs0
[538.441641] Dynamic subtest ccs0: SUCCESS (1.121s)
[538.452459] Starting dynamic subtest: all
[539.567897] Dynamic subtest all: SUCCESS (1.125s)
[539.570851] Subtest evict-prime-sanity-check: SUCCESS (9.978s)
[539.667373] [123/132] (484s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[539.775584] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[546.483609] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.713s)
[546.609367] [124/132] (478s left) kms_cursor_crc (cursor-sliding-32x10)
[546.769288] Starting subtest: cursor-sliding-32x10
[546.813094] Subtest cursor-sliding-32x10: SKIP (0.039s)
[547.066231] [125/132] (477s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[547.167988] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[547.173190] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[547.273884] [126/132] (477s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[547.363445] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[554.019197] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.661s)
[554.137012] [127/132] (470s left) gem_fence_thrash (bo-copy)
[554.172632] Starting subtest: bo-copy
[554.187521] Subtest bo-copy: SKIP (0.012s)
[554.250855] [128/132] (470s left) kms_scaling_modes (scaling-mode-full-aspect)
[554.339431] Starting subtest: scaling-mode-full-aspect
[554.342422] Starting dynamic subtest: pipe-A-eDP-1
[554.434593] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.095s)
[554.447921] Starting dynamic subtest: pipe-B-eDP-1
[555.563623] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.124s)
[555.574616] Starting dynamic subtest: pipe-C-eDP-1
[556.673100] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.110s)
[556.683225] Starting dynamic subtest: pipe-D-eDP-1
[557.808159] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s)
[557.810970] Subtest scaling-mode-full-aspect: SUCCESS (3.470s)
[558.966062] [129/132] (465s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[559.090336] Starting subtest: cursorA-vs-flipB-varying-size
[559.094998] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[559.241279] [130/132] (465s left) syncobj_timeline (etime-single-wait-all-submitted)
[559.293920] Starting subtest: etime-single-wait-all-submitted
[559.399066] Subtest etime-single-wait-all-submitted: SUCCESS (0.104s)
[559.493037] [131/132] (465s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[559.555950] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[559.561303] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[559.739502] [132/132] (465s left) gem_wait (invalid-flags)
[559.795724] Starting subtest: invalid-flags
[559.798600] Subtest invalid-flags: SUCCESS (0.000s)
[560.008279] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_crc
results: parsing output: 1/ for test: gem_exec_gttfill
results: parsing output: 2/ for test: gem_exec_balancer
results: parsing output: 3/ for test: kms_dither
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: kms_flip
results: parsing output: 6/ for test: gem_exec_fence
results: parsing output: 7/ for test: kms_async_flips
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: gem_ctx_isolation
results: parsing output: 10/ for test: kms_getfb
results: parsing output: 11/ for test: gem_exec_store
results: parsing output: 12/ for test: gem_exec_schedule
results: parsing output: 13/ for test: syncobj_wait
results: parsing output: 14/ for test: kms_pm_rpm
results: parsing output: 15/ for test: gem_eio
results: parsing output: 16/ for test: gem_partial_pwrite_pread
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: perf_pmu
results: parsing output: 19/ for test: i915_query
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: gem_exec_schedule
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_cursor_crc
results: parsing output: 24/ for test: kms_dp_link_training
results: parsing output: 25/ for test: kms_getfb
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: gem_partial_pwrite_pread
results: parsing output: 28/ for test: kms_selftest
results: parsing output: 29/ for test: kms_content_protection
results: parsing output: 30/ for test: gen9_exec_parse
results: parsing output: 31/ for test: kms_setmode
results: parsing output: 32/ for test: kms_cursor_crc
results: parsing output: 33/ for test: perf
results: parsing output: 34/ for test: kms_psr2_sf
results: parsing output: 35/ for test: perf_pmu
results: parsing output: 36/ for test: gem_exec_async
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: kms_cursor_legacy
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_mmap_offset
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: i915_drm_fdinfo
results: parsing output: 43/ for test: kms_flip_scaled_crc
results: parsing output: 44/ for test: kms_flip
results: parsing output: 45/ for test: kms_atomic_interruptible
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: prime_busy
results: parsing output: 49/ for test: gem_ccs
results: parsing output: 50/ for test: kms_plane_alpha_blend
results: parsing output: 51/ for test: kms_prop_blob
results: parsing output: 52/ for test: i915_pm_freq_api
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_flip_scaled_crc
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: gem_render_copy
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_chamelium_color
results: parsing output: 60/ for test: gem_exec_reloc
results: parsing output: 61/ for test: api_intel_bb
results: parsing output: 62/ for test: sysfs_defaults
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_chamelium_frames
results: parsing output: 65/ for test: kms_chamelium_hpd
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: gem_wait
results: parsing output: 68/ for test: gem_ctx_persistence
results: parsing output: 69/ for test: kms_lease
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: prime_self_import
results: parsing output: 72/ for test: gem_ctx_param
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: i915_pm_rpm
results: parsing output: 75/ for test: gem_sync
results: parsing output: 76/ for test: gem_exec_reloc
results: parsing output: 77/ for test: kms_getfb
results: parsing output: 78/ for test: gem_mmap_gtt
results: parsing output: 79/ for test: kms_cursor_legacy
results: parsing output: 80/ for test: kms_vblank
results: parsing output: 81/ for test: kms_plane
results: parsing output: 82/ for test: kms_addfb_basic
results: parsing output: 83/ for test: gem_fenced_exec_thrash
results: parsing output: 84/ for test: gem_exec_balancer
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: kms_color_pipeline
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: kms_invalid_mode
results: parsing output: 90/ for test: kms_getfb
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: gem_exec_reloc
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_plane_scaling
results: parsing output: 95/ for test: kms_vrr
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: sw_sync
results: parsing output: 99/ for test: gem_mmap_wc
results: parsing output: 100/ for test: gem_mmap_gtt
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_plane_multiple
results: parsing output: 103/ for test: gem_exec_whisper
results: parsing output: 104/ for test: gem_close_race
results: parsing output: 105/ for test: kms_plane_scaling
results: parsing output: 106/ for test: api_intel_allocator
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: kms_flip
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: gem_basic
results: parsing output: 111/ for test: kms_addfb_basic
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_exec_nop
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: core_setmaster
results: parsing output: 117/ for test: gem_pxp
results: parsing output: 118/ for test: kms_psr2_su
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_atomic_transition
results: parsing output: 121/ for test: gem_softpin
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_cursor_crc
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_fence_thrash
results: parsing output: 127/ for test: kms_scaling_modes
results: parsing output: 128/ for test: kms_cursor_legacy
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: gem_render_copy
results: parsing output: 131/ for test: gem_wait
Done.