[57.460850] Initializing watchdogs
[57.460902]   /dev/watchdog0
[57.478026] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.482359] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.484556] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.487942] [001/133] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[57.610140] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[57.614231] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[57.720885] [002/133] (960s left) gem_mmap_gtt (fault-concurrent-x)
[57.776232] Subtest fault-concurrent-X: SKIP (0.000s)
[57.832691] [003/133] (960s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[57.915681] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[57.928106] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[57.999930] [004/133] (960s left) syncobj_wait (wait-any-snapshot)
[58.057107] Starting subtest: wait-any-snapshot
[58.138599] Subtest wait-any-snapshot: SUCCESS (0.082s)
[58.209314] [005/133] (959s left) kms_frontbuffer_tracking (psr-1p-rte)
[58.308018] Starting subtest: psr-1p-rte
[63.673907] Subtest psr-1p-rte: SUCCESS (5.395s)
[63.818232] [006/133] (954s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[63.914381] Starting subtest: disable-crc-after-crtc
[63.916358] Starting dynamic subtest: pipe-A-eDP-1
[65.602731] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.694s)
[65.611903] Starting dynamic subtest: pipe-B-eDP-1
[67.899651] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.300s)
[67.908572] Starting dynamic subtest: pipe-C-eDP-1
[70.148064] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.251s)
[70.157718] Starting dynamic subtest: pipe-D-eDP-1
[72.406496] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.258s)
[72.408987] Subtest disable-crc-after-crtc: SUCCESS (8.508s)
[73.233146] [007/133] (944s left) kms_dp_link_training (uhbr-sst)
[73.386778] Starting subtest: uhbr-sst
[73.395617] Subtest uhbr-sst: SKIP (0.000s)
[73.625083] [008/133] (944s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[73.684478] Starting subtest: invalid-single-wait-all-unsubmitted
[73.686474] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[73.792382] [009/133] (944s left) gem_ctx_isolation (preservation)
[73.862764] Starting subtest: preservation
[73.865351] Starting dynamic subtest: rcs0
[74.002802] Dynamic subtest rcs0: SUCCESS (0.142s)
[74.012531] Starting dynamic subtest: bcs0
[74.150877] Dynamic subtest bcs0: SUCCESS (0.148s)
[74.161566] Starting dynamic subtest: vcs0
[74.297701] Dynamic subtest vcs0: SUCCESS (0.147s)
[74.306605] Starting dynamic subtest: vcs1
[75.366579] Dynamic subtest vcs1: SUCCESS (1.069s)
[75.377736] Starting dynamic subtest: vecs0
[77.436062] Dynamic subtest vecs0: SUCCESS (2.070s)
[77.447258] Starting dynamic subtest: ccs0
[79.443073] Dynamic subtest ccs0: SUCCESS (2.008s)
[79.445766] Subtest preservation: SUCCESS (5.587s)
[79.693947] [010/133] (938s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[79.800635] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[79.804973] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[79.900793] [011/133] (938s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[79.996825] Starting subtest: primary-y-tiled-reflect-x-270
[80.001375] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[80.068683] [012/133] (938s left) kms_psr (fbc-psr-no-drrs)
[80.169898] Starting subtest: fbc-psr-no-drrs
[80.172345] Starting dynamic subtest: eDP-1
[80.176868] Dynamic subtest eDP-1: SKIP (0.000s)
[80.181461] Subtest fbc-psr-no-drrs: SKIP (0.000s)
[80.239320] [013/133] (938s left) core_setmaster (master-drop-set-user)
[80.326946] Starting subtest: master-drop-set-user
[80.339836] Subtest master-drop-set-user: SUCCESS (0.014s)
[80.379307] [014/133] (938s left) gem_eio (wait-1us)
[80.580889] Starting subtest: wait-1us
[80.874031] Subtest wait-1us: SUCCESS (0.293s)
[81.020958] [015/133] (937s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[81.110952] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[81.113088] Starting dynamic subtest: pipe-A-eDP-1
[81.130747] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[81.138828] Starting dynamic subtest: pipe-B-eDP-1
[81.155316] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[81.163043] Starting dynamic subtest: pipe-C-eDP-1
[81.179308] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[81.186693] Starting dynamic subtest: pipe-D-eDP-1
[81.203671] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[81.205498] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[83.390233] [016/133] (935s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[83.497416] Starting subtest: y-tiled-16bpp-rotate-90
[83.501495] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[83.597170] [017/133] (935s left) gem_ppgtt (shrink-vs-evict-pinned)
[83.662042] Starting subtest: shrink-vs-evict-pinned
[91.246920] Subtest shrink-vs-evict-pinned: SUCCESS (7.583s)
[91.328973] [018/133] (927s left) kms_getfb (getfb-reject-nv12)
[91.428949] Starting subtest: getfb-reject-nv12
[91.431250] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[91.537309] [019/133] (927s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[91.645665] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[99.400804] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.759s)
[99.511787] [020/133] (919s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[99.623626] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[99.628096] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[99.720333] [021/133] (919s left) kms_properties (plane-properties-legacy)
[99.809716] Starting subtest: plane-properties-legacy
[99.811696] Starting dynamic subtest: pipe-A-eDP-1
[100.394330] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.585s)
[100.404351] Starting dynamic subtest: pipe-B-eDP-1
[101.704084] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.308s)
[101.714806] Starting dynamic subtest: pipe-C-eDP-1
[102.942356] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.236s)
[102.952148] Starting dynamic subtest: pipe-D-eDP-1
[104.175775] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.233s)
[104.177746] Subtest plane-properties-legacy: SUCCESS (4.366s)
[104.972131] [022/133] (913s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[105.073168] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[105.077313] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[105.156975] [023/133] (913s left) gem_exec_reloc (basic-cpu-noreloc)
[105.228257] Subtest basic-cpu-noreloc: SKIP (0.000s)
[105.294384] [024/133] (913s left) i915_query (query-topology-coherent-slice-mask)
[105.346985] Starting subtest: query-topology-coherent-slice-mask
[105.351457] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[105.445767] [025/133] (913s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[105.512038] Starting subtest: multi-wait-available-submitted-signaled
[105.514415] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s)
[105.608585] [026/133] (913s left) gem_exec_fence (syncobj-unused-fence)
[106.075540] Starting subtest: syncobj-unused-fence
[106.077552] Subtest syncobj-unused-fence: SUCCESS (0.005s)
[107.337037] [FACT gem_exec_fence (syncobj-unused-fence)] new: kernel.kmod_is_loaded.vgem: true
[107.340657] [027/133] (911s left) gem_mmap_wc (write-read-distinct)
[107.406994] Subtest write-read-distinct: SKIP (0.000s)
[107.467518] [028/133] (911s left) kms_cursor_edge_walk (128x128-top-bottom)
[107.561890] Starting subtest: 128x128-top-bottom
[107.564077] Starting dynamic subtest: pipe-A-eDP-1
[111.040214] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.478s)
[111.049568] Starting dynamic subtest: pipe-D-eDP-1
[114.173534] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.132s)
[114.175848] Subtest 128x128-top-bottom: SUCCESS (6.612s)
[114.966405] [029/133] (904s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[115.074675] Starting subtest: fbc-psr2-primary-mmap-cpu
[115.076954] Starting dynamic subtest: eDP-1
[115.081109] Dynamic subtest eDP-1: SKIP (0.000s)
[115.085094] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[115.148903] [030/133] (903s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[115.239763] Starting subtest: x-tiled-32bpp-rotate-270
[115.262421] Subtest x-tiled-32bpp-rotate-270: SKIP (0.020s)
[115.363059] [031/133] (903s left) kms_psr (pr-cursor-mmap-cpu)
[115.451852] Starting subtest: pr-cursor-mmap-cpu
[115.456361] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[115.528557] [032/133] (903s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[115.620328] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[115.624754] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[115.720312] [033/133] (903s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[115.813608] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[115.818101] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[115.912092] [034/133] (903s left) kms_big_fb (yf-tiled-addfb)
[116.011037] Starting subtest: yf-tiled-addfb
[116.014733] Subtest yf-tiled-addfb: SKIP (0.000s)
[116.102964] [035/133] (903s left) prime_vgem (wait)
[116.162078] Starting subtest: wait
[116.163948] Starting dynamic subtest: rcs0
[116.205699] Dynamic subtest rcs0: SUCCESS (0.043s)
[116.213728] Starting dynamic subtest: bcs0
[116.251641] Dynamic subtest bcs0: SUCCESS (0.045s)
[116.259770] Starting dynamic subtest: vcs0
[116.300305] Dynamic subtest vcs0: SUCCESS (0.048s)
[116.308070] Starting dynamic subtest: vcs1
[116.344742] Dynamic subtest vcs1: SUCCESS (0.044s)
[116.352627] Starting dynamic subtest: vecs0
[116.394505] Dynamic subtest vecs0: SUCCESS (0.049s)
[116.402570] Starting dynamic subtest: ccs0
[116.438827] Dynamic subtest ccs0: SUCCESS (0.044s)
[116.440672] Subtest wait: SUCCESS (0.277s)
[116.555887] [036/133] (902s left) gem_mmap_offset (partial-remap)
[116.607073] Starting subtest: partial-remap
[116.608897] Starting dynamic subtest: smem0
[116.616137] Dynamic subtest smem0: SUCCESS (0.004s)
[116.617866] Subtest partial-remap: SUCCESS (0.004s)
[116.727488] [037/133] (902s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[116.824499] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[116.826483] Starting dynamic subtest: pipe-A-eDP-1
[122.680976] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.858s)
[122.691953] Starting dynamic subtest: pipe-B-eDP-1
[129.333094] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.649s)
[129.335438] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.510s)
[130.210361] [038/133] (889s left) kms_hdr (static-toggle-suspend)
[130.312610] Starting subtest: static-toggle-suspend
[130.319182] Subtest static-toggle-suspend: SKIP (0.000s)
[130.387045] [039/133] (889s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[130.451025] Starting subtest: yf-tiled-to-vebox-yf-tiled
[130.455537] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[130.634748] [040/133] (888s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[130.740494] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[130.742929] Starting dynamic subtest: pipe-A-eDP-1
[130.766523] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[130.777341] Starting dynamic subtest: pipe-B-eDP-1
[130.798787] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[130.807324] Starting dynamic subtest: pipe-C-eDP-1
[130.828125] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[130.836044] Starting dynamic subtest: pipe-D-eDP-1
[130.857183] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[130.861402] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[133.078999] [041/133] (886s left) kms_pm_rpm (pc8-residency)
[134.636404] Starting subtest: pc8-residency
[134.641751] Subtest pc8-residency: SKIP (0.000s)
[135.348381] [042/133] (884s left) gem_exec_schedule (preemptive-hang)
[135.525686] Starting subtest: preemptive-hang
[135.528052] Starting dynamic subtest: rcs0
[144.494020] Dynamic subtest rcs0: SUCCESS (8.962s)
[144.505430] Starting dynamic subtest: bcs0
[153.379931] Dynamic subtest bcs0: SUCCESS (8.892s)
[153.390053] Starting dynamic subtest: vcs0
[162.412714] Dynamic subtest vcs0: SUCCESS (9.028s)
[162.426140] Starting dynamic subtest: vcs1
[171.433608] Dynamic subtest vcs1: SUCCESS (9.017s)
[171.442244] Starting dynamic subtest: vecs0
[180.387640] Dynamic subtest vecs0: SUCCESS (8.959s)
[180.395828] Starting dynamic subtest: ccs0
[189.421039] Dynamic subtest ccs0: SUCCESS (9.026s)
[189.423685] Subtest preemptive-hang: SUCCESS (53.890s)
[189.663915] [043/133] (829s left) kms_pipe_crc_basic (bad-source)
[189.761046] Starting subtest: bad-source
[189.763333] Subtest bad-source: SUCCESS (0.000s)
[189.830123] [044/133] (829s left) gem_exec_schedule (preempt-user)
[189.902851] Starting subtest: preempt-user
[189.905125] Starting dynamic subtest: rcs0
[189.919809] Dynamic subtest rcs0: SUCCESS (0.023s)
[189.933998] Starting dynamic subtest: bcs0
[189.938764] Dynamic subtest bcs0: SUCCESS (0.019s)
[189.947381] Starting dynamic subtest: vcs0
[189.958033] Dynamic subtest vcs0: SUCCESS (0.019s)
[189.966385] Starting dynamic subtest: vcs1
[189.981291] Dynamic subtest vcs1: SUCCESS (0.023s)
[189.989899] Starting dynamic subtest: vecs0
[190.001359] Dynamic subtest vecs0: SUCCESS (0.020s)
[190.010564] Starting dynamic subtest: ccs0
[190.028384] Dynamic subtest ccs0: SUCCESS (0.026s)
[190.030707] Subtest preempt-user: SUCCESS (0.133s)
[191.379775] [045/133] (828s left) gem_huc_copy (huc-copy)
[191.446271] Starting subtest: huc-copy
[191.451402] Subtest huc-copy: SUCCESS (0.003s)
[191.574022] [046/133] (828s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[191.698895] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[192.746213] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.048s)
[192.880829] [047/133] (826s left) kms_content_protection (dp-mst-lic-type-1)
[193.027640] Starting subtest: dp-mst-lic-type-1
[193.031323] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[193.156066] [048/133] (826s left) core_getclient (basic)
[193.204576] Starting subtest: basic
[193.206281] Subtest basic: SUCCESS (0.000s)
[193.293135] [049/133] (826s left) gem_mmap (short-mmap)
[193.357381] Subtest short-mmap: SKIP (0.000s)
[193.422039] [050/133] (826s left) perf_pmu (busy-check-all)
[193.467618] Starting subtest: busy-check-all
[193.469457] Starting dynamic subtest: rcs0
[194.019151] Dynamic subtest rcs0: SUCCESS (0.553s)
[194.029677] Starting dynamic subtest: bcs0
[194.568509] Dynamic subtest bcs0: SUCCESS (0.547s)
[194.580113] Starting dynamic subtest: vcs0
[196.285852] Dynamic subtest vcs0: SUCCESS (1.714s)
[196.297916] Starting dynamic subtest: vcs1
[198.270075] Dynamic subtest vcs1: SUCCESS (1.982s)
[198.281933] Starting dynamic subtest: vecs0
[200.318452] Dynamic subtest vecs0: SUCCESS (2.046s)
[200.331085] Starting dynamic subtest: ccs0
[200.876081] Dynamic subtest ccs0: SUCCESS (0.557s)
[200.882047] Subtest busy-check-all: SUCCESS (7.410s)
[200.992517] [051/133] (818s left) gem_partial_pwrite_pread (write-display)
[201.052198] Subtest write-display: SKIP (0.000s)
[201.125660] [052/133] (818s left) gem_ctx_sseu (invalid-sseu)
[201.176801] Subtest invalid-sseu: SKIP (0.000s)
[201.252814] [053/133] (818s left) kms_plane_multiple (tiling-none)
[201.348065] Starting subtest: tiling-none
[201.349895] Starting dynamic subtest: pipe-A-eDP-1
[205.164295] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.815s)
[205.173904] Starting dynamic subtest: pipe-B-eDP-1
[209.606386] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.442s)
[209.616050] Starting dynamic subtest: pipe-C-eDP-1
[213.946482] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.339s)
[213.956741] Starting dynamic subtest: pipe-D-eDP-1
[218.299436] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.351s)
[218.301841] Subtest tiling-none: SUCCESS (16.953s)
[219.102442] [054/133] (801s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[219.167060] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[219.237501] [055/133] (800s left) i915_pm_rpm (system-suspend-devices)
[221.465503] Starting subtest: system-suspend-devices
[229.289734] Subtest system-suspend-devices: SUCCESS (7.824s)
[229.660927] [056/133] (790s left) kms_async_flips (test-time-stamp-atomic)
[229.769040] Starting subtest: test-time-stamp-atomic
[230.148561] Starting dynamic subtest: pipe-A-eDP-1
[230.956267] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.805s)
[231.335174] Starting dynamic subtest: pipe-B-eDP-1
[232.092883] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.764s)
[232.477129] Starting dynamic subtest: pipe-C-eDP-1
[233.236346] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.764s)
[233.613058] Starting dynamic subtest: pipe-D-eDP-1
[234.365255] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.768s)
[234.367717] Subtest test-time-stamp-atomic: SUCCESS (4.596s)
[235.524925] [057/133] (784s left) kms_cursor_crc (cursor-offscreen-256x256)
[235.762989] Starting subtest: cursor-offscreen-256x256
[235.765305] Starting dynamic subtest: pipe-A-eDP-1
[237.714834] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.949s)
[237.743581] Starting dynamic subtest: pipe-D-eDP-1
[240.329140] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.592s)
[240.331235] Subtest cursor-offscreen-256x256: SUCCESS (4.567s)
[241.191209] [058/133] (779s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[241.295123] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[241.299071] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[241.399133] [059/133] (778s left) gem_exec_await (wide-contexts)
[241.603861] Starting subtest: wide-contexts
[265.230553] Subtest wide-contexts: SUCCESS (23.625s)
[265.440047] [060/133] (754s left) kms_flip (nonexisting-fb-interruptible)
[265.598722] Starting subtest: nonexisting-fb-interruptible
[265.600665] Starting dynamic subtest: A-eDP1
[266.776690] Dynamic subtest A-eDP1: SUCCESS (1.176s)
[266.791254] Starting dynamic subtest: B-eDP1
[267.910733] Dynamic subtest B-eDP1: SUCCESS (1.132s)
[267.925188] Starting dynamic subtest: C-eDP1
[269.040410] Dynamic subtest C-eDP1: SUCCESS (1.127s)
[269.052061] Starting dynamic subtest: D-eDP1
[270.182157] Dynamic subtest D-eDP1: SUCCESS (1.141s)
[270.184489] Subtest nonexisting-fb-interruptible: SUCCESS (4.586s)
[271.353882] [061/133] (749s left) kms_psr (psr2-no-drrs)
[271.453993] Starting subtest: psr2-no-drrs
[271.456259] Starting dynamic subtest: eDP-1
[273.018668] Dynamic subtest eDP-1: SUCCESS (1.561s)
[273.020817] Subtest psr2-no-drrs: SUCCESS (1.562s)
[273.831798] [062/133] (746s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[273.923092] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[273.949251] Starting dynamic subtest: pipe-A-plane-0
[274.238320] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[274.248454] Starting dynamic subtest: pipe-A-plane-3
[274.470823] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[275.604537] Starting dynamic subtest: pipe-B-plane-0
[275.896075] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[275.906085] Starting dynamic subtest: pipe-B-plane-3
[276.140419] Dynamic subtest pipe-B-plane-3: SUCCESS (0.242s)
[276.459541] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.539s)
[277.293681] [063/133] (743s left) gem_exec_balancer (bonded-true-hang)
[277.546341] Starting subtest: bonded-true-hang
[277.551641] Subtest bonded-true-hang: SKIP (0.000s)
[277.655337] [064/133] (742s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[278.040700] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[278.812928] [065/133] (741s left) gem_exec_reloc (basic-write-cpu-noreloc)
[278.871644] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[278.963969] [066/133] (741s left) kms_hdmi_inject (inject-4k)
[279.310741] Starting subtest: inject-4k
[279.630781] Subtest inject-4k: SUCCESS (0.323s)
[280.204175] [067/133] (740s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[280.275388] Starting subtest: etime-single-wait-all-for-submit-submitted
[280.378433] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.103s)
[280.457666] [068/133] (740s left) kms_flip (flip-vs-modeset-vs-hang)
[280.563475] Starting subtest: flip-vs-modeset-vs-hang
[280.565718] Starting dynamic subtest: A-eDP1
[331.746754] Dynamic subtest A-eDP1: SUCCESS (51.171s)
[331.757793] Starting dynamic subtest: D-eDP1
[382.753071] Dynamic subtest D-eDP1: SUCCESS (51.005s)
[382.755896] Subtest flip-vs-modeset-vs-hang: SUCCESS (102.182s)
[383.130420] [069/133] (637s left) kms_lease (master-vs-lease)
[383.221762] Starting subtest: master-vs-lease
[383.224115] Subtest master-vs-lease: SUCCESS (0.002s)
[383.352570] [070/133] (637s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[383.451074] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[383.453291] Starting dynamic subtest: pipe-A-eDP-1
[383.975710] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.489s)
[383.987898] Starting dynamic subtest: pipe-B-eDP-1
[385.421449] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.448s)
[385.441833] Starting dynamic subtest: pipe-C-eDP-1
[386.823064] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.405s)
[386.834791] Starting dynamic subtest: pipe-D-eDP-1
[388.222720] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.396s)
[388.224680] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.742s)
[389.351890] [071/133] (631s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[389.418825] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[389.423445] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[389.605766] [072/133] (631s left) gem_ctx_engines (invalid-engines)
[389.662897] Starting subtest: invalid-engines
[389.671445] Subtest invalid-engines: SUCCESS (0.008s)
[389.916715] [073/133] (631s left) gem_exec_params (dr4-dirt)
[389.976735] Starting subtest: DR4-dirt
[389.978881] Subtest DR4-dirt: SUCCESS (0.000s)
[390.073491] [074/133] (630s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[390.177155] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[390.181418] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[390.277745] [075/133] (630s left) sw_sync (sync_multi_producer_single_consumer)
[390.320725] Starting subtest: sync_multi_producer_single_consumer
[391.394368] Subtest sync_multi_producer_single_consumer: SUCCESS (1.076s)
[391.459422] [076/133] (629s left) syncobj_timeline (wait-all-for-submit-complex)
[391.512587] Starting subtest: wait-all-for-submit-complex
[391.728807] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[391.804704] [077/133] (629s left) gem_eio (execbuf)
[392.004969] Starting subtest: execbuf
[392.299133] Subtest execbuf: SUCCESS (0.294s)
[392.470468] [078/133] (628s left) gem_partial_pwrite_pread (writes-after-reads)
[392.532956] Subtest writes-after-reads: SKIP (0.000s)
[392.603293] [079/133] (628s left) kms_feature_discovery (dp-mst)
[392.699258] Starting subtest: dp-mst
[392.703373] Subtest dp-mst: SKIP (0.000s)
[392.782582] [080/133] (628s left) perf (low-oa-exponent-permissions)
[392.918389] Starting subtest: low-oa-exponent-permissions
[392.953698] Subtest low-oa-exponent-permissions: SUCCESS (0.036s)
[393.004277] [081/133] (628s left) gem_exec_fence (syncobj-import)
[393.421356] Starting subtest: syncobj-import
[393.427466] Subtest syncobj-import: SUCCESS (0.005s)
[395.420305] [082/133] (625s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[395.522490] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[395.524762] Starting dynamic subtest: pipe-A-eDP-1
[395.619086] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[395.630175] Starting dynamic subtest: pipe-B-eDP-1
[396.801580] Dynamic subtest pipe-B-eDP-1: SKIP (1.179s)
[396.806418] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.282s)
[398.059655] [083/133] (623s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[398.181256] Starting subtest: cursorB-vs-flipB-atomic
[398.185613] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[398.329995] [084/133] (623s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[398.418182] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[398.429194] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s)
[398.520960] [085/133] (622s left) kms_vblank (ts-continuation-idle)
[398.625171] Starting subtest: ts-continuation-idle
[398.627488] Starting dynamic subtest: pipe-A-eDP-1
[399.022657] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.396s)
[399.038610] Starting dynamic subtest: pipe-D-eDP-1
[400.119594] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.092s)
[400.121505] Subtest ts-continuation-idle: SUCCESS (1.493s)
[400.964387] [086/133] (620s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[401.053427] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[401.057923] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[402.167465] [087/133] (619s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[402.259446] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[402.263823] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[402.360775] [088/133] (619s left) syncobj_eventfd (invalid-bad-flags)
[402.415057] Starting subtest: invalid-bad-flags
[402.417370] Subtest invalid-bad-flags: SUCCESS (0.000s)
[402.508471] [089/133] (619s left) kms_pwrite_crc (basic)
[402.592471] Starting subtest: basic
[403.292668] Subtest basic: SUCCESS (0.700s)
[404.154459] [090/133] (617s left) gem_sync (basic-store-each)
[404.246147] Starting subtest: basic-store-each
[406.826966] Subtest basic-store-each: SUCCESS (2.592s)
[407.027760] [091/133] (614s left) kms_universal_plane (universal-plane-sanity)
[407.136407] Starting subtest: universal-plane-sanity
[407.138893] Starting dynamic subtest: pipe-A-eDP-1
[407.737177] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.600s)
[407.748263] Starting dynamic subtest: pipe-B-eDP-1
[408.949071] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.212s)
[408.960251] Starting dynamic subtest: pipe-C-eDP-1
[410.135955] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.185s)
[410.147893] Starting dynamic subtest: pipe-D-eDP-1
[411.332351] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.194s)
[411.334552] Subtest universal-plane-sanity: SUCCESS (4.197s)
[412.164290] [092/133] (609s left) gem_spin_batch (legacy)
[412.218639] Starting subtest: legacy
[412.220705] Starting dynamic subtest: default
[415.455502] Dynamic subtest default: SUCCESS (3.234s)
[415.466808] Starting dynamic subtest: render
[418.738834] Dynamic subtest render: SUCCESS (3.229s)
[418.754072] Starting dynamic subtest: bsd
[421.979368] Dynamic subtest bsd: SUCCESS (3.237s)
[421.993889] Starting dynamic subtest: bsd1
[425.214661] Dynamic subtest bsd1: SUCCESS (3.232s)
[425.227072] Starting dynamic subtest: bsd2
[428.455287] Dynamic subtest bsd2: SUCCESS (3.237s)
[428.467678] Starting dynamic subtest: blt
[431.694759] Dynamic subtest blt: SUCCESS (3.236s)
[431.708821] Starting dynamic subtest: vebox
[434.932060] Dynamic subtest vebox: SUCCESS (3.234s)
[434.934196] Subtest legacy: SUCCESS (22.662s)
[435.338353] [093/133] (586s left) kms_rotation_crc (primary-rotation-90)
[435.429384] Starting subtest: primary-rotation-90
[435.433322] Subtest primary-rotation-90: SKIP (0.001s)
[435.502659] [094/133] (586s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[435.595739] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[444.266672] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.675s)
[444.380595] [095/133] (577s left) api_intel_allocator (default-alignment)
[444.441857] Starting subtest: default-alignment
[444.446448] Subtest default-alignment: SUCCESS (0.004s)
[444.558431] [096/133] (577s left) kms_chamelium_frames (hdmi-frame-dump)
[444.957119] Subtest hdmi-frame-dump: SKIP (0.000s)
[445.732321] [097/133] (576s left) kms_chamelium_audio (hdmi-audio)
[446.116966] Subtest hdmi-audio: SKIP (0.000s)
[446.929312] [098/133] (575s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[447.027578] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[447.840875] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.815s)
[447.997727] [099/133] (574s left) gen7_exec_parse (bitmasks)
[448.059479] Subtest bitmasks: SKIP (0.000s)
[448.138888] [100/133] (574s left) gem_mmap_wc (set-cache-level)
[448.191629] Subtest set-cache-level: SKIP (0.000s)
[448.256053] [101/133] (573s left) gem_madvise (dontneed-before-exec)
[448.292025] Starting subtest: dontneed-before-exec
[448.318729] Subtest dontneed-before-exec: SKIP (0.023s)
[448.386625] [102/133] (573s left) i915_module_load (resize-bar)
[448.430387] Starting subtest: resize-bar
[448.436456] Subtest resize-bar: SKIP (0.006s)
[448.475223] [103/133] (573s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[448.569696] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[448.571881] Starting dynamic subtest: pipe-A-eDP-1
[448.580645] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[448.592075] Starting dynamic subtest: pipe-B-eDP-1
[448.600768] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[448.611119] Starting dynamic subtest: pipe-C-eDP-1
[448.619181] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[448.628823] Starting dynamic subtest: pipe-D-eDP-1
[448.636985] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[448.640964] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s)
[450.854062] [104/133] (571s left) gem_eio (wait-immediate)
[451.069059] Starting subtest: wait-immediate
[451.428529] Subtest wait-immediate: SUCCESS (0.359s)
[451.559068] [105/133] (570s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[451.684817] Starting subtest: 2x-long-flip-vs-cursor-legacy
[451.689542] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[451.835839] [106/133] (570s left) gem_exec_reloc (basic-gtt-wc-active)
[451.889660] Subtest basic-gtt-wc-active: SKIP (0.000s)
[451.957462] [107/133] (570s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[452.058632] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[452.062104] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[452.156388] [108/133] (570s left) kms_frontbuffer_tracking (fbc-tiling-4)
[452.250763] Starting subtest: fbc-tiling-4
[456.377725] Subtest fbc-tiling-4: SUCCESS (4.129s)
[457.564521] [109/133] (564s left) kms_big_fb (linear-32bpp-rotate-270)
[457.662058] Starting subtest: linear-32bpp-rotate-270
[457.682799] Subtest linear-32bpp-rotate-270: SKIP (0.020s)
[457.786353] [110/133] (564s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[457.869228] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[457.871335] Starting dynamic subtest: pipe-A
[458.010755] Dynamic subtest pipe-A: SKIP (0.135s)
[458.021257] Starting dynamic subtest: pipe-B
[459.196066] Dynamic subtest pipe-B: SKIP (1.186s)
[459.207164] Starting dynamic subtest: pipe-C
[460.380961] Dynamic subtest pipe-C: SUCCESS (1.189s)
[460.391306] Starting dynamic subtest: pipe-D
[461.589354] Dynamic subtest pipe-D: SUCCESS (1.207s)
[461.591702] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.721s)
[462.748104] [111/133] (559s left) fbdev (pan)
[462.788465] Starting subtest: pan
[462.815208] Subtest pan: SUCCESS (0.028s)
[462.902322] [112/133] (559s left) gem_exec_capture (pi)
[462.977179] Starting subtest: pi
[462.979125] Starting dynamic subtest: rcs0
[467.065234] Dynamic subtest rcs0: SUCCESS (4.090s)
[467.078951] Starting dynamic subtest: bcs0
[471.051941] Dynamic subtest bcs0: SUCCESS (3.984s)
[471.064604] Starting dynamic subtest: vcs0
[474.999813] Dynamic subtest vcs0: SUCCESS (3.945s)
[475.012227] Starting dynamic subtest: vcs1
[478.934665] Dynamic subtest vcs1: SUCCESS (3.933s)
[478.947747] Starting dynamic subtest: vecs0
[482.890686] Dynamic subtest vecs0: SUCCESS (3.955s)
[482.912983] Starting dynamic subtest: ccs0
[486.880427] Dynamic subtest ccs0: SUCCESS (3.988s)
[486.882630] Subtest pi: SUCCESS (23.907s)
[486.976841] [113/133] (535s left) i915_query (query-regions-garbage-items)
[487.094460] Starting subtest: query-regions-garbage-items
[487.096788] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[487.201439] [114/133] (535s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[487.302920] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[487.307267] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[487.375586] [115/133] (535s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[487.479483] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[487.483369] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[487.576736] [116/133] (535s left) gem_userptr_blits (sd-probe)
[487.642093] Starting subtest: sd-probe
[487.644322] Subtest sd-probe: SUCCESS (0.000s)
[487.771388] [117/133] (535s left) i915_drm_fdinfo (busy-check-all)
[487.811434] Starting subtest: busy-check-all
[487.813718] Starting dynamic subtest: rcs0
[487.818215] Dynamic subtest rcs0: SKIP (0.004s)
[487.828731] Starting dynamic subtest: bcs0
[487.832819] Dynamic subtest bcs0: SKIP (0.000s)
[487.843296] Starting dynamic subtest: vcs0
[487.846674] Dynamic subtest vcs0: SKIP (0.000s)
[487.856025] Starting dynamic subtest: vcs1
[487.859247] Dynamic subtest vcs1: SKIP (0.000s)
[487.868283] Starting dynamic subtest: vecs0
[487.871499] Dynamic subtest vecs0: SKIP (0.000s)
[487.880848] Starting dynamic subtest: ccs0
[487.884064] Dynamic subtest ccs0: SKIP (0.000s)
[487.887281] Subtest busy-check-all: SKIP (0.009s)
[487.924214] [118/133] (534s left) syncobj_timeline (wait-zero-handles)
[488.012325] Starting subtest: wait-zero-handles
[488.014457] Subtest wait-zero-handles: SUCCESS (0.000s)
[488.127278] [119/133] (534s left) syncobj_basic (bad-create-flags)
[488.184447] Starting subtest: bad-create-flags
[488.186065] Subtest bad-create-flags: SUCCESS (0.000s)
[488.286736] [120/133] (534s left) perf_pmu (busy-start)
[488.332427] Starting subtest: busy-start
[488.334191] Starting dynamic subtest: rcs0
[490.883534] Dynamic subtest rcs0: SUCCESS (2.552s)
[490.895064] Starting dynamic subtest: bcs0
[493.432107] Dynamic subtest bcs0: SUCCESS (2.547s)
[493.443045] Starting dynamic subtest: vcs0
[497.277441] Dynamic subtest vcs0: SUCCESS (3.842s)
[497.290310] Starting dynamic subtest: vcs1
[501.308789] Dynamic subtest vcs1: SUCCESS (4.029s)
[501.320321] Starting dynamic subtest: vecs0
[505.276970] Dynamic subtest vecs0: SUCCESS (3.965s)
[505.288080] Starting dynamic subtest: ccs0
[507.845881] Dynamic subtest ccs0: SUCCESS (2.548s)
[507.848414] Subtest busy-start: SUCCESS (19.496s)
[507.923578] [121/133] (515s left) gem_ctx_persistence (processes)
[507.994066] Starting subtest: processes
[509.275469] Subtest processes: SUCCESS (1.281s)
[509.366671] [122/133] (513s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[509.481087] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[509.485430] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[509.584852] [123/133] (513s left) gen3_mixed_blits
[509.718810] [124/133] (513s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[509.826233] Starting subtest: async-flip-with-page-flip-events-tiled
[510.197634] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[513.052398] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.792s)
[513.065877] Starting dynamic subtest: pipe-A-eDP-1-4
[515.216891] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[515.227854] Starting dynamic subtest: pipe-A-eDP-1-4
[517.175603] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[517.188623] Starting dynamic subtest: pipe-A-eDP-1-x
[519.439203] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.211s)
[519.768886] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[522.495481] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.735s)
[522.506329] Starting dynamic subtest: pipe-B-eDP-1-4
[524.732226] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s)
[524.746347] Starting dynamic subtest: pipe-B-eDP-1-4
[526.691448] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[526.702341] Starting dynamic subtest: pipe-B-eDP-1-x
[528.943987] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.200s)
[529.272673] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[532.043351] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.732s)
[532.055749] Starting dynamic subtest: pipe-C-eDP-1-4
[534.217523] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[534.229467] Starting dynamic subtest: pipe-C-eDP-1-4
[536.176485] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[536.187214] Starting dynamic subtest: pipe-C-eDP-1-x
[538.406523] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[538.719157] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[541.495334] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.783s)
[541.506271] Starting dynamic subtest: pipe-D-eDP-1-4
[543.732713] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.184s)
[543.743622] Starting dynamic subtest: pipe-D-eDP-1-4
[545.690320] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[545.700985] Starting dynamic subtest: pipe-D-eDP-1-x
[547.920680] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s)
[547.923470] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.043s)
[549.048558] [125/133] (474s left) gem_exec_whisper (basic-contexts)
[549.121327] Starting subtest: basic-contexts
[555.904827] Subtest basic-contexts: SUCCESS (6.782s)
[556.104675] [126/133] (467s left) kms_cursor_crc (cursor-random-512x170)
[556.400771] Starting subtest: cursor-random-512x170
[556.405212] Subtest cursor-random-512x170: SKIP (0.001s)
[556.547892] [127/133] (466s left) kms_color_pipeline (plane-ctm3x4)
[556.668098] Starting subtest: plane-ctm3x4
[556.813867] Starting dynamic subtest: pipe-A-plane-0
[556.958113] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[556.969294] Starting dynamic subtest: pipe-A-plane-1
[557.091056] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[557.101512] Starting dynamic subtest: pipe-A-plane-2
[557.224515] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[558.418974] Starting dynamic subtest: pipe-B-plane-0
[558.552057] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s)
[558.563055] Starting dynamic subtest: pipe-B-plane-1
[558.674255] Dynamic subtest pipe-B-plane-1: SUCCESS (0.121s)
[558.685144] Starting dynamic subtest: pipe-B-plane-2
[558.796777] Dynamic subtest pipe-B-plane-2: SUCCESS (0.122s)
[559.995834] Starting dynamic subtest: pipe-C-plane-0
[560.119793] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[560.130744] Starting dynamic subtest: pipe-C-plane-1
[560.231494] Dynamic subtest pipe-C-plane-1: SUCCESS (0.110s)
[560.242245] Starting dynamic subtest: pipe-C-plane-2
[560.364601] Dynamic subtest pipe-C-plane-2: SUCCESS (0.132s)
[561.530709] Starting dynamic subtest: pipe-D-plane-0
[561.632612] Dynamic subtest pipe-D-plane-0: SUCCESS (0.111s)
[561.643095] Starting dynamic subtest: pipe-D-plane-1
[561.765930] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s)
[561.776939] Starting dynamic subtest: pipe-D-plane-2
[561.877469] Dynamic subtest pipe-D-plane-2: SUCCESS (0.110s)
[562.165963] Subtest plane-ctm3x4: SUCCESS (5.500s)
[563.033514] [128/133] (460s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[563.135758] Starting subtest: fbcpsr-1p-rte
[570.096047] Subtest fbcpsr-1p-rte: SUCCESS (6.965s)
[570.246876] [129/133] (453s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[570.369264] Starting subtest: basic-flip-before-cursor-legacy
[571.318160] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.946s)
[572.141349] [130/133] (451s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[572.234204] Starting subtest: plane-upscale-factor-0-25-with-rotation
[572.236492] Starting dynamic subtest: pipe-A
[572.459073] Dynamic subtest pipe-A: SUCCESS (0.227s)
[572.469922] Starting dynamic subtest: pipe-B
[573.786432] Dynamic subtest pipe-B: SUCCESS (1.326s)
[573.797834] Starting dynamic subtest: pipe-C
[575.099326] Dynamic subtest pipe-C: SUCCESS (1.312s)
[575.111911] Starting dynamic subtest: pipe-D
[576.380783] Dynamic subtest pipe-D: SUCCESS (1.281s)
[576.383081] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.149s)
[577.560478] [131/133] (445s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[577.683447] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[609.620087] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.935s)
[610.437697] [132/133] (413s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[610.562853] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[610.566807] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[610.670262] [133/133] (412s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[612.400449] Starting subtest: dpms-mode-unset-lpsp
[616.475238] Subtest dpms-mode-unset-lpsp: SUCCESS (4.075s)
[616.854807] 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.