[56.768798] Initializing watchdogs
[56.768846]   /dev/watchdog0
[56.784152] [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.788647] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.791382] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.795185] [001/133] (960s left) perf_pmu (busy-hang)
[56.858282] Starting subtest: busy-hang
[56.860799] Starting dynamic subtest: rcs0
[58.070974] Dynamic subtest rcs0: SUCCESS (1.210s)
[58.084154] Starting dynamic subtest: bcs0
[59.253360] Dynamic subtest bcs0: SUCCESS (1.176s)
[59.263944] Starting dynamic subtest: vcs0
[61.411662] Dynamic subtest vcs0: SUCCESS (2.152s)
[61.424437] Starting dynamic subtest: vcs1
[63.443855] Dynamic subtest vcs1: SUCCESS (2.031s)
[63.454033] Starting dynamic subtest: vecs0
[65.436523] Dynamic subtest vecs0: SUCCESS (1.987s)
[65.446759] Starting dynamic subtest: ccs0
[66.606944] Dynamic subtest ccs0: SUCCESS (1.168s)
[66.609657] Subtest busy-hang: SUCCESS (9.730s)
[66.720048] [002/133] (950s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[66.824320] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[66.930996] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.105s)
[67.084362] [003/133] (950s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[67.328793] Starting subtest: cursorA-vs-flipA-toggle
[78.557550] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.225s)
[79.386369] [004/133] (938s left) kms_vrr (negative-basic)
[79.475833] Starting subtest: negative-basic
[79.482342] Starting dynamic subtest: pipe-A-eDP-1
[85.416480] Dynamic subtest pipe-A-eDP-1: FAIL (5.446s)
[85.418462] Subtest negative-basic: FAIL (5.748s)
[86.076840] [005/133] (931s left) kms_flip (2x-flip-vs-wf_vblank)
[86.174017] Starting subtest: 2x-flip-vs-wf_vblank
[86.183229] Subtest 2x-flip-vs-wf_vblank: SKIP (0.011s)
[86.267820] [006/133] (931s left) kms_pm_rpm (legacy-planes-dpms)
[88.107927] Starting subtest: legacy-planes-dpms
[88.110674] Starting dynamic subtest: plane-65
[96.453592] Dynamic subtest plane-65: SUCCESS (8.348s)
[96.464735] Starting dynamic subtest: plane-95
[105.055666] Dynamic subtest plane-95: SUCCESS (8.600s)
[105.066985] Starting dynamic subtest: plane-125
[113.681047] Dynamic subtest plane-125: SUCCESS (8.623s)
[113.692105] Starting dynamic subtest: plane-135
[122.165392] Dynamic subtest plane-135: SUCCESS (8.480s)
[122.168086] Subtest legacy-planes-dpms: SUCCESS (34.059s)
[122.543905] [007/133] (895s left) kms_chamelium_color (ctm-red-to-blue)
[122.635770] Subtest ctm-red-to-blue: SKIP (0.000s)
[122.681406] [008/133] (894s left) gem_ctx_isolation (nonpriv)
[122.751239] Starting subtest: nonpriv
[122.753778] Starting dynamic subtest: rcs0
[123.001664] Dynamic subtest rcs0: SUCCESS (0.250s)
[123.011992] Starting dynamic subtest: bcs0
[123.277318] Dynamic subtest bcs0: SUCCESS (0.275s)
[123.288257] Starting dynamic subtest: vcs0
[123.556222] Dynamic subtest vcs0: SUCCESS (0.279s)
[123.564215] Starting dynamic subtest: vcs1
[125.114030] Dynamic subtest vcs1: SUCCESS (1.557s)
[125.123847] Starting dynamic subtest: vecs0
[127.202212] Dynamic subtest vecs0: SUCCESS (2.088s)
[127.210487] Starting dynamic subtest: ccs0
[129.189538] Dynamic subtest ccs0: SUCCESS (1.987s)
[129.191801] Subtest nonpriv: SUCCESS (6.438s)
[129.431245] [009/133] (888s left) perf_pmu (frequency)
[129.471174] Starting subtest: frequency
[129.473527] Starting dynamic subtest: gt0
[131.636406] Dynamic subtest gt0: SUCCESS (2.158s)
[131.653854] Starting dynamic subtest: idle-gt0
[132.145472] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[132.154617] Starting dynamic subtest: gt1
[136.897334] Dynamic subtest gt1: SUCCESS (4.752s)
[136.907114] Starting dynamic subtest: idle-gt1
[137.431898] Dynamic subtest idle-gt1: SUCCESS (0.536s)
[137.434474] Subtest frequency: SUCCESS (7.962s)
[137.552842] [010/133] (880s left) gem_exec_alignment (forked)
[137.616879] Starting subtest: forked
[179.792670] Subtest forked: SUCCESS (42.172s)
[179.880893] [011/133] (837s left) kms_selftest (drm_format)
[179.964040] Starting subtest: drm_format
[180.030560] Starting dynamic subtest: drm_test_format_block_width_invalid
[180.139514] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.107s)
[180.150117] Starting dynamic subtest: drm_test_format_block_width_one_plane
[180.223655] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.084s)
[180.233972] Starting dynamic subtest: drm_test_format_block_width_two_plane
[180.329678] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.106s)
[180.340045] Starting dynamic subtest: drm_test_format_block_width_three_plane
[180.416038] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.086s)
[180.428517] Starting dynamic subtest: drm_test_format_block_width_tiled
[180.511361] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.095s)
[180.522357] Starting dynamic subtest: drm_test_format_block_height_invalid
[180.605433] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.094s)
[180.615685] Starting dynamic subtest: drm_test_format_block_height_one_plane
[180.700349] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.094s)
[180.709932] Starting dynamic subtest: drm_test_format_block_height_two_plane
[180.810143] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.109s)
[180.818501] Starting dynamic subtest: drm_test_format_block_height_three_plane
[180.921364] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.111s)
[180.929769] Starting dynamic subtest: drm_test_format_block_height_tiled
[181.045356] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.122s)
[181.053854] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[181.141350] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.097s)
[181.150192] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[181.232337] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.091s)
[181.242746] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[181.336163] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.103s)
[181.346788] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[181.432357] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.096s)
[181.443131] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[181.522062] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.089s)
[181.530757] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[181.611981] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.089s)
[181.620715] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[181.720682] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.109s)
[181.729840] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[181.816155] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.095s)
[181.818381] Subtest drm_format: SUCCESS (1.852s)
[181.968031] [012/133] (835s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[182.075268] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[182.078749] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[182.163096] [013/133] (835s left) syncobj_wait (multi-wait-all-submitted)
[182.232178] Starting subtest: multi-wait-all-submitted
[182.340023] Subtest multi-wait-all-submitted: SUCCESS (0.104s)
[182.414600] [014/133] (835s left) kms_flip (bo-too-big-interruptible)
[182.511163] Starting subtest: bo-too-big-interruptible
[182.513555] Starting dynamic subtest: A-eDP1
[183.884395] Dynamic subtest A-eDP1: SUCCESS (1.372s)
[183.893207] Starting dynamic subtest: B-eDP1
[185.130706] Dynamic subtest B-eDP1: SUCCESS (1.245s)
[185.142065] Starting dynamic subtest: C-eDP1
[186.462940] Dynamic subtest C-eDP1: SUCCESS (1.330s)
[186.477728] Starting dynamic subtest: D-eDP1
[187.720853] Dynamic subtest D-eDP1: SUCCESS (1.256s)
[187.723432] Subtest bo-too-big-interruptible: SUCCESS (5.212s)
[188.921931] [015/133] (828s left) kms_psr (psr2-sprite-plane-move)
[189.015711] Starting subtest: psr2-sprite-plane-move
[189.017980] Starting dynamic subtest: eDP-1
[190.761264] Dynamic subtest eDP-1: SUCCESS (1.745s)
[190.763145] Subtest psr2-sprite-plane-move: SUCCESS (1.746s)
[191.600415] [016/133] (826s left) syncobj_wait (reset-signaled)
[191.659751] Starting subtest: reset-signaled
[191.662157] Subtest reset-signaled: SUCCESS (0.000s)
[191.755361] [017/133] (826s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[191.851063] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[191.937463] [018/133] (826s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[192.032238] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[192.036876] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[192.151893] [019/133] (825s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[192.255062] Starting subtest: y-tiled-16bpp-rotate-270
[192.259134] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[192.350670] [020/133] (825s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[192.445277] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[192.449265] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[192.541794] [021/133] (825s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[192.627935] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[192.631367] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[192.722985] [022/133] (825s left) gem_lmem_swapping (heavy-verify-multi)
[192.773859] Subtest heavy-verify-multi: SKIP (0.000s)
[192.817257] [023/133] (825s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[192.920143] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[193.622536] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.703s)
[193.773721] [024/133] (824s left) gem_exec_fence (syncobj-timeline-chain-engines)
[194.338228] Starting subtest: syncobj-timeline-chain-engines
[194.457444] Subtest syncobj-timeline-chain-engines: SUCCESS (0.118s)
[196.011173] [FACT gem_exec_fence (syncobj-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[196.014349] [025/133] (822s left) i915_pm_rc6_residency (rc6-accuracy)
[196.078698] Starting subtest: rc6-accuracy
[196.081239] Starting dynamic subtest: gt0
[199.253102] Dynamic subtest gt0: SUCCESS (3.169s)
[199.265037] Starting dynamic subtest: gt1
[202.422499] Dynamic subtest gt1: SUCCESS (3.168s)
[202.425061] Subtest rc6-accuracy: SUCCESS (6.341s)
[202.498703] [026/133] (815s left) prime_mmap (test_userptr)
[202.560057] Starting subtest: test_userptr
[202.562246] Starting dynamic subtest: test_userptr-smem
[202.564075] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[202.565826] Subtest test_userptr: SUCCESS (0.001s)
[202.657962] [027/133] (815s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[202.764445] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[202.768940] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[202.868971] [028/133] (815s left) kms_addfb_basic (legacy-format)
[202.924934] Starting subtest: legacy-format
[202.952811] Subtest legacy-format: SUCCESS (0.024s)
[203.074617] [029/133] (815s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[203.174877] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[203.201321] Starting dynamic subtest: pipe-A-plane-0
[203.633745] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[203.644595] Starting dynamic subtest: pipe-A-plane-3
[203.912173] Dynamic subtest pipe-A-plane-3: SUCCESS (0.276s)
[203.924563] Starting dynamic subtest: pipe-A-plane-5
[203.928531] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[204.985561] Starting dynamic subtest: pipe-B-plane-0
[205.410561] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[205.422291] Starting dynamic subtest: pipe-B-plane-3
[205.766091] Dynamic subtest pipe-B-plane-3: SUCCESS (0.355s)
[205.775266] Starting dynamic subtest: pipe-B-plane-5
[205.779439] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[206.086193] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.913s)
[207.163689] [030/133] (811s left) gem_userptr_blits (unsync-unmap-after-close)
[207.231762] Subtest unsync-unmap-after-close: SKIP (0.000s)
[207.373998] [031/133] (811s left) gem_readwrite (new-obj)
[207.434655] Subtest new-obj: SKIP (0.000s)
[207.501584] [032/133] (811s left) gem_exec_schedule (preempt-engines)
[207.578422] Starting subtest: preempt-engines
[207.580701] Starting dynamic subtest: rcs0
[210.237018] Dynamic subtest rcs0: SUCCESS (2.659s)
[210.251451] Starting dynamic subtest: bcs0
[212.594172] Dynamic subtest bcs0: SUCCESS (2.355s)
[212.609440] Starting dynamic subtest: vcs0
[214.882898] Dynamic subtest vcs0: SUCCESS (2.286s)
[214.892346] Starting dynamic subtest: vcs1
[217.176838] Dynamic subtest vcs1: SUCCESS (2.292s)
[217.190902] Starting dynamic subtest: vecs0
[219.439962] Dynamic subtest vecs0: SUCCESS (2.261s)
[219.450772] Starting dynamic subtest: ccs0
[221.756804] Dynamic subtest ccs0: SUCCESS (2.315s)
[221.759158] Subtest preempt-engines: SUCCESS (14.181s)
[222.062737] [033/133] (796s left) gen7_exec_parse (basic-offset)
[222.123187] Subtest basic-offset: SKIP (0.000s)
[222.197425] [034/133] (796s left) gem_shrink (reclaim)
[222.265699] Starting subtest: reclaim
[224.771621] Subtest reclaim: SUCCESS (2.506s)
[224.923627] [035/133] (793s left) syncobj_timeline (reset-unsignaled)
[224.984570] Starting subtest: reset-unsignaled
[224.986783] Subtest reset-unsignaled: SUCCESS (0.000s)
[225.084104] [036/133] (793s left) i915_module_load (reload-no-display)
[225.121073] Starting subtest: reload-no-display
[231.056912] Subtest reload-no-display: SUCCESS (5.938s)
[231.086535] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[231.087279] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[231.090365] [037/133] (787s left) drm_mm (drm_mm)
[231.148887] Starting subtest: drm_mm
[231.154348] Starting dynamic subtest: drm_test_mm_init
[231.244942] Dynamic subtest drm_test_mm_init: SUCCESS (0.091s)
[231.254398] Starting dynamic subtest: drm_test_mm_debug
[231.342883] Dynamic subtest drm_test_mm_debug: SUCCESS (0.097s)
[231.352146] Starting dynamic subtest: drm_test_mm_align32
[231.437899] Dynamic subtest drm_test_mm_align32: SUCCESS (0.095s)
[231.445342] Starting dynamic subtest: drm_test_mm_align64
[231.527988] Dynamic subtest drm_test_mm_align64: SUCCESS (0.089s)
[231.535614] Starting dynamic subtest: drm_test_mm_lowest
[231.618983] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.090s)
[231.627956] Starting dynamic subtest: drm_test_mm_highest
[231.715807] Dynamic subtest drm_test_mm_highest: SUCCESS (0.096s)
[231.718063] Subtest drm_mm: SUCCESS (0.568s)
[231.835302] [038/133] (787s left) kms_flip (2x-blocking-absolute-wf_vblank)
[233.392113] Starting subtest: 2x-blocking-absolute-wf_vblank
[233.403507] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.012s)
[233.500796] [FACT kms_flip (2x-blocking-absolute-wf_vblank)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[233.502041] [FACT kms_flip (2x-blocking-absolute-wf_vblank)] new: kernel.kmod_is_loaded.i915: true
[233.505606] [039/133] (785s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[233.616287] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[237.913350] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.302s)
[239.047505] [040/133] (779s left) gem_close_race (basic-process)
[239.127409] Starting subtest: basic-process
[239.184252] Subtest basic-process: SUCCESS (0.057s)
[239.368221] [041/133] (779s left) kms_color (ctm-0-75)
[239.468107] Starting subtest: ctm-0-75
[239.470061] Starting dynamic subtest: pipe-A-eDP-1
[244.392032] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.923s)
[244.401644] Starting dynamic subtest: pipe-B-eDP-1
[250.075402] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.682s)
[250.084525] Starting dynamic subtest: pipe-C-eDP-1
[255.417893] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.342s)
[255.427668] Starting dynamic subtest: pipe-D-eDP-1
[260.728497] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.310s)
[260.730767] Subtest ctm-0-75: SUCCESS (21.261s)
[261.559082] [042/133] (757s left) prime_busy (after)
[261.629329] Starting subtest: after
[261.634953] Starting dynamic subtest: rcs0
[261.664202] Dynamic subtest rcs0: SUCCESS (0.032s)
[261.675576] Starting dynamic subtest: bcs0
[261.714899] Dynamic subtest bcs0: SUCCESS (0.050s)
[261.724644] Starting dynamic subtest: vcs0
[261.755161] Dynamic subtest vcs0: SUCCESS (0.039s)
[261.763786] Starting dynamic subtest: vcs1
[261.796435] Dynamic subtest vcs1: SUCCESS (0.039s)
[261.807267] Starting dynamic subtest: vecs0
[261.837041] Dynamic subtest vecs0: SUCCESS (0.040s)
[261.846076] Starting dynamic subtest: ccs0
[261.877822] Dynamic subtest ccs0: SUCCESS (0.040s)
[261.987266] Subtest after: SUCCESS (0.356s)
[262.060218] [043/133] (757s left) api_intel_allocator (default-alignment)
[262.123662] Starting subtest: default-alignment
[262.126171] Subtest default-alignment: SUCCESS (0.003s)
[262.251645] [044/133] (756s left) perf_pmu (all-busy-check-all)
[262.292028] Starting subtest: all-busy-check-all
[263.895810] Subtest all-busy-check-all: SUCCESS (1.602s)
[264.017328] [045/133] (755s left) gem_lmem_swapping (parallel-random-verify)
[264.062231] Subtest parallel-random-verify: SKIP (0.000s)
[264.106290] [046/133] (755s left) kms_atomic_interruptible (legacy-pageflip)
[264.211884] Starting subtest: legacy-pageflip
[264.214182] Starting dynamic subtest: pipe-A-eDP-1
[271.611299] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.398s)
[271.613499] Subtest legacy-pageflip: SUCCESS (7.399s)
[272.452324] [047/133] (746s left) i915_drm_fdinfo (memory-info-active)
[272.498983] Starting subtest: memory-info-active
[272.501335] Starting dynamic subtest: smem0
[275.063494] Dynamic subtest smem0: SUCCESS (2.566s)
[275.065534] Subtest memory-info-active: SUCCESS (2.567s)
[275.141319] [048/133] (744s left) kms_vblank (query-idle-hang)
[275.248209] Starting subtest: query-idle-hang
[275.250039] Starting dynamic subtest: pipe-A-eDP-1
[301.659764] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.407s)
[301.683355] Starting dynamic subtest: pipe-D-eDP-1
[326.680279] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.018s)
[326.682621] Subtest query-idle-hang: SUCCESS (51.429s)
[327.487186] [049/133] (691s left) kms_cursor_crc (cursor-onscreen-128x128)
[327.720528] Starting subtest: cursor-onscreen-128x128
[327.722919] Starting dynamic subtest: pipe-A-eDP-1
[329.858257] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.137s)
[329.889469] Starting dynamic subtest: pipe-D-eDP-1
[332.677779] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.796s)
[332.680284] Subtest cursor-onscreen-128x128: SUCCESS (4.958s)
[333.553440] [050/133] (685s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[333.668598] Starting subtest: x-tiled-64bpp-rotate-0
[335.303554] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.635s)
[335.471063] [051/133] (683s left) kms_dp_linktrain_fallback (dp-fallback)
[335.580700] Starting subtest: dp-fallback
[335.586151] Subtest dp-fallback: SKIP (0.000s)
[335.654415] [052/133] (683s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[335.747094] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[335.750489] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[335.843631] [053/133] (683s left) i915_pm_rps (thresholds)
[335.912220] Starting subtest: thresholds
[335.916136] Subtest thresholds: SKIP (0.001s)
[336.034679] [054/133] (683s left) gem_mmap_gtt (isolation)
[336.085903] Subtest isolation: SKIP (0.000s)
[336.153756] [055/133] (683s left) syncobj_timeline (wait-all-complex)
[336.213113] Starting subtest: wait-all-complex
[336.429352] Subtest wait-all-complex: SUCCESS (0.214s)
[336.521586] [056/133] (683s left) gem_exec_flush (basic-uc-ro-default)
[336.594805] Starting subtest: basic-uc-ro-default
[342.051947] Subtest basic-uc-ro-default: SUCCESS (5.458s)
[342.242561] [057/133] (677s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[342.457589] Starting subtest: cursor-rapid-movement-128x128
[342.462499] Starting dynamic subtest: pipe-A-eDP-1
[343.029653] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s)
[343.057715] Starting dynamic subtest: pipe-D-eDP-1
[344.278773] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.228s)
[344.280725] Subtest cursor-rapid-movement-128x128: SUCCESS (1.819s)
[345.198281] [058/133] (674s left) gem_exec_reloc (basic-write-gtt)
[345.253422] Subtest basic-write-gtt: SKIP (0.000s)
[345.330895] [059/133] (674s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[345.423284] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[345.427259] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[345.495461] [060/133] (674s left) gem_exec_reloc (basic-write-wc-noreloc)
[345.556226] Subtest basic-write-wc-noreloc: SKIP (0.000s)
[345.640469] [061/133] (674s left) gem_exec_schedule (fairslice-all)
[345.708625] Starting subtest: fairslice-all
[347.758612] Subtest fairslice-all: SUCCESS (2.059s)
[348.964320] [062/133] (671s left) gem_exec_params (invalid-bsd-ring)
[349.039684] Starting subtest: invalid-bsd-ring
[349.041684] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[349.145391] [063/133] (670s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[349.253661] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[349.257830] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[349.348692] [064/133] (670s left) gem_busy (close-race)
[349.409993] Starting subtest: close-race
[372.886628] Subtest close-race: SUCCESS (23.474s)
[373.266571] [065/133] (646s left) sysfs_timeslice_duration (timeout)
[373.363836] Starting subtest: timeout
[373.366367] Starting dynamic subtest: vecs0
[382.932878] Dynamic subtest vecs0: SUCCESS (9.564s)
[382.945966] Starting dynamic subtest: ccs0
[384.207696] Dynamic subtest ccs0: SUCCESS (1.274s)
[384.218205] Starting dynamic subtest: vcs0
[393.870414] Dynamic subtest vcs0: SUCCESS (9.658s)
[393.882794] Starting dynamic subtest: bcs0
[394.415054] Dynamic subtest bcs0: SUCCESS (0.544s)
[394.425982] Starting dynamic subtest: rcs0
[395.612964] Dynamic subtest rcs0: SUCCESS (1.199s)
[395.625039] Starting dynamic subtest: vcs1
[404.883297] Dynamic subtest vcs1: SUCCESS (9.265s)
[404.885875] Subtest timeout: SUCCESS (31.517s)
[404.963299] [066/133] (615s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[405.364319] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[406.134802] [067/133] (614s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[406.247404] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[407.306863] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.059s)
[407.442089] [068/133] (612s left) gem_exec_capture (userptr)
[407.507313] Starting subtest: userptr
[408.339258] Subtest userptr: SUCCESS (0.830s)
[408.449815] [069/133] (611s left) gem_busy (busy)
[408.520426] Starting subtest: busy
[408.522324] Starting dynamic subtest: all-engines
[408.597332] Dynamic subtest all-engines: SUCCESS (0.079s)
[408.610894] Starting dynamic subtest: rcs0
[409.887158] Dynamic subtest rcs0: SUCCESS (1.286s)
[409.898376] Starting dynamic subtest: bcs0
[409.929553] Dynamic subtest bcs0: SUCCESS (0.041s)
[409.941244] Starting dynamic subtest: vcs0
[409.974187] Dynamic subtest vcs0: SUCCESS (0.040s)
[409.983617] Starting dynamic subtest: vcs1
[411.869117] Dynamic subtest vcs1: SUCCESS (1.891s)
[411.880022] Starting dynamic subtest: vecs0
[413.852843] Dynamic subtest vecs0: SUCCESS (1.981s)
[413.863763] Starting dynamic subtest: ccs0
[415.836794] Dynamic subtest ccs0: SUCCESS (1.982s)
[415.838869] Subtest busy: SUCCESS (7.317s)
[416.204453] [070/133] (604s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[416.311991] Starting subtest: fbc-rgb101010-draw-blt
[420.963402] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.653s)
[422.138781] [071/133] (598s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[422.230991] Starting subtest: dsc-fractional-bpp-with-bpc
[422.263064] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s)
[422.303522] [072/133] (598s left) gem_exec_params (cliprects-invalid)
[422.368089] Starting subtest: cliprects-invalid
[422.370215] Subtest cliprects-invalid: SUCCESS (0.000s)
[422.490916] [073/133] (597s left) prime_mmap (test_errors)
[422.544312] Starting subtest: test_errors
[422.546485] Starting dynamic subtest: test_errors-smem
[422.641785] Dynamic subtest test_errors-smem: SUCCESS (0.099s)
[422.644196] Subtest test_errors: SUCCESS (0.100s)
[422.736266] [074/133] (597s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[422.818926] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[422.823280] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[422.892475] [075/133] (597s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[422.985349] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[431.588375] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.606s)
[431.714439] [076/133] (588s left) gem_exec_whisper (basic-forked)
[431.787019] Starting subtest: basic-forked
[439.895210] Subtest basic-forked: SUCCESS (8.106s)
[440.089280] [077/133] (580s left) gem_pxp (regular-baseline-src-copy-readible)
[440.228669] Starting subtest: regular-baseline-src-copy-readible
[440.291934] Subtest regular-baseline-src-copy-readible: SUCCESS (0.065s)
[440.404283] [078/133] (580s left) perf (disabled-read-error)
[440.544467] Starting subtest: disabled-read-error
[440.559665] Subtest disabled-read-error: SUCCESS (0.016s)
[440.608149] [079/133] (580s left) gem_mmap_wc (close)
[440.677146] Subtest close: SKIP (0.000s)
[440.744940] [080/133] (580s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[440.845667] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[440.849781] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[440.956285] [081/133] (579s left) kms_properties (connector-properties-atomic)
[441.055048] Starting subtest: connector-properties-atomic
[441.056861] Starting dynamic subtest: pipe-A-eDP-1
[449.041553] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.985s)
[449.052701] Starting dynamic subtest: pipe-None-DP-1
[449.057612] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[449.067162] Starting dynamic subtest: pipe-None-HDMI-A-1
[449.071894] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[449.081419] Starting dynamic subtest: pipe-None-DP-2
[449.085840] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[449.095811] Starting dynamic subtest: pipe-None-HDMI-A-2
[449.101951] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[449.113586] Starting dynamic subtest: pipe-None-DP-3
[449.119042] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[449.129771] Starting dynamic subtest: pipe-None-DP-4
[449.134438] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[449.136775] Subtest connector-properties-atomic: SUCCESS (7.997s)
[449.915553] [082/133] (570s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[450.020908] Starting subtest: psr-rgb101010-draw-render
[457.423083] Subtest psr-rgb101010-draw-render: SUCCESS (7.405s)
[457.553614] [083/133] (563s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[457.612232] Starting subtest: invalid-signal-one-illegal-handle
[457.614460] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[457.714363] [084/133] (563s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[457.806211] Starting subtest: extended-pageflip-modeset-hang-oldfb
[457.808124] Starting dynamic subtest: pipe-A
[465.707112] Dynamic subtest pipe-A: SUCCESS (7.901s)
[465.718954] Starting dynamic subtest: pipe-D
[474.380707] Dynamic subtest pipe-D: SUCCESS (8.669s)
[474.383238] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.576s)
[475.228136] [085/133] (545s left) gem_mmap_gtt (big-bo-tiledy)
[475.297753] Subtest big-bo-tiledY: SKIP (0.000s)
[475.386675] [086/133] (545s left) gem_fence_thrash (bo-write-verify-threaded-y)
[475.420051] Starting subtest: bo-write-verify-threaded-y
[475.446394] Subtest bo-write-verify-threaded-y: SKIP (0.023s)
[475.505421] [087/133] (545s left) perf_pmu (interrupts-sync)
[475.543184] Starting subtest: interrupts-sync
[476.638854] Subtest interrupts-sync: SUCCESS (1.094s)
[476.761349] [088/133] (544s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[476.863642] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[484.154638] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.294s)
[484.303207] [089/133] (536s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[484.400862] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[484.405076] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[484.492346] [090/133] (536s left) gem_ctx_engines (none)
[484.573600] Starting subtest: none
[484.575513] Subtest none: SUCCESS (0.001s)
[484.758717] [091/133] (536s left) gem_spin_batch (legacy-resubmit-new)
[484.818076] Starting subtest: legacy-resubmit-new
[484.820365] Starting dynamic subtest: default
[484.828739] Dynamic subtest default: SUCCESS (0.009s)
[484.841678] Starting dynamic subtest: render
[484.844018] Dynamic subtest render: SUCCESS (0.004s)
[484.853815] Starting dynamic subtest: bsd
[484.855902] Dynamic subtest bsd: SUCCESS (0.005s)
[484.866298] Starting dynamic subtest: bsd1
[484.868548] Dynamic subtest bsd1: SUCCESS (0.006s)
[484.877931] Starting dynamic subtest: bsd2
[484.880202] Dynamic subtest bsd2: SUCCESS (0.003s)
[484.889712] Starting dynamic subtest: blt
[484.891870] Dynamic subtest blt: SUCCESS (0.004s)
[484.902107] Starting dynamic subtest: vebox
[484.904225] Dynamic subtest vebox: SUCCESS (0.004s)
[484.906401] Subtest legacy-resubmit-new: SUCCESS (0.044s)
[485.951700] [092/133] (535s left) api_intel_bb (misplaced-blitter)
[486.012325] Starting subtest: misplaced-blitter
[486.017358] Subtest misplaced-blitter: SUCCESS (0.006s)
[486.139556] [093/133] (535s left) gem_exec_balancer (full-pulse)
[486.198704] Starting subtest: full-pulse
[490.772886] Subtest full-pulse: SUCCESS (4.574s)
[491.091088] [094/133] (530s left) kms_atomic (plane-overlay-legacy)
[491.184938] Starting subtest: plane-overlay-legacy
[491.187234] Starting dynamic subtest: pipe-A-eDP-1
[491.602801] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.416s)
[491.605092] Subtest plane-overlay-legacy: SUCCESS (0.417s)
[492.475401] [095/133] (528s left) kms_plane_scaling (planes-upscale-20x20)
[492.582622] Starting subtest: planes-upscale-20x20
[492.584754] Starting dynamic subtest: pipe-A
[492.643969] Dynamic subtest pipe-A: SUCCESS (0.062s)
[492.654712] Starting dynamic subtest: pipe-B
[493.809078] Dynamic subtest pipe-B: SUCCESS (1.164s)
[493.821084] Starting dynamic subtest: pipe-C
[494.919288] Dynamic subtest pipe-C: SUCCESS (1.109s)
[494.929846] Starting dynamic subtest: pipe-D
[496.038621] Dynamic subtest pipe-D: SUCCESS (1.118s)
[496.041038] Subtest planes-upscale-20x20: SUCCESS (3.458s)
[497.202491] [096/133] (524s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[497.310536] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[504.004852] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.697s)
[504.154175] [097/133] (517s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[504.271812] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[504.275958] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[504.405050] [098/133] (517s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[504.507750] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[504.510054] Starting dynamic subtest: pipe-A-eDP-1
[504.787668] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.250s)
[504.798529] Starting dynamic subtest: pipe-B-eDP-1
[506.105454] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.311s)
[506.116534] Starting dynamic subtest: pipe-C-eDP-1
[507.319408] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.217s)
[507.330089] Starting dynamic subtest: pipe-D-eDP-1
[508.554201] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.232s)
[508.556169] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.015s)
[509.668918] [099/133] (511s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[509.770739] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[509.775141] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[509.849079] [100/133] (511s left) kms_flip (2x-flip-vs-rmfb)
[509.951866] Starting subtest: 2x-flip-vs-rmfb
[509.964946] Subtest 2x-flip-vs-rmfb: SKIP (0.014s)
[510.074633] [101/133] (511s left) kms_cursor_edge_walk (64x64-left-edge)
[510.174143] Starting subtest: 64x64-left-edge
[510.176412] Starting dynamic subtest: pipe-A-eDP-1
[513.611340] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.435s)
[513.622083] Starting dynamic subtest: pipe-D-eDP-1
[516.745635] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.133s)
[516.747841] Subtest 64x64-left-edge: SUCCESS (6.571s)
[517.557278] [102/133] (504s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[517.673885] Starting subtest: fbcpsr-rgb565-draw-blt
[524.716305] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.043s)
[524.853068] [103/133] (496s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[524.952771] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[524.955073] Starting dynamic subtest: pipe-A-eDP-1
[524.975235] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[524.986656] Starting dynamic subtest: pipe-B-eDP-1
[525.006261] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[525.016478] Starting dynamic subtest: pipe-C-eDP-1
[525.035091] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[525.044676] Starting dynamic subtest: pipe-D-eDP-1
[525.063239] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[525.065380] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[527.276835] [104/133] (494s left) gem_exec_schedule (u-semaphore-resolve)
[527.346493] Starting subtest: u-semaphore-resolve
[527.374967] Subtest u-semaphore-resolve: SUCCESS (0.037s)
[527.714744] [105/133] (494s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[527.770783] Starting subtest: etime-multi-wait-for-submit-submitted
[527.873799] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.102s)
[527.952988] [106/133] (493s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[528.022622] Starting subtest: y-tiled-to-vebox-yf-tiled
[528.026862] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[528.219551] [107/133] (493s left) gem_render_linear_blits (basic)
[528.284155] Starting subtest: basic
[528.310926] Subtest basic: SUCCESS (0.029s)
[528.400111] [108/133] (493s left) gem_userptr_blits (sd-probe)
[528.473143] Starting subtest: sd-probe
[528.475436] Subtest sd-probe: SUCCESS (0.000s)
[528.621484] [109/133] (493s left) kms_content_protection (dp-mst-lic-type-1)
[528.760626] Starting subtest: dp-mst-lic-type-1
[528.765035] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[528.897322] [110/133] (493s left) kms_psr (psr-primary-page-flip)
[528.988177] Starting subtest: psr-primary-page-flip
[528.990365] Starting dynamic subtest: eDP-1
[530.688098] Dynamic subtest eDP-1: SUCCESS (1.698s)
[530.690372] Subtest psr-primary-page-flip: SUCCESS (1.699s)
[531.555500] [111/133] (490s left) gem_eio (in-flight-internal-1us)
[531.793327] Starting subtest: in-flight-internal-1us
[532.968114] Subtest in-flight-internal-1us: SUCCESS (1.173s)
[533.113910] [112/133] (489s left) kms_pipe_crc_basic (read-crc)
[533.221187] Starting subtest: read-crc
[533.223504] Starting dynamic subtest: pipe-A-eDP-1
[533.931815] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.712s)
[533.942885] Starting dynamic subtest: pipe-B-eDP-1
[535.323814] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.388s)
[535.334635] Starting dynamic subtest: pipe-C-eDP-1
[536.622950] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.298s)
[536.636822] Starting dynamic subtest: pipe-D-eDP-1
[537.956265] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.332s)
[537.958753] Subtest read-crc: SUCCESS (4.737s)
[538.777373] [113/133] (483s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[538.891106] Starting subtest: pr-overlay-plane-move-continuous-sf
[538.895437] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[538.963396] [114/133] (483s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[539.059719] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[539.061995] Starting dynamic subtest: pipe-A-eDP-1
[539.084999] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[539.097206] Starting dynamic subtest: pipe-B-eDP-1
[539.118771] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[539.128822] Starting dynamic subtest: pipe-C-eDP-1
[539.150486] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[539.160570] Starting dynamic subtest: pipe-D-eDP-1
[539.182216] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[539.186271] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[541.331972] [115/133] (480s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[541.431338] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[541.435572] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[541.517295] [116/133] (480s left) gem_exec_balancer (sliced)
[541.586721] Starting subtest: sliced
[541.591219] Subtest sliced: SKIP (0.000s)
[541.889836] [117/133] (480s left) kms_hdr (static-swap)
[541.974307] Starting subtest: static-swap
[541.980662] Subtest static-swap: SKIP (0.000s)
[542.052067] [118/133] (480s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[542.150681] Starting subtest: 4-tiled-64bpp-rotate-90
[542.170440] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s)
[542.286295] [119/133] (480s left) kms_pm_rpm (fences)
[544.009663] Starting subtest: fences
[544.014416] Subtest fences: SKIP (0.000s)
[544.585410] [120/133] (477s left) kms_addfb_basic (bad-pitch-0)
[544.655069] Starting subtest: bad-pitch-0
[544.657260] Subtest bad-pitch-0: SUCCESS (0.000s)
[544.794464] [121/133] (477s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[544.881619] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[544.883749] Starting dynamic subtest: pipe-A-eDP-1
[544.907316] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[544.918613] Starting dynamic subtest: pipe-B-eDP-1
[544.941376] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[544.950856] Starting dynamic subtest: pipe-C-eDP-1
[544.973586] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[544.982962] Starting dynamic subtest: pipe-D-eDP-1
[545.005747] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[545.009826] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[547.130466] [122/133] (475s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[547.189567] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[547.251713] [123/133] (475s left) kms_psr (fbc-psr2-primary-page-flip)
[547.341622] Starting subtest: fbc-psr2-primary-page-flip
[547.343772] Starting dynamic subtest: eDP-1
[547.347714] Dynamic subtest eDP-1: SKIP (0.000s)
[547.351632] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[547.418859] [124/133] (475s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[547.516687] Starting subtest: fbc-psr2-sprite-plane-onoff
[547.518870] Starting dynamic subtest: eDP-1
[547.522816] Dynamic subtest eDP-1: SKIP (0.000s)
[547.526787] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[547.594668] [125/133] (475s left) gem_ctx_persistence (legacy-engines-queued)
[547.654397] Starting subtest: legacy-engines-queued
[547.656560] Starting dynamic subtest: render
[547.738238] Dynamic subtest render: SUCCESS (0.083s)
[547.752943] Starting dynamic subtest: bsd1
[548.853409] Dynamic subtest bsd1: SUCCESS (1.110s)
[548.868053] Starting dynamic subtest: bsd2
[550.837604] Dynamic subtest bsd2: SUCCESS (1.980s)
[550.851078] Starting dynamic subtest: blt
[550.889915] Dynamic subtest blt: SUCCESS (0.051s)
[550.902347] Starting dynamic subtest: vebox
[552.884546] Dynamic subtest vebox: SUCCESS (1.991s)
[552.887575] Subtest legacy-engines-queued: SUCCESS (5.230s)
[552.966610] [126/133] (469s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[553.084536] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[553.086652] Starting dynamic subtest: pipe-A-eDP-1
[553.106308] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[553.117420] Starting dynamic subtest: pipe-B-eDP-1
[553.135121] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[553.146681] Starting dynamic subtest: pipe-C-eDP-1
[553.165533] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[553.175657] Starting dynamic subtest: pipe-D-eDP-1
[553.194107] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[553.195907] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[555.303314] [127/133] (467s left) kms_hdr (bpc-switch-suspend)
[555.402277] Starting subtest: bpc-switch-suspend
[556.470826] Starting dynamic subtest: pipe-A-eDP-1
[576.227353] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.609s)
[576.229867] Subtest bpc-switch-suspend: SUCCESS (5.677s)
[576.338679] [128/133] (446s left) gem_pxp (create-regular-context-2)
[576.463825] Starting subtest: create-regular-context-2
[576.466763] Subtest create-regular-context-2: SUCCESS (0.001s)
[576.583996] [129/133] (446s left) kms_psr (fbc-pr-cursor-plane-onoff)
[576.689846] Starting subtest: fbc-pr-cursor-plane-onoff
[576.695134] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[576.766303] [130/133] (446s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[576.867664] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[576.872708] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[576.937836] [131/133] (446s left) kms_psr (fbc-psr-suspend)
[577.035358] Starting subtest: fbc-psr-suspend
[577.037827] Starting dynamic subtest: eDP-1
[577.042939] Dynamic subtest eDP-1: SKIP (0.000s)
[577.047829] Subtest fbc-psr-suspend: SKIP (0.001s)
[577.111851] [132/133] (445s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[577.204874] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[577.207486] Starting dynamic subtest: pipe-A
[578.433657] Dynamic subtest pipe-A: SUCCESS (1.217s)
[578.444540] Starting dynamic subtest: pipe-B
[580.646140] Dynamic subtest pipe-B: SUCCESS (2.191s)
[580.657630] Starting dynamic subtest: pipe-C
[581.833759] Dynamic subtest pipe-C: SUCCESS (1.177s)
[581.847376] Starting dynamic subtest: pipe-D
[582.971490] Dynamic subtest pipe-D: SUCCESS (1.130s)
[582.973813] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.720s)
[584.176001] [133/133] (438s left) kms_lease (lease-invalid-connector)
[584.276941] Starting subtest: lease-invalid-connector
[584.279655] Starting dynamic subtest: pipe-A-eDP-1
[584.282507] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[584.293832] Starting dynamic subtest: pipe-B-eDP-1
[584.296206] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[584.307274] Starting dynamic subtest: pipe-C-eDP-1
[584.310397] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[584.321724] Starting dynamic subtest: pipe-D-eDP-1
[584.324545] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[584.326908] Subtest lease-invalid-connector: SUCCESS (0.004s)
[584.364592] 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.