[59.085370] Initializing watchdogs
[59.085505]   /dev/watchdog0
[59.101677] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[59.105511] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.107517] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.111232] [001/133] (960s left) kms_psr (fbc-pr-cursor-plane-onoff)
[59.203643] Starting subtest: fbc-pr-cursor-plane-onoff
[59.208047] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[59.282320] [002/133] (960s left) gem_exec_schedule (preempt-self)
[59.346493] Starting subtest: preempt-self
[59.348406] Starting dynamic subtest: rcs0
[59.370102] Dynamic subtest rcs0: SUCCESS (0.025s)
[59.376978] Starting dynamic subtest: bcs0
[59.390942] Dynamic subtest bcs0: SUCCESS (0.020s)
[59.398636] Starting dynamic subtest: vcs0
[59.411260] Dynamic subtest vcs0: SUCCESS (0.020s)
[59.418918] Starting dynamic subtest: vcs1
[59.430950] Dynamic subtest vcs1: SUCCESS (0.019s)
[59.437853] Starting dynamic subtest: vecs0
[59.447834] Dynamic subtest vecs0: SUCCESS (0.017s)
[59.455922] Starting dynamic subtest: ccs0
[59.462717] Dynamic subtest ccs0: SUCCESS (0.014s)
[59.464903] Subtest preempt-self: SUCCESS (0.118s)
[60.905105] [003/133] (958s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[60.980557] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[60.984875] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[61.088775] [004/133] (958s left) kms_color_pipeline (plane-ctm3x4)
[61.155499] Starting subtest: plane-ctm3x4
[61.300499] Starting dynamic subtest: pipe-A-plane-0
[61.604463] Dynamic subtest pipe-A-plane-0: FAIL (0.130s)
[61.612696] Starting dynamic subtest: pipe-A-plane-1
[61.833314] Dynamic subtest pipe-A-plane-1: FAIL (0.133s)
[61.842977] Starting dynamic subtest: pipe-A-plane-2
[62.052788] Dynamic subtest pipe-A-plane-2: FAIL (0.145s)
[62.895654] Starting dynamic subtest: pipe-B-plane-0
[63.270044] Dynamic subtest pipe-B-plane-0: FAIL (0.123s)
[63.279378] Starting dynamic subtest: pipe-B-plane-1
[63.583977] Dynamic subtest pipe-B-plane-1: FAIL (0.129s)
[63.593084] Starting dynamic subtest: pipe-B-plane-2
[63.899783] Dynamic subtest pipe-B-plane-2: FAIL (0.155s)
[64.526468] Starting dynamic subtest: pipe-C-plane-0
[64.995963] Dynamic subtest pipe-C-plane-0: FAIL (0.118s)
[65.004917] Starting dynamic subtest: pipe-C-plane-1
[65.396177] Dynamic subtest pipe-C-plane-1: FAIL (0.133s)
[65.402986] Starting dynamic subtest: pipe-C-plane-2
[65.751706] Dynamic subtest pipe-C-plane-2: FAIL (0.588s)
[66.574347] Starting dynamic subtest: pipe-D-plane-0
[67.137691] Dynamic subtest pipe-D-plane-0: FAIL (0.106s)
[67.146604] Starting dynamic subtest: pipe-D-plane-1
[67.607036] Dynamic subtest pipe-D-plane-1: FAIL (0.605s)
[67.615513] Starting dynamic subtest: pipe-D-plane-2
[68.036553] Dynamic subtest pipe-D-plane-2: FAIL (0.558s)
[68.130873] Subtest plane-ctm3x4: FAIL (6.976s)
[68.920816] [005/133] (950s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[68.996705] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[76.096137] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.103s)
[76.242405] [006/133] (943s left) perf_pmu (busy-idle-check-all)
[76.282910] Starting subtest: busy-idle-check-all
[76.285562] Starting dynamic subtest: rcs0
[76.951256] Dynamic subtest rcs0: SUCCESS (0.668s)
[76.961850] Starting dynamic subtest: bcs0
[77.614618] Dynamic subtest bcs0: SUCCESS (0.661s)
[77.624902] Starting dynamic subtest: vcs0
[78.875914] Dynamic subtest vcs0: SUCCESS (1.260s)
[78.886886] Starting dynamic subtest: vcs1
[80.858418] Dynamic subtest vcs1: SUCCESS (1.981s)
[80.869394] Starting dynamic subtest: vecs0
[82.842847] Dynamic subtest vecs0: SUCCESS (1.983s)
[82.854084] Starting dynamic subtest: ccs0
[83.498290] Dynamic subtest ccs0: SUCCESS (0.656s)
[83.500750] Subtest busy-idle-check-all: SUCCESS (7.217s)
[83.618612] [007/133] (936s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[83.700320] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[83.702685] Starting dynamic subtest: pipe-A
[83.764570] Dynamic subtest pipe-A: SUCCESS (0.066s)
[83.777435] Starting dynamic subtest: pipe-B
[84.957625] Dynamic subtest pipe-B: SUCCESS (1.192s)
[84.968374] Starting dynamic subtest: pipe-C
[86.069475] Dynamic subtest pipe-C: SUCCESS (1.111s)
[86.078982] Starting dynamic subtest: pipe-D
[87.197896] Dynamic subtest pipe-D: SUCCESS (1.128s)
[87.200278] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.499s)
[88.372694] [008/133] (931s left) gem_basic (bad-close)
[88.424193] Starting subtest: bad-close
[88.428736] Subtest bad-close: SUCCESS (0.000s)
[88.502799] [009/133] (931s left) syncobj_basic (test-valid-cycle)
[88.556732] Starting subtest: test-valid-cycle
[88.558634] Subtest test-valid-cycle: SUCCESS (0.000s)
[88.665441] [010/133] (931s left) gen9_exec_parse (unaligned-jump)
[88.728811] Subtest unaligned-jump: SKIP (0.000s)
[88.805672] [011/133] (931s left) drm_buddy (drm_buddy)
[88.842769] Starting subtest: drm_buddy
[88.846895] Subtest drm_buddy: SKIP (0.000s)
[88.896769] [012/133] (931s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[88.993058] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[90.093666] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.100s)
[90.224776] [013/133] (929s left) gen9_exec_parse (bb-chained)
[90.284718] Subtest bb-chained: SKIP (0.000s)
[90.354220] [014/133] (929s left) gem_gtt_cpu_tlb
[90.469747] [015/133] (929s left) syncobj_timeline (transfer-timeline-point)
[90.516744] Starting subtest: transfer-timeline-point
[90.518823] Subtest transfer-timeline-point: SUCCESS (0.001s)
[90.624694] [016/133] (929s left) gem_ctx_shared (exec-single-timeline)
[90.687853] Starting subtest: exec-single-timeline
[90.689889] Starting dynamic subtest: rcs0
[91.764823] Dynamic subtest rcs0: SUCCESS (1.076s)
[91.773686] Starting dynamic subtest: bcs0
[92.854575] Dynamic subtest bcs0: SUCCESS (1.087s)
[92.865832] Starting dynamic subtest: vcs0
[93.943295] Dynamic subtest vcs0: SUCCESS (1.087s)
[93.958898] Starting dynamic subtest: vcs1
[95.030811] Dynamic subtest vcs1: SUCCESS (1.086s)
[95.042382] Starting dynamic subtest: vecs0
[96.119064] Dynamic subtest vecs0: SUCCESS (1.086s)
[96.130370] Starting dynamic subtest: ccs0
[97.207222] Dynamic subtest ccs0: SUCCESS (1.086s)
[97.210222] Subtest exec-single-timeline: SUCCESS (6.518s)
[97.953215] [017/133] (922s left) kms_chamelium_color (ctm-0-75)
[98.035296] Subtest ctm-0-75: SKIP (0.000s)
[98.077439] [018/133] (922s left) gem_pxp (create-regular-buffer)
[98.199479] Starting subtest: create-regular-buffer
[98.201741] Subtest create-regular-buffer: SUCCESS (0.000s)
[98.302387] [019/133] (921s left) kms_force_connector_basic (prune-stale-modes)
[98.354426] Subtest prune-stale-modes: SKIP (0.000s)
[98.406420] [020/133] (921s left) kms_chamelium_hpd (dp-hpd)
[98.790173] Subtest dp-hpd: SKIP (0.000s)
[99.566363] [021/133] (920s left) gem_render_copy (yf-tiled-to-vebox-linear)
[99.634451] Starting subtest: yf-tiled-to-vebox-linear
[99.639162] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[99.810917] [022/133] (920s left) kms_psr (psr-sprite-blt)
[99.889446] Starting subtest: psr-sprite-blt
[99.891668] Starting dynamic subtest: eDP-1
[101.603240] Dynamic subtest eDP-1: SUCCESS (1.715s)
[101.605631] Subtest psr-sprite-blt: SUCCESS (1.716s)
[102.444077] [023/133] (917s left) perf (non-system-wide-paranoid)
[102.572499] Starting subtest: non-system-wide-paranoid
[102.601479] Subtest non-system-wide-paranoid: SUCCESS (0.031s)
[102.653290] [024/133] (917s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[102.728850] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[102.731120] Starting dynamic subtest: pipe-A-eDP-1
[102.753954] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[102.763796] Starting dynamic subtest: pipe-B-eDP-1
[102.785907] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[102.793131] Starting dynamic subtest: pipe-C-eDP-1
[102.813937] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[102.821645] Starting dynamic subtest: pipe-D-eDP-1
[102.843455] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[102.847452] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[105.015299] [025/133] (915s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[105.076450] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[105.182664] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[105.254465] [026/133] (915s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k)
[105.641537] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s)
[106.412430] [027/133] (914s left) kms_panel_fitting (legacy)
[106.504702] Starting subtest: legacy
[106.506955] Starting dynamic subtest: pipe-A-eDP-1
[107.128798] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.624s)
[107.153863] Starting dynamic subtest: pipe-B-eDP-1
[108.723208] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.575s)
[108.748835] Starting dynamic subtest: pipe-C-eDP-1
[110.282430] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.539s)
[110.307548] Starting dynamic subtest: pipe-D-eDP-1
[111.821393] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.519s)
[111.823677] Subtest legacy: SUCCESS (5.319s)
[113.055736] [028/133] (907s left) api_intel_allocator (reserve-simple)
[113.124475] Starting subtest: reserve-simple
[113.126900] Subtest reserve-simple: SUCCESS (0.003s)
[113.239950] [029/133] (907s left) gem_exec_balancer (hog)
[113.295398] Starting subtest: hog
[113.299891] Subtest hog: SKIP (0.000s)
[113.586975] [030/133] (907s left) kms_flip (2x-dpms-vs-vblank-race)
[113.657532] Starting subtest: 2x-dpms-vs-vblank-race
[113.662345] Subtest 2x-dpms-vs-vblank-race: SKIP (0.007s)
[113.737287] [031/133] (906s left) gem_exec_schedule (pi-userfault)
[113.920512] Starting subtest: pi-userfault
[113.922805] Starting dynamic subtest: rcs0
[113.932829] Dynamic subtest rcs0: SUCCESS (0.014s)
[113.943130] Starting dynamic subtest: bcs0
[113.945381] Dynamic subtest bcs0: SUCCESS (0.010s)
[113.953241] Starting dynamic subtest: vcs0
[113.955056] Dynamic subtest vcs0: SUCCESS (0.007s)
[113.971598] Starting dynamic subtest: vcs1
[113.973871] Dynamic subtest vcs1: SUCCESS (0.009s)
[113.986268] Starting dynamic subtest: vecs0
[113.988086] Dynamic subtest vecs0: SUCCESS (0.015s)
[113.995666] Starting dynamic subtest: ccs0
[113.997580] Dynamic subtest ccs0: SUCCESS (0.007s)
[113.999490] Subtest pi-userfault: SUCCESS (0.064s)
[114.162868] [032/133] (906s left) kms_frontbuffer_tracking (fbc-tiling-y)
[114.251676] Starting subtest: fbc-tiling-y
[114.256169] Subtest fbc-tiling-y: SKIP (0.000s)
[114.364253] [033/133] (906s left) kms_vblank (wait-busy-hang)
[114.446983] Starting subtest: wait-busy-hang
[114.449311] Starting dynamic subtest: pipe-A-eDP-1
[140.637711] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.187s)
[140.651543] Starting dynamic subtest: pipe-D-eDP-1
[165.596577] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.955s)
[165.598963] Subtest wait-busy-hang: SUCCESS (51.146s)
[166.412481] [034/133] (854s left) gem_lmem_swapping (heavy-verify-random-ccs)
[166.460051] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[166.501124] [035/133] (854s left) gem_create (create-ext-cpu-access-big)
[166.668334] Starting subtest: create-ext-cpu-access-big
[166.673641] Subtest create-ext-cpu-access-big: SKIP (0.002s)
[166.744518] [036/133] (854s left) kms_async_flips (invalid-async-flip)
[166.826125] Starting subtest: invalid-async-flip
[167.216109] Starting dynamic subtest: pipe-A-eDP-1
[168.042930] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.827s)
[168.404903] Starting dynamic subtest: pipe-B-eDP-1
[169.191613] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.793s)
[169.559871] Starting dynamic subtest: pipe-C-eDP-1
[170.397052] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.842s)
[170.758394] Starting dynamic subtest: pipe-D-eDP-1
[171.538055] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.786s)
[171.540356] Subtest invalid-async-flip: SUCCESS (4.714s)
[172.694988] [037/133] (848s left) gem_userptr_blits (huge-split)
[172.761635] Starting subtest: huge-split
[172.769651] Subtest huge-split: SUCCESS (0.008s)
[172.894347] [038/133] (848s left) kms_pm_dc (dc5-psr)
[173.981031] Starting subtest: dc5-psr
[176.962397] Subtest dc5-psr: SUCCESS (2.981s)
[177.808258] [039/133] (843s left) prime_mmap (test_forked_cpu_write)
[177.855245] Starting subtest: test_forked_cpu_write
[177.857206] Starting dynamic subtest: test_forked_cpu_write-smem
[177.861638] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.007s)
[177.863780] Subtest test_forked_cpu_write: SUCCESS (0.008s)
[177.960758] [040/133] (843s left) kms_invalid_mode (zero-vdisplay)
[178.034557] Starting subtest: zero-vdisplay
[178.036841] Starting dynamic subtest: pipe-A-eDP-1
[178.326899] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.295s)
[178.335955] Starting dynamic subtest: pipe-B-eDP-1
[178.337835] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[178.345426] Starting dynamic subtest: pipe-C-eDP-1
[178.347349] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[178.355335] Starting dynamic subtest: pipe-D-eDP-1
[178.357539] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[178.359751] Subtest zero-vdisplay: SUCCESS (0.300s)
[179.161218] [041/133] (841s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[179.266702] Starting subtest: basic-busy-flip-before-cursor-legacy
[179.271521] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[179.416964] [042/133] (841s left) gem_eio (in-flight-contexts-1us)
[179.623136] Starting subtest: in-flight-contexts-1us
[190.893438] Subtest in-flight-contexts-1us: SUCCESS (11.270s)
[191.041427] [043/133] (830s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[191.126667] Starting subtest: 4-tiled-32bpp-rotate-270
[191.147937] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.021s)
[191.249207] [044/133] (829s left) perf (invalid-oa-format-id)
[191.339782] Starting subtest: invalid-oa-format-id
[191.348195] Subtest invalid-oa-format-id: SUCCESS (0.006s)
[191.392199] [045/133] (829s left) tools_test (tools_test)
[191.445119] Starting subtest: tools_test
[191.489274] Subtest tools_test: SUCCESS (0.061s)
[191.564607] [046/133] (829s left) prime_mmap (test_refcounting)
[191.619115] Starting subtest: test_refcounting
[191.621165] Starting dynamic subtest: test_refcounting-smem
[191.648016] Dynamic subtest test_refcounting-smem: SUCCESS (0.031s)
[191.650285] Subtest test_refcounting: SUCCESS (0.031s)
[191.745175] [047/133] (829s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[191.840650] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[195.864840] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.027s)
[197.048751] [048/133] (824s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[197.136576] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[197.140636] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[197.233326] [049/133] (824s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[197.288828] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[197.358898] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.005s)
[197.391995] [050/133] (824s left) kms_sequence (get-forked)
[197.458036] Starting subtest: get-forked
[197.460302] Starting dynamic subtest: pipe-A-eDP-1
[199.364835] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.905s)
[199.381757] Starting dynamic subtest: pipe-B-eDP-1
[201.887650] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.522s)
[201.896849] Starting dynamic subtest: pipe-C-eDP-1
[204.408790] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.520s)
[204.418122] Starting dynamic subtest: pipe-D-eDP-1
[206.941695] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.533s)
[206.944070] Subtest get-forked: SUCCESS (9.485s)
[207.752136] [051/133] (813s left) kms_flip (2x-flip-vs-suspend)
[207.829961] Starting subtest: 2x-flip-vs-suspend
[207.838183] Subtest 2x-flip-vs-suspend: SKIP (0.008s)
[207.912657] [052/133] (813s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[207.999975] Starting subtest: fbcpsr-rgb565-draw-blt
[214.993058] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (6.996s)
[215.128030] [053/133] (806s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[215.226463] Starting subtest: yf-tiled-64bpp-rotate-90
[215.230681] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[215.336038] [054/133] (806s left) gem_mmap_gtt (hang-user)
[215.394532] Subtest hang-user: SKIP (0.000s)
[215.450822] [055/133] (806s left) vgem_basic (busy-fence)
[215.539470] Starting subtest: busy-fence
[215.541398] Subtest busy-fence: SUCCESS (0.000s)
[215.592688] [FACT vgem_basic (busy-fence)] new: kernel.kmod_is_loaded.vgem: true
[215.595753] [056/133] (806s left) kms_psr (psr2-cursor-render)
[215.675770] Starting subtest: psr2-cursor-render
[215.678091] Starting dynamic subtest: eDP-1
[217.364071] Dynamic subtest eDP-1: SUCCESS (1.688s)
[217.366367] Subtest psr2-cursor-render: SUCCESS (1.689s)
[218.164887] [057/133] (803s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[218.248967] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[218.251348] Starting dynamic subtest: pipe-A-default-mode
[219.421597] Dynamic subtest pipe-A-default-mode: SKIP (1.170s)
[219.426382] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.172s)
[219.565100] [058/133] (802s left) kms_flip (2x-flip-vs-panning-vs-hang)
[219.646233] Starting subtest: 2x-flip-vs-panning-vs-hang
[219.650927] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.007s)
[219.769275] [059/133] (802s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[219.851704] Starting subtest: pr-cursor-plane-move-continuous-sf
[219.855938] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[219.918904] [060/133] (801s left) api_intel_bb (delta-check)
[219.973840] Starting subtest: delta-check
[219.980348] Subtest delta-check: SUCCESS (0.007s)
[220.108838] [061/133] (801s left) gem_exec_parallel (contexts)
[220.169287] Starting subtest: contexts
[220.171609] Starting dynamic subtest: rcs0
[223.593840] Dynamic subtest rcs0: SUCCESS (3.423s)
[223.602632] Starting dynamic subtest: bcs0
[227.979864] Dynamic subtest bcs0: SUCCESS (4.383s)
[227.991542] Starting dynamic subtest: vcs0
[234.243480] Dynamic subtest vcs0: SUCCESS (6.262s)
[234.254851] Starting dynamic subtest: vcs1
[240.231051] Dynamic subtest vcs1: SUCCESS (5.986s)
[240.246088] Starting dynamic subtest: vecs0
[246.275481] Dynamic subtest vecs0: SUCCESS (6.042s)
[246.284546] Starting dynamic subtest: ccs0
[250.533592] Dynamic subtest ccs0: SUCCESS (4.255s)
[250.535787] Subtest contexts: SUCCESS (30.363s)
[250.739421] [062/133] (771s left) i915_pm_rpm (debugfs-read)
[252.945645] Starting subtest: debugfs-read
[254.097671] Subtest debugfs-read: SUCCESS (1.152s)
[254.475701] [063/133] (767s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[254.557122] Starting subtest: fbc-rgb101010-draw-pwrite
[259.947366] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.395s)
[261.080888] [064/133] (760s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[261.135445] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[261.236588] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.102s)
[261.312590] [065/133] (760s left) kms_prop_blob (blob-multiple)
[261.370551] Starting subtest: blob-multiple
[261.372655] Subtest blob-multiple: SUCCESS (0.001s)
[261.465246] [066/133] (760s left) kms_draw_crc (draw-method-mmap-gtt)
[261.530908] Starting subtest: draw-method-mmap-gtt
[261.535173] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[261.620337] [067/133] (760s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[261.724297] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[262.736298] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.012s)
[262.846401] [068/133] (759s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[262.922550] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[262.926672] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[262.994425] [069/133] (759s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[263.074018] Starting subtest: y-tiled-8bpp-rotate-180
[263.077677] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[263.170331] [070/133] (759s left) gem_softpin (noreloc)
[263.219595] Starting subtest: noreloc
[268.652808] Subtest noreloc: SUCCESS (5.430s)
[268.760961] [071/133] (753s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[268.846610] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[268.851013] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[268.950262] [072/133] (753s left) gem_ctx_persistence (heartbeat-hang)
[269.000774] Starting subtest: heartbeat-hang
[269.005460] Subtest heartbeat-hang: SKIP (0.000s)
[269.119629] [073/133] (753s left) gem_exec_whisper (basic-normal-all)
[269.186655] Starting subtest: basic-normal-all
[271.366294] Subtest basic-normal-all: SUCCESS (2.178s)
[271.546913] [074/133] (750s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[271.627366] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[271.631407] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[271.713146] [075/133] (750s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[271.786513] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[271.790425] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[271.896827] [076/133] (750s left) kms_plane_lowres (tiling-none)
[271.971489] Starting subtest: tiling-none
[271.973717] Starting dynamic subtest: pipe-A-eDP-1
[271.978084] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[272.274075] Starting dynamic subtest: pipe-B-eDP-1
[272.278924] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[272.287803] Starting dynamic subtest: pipe-C-eDP-1
[272.292573] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[272.301513] Starting dynamic subtest: pipe-D-eDP-1
[272.305979] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[272.310282] Subtest tiling-none: SKIP (0.301s)
[273.111501] [077/133] (749s left) gem_tiled_fence_blits (basic)
[273.164157] Subtest basic: SKIP (0.000s)
[273.219810] [078/133] (749s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[273.287281] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[273.389909] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.103s)
[273.467068] [079/133] (749s left) perf (per-context-mode-unprivileged)
[273.549675] Starting subtest: per-context-mode-unprivileged
[273.554174] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[273.601069] [080/133] (749s left) kms_psr (pr-dpms)
[273.675212] Starting subtest: pr-dpms
[273.679778] Subtest pr-dpms: SKIP (0.000s)
[273.782224] [081/133] (748s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[273.862088] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[273.865863] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[273.969337] [082/133] (748s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[274.039112] Starting subtest: basic-modeset-with-all-modifiers-formats
[274.414344] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[275.172855] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.760s)
[275.182200] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[275.194236] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[275.202712] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[275.216480] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[275.227664] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[275.361108] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.144s)
[275.371062] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[275.383220] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[275.391947] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[275.405416] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[275.414064] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[275.427794] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[275.436661] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[275.449973] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.022s)
[275.458769] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[275.472305] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[275.481212] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[275.494390] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[275.505487] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[275.516659] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.022s)
[275.525140] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[275.538874] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[275.550427] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[275.695618] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.156s)
[275.705231] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[275.717128] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.019s)
[275.727652] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[275.738918] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.020s)
[275.747578] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[275.761104] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.021s)
[275.769643] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[275.783248] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.021s)
[275.791807] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[275.805585] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s)
[275.814496] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[275.827745] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.021s)
[275.836510] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[275.850188] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.021s)
[275.858871] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[275.872295] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.021s)
[275.881897] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[276.027922] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s)
[276.036360] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[276.049927] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[276.057886] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[276.072238] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[276.080149] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[276.094507] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.021s)
[276.102510] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[276.116772] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[276.124667] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[276.138921] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[276.147221] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[276.161107] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[276.169734] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[276.183510] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[276.191718] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[276.205572] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.021s)
[276.588285] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.549s)
[277.359455] [083/133] (745s left) syncobj_timeline (signal)
[277.421469] Starting subtest: signal
[277.423396] Subtest signal: SUCCESS (0.000s)
[277.511173] [084/133] (745s left) kms_hdr (invalid-metadata-sizes)
[277.579969] Starting subtest: invalid-metadata-sizes
[277.586512] Subtest invalid-metadata-sizes: SKIP (0.000s)
[277.655066] [085/133] (745s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[277.737702] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[281.700906] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (3.967s)
[282.850532] [086/133] (740s left) gem_softpin (allocator-nopin)
[282.915894] Starting subtest: allocator-nopin
[283.003899] Subtest allocator-nopin: SUCCESS (0.088s)
[283.144976] [087/133] (739s left) kms_cursor_crc (cursor-onscreen-128x42)
[283.378690] Starting subtest: cursor-onscreen-128x42
[283.441217] Subtest cursor-onscreen-128x42: SKIP (0.059s)
[283.660541] [088/133] (739s left) syncobj_timeline (invalid-wait-illegal-handle)
[283.719474] Starting subtest: invalid-wait-illegal-handle
[283.721647] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[283.814668] [089/133] (739s left) perf_pmu (busy-accuracy-2)
[283.851168] Starting subtest: busy-accuracy-2
[283.853279] Starting dynamic subtest: rcs0
[286.894157] Dynamic subtest rcs0: SUCCESS (3.039s)
[286.904735] Starting dynamic subtest: bcs0
[289.952741] Dynamic subtest bcs0: SUCCESS (3.057s)
[289.962271] Starting dynamic subtest: vcs0
[292.997649] Dynamic subtest vcs0: SUCCESS (3.043s)
[293.007051] Starting dynamic subtest: vcs1
[296.042308] Dynamic subtest vcs1: SUCCESS (3.042s)
[296.053211] Starting dynamic subtest: vecs0
[299.086190] Dynamic subtest vecs0: SUCCESS (3.041s)
[299.097321] Starting dynamic subtest: ccs0
[302.143587] Dynamic subtest ccs0: SUCCESS (3.054s)
[302.146095] Subtest busy-accuracy-2: SUCCESS (18.290s)
[302.262075] [090/133] (720s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[302.352593] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[302.354813] Starting dynamic subtest: pipe-A-eDP-1
[302.377713] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[302.389241] Starting dynamic subtest: pipe-B-eDP-1
[302.411174] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[302.420095] Starting dynamic subtest: pipe-C-eDP-1
[302.442067] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[302.453726] Starting dynamic subtest: pipe-D-eDP-1
[302.476053] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[302.480162] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.008s)
[304.592986] [091/133] (718s left) gem_pipe_control_store_loop (fresh-buffer)
[304.652730] Starting subtest: fresh-buffer
[306.805882] Subtest fresh-buffer: SUCCESS (2.152s)
[306.911223] [092/133] (716s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[306.991887] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[314.143313] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.157s)
[314.257614] [093/133] (708s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[314.355679] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[314.360279] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[314.463972] [094/133] (708s left) perf (invalid-oa-metric-set-id)
[314.555839] Starting subtest: invalid-oa-metric-set-id
[314.566368] Subtest invalid-oa-metric-set-id: SUCCESS (0.008s)
[314.605503] [095/133] (708s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[314.680885] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[315.649610] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.968s)
[315.772111] [096/133] (707s left) gem_softpin (evict-snoop-interruptible)
[315.832640] Starting subtest: evict-snoop-interruptible
[315.837228] Subtest evict-snoop-interruptible: SKIP (0.000s)
[315.945278] [097/133] (707s left) kms_flip (modeset-vs-vblank-race)
[316.025655] Starting subtest: modeset-vs-vblank-race
[316.027680] Starting dynamic subtest: A-eDP1
[320.743694] Dynamic subtest A-eDP1: SUCCESS (4.718s)
[320.754671] Starting dynamic subtest: B-eDP1
[325.470503] Dynamic subtest B-eDP1: SUCCESS (4.724s)
[325.485122] Starting dynamic subtest: C-eDP1
[330.163387] Dynamic subtest C-eDP1: SUCCESS (4.690s)
[330.174531] Starting dynamic subtest: D-eDP1
[334.781531] Dynamic subtest D-eDP1: SUCCESS (4.616s)
[334.783938] Subtest modeset-vs-vblank-race: SUCCESS (18.760s)
[335.955098] [098/133] (687s left) gem_eio (banned)
[336.178401] Starting subtest: banned
[336.815358] Subtest banned: SUCCESS (0.637s)
[336.967355] [099/133] (686s left) kms_cursor_crc (cursor-random-128x42)
[337.179178] Starting subtest: cursor-random-128x42
[337.221902] Subtest cursor-random-128x42: SKIP (0.040s)
[337.417848] [100/133] (686s left) kms_lease (lease-revoke)
[337.481059] Starting subtest: lease-revoke
[337.482971] Starting dynamic subtest: pipe-A-eDP-1
[337.511968] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.031s)
[337.522476] Starting dynamic subtest: pipe-B-eDP-1
[337.539597] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.026s)
[337.551759] Starting dynamic subtest: pipe-C-eDP-1
[337.570347] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.027s)
[337.579256] Starting dynamic subtest: pipe-D-eDP-1
[337.599193] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.027s)
[337.601136] Subtest lease-revoke: SUCCESS (0.117s)
[337.714855] [101/133] (685s left) gem_exec_reloc (basic-gtt-noreloc)
[337.763937] Subtest basic-gtt-noreloc: SKIP (0.000s)
[337.828913] [102/133] (685s left) kms_pipe_stress (stress-xrgb8888-untiled)
[337.897446] Starting subtest: stress-xrgb8888-untiled
[343.621943] Subtest stress-xrgb8888-untiled: SUCCESS (5.724s)
[343.679605] [103/133] (679s left) kms_content_protection (mei-interface)
[343.799468] Starting subtest: mei-interface
[343.803177] Subtest mei-interface: SKIP (0.001s)
[343.923708] [104/133] (679s left) gem_mmap_gtt (cpuset-big-copy-odd)
[343.979304] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[344.033643] [105/133] (679s left) prime_self_import (basic-with_fd_dup)
[344.070566] Starting subtest: basic-with_fd_dup
[344.090354] Subtest basic-with_fd_dup: SUCCESS (0.021s)
[344.194736] [106/133] (679s left) fbdev (nullptr)
[344.239326] Starting subtest: nullptr
[344.241395] Subtest nullptr: SUCCESS (0.000s)
[344.304816] [107/133] (679s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[344.387992] Starting subtest: psr-rgb101010-draw-mmap-cpu
[351.312059] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (6.927s)
[351.409677] [108/133] (672s left) i915_hangman (error-state-basic)
[351.467640] Starting subtest: error-state-basic
[351.618815] Subtest error-state-basic: SUCCESS (0.153s)
[351.704643] [109/133] (672s left) kms_rotation_crc (bad-tiling)
[351.780990] Starting subtest: bad-tiling
[351.785403] Subtest bad-tiling: SKIP (0.001s)
[351.855318] [110/133] (672s left) gem_userptr_blits (sync-unmap-after-close)
[351.918759] Starting subtest: sync-unmap-after-close
[351.928547] Subtest sync-unmap-after-close: SUCCESS (0.012s)
[352.063525] [111/133] (671s left) kms_flip (flip-vs-expired-vblank-interruptible)
[352.136283] Starting subtest: flip-vs-expired-vblank-interruptible
[352.138491] Starting dynamic subtest: A-eDP1
[360.780282] Dynamic subtest A-eDP1: SUCCESS (8.642s)
[360.789068] Starting dynamic subtest: B-eDP1
[369.407588] Dynamic subtest B-eDP1: SUCCESS (8.625s)
[369.416665] Starting dynamic subtest: C-eDP1
[378.035581] Dynamic subtest C-eDP1: SUCCESS (8.626s)
[378.045568] Starting dynamic subtest: D-eDP1
[386.667414] Dynamic subtest D-eDP1: SUCCESS (8.630s)
[386.669675] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.532s)
[387.842686] [112/133] (636s left) gem_exec_fence (syncobj-timeline-chain-engines)
[388.434495] Starting subtest: syncobj-timeline-chain-engines
[388.560711] Subtest syncobj-timeline-chain-engines: SUCCESS (0.126s)
[389.935823] [113/133] (634s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[390.029685] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[390.033705] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[390.102189] [114/133] (633s left) kms_cursor_edge_walk (64x64-left-edge)
[390.168759] Starting subtest: 64x64-left-edge
[390.171067] Starting dynamic subtest: pipe-A-eDP-1
[393.607892] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.437s)
[393.617142] Starting dynamic subtest: pipe-D-eDP-1
[396.734524] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.126s)
[396.736916] Subtest 64x64-left-edge: SUCCESS (6.566s)
[397.527175] [115/133] (626s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[397.618216] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[397.620624] Starting dynamic subtest: pipe-A-eDP-1
[397.643412] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[397.653949] Starting dynamic subtest: pipe-B-eDP-1
[397.675325] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[397.683312] Starting dynamic subtest: pipe-C-eDP-1
[397.704371] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[397.712477] Starting dynamic subtest: pipe-D-eDP-1
[397.734262] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[397.738588] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[399.904486] [116/133] (624s left) gem_exec_schedule (fifo)
[399.964335] Starting subtest: fifo
[399.966522] Starting dynamic subtest: rcs0
[400.055708] Dynamic subtest rcs0: SUCCESS (0.101s)
[400.067670] Starting dynamic subtest: vcs0
[400.138813] Dynamic subtest vcs0: SUCCESS (0.082s)
[400.149855] Starting dynamic subtest: vcs1
[400.217844] Dynamic subtest vcs1: SUCCESS (0.078s)
[400.228960] Starting dynamic subtest: vecs0
[400.297796] Dynamic subtest vecs0: SUCCESS (0.079s)
[400.311876] Starting dynamic subtest: ccs0
[400.385792] Dynamic subtest ccs0: SUCCESS (0.087s)
[400.388549] Subtest fifo: SUCCESS (0.432s)
[401.905993] [117/133] (622s left) kms_psr (fbc-psr2-basic)
[401.979889] Starting subtest: fbc-psr2-basic
[401.982142] Starting dynamic subtest: eDP-1
[401.986247] Dynamic subtest eDP-1: SKIP (0.000s)
[401.990519] Subtest fbc-psr2-basic: SKIP (0.001s)
[402.053208] [118/133] (622s left) prime_mmap (test_forked)
[402.106599] Starting subtest: test_forked
[402.109064] Starting dynamic subtest: test_forked-smem
[402.149081] Dynamic subtest test_forked-smem: SUCCESS (0.045s)
[402.151325] Subtest test_forked: SUCCESS (0.046s)
[402.262951] [119/133] (621s left) i915_query (query-regions-garbage-items)
[402.324198] Starting subtest: query-regions-garbage-items
[402.326590] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[402.422083] [120/133] (621s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[402.505737] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[402.510154] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[402.621223] [121/133] (621s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[402.731227] Starting subtest: cursorA-vs-flipB-varying-size
[402.735542] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[402.876193] [122/133] (621s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[402.950955] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[402.954443] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[403.061963] [123/133] (621s left) gem_render_copy (linear-to-vebox-yf-tiled)
[403.115617] Starting subtest: linear-to-vebox-yf-tiled
[403.119157] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[403.302046] [124/133] (621s left) gem_ctx_isolation (nonpriv)
[403.367356] Starting subtest: nonpriv
[403.369789] Starting dynamic subtest: rcs0
[403.601646] Dynamic subtest rcs0: SUCCESS (0.234s)
[403.613187] Starting dynamic subtest: bcs0
[403.846202] Dynamic subtest bcs0: SUCCESS (0.244s)
[403.857889] Starting dynamic subtest: vcs0
[404.109191] Dynamic subtest vcs0: SUCCESS (0.262s)
[404.120424] Starting dynamic subtest: vcs1
[406.081126] Dynamic subtest vcs1: SUCCESS (1.971s)
[406.092721] Starting dynamic subtest: vecs0
[408.059040] Dynamic subtest vecs0: SUCCESS (1.976s)
[408.068122] Starting dynamic subtest: ccs0
[410.133208] Dynamic subtest ccs0: SUCCESS (2.073s)
[410.135680] Subtest nonpriv: SUCCESS (6.766s)
[410.375022] [125/133] (614s left) kms_psr (fbc-psr-primary-mmap-gtt)
[410.454388] Starting subtest: fbc-psr-primary-mmap-gtt
[410.456654] Starting dynamic subtest: eDP-1
[410.460987] Dynamic subtest eDP-1: SKIP (0.000s)
[410.465380] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.001s)
[410.528173] [126/133] (614s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[410.603801] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[410.608092] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[410.691102] [127/133] (613s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[410.945891] Starting subtest: parallel-dmabuf-import-out-fence
[412.004571] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.061s)
[412.103986] [128/133] (612s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[412.198022] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[412.200231] Starting dynamic subtest: A-eDP1
[421.154935] Dynamic subtest A-eDP1: SUCCESS (8.955s)
[421.172269] Starting dynamic subtest: B-eDP1
[430.088315] Dynamic subtest B-eDP1: SUCCESS (8.931s)
[430.099791] Starting dynamic subtest: C-eDP1
[438.999924] Dynamic subtest C-eDP1: SUCCESS (8.908s)
[439.012085] Starting dynamic subtest: D-eDP1
[447.932791] Dynamic subtest D-eDP1: SUCCESS (8.929s)
[447.938691] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.738s)
[449.150362] [129/133] (575s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[449.231303] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[449.235322] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[449.336157] [130/133] (575s left) kms_plane (plane-position-covered)
[449.412807] Starting subtest: plane-position-covered
[449.959059] Starting dynamic subtest: pipe-A-plane-1
[451.230331] Dynamic subtest pipe-A-plane-1: SUCCESS (1.270s)
[451.240024] Starting dynamic subtest: pipe-A-plane-2
[452.470257] Dynamic subtest pipe-A-plane-2: SUCCESS (1.237s)
[452.480068] Starting dynamic subtest: pipe-A-plane-3
[453.780246] Dynamic subtest pipe-A-plane-3: SUCCESS (1.310s)
[453.790066] Starting dynamic subtest: pipe-A-plane-4
[455.017645] Dynamic subtest pipe-A-plane-4: SUCCESS (1.236s)
[455.027160] Starting dynamic subtest: pipe-A-plane-5
[455.042928] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[456.187760] Starting dynamic subtest: pipe-B-plane-1
[457.569712] Dynamic subtest pipe-B-plane-1: SUCCESS (1.390s)
[457.579999] Starting dynamic subtest: pipe-B-plane-2
[458.837081] Dynamic subtest pipe-B-plane-2: SUCCESS (1.263s)
[458.847211] Starting dynamic subtest: pipe-B-plane-3
[460.192215] Dynamic subtest pipe-B-plane-3: SUCCESS (1.355s)
[460.202468] Starting dynamic subtest: pipe-B-plane-4
[461.502589] Dynamic subtest pipe-B-plane-4: SUCCESS (1.312s)
[461.513266] Starting dynamic subtest: pipe-B-plane-5
[461.529487] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[461.531902] Subtest plane-position-covered: SUCCESS (12.115s)
[462.380687] [131/133] (562s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[462.483577] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[462.487930] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[462.629468] [132/133] (562s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[462.698911] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[462.701136] Starting dynamic subtest: pipe-A-eDP-1
[462.723116] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[462.734569] Starting dynamic subtest: pipe-B-eDP-1
[462.755951] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[462.764460] Starting dynamic subtest: pipe-C-eDP-1
[462.786189] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[462.794790] Starting dynamic subtest: pipe-D-eDP-1
[462.816683] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[462.820751] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[464.960196] [133/133] (559s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[465.042497] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[465.046846] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[465.150600] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: gem_exec_schedule
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_color_pipeline
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: perf_pmu
results: parsing output: 6/ for test: kms_plane_scaling
results: parsing output: 7/ for test: gem_basic
results: parsing output: 8/ for test: syncobj_basic
results: parsing output: 9/ for test: gen9_exec_parse
results: parsing output: 10/ for test: drm_buddy
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: gen9_exec_parse
results: parsing output: 13/ for test: gem_gtt_cpu_tlb
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: gem_ctx_shared
results: parsing output: 16/ for test: kms_chamelium_color
results: parsing output: 17/ for test: gem_pxp
results: parsing output: 18/ for test: kms_force_connector_basic
results: parsing output: 19/ for test: kms_chamelium_hpd
results: parsing output: 20/ for test: gem_render_copy
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: perf
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: kms_chamelium_edid
results: parsing output: 26/ for test: kms_panel_fitting
results: parsing output: 27/ for test: api_intel_allocator
results: parsing output: 28/ for test: gem_exec_balancer
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: gem_exec_schedule
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_vblank
results: parsing output: 33/ for test: gem_lmem_swapping
results: parsing output: 34/ for test: gem_create
results: parsing output: 35/ for test: kms_async_flips
results: parsing output: 36/ for test: gem_userptr_blits
results: parsing output: 37/ for test: kms_pm_dc
results: parsing output: 38/ for test: prime_mmap
results: parsing output: 39/ for test: kms_invalid_mode
results: parsing output: 40/ for test: kms_cursor_legacy
results: parsing output: 41/ for test: gem_eio
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: perf
results: parsing output: 44/ for test: tools_test
results: parsing output: 45/ for test: prime_mmap
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: sriov_basic
results: parsing output: 49/ for test: kms_sequence
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: gem_mmap_gtt
results: parsing output: 54/ for test: vgem_basic
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: kms_flip_scaled_crc
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: kms_psr2_sf
results: parsing output: 59/ for test: api_intel_bb
results: parsing output: 60/ for test: gem_exec_parallel
results: parsing output: 61/ for test: i915_pm_rpm
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: syncobj_wait
results: parsing output: 64/ for test: kms_prop_blob
results: parsing output: 65/ for test: kms_draw_crc
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: kms_plane
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: gem_softpin
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_ctx_persistence
results: parsing output: 72/ for test: gem_exec_whisper
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_plane_lowres
results: parsing output: 76/ for test: gem_tiled_fence_blits
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: perf
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_async_flips
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: kms_hdr
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_softpin
results: parsing output: 86/ for test: kms_cursor_crc
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: perf_pmu
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: gem_pipe_control_store_loop
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: perf
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: gem_softpin
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: gem_eio
results: parsing output: 98/ for test: kms_cursor_crc
results: parsing output: 99/ for test: kms_lease
results: parsing output: 100/ for test: gem_exec_reloc
results: parsing output: 101/ for test: kms_pipe_stress
results: parsing output: 102/ for test: kms_content_protection
results: parsing output: 103/ for test: gem_mmap_gtt
results: parsing output: 104/ for test: prime_self_import
results: parsing output: 105/ for test: fbdev
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: i915_hangman
results: parsing output: 108/ for test: kms_rotation_crc
results: parsing output: 109/ for test: gem_userptr_blits
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: gem_exec_fence
results: parsing output: 112/ for test: kms_psr2_sf
results: parsing output: 113/ for test: kms_cursor_edge_walk
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: gem_exec_schedule
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: prime_mmap
results: parsing output: 118/ for test: i915_query
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: kms_cursor_legacy
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_render_copy
results: parsing output: 123/ for test: gem_ctx_isolation
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_exec_balancer
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_plane
results: parsing output: 130/ for test: kms_cursor_legacy
results: parsing output: 131/ for test: kms_ccs
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.