[57.785990] Initializing watchdogs
[57.786144]   /dev/watchdog0
[57.799893] [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.803604] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.805799] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.808997] [001/130] (960s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[62.856596] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[62.861267] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.002s)
[63.713945] [002/130] (954s left) kms_feature_discovery (display-1x)
[63.817733] Starting subtest: display-1x
[63.820039] Subtest display-1x: SUCCESS (0.000s)
[63.877532] [003/130] (954s left) kms_big_fb (linear-8bpp-rotate-0)
[64.008168] Starting subtest: linear-8bpp-rotate-0
[65.176948] Subtest linear-8bpp-rotate-0: SUCCESS (1.177s)
[65.327257] [004/130] (953s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[65.382987] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[65.385066] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[65.491439] [005/130] (952s left) kms_psr (psr2-dpms)
[65.585757] Starting subtest: psr2-dpms
[65.587744] Starting dynamic subtest: eDP-1
[68.492111] Dynamic subtest eDP-1: SUCCESS (2.918s)
[68.494449] Subtest psr2-dpms: SUCCESS (2.918s)
[69.333247] [006/130] (949s left) kms_busy (basic-hang)
[69.433891] Starting subtest: basic-hang
[69.436298] Starting dynamic subtest: flip-pipe-A
[70.040874] Dynamic subtest flip-pipe-A: SUCCESS (0.606s)
[70.049080] Starting dynamic subtest: modeset-pipe-A
[73.441173] Dynamic subtest modeset-pipe-A: SUCCESS (3.408s)
[73.449264] Starting dynamic subtest: flip-pipe-D
[74.654066] Dynamic subtest flip-pipe-D: SUCCESS (1.213s)
[74.661755] Starting dynamic subtest: modeset-pipe-D
[78.056201] Dynamic subtest modeset-pipe-D: SUCCESS (3.408s)
[78.058568] Subtest basic-hang: SUCCESS (8.639s)
[78.838481] [007/130] (939s left) gem_caching (read-writes)
[78.900084] Subtest read-writes: SKIP (0.000s)
[78.974712] [008/130] (939s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[79.100518] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[90.297249] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.199s)
[91.170011] [009/130] (927s left) kms_chamelium_audio (dp-audio-edid)
[91.554631] Subtest dp-audio-edid: SKIP (0.000s)
[92.361664] [010/130] (926s left) kms_psr (fbc-psr-primary-mmap-gtt)
[92.455325] Starting subtest: fbc-psr-primary-mmap-gtt
[92.457687] Starting dynamic subtest: eDP-1
[92.461951] Dynamic subtest eDP-1: SKIP (0.000s)
[92.466246] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.000s)
[92.522818] [011/130] (926s left) gem_exec_flush (basic-wb-ro-before-default)
[92.591958] Starting subtest: basic-wb-ro-before-default
[98.062419] Subtest basic-wb-ro-before-default: SUCCESS (5.470s)
[98.239335] [012/130] (920s left) i915_suspend (basic-s2idle-without-i915)
[98.269886] Starting subtest: basic-s2idle-without-i915
[119.745186] Subtest basic-s2idle-without-i915: SUCCESS (5.669s)
[119.857322] [013/130] (914s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[119.970453] Starting subtest: fbc-psr2-cursor-plane-onoff
[119.973175] Starting dynamic subtest: eDP-1
[119.978211] Dynamic subtest eDP-1: SKIP (0.000s)
[119.983206] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.000s)
[120.034459] [014/130] (914s left) kms_async_flips (test-time-stamp)
[120.128104] Starting subtest: test-time-stamp
[120.488658] Starting dynamic subtest: pipe-A-eDP-1
[121.297437] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.835s)
[121.660734] Starting dynamic subtest: pipe-B-eDP-1
[122.398385] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.765s)
[122.761297] Starting dynamic subtest: pipe-C-eDP-1
[123.501731] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.765s)
[123.867361] Starting dynamic subtest: pipe-D-eDP-1
[124.609589] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.763s)
[124.612563] Subtest test-time-stamp: SUCCESS (4.615s)
[125.727875] [015/130] (908s left) syncobj_timeline (host-signal-ordered)
[125.789461] Starting subtest: host-signal-ordered
[125.792119] Subtest host-signal-ordered: SUCCESS (0.000s)
[125.870343] [016/130] (908s left) syncobj_wait (wait-all-for-submit-complex)
[125.936336] Starting subtest: wait-all-for-submit-complex
[126.151867] Subtest wait-all-for-submit-complex: SUCCESS (0.218s)
[126.219588] [017/130] (908s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[126.323311] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[127.538121] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (1.237s)
[127.743629] [018/130] (906s left) gem_userptr_blits (huge-split)
[127.823697] Starting subtest: huge-split
[127.832700] Subtest huge-split: SUCCESS (0.010s)
[127.967786] [019/130] (906s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[128.071956] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[131.613910] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (3.587s)
[131.732630] [020/130] (902s left) gem_exec_reloc (basic-scanout)
[131.793402] Subtest basic-scanout: SKIP (0.000s)
[131.861712] [021/130] (902s left) kms_cursor_crc (cursor-onscreen-32x32)
[131.987002] Starting subtest: cursor-onscreen-32x32
[132.025949] Subtest cursor-onscreen-32x32: SKIP (0.033s)
[132.292372] [022/130] (902s left) gem_exec_fence (syncobj-channel)
[132.735596] Starting subtest: syncobj-channel
[133.760577] Subtest syncobj-channel: SUCCESS (1.028s)
[134.049200] [FACT gem_exec_fence (syncobj-channel)] new: kernel.kmod_is_loaded.vgem: true
[134.052742] [023/130] (900s left) sw_sync (sync_busy)
[134.090556] Starting subtest: sync_busy
[134.093481] Subtest sync_busy: SUCCESS (0.002s)
[134.137596] [024/130] (900s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[134.236436] Starting subtest: fbc-psr2-cursor-mmap-gtt
[134.239494] Starting dynamic subtest: eDP-1
[134.244950] Dynamic subtest eDP-1: SKIP (0.000s)
[134.250414] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[134.302009] [025/130] (900s left) gem_userptr_blits (readonly-pwrite-unsync)
[134.379432] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[134.508904] [026/130] (900s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[134.619271] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[139.781393] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (5.190s)
[139.924436] [027/130] (894s left) gem_userptr_blits (access-control)
[140.004554] Starting subtest: access-control
[140.010372] Subtest access-control: SKIP (0.000s)
[140.137070] [028/130] (894s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[140.233826] Starting subtest: plane-use-after-nonblocking-unbind
[140.236155] Starting dynamic subtest: pipe-A-eDP-1
[140.302469] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.070s)
[140.600580] Starting dynamic subtest: pipe-B-eDP-1
[141.388857] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.796s)
[141.662690] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.434s)
[142.526922] [029/130] (892s left) kms_writeback (writeback-fb-id-xrgb2101010)
[142.623454] Subtest writeback-fb-id-XRGB2101010: SKIP (0.000s)
[142.661711] [030/130] (892s left) gem_ctx_sseu (invalid-sseu)
[142.731268] Subtest invalid-sseu: SKIP (0.000s)
[142.807196] [031/130] (891s left) kms_chamelium_edid (dp-mode-timings)
[143.193251] Subtest dp-mode-timings: SKIP (0.000s)
[144.038909] [032/130] (890s left) i915_power (sanity)
[144.092458] Starting subtest: sanity
[148.139507] Subtest sanity: SUCCESS (4.047s)
[149.772713] [033/130] (885s left) gem_ctx_shared (create-shared-gtt)
[149.839286] Starting subtest: create-shared-gtt
[151.998169] Subtest create-shared-gtt: SUCCESS (2.157s)
[152.279917] [034/130] (882s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[152.389101] Starting subtest: crc-primary-basic-y-tiled-ccs
[152.391710] Starting dynamic subtest: pipe-A-eDP-1
[152.417774] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[152.426567] Starting dynamic subtest: pipe-B-eDP-1
[152.452588] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[152.461339] Starting dynamic subtest: pipe-C-eDP-1
[152.487475] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[152.496604] Starting dynamic subtest: pipe-D-eDP-1
[152.523480] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[152.528390] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.004s)
[154.503960] [035/130] (880s left) gem_exec_flush (basic-uc-ro-default)
[154.563895] Starting subtest: basic-uc-ro-default
[160.037983] Subtest basic-uc-ro-default: SUCCESS (5.475s)
[160.216680] [036/130] (874s left) perf_pmu (interrupts)
[160.261012] Starting subtest: interrupts
[161.367198] Subtest interrupts: SUCCESS (1.106s)
[161.494336] [037/130] (873s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[161.612414] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[161.618230] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[161.716833] [038/130] (873s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[161.825590] Starting subtest: yf-tiled-16bpp-rotate-180
[161.831085] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[161.937384] [039/130] (873s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[162.045273] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[162.047991] Starting dynamic subtest: pipe-A-default-mode
[163.148453] Dynamic subtest pipe-A-default-mode: SKIP (1.098s)
[163.154551] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.099s)
[163.298070] [040/130] (871s left) gem_linear_blits (basic)
[163.667375] Starting subtest: basic
[163.678556] Subtest basic: SUCCESS (0.011s)
[163.820787] [041/130] (871s left) kms_fbcon_fbt (psr)
[163.930376] Starting subtest: psr
[169.268417] Subtest psr: SUCCESS (5.339s)
[169.349718] [042/130] (865s left) gem_exec_whisper (basic-queues-forked)
[169.416441] Starting subtest: basic-queues-forked
[193.671511] Subtest basic-queues-forked: SUCCESS (24.257s)
[193.846666] [043/130] (841s left) gem_userptr_blits (sync-unmap-cycles)
[193.916275] Starting subtest: sync-unmap-cycles
[199.285262] Subtest sync-unmap-cycles: SUCCESS (5.371s)
[199.437301] [044/130] (835s left) syncobj_timeline (single-wait-signaled)
[199.514784] Starting subtest: single-wait-signaled
[199.517589] Subtest single-wait-signaled: SUCCESS (0.000s)
[199.629371] [045/130] (835s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[199.749288] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[200.715495] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.968s)
[200.892056] [046/130] (834s left) kms_content_protection (atomic-dpms)
[201.067378] Starting subtest: atomic-dpms
[204.305354] Subtest atomic-dpms: SKIP (3.233s)
[205.477124] [047/130] (829s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[205.594383] Starting subtest: fbcpsr-tiling-y
[205.599631] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[205.686199] [048/130] (829s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[205.785296] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[205.787965] Starting dynamic subtest: pipe-A-eDP-1
[205.813417] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[205.822841] Starting dynamic subtest: pipe-B-eDP-1
[205.848208] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[205.856562] Starting dynamic subtest: pipe-C-eDP-1
[205.882546] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[205.890697] Starting dynamic subtest: pipe-D-eDP-1
[205.916092] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[205.921425] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.003s)
[207.922242] [049/130] (827s left) testdisplay
[208.286983] [050/130] (827s left) gem_render_copy (x-tiled)
[208.354151] Starting subtest: x-tiled
[208.356927] Starting dynamic subtest: smem
[208.397889] Dynamic subtest smem: SUCCESS (0.043s)
[208.400859] Subtest x-tiled: SUCCESS (0.044s)
[208.642898] [051/130] (826s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[208.761865] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[208.767155] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[208.856018] [052/130] (826s left) gem_mmap_offset (partial-mmap)
[208.906445] Starting subtest: partial-mmap
[208.908435] Starting dynamic subtest: smem0
[208.911138] Dynamic subtest smem0: SUCCESS (0.005s)
[208.913597] Subtest partial-mmap: SUCCESS (0.005s)
[209.007872] [053/130] (826s left) perf_pmu (faulting-read)
[209.049749] Starting subtest: faulting-read
[209.052504] Starting dynamic subtest: wb
[209.055270] Dynamic subtest wb: SUCCESS (0.001s)
[209.063982] Starting dynamic subtest: wc
[209.066390] Dynamic subtest wc: SUCCESS (0.000s)
[209.074593] Starting dynamic subtest: uc
[209.076804] Dynamic subtest uc: SUCCESS (0.000s)
[209.078813] Subtest faulting-read: SUCCESS (0.003s)
[209.168597] [054/130] (826s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[209.235311] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[209.288407] [055/130] (826s left) vgem_basic (bad-handle)
[209.327840] Starting subtest: bad-handle
[209.330032] Subtest bad-handle: SUCCESS (0.000s)
[209.378998] [056/130] (826s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[209.485723] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[209.489766] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[209.596897] [057/130] (826s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[209.658186] Starting subtest: y-tiled-to-vebox-yf-tiled
[209.662850] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[209.835978] [058/130] (825s left) kms_psr (psr-primary-blt)
[209.932232] Starting subtest: psr-primary-blt
[209.934876] Starting dynamic subtest: eDP-1
[211.717419] Dynamic subtest eDP-1: SUCCESS (1.785s)
[211.720097] Subtest psr-primary-blt: SUCCESS (1.785s)
[212.583675] [059/130] (823s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[212.688550] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[217.191144] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (4.506s)
[217.313180] [060/130] (818s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[217.374955] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[217.438131] [061/130] (818s left) i915_module_load (reload-no-display)
[217.474368] Starting subtest: reload-no-display
[223.743976] Subtest reload-no-display: SUCCESS (6.266s)
[223.766101] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[223.766829] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[223.769742] [062/130] (812s left) gem_ctx_param (invalid-size-get)
[225.329152] Starting subtest: invalid-size-get
[225.332312] Subtest invalid-size-get: SUCCESS (0.004s)
[225.398245] [FACT gem_ctx_param (invalid-size-get)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[225.400074] [FACT gem_ctx_param (invalid-size-get)] new: kernel.kmod_is_loaded.i915: true
[225.404043] [063/130] (810s left) gem_wait (busy)
[225.479317] Starting subtest: busy
[225.482176] Starting dynamic subtest: all-engines
[226.730852] Dynamic subtest all-engines: SUCCESS (1.249s)
[226.742110] Starting dynamic subtest: rcs0
[227.273733] Dynamic subtest rcs0: SUCCESS (0.542s)
[227.284587] Starting dynamic subtest: bcs0
[227.813113] Dynamic subtest bcs0: SUCCESS (0.539s)
[227.823657] Starting dynamic subtest: vcs0
[229.741182] Dynamic subtest vcs0: SUCCESS (1.925s)
[229.752592] Starting dynamic subtest: vcs1
[231.720478] Dynamic subtest vcs1: SUCCESS (1.978s)
[231.731591] Starting dynamic subtest: vecs0
[233.706011] Dynamic subtest vecs0: SUCCESS (1.983s)
[233.718235] Starting dynamic subtest: ccs0
[234.248877] Dynamic subtest ccs0: SUCCESS (0.542s)
[234.251845] Subtest busy: SUCCESS (8.767s)
[234.441287] [064/130] (801s left) gem_set_tiling_vs_pwrite
[234.563037] [065/130] (801s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[234.663305] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[234.673836] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.010s)
[234.748571] [066/130] (801s left) gem_pread (self)
[234.811234] Subtest self: SKIP (0.000s)
[234.871439] [067/130] (801s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[234.979291] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[234.984401] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[235.066278] [068/130] (800s left) kms_rotation_crc (exhaust-fences)
[235.166261] Starting subtest: exhaust-fences
[235.171511] Subtest exhaust-fences: SKIP (0.000s)
[235.232041] [069/130] (800s left) kms_dp_aux_dev
[235.598900] [070/130] (800s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[235.703493] Starting subtest: 4-tiled-8bpp-rotate-90
[235.734566] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.032s)
[235.863557] [071/130] (800s left) gem_exec_balancer (sliced)
[235.924951] Starting subtest: sliced
[235.930403] Subtest sliced: SKIP (0.000s)
[236.208033] [072/130] (799s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[236.315486] Starting subtest: psr-rgb565-draw-render
[241.302316] Subtest psr-rgb565-draw-render: SUCCESS (4.990s)
[241.419466] [073/130] (794s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[241.528607] Starting subtest: y-tiled-32bpp-rotate-270
[241.532684] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[241.633450] [074/130] (794s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[242.018257] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[242.854883] [075/130] (793s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[242.912887] Subtest no-spare-fences-busy: SKIP (0.000s)
[242.973343] [076/130] (793s left) syncobj_wait (multi-wait-signaled)
[243.036183] Starting subtest: multi-wait-signaled
[243.038566] Subtest multi-wait-signaled: SUCCESS (0.000s)
[243.127166] [077/130] (793s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[243.231013] Starting subtest: psr-1p-pri-indfb-multidraw
[263.000452] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (19.772s)
[263.116481] [078/130] (773s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[263.221086] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[263.225810] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[264.350872] [079/130] (772s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[264.414719] Starting subtest: multi-wait-available-unsubmitted-signaled
[264.417332] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[264.518854] [080/130] (771s left) kms_setmode (basic-clone-single-crtc)
[264.577487] Starting subtest: basic-clone-single-crtc
[264.584602] Subtest basic-clone-single-crtc: SKIP (0.000s)
[264.675151] [081/130] (771s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[264.733254] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[264.738551] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[264.913777] [082/130] (771s left) kms_plane_alpha_blend (alpha-opaque-fb)
[265.015972] Starting subtest: alpha-opaque-fb
[265.432181] Starting dynamic subtest: pipe-A-eDP-1
[266.007595] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.574s)
[266.017393] Starting dynamic subtest: pipe-D-eDP-1
[267.373845] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.364s)
[267.376334] Subtest alpha-opaque-fb: SUCCESS (2.356s)
[268.193323] [083/130] (768s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[268.299068] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[268.301488] Starting dynamic subtest: pipe-A-eDP-1
[268.326423] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[268.334789] Starting dynamic subtest: pipe-B-eDP-1
[268.360203] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[268.368110] Starting dynamic subtest: pipe-C-eDP-1
[268.394001] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[268.402565] Starting dynamic subtest: pipe-D-eDP-1
[268.428284] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[268.433306] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[270.438947] [084/130] (766s left) gem_exec_schedule (u-semaphore-resolve)
[270.525956] Starting subtest: u-semaphore-resolve
[270.552282] Subtest u-semaphore-resolve: SUCCESS (0.039s)
[270.909925] [085/130] (765s left) kms_sequence (queue-idle)
[271.012746] Starting subtest: queue-idle
[271.015326] Starting dynamic subtest: pipe-A-eDP-1
[272.841405] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.826s)
[272.855583] Starting dynamic subtest: pipe-B-eDP-1
[275.312098] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.470s)
[275.321392] Starting dynamic subtest: pipe-C-eDP-1
[277.728561] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.414s)
[277.737345] Starting dynamic subtest: pipe-D-eDP-1
[280.142257] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.412s)
[280.144551] Subtest queue-idle: SUCCESS (9.128s)
[280.956009] [086/130] (755s left) gem_create (busy-create)
[281.022420] Starting subtest: busy-create
[281.025341] Starting dynamic subtest: smem0
[314.661003] Dynamic subtest smem0: SUCCESS (33.644s)
[314.664222] Subtest busy-create: SUCCESS (33.646s)
[314.842288] [087/130] (721s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[314.949158] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[314.954398] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[315.046683] [088/130] (721s left) kms_setmode (basic)
[315.098004] Starting subtest: basic
[315.429865] Starting dynamic subtest: pipe-A-eDP-1
[317.456892] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.024s)
[317.809866] Starting dynamic subtest: pipe-B-eDP-1
[319.881161] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.075s)
[320.188692] Subtest basic: SUCCESS (5.089s)
[321.014245] [089/130] (715s left) kms_flip (nonexisting-fb)
[321.124483] Starting subtest: nonexisting-fb
[321.127260] Starting dynamic subtest: A-eDP1
[322.311489] Dynamic subtest A-eDP1: SUCCESS (1.187s)
[322.319576] Starting dynamic subtest: B-eDP1
[323.539414] Dynamic subtest B-eDP1: SUCCESS (1.226s)
[323.550269] Starting dynamic subtest: C-eDP1
[324.769899] Dynamic subtest C-eDP1: SUCCESS (1.230s)
[324.778846] Starting dynamic subtest: D-eDP1
[325.901426] Dynamic subtest D-eDP1: SUCCESS (1.132s)
[325.903716] Subtest nonexisting-fb: SUCCESS (4.783s)
[327.069364] [090/130] (709s left) gem_exec_flush (basic-batch-kernel-default-wb)
[327.136475] Starting subtest: basic-batch-kernel-default-wb
[333.509853] Subtest basic-batch-kernel-default-wb: SUCCESS (6.376s)
[333.691649] [091/130] (703s left) device_reset (unbind-cold-reset-rebind)
[333.734806] Starting subtest: unbind-cold-reset-rebind
[333.739749] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[333.802144] [092/130] (703s left) drm_fdinfo (virtual-busy-all)
[333.849854] Starting subtest: virtual-busy-all
[333.854612] Subtest virtual-busy-all: SKIP (0.000s)
[333.914949] [093/130] (703s left) gem_exec_balancer (individual)
[333.988033] Starting subtest: individual
[335.751597] Subtest individual: SUCCESS (1.763s)
[336.076822] [094/130] (700s left) perf_pmu (idle)
[336.121446] Starting subtest: idle
[336.124236] Starting dynamic subtest: rcs0
[336.695910] Dynamic subtest rcs0: SUCCESS (0.575s)
[336.707854] Starting dynamic subtest: bcs0
[337.225720] Dynamic subtest bcs0: SUCCESS (0.528s)
[337.238456] Starting dynamic subtest: vcs0
[337.746136] Dynamic subtest vcs0: SUCCESS (0.518s)
[337.758317] Starting dynamic subtest: vcs1
[338.271139] Dynamic subtest vcs1: SUCCESS (0.522s)
[338.283279] Starting dynamic subtest: vecs0
[338.791655] Dynamic subtest vecs0: SUCCESS (0.518s)
[338.802861] Starting dynamic subtest: ccs0
[339.311602] Dynamic subtest ccs0: SUCCESS (0.519s)
[339.314561] Subtest idle: SUCCESS (3.193s)
[339.413833] [095/130] (697s left) gem_exec_schedule (preempt-user)
[339.489289] Starting subtest: preempt-user
[339.492118] Starting dynamic subtest: rcs0
[339.518003] Dynamic subtest rcs0: SUCCESS (0.038s)
[339.529609] Starting dynamic subtest: bcs0
[339.546604] Dynamic subtest bcs0: SUCCESS (0.028s)
[339.555551] Starting dynamic subtest: vcs0
[339.572978] Dynamic subtest vcs0: SUCCESS (0.026s)
[339.581577] Starting dynamic subtest: vcs1
[339.599252] Dynamic subtest vcs1: SUCCESS (0.026s)
[339.611033] Starting dynamic subtest: vecs0
[339.622160] Dynamic subtest vecs0: SUCCESS (0.022s)
[339.631585] Starting dynamic subtest: ccs0
[339.655281] Dynamic subtest ccs0: SUCCESS (0.033s)
[339.658089] Subtest preempt-user: SUCCESS (0.176s)
[340.802102] [096/130] (696s left) syncobj_wait (signal)
[340.852893] Starting subtest: signal
[340.855469] Subtest signal: SUCCESS (0.000s)
[340.937952] [097/130] (696s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[340.999457] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[341.099586] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.103s)
[341.175212] [098/130] (695s left) api_intel_bb (render-ccs)
[341.243835] Starting subtest: render-ccs
[341.600022] Subtest render-ccs: SUCCESS (0.358s)
[341.734147] [099/130] (695s left) gem_exec_reloc (basic-cpu-read-noreloc)
[341.802367] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[341.879486] [100/130] (695s left) gem_exec_reloc (basic-gtt-read)
[341.945618] Subtest basic-gtt-read: SKIP (0.000s)
[342.013544] [101/130] (695s left) kms_plane (pixel-format)
[342.119053] Starting subtest: pixel-format
[342.155508] Starting dynamic subtest: pipe-A-plane-0
[347.090427] Dynamic subtest pipe-A-plane-0: SUCCESS (4.933s)
[347.100204] Starting dynamic subtest: pipe-A-plane-3
[349.479581] Dynamic subtest pipe-A-plane-3: SUCCESS (2.388s)
[349.489293] Starting dynamic subtest: pipe-A-plane-5
[349.679611] Dynamic subtest pipe-A-plane-5: SUCCESS (0.198s)
[350.749831] Starting dynamic subtest: pipe-B-plane-0
[355.756371] Dynamic subtest pipe-B-plane-0: SUCCESS (5.011s)
[355.765665] Starting dynamic subtest: pipe-B-plane-3
[358.112247] Dynamic subtest pipe-B-plane-3: SUCCESS (2.355s)
[358.121187] Starting dynamic subtest: pipe-B-plane-5
[358.290176] Dynamic subtest pipe-B-plane-5: SUCCESS (0.177s)
[358.598155] Subtest pixel-format: SUCCESS (16.471s)
[359.412080] [102/130] (677s left) prime_vgem (shrink)
[359.502540] Starting subtest: shrink
[359.530802] Subtest shrink: SUCCESS (0.025s)
[359.624932] [103/130] (677s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[359.683019] Starting subtest: multi-wait-for-submit-submitted-signaled
[359.685564] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[359.790136] [104/130] (677s left) kms_pm_dc (dc5-psr)
[360.901544] Starting subtest: dc5-psr
[363.788098] Subtest dc5-psr: SUCCESS (2.886s)
[364.641769] [105/130] (672s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[364.745063] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[364.749756] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[364.856758] [106/130] (672s left) gem_caching (reads)
[364.915326] Subtest reads: SKIP (0.000s)
[364.987907] [107/130] (672s left) gem_ctx_persistence (hang)
[365.043055] Starting subtest: hang
[365.048449] Subtest hang: SKIP (0.000s)
[365.158608] [108/130] (672s left) gem_lmem_swapping (parallel-random-verify)
[365.209136] Subtest parallel-random-verify: SKIP (0.000s)
[365.248795] [109/130] (672s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[370.298575] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[370.304342] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.004s)
[371.145390] [110/130] (666s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[371.264162] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[371.269435] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[371.362539] [111/130] (666s left) kms_pm_rpm (modeset-non-lpsp-stress)
[372.910721] Starting subtest: modeset-non-lpsp-stress
[374.068460] Subtest modeset-non-lpsp-stress: SKIP (1.155s)
[374.417614] [112/130] (663s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-blt)
[374.517271] Starting subtest: fbc-1p-offscren-pri-indfb-draw-blt
[377.701209] Subtest fbc-1p-offscren-pri-indfb-draw-blt: SUCCESS (3.189s)
[377.832327] [113/130] (659s left) kms_cursor_crc (cursor-sliding-256x85)
[378.060004] Starting subtest: cursor-sliding-256x85
[378.097789] Subtest cursor-sliding-256x85: SKIP (0.032s)
[378.263175] [114/130] (659s left) gem_create (create-ext-placement-each)
[378.434278] Starting subtest: create-ext-placement-each
[378.437407] Subtest create-ext-placement-each: SUCCESS (0.000s)
[378.522270] [115/130] (659s left) api_intel_allocator (reloc-allocator)
[378.582547] Starting subtest: reloc-allocator
[378.585134] Starting dynamic subtest: basic
[378.588021] Dynamic subtest basic: SUCCESS (0.005s)
[378.600166] Starting dynamic subtest: parallel-one
[378.602251] Dynamic subtest parallel-one: SUCCESS (0.007s)
[378.611340] Starting dynamic subtest: print
[378.614440] Dynamic subtest print: SUCCESS (0.000s)
[378.623120] Starting dynamic subtest: reuse
[378.625261] Dynamic subtest reuse: SUCCESS (0.000s)
[378.633867] Starting dynamic subtest: fork-reopen-allocator
[378.635994] Dynamic subtest fork-reopen-allocator: SUCCESS (0.016s)
[378.638109] Subtest reloc-allocator: SUCCESS (0.032s)
[378.721648] [116/130] (659s left) kms_lease (lease-invalid-plane)
[378.820852] Starting subtest: lease-invalid-plane
[378.823378] Starting dynamic subtest: pipe-A-eDP-1
[378.825852] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[378.835215] Starting dynamic subtest: pipe-B-eDP-1
[378.837232] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[378.846335] Starting dynamic subtest: pipe-C-eDP-1
[378.849106] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[378.858554] Starting dynamic subtest: pipe-D-eDP-1
[378.861040] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[378.863334] Subtest lease-invalid-plane: SUCCESS (0.003s)
[378.896257] [117/130] (658s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[379.000461] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[383.815887] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.818s)
[383.933589] [118/130] (653s left) kms_cursor_edge_walk (64x64-top-edge)
[384.034739] Starting subtest: 64x64-top-edge
[384.037182] Starting dynamic subtest: pipe-A-eDP-1
[387.450557] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.413s)
[387.461151] Starting dynamic subtest: pipe-D-eDP-1
[390.548414] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.096s)
[390.551345] Subtest 64x64-top-edge: SUCCESS (6.512s)
[391.359205] [119/130] (646s left) gen9_exec_parse (allowed-single)
[391.422970] Subtest allowed-single: SKIP (0.000s)
[391.482833] [120/130] (646s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[391.585727] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[391.588040] Starting dynamic subtest: pipe-A
[391.597227] Dynamic subtest pipe-A: SKIP (0.004s)
[391.606810] Starting dynamic subtest: pipe-B
[391.616454] Dynamic subtest pipe-B: SKIP (0.015s)
[391.628386] Starting dynamic subtest: pipe-C
[391.639234] Dynamic subtest pipe-C: SKIP (0.015s)
[391.647870] Starting dynamic subtest: pipe-D
[391.657590] Dynamic subtest pipe-D: SKIP (0.015s)
[391.662744] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.051s)
[391.758607] [121/130] (646s left) syncobj_basic (bad-pad-fd-to-handle)
[391.821403] Starting subtest: bad-pad-fd-to-handle
[391.824343] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[391.907693] [122/130] (646s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[392.006430] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[392.009188] Starting dynamic subtest: pipe-A-default-mode
[392.291392] Dynamic subtest pipe-A-default-mode: SKIP (0.283s)
[392.296070] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.285s)
[393.082320] [123/130] (644s left) syncobj_basic (bad-destroy)
[393.145732] Starting subtest: bad-destroy
[393.148532] Subtest bad-destroy: SUCCESS (0.000s)
[393.232941] [124/130] (644s left) kms_joiner (invalid-modeset-force-big-joiner)
[393.354586] Starting subtest: invalid-modeset-force-big-joiner
[393.357451] Starting dynamic subtest: big_joiner_on_last_pipe
[393.695046] Dynamic subtest big_joiner_on_last_pipe: SUCCESS (0.347s)
[393.697162] Subtest invalid-modeset-force-big-joiner: SUCCESS (0.347s)
[394.415011] [125/130] (643s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[394.514241] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[394.519364] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[394.596071] [126/130] (643s left) kms_rotation_crc (primary-rotation-90)
[394.696182] Starting subtest: primary-rotation-90
[394.701407] Subtest primary-rotation-90: SKIP (0.001s)
[394.763523] [127/130] (643s left) sw_sync (sync_busy_fork_unixsocket)
[394.807399] Starting subtest: sync_busy_fork_unixsocket
[394.811938] Subtest sync_busy_fork_unixsocket: SUCCESS (0.008s)
[394.867601] [128/130] (643s left) kms_color (ctm-0-25)
[394.966160] Starting subtest: ctm-0-25
[394.968586] Starting dynamic subtest: pipe-A-eDP-1
[398.306363] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.337s)
[398.316249] Starting dynamic subtest: pipe-B-eDP-1
[402.388589] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.081s)
[402.399530] Starting dynamic subtest: pipe-C-eDP-1
[406.320698] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.931s)
[406.332036] Starting dynamic subtest: pipe-D-eDP-1
[410.284130] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.965s)
[410.286704] Subtest ctm-0-25: SUCCESS (15.316s)
[411.147710] [129/130] (627s left) kms_vblank (accuracy-idle)
[411.244090] Starting subtest: accuracy-idle
[411.246586] Starting dynamic subtest: pipe-A-eDP-1
[412.997997] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.751s)
[413.013579] Starting dynamic subtest: pipe-D-eDP-1
[415.478539] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.477s)
[415.481164] Subtest accuracy-idle: SUCCESS (4.232s)
[416.293095] [130/130] (621s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[416.403431] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[416.408820] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[416.504345] Closing watchdogs
Done.