[56.082188] Initializing watchdogs
[56.082233]   /dev/watchdog0
[56.096174] [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]
[56.100545] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.102623] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.106313] [001/133] (960s left) perf_pmu (busy-hang)
[56.180913] Starting subtest: busy-hang
[56.183523] Starting dynamic subtest: rcs0
[57.385543] Dynamic subtest rcs0: SUCCESS (1.202s)
[57.395529] Starting dynamic subtest: bcs0
[58.546515] Dynamic subtest bcs0: SUCCESS (1.159s)
[58.556736] Starting dynamic subtest: vcs0
[60.806240] Dynamic subtest vcs0: SUCCESS (2.257s)
[60.814058] Starting dynamic subtest: vcs1
[62.789140] Dynamic subtest vcs1: SUCCESS (1.981s)
[62.799242] Starting dynamic subtest: vecs0
[64.845369] Dynamic subtest vecs0: SUCCESS (2.053s)
[64.856311] Starting dynamic subtest: ccs0
[66.018963] Dynamic subtest ccs0: SUCCESS (1.169s)
[66.021118] Subtest busy-hang: SUCCESS (9.825s)
[66.111521] [002/133] (950s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[66.168746] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[66.275467] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.105s)
[66.348063] [003/133] (950s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[66.478980] Starting subtest: cursorA-vs-flipA-toggle
[77.679571] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.194s)
[78.514426] [004/133] (938s left) kms_vrr (negative-basic)
[78.620179] Starting subtest: negative-basic
[78.627230] Starting dynamic subtest: pipe-A-eDP-1
[84.539322] Dynamic subtest pipe-A-eDP-1: FAIL (5.437s)
[84.541285] Subtest negative-basic: FAIL (5.744s)
[85.162334] [005/133] (931s left) kms_flip (2x-flip-vs-wf_vblank)
[85.263250] Starting subtest: 2x-flip-vs-wf_vblank
[85.271394] Subtest 2x-flip-vs-wf_vblank: SKIP (0.010s)
[85.374881] [006/133] (931s left) kms_pm_rpm (legacy-planes-dpms)
[87.412355] Starting subtest: legacy-planes-dpms
[87.414718] Starting dynamic subtest: plane-65
[96.023420] Dynamic subtest plane-65: SUCCESS (8.612s)
[96.034071] Starting dynamic subtest: plane-95
[104.638322] Dynamic subtest plane-95: SUCCESS (8.613s)
[104.648714] Starting dynamic subtest: plane-125
[112.978887] Dynamic subtest plane-125: SUCCESS (8.339s)
[112.994627] Starting dynamic subtest: plane-135
[121.301654] Dynamic subtest plane-135: SUCCESS (8.320s)
[121.304705] Subtest legacy-planes-dpms: SUCCESS (33.889s)
[121.688803] [007/133] (895s left) kms_chamelium_color (ctm-red-to-blue)
[121.776833] Subtest ctm-red-to-blue: SKIP (0.000s)
[121.823273] [008/133] (895s left) gem_ctx_isolation (nonpriv)
[121.884969] Starting subtest: nonpriv
[121.887368] Starting dynamic subtest: rcs0
[122.127109] Dynamic subtest rcs0: SUCCESS (0.242s)
[122.137988] Starting dynamic subtest: bcs0
[122.401909] Dynamic subtest bcs0: SUCCESS (0.274s)
[122.410783] Starting dynamic subtest: vcs0
[122.663065] Dynamic subtest vcs0: SUCCESS (0.261s)
[122.673257] Starting dynamic subtest: vcs1
[124.540408] Dynamic subtest vcs1: SUCCESS (1.876s)
[124.550207] Starting dynamic subtest: vecs0
[126.512455] Dynamic subtest vecs0: SUCCESS (1.971s)
[126.523240] Starting dynamic subtest: ccs0
[128.586327] Dynamic subtest ccs0: SUCCESS (2.073s)
[128.588754] Subtest nonpriv: SUCCESS (6.701s)
[128.816737] [009/133] (888s left) perf_pmu (frequency)
[128.872664] Starting subtest: frequency
[128.877773] Starting dynamic subtest: gt0
[131.029021] Dynamic subtest gt0: SUCCESS (2.146s)
[131.039058] Starting dynamic subtest: idle-gt0
[131.533895] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[131.544617] Starting dynamic subtest: gt1
[136.240227] Dynamic subtest gt1: SUCCESS (4.703s)
[136.249634] Starting dynamic subtest: idle-gt1
[136.763210] Dynamic subtest idle-gt1: SUCCESS (0.523s)
[136.765931] Subtest frequency: SUCCESS (7.891s)
[136.852373] [010/133] (880s left) gem_exec_alignment (forked)
[136.920193] Starting subtest: forked
[175.475739] Subtest forked: SUCCESS (38.555s)
[175.588856] [011/133] (841s left) kms_selftest (drm_format)
[175.676666] Starting subtest: drm_format
[175.748907] Starting dynamic subtest: drm_test_format_block_width_invalid
[175.860062] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.111s)
[175.877109] Starting dynamic subtest: drm_test_format_block_width_one_plane
[175.957242] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.098s)
[175.974990] Starting dynamic subtest: drm_test_format_block_width_two_plane
[176.074440] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.116s)
[176.091590] Starting dynamic subtest: drm_test_format_block_width_three_plane
[176.168080] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.092s)
[176.184727] Starting dynamic subtest: drm_test_format_block_width_tiled
[176.265058] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.098s)
[176.281908] Starting dynamic subtest: drm_test_format_block_height_invalid
[176.373261] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.108s)
[176.382041] Starting dynamic subtest: drm_test_format_block_height_one_plane
[176.474591] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.101s)
[176.483024] Starting dynamic subtest: drm_test_format_block_height_two_plane
[176.565365] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.090s)
[176.574165] Starting dynamic subtest: drm_test_format_block_height_three_plane
[176.678562] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.113s)
[176.688066] Starting dynamic subtest: drm_test_format_block_height_tiled
[176.777466] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.099s)
[176.787258] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[176.861449] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.084s)
[176.871415] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[176.943273] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.081s)
[176.952320] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[177.029323] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.085s)
[177.038305] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[177.118111] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.089s)
[177.126837] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[177.207397] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.088s)
[177.216955] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[177.296396] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.089s)
[177.305484] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[177.379140] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.082s)
[177.388969] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[177.463154] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.083s)
[177.464967] Subtest drm_format: SUCCESS (1.785s)
[177.638491] [012/133] (839s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[177.759386] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[177.762794] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[177.854279] [013/133] (839s left) syncobj_wait (multi-wait-all-submitted)
[177.903976] Starting subtest: multi-wait-all-submitted
[178.009799] Subtest multi-wait-all-submitted: SUCCESS (0.103s)
[178.082837] [014/133] (839s left) kms_flip (bo-too-big-interruptible)
[178.178684] Starting subtest: bo-too-big-interruptible
[178.180947] Starting dynamic subtest: A-eDP1
[179.516873] Dynamic subtest A-eDP1: SUCCESS (1.337s)
[179.527793] Starting dynamic subtest: B-eDP1
[180.837652] Dynamic subtest B-eDP1: SUCCESS (1.319s)
[180.848221] Starting dynamic subtest: C-eDP1
[182.088868] Dynamic subtest C-eDP1: SUCCESS (1.249s)
[182.105149] Starting dynamic subtest: D-eDP1
[183.414295] Dynamic subtest D-eDP1: SUCCESS (1.324s)
[183.419262] Subtest bo-too-big-interruptible: SUCCESS (5.241s)
[184.624375] [015/133] (832s left) kms_psr (psr2-sprite-plane-move)
[184.718875] Starting subtest: psr2-sprite-plane-move
[184.721103] Starting dynamic subtest: eDP-1
[186.445085] Dynamic subtest eDP-1: SUCCESS (1.726s)
[186.447381] Subtest psr2-sprite-plane-move: SUCCESS (1.727s)
[187.277455] [016/133] (829s left) syncobj_wait (reset-signaled)
[187.330202] Starting subtest: reset-signaled
[187.332715] Subtest reset-signaled: SUCCESS (0.001s)
[187.439260] [017/133] (829s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[187.544727] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[187.652596] [018/133] (829s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[187.750635] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[187.754838] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[187.826295] [019/133] (829s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[187.935440] Starting subtest: y-tiled-16bpp-rotate-270
[187.939823] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[188.033874] [020/133] (829s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[188.134621] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[188.138638] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[188.229107] [021/133] (829s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[188.322170] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[188.325497] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[188.406115] [022/133] (829s left) gem_lmem_swapping (heavy-verify-multi)
[188.451921] Subtest heavy-verify-multi: SKIP (0.000s)
[188.494505] [023/133] (829s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[188.597701] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[189.322582] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.726s)
[189.485202] [024/133] (828s left) gem_exec_fence (syncobj-timeline-chain-engines)
[190.037602] Starting subtest: syncobj-timeline-chain-engines
[190.151630] Subtest syncobj-timeline-chain-engines: SUCCESS (0.114s)
[191.392372] [FACT gem_exec_fence (syncobj-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[191.395456] [025/133] (826s left) i915_pm_rc6_residency (rc6-accuracy)
[191.458257] Starting subtest: rc6-accuracy
[191.460548] Starting dynamic subtest: gt0
[194.631266] Dynamic subtest gt0: SUCCESS (3.170s)
[194.641743] Starting dynamic subtest: gt1
[197.800913] Dynamic subtest gt1: SUCCESS (3.168s)
[197.803742] Subtest rc6-accuracy: SUCCESS (6.341s)
[197.873270] [026/133] (819s left) prime_mmap (test_userptr)
[197.937106] Starting subtest: test_userptr
[197.939506] Starting dynamic subtest: test_userptr-smem
[197.941711] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[197.943925] Subtest test_userptr: SUCCESS (0.001s)
[198.071113] [027/133] (819s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[198.177343] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[198.181446] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[198.278910] [028/133] (819s left) kms_addfb_basic (legacy-format)
[198.336843] Starting subtest: legacy-format
[198.363409] Subtest legacy-format: SUCCESS (0.025s)
[198.518429] [029/133] (819s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[198.614062] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[198.640047] Starting dynamic subtest: pipe-A-plane-0
[199.095585] Dynamic subtest pipe-A-plane-0: SUCCESS (0.455s)
[199.109696] Starting dynamic subtest: pipe-A-plane-3
[199.361942] Dynamic subtest pipe-A-plane-3: SUCCESS (0.265s)
[199.370644] Starting dynamic subtest: pipe-A-plane-5
[199.373698] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[200.471068] Starting dynamic subtest: pipe-B-plane-0
[200.896438] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[200.906624] Starting dynamic subtest: pipe-B-plane-3
[201.152878] Dynamic subtest pipe-B-plane-3: SUCCESS (0.254s)
[201.162283] Starting dynamic subtest: pipe-B-plane-5
[201.166705] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[201.471303] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.857s)
[202.347092] [030/133] (815s left) gem_userptr_blits (unsync-unmap-after-close)
[202.414135] Subtest unsync-unmap-after-close: SKIP (0.000s)
[202.522442] [031/133] (815s left) gem_readwrite (new-obj)
[202.580209] Subtest new-obj: SKIP (0.000s)
[202.651822] [032/133] (815s left) gem_exec_schedule (preempt-engines)
[202.723788] Starting subtest: preempt-engines
[202.726103] Starting dynamic subtest: rcs0
[204.986686] Dynamic subtest rcs0: SUCCESS (2.268s)
[205.002449] Starting dynamic subtest: bcs0
[207.344241] Dynamic subtest bcs0: SUCCESS (2.303s)
[207.356587] Starting dynamic subtest: vcs0
[209.632623] Dynamic subtest vcs0: SUCCESS (2.287s)
[209.644372] Starting dynamic subtest: vcs1
[211.921690] Dynamic subtest vcs1: SUCCESS (2.288s)
[211.933254] Starting dynamic subtest: vecs0
[214.202469] Dynamic subtest vecs0: SUCCESS (2.279s)
[214.215540] Starting dynamic subtest: ccs0
[216.515219] Dynamic subtest ccs0: SUCCESS (2.311s)
[216.518065] Subtest preempt-engines: SUCCESS (13.745s)
[216.823685] [033/133] (801s left) gen7_exec_parse (basic-offset)
[216.888627] Subtest basic-offset: SKIP (0.000s)
[216.964184] [034/133] (801s left) gem_shrink (reclaim)
[217.017532] Starting subtest: reclaim
[219.497088] Subtest reclaim: SUCCESS (2.428s)
[219.558424] [035/133] (798s left) syncobj_timeline (reset-unsignaled)
[219.626681] Starting subtest: reset-unsignaled
[219.629190] Subtest reset-unsignaled: SUCCESS (0.000s)
[219.730274] [036/133] (798s left) i915_module_load (reload-no-display)
[219.764754] Starting subtest: reload-no-display
[225.597076] Subtest reload-no-display: SUCCESS (5.831s)
[225.626777] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[225.627501] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[225.630646] [037/133] (792s left) drm_mm (drm_mm)
[225.687386] Starting subtest: drm_mm
[225.693549] Starting dynamic subtest: drm_test_mm_init
[225.772894] Dynamic subtest drm_test_mm_init: SUCCESS (0.080s)
[225.780707] Starting dynamic subtest: drm_test_mm_debug
[225.859776] Dynamic subtest drm_test_mm_debug: SUCCESS (0.085s)
[225.868255] Starting dynamic subtest: drm_test_mm_align32
[225.947828] Dynamic subtest drm_test_mm_align32: SUCCESS (0.088s)
[225.955724] Starting dynamic subtest: drm_test_mm_align64
[226.030896] Dynamic subtest drm_test_mm_align64: SUCCESS (0.083s)
[226.039831] Starting dynamic subtest: drm_test_mm_lowest
[226.118088] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.084s)
[226.124427] Starting dynamic subtest: drm_test_mm_highest
[226.200700] Dynamic subtest drm_test_mm_highest: SUCCESS (0.082s)
[226.203052] Subtest drm_mm: SUCCESS (0.514s)
[226.305357] [038/133] (791s left) kms_flip (2x-blocking-absolute-wf_vblank)
[227.823739] Starting subtest: 2x-blocking-absolute-wf_vblank
[227.834913] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.012s)
[227.941256] [FACT kms_flip (2x-blocking-absolute-wf_vblank)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[227.942450] [FACT kms_flip (2x-blocking-absolute-wf_vblank)] new: kernel.kmod_is_loaded.i915: true
[227.946146] [039/133] (790s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[228.057283] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[232.682235] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.628s)
[233.900223] [040/133] (784s left) gem_close_race (basic-process)
[233.973019] Starting subtest: basic-process
[234.028764] Subtest basic-process: SUCCESS (0.058s)
[234.215069] [041/133] (784s left) kms_color (ctm-0-75)
[234.309590] Starting subtest: ctm-0-75
[234.311954] Starting dynamic subtest: pipe-A-eDP-1
[239.237236] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.929s)
[239.246935] Starting dynamic subtest: pipe-B-eDP-1
[244.864796] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.626s)
[244.873224] Starting dynamic subtest: pipe-C-eDP-1
[250.163554] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.299s)
[250.173207] Starting dynamic subtest: pipe-D-eDP-1
[255.520660] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.353s)
[255.522552] Subtest ctm-0-75: SUCCESS (21.210s)
[256.369283] [042/133] (761s left) prime_busy (after)
[256.429160] Starting subtest: after
[256.434140] Starting dynamic subtest: rcs0
[256.469068] Dynamic subtest rcs0: SUCCESS (0.036s)
[256.478401] Starting dynamic subtest: bcs0
[256.510908] Dynamic subtest bcs0: SUCCESS (0.041s)
[256.519662] Starting dynamic subtest: vcs0
[256.551578] Dynamic subtest vcs0: SUCCESS (0.040s)
[256.560311] Starting dynamic subtest: vcs1
[256.593657] Dynamic subtest vcs1: SUCCESS (0.041s)
[256.602440] Starting dynamic subtest: vecs0
[256.635206] Dynamic subtest vecs0: SUCCESS (0.041s)
[256.643672] Starting dynamic subtest: ccs0
[256.675469] Dynamic subtest ccs0: SUCCESS (0.040s)
[256.783310] Subtest after: SUCCESS (0.352s)
[256.863145] [043/133] (761s left) api_intel_allocator (default-alignment)
[256.931027] Starting subtest: default-alignment
[256.933589] Subtest default-alignment: SUCCESS (0.004s)
[257.045615] [044/133] (761s left) perf_pmu (all-busy-check-all)
[257.094554] Starting subtest: all-busy-check-all
[258.312254] Subtest all-busy-check-all: SUCCESS (1.216s)
[258.415393] [045/133] (760s left) gem_lmem_swapping (parallel-random-verify)
[258.460228] Subtest parallel-random-verify: SKIP (0.000s)
[258.501625] [046/133] (759s left) kms_atomic_interruptible (legacy-pageflip)
[258.596024] Starting subtest: legacy-pageflip
[258.598261] Starting dynamic subtest: pipe-A-eDP-1
[265.973079] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.376s)
[265.975340] Subtest legacy-pageflip: SUCCESS (7.377s)
[266.859251] [047/133] (751s left) i915_drm_fdinfo (memory-info-active)
[266.906527] Starting subtest: memory-info-active
[266.909047] Starting dynamic subtest: smem0
[269.633235] Dynamic subtest smem0: SUCCESS (2.730s)
[269.635329] Subtest memory-info-active: SUCCESS (2.730s)
[269.705972] [048/133] (748s left) kms_vblank (query-idle-hang)
[269.816169] Starting subtest: query-idle-hang
[269.818083] Starting dynamic subtest: pipe-A-eDP-1
[296.080548] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.259s)
[296.094622] Starting dynamic subtest: pipe-D-eDP-1
[311.057911] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.975s)
[311.060297] Subtest query-idle-hang: SUCCESS (41.239s)
[311.905868] [049/133] (706s left) kms_cursor_crc (cursor-onscreen-128x128)
[312.129588] Starting subtest: cursor-onscreen-128x128
[312.131913] Starting dynamic subtest: pipe-A-eDP-1
[314.228830] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.097s)
[314.256811] Starting dynamic subtest: pipe-D-eDP-1
[316.969111] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.718s)
[316.971301] Subtest cursor-onscreen-128x128: SUCCESS (4.839s)
[317.784590] [050/133] (700s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[317.894184] Starting subtest: x-tiled-64bpp-rotate-0
[319.350752] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.457s)
[319.528051] [051/133] (699s left) kms_dp_linktrain_fallback (dp-fallback)
[319.621139] Starting subtest: dp-fallback
[319.627742] Subtest dp-fallback: SKIP (0.000s)
[319.694267] [052/133] (699s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[319.790063] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[319.793465] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[319.886107] [053/133] (698s left) i915_pm_rps (thresholds)
[319.951388] Starting subtest: thresholds
[319.954863] Subtest thresholds: SKIP (0.001s)
[320.044936] [054/133] (698s left) gem_mmap_gtt (isolation)
[320.100791] Subtest isolation: SKIP (0.000s)
[320.168369] [055/133] (698s left) syncobj_timeline (wait-all-complex)
[320.219116] Starting subtest: wait-all-complex
[320.434479] Subtest wait-all-complex: SUCCESS (0.214s)
[320.519459] [056/133] (698s left) gem_exec_flush (basic-uc-ro-default)
[320.581692] Starting subtest: basic-uc-ro-default
[326.067572] Subtest basic-uc-ro-default: SUCCESS (5.453s)
[326.220691] [057/133] (692s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[326.448386] Starting subtest: cursor-rapid-movement-128x128
[326.450650] Starting dynamic subtest: pipe-A-eDP-1
[326.995515] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.543s)
[327.021469] Starting dynamic subtest: pipe-D-eDP-1
[328.196835] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.183s)
[328.199252] Subtest cursor-rapid-movement-128x128: SUCCESS (1.751s)
[329.057376] [058/133] (689s left) gem_exec_reloc (basic-write-gtt)
[329.109888] Subtest basic-write-gtt: SKIP (0.000s)
[329.183805] [059/133] (689s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[329.285278] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[329.289618] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[329.365997] [060/133] (689s left) gem_exec_reloc (basic-write-wc-noreloc)
[329.426688] Subtest basic-write-wc-noreloc: SKIP (0.000s)
[329.503655] [061/133] (689s left) gem_exec_schedule (fairslice-all)
[329.572550] Starting subtest: fairslice-all
[331.625645] Subtest fairslice-all: SUCCESS (2.061s)
[333.394349] [062/133] (685s left) gem_exec_params (invalid-bsd-ring)
[333.450538] Starting subtest: invalid-bsd-ring
[333.452782] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[333.562496] [063/133] (685s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[333.656597] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[333.660976] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[333.768508] [064/133] (685s left) gem_busy (close-race)
[333.828325] Starting subtest: close-race
[357.317532] Subtest close-race: SUCCESS (23.487s)
[357.696136] [065/133] (661s left) sysfs_timeslice_duration (timeout)
[357.801056] Starting subtest: timeout
[357.803486] Starting dynamic subtest: vecs0
[367.295227] Dynamic subtest vecs0: SUCCESS (9.490s)
[367.307302] Starting dynamic subtest: ccs0
[368.559966] Dynamic subtest ccs0: SUCCESS (1.264s)
[368.570164] Starting dynamic subtest: vcs0
[378.303864] Dynamic subtest vcs0: SUCCESS (9.740s)
[378.316273] Starting dynamic subtest: bcs0
[378.947717] Dynamic subtest bcs0: SUCCESS (0.642s)
[378.957635] Starting dynamic subtest: rcs0
[380.258884] Dynamic subtest rcs0: SUCCESS (1.311s)
[380.273653] Starting dynamic subtest: vcs1
[390.275150] Dynamic subtest vcs1: SUCCESS (10.013s)
[390.277779] Subtest timeout: SUCCESS (32.474s)
[390.358926] [066/133] (629s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[390.754609] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[391.554939] [067/133] (627s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[391.671131] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[392.663107] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.992s)
[392.776546] [068/133] (626s left) gem_exec_capture (userptr)
[392.844408] Starting subtest: userptr
[393.673278] Subtest userptr: SUCCESS (0.828s)
[393.795396] [069/133] (625s left) gem_busy (busy)
[393.853179] Starting subtest: busy
[393.855567] Starting dynamic subtest: all-engines
[393.888066] Dynamic subtest all-engines: SUCCESS (0.035s)
[393.898921] Starting dynamic subtest: rcs0
[395.276143] Dynamic subtest rcs0: SUCCESS (1.386s)
[395.287478] Starting dynamic subtest: bcs0
[395.317633] Dynamic subtest bcs0: SUCCESS (0.039s)
[395.327263] Starting dynamic subtest: vcs0
[395.357408] Dynamic subtest vcs0: SUCCESS (0.039s)
[395.367441] Starting dynamic subtest: vcs1
[397.323093] Dynamic subtest vcs1: SUCCESS (1.962s)
[397.333249] Starting dynamic subtest: vecs0
[399.359821] Dynamic subtest vecs0: SUCCESS (1.983s)
[399.371158] Starting dynamic subtest: ccs0
[401.291953] Dynamic subtest ccs0: SUCCESS (1.983s)
[401.294062] Subtest busy: SUCCESS (7.437s)
[401.659088] [070/133] (617s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[401.768385] Starting subtest: fbc-rgb101010-draw-blt
[406.388692] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.621s)
[407.571412] [071/133] (612s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[407.660986] Starting subtest: dsc-fractional-bpp-with-bpc
[407.690790] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.002s)
[407.739225] [072/133] (611s left) gem_exec_params (cliprects-invalid)
[407.794465] Starting subtest: cliprects-invalid
[407.796817] Subtest cliprects-invalid: SUCCESS (0.000s)
[407.914982] [073/133] (611s left) prime_mmap (test_errors)
[407.979490] Starting subtest: test_errors
[407.981770] Starting dynamic subtest: test_errors-smem
[408.074744] Dynamic subtest test_errors-smem: SUCCESS (0.096s)
[408.077705] Subtest test_errors: SUCCESS (0.096s)
[408.166851] [074/133] (611s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[408.268258] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[408.272223] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[408.340762] [075/133] (611s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[408.429563] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[416.982293] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.556s)
[417.086655] [076/133] (602s left) gem_exec_whisper (basic-forked)
[417.145291] Starting subtest: basic-forked
[424.447680] Subtest basic-forked: SUCCESS (7.304s)
[424.642762] [077/133] (595s left) gem_pxp (regular-baseline-src-copy-readible)
[424.774676] Starting subtest: regular-baseline-src-copy-readible
[424.834557] Subtest regular-baseline-src-copy-readible: SUCCESS (0.063s)
[424.961878] [078/133] (594s left) perf (disabled-read-error)
[425.100967] Starting subtest: disabled-read-error
[425.117394] Subtest disabled-read-error: SUCCESS (0.018s)
[425.157832] [079/133] (594s left) gem_mmap_wc (close)
[425.212547] Subtest close: SKIP (0.000s)
[425.268343] [080/133] (594s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[425.375570] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[425.379992] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[425.482883] [081/133] (594s left) kms_properties (connector-properties-atomic)
[425.577686] Starting subtest: connector-properties-atomic
[425.579350] Starting dynamic subtest: pipe-A-eDP-1
[433.374722] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.795s)
[433.384678] Starting dynamic subtest: pipe-None-DP-1
[433.388812] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[433.397315] Starting dynamic subtest: pipe-None-HDMI-A-1
[433.401425] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[433.409851] Starting dynamic subtest: pipe-None-DP-2
[433.414182] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[433.422671] Starting dynamic subtest: pipe-None-HDMI-A-2
[433.427054] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[433.435705] Starting dynamic subtest: pipe-None-DP-3
[433.440309] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[433.451915] Starting dynamic subtest: pipe-None-DP-4
[433.456827] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[433.459138] Subtest connector-properties-atomic: SUCCESS (7.807s)
[434.244812] [082/133] (585s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[434.350555] Starting subtest: psr-rgb101010-draw-render
[441.652413] Subtest psr-rgb101010-draw-render: SUCCESS (7.306s)
[441.775752] [083/133] (578s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[441.831570] Starting subtest: invalid-signal-one-illegal-handle
[441.833693] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[441.938580] [084/133] (578s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[442.030056] Starting subtest: extended-pageflip-modeset-hang-oldfb
[442.032227] Starting dynamic subtest: pipe-A
[449.935660] Dynamic subtest pipe-A: SUCCESS (7.904s)
[449.945644] Starting dynamic subtest: pipe-D
[458.550682] Dynamic subtest pipe-D: SUCCESS (8.614s)
[458.553071] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.523s)
[459.413552] [085/133] (560s left) gem_mmap_gtt (big-bo-tiledy)
[459.473391] Subtest big-bo-tiledY: SKIP (0.000s)
[459.540417] [086/133] (560s left) gem_fence_thrash (bo-write-verify-threaded-y)
[459.578402] Starting subtest: bo-write-verify-threaded-y
[459.599067] Subtest bo-write-verify-threaded-y: SKIP (0.019s)
[459.666786] [087/133] (560s left) perf_pmu (interrupts-sync)
[459.702827] Starting subtest: interrupts-sync
[460.810066] Subtest interrupts-sync: SUCCESS (1.106s)
[460.931917] [088/133] (559s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[461.029896] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[468.287938] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.261s)
[468.458994] [089/133] (551s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[468.556250] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[468.560237] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[468.657888] [090/133] (551s left) gem_ctx_engines (none)
[468.726484] Starting subtest: none
[468.728822] Subtest none: SUCCESS (0.001s)
[468.911776] [091/133] (551s left) gem_spin_batch (legacy-resubmit-new)
[468.983464] Starting subtest: legacy-resubmit-new
[468.985392] Starting dynamic subtest: default
[468.990858] Dynamic subtest default: SUCCESS (0.007s)
[469.001335] Starting dynamic subtest: render
[469.003544] Dynamic subtest render: SUCCESS (0.003s)
[469.013255] Starting dynamic subtest: bsd
[469.015558] Dynamic subtest bsd: SUCCESS (0.004s)
[469.024774] Starting dynamic subtest: bsd1
[469.026692] Dynamic subtest bsd1: SUCCESS (0.005s)
[469.035476] Starting dynamic subtest: bsd2
[469.037391] Dynamic subtest bsd2: SUCCESS (0.002s)
[469.045807] Starting dynamic subtest: blt
[469.047682] Dynamic subtest blt: SUCCESS (0.004s)
[469.056065] Starting dynamic subtest: vebox
[469.057888] Dynamic subtest vebox: SUCCESS (0.008s)
[469.059714] Subtest legacy-resubmit-new: SUCCESS (0.039s)
[470.318553] [092/133] (550s left) api_intel_bb (misplaced-blitter)
[470.382837] Starting subtest: misplaced-blitter
[470.390644] Subtest misplaced-blitter: SUCCESS (0.008s)
[470.523472] [093/133] (549s left) gem_exec_balancer (full-pulse)
[470.596663] Starting subtest: full-pulse
[475.140920] Subtest full-pulse: SUCCESS (4.544s)
[475.455953] [094/133] (545s left) kms_atomic (plane-overlay-legacy)
[475.546047] Starting subtest: plane-overlay-legacy
[475.548301] Starting dynamic subtest: pipe-A-eDP-1
[475.975330] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.431s)
[475.977630] Subtest plane-overlay-legacy: SUCCESS (0.432s)
[476.852294] [095/133] (543s left) kms_plane_scaling (planes-upscale-20x20)
[476.952295] Starting subtest: planes-upscale-20x20
[476.954656] Starting dynamic subtest: pipe-A
[477.012116] Dynamic subtest pipe-A: SUCCESS (0.062s)
[477.023228] Starting dynamic subtest: pipe-B
[478.188274] Dynamic subtest pipe-B: SUCCESS (1.175s)
[478.198696] Starting dynamic subtest: pipe-C
[479.310072] Dynamic subtest pipe-C: SUCCESS (1.120s)
[479.319305] Starting dynamic subtest: pipe-D
[480.438529] Dynamic subtest pipe-D: SUCCESS (1.128s)
[480.440917] Subtest planes-upscale-20x20: SUCCESS (3.489s)
[481.599240] [096/133] (539s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[481.709675] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[488.294196] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.586s)
[488.420838] [097/133] (532s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[488.505450] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[488.509800] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[488.604836] [098/133] (532s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[488.699253] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[488.701534] Starting dynamic subtest: pipe-A-eDP-1
[488.948377] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.220s)
[488.959791] Starting dynamic subtest: pipe-B-eDP-1
[490.214977] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.261s)
[490.226096] Starting dynamic subtest: pipe-C-eDP-1
[491.411330] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.196s)
[491.423744] Starting dynamic subtest: pipe-D-eDP-1
[492.643436] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.233s)
[492.645733] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.916s)
[493.874413] [099/133] (526s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[493.991359] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[493.995647] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[494.064863] [100/133] (526s left) kms_flip (2x-flip-vs-rmfb)
[494.154536] Starting subtest: 2x-flip-vs-rmfb
[494.162560] Subtest 2x-flip-vs-rmfb: SKIP (0.010s)
[494.245986] [101/133] (526s left) kms_cursor_edge_walk (64x64-left-edge)
[494.342977] Starting subtest: 64x64-left-edge
[494.345233] Starting dynamic subtest: pipe-A-eDP-1
[497.824865] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.481s)
[497.834138] Starting dynamic subtest: pipe-D-eDP-1
[500.950980] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.126s)
[500.953284] Subtest 64x64-left-edge: SUCCESS (6.610s)
[501.756172] [102/133] (519s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[501.865489] Starting subtest: fbcpsr-rgb565-draw-blt
[508.888447] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.026s)
[509.023022] [103/133] (511s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[509.113252] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[509.115538] Starting dynamic subtest: pipe-A-eDP-1
[509.135194] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[509.145762] Starting dynamic subtest: pipe-B-eDP-1
[509.164557] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[509.172820] Starting dynamic subtest: pipe-C-eDP-1
[509.191809] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[509.200424] Starting dynamic subtest: pipe-D-eDP-1
[509.219772] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[509.221665] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[511.272188] [104/133] (509s left) gem_exec_schedule (u-semaphore-resolve)
[511.345530] Starting subtest: u-semaphore-resolve
[511.388446] Subtest u-semaphore-resolve: SUCCESS (0.050s)
[511.717756] [105/133] (509s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[511.773737] Starting subtest: etime-multi-wait-for-submit-submitted
[511.881568] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.108s)
[511.959644] [106/133] (509s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[512.019222] Starting subtest: y-tiled-to-vebox-yf-tiled
[512.023768] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[512.206431] [107/133] (508s left) gem_render_linear_blits (basic)
[512.262369] Starting subtest: basic
[512.284602] Subtest basic: SUCCESS (0.022s)
[512.368824] [108/133] (508s left) gem_userptr_blits (sd-probe)
[512.429221] Starting subtest: sd-probe
[512.431349] Subtest sd-probe: SUCCESS (0.000s)
[512.556611] [109/133] (508s left) kms_content_protection (dp-mst-lic-type-1)
[512.723465] Starting subtest: dp-mst-lic-type-1
[512.727659] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[512.846165] [110/133] (508s left) kms_psr (psr-primary-page-flip)
[512.940581] Starting subtest: psr-primary-page-flip
[512.942940] Starting dynamic subtest: eDP-1
[514.670477] Dynamic subtest eDP-1: SUCCESS (1.729s)
[514.672688] Subtest psr-primary-page-flip: SUCCESS (1.729s)
[515.519432] [111/133] (505s left) gem_eio (in-flight-internal-1us)
[515.738547] Starting subtest: in-flight-internal-1us
[517.400225] Subtest in-flight-internal-1us: SUCCESS (1.661s)
[517.532899] [112/133] (503s left) kms_pipe_crc_basic (read-crc)
[517.626253] Starting subtest: read-crc
[517.628549] Starting dynamic subtest: pipe-A-eDP-1
[518.323195] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.699s)
[518.334534] Starting dynamic subtest: pipe-B-eDP-1
[519.704355] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.377s)
[519.714327] Starting dynamic subtest: pipe-C-eDP-1
[520.987267] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.282s)
[520.997342] Starting dynamic subtest: pipe-D-eDP-1
[522.335637] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.347s)
[522.337846] Subtest read-crc: SUCCESS (4.711s)
[523.162817] [113/133] (498s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[523.262612] Starting subtest: pr-overlay-plane-move-continuous-sf
[523.266652] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[523.335116] [114/133] (498s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[523.420207] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[523.422812] Starting dynamic subtest: pipe-A-eDP-1
[523.445222] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[523.455899] Starting dynamic subtest: pipe-B-eDP-1
[523.476906] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[523.489234] Starting dynamic subtest: pipe-C-eDP-1
[523.510304] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[523.520194] Starting dynamic subtest: pipe-D-eDP-1
[523.541528] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[523.545860] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[525.718124] [115/133] (495s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[525.814773] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[525.818940] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[525.909740] [116/133] (495s left) gem_exec_balancer (sliced)
[525.965076] Starting subtest: sliced
[525.969651] Subtest sliced: SKIP (0.000s)
[526.268708] [117/133] (495s left) kms_hdr (static-swap)
[526.356155] Starting subtest: static-swap
[526.362832] Subtest static-swap: SKIP (0.000s)
[526.431483] [118/133] (495s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[526.531881] Starting subtest: 4-tiled-64bpp-rotate-90
[526.550867] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s)
[526.674673] [119/133] (494s left) kms_pm_rpm (fences)
[528.503481] Starting subtest: fences
[528.508568] Subtest fences: SKIP (0.000s)
[528.965794] [120/133] (492s left) kms_addfb_basic (bad-pitch-0)
[529.028442] Starting subtest: bad-pitch-0
[529.030368] Subtest bad-pitch-0: SUCCESS (0.000s)
[529.154116] [121/133] (492s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[529.247156] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[529.249388] Starting dynamic subtest: pipe-A-eDP-1
[529.274201] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[529.286801] Starting dynamic subtest: pipe-B-eDP-1
[529.310453] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[529.319893] Starting dynamic subtest: pipe-C-eDP-1
[529.343695] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[529.352838] Starting dynamic subtest: pipe-D-eDP-1
[529.376964] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[529.381053] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[531.443937] [122/133] (490s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[531.513330] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[531.574934] [123/133] (490s left) kms_psr (fbc-psr2-primary-page-flip)
[531.669812] Starting subtest: fbc-psr2-primary-page-flip
[531.672085] Starting dynamic subtest: eDP-1
[531.676162] Dynamic subtest eDP-1: SKIP (0.000s)
[531.680306] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[531.743019] [124/133] (490s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[531.834717] Starting subtest: fbc-psr2-sprite-plane-onoff
[531.836959] Starting dynamic subtest: eDP-1
[531.841096] Dynamic subtest eDP-1: SKIP (0.000s)
[531.845074] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[531.908884] [125/133] (489s left) gem_ctx_persistence (legacy-engines-queued)
[531.979519] Starting subtest: legacy-engines-queued
[531.981938] Starting dynamic subtest: render
[532.062502] Dynamic subtest render: SUCCESS (0.082s)
[532.077919] Starting dynamic subtest: bsd1
[533.285501] Dynamic subtest bsd1: SUCCESS (1.218s)
[533.298673] Starting dynamic subtest: bsd2
[535.268485] Dynamic subtest bsd2: SUCCESS (1.979s)
[535.281050] Starting dynamic subtest: blt
[535.332048] Dynamic subtest blt: SUCCESS (0.061s)
[535.344486] Starting dynamic subtest: vebox
[537.252404] Dynamic subtest vebox: SUCCESS (1.916s)
[537.255413] Subtest legacy-engines-queued: SUCCESS (5.272s)
[537.332549] [126/133] (484s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[537.428413] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[537.430881] Starting dynamic subtest: pipe-A-eDP-1
[537.452310] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[537.465126] Starting dynamic subtest: pipe-B-eDP-1
[537.485252] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[537.494663] Starting dynamic subtest: pipe-C-eDP-1
[537.513776] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[537.523300] Starting dynamic subtest: pipe-D-eDP-1
[537.542738] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[537.544952] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[539.736036] [127/133] (482s left) kms_hdr (bpc-switch-suspend)
[539.835201] Starting subtest: bpc-switch-suspend
[540.898159] Starting dynamic subtest: pipe-A-eDP-1
[560.023670] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.644s)
[560.026072] Subtest bpc-switch-suspend: SUCCESS (5.706s)
[560.152434] [128/133] (461s left) gem_pxp (create-regular-context-2)
[560.294867] Starting subtest: create-regular-context-2
[560.297607] Subtest create-regular-context-2: SUCCESS (0.002s)
[560.407355] [129/133] (461s left) kms_psr (fbc-pr-cursor-plane-onoff)
[560.500138] Starting subtest: fbc-pr-cursor-plane-onoff
[560.504672] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[560.591972] [130/133] (461s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[560.701403] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[560.705403] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[560.774824] [131/133] (461s left) kms_psr (fbc-psr-suspend)
[560.869226] Starting subtest: fbc-psr-suspend
[560.871456] Starting dynamic subtest: eDP-1
[560.875607] Dynamic subtest eDP-1: SKIP (0.000s)
[560.879879] Subtest fbc-psr-suspend: SKIP (0.002s)
[560.949452] [132/133] (461s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[561.037331] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[561.039576] Starting dynamic subtest: pipe-A
[562.214077] Dynamic subtest pipe-A: SUCCESS (1.173s)
[562.226917] Starting dynamic subtest: pipe-B
[564.445992] Dynamic subtest pipe-B: SUCCESS (2.220s)
[564.462824] Starting dynamic subtest: pipe-C
[565.595194] Dynamic subtest pipe-C: SUCCESS (1.143s)
[565.605617] Starting dynamic subtest: pipe-D
[566.832428] Dynamic subtest pipe-D: SUCCESS (1.233s)
[566.834741] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.776s)
[568.027732] [133/133] (454s left) kms_lease (lease-invalid-connector)
[568.128438] Starting subtest: lease-invalid-connector
[568.130891] Starting dynamic subtest: pipe-A-eDP-1
[568.133248] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[568.145618] Starting dynamic subtest: pipe-B-eDP-1
[568.147927] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[568.159084] Starting dynamic subtest: pipe-C-eDP-1
[568.161430] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[568.171480] Starting dynamic subtest: pipe-D-eDP-1
[568.173839] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[568.176126] Subtest lease-invalid-connector: SUCCESS (0.010s)
[568.210918] 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.