[59.353990] Initializing watchdogs
[59.354051]   /dev/watchdog0
[59.369012] [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]
[59.373576] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.375793] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.378963] [001/133] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[59.496038] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[59.499814] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[59.605971] [002/133] (960s left) gem_mmap_gtt (fault-concurrent-x)
[59.663083] Subtest fault-concurrent-X: SKIP (0.000s)
[59.721412] [003/133] (960s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[59.815248] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[59.827706] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[59.896764] [004/133] (960s left) syncobj_wait (wait-any-snapshot)
[59.943293] Starting subtest: wait-any-snapshot
[60.025072] Subtest wait-any-snapshot: SUCCESS (0.082s)
[60.097273] [005/133] (959s left) kms_frontbuffer_tracking (psr-1p-rte)
[60.186264] Starting subtest: psr-1p-rte
[65.547737] Subtest psr-1p-rte: SUCCESS (5.403s)
[65.694200] [006/133] (954s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[65.783943] Starting subtest: disable-crc-after-crtc
[65.786360] Starting dynamic subtest: pipe-A-eDP-1
[67.445788] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.670s)
[67.453889] Starting dynamic subtest: pipe-B-eDP-1
[69.801485] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.360s)
[69.810812] Starting dynamic subtest: pipe-C-eDP-1
[72.065333] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.270s)
[72.074330] Starting dynamic subtest: pipe-D-eDP-1
[74.313294] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.249s)
[74.315228] Subtest disable-crc-after-crtc: SUCCESS (8.554s)
[75.138427] [007/133] (944s left) kms_dp_link_training (uhbr-sst)
[75.236052] Starting subtest: uhbr-sst
[75.244851] Subtest uhbr-sst: SKIP (0.000s)
[75.305226] [008/133] (944s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[75.364837] Starting subtest: invalid-single-wait-all-unsubmitted
[75.367151] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[75.473490] [009/133] (944s left) gem_ctx_isolation (preservation)
[75.542045] Starting subtest: preservation
[75.544312] Starting dynamic subtest: rcs0
[75.655247] Dynamic subtest rcs0: SUCCESS (0.113s)
[75.664749] Starting dynamic subtest: bcs0
[75.800699] Dynamic subtest bcs0: SUCCESS (0.145s)
[75.809059] Starting dynamic subtest: vcs0
[75.951981] Dynamic subtest vcs0: SUCCESS (0.150s)
[75.963269] Starting dynamic subtest: vcs1
[77.465651] Dynamic subtest vcs1: SUCCESS (1.516s)
[77.473293] Starting dynamic subtest: vecs0
[79.450865] Dynamic subtest vecs0: SUCCESS (1.986s)
[79.464070] Starting dynamic subtest: ccs0
[81.452448] Dynamic subtest ccs0: SUCCESS (2.002s)
[81.454999] Subtest preservation: SUCCESS (5.915s)
[81.672351] [010/133] (938s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[81.775433] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[81.779879] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[81.882187] [011/133] (938s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[81.969813] Starting subtest: primary-y-tiled-reflect-x-270
[81.974331] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[82.044973] [012/133] (938s left) kms_psr (fbc-psr-no-drrs)
[82.143708] Starting subtest: fbc-psr-no-drrs
[82.145925] Starting dynamic subtest: eDP-1
[82.150048] Dynamic subtest eDP-1: SKIP (0.000s)
[82.154148] Subtest fbc-psr-no-drrs: SKIP (0.000s)
[82.214381] [013/133] (938s left) core_setmaster (master-drop-set-user)
[82.289479] Starting subtest: master-drop-set-user
[82.303536] Subtest master-drop-set-user: SUCCESS (0.014s)
[82.339833] [014/133] (938s left) gem_eio (wait-1us)
[82.546294] Starting subtest: wait-1us
[82.838149] Subtest wait-1us: SUCCESS (0.295s)
[83.003812] [015/133] (937s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[83.095080] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[83.097045] Starting dynamic subtest: pipe-A-eDP-1
[83.115565] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[83.127430] Starting dynamic subtest: pipe-B-eDP-1
[83.143350] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[83.150601] Starting dynamic subtest: pipe-C-eDP-1
[83.166464] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[83.173600] Starting dynamic subtest: pipe-D-eDP-1
[83.189202] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[83.190743] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[85.391715] [016/133] (935s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[85.500176] Starting subtest: y-tiled-16bpp-rotate-90
[85.504447] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[85.617192] [017/133] (934s left) gem_ppgtt (shrink-vs-evict-pinned)
[85.681403] Starting subtest: shrink-vs-evict-pinned
[91.383329] Subtest shrink-vs-evict-pinned: SUCCESS (5.700s)
[91.478728] [018/133] (929s left) kms_getfb (getfb-reject-nv12)
[91.570978] Starting subtest: getfb-reject-nv12
[91.573286] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[91.665685] [019/133] (928s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[91.763855] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[99.500064] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.741s)
[99.612888] [020/133] (921s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[99.724341] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[99.728189] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[99.815410] [021/133] (920s left) kms_properties (plane-properties-legacy)
[99.920806] Starting subtest: plane-properties-legacy
[99.923065] Starting dynamic subtest: pipe-A-eDP-1
[100.496311] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.574s)
[100.504696] Starting dynamic subtest: pipe-B-eDP-1
[101.807670] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.311s)
[101.817726] Starting dynamic subtest: pipe-C-eDP-1
[103.041331] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.232s)
[103.054889] Starting dynamic subtest: pipe-D-eDP-1
[104.284440] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.240s)
[104.286378] Subtest plane-properties-legacy: SUCCESS (4.362s)
[105.095799] [022/133] (915s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[105.198343] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[105.202858] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[105.268077] [023/133] (915s left) gem_exec_reloc (basic-cpu-noreloc)
[105.332307] Subtest basic-cpu-noreloc: SKIP (0.000s)
[105.413565] [024/133] (915s left) i915_query (query-topology-coherent-slice-mask)
[105.465050] Starting subtest: query-topology-coherent-slice-mask
[105.469111] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[105.576783] [025/133] (915s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[105.635661] Starting subtest: multi-wait-available-submitted-signaled
[105.637972] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s)
[105.744864] [026/133] (915s left) gem_exec_fence (syncobj-unused-fence)
[106.185032] Starting subtest: syncobj-unused-fence
[106.190467] Subtest syncobj-unused-fence: SUCCESS (0.006s)
[107.414447] [FACT gem_exec_fence (syncobj-unused-fence)] new: kernel.kmod_is_loaded.vgem: true
[107.417456] [027/133] (913s left) gem_mmap_wc (write-read-distinct)
[107.481656] Subtest write-read-distinct: SKIP (0.000s)
[107.551978] [028/133] (913s left) kms_cursor_edge_walk (128x128-top-bottom)
[107.649960] Starting subtest: 128x128-top-bottom
[107.652390] Starting dynamic subtest: pipe-A-eDP-1
[111.143887] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.494s)
[111.153798] Starting dynamic subtest: pipe-D-eDP-1
[114.276510] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.131s)
[114.278881] Subtest 128x128-top-bottom: SUCCESS (6.628s)
[115.085312] [029/133] (905s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[115.181111] Starting subtest: fbc-psr2-primary-mmap-cpu
[115.183435] Starting dynamic subtest: eDP-1
[115.187676] Dynamic subtest eDP-1: SKIP (0.000s)
[115.192051] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[115.251496] [030/133] (905s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[115.358482] Starting subtest: x-tiled-32bpp-rotate-270
[115.378033] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s)
[115.502686] [031/133] (905s left) kms_psr (pr-cursor-mmap-cpu)
[115.596770] Starting subtest: pr-cursor-mmap-cpu
[115.600729] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[115.667770] [032/133] (905s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[115.761087] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[115.765278] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[115.852350] [033/133] (905s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[115.949746] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[115.953914] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[116.047807] [034/133] (905s left) kms_big_fb (yf-tiled-addfb)
[116.143408] Starting subtest: yf-tiled-addfb
[116.147212] Subtest yf-tiled-addfb: SKIP (0.000s)
[116.242862] [035/133] (905s left) prime_vgem (wait)
[116.317985] Starting subtest: wait
[116.320017] Starting dynamic subtest: rcs0
[116.353728] Dynamic subtest rcs0: SUCCESS (0.036s)
[116.361999] Starting dynamic subtest: bcs0
[116.406074] Dynamic subtest bcs0: SUCCESS (0.052s)
[116.414219] Starting dynamic subtest: vcs0
[116.453325] Dynamic subtest vcs0: SUCCESS (0.047s)
[116.461405] Starting dynamic subtest: vcs1
[116.499919] Dynamic subtest vcs1: SUCCESS (0.046s)
[116.508020] Starting dynamic subtest: vecs0
[116.546116] Dynamic subtest vecs0: SUCCESS (0.046s)
[116.554195] Starting dynamic subtest: ccs0
[116.594186] Dynamic subtest ccs0: SUCCESS (0.047s)
[116.595972] Subtest wait: SUCCESS (0.277s)
[116.727415] [036/133] (904s left) gem_mmap_offset (partial-remap)
[116.795504] Starting subtest: partial-remap
[116.797509] Starting dynamic subtest: smem0
[116.805038] Dynamic subtest smem0: SUCCESS (0.004s)
[116.806939] Subtest partial-remap: SUCCESS (0.004s)
[116.918073] [037/133] (904s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[117.022067] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[117.023973] Starting dynamic subtest: pipe-A-eDP-1
[122.866516] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.845s)
[122.875898] Starting dynamic subtest: pipe-B-eDP-1
[129.526985] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.661s)
[129.529456] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.509s)
[130.416425] [038/133] (890s left) kms_hdr (static-toggle-suspend)
[130.509324] Starting subtest: static-toggle-suspend
[130.515753] Subtest static-toggle-suspend: SKIP (0.000s)
[130.594758] [039/133] (890s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[130.655655] Starting subtest: yf-tiled-to-vebox-yf-tiled
[130.659657] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[130.837224] [040/133] (890s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[130.923981] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[130.926147] Starting dynamic subtest: pipe-A-eDP-1
[130.947812] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[130.958636] Starting dynamic subtest: pipe-B-eDP-1
[130.979086] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[130.987170] Starting dynamic subtest: pipe-C-eDP-1
[131.008391] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[131.017606] Starting dynamic subtest: pipe-D-eDP-1
[131.039042] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[131.043057] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[133.082571] [041/133] (888s left) kms_pm_rpm (pc8-residency)
[134.630396] Starting subtest: pc8-residency
[134.635201] Subtest pc8-residency: SKIP (0.000s)
[135.338687] [042/133] (886s left) gem_exec_schedule (preemptive-hang)
[135.513310] Starting subtest: preemptive-hang
[135.515527] Starting dynamic subtest: rcs0
[144.464654] Dynamic subtest rcs0: SUCCESS (8.949s)
[144.478611] Starting dynamic subtest: bcs0
[153.417043] Dynamic subtest bcs0: SUCCESS (8.953s)
[153.428510] Starting dynamic subtest: vcs0
[162.505822] Dynamic subtest vcs0: SUCCESS (9.085s)
[162.514129] Starting dynamic subtest: vcs1
[171.463685] Dynamic subtest vcs1: SUCCESS (8.956s)
[171.473844] Starting dynamic subtest: vecs0
[180.425682] Dynamic subtest vecs0: SUCCESS (8.957s)
[180.436756] Starting dynamic subtest: ccs0
[189.449676] Dynamic subtest ccs0: SUCCESS (9.023s)
[189.452425] Subtest preemptive-hang: SUCCESS (53.932s)
[189.667666] [043/133] (831s left) kms_pipe_crc_basic (bad-source)
[189.766834] Starting subtest: bad-source
[189.769080] Subtest bad-source: SUCCESS (0.000s)
[189.844195] [044/133] (831s left) gem_exec_schedule (preempt-user)
[189.918915] Starting subtest: preempt-user
[189.920943] Starting dynamic subtest: rcs0
[189.934872] Dynamic subtest rcs0: SUCCESS (0.024s)
[189.946237] Starting dynamic subtest: bcs0
[189.952290] Dynamic subtest bcs0: SUCCESS (0.017s)
[189.960982] Starting dynamic subtest: vcs0
[189.971419] Dynamic subtest vcs0: SUCCESS (0.019s)
[189.980076] Starting dynamic subtest: vcs1
[189.991274] Dynamic subtest vcs1: SUCCESS (0.019s)
[189.999963] Starting dynamic subtest: vecs0
[190.009749] Dynamic subtest vecs0: SUCCESS (0.018s)
[190.018530] Starting dynamic subtest: ccs0
[190.032041] Dynamic subtest ccs0: SUCCESS (0.021s)
[190.034287] Subtest preempt-user: SUCCESS (0.121s)
[191.407510] [045/133] (830s left) gem_huc_copy (huc-copy)
[191.468341] Starting subtest: huc-copy
[191.473274] Subtest huc-copy: SUCCESS (0.004s)
[191.594257] [046/133] (830s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[191.695642] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[192.762685] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.067s)
[192.884214] [047/133] (828s left) kms_content_protection (dp-mst-lic-type-1)
[193.031658] Starting subtest: dp-mst-lic-type-1
[193.035437] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[193.157272] [048/133] (828s left) core_getclient (basic)
[193.214447] Starting subtest: basic
[193.216494] Subtest basic: SUCCESS (0.000s)
[193.319612] [049/133] (828s left) gem_mmap (short-mmap)
[193.380537] Subtest short-mmap: SKIP (0.000s)
[193.444733] [050/133] (828s left) perf_pmu (busy-check-all)
[193.490251] Starting subtest: busy-check-all
[193.492068] Starting dynamic subtest: rcs0
[194.045210] Dynamic subtest rcs0: SUCCESS (0.555s)
[194.057183] Starting dynamic subtest: bcs0
[194.595716] Dynamic subtest bcs0: SUCCESS (0.548s)
[194.607634] Starting dynamic subtest: vcs0
[196.322332] Dynamic subtest vcs0: SUCCESS (1.723s)
[196.334581] Starting dynamic subtest: vcs1
[198.305751] Dynamic subtest vcs1: SUCCESS (1.981s)
[198.318083] Starting dynamic subtest: vecs0
[200.354537] Dynamic subtest vecs0: SUCCESS (2.047s)
[200.366677] Starting dynamic subtest: ccs0
[200.910959] Dynamic subtest ccs0: SUCCESS (0.555s)
[200.913799] Subtest busy-check-all: SUCCESS (7.422s)
[201.011216] [051/133] (820s left) gem_partial_pwrite_pread (write-display)
[201.078253] Subtest write-display: SKIP (0.000s)
[201.152030] [052/133] (820s left) gem_ctx_sseu (invalid-sseu)
[201.222360] Subtest invalid-sseu: SKIP (0.000s)
[201.289336] [053/133] (820s left) kms_plane_multiple (tiling-none)
[201.395887] Starting subtest: tiling-none
[201.397807] Starting dynamic subtest: pipe-A-eDP-1
[205.080081] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.682s)
[205.090306] Starting dynamic subtest: pipe-B-eDP-1
[209.507504] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.428s)
[209.517072] Starting dynamic subtest: pipe-C-eDP-1
[213.856564] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.348s)
[213.866070] Starting dynamic subtest: pipe-D-eDP-1
[218.204758] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.344s)
[218.207105] Subtest tiling-none: SUCCESS (16.807s)
[219.001873] [054/133] (803s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[219.061086] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[219.120806] [055/133] (802s left) i915_pm_rpm (system-suspend-devices)
[220.638752] Starting subtest: system-suspend-devices
[228.424362] Subtest system-suspend-devices: SUCCESS (7.788s)
[237.813772] [056/133] (793s left) kms_async_flips (test-time-stamp-atomic)
[237.922595] Starting subtest: test-time-stamp-atomic
[238.306802] Starting dynamic subtest: pipe-A-eDP-1
[239.095817] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.787s)
[239.474998] Starting dynamic subtest: pipe-B-eDP-1
[240.232365] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.764s)
[240.622931] Starting dynamic subtest: pipe-C-eDP-1
[241.377201] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.765s)
[241.746910] Starting dynamic subtest: pipe-D-eDP-1
[242.505131] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.764s)
[242.507494] Subtest test-time-stamp-atomic: SUCCESS (4.582s)
[243.673736] [057/133] (787s left) kms_cursor_crc (cursor-offscreen-256x256)
[243.939941] Starting subtest: cursor-offscreen-256x256
[243.945113] Starting dynamic subtest: pipe-A-eDP-1
[245.873418] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.927s)
[245.914460] Starting dynamic subtest: pipe-D-eDP-1
[248.477066] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.571s)
[248.479680] Subtest cursor-offscreen-256x256: SUCCESS (4.536s)
[249.331474] [058/133] (781s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[249.427229] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[249.431341] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[249.535302] [059/133] (781s left) gem_exec_await (wide-contexts)
[249.773362] Starting subtest: wide-contexts
[273.145376] Subtest wide-contexts: SUCCESS (23.373s)
[273.357714] [060/133] (757s left) kms_flip (nonexisting-fb-interruptible)
[273.508194] Starting subtest: nonexisting-fb-interruptible
[273.510470] Starting dynamic subtest: A-eDP1
[274.715590] Dynamic subtest A-eDP1: SUCCESS (1.206s)
[274.729313] Starting dynamic subtest: B-eDP1
[275.849486] Dynamic subtest B-eDP1: SUCCESS (1.131s)
[275.860073] Starting dynamic subtest: C-eDP1
[276.975229] Dynamic subtest C-eDP1: SUCCESS (1.124s)
[276.988778] Starting dynamic subtest: D-eDP1
[278.109821] Dynamic subtest D-eDP1: SUCCESS (1.132s)
[278.114933] Subtest nonexisting-fb-interruptible: SUCCESS (4.607s)
[279.294363] [061/133] (752s left) kms_psr (psr2-no-drrs)
[279.397156] Starting subtest: psr2-no-drrs
[279.399348] Starting dynamic subtest: eDP-1
[281.067742] Dynamic subtest eDP-1: SUCCESS (1.667s)
[281.070035] Subtest psr2-no-drrs: SUCCESS (1.669s)
[281.874196] [062/133] (749s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[281.969034] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[281.995203] Starting dynamic subtest: pipe-A-plane-0
[282.295651] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[282.308018] Starting dynamic subtest: pipe-A-plane-3
[282.528356] Dynamic subtest pipe-A-plane-3: SUCCESS (0.230s)
[283.657615] Starting dynamic subtest: pipe-B-plane-0
[283.948614] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[283.959471] Starting dynamic subtest: pipe-B-plane-3
[284.204859] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[284.537669] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.568s)
[285.339729] [063/133] (746s left) gem_exec_balancer (bonded-true-hang)
[285.610705] Starting subtest: bonded-true-hang
[285.615548] Subtest bonded-true-hang: SKIP (0.000s)
[285.719303] [064/133] (745s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[286.098971] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[286.952365] [065/133] (744s left) gem_exec_reloc (basic-write-cpu-noreloc)
[287.008114] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[287.092336] [066/133] (744s left) kms_hdmi_inject (inject-4k)
[287.438680] Starting subtest: inject-4k
[287.760743] Subtest inject-4k: SUCCESS (0.322s)
[288.328384] [067/133] (743s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[288.391520] Starting subtest: etime-single-wait-all-for-submit-submitted
[288.501945] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.108s)
[288.589899] [068/133] (743s left) kms_flip (flip-vs-modeset-vs-hang)
[288.695748] Starting subtest: flip-vs-modeset-vs-hang
[288.697759] Starting dynamic subtest: A-eDP1
[339.769267] Dynamic subtest A-eDP1: SUCCESS (51.071s)
[339.780444] Starting dynamic subtest: D-eDP1
[389.818131] Dynamic subtest D-eDP1: SUCCESS (50.047s)
[389.820783] Subtest flip-vs-modeset-vs-hang: SUCCESS (101.123s)
[390.169961] [069/133] (641s left) kms_lease (master-vs-lease)
[390.278907] Starting subtest: master-vs-lease
[390.281162] Subtest master-vs-lease: SUCCESS (0.002s)
[390.384099] [070/133] (641s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[390.474139] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[390.476418] Starting dynamic subtest: pipe-A-eDP-1
[390.937071] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.436s)
[390.949688] Starting dynamic subtest: pipe-B-eDP-1
[392.365872] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.426s)
[392.377729] Starting dynamic subtest: pipe-C-eDP-1
[393.736389] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.368s)
[393.748642] Starting dynamic subtest: pipe-D-eDP-1
[395.137317] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.404s)
[395.139259] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.639s)
[396.290856] [071/133] (635s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[396.345202] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[396.350074] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[396.532445] [072/133] (635s left) gem_ctx_engines (invalid-engines)
[396.587028] Starting subtest: invalid-engines
[396.596457] Subtest invalid-engines: SUCCESS (0.009s)
[396.818287] [073/133] (635s left) gem_exec_params (dr4-dirt)
[396.879387] Starting subtest: DR4-dirt
[396.881694] Subtest DR4-dirt: SUCCESS (0.000s)
[396.980975] [074/133] (634s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[397.068620] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[397.072766] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[397.150947] [075/133] (634s left) sw_sync (sync_multi_producer_single_consumer)
[397.193471] Starting subtest: sync_multi_producer_single_consumer
[398.264591] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[398.327984] [076/133] (633s left) syncobj_timeline (wait-all-for-submit-complex)
[398.398046] Starting subtest: wait-all-for-submit-complex
[398.611989] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[398.687739] [077/133] (633s left) gem_eio (execbuf)
[398.894561] Starting subtest: execbuf
[399.212330] Subtest execbuf: SUCCESS (0.316s)
[399.395443] [078/133] (632s left) gem_partial_pwrite_pread (writes-after-reads)
[399.451714] Subtest writes-after-reads: SKIP (0.000s)
[399.525165] [079/133] (632s left) kms_feature_discovery (dp-mst)
[399.625620] Starting subtest: dp-mst
[399.629422] Subtest dp-mst: SKIP (0.000s)
[399.703264] [080/133] (632s left) perf (low-oa-exponent-permissions)
[399.820261] Starting subtest: low-oa-exponent-permissions
[399.858416] Subtest low-oa-exponent-permissions: SUCCESS (0.039s)
[399.910747] [081/133] (632s left) gem_exec_fence (syncobj-import)
[400.334662] Starting subtest: syncobj-import
[400.340457] Subtest syncobj-import: SUCCESS (0.005s)
[401.417341] [082/133] (630s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[401.514541] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[401.516634] Starting dynamic subtest: pipe-A-eDP-1
[401.601745] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[401.613043] Starting dynamic subtest: pipe-B-eDP-1
[402.836906] Dynamic subtest pipe-B-eDP-1: SKIP (1.233s)
[402.841367] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.325s)
[404.086559] [083/133] (628s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[404.211762] Starting subtest: cursorB-vs-flipB-atomic
[404.216438] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[404.356559] [084/133] (628s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[404.454883] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[404.467623] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.012s)
[404.546373] [085/133] (627s left) kms_vblank (ts-continuation-idle)
[404.635262] Starting subtest: ts-continuation-idle
[404.637141] Starting dynamic subtest: pipe-A-eDP-1
[405.040626] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.406s)
[405.056306] Starting dynamic subtest: pipe-D-eDP-1
[406.138575] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.097s)
[406.141047] Subtest ts-continuation-idle: SUCCESS (1.506s)
[406.988398] [086/133] (625s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[407.085187] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[407.089566] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[408.215092] [087/133] (624s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[408.315201] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[408.319462] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[408.439105] [088/133] (624s left) syncobj_eventfd (invalid-bad-flags)
[408.494604] Starting subtest: invalid-bad-flags
[408.496901] Subtest invalid-bad-flags: SUCCESS (0.000s)
[408.592588] [089/133] (624s left) kms_pwrite_crc (basic)
[408.679169] Starting subtest: basic
[409.365825] Subtest basic: SUCCESS (0.687s)
[410.188473] [090/133] (622s left) gem_sync (basic-store-each)
[410.273610] Starting subtest: basic-store-each
[412.677468] Subtest basic-store-each: SUCCESS (2.416s)
[412.863716] [091/133] (619s left) kms_universal_plane (universal-plane-sanity)
[412.962853] Starting subtest: universal-plane-sanity
[412.964804] Starting dynamic subtest: pipe-A-eDP-1
[413.575207] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.611s)
[413.585758] Starting dynamic subtest: pipe-B-eDP-1
[414.772712] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.198s)
[414.788170] Starting dynamic subtest: pipe-C-eDP-1
[415.949476] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.175s)
[415.962556] Starting dynamic subtest: pipe-D-eDP-1
[417.160481] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.207s)
[417.162410] Subtest universal-plane-sanity: SUCCESS (4.198s)
[417.995028] [092/133] (614s left) gem_spin_batch (legacy)
[418.066029] Starting subtest: legacy
[418.067942] Starting dynamic subtest: default
[421.303819] Dynamic subtest default: SUCCESS (3.235s)
[421.314491] Starting dynamic subtest: render
[424.539803] Dynamic subtest render: SUCCESS (3.232s)
[424.551489] Starting dynamic subtest: bsd
[427.778602] Dynamic subtest bsd: SUCCESS (3.236s)
[427.789774] Starting dynamic subtest: bsd1
[431.017252] Dynamic subtest bsd1: SUCCESS (3.235s)
[431.027859] Starting dynamic subtest: bsd2
[434.251713] Dynamic subtest bsd2: SUCCESS (3.231s)
[434.264064] Starting dynamic subtest: blt
[437.491863] Dynamic subtest blt: SUCCESS (3.236s)
[437.504748] Starting dynamic subtest: vebox
[440.726052] Dynamic subtest vebox: SUCCESS (3.233s)
[440.728111] Subtest legacy: SUCCESS (22.660s)
[441.378045] [093/133] (591s left) kms_rotation_crc (primary-rotation-90)
[441.474022] Starting subtest: primary-rotation-90
[441.478422] Subtest primary-rotation-90: SKIP (0.001s)
[441.549884] [094/133] (591s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[441.635672] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[450.394443] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.760s)
[450.558319] [095/133] (582s left) api_intel_allocator (default-alignment)
[450.619243] Starting subtest: default-alignment
[450.621631] Subtest default-alignment: SUCCESS (0.004s)
[450.741303] [096/133] (582s left) kms_chamelium_frames (hdmi-frame-dump)
[451.121675] Subtest hdmi-frame-dump: SKIP (0.000s)
[451.954303] [097/133] (581s left) kms_chamelium_audio (hdmi-audio)
[452.327358] Subtest hdmi-audio: SKIP (0.000s)
[453.154366] [098/133] (579s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[453.260053] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[454.073372] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.815s)
[454.238395] [099/133] (578s left) gen7_exec_parse (bitmasks)
[454.312298] Subtest bitmasks: SKIP (0.000s)
[454.387664] [100/133] (578s left) gem_mmap_wc (set-cache-level)
[454.443056] Subtest set-cache-level: SKIP (0.000s)
[454.507805] [101/133] (578s left) gem_madvise (dontneed-before-exec)
[454.538702] Starting subtest: dontneed-before-exec
[454.565880] Subtest dontneed-before-exec: SKIP (0.023s)
[454.628747] [102/133] (578s left) i915_module_load (resize-bar)
[454.665653] Starting subtest: resize-bar
[454.672821] Subtest resize-bar: SKIP (0.007s)
[454.716027] [103/133] (578s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[454.814065] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[454.816176] Starting dynamic subtest: pipe-A-eDP-1
[454.824752] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[454.835270] Starting dynamic subtest: pipe-B-eDP-1
[454.843827] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[454.854340] Starting dynamic subtest: pipe-C-eDP-1
[454.862285] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[454.872440] Starting dynamic subtest: pipe-D-eDP-1
[454.880458] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[454.884390] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s)
[457.080819] [104/133] (576s left) gem_eio (wait-immediate)
[457.294676] Starting subtest: wait-immediate
[457.648221] Subtest wait-immediate: SUCCESS (0.354s)
[457.804821] [105/133] (575s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[457.923590] Starting subtest: 2x-long-flip-vs-cursor-legacy
[457.928023] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[458.068117] [106/133] (575s left) gem_exec_reloc (basic-gtt-wc-active)
[458.120107] Subtest basic-gtt-wc-active: SKIP (0.000s)
[458.191511] [107/133] (575s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[458.275830] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[458.279657] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[458.349021] [108/133] (575s left) kms_frontbuffer_tracking (fbc-tiling-4)
[458.441293] Starting subtest: fbc-tiling-4
[462.633576] Subtest fbc-tiling-4: SUCCESS (4.195s)
[463.803701] [109/133] (569s left) kms_big_fb (linear-32bpp-rotate-270)
[463.903912] Starting subtest: linear-32bpp-rotate-270
[463.923422] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[464.029810] [110/133] (569s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[464.112261] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[464.114567] Starting dynamic subtest: pipe-A
[464.223643] Dynamic subtest pipe-A: SKIP (0.107s)
[464.234388] Starting dynamic subtest: pipe-B
[465.412261] Dynamic subtest pipe-B: SKIP (1.189s)
[465.423425] Starting dynamic subtest: pipe-C
[466.612944] Dynamic subtest pipe-C: SUCCESS (1.205s)
[466.624643] Starting dynamic subtest: pipe-D
[467.813858] Dynamic subtest pipe-D: SUCCESS (1.199s)
[467.816252] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.705s)
[468.977244] [111/133] (564s left) fbdev (pan)
[469.021688] Starting subtest: pan
[469.047757] Subtest pan: SUCCESS (0.028s)
[469.143566] [112/133] (564s left) gem_exec_capture (pi)
[469.203398] Starting subtest: pi
[469.205353] Starting dynamic subtest: rcs0
[473.211660] Dynamic subtest rcs0: SUCCESS (4.011s)
[473.225635] Starting dynamic subtest: bcs0
[477.165210] Dynamic subtest bcs0: SUCCESS (3.951s)
[477.176140] Starting dynamic subtest: vcs0
[481.085346] Dynamic subtest vcs0: SUCCESS (3.918s)
[481.097922] Starting dynamic subtest: vcs1
[484.978890] Dynamic subtest vcs1: SUCCESS (3.891s)
[484.995495] Starting dynamic subtest: vecs0
[488.966655] Dynamic subtest vecs0: SUCCESS (3.986s)
[488.977809] Starting dynamic subtest: ccs0
[492.918243] Dynamic subtest ccs0: SUCCESS (3.950s)
[492.920463] Subtest pi: SUCCESS (23.718s)
[492.998669] [113/133] (540s left) i915_query (query-regions-garbage-items)
[493.097433] Starting subtest: query-regions-garbage-items
[493.099649] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[493.204690] [114/133] (540s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[493.328909] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[493.333279] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[493.411461] [115/133] (540s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[493.517511] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[493.521455] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[493.600838] [116/133] (540s left) gem_userptr_blits (sd-probe)
[493.663931] Starting subtest: sd-probe
[493.665941] Subtest sd-probe: SUCCESS (0.000s)
[493.776620] [117/133] (540s left) i915_drm_fdinfo (busy-check-all)
[493.820786] Starting subtest: busy-check-all
[493.823296] Starting dynamic subtest: rcs0
[493.828263] Dynamic subtest rcs0: SKIP (0.003s)
[493.840803] Starting dynamic subtest: bcs0
[493.845079] Dynamic subtest bcs0: SKIP (0.000s)
[493.855625] Starting dynamic subtest: vcs0
[493.859656] Dynamic subtest vcs0: SKIP (0.000s)
[493.869640] Starting dynamic subtest: vcs1
[493.873690] Dynamic subtest vcs1: SKIP (0.000s)
[493.886127] Starting dynamic subtest: vecs0
[493.889369] Dynamic subtest vecs0: SKIP (0.000s)
[493.898530] Starting dynamic subtest: ccs0
[493.901774] Dynamic subtest ccs0: SKIP (0.000s)
[493.904979] Subtest busy-check-all: SKIP (0.008s)
[493.942801] [118/133] (539s left) syncobj_timeline (wait-zero-handles)
[494.025108] Starting subtest: wait-zero-handles
[494.027150] Subtest wait-zero-handles: SUCCESS (0.000s)
[494.110326] [119/133] (539s left) syncobj_basic (bad-create-flags)
[494.174507] Starting subtest: bad-create-flags
[494.176587] Subtest bad-create-flags: SUCCESS (0.000s)
[494.278089] [120/133] (539s left) perf_pmu (busy-start)
[494.323155] Starting subtest: busy-start
[494.325058] Starting dynamic subtest: rcs0
[496.874106] Dynamic subtest rcs0: SUCCESS (2.550s)
[496.885776] Starting dynamic subtest: bcs0
[499.425256] Dynamic subtest bcs0: SUCCESS (2.549s)
[499.437208] Starting dynamic subtest: vcs0
[503.329662] Dynamic subtest vcs0: SUCCESS (3.900s)
[503.343491] Starting dynamic subtest: vcs1
[507.360769] Dynamic subtest vcs1: SUCCESS (4.029s)
[507.374672] Starting dynamic subtest: vecs0
[511.329342] Dynamic subtest vecs0: SUCCESS (3.965s)
[511.342758] Starting dynamic subtest: ccs0
[513.880673] Dynamic subtest ccs0: SUCCESS (2.550s)
[513.883220] Subtest busy-start: SUCCESS (19.558s)
[513.971755] [121/133] (520s left) gem_ctx_persistence (processes)
[514.029782] Starting subtest: processes
[515.304456] Subtest processes: SUCCESS (1.277s)
[515.384465] [122/133] (518s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[515.485609] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[515.489764] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[515.586062] [123/133] (518s left) gen3_mixed_blits
[515.695684] [124/133] (518s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[515.801259] Starting subtest: async-flip-with-page-flip-events-tiled
[516.171956] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[518.915358] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.741s)
[518.927582] Starting dynamic subtest: pipe-A-eDP-1-4
[521.086552] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.171s)
[521.097582] Starting dynamic subtest: pipe-A-eDP-1-4
[523.096687] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[523.107784] Starting dynamic subtest: pipe-A-eDP-1-x
[525.276061] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.176s)
[525.682720] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[528.414036] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.739s)
[528.427223] Starting dynamic subtest: pipe-B-eDP-1-4
[530.599704] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s)
[530.613098] Starting dynamic subtest: pipe-B-eDP-1-4
[532.609985] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[532.620942] Starting dynamic subtest: pipe-B-eDP-1-x
[534.799890] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[535.164321] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[537.907318] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.751s)
[537.918368] Starting dynamic subtest: pipe-C-eDP-1-4
[540.081975] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[540.092698] Starting dynamic subtest: pipe-C-eDP-1-4
[542.092588] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[542.103599] Starting dynamic subtest: pipe-C-eDP-1-x
[544.271266] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[544.635074] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[547.414071] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.787s)
[547.426677] Starting dynamic subtest: pipe-D-eDP-1-4
[549.604491] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.184s)
[549.618746] Starting dynamic subtest: pipe-D-eDP-1-4
[551.610270] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[551.622765] Starting dynamic subtest: pipe-D-eDP-1-x
[553.833048] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.222s)
[553.835505] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.034s)
[555.091319] [125/133] (479s left) gem_exec_whisper (basic-contexts)
[555.154176] Starting subtest: basic-contexts
[561.867246] Subtest basic-contexts: SUCCESS (6.712s)
[562.058443] [126/133] (472s left) kms_cursor_crc (cursor-random-512x170)
[562.364592] Starting subtest: cursor-random-512x170
[562.369019] Subtest cursor-random-512x170: SKIP (0.001s)
[562.499696] [127/133] (471s left) kms_color_pipeline (plane-ctm3x4)
[562.592101] Starting subtest: plane-ctm3x4
[562.740960] Starting dynamic subtest: pipe-A-plane-0
[562.871223] Dynamic subtest pipe-A-plane-0: SUCCESS (0.133s)
[562.882905] Starting dynamic subtest: pipe-A-plane-1
[562.993077] Dynamic subtest pipe-A-plane-1: SUCCESS (0.121s)
[563.004356] Starting dynamic subtest: pipe-A-plane-2
[563.117290] Dynamic subtest pipe-A-plane-2: SUCCESS (0.122s)
[564.331383] Starting dynamic subtest: pipe-B-plane-0
[564.500480] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s)
[564.513722] Starting dynamic subtest: pipe-B-plane-1
[564.656044] Dynamic subtest pipe-B-plane-1: SUCCESS (0.154s)
[564.667053] Starting dynamic subtest: pipe-B-plane-2
[564.811056] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[566.062237] Starting dynamic subtest: pipe-C-plane-0
[566.186113] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[566.197518] Starting dynamic subtest: pipe-C-plane-1
[566.319531] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s)
[566.330588] Starting dynamic subtest: pipe-C-plane-2
[566.453037] Dynamic subtest pipe-C-plane-2: SUCCESS (0.132s)
[567.624232] Starting dynamic subtest: pipe-D-plane-0
[567.737694] Dynamic subtest pipe-D-plane-0: SUCCESS (0.122s)
[567.749092] Starting dynamic subtest: pipe-D-plane-1
[567.847946] Dynamic subtest pipe-D-plane-1: SUCCESS (0.110s)
[567.858937] Starting dynamic subtest: pipe-D-plane-2
[567.970551] Dynamic subtest pipe-D-plane-2: SUCCESS (0.121s)
[568.259243] Subtest plane-ctm3x4: SUCCESS (5.667s)
[569.093574] [128/133] (465s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[569.187580] Starting subtest: fbcpsr-1p-rte
[576.101078] Subtest fbcpsr-1p-rte: SUCCESS (6.917s)
[576.237952] [129/133] (458s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[576.356631] Starting subtest: basic-flip-before-cursor-legacy
[577.299338] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.941s)
[578.162590] [130/133] (456s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[578.256956] Starting subtest: plane-upscale-factor-0-25-with-rotation
[578.259258] Starting dynamic subtest: pipe-A
[578.480911] Dynamic subtest pipe-A: SUCCESS (0.227s)
[578.492048] Starting dynamic subtest: pipe-B
[579.809968] Dynamic subtest pipe-B: SUCCESS (1.327s)
[579.820958] Starting dynamic subtest: pipe-C
[581.115193] Dynamic subtest pipe-C: SUCCESS (1.303s)
[581.128904] Starting dynamic subtest: pipe-D
[582.423707] Dynamic subtest pipe-D: SUCCESS (1.306s)
[582.426371] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.170s)
[583.573466] [131/133] (450s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[583.693267] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[615.532268] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.838s)
[616.365483] [132/133] (418s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[616.477476] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[616.481796] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[616.582043] [133/133] (418s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[618.509088] Starting subtest: dpms-mode-unset-lpsp
[622.563752] Subtest dpms-mode-unset-lpsp: SUCCESS (4.059s)
[622.948634] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_mmap_gtt
results: parsing output: 2/ for test: kms_flip
results: parsing output: 3/ for test: syncobj_wait
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_pipe_crc_basic
results: parsing output: 6/ for test: kms_dp_link_training
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: gem_ctx_isolation
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_rotation_crc
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: core_setmaster
results: parsing output: 13/ for test: gem_eio
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: gem_ppgtt
results: parsing output: 17/ for test: kms_getfb
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_properties
results: parsing output: 21/ for test: kms_flip_scaled_crc
results: parsing output: 22/ for test: gem_exec_reloc
results: parsing output: 23/ for test: i915_query
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: gem_exec_fence
results: parsing output: 26/ for test: gem_mmap_wc
results: parsing output: 27/ for test: kms_cursor_edge_walk
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: prime_vgem
results: parsing output: 35/ for test: gem_mmap_offset
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: kms_hdr
results: parsing output: 38/ for test: gem_render_copy
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: kms_pm_rpm
results: parsing output: 41/ for test: gem_exec_schedule
results: parsing output: 42/ for test: kms_pipe_crc_basic
results: parsing output: 43/ for test: gem_exec_schedule
results: parsing output: 44/ for test: gem_huc_copy
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_content_protection
results: parsing output: 47/ for test: core_getclient
results: parsing output: 48/ for test: gem_mmap
results: parsing output: 49/ for test: perf_pmu
results: parsing output: 50/ for test: gem_partial_pwrite_pread
results: parsing output: 51/ for test: gem_ctx_sseu
results: parsing output: 52/ for test: kms_plane_multiple
results: parsing output: 53/ for test: gem_fenced_exec_thrash
results: parsing output: 54/ for test: i915_pm_rpm
results: parsing output: 55/ for test: kms_async_flips
results: parsing output: 56/ for test: kms_cursor_crc
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_exec_await
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: kms_plane
results: parsing output: 62/ for test: gem_exec_balancer
results: parsing output: 63/ for test: kms_chamelium_hpd
results: parsing output: 64/ for test: gem_exec_reloc
results: parsing output: 65/ for test: kms_hdmi_inject
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: kms_flip
results: parsing output: 68/ for test: kms_lease
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: gem_render_copy
results: parsing output: 71/ for test: gem_ctx_engines
results: parsing output: 72/ for test: gem_exec_params
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: sw_sync
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: gem_eio
results: parsing output: 77/ for test: gem_partial_pwrite_pread
results: parsing output: 78/ for test: kms_feature_discovery
results: parsing output: 79/ for test: perf
results: parsing output: 80/ for test: gem_exec_fence
results: parsing output: 81/ for test: kms_psr2_sf
results: parsing output: 82/ for test: kms_cursor_legacy
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: kms_vblank
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: syncobj_eventfd
results: parsing output: 88/ for test: kms_pwrite_crc
results: parsing output: 89/ for test: gem_sync
results: parsing output: 90/ for test: kms_universal_plane
results: parsing output: 91/ for test: gem_spin_batch
results: parsing output: 92/ for test: kms_rotation_crc
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: api_intel_allocator
results: parsing output: 95/ for test: kms_chamelium_frames
results: parsing output: 96/ for test: kms_chamelium_audio
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: gen7_exec_parse
results: parsing output: 99/ for test: gem_mmap_wc
results: parsing output: 100/ for test: gem_madvise
results: parsing output: 101/ for test: i915_module_load
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: gem_eio
results: parsing output: 104/ for test: kms_cursor_legacy
results: parsing output: 105/ for test: gem_exec_reloc
results: parsing output: 106/ for test: kms_psr2_sf
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_plane_scaling
results: parsing output: 110/ for test: fbdev
results: parsing output: 111/ for test: gem_exec_capture
results: parsing output: 112/ for test: i915_query
results: parsing output: 113/ for test: kms_flip_scaled_crc
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_userptr_blits
results: parsing output: 116/ for test: i915_drm_fdinfo
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: syncobj_basic
results: parsing output: 119/ for test: perf_pmu
results: parsing output: 120/ for test: gem_ctx_persistence
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gen3_mixed_blits
results: parsing output: 123/ for test: kms_async_flips
results: parsing output: 124/ for test: gem_exec_whisper
results: parsing output: 125/ for test: kms_cursor_crc
results: parsing output: 126/ for test: kms_color_pipeline
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_cursor_legacy
results: parsing output: 129/ for test: kms_plane_scaling
results: parsing output: 130/ for test: kms_cursor_legacy
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_pm_rpm
Done.