[62.944009] Initializing watchdogs
[62.944067]   /dev/watchdog0
[62.959605] [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]
[62.964310] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.966431] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.968285] [001/133] (960s left) perf_pmu (busy-hang)
[63.015933] Starting subtest: busy-hang
[63.016849] Starting dynamic subtest: rcs0
[64.253587] Dynamic subtest rcs0: SUCCESS (1.224s)
[64.262006] Starting dynamic subtest: bcs0
[65.423509] Dynamic subtest bcs0: SUCCESS (1.161s)
[65.433490] Starting dynamic subtest: vcs0
[67.819324] Dynamic subtest vcs0: SUCCESS (2.381s)
[67.827528] Starting dynamic subtest: vcs1
[69.859316] Dynamic subtest vcs1: SUCCESS (2.029s)
[69.870790] Starting dynamic subtest: vecs0
[71.841480] Dynamic subtest vecs0: SUCCESS (1.976s)
[71.848141] Starting dynamic subtest: ccs0
[72.997822] Dynamic subtest ccs0: SUCCESS (1.150s)
[72.999030] Subtest busy-hang: SUCCESS (9.926s)
[73.140053] [002/133] (950s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[73.234462] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[73.340953] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.107s)
[73.422648] [003/133] (950s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[73.558126] Starting subtest: cursorA-vs-flipA-toggle
[84.752068] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.179s)
[85.599529] [004/133] (937s left) kms_vrr (negative-basic)
[85.699876] Starting subtest: negative-basic
[85.702752] Starting dynamic subtest: pipe-A-eDP-1
[91.114861] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.407s)
[91.397770] Subtest negative-basic: SUCCESS (5.693s)
[92.222246] [005/133] (931s left) kms_flip (2x-flip-vs-wf_vblank)
[92.310328] Starting subtest: 2x-flip-vs-wf_vblank
[92.320054] Subtest 2x-flip-vs-wf_vblank: SKIP (0.011s)
[92.415926] [006/133] (931s left) kms_pm_rpm (legacy-planes-dpms)
[94.446875] Starting subtest: legacy-planes-dpms
[94.448931] Starting dynamic subtest: plane-65
[102.762209] Dynamic subtest plane-65: SUCCESS (8.312s)
[102.772593] Starting dynamic subtest: plane-95
[111.384058] Dynamic subtest plane-95: SUCCESS (8.617s)
[111.393488] Starting dynamic subtest: plane-125
[119.999444] Dynamic subtest plane-125: SUCCESS (8.612s)
[120.008974] Starting dynamic subtest: plane-135
[128.268355] Dynamic subtest plane-135: SUCCESS (8.266s)
[128.270227] Subtest legacy-planes-dpms: SUCCESS (33.812s)
[128.656958] [007/133] (895s left) kms_chamelium_color (ctm-red-to-blue)
[128.743246] Subtest ctm-red-to-blue: SKIP (0.000s)
[128.786334] [008/133] (894s left) gem_ctx_isolation (nonpriv)
[128.834654] Starting subtest: nonpriv
[128.835729] Starting dynamic subtest: rcs0
[129.076038] Dynamic subtest rcs0: SUCCESS (0.241s)
[129.086291] Starting dynamic subtest: bcs0
[129.333664] Dynamic subtest bcs0: SUCCESS (0.257s)
[129.343794] Starting dynamic subtest: vcs0
[129.581699] Dynamic subtest vcs0: SUCCESS (0.248s)
[129.591372] Starting dynamic subtest: vcs1
[131.543380] Dynamic subtest vcs1: SUCCESS (1.961s)
[131.552896] Starting dynamic subtest: vecs0
[133.574393] Dynamic subtest vecs0: SUCCESS (2.030s)
[133.581427] Starting dynamic subtest: ccs0
[135.596907] Dynamic subtest ccs0: SUCCESS (2.022s)
[135.598039] Subtest nonpriv: SUCCESS (6.761s)
[135.814677] [009/133] (887s left) perf_pmu (frequency)
[135.848277] Starting subtest: frequency
[135.851676] Starting dynamic subtest: gt0
[137.999863] Dynamic subtest gt0: SUCCESS (2.145s)
[138.010058] Starting dynamic subtest: idle-gt0
[138.516214] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[138.526156] Starting dynamic subtest: gt1
[143.339315] Dynamic subtest gt1: SUCCESS (4.820s)
[143.348179] Starting dynamic subtest: idle-gt1
[143.844314] Dynamic subtest idle-gt1: SUCCESS (0.504s)
[143.845359] Subtest frequency: SUCCESS (7.987s)
[143.932927] [010/133] (879s left) gem_exec_alignment (forked)
[143.990799] Starting subtest: forked
[185.853633] Subtest forked: SUCCESS (41.825s)
[185.885881] [011/133] (837s left) kms_selftest (drm_format)
[185.963804] Starting subtest: drm_format
[186.018986] Starting dynamic subtest: drm_test_format_block_width_invalid
[186.113864] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.096s)
[186.123217] Starting dynamic subtest: drm_test_format_block_width_one_plane
[186.198708] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.084s)
[186.208107] Starting dynamic subtest: drm_test_format_block_width_two_plane
[186.289299] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.089s)
[186.298567] Starting dynamic subtest: drm_test_format_block_width_three_plane
[186.375344] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.087s)
[186.384621] Starting dynamic subtest: drm_test_format_block_width_tiled
[186.450780] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.075s)
[186.460131] Starting dynamic subtest: drm_test_format_block_height_invalid
[186.537349] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.085s)
[186.546435] Starting dynamic subtest: drm_test_format_block_height_one_plane
[186.627535] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.090s)
[186.635988] Starting dynamic subtest: drm_test_format_block_height_two_plane
[186.714655] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.088s)
[186.724143] Starting dynamic subtest: drm_test_format_block_height_three_plane
[186.803065] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.088s)
[186.810381] Starting dynamic subtest: drm_test_format_block_height_tiled
[186.898844] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.095s)
[186.907914] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[186.979624] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.079s)
[186.987967] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[187.075025] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.096s)
[187.084364] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[187.170149] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.094s)
[187.178595] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[187.260073] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.090s)
[187.269060] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[187.350054] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.088s)
[187.359181] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[187.434729] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.086s)
[187.443855] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[187.532296] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.096s)
[187.541138] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[187.616752] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.085s)
[187.617809] Subtest drm_format: SUCCESS (1.653s)
[187.747419] [012/133] (836s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[187.847515] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[187.849335] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[187.927978] [013/133] (835s left) syncobj_wait (multi-wait-all-submitted)
[187.983439] Starting subtest: multi-wait-all-submitted
[188.103722] Subtest multi-wait-all-submitted: SUCCESS (0.108s)
[188.162356] [014/133] (835s left) kms_flip (bo-too-big-interruptible)
[188.254746] Starting subtest: bo-too-big-interruptible
[188.256825] Starting dynamic subtest: A-eDP1
[189.588236] Dynamic subtest A-eDP1: SUCCESS (1.329s)
[189.598391] Starting dynamic subtest: B-eDP1
[190.836991] Dynamic subtest B-eDP1: SUCCESS (1.249s)
[190.847238] Starting dynamic subtest: C-eDP1
[192.080855] Dynamic subtest C-eDP1: SUCCESS (1.244s)
[192.092409] Starting dynamic subtest: D-eDP1
[193.410790] Dynamic subtest D-eDP1: SUCCESS (1.328s)
[193.415056] Subtest bo-too-big-interruptible: SUCCESS (5.160s)
[194.616240] [015/133] (829s left) kms_psr (psr2-sprite-plane-move)
[194.706194] Starting subtest: psr2-sprite-plane-move
[194.707272] Starting dynamic subtest: eDP-1
[196.447155] Dynamic subtest eDP-1: SUCCESS (1.741s)
[196.448029] Subtest psr2-sprite-plane-move: SUCCESS (1.742s)
[197.279341] [016/133] (826s left) syncobj_wait (reset-signaled)
[197.331984] Starting subtest: reset-signaled
[197.332901] Subtest reset-signaled: SUCCESS (0.000s)
[197.423547] [017/133] (826s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[197.514370] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[197.611556] [018/133] (826s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[197.701337] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[197.703216] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[197.768540] [019/133] (826s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[197.865058] Starting subtest: y-tiled-16bpp-rotate-270
[197.866923] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[197.976704] [020/133] (826s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[198.084451] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[198.085959] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[198.174858] [021/133] (825s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[198.265844] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[198.267478] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[198.352489] [022/133] (825s left) gem_lmem_swapping (heavy-verify-multi)
[198.391629] Subtest heavy-verify-multi: SKIP (0.000s)
[198.422640] [023/133] (825s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[198.514455] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[199.206074] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.692s)
[199.358134] [024/133] (824s left) gem_exec_fence (syncobj-timeline-chain-engines)
[199.941314] Starting subtest: syncobj-timeline-chain-engines
[200.066373] Subtest syncobj-timeline-chain-engines: SUCCESS (0.125s)
[201.387841] [FACT gem_exec_fence (syncobj-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[201.390258] [025/133] (822s left) i915_pm_rc6_residency (rc6-accuracy)
[201.445309] Starting subtest: rc6-accuracy
[201.446208] Starting dynamic subtest: gt0
[204.664070] Dynamic subtest gt0: SUCCESS (3.170s)
[204.675728] Starting dynamic subtest: gt1
[207.833630] Dynamic subtest gt1: SUCCESS (3.169s)
[207.834721] Subtest rc6-accuracy: SUCCESS (6.343s)
[207.865987] [026/133] (816s left) prime_mmap (test_userptr)
[207.917045] Starting subtest: test_userptr
[207.918028] Starting dynamic subtest: test_userptr-smem
[207.920370] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[207.921948] Subtest test_userptr: SUCCESS (0.001s)
[208.044232] [027/133] (816s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[208.138936] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[208.140639] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[208.244784] [028/133] (816s left) kms_addfb_basic (legacy-format)
[208.305121] Starting subtest: legacy-format
[208.334492] Subtest legacy-format: SUCCESS (0.026s)
[208.477711] [029/133] (815s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[208.579209] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[208.607359] Starting dynamic subtest: pipe-A-plane-0
[209.040279] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[209.049577] Starting dynamic subtest: pipe-A-plane-3
[209.296069] Dynamic subtest pipe-A-plane-3: SUCCESS (0.254s)
[209.305903] Starting dynamic subtest: pipe-A-plane-5
[209.307680] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[210.382992] Starting dynamic subtest: pipe-B-plane-0
[210.819753] Dynamic subtest pipe-B-plane-0: SUCCESS (0.444s)
[210.831562] Starting dynamic subtest: pipe-B-plane-3
[211.085954] Dynamic subtest pipe-B-plane-3: SUCCESS (0.266s)
[211.095748] Starting dynamic subtest: pipe-B-plane-5
[211.097433] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[211.410728] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.831s)
[212.273638] [030/133] (812s left) gem_userptr_blits (unsync-unmap-after-close)
[212.342454] Subtest unsync-unmap-after-close: SKIP (0.000s)
[212.481046] [031/133] (812s left) gem_readwrite (new-obj)
[212.528962] Subtest new-obj: SKIP (0.000s)
[212.587119] [032/133] (811s left) gem_exec_schedule (preempt-engines)
[212.648066] Starting subtest: preempt-engines
[212.648881] Starting dynamic subtest: rcs0
[214.934420] Dynamic subtest rcs0: SUCCESS (2.276s)
[214.946920] Starting dynamic subtest: bcs0
[217.268613] Dynamic subtest bcs0: SUCCESS (2.295s)
[217.278610] Starting dynamic subtest: vcs0
[219.556070] Dynamic subtest vcs0: SUCCESS (2.286s)
[219.566314] Starting dynamic subtest: vcs1
[221.844154] Dynamic subtest vcs1: SUCCESS (2.285s)
[221.855558] Starting dynamic subtest: vecs0
[224.117052] Dynamic subtest vecs0: SUCCESS (2.272s)
[224.127522] Starting dynamic subtest: ccs0
[226.455882] Dynamic subtest ccs0: SUCCESS (2.337s)
[226.457340] Subtest preempt-engines: SUCCESS (13.761s)
[226.709227] [033/133] (797s left) gen7_exec_parse (basic-offset)
[226.764346] Subtest basic-offset: SKIP (0.000s)
[226.818584] [034/133] (797s left) gem_shrink (reclaim)
[226.873613] Starting subtest: reclaim
[229.345290] Subtest reclaim: SUCCESS (2.426s)
[229.452388] [035/133] (795s left) syncobj_timeline (reset-unsignaled)
[229.495185] Starting subtest: reset-unsignaled
[229.496132] Subtest reset-unsignaled: SUCCESS (0.000s)
[229.579727] [036/133] (795s left) i915_module_load (reload-no-display)
[229.610344] Starting subtest: reload-no-display
[233.922768] Subtest reload-no-display: SUCCESS (4.301s)
[233.944608] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[233.945587] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[233.947238] [037/133] (790s left) drm_mm (drm_mm)
[233.986798] Starting subtest: drm_mm
[233.991181] Starting dynamic subtest: drm_test_mm_init
[234.078758] Dynamic subtest drm_test_mm_init: SUCCESS (0.086s)
[234.087192] Starting dynamic subtest: drm_test_mm_debug
[234.163185] Dynamic subtest drm_test_mm_debug: SUCCESS (0.084s)
[234.169119] Starting dynamic subtest: drm_test_mm_align32
[234.257203] Dynamic subtest drm_test_mm_align32: SUCCESS (0.094s)
[234.264582] Starting dynamic subtest: drm_test_mm_align64
[234.340271] Dynamic subtest drm_test_mm_align64: SUCCESS (0.082s)
[234.347966] Starting dynamic subtest: drm_test_mm_lowest
[234.429369] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.088s)
[234.436672] Starting dynamic subtest: drm_test_mm_highest
[234.508686] Dynamic subtest drm_test_mm_highest: SUCCESS (0.078s)
[234.509685] Subtest drm_mm: SUCCESS (0.521s)
[234.625352] [038/133] (790s left) kms_flip (2x-blocking-absolute-wf_vblank)
[236.170339] Starting subtest: 2x-blocking-absolute-wf_vblank
[236.182952] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.013s)
[236.284132] [FACT kms_flip (2x-blocking-absolute-wf_vblank)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[236.285453] [FACT kms_flip (2x-blocking-absolute-wf_vblank)] new: kernel.kmod_is_loaded.i915: true
[236.288133] [039/133] (788s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[236.385678] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[240.688411] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.303s)
[241.892653] [040/133] (782s left) gem_close_race (basic-process)
[241.949569] Starting subtest: basic-process
[242.000385] Subtest basic-process: SUCCESS (0.051s)
[242.182198] [041/133] (782s left) kms_color (ctm-0-75)
[242.276513] Starting subtest: ctm-0-75
[242.277587] Starting dynamic subtest: pipe-A-eDP-1
[247.125412] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.849s)
[247.132518] Starting dynamic subtest: pipe-B-eDP-1
[252.758477] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.631s)
[252.767475] Starting dynamic subtest: pipe-C-eDP-1
[258.139067] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.381s)
[258.146586] Starting dynamic subtest: pipe-D-eDP-1
[263.467703] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.327s)
[263.468558] Subtest ctm-0-75: SUCCESS (21.191s)
[264.291437] [042/133] (760s left) prime_busy (after)
[264.353087] Starting subtest: after
[264.356583] Starting dynamic subtest: rcs0
[264.389859] Dynamic subtest rcs0: SUCCESS (0.033s)
[264.399559] Starting dynamic subtest: bcs0
[264.438265] Dynamic subtest bcs0: SUCCESS (0.048s)
[264.446904] Starting dynamic subtest: vcs0
[264.479476] Dynamic subtest vcs0: SUCCESS (0.041s)
[264.487241] Starting dynamic subtest: vcs1
[264.520874] Dynamic subtest vcs1: SUCCESS (0.040s)
[264.529665] Starting dynamic subtest: vecs0
[264.560726] Dynamic subtest vecs0: SUCCESS (0.039s)
[264.568382] Starting dynamic subtest: ccs0
[264.602889] Dynamic subtest ccs0: SUCCESS (0.041s)
[264.710612] Subtest after: SUCCESS (0.356s)
[264.784434] [043/133] (760s left) api_intel_allocator (default-alignment)
[264.839431] Starting subtest: default-alignment
[264.843259] Subtest default-alignment: SUCCESS (0.004s)
[264.958167] [044/133] (759s left) perf_pmu (all-busy-check-all)
[264.993273] Starting subtest: all-busy-check-all
[266.345352] Subtest all-busy-check-all: SUCCESS (1.343s)
[266.431638] [045/133] (758s left) gem_lmem_swapping (parallel-random-verify)
[266.476343] Subtest parallel-random-verify: SKIP (0.000s)
[266.515684] [046/133] (758s left) kms_atomic_interruptible (legacy-pageflip)
[266.613378] Starting subtest: legacy-pageflip
[266.614248] Starting dynamic subtest: pipe-A-eDP-1
[274.034528] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.419s)
[274.035490] Subtest legacy-pageflip: SUCCESS (7.420s)
[274.858014] [047/133] (750s left) i915_drm_fdinfo (memory-info-active)
[274.901479] Starting subtest: memory-info-active
[274.902388] Starting dynamic subtest: smem0
[277.472315] Dynamic subtest smem0: SUCCESS (2.571s)
[277.474367] Subtest memory-info-active: SUCCESS (2.572s)
[277.541983] [048/133] (747s left) kms_vblank (query-idle-hang)
[277.638226] Starting subtest: query-idle-hang
[277.639098] Starting dynamic subtest: pipe-A-eDP-1
[304.105049] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.461s)
[304.114455] Starting dynamic subtest: pipe-D-eDP-1
[329.057747] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.947s)
[329.058771] Subtest query-idle-hang: SUCCESS (51.412s)
[329.929105] [049/133] (695s left) kms_cursor_crc (cursor-onscreen-128x128)
[330.141377] Starting subtest: cursor-onscreen-128x128
[330.143527] Starting dynamic subtest: pipe-A-eDP-1
[332.272373] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.128s)
[332.309234] Starting dynamic subtest: pipe-D-eDP-1
[335.030688] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.734s)
[335.031585] Subtest cursor-onscreen-128x128: SUCCESS (4.890s)
[335.900927] [050/133] (689s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[336.004510] Starting subtest: x-tiled-64bpp-rotate-0
[337.634115] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.630s)
[337.809281] [051/133] (687s left) kms_dp_linktrain_fallback (dp-fallback)
[337.892865] Starting subtest: dp-fallback
[337.895467] Subtest dp-fallback: SKIP (0.000s)
[337.962836] [052/133] (687s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[338.060875] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[338.062787] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[338.156205] [053/133] (687s left) i915_pm_rps (thresholds)
[338.231562] Starting subtest: thresholds
[338.233302] Subtest thresholds: SKIP (0.001s)
[338.334525] [054/133] (686s left) gem_mmap_gtt (isolation)
[338.393695] Subtest isolation: SKIP (0.000s)
[338.451460] [055/133] (686s left) syncobj_timeline (wait-all-complex)
[338.505735] Starting subtest: wait-all-complex
[338.731530] Subtest wait-all-complex: SUCCESS (0.216s)
[338.796037] [056/133] (686s left) gem_exec_flush (basic-uc-ro-default)
[338.856623] Starting subtest: basic-uc-ro-default
[344.317463] Subtest basic-uc-ro-default: SUCCESS (5.460s)
[344.511915] [057/133] (680s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[344.716114] Starting subtest: cursor-rapid-movement-128x128
[344.719172] Starting dynamic subtest: pipe-A-eDP-1
[345.261575] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.541s)
[345.290077] Starting dynamic subtest: pipe-D-eDP-1
[346.531973] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.248s)
[346.532869] Subtest cursor-rapid-movement-128x128: SUCCESS (1.815s)
[347.362647] [058/133] (678s left) gem_exec_reloc (basic-write-gtt)
[347.428932] Subtest basic-write-gtt: SKIP (0.000s)
[347.481650] [059/133] (677s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[347.570445] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[347.572291] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[347.650911] [060/133] (677s left) gem_exec_reloc (basic-write-wc-noreloc)
[347.703132] Subtest basic-write-wc-noreloc: SKIP (0.000s)
[347.771694] [061/133] (677s left) gem_exec_schedule (fairslice-all)
[347.830706] Starting subtest: fairslice-all
[349.890782] Subtest fairslice-all: SUCCESS (2.061s)
[351.328145] [062/133] (674s left) gem_exec_params (invalid-bsd-ring)
[351.374232] Starting subtest: invalid-bsd-ring
[351.375313] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[351.472550] [063/133] (674s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[351.577640] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[351.579396] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[351.670063] [064/133] (673s left) gem_busy (close-race)
[351.738633] Starting subtest: close-race
[375.336222] Subtest close-race: SUCCESS (23.586s)
[375.680333] [065/133] (649s left) sysfs_timeslice_duration (timeout)
[375.791307] Starting subtest: timeout
[375.792177] Starting dynamic subtest: vecs0
[385.315660] Dynamic subtest vecs0: SUCCESS (9.513s)
[385.326888] Starting dynamic subtest: ccs0
[386.575909] Dynamic subtest ccs0: SUCCESS (1.267s)
[386.588196] Starting dynamic subtest: vcs0
[396.326847] Dynamic subtest vcs0: SUCCESS (9.738s)
[396.336199] Starting dynamic subtest: bcs0
[396.922256] Dynamic subtest bcs0: SUCCESS (0.601s)
[396.933625] Starting dynamic subtest: rcs0
[398.141421] Dynamic subtest rcs0: SUCCESS (1.218s)
[398.151531] Starting dynamic subtest: vcs1
[407.328314] Dynamic subtest vcs1: SUCCESS (9.175s)
[407.329516] Subtest timeout: SUCCESS (31.525s)
[407.393700] [066/133] (618s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[407.802067] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[408.575777] [067/133] (617s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[408.679222] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[409.632970] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: FAIL (0.737s)
[409.666951] [068/133] (616s left) gem_exec_capture (userptr)
[409.726826] Starting subtest: userptr
[410.557857] Subtest userptr: SUCCESS (0.831s)
[410.679748] [069/133] (615s left) gem_busy (busy)
[410.751736] Starting subtest: busy
[410.752943] Starting dynamic subtest: all-engines
[410.808927] Dynamic subtest all-engines: SUCCESS (0.057s)
[410.818149] Starting dynamic subtest: rcs0
[412.332558] Dynamic subtest rcs0: SUCCESS (1.519s)
[412.343027] Starting dynamic subtest: bcs0
[412.379815] Dynamic subtest bcs0: SUCCESS (0.050s)
[412.388473] Starting dynamic subtest: vcs0
[412.419715] Dynamic subtest vcs0: SUCCESS (0.039s)
[412.429060] Starting dynamic subtest: vcs1
[414.316552] Dynamic subtest vcs1: SUCCESS (1.886s)
[414.326982] Starting dynamic subtest: vecs0
[416.364279] Dynamic subtest vecs0: SUCCESS (2.047s)
[416.374170] Starting dynamic subtest: ccs0
[418.349473] Dynamic subtest ccs0: SUCCESS (1.984s)
[418.350552] Subtest busy: SUCCESS (7.589s)
[418.696205] [070/133] (607s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[418.796066] Starting subtest: fbc-rgb101010-draw-blt
[423.419750] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.624s)
[424.611307] [071/133] (601s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[424.697487] Starting subtest: dsc-fractional-bpp-with-bpc
[424.709690] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s)
[424.781226] [072/133] (601s left) gem_exec_params (cliprects-invalid)
[424.825124] Starting subtest: cliprects-invalid
[424.825986] Subtest cliprects-invalid: SUCCESS (0.000s)
[424.910999] [073/133] (601s left) prime_mmap (test_errors)
[424.966473] Starting subtest: test_errors
[424.967382] Starting dynamic subtest: test_errors-smem
[425.068251] Dynamic subtest test_errors-smem: SUCCESS (0.102s)
[425.069596] Subtest test_errors: SUCCESS (0.103s)
[425.172069] [074/133] (600s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[425.258499] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[425.260303] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[425.342640] [075/133] (600s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[425.435884] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[434.104074] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.669s)
[434.212169] [076/133] (591s left) gem_exec_whisper (basic-forked)
[434.274893] Starting subtest: basic-forked
[442.283096] Subtest basic-forked: SUCCESS (7.997s)
[442.453897] [077/133] (583s left) gem_pxp (regular-baseline-src-copy-readible)
[442.572457] Starting subtest: regular-baseline-src-copy-readible
[442.637359] Subtest regular-baseline-src-copy-readible: SUCCESS (0.067s)
[442.740189] [078/133] (583s left) perf (disabled-read-error)
[442.872897] Starting subtest: disabled-read-error
[442.889370] Subtest disabled-read-error: SUCCESS (0.016s)
[442.927789] [079/133] (583s left) gem_mmap_wc (close)
[442.973970] Subtest close: SKIP (0.000s)
[443.037490] [080/133] (583s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[443.142507] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[443.144301] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[443.239399] [081/133] (583s left) kms_properties (connector-properties-atomic)
[443.328469] Starting subtest: connector-properties-atomic
[443.329379] Starting dynamic subtest: pipe-A-eDP-1
[451.023913] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.693s)
[451.032218] Starting dynamic subtest: pipe-None-DP-1
[451.034529] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[451.042777] Starting dynamic subtest: pipe-None-HDMI-A-1
[451.044658] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[451.052699] Starting dynamic subtest: pipe-None-DP-2
[451.054154] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[451.063421] Starting dynamic subtest: pipe-None-HDMI-A-2
[451.065419] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[451.073558] Starting dynamic subtest: pipe-None-DP-3
[451.075379] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[451.083560] Starting dynamic subtest: pipe-None-DP-4
[451.085241] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[451.085998] Subtest connector-properties-atomic: SUCCESS (7.705s)
[451.899435] [082/133] (574s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[451.986731] Starting subtest: psr-rgb101010-draw-render
[459.333793] Subtest psr-rgb101010-draw-render: SUCCESS (7.346s)
[459.444957] [083/133] (566s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[459.506050] Starting subtest: invalid-signal-one-illegal-handle
[459.507038] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[459.604979] [084/133] (566s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[459.709403] Starting subtest: extended-pageflip-modeset-hang-oldfb
[459.710383] Starting dynamic subtest: pipe-A
[467.607242] Dynamic subtest pipe-A: SUCCESS (7.897s)
[467.617413] Starting dynamic subtest: pipe-D
[476.255706] Dynamic subtest pipe-D: SUCCESS (8.646s)
[476.256617] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.547s)
[477.098096] [085/133] (549s left) gem_mmap_gtt (big-bo-tiledy)
[477.146982] Subtest big-bo-tiledY: SKIP (0.000s)
[477.201315] [086/133] (549s left) gem_fence_thrash (bo-write-verify-threaded-y)
[477.228608] Starting subtest: bo-write-verify-threaded-y
[477.244621] Subtest bo-write-verify-threaded-y: SKIP (0.013s)
[477.325698] [087/133] (549s left) perf_pmu (interrupts-sync)
[477.359361] Starting subtest: interrupts-sync
[478.474562] Subtest interrupts-sync: SUCCESS (1.104s)
[478.570504] [088/133] (547s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[478.658703] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[486.011952] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.354s)
[486.141490] [089/133] (540s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[486.239589] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[486.241381] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[486.341480] [090/133] (540s left) gem_ctx_engines (none)
[486.411311] Starting subtest: none
[486.412271] Subtest none: SUCCESS (0.001s)
[486.600215] [091/133] (540s left) gem_spin_batch (legacy-resubmit-new)
[486.660194] Starting subtest: legacy-resubmit-new
[486.661071] Starting dynamic subtest: default
[486.666199] Dynamic subtest default: SUCCESS (0.007s)
[486.675098] Starting dynamic subtest: render
[486.676016] Dynamic subtest render: SUCCESS (0.004s)
[486.684192] Starting dynamic subtest: bsd
[486.685016] Dynamic subtest bsd: SUCCESS (0.006s)
[486.693128] Starting dynamic subtest: bsd1
[486.693905] Dynamic subtest bsd1: SUCCESS (0.005s)
[486.701847] Starting dynamic subtest: bsd2
[486.702849] Dynamic subtest bsd2: SUCCESS (0.003s)
[486.710781] Starting dynamic subtest: blt
[486.711825] Dynamic subtest blt: SUCCESS (0.004s)
[486.719816] Starting dynamic subtest: vebox
[486.720685] Dynamic subtest vebox: SUCCESS (0.004s)
[486.721545] Subtest legacy-resubmit-new: SUCCESS (0.040s)
[488.324473] [092/133] (538s left) api_intel_bb (misplaced-blitter)
[488.376740] Starting subtest: misplaced-blitter
[488.382187] Subtest misplaced-blitter: SUCCESS (0.007s)
[488.503395] [093/133] (538s left) gem_exec_balancer (full-pulse)
[488.549580] Starting subtest: full-pulse
[493.224228] Subtest full-pulse: SUCCESS (4.672s)
[493.516491] [094/133] (533s left) kms_atomic (plane-overlay-legacy)
[493.603088] Starting subtest: plane-overlay-legacy
[493.603953] Starting dynamic subtest: pipe-A-eDP-1
[494.013885] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.410s)
[494.014758] Subtest plane-overlay-legacy: SUCCESS (0.412s)
[494.885827] [095/133] (531s left) kms_plane_scaling (planes-upscale-20x20)
[494.973332] Starting subtest: planes-upscale-20x20
[494.974177] Starting dynamic subtest: pipe-A
[495.035144] Dynamic subtest pipe-A: SUCCESS (0.063s)
[495.045567] Starting dynamic subtest: pipe-B
[496.192889] Dynamic subtest pipe-B: SUCCESS (1.157s)
[496.202942] Starting dynamic subtest: pipe-C
[497.322829] Dynamic subtest pipe-C: SUCCESS (1.127s)
[497.333207] Starting dynamic subtest: pipe-D
[498.440523] Dynamic subtest pipe-D: SUCCESS (1.116s)
[498.441411] Subtest planes-upscale-20x20: SUCCESS (3.468s)
[499.592121] [096/133] (527s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[499.676903] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[506.413496] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.737s)
[506.538368] [097/133] (520s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[506.655446] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[506.656942] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[506.752627] [098/133] (520s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[506.853442] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[506.854452] Starting dynamic subtest: pipe-A-eDP-1
[507.106249] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.242s)
[507.119047] Starting dynamic subtest: pipe-B-eDP-1
[508.409250] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.301s)
[508.418421] Starting dynamic subtest: pipe-C-eDP-1
[509.671886] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.262s)
[509.680699] Starting dynamic subtest: pipe-D-eDP-1
[510.894236] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.222s)
[510.895024] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.031s)
[512.045007] [099/133] (514s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[512.139482] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[512.141393] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[512.209643] [100/133] (514s left) kms_flip (2x-flip-vs-rmfb)
[512.303324] Starting subtest: 2x-flip-vs-rmfb
[512.313796] Subtest 2x-flip-vs-rmfb: SKIP (0.011s)
[512.398889] [101/133] (514s left) kms_cursor_edge_walk (64x64-left-edge)
[512.499168] Starting subtest: 64x64-left-edge
[512.500450] Starting dynamic subtest: pipe-A-eDP-1
[515.920066] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.422s)
[515.929532] Starting dynamic subtest: pipe-D-eDP-1
[519.045720] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.123s)
[519.046561] Subtest 64x64-left-edge: SUCCESS (6.548s)
[519.851641] [102/133] (507s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[519.942906] Starting subtest: fbcpsr-rgb565-draw-blt
[527.092779] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.150s)
[527.214534] [103/133] (499s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[527.297271] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[527.298110] Starting dynamic subtest: pipe-A-eDP-1
[527.305954] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[527.314567] Starting dynamic subtest: pipe-B-eDP-1
[527.322489] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[527.330872] Starting dynamic subtest: pipe-C-eDP-1
[527.338468] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[527.346800] Starting dynamic subtest: pipe-D-eDP-1
[527.353732] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[527.354586] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[529.469395] [104/133] (497s left) gem_exec_schedule (u-semaphore-resolve)
[529.550645] Starting subtest: u-semaphore-resolve
[529.587838] Subtest u-semaphore-resolve: SUCCESS (0.036s)
[529.925111] [105/133] (497s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[529.985837] Starting subtest: etime-multi-wait-for-submit-submitted
[530.093031] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.106s)
[530.167089] [106/133] (496s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[530.226445] Starting subtest: y-tiled-to-vebox-yf-tiled
[530.228381] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[530.405377] [107/133] (496s left) gem_render_linear_blits (basic)
[530.466088] Starting subtest: basic
[530.486397] Subtest basic: SUCCESS (0.021s)
[530.566796] [108/133] (496s left) gem_userptr_blits (sd-probe)
[530.616424] Starting subtest: sd-probe
[530.617326] Subtest sd-probe: SUCCESS (0.000s)
[530.742469] [109/133] (496s left) kms_content_protection (dp-mst-lic-type-1)
[530.873875] Starting subtest: dp-mst-lic-type-1
[530.875745] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[530.993778] [110/133] (496s left) kms_psr (psr-primary-page-flip)
[531.079262] Starting subtest: psr-primary-page-flip
[531.080109] Starting dynamic subtest: eDP-1
[532.781042] Dynamic subtest eDP-1: SUCCESS (1.700s)
[532.781935] Subtest psr-primary-page-flip: SUCCESS (1.701s)
[533.642408] [111/133] (493s left) gem_eio (in-flight-internal-1us)
[533.874091] Starting subtest: in-flight-internal-1us
[535.408882] Subtest in-flight-internal-1us: SUCCESS (1.534s)
[535.534392] [112/133] (491s left) kms_pipe_crc_basic (read-crc)
[535.622428] Starting subtest: read-crc
[535.623401] Starting dynamic subtest: pipe-A-eDP-1
[536.336457] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.713s)
[536.345578] Starting dynamic subtest: pipe-B-eDP-1
[537.729158] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.392s)
[537.739066] Starting dynamic subtest: pipe-C-eDP-1
[539.044870] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.314s)
[539.054351] Starting dynamic subtest: pipe-D-eDP-1
[540.363489] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.317s)
[540.364375] Subtest read-crc: SUCCESS (4.741s)
[541.188416] [113/133] (486s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[541.286574] Starting subtest: pr-overlay-plane-move-continuous-sf
[541.288215] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[541.352981] [114/133] (486s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[541.441735] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[541.442612] Starting dynamic subtest: pipe-A-eDP-1
[541.450935] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[541.469977] Starting dynamic subtest: pipe-B-eDP-1
[541.477790] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[541.486187] Starting dynamic subtest: pipe-C-eDP-1
[541.493952] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[541.502173] Starting dynamic subtest: pipe-D-eDP-1
[541.518209] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[541.520191] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[543.762736] [115/133] (483s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[543.847395] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[543.849214] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[543.936850] [116/133] (483s left) gem_exec_balancer (sliced)
[543.989592] Starting subtest: sliced
[543.992027] Subtest sliced: SKIP (0.000s)
[544.302879] [117/133] (483s left) kms_hdr (static-swap)
[544.386512] Starting subtest: static-swap
[544.389443] Subtest static-swap: SKIP (0.000s)
[544.455494] [118/133] (483s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[544.561606] Starting subtest: 4-tiled-64bpp-rotate-90
[544.587035] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.025s)
[544.712437] [119/133] (482s left) kms_pm_rpm (fences)
[546.435685] Starting subtest: fences
[546.437602] Subtest fences: SKIP (0.000s)
[546.994030] [120/133] (480s left) kms_addfb_basic (bad-pitch-0)
[547.049372] Starting subtest: bad-pitch-0
[547.050339] Subtest bad-pitch-0: SUCCESS (0.000s)
[547.166543] [121/133] (480s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[547.264695] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[547.265691] Starting dynamic subtest: pipe-A-eDP-1
[547.274561] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[547.283750] Starting dynamic subtest: pipe-B-eDP-1
[547.301325] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[547.309972] Starting dynamic subtest: pipe-C-eDP-1
[547.318358] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[547.327149] Starting dynamic subtest: pipe-D-eDP-1
[547.335815] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[547.337436] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[549.563902] [122/133] (478s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[549.611927] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[549.661317] [123/133] (478s left) kms_psr (fbc-psr2-primary-page-flip)
[549.766415] Starting subtest: fbc-psr2-primary-page-flip
[549.767470] Starting dynamic subtest: eDP-1
[549.769114] Dynamic subtest eDP-1: SKIP (0.000s)
[549.770771] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[549.844527] [124/133] (477s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[549.940398] Starting subtest: fbc-psr2-sprite-plane-onoff
[549.941419] Starting dynamic subtest: eDP-1
[549.943490] Dynamic subtest eDP-1: SKIP (0.000s)
[549.945269] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[550.009527] [125/133] (477s left) gem_ctx_persistence (legacy-engines-queued)
[550.065197] Starting subtest: legacy-engines-queued
[550.066054] Starting dynamic subtest: render
[550.135667] Dynamic subtest render: SUCCESS (0.071s)
[550.148530] Starting dynamic subtest: bsd1
[551.305043] Dynamic subtest bsd1: SUCCESS (1.156s)
[551.316098] Starting dynamic subtest: bsd2
[553.288193] Dynamic subtest bsd2: SUCCESS (1.980s)
[553.299744] Starting dynamic subtest: blt
[553.337575] Dynamic subtest blt: SUCCESS (0.056s)
[553.350983] Starting dynamic subtest: vebox
[555.336041] Dynamic subtest vebox: SUCCESS (1.985s)
[555.337357] Subtest legacy-engines-queued: SUCCESS (5.263s)
[555.407823] [126/133] (472s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[555.508133] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[555.508956] Starting dynamic subtest: pipe-A-eDP-1
[555.516706] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[555.525921] Starting dynamic subtest: pipe-B-eDP-1
[555.533703] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[555.542440] Starting dynamic subtest: pipe-C-eDP-1
[555.549818] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[555.558214] Starting dynamic subtest: pipe-D-eDP-1
[555.565470] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[555.566287] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[557.809870] [127/133] (470s left) kms_hdr (bpc-switch-suspend)
[557.908262] Starting subtest: bpc-switch-suspend
[559.003120] Starting dynamic subtest: pipe-A-eDP-1
[578.158208] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.753s)
[578.159008] Subtest bpc-switch-suspend: SUCCESS (6.848s)
[584.354722] [128/133] (449s left) gem_pxp (create-regular-context-2)
[584.475954] Starting subtest: create-regular-context-2
[584.477168] Subtest create-regular-context-2: SUCCESS (0.001s)
[584.582993] [129/133] (449s left) kms_psr (fbc-pr-cursor-plane-onoff)
[584.687692] Starting subtest: fbc-pr-cursor-plane-onoff
[584.689414] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[584.777891] [130/133] (449s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[584.872948] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[584.874620] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[584.950101] [131/133] (449s left) kms_psr (fbc-psr-suspend)
[585.040777] Starting subtest: fbc-psr-suspend
[585.041599] Starting dynamic subtest: eDP-1
[585.043279] Dynamic subtest eDP-1: SKIP (0.000s)
[585.044985] Subtest fbc-psr-suspend: SKIP (0.001s)
[585.113931] [132/133] (449s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[585.195424] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[585.196401] Starting dynamic subtest: pipe-A
[586.482382] Dynamic subtest pipe-A: SUCCESS (1.240s)
[586.495172] Starting dynamic subtest: pipe-B
[588.769150] Dynamic subtest pipe-B: SUCCESS (2.215s)
[588.780257] Starting dynamic subtest: pipe-C
[590.019818] Dynamic subtest pipe-C: SUCCESS (1.216s)
[590.048812] Starting dynamic subtest: pipe-D
[591.284519] Dynamic subtest pipe-D: SUCCESS (1.240s)
[591.285412] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.917s)
[592.508720] [133/133] (441s left) kms_lease (lease-invalid-connector)
[592.602700] Starting subtest: lease-invalid-connector
[592.603546] Starting dynamic subtest: pipe-A-eDP-1
[592.604411] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[592.614439] Starting dynamic subtest: pipe-B-eDP-1
[592.615340] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[592.624852] Starting dynamic subtest: pipe-C-eDP-1
[592.625660] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[592.634993] Starting dynamic subtest: pipe-D-eDP-1
[592.635833] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[592.636579] Subtest lease-invalid-connector: SUCCESS (0.005s)
[592.678581] Closing watchdogs
results: parsing output: 0/ for test: perf_pmu
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: kms_cursor_legacy
results: parsing output: 3/ for test: kms_vrr
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: kms_pm_rpm
results: parsing output: 6/ for test: kms_chamelium_color
results: parsing output: 7/ for test: gem_ctx_isolation
results: parsing output: 8/ for test: perf_pmu
results: parsing output: 9/ for test: gem_exec_alignment
results: parsing output: 10/ for test: kms_selftest
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: kms_flip
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: kms_addfb_basic
results: parsing output: 17/ for test: kms_flip_scaled_crc
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_lmem_swapping
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: gem_exec_fence
results: parsing output: 24/ for test: i915_pm_rc6_residency
results: parsing output: 25/ for test: prime_mmap
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_addfb_basic
results: parsing output: 28/ for test: kms_plane
results: parsing output: 29/ for test: gem_userptr_blits
results: parsing output: 30/ for test: gem_readwrite
results: parsing output: 31/ for test: gem_exec_schedule
results: parsing output: 32/ for test: gen7_exec_parse
results: parsing output: 33/ for test: gem_shrink
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: i915_module_load
results: parsing output: 36/ for test: drm_mm
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_close_race
results: parsing output: 40/ for test: kms_color
results: parsing output: 41/ for test: prime_busy
results: parsing output: 42/ for test: api_intel_allocator
results: parsing output: 43/ for test: perf_pmu
results: parsing output: 44/ for test: gem_lmem_swapping
results: parsing output: 45/ for test: kms_atomic_interruptible
results: parsing output: 46/ for test: i915_drm_fdinfo
results: parsing output: 47/ for test: kms_vblank
results: parsing output: 48/ for test: kms_cursor_crc
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: kms_dp_linktrain_fallback
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: i915_pm_rps
results: parsing output: 53/ for test: gem_mmap_gtt
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: gem_exec_flush
results: parsing output: 56/ for test: kms_cursor_crc
results: parsing output: 57/ for test: gem_exec_reloc
results: parsing output: 58/ for test: kms_flip_scaled_crc
results: parsing output: 59/ for test: gem_exec_reloc
results: parsing output: 60/ for test: gem_exec_schedule
results: parsing output: 61/ for test: gem_exec_params
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_busy
results: parsing output: 64/ for test: sysfs_timeslice_duration
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_exec_capture
results: parsing output: 68/ for test: gem_busy
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_dsc
results: parsing output: 71/ for test: gem_exec_params
results: parsing output: 72/ for test: prime_mmap
results: parsing output: 73/ for test: kms_flip_scaled_crc
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_pxp
results: parsing output: 77/ for test: perf
results: parsing output: 78/ for test: gem_mmap_wc
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_properties
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: kms_busy
results: parsing output: 84/ for test: gem_mmap_gtt
results: parsing output: 85/ for test: gem_fence_thrash
results: parsing output: 86/ for test: perf_pmu
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_ctx_engines
results: parsing output: 90/ for test: gem_spin_batch
results: parsing output: 91/ for test: api_intel_bb
results: parsing output: 92/ for test: gem_exec_balancer
results: parsing output: 93/ for test: kms_atomic
results: parsing output: 94/ for test: kms_plane_scaling
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: kms_plane
results: parsing output: 99/ for test: kms_flip
results: parsing output: 100/ for test: kms_cursor_edge_walk
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: gem_exec_schedule
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: gem_render_copy
results: parsing output: 106/ for test: gem_render_linear_blits
results: parsing output: 107/ for test: gem_userptr_blits
results: parsing output: 108/ for test: kms_content_protection
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: gem_eio
results: parsing output: 111/ for test: kms_pipe_crc_basic
results: parsing output: 112/ for test: kms_psr2_sf
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_exec_balancer
results: parsing output: 116/ for test: kms_hdr
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: kms_pm_rpm
results: parsing output: 119/ for test: kms_addfb_basic
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: kms_pipe_b_c_ivb
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: gem_ctx_persistence
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: kms_hdr
results: parsing output: 127/ for test: gem_pxp
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: kms_psr2_sf
results: parsing output: 130/ for test: kms_psr
results: parsing output: 131/ for test: kms_plane_scaling
results: parsing output: 132/ for test: kms_lease
Done.