[62.098550] Initializing watchdogs
[62.098598]   /dev/watchdog0
[62.113530] [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]
[62.118309] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.121416] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.123265] [001/133] (960s left) gem_workarounds (suspend-resume-context)
[62.192330] Starting subtest: suspend-resume-context
[79.004038] Subtest suspend-resume-context: SUCCESS (1.709s)
[85.162515] [002/133] (943s left) api_intel_bb (crc32)
[85.218005] Starting subtest: crc32
[85.218985] Starting dynamic subtest: rcs0-smem0
[85.558836] Dynamic subtest rcs0-smem0: SUCCESS (0.330s)
[85.566060] Starting dynamic subtest: bcs0-smem0
[85.932249] Dynamic subtest bcs0-smem0: SUCCESS (0.372s)
[85.941734] Starting dynamic subtest: vcs0-smem0
[86.362025] Dynamic subtest vcs0-smem0: SUCCESS (0.426s)
[86.371944] Starting dynamic subtest: vcs1-smem0
[86.724762] Dynamic subtest vcs1-smem0: SUCCESS (0.359s)
[86.735276] Starting dynamic subtest: vecs0-smem0
[87.085843] Dynamic subtest vecs0-smem0: SUCCESS (0.358s)
[87.095122] Starting dynamic subtest: ccs0-smem0
[87.448334] Dynamic subtest ccs0-smem0: SUCCESS (0.360s)
[87.449427] Subtest crc32: SUCCESS (2.211s)
[87.558528] [003/133] (941s left) kms_psr (psr-sprite-plane-move)
[87.651440] Starting subtest: psr-sprite-plane-move
[87.652541] Starting dynamic subtest: eDP-1
[89.405794] Dynamic subtest eDP-1: SUCCESS (1.745s)
[89.406715] Subtest psr-sprite-plane-move: SUCCESS (1.745s)
[90.223910] [004/133] (938s left) kms_display_modes (extended-mode-basic)
[90.300585] Starting subtest: extended-mode-basic
[90.302313] Subtest extended-mode-basic: SKIP (0.000s)
[90.341795] [005/133] (938s left) kms_plane_alpha_blend (constant-alpha-mid)
[90.445813] Starting subtest: constant-alpha-mid
[90.730569] Starting dynamic subtest: pipe-A-eDP-1
[91.654921] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.920s)
[91.661676] Starting dynamic subtest: pipe-D-eDP-1
[93.191783] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.530s)
[93.192716] Subtest constant-alpha-mid: SUCCESS (2.736s)
[93.994553] [006/133] (934s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[94.079052] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[94.079889] Starting dynamic subtest: pipe-A-eDP-1
[105.416762] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.317s)
[105.423940] Starting dynamic subtest: pipe-B-eDP-1
[117.451484] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.026s)
[117.452446] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.345s)
[118.289959] [007/133] (910s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[118.402930] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[118.404578] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[118.492254] [008/133] (910s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[118.570359] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[118.579208] Starting dynamic subtest: A-eDP1
[122.226900] Dynamic subtest A-eDP1: SUCCESS (3.656s)
[122.234452] Starting dynamic subtest: B-eDP1
[125.442032] Dynamic subtest B-eDP1: SUCCESS (3.214s)
[125.454364] Starting dynamic subtest: C-eDP1
[128.561649] Dynamic subtest C-eDP1: SUCCESS (3.119s)
[128.568855] Starting dynamic subtest: D-eDP1
[131.774782] Dynamic subtest D-eDP1: SUCCESS (3.212s)
[131.776435] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.207s)
[132.566165] [009/133] (896s left) i915_drm_fdinfo (busy-hang)
[132.609992] Starting subtest: busy-hang
[132.610937] Starting dynamic subtest: rcs0
[132.636659] Dynamic subtest rcs0: SKIP (0.025s)
[132.644834] Starting dynamic subtest: bcs0
[132.646658] Dynamic subtest bcs0: SKIP (0.001s)
[132.652633] Starting dynamic subtest: vcs0
[132.654463] Dynamic subtest vcs0: SKIP (0.000s)
[132.660425] Starting dynamic subtest: vcs1
[132.662323] Dynamic subtest vcs1: SKIP (0.000s)
[132.668428] Starting dynamic subtest: vecs0
[132.670289] Dynamic subtest vecs0: SKIP (0.000s)
[132.676672] Starting dynamic subtest: ccs0
[132.678445] Dynamic subtest ccs0: SKIP (0.000s)
[132.680273] Subtest busy-hang: SKIP (0.029s)
[132.706062] [010/133] (896s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[132.804068] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[132.805826] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[132.897982] [011/133] (896s left) kms_addfb_basic (unused-modifier)
[132.946606] Starting subtest: unused-modifier
[132.947481] Subtest unused-modifier: SUCCESS (0.000s)
[133.081422] [012/133] (895s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[133.168850] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[133.170634] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[133.264586] [013/133] (895s left) gem_softpin (allocator-fork)
[133.316638] Starting subtest: allocator-fork
[135.535820] Subtest allocator-fork: SUCCESS (2.210s)
[135.651654] [014/133] (893s left) gem_exec_params (invalid-ring)
[135.696457] Starting subtest: invalid-ring
[135.697505] Subtest invalid-ring: SUCCESS (0.000s)
[135.785587] [015/133] (893s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[135.886517] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[142.485899] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.599s)
[142.628018] [016/133] (886s left) gem_exec_balancer (persistence)
[142.888265] Starting subtest: persistence
[143.871931] Subtest persistence: SUCCESS (0.981s)
[143.971576] [017/133] (885s left) gem_exec_reloc (basic-cpu-wc-active)
[144.018913] Subtest basic-cpu-wc-active: SKIP (0.000s)
[144.092309] [018/133] (885s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[144.188138] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[144.189736] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[144.275211] [019/133] (884s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[144.356687] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[144.358380] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[144.424730] [020/133] (884s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[144.519792] Starting subtest: yf-tiled-8bpp-rotate-90
[144.521481] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[144.604050] [021/133] (884s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[144.666429] Starting subtest: multi-wait-all-for-submit-available-submitted
[144.667355] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[144.781488] [022/133] (884s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[144.875435] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[144.879127] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[144.980763] [023/133] (884s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[145.066217] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[145.068200] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[145.190824] [024/133] (884s left) gem_media_vme
[145.332206] [025/133] (884s left) kms_invalid_mode (clock-too-high)
[145.419334] Starting subtest: clock-too-high
[145.420217] Starting dynamic subtest: pipe-A-eDP-1
[145.421976] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[145.428977] Starting dynamic subtest: pipe-B-eDP-1
[145.430690] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[145.442960] Starting dynamic subtest: pipe-C-eDP-1
[145.445419] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[145.459822] Starting dynamic subtest: pipe-D-eDP-1
[145.462457] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[145.464877] Subtest clock-too-high: SKIP (0.004s)
[145.497052] [026/133] (883s left) kms_psr (fbc-psr2-primary-blt)
[145.580997] Starting subtest: fbc-psr2-primary-blt
[145.581911] Starting dynamic subtest: eDP-1
[145.583593] Dynamic subtest eDP-1: SKIP (0.000s)
[145.585284] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[145.657221] [027/133] (883s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[145.754691] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[145.755577] Starting dynamic subtest: pipe-A
[145.774059] Dynamic subtest pipe-A: SKIP (0.018s)
[145.780748] Starting dynamic subtest: pipe-B
[145.807025] Dynamic subtest pipe-B: SKIP (0.033s)
[145.813809] Starting dynamic subtest: pipe-C
[145.840310] Dynamic subtest pipe-C: SKIP (0.032s)
[145.846879] Starting dynamic subtest: pipe-D
[145.871828] Dynamic subtest pipe-D: SKIP (0.031s)
[145.873496] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.116s)
[145.971209] [028/133] (883s left) gem_exec_schedule (out-order)
[146.031286] Starting subtest: out-order
[146.032240] Starting dynamic subtest: rcs0
[146.135249] Dynamic subtest rcs0: SUCCESS (0.103s)
[146.144255] Starting dynamic subtest: vcs0
[146.229462] Dynamic subtest vcs0: SUCCESS (0.086s)
[146.239806] Starting dynamic subtest: vcs1
[146.306427] Dynamic subtest vcs1: SUCCESS (0.084s)
[146.316484] Starting dynamic subtest: vecs0
[146.386772] Dynamic subtest vecs0: SUCCESS (0.079s)
[146.397010] Starting dynamic subtest: ccs0
[146.469527] Dynamic subtest ccs0: SUCCESS (0.082s)
[146.471269] Subtest out-order: SUCCESS (0.437s)
[148.075364] [029/133] (881s left) kms_psr (psr2-no-drrs)
[148.151940] Starting subtest: psr2-no-drrs
[148.152945] Starting dynamic subtest: eDP-1
[149.797315] Dynamic subtest eDP-1: SUCCESS (1.644s)
[149.798068] Subtest psr2-no-drrs: SUCCESS (1.645s)
[150.593750] [030/133] (879s left) gem_exec_balancer (bonded-chain)
[150.646160] Starting subtest: bonded-chain
[157.691161] Subtest bonded-chain: SUCCESS (7.034s)
[157.994718] [031/133] (871s left) kms_chamelium_edid (hdmi-edid-read)
[158.375903] Subtest hdmi-edid-read: SKIP (0.000s)
[159.189454] [032/133] (870s left) kms_content_protection (dp-mst-lic-type-1)
[159.326779] Starting subtest: dp-mst-lic-type-1
[159.329255] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[159.440651] [033/133] (870s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[159.528915] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[159.530596] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[159.594774] [034/133] (870s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[159.681124] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[163.303926] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.622s)
[164.428409] [035/133] (865s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[164.518707] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[164.547069] Starting dynamic subtest: pipe-A-plane-0
[164.980208] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[164.988590] Starting dynamic subtest: pipe-A-plane-3
[165.235721] Dynamic subtest pipe-A-plane-3: SUCCESS (0.254s)
[166.310645] Starting dynamic subtest: pipe-B-plane-0
[166.737149] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[166.744531] Starting dynamic subtest: pipe-B-plane-3
[167.003886] Dynamic subtest pipe-B-plane-3: SUCCESS (0.266s)
[167.312167] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.792s)
[168.193941] [036/133] (861s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[168.294110] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[168.295834] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[168.372206] [037/133] (861s left) gem_tiled_fence_blits (normal)
[168.427545] Subtest normal: SKIP (0.000s)
[168.495297] [038/133] (861s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[168.584181] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[168.585169] Starting dynamic subtest: pipe-A-eDP-1
[168.593976] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[168.600975] Starting dynamic subtest: pipe-B-eDP-1
[168.609481] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[168.616219] Starting dynamic subtest: pipe-C-eDP-1
[168.624203] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[168.630501] Starting dynamic subtest: pipe-D-eDP-1
[168.639247] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[168.641198] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[170.840667] [039/133] (859s left) kms_cursor_crc (cursor-alpha-transparent)
[170.934649] Starting subtest: cursor-alpha-transparent
[170.935556] Starting dynamic subtest: pipe-A-eDP-1
[171.544003] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.608s)
[171.550835] Starting dynamic subtest: pipe-D-eDP-1
[172.805721] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.260s)
[172.806573] Subtest cursor-alpha-transparent: SUCCESS (1.871s)
[173.595584] [040/133] (856s left) core_auth (basic-auth)
[173.648481] Starting subtest: basic-auth
[173.649352] Subtest basic-auth: SUCCESS (0.001s)
[173.752389] [041/133] (856s left) kms_getfb (getfb-reject-nv12)
[173.840575] Starting subtest: getfb-reject-nv12
[173.841335] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[173.957386] [042/133] (856s left) kms_psr (fbc-psr-cursor-plane-move)
[174.041319] Starting subtest: fbc-psr-cursor-plane-move
[174.042170] Starting dynamic subtest: eDP-1
[174.044006] Dynamic subtest eDP-1: SKIP (0.000s)
[174.053265] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[174.123934] [043/133] (855s left) gem_userptr_blits (sync-overlap)
[174.178850] Starting subtest: sync-overlap
[174.179835] Subtest sync-overlap: SUCCESS (0.000s)
[174.293046] [044/133] (855s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[174.384485] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[175.188020] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.803s)
[175.354338] [045/133] (854s left) gem_exec_gttfill (multigpu-basic)
[175.534009] Starting subtest: multigpu-basic
[188.109127] Subtest multigpu-basic: SUCCESS (12.576s)
[188.141545] [046/133] (841s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[188.285542] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[188.286469] Starting dynamic subtest: pipe-A-eDP-1
[188.290128] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[188.300086] Starting dynamic subtest: pipe-B-eDP-1
[188.303616] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[188.310450] Starting dynamic subtest: pipe-C-eDP-1
[188.313855] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[188.320687] Starting dynamic subtest: pipe-D-eDP-1
[188.323908] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[188.325542] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[190.472678] [047/133] (839s left) kms_cursor_edge_walk (256x256-top-edge)
[190.569002] Starting subtest: 256x256-top-edge
[190.569911] Starting dynamic subtest: pipe-A-eDP-1
[194.059199] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.490s)
[194.066339] Starting dynamic subtest: pipe-D-eDP-1
[197.196465] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.137s)
[197.197357] Subtest 256x256-top-edge: SUCCESS (6.629s)
[197.985357] [048/133] (832s left) gem_mmap_wc (write-cpu-read-wc)
[198.033254] Subtest write-cpu-read-wc: SKIP (0.000s)
[198.095274] [049/133] (832s left) gem_ctx_isolation (preservation-s3)
[198.156640] Starting subtest: preservation-S3
[198.157627] Starting dynamic subtest: rcs0
[215.029387] Dynamic subtest rcs0: SUCCESS (1.736s)
[215.039608] Starting dynamic subtest: bcs0
[232.031923] Dynamic subtest bcs0: SUCCESS (1.685s)
[232.038969] Starting dynamic subtest: vcs0
[249.033406] Dynamic subtest vcs0: SUCCESS (2.858s)
[249.040799] Starting dynamic subtest: vcs1
[267.027726] Dynamic subtest vcs1: SUCCESS (5.053s)
[267.035410] Starting dynamic subtest: vecs0
[285.029202] Dynamic subtest vecs0: SUCCESS (4.989s)
[285.038285] Starting dynamic subtest: ccs0
[303.031085] Dynamic subtest ccs0: SUCCESS (3.183s)
[303.032050] Subtest preservation-S3: SUCCESS (19.510s)
[310.288358] [050/133] (726s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[312.522022] Starting subtest: dpms-mode-unset-non-lpsp
[313.691727] Subtest dpms-mode-unset-non-lpsp: SKIP (1.163s)
[314.054661] [051/133] (723s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[314.175966] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[314.329275] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.154s)
[314.460100] [052/133] (722s left) gem_mmap_gtt (basic-short)
[314.507133] Subtest basic-short: SKIP (0.000s)
[314.570630] [053/133] (722s left) gem_mmap_gtt (basic-write-gtt)
[314.622702] Subtest basic-write-gtt: SKIP (0.000s)
[314.690569] [054/133] (722s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[314.739289] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[314.842491] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[314.911781] [055/133] (722s left) fbdev (eof)
[314.948614] Starting subtest: eof
[314.949768] Subtest eof: SUCCESS (0.000s)
[315.026398] [056/133] (722s left) kms_plane_cursor (primary)
[315.123192] Starting subtest: primary
[315.124943] Starting dynamic subtest: pipe-A-eDP-1-size-64
[317.687597] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.554s)
[317.714293] Starting dynamic subtest: pipe-A-eDP-1-size-128
[320.285460] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.572s)
[320.310875] Starting dynamic subtest: pipe-A-eDP-1-size-256
[322.881066] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.572s)
[323.196363] Starting dynamic subtest: pipe-B-eDP-1-size-64
[326.530920] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.337s)
[326.555585] Starting dynamic subtest: pipe-B-eDP-1-size-128
[329.113082] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.561s)
[329.138235] Starting dynamic subtest: pipe-B-eDP-1-size-256
[331.716772] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.583s)
[332.038164] Starting dynamic subtest: pipe-C-eDP-1-size-64
[334.941767] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.909s)
[334.968871] Starting dynamic subtest: pipe-C-eDP-1-size-128
[337.154625] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.192s)
[337.182890] Starting dynamic subtest: pipe-C-eDP-1-size-256
[339.367311] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.192s)
[339.682481] Starting dynamic subtest: pipe-D-eDP-1-size-64
[342.599233] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.924s)
[342.625503] Starting dynamic subtest: pipe-D-eDP-1-size-128
[344.809423] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.191s)
[344.836432] Starting dynamic subtest: pipe-D-eDP-1-size-256
[347.031211] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.202s)
[347.344450] Subtest primary: SUCCESS (32.179s)
[348.130167] [057/133] (689s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[348.236004] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[356.955661] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.720s)
[357.077071] [058/133] (680s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[357.132255] Starting subtest: yf-tiled-to-vebox-y-tiled
[357.134012] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[357.322038] [059/133] (680s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[357.411357] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[357.413015] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[357.500963] [060/133] (680s left) kms_universal_plane (universal-plane-pageflip-windowed)
[357.591478] Starting subtest: universal-plane-pageflip-windowed
[357.592403] Starting dynamic subtest: pipe-A-eDP-1
[358.186894] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.594s)
[358.194276] Starting dynamic subtest: pipe-B-eDP-1
[359.408137] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.220s)
[359.416970] Starting dynamic subtest: pipe-C-eDP-1
[360.654764] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.245s)
[360.663120] Starting dynamic subtest: pipe-D-eDP-1
[361.878151] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.221s)
[361.878998] Subtest universal-plane-pageflip-windowed: SUCCESS (4.287s)
[362.717333] [061/133] (674s left) syncobj_timeline (wait-for-submit-complex)
[362.771899] Starting subtest: wait-for-submit-complex
[362.833496] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[362.914912] [062/133] (674s left) gem_mmap_gtt (big-copy-xy)
[362.956993] Subtest big-copy-XY: SKIP (0.000s)
[363.008949] [063/133] (674s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[363.060382] Starting subtest: yf-tiled-ccs-to-x-tiled
[363.062208] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[363.233900] [064/133] (674s left) kms_dsc (dsc-basic)
[363.317371] Starting subtest: dsc-basic
[363.322766] Subtest dsc-basic: SKIP (0.000s)
[363.382849] [065/133] (674s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[363.469305] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[363.480810] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.011s)
[363.555625] [066/133] (674s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[363.645099] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[370.344896] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.699s)
[370.476669] [067/133] (667s left) kms_flip (flip-vs-suspend)
[370.569987] Starting subtest: flip-vs-suspend
[370.570995] Starting dynamic subtest: A-eDP1
[404.010192] Dynamic subtest A-eDP1: SUCCESS (4.255s)
[404.025624] Starting dynamic subtest: B-eDP1
[438.012525] Dynamic subtest B-eDP1: SUCCESS (4.177s)
[438.026839] Starting dynamic subtest: C-eDP1
[472.026913] Dynamic subtest C-eDP1: SUCCESS (4.188s)
[472.043373] Starting dynamic subtest: D-eDP1
[506.017403] Dynamic subtest D-eDP1: SUCCESS (4.152s)
[506.020250] Subtest flip-vs-suspend: SUCCESS (16.784s)
[512.245325] [068/133] (530s left) gem_gpgpu_fill (basic)
[512.298070] Starting subtest: basic
[512.299184] Starting dynamic subtest: smem
[512.309515] Dynamic subtest smem: SUCCESS (0.012s)
[512.310532] Subtest basic: SUCCESS (0.013s)
[512.443749] [069/133] (530s left) gem_exec_params (no-bsd)
[512.490728] Starting subtest: no-bsd
[512.493197] Subtest no-bsd: SUCCESS (0.002s)
[514.115950] [070/133] (528s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[514.213731] Starting subtest: psr-1p-primscrn-spr-indfb-move
[521.803683] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.588s)
[521.943742] [071/133] (521s left) gem_exec_schedule (semaphore-codependency)
[522.018420] Starting subtest: semaphore-codependency
[522.045481] Subtest semaphore-codependency: SUCCESS (0.027s)
[522.393620] [072/133] (520s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[522.480475] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[522.482255] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[522.567999] [073/133] (520s left) kms_flip (2x-flip-vs-fences)
[522.649737] Starting subtest: 2x-flip-vs-fences
[522.651413] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[522.749320] [074/133] (520s left) gem_ctx_persistence (legacy-engines-hostile)
[522.803043] Starting subtest: legacy-engines-hostile
[522.803952] Starting dynamic subtest: render
[522.841074] Dynamic subtest render: SUCCESS (0.039s)
[522.849751] Starting dynamic subtest: bsd1
[522.962935] Dynamic subtest bsd1: SUCCESS (0.121s)
[522.974350] Starting dynamic subtest: bsd2
[523.066388] Dynamic subtest bsd2: SUCCESS (0.100s)
[523.078015] Starting dynamic subtest: blt
[523.163003] Dynamic subtest blt: SUCCESS (0.094s)
[523.174134] Starting dynamic subtest: vebox
[523.262106] Dynamic subtest vebox: SUCCESS (0.096s)
[523.263310] Subtest legacy-engines-hostile: SUCCESS (0.461s)
[523.334670] [075/133] (519s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[523.381802] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[523.435059] [076/133] (519s left) perf (gen12-mi-rpc)
[523.567647] Starting subtest: gen12-mi-rpc
[523.568525] Starting dynamic subtest: rcs0
[523.587754] Dynamic subtest rcs0: SUCCESS (0.019s)
[523.588714] Subtest gen12-mi-rpc: SUCCESS (0.020s)
[523.629218] [077/133] (519s left) perf_pmu (init-sema)
[523.666066] Starting subtest: init-sema
[523.667055] Starting dynamic subtest: rcs0
[523.668007] Dynamic subtest rcs0: SUCCESS (0.001s)
[523.677499] Starting dynamic subtest: bcs0
[523.678810] Dynamic subtest bcs0: SUCCESS (0.000s)
[523.685924] Starting dynamic subtest: vcs0
[523.686723] Dynamic subtest vcs0: SUCCESS (0.001s)
[523.693802] Starting dynamic subtest: vcs1
[523.694652] Dynamic subtest vcs1: SUCCESS (0.000s)
[523.701544] Starting dynamic subtest: vecs0
[523.702459] Dynamic subtest vecs0: SUCCESS (0.000s)
[523.709456] Starting dynamic subtest: ccs0
[523.710356] Dynamic subtest ccs0: SUCCESS (0.000s)
[523.711231] Subtest init-sema: SUCCESS (0.009s)
[523.798966] [078/133] (519s left) syncobj_timeline (multi-wait-signaled)
[523.862433] Starting subtest: multi-wait-signaled
[523.863607] Subtest multi-wait-signaled: SUCCESS (0.001s)
[523.961557] [079/133] (519s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[524.050941] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[524.052547] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[524.142024] [080/133] (519s left) gem_softpin (overlap)
[524.189914] Starting subtest: overlap
[525.124125] Subtest overlap: SUCCESS (0.934s)
[525.244921] [081/133] (518s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[525.294372] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[525.401307] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.106s)
[525.483729] [082/133] (517s left) gem_exec_reloc (basic-gtt-noreloc)
[525.536400] Subtest basic-gtt-noreloc: SKIP (0.000s)
[525.600078] [083/133] (517s left) gem_wait (await)
[525.661457] Starting subtest: await
[525.662461] Starting dynamic subtest: all-engines
[526.841391] Dynamic subtest all-engines: SUCCESS (1.179s)
[526.859756] Starting dynamic subtest: rcs0
[527.900427] Dynamic subtest rcs0: SUCCESS (1.056s)
[527.919803] Starting dynamic subtest: bcs0
[528.959801] Dynamic subtest bcs0: SUCCESS (1.056s)
[528.979016] Starting dynamic subtest: vcs0
[530.014472] Dynamic subtest vcs0: SUCCESS (1.052s)
[530.032524] Starting dynamic subtest: vcs1
[531.071312] Dynamic subtest vcs1: SUCCESS (1.054s)
[531.087590] Starting dynamic subtest: vecs0
[532.124459] Dynamic subtest vecs0: SUCCESS (1.050s)
[532.141398] Starting dynamic subtest: ccs0
[533.181674] Dynamic subtest ccs0: SUCCESS (1.054s)
[533.185062] Subtest await: SUCCESS (7.519s)
[533.380531] [FACT gem_wait (await)] new: kernel.kmod_is_loaded.vgem: true
[533.382406] [084/133] (510s left) drm_mm (drm_mm)
[533.419898] Starting subtest: drm_mm
[533.423900] Starting dynamic subtest: drm_test_mm_init
[533.518736] Dynamic subtest drm_test_mm_init: SUCCESS (0.095s)
[533.526110] Starting dynamic subtest: drm_test_mm_debug
[533.610247] Dynamic subtest drm_test_mm_debug: SUCCESS (0.091s)
[533.618865] Starting dynamic subtest: drm_test_mm_align32
[533.709143] Dynamic subtest drm_test_mm_align32: SUCCESS (0.098s)
[533.717349] Starting dynamic subtest: drm_test_mm_align64
[533.793635] Dynamic subtest drm_test_mm_align64: SUCCESS (0.082s)
[533.801282] Starting dynamic subtest: drm_test_mm_lowest
[533.893122] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.099s)
[533.901407] Starting dynamic subtest: drm_test_mm_highest
[533.990007] Dynamic subtest drm_test_mm_highest: SUCCESS (0.095s)
[533.990955] Subtest drm_mm: SUCCESS (0.572s)
[534.135214] [085/133] (509s left) gem_ctx_param (basic)
[534.181011] Starting subtest: basic
[534.181986] Subtest basic: SUCCESS (0.001s)
[534.289459] [086/133] (509s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[534.391655] Starting subtest: plane-primary-overlay-mutable-zpos
[537.882963] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.484s)
[539.073703] [087/133] (504s left) i915_module_load (resize-bar)
[539.105089] Starting subtest: resize-bar
[539.112359] Subtest resize-bar: SKIP (0.006s)
[539.152294] [088/133] (504s left) gem_exec_suspend (basic-s3)
[539.203347] Starting subtest: basic-S3
[539.204378] Starting dynamic subtest: smem
[559.477543] Dynamic subtest smem: SUCCESS (6.766s)
[559.479321] Subtest basic-S3: SUCCESS (6.768s)
[564.679161] [089/133] (483s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[564.825388] Starting subtest: basic-flip-after-cursor-atomic
[565.758892] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.932s)
[566.610855] [090/133] (482s left) kms_lease (lease-revoke)
[566.701120] Starting subtest: lease-revoke
[566.702286] Starting dynamic subtest: pipe-A-eDP-1
[566.733171] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.032s)
[566.741628] Starting dynamic subtest: pipe-B-eDP-1
[566.763271] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.028s)
[566.771386] Starting dynamic subtest: pipe-C-eDP-1
[566.792288] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.029s)
[566.800514] Starting dynamic subtest: pipe-D-eDP-1
[566.823418] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.030s)
[566.824413] Subtest lease-revoke: SUCCESS (0.124s)
[566.943014] [091/133] (481s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[567.039317] Starting subtest: 4-tiled-64bpp-rotate-90
[567.059843] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s)
[567.167982] [092/133] (481s left) gem_exec_async (forked-writes)
[567.230411] Starting subtest: forked-writes
[567.231496] Starting dynamic subtest: rcs0
[567.258529] Dynamic subtest rcs0: SUCCESS (0.028s)
[567.268009] Starting dynamic subtest: bcs0
[567.282327] Dynamic subtest bcs0: SUCCESS (0.023s)
[567.292316] Starting dynamic subtest: vcs0
[567.306549] Dynamic subtest vcs0: SUCCESS (0.023s)
[567.315068] Starting dynamic subtest: vcs1
[567.334079] Dynamic subtest vcs1: SUCCESS (0.026s)
[567.342447] Starting dynamic subtest: vecs0
[567.355385] Dynamic subtest vecs0: SUCCESS (0.021s)
[567.364026] Starting dynamic subtest: ccs0
[567.380045] Dynamic subtest ccs0: SUCCESS (0.023s)
[567.381345] Subtest forked-writes: SUCCESS (0.149s)
[567.596818] [093/133] (481s left) kms_cursor_crc (cursor-random-32x10)
[567.747301] Starting subtest: cursor-random-32x10
[567.790280] Subtest cursor-random-32x10: SKIP (0.044s)
[568.031467] [094/133] (480s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[568.130132] Starting subtest: pr-cursor-plane-update-sf
[568.131956] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[568.212333] [095/133] (480s left) perf_pmu (all-busy-idle-check-all)
[568.252030] Starting subtest: all-busy-idle-check-all
[569.533684] Subtest all-busy-idle-check-all: SUCCESS (1.271s)
[569.616055] [096/133] (479s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[569.728311] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[569.730685] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[569.816453] [097/133] (479s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[569.903497] Starting subtest: fbcpsr-slowdraw
[595.180648] Subtest fbcpsr-slowdraw: SUCCESS (25.230s)
[595.299245] [098/133] (453s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[595.406405] Starting subtest: x-tiled-8bpp-rotate-180
[596.632305] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.226s)
[596.752598] [099/133] (452s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[597.324377] Starting subtest: syncobj-backward-timeline-chain-engines
[597.420467] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.106s)
[598.554197] [100/133] (450s left) gem_eio (in-flight-external)
[598.776305] Starting subtest: in-flight-external
[600.589329] Subtest in-flight-external: SUCCESS (1.812s)
[600.725209] [101/133] (448s left) kms_pm_rpm (pm-caching)
[602.661218] Starting subtest: pm-caching
[602.662967] Subtest pm-caching: SKIP (0.000s)
[603.044434] [102/133] (446s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[603.100014] Starting subtest: invalid-smem-bo-on-discrete
[603.102469] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[603.213126] [103/133] (445s left) gem_eio (in-flight-internal-immediate)
[603.456375] Starting subtest: in-flight-internal-immediate
[604.601301] Subtest in-flight-internal-immediate: SUCCESS (1.144s)
[604.709783] [104/133] (444s left) api_intel_bb (delta-check)
[604.763433] Starting subtest: delta-check
[604.768414] Subtest delta-check: SUCCESS (0.007s)
[604.849692] [105/133] (444s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[604.945438] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[604.946462] Starting dynamic subtest: pipe-A-eDP-1
[604.972472] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[604.982034] Starting dynamic subtest: pipe-B-eDP-1
[605.007422] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[605.016497] Starting dynamic subtest: pipe-C-eDP-1
[605.040127] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[605.048829] Starting dynamic subtest: pipe-D-eDP-1
[605.075122] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[605.077665] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.009s)
[607.199841] [106/133] (442s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[607.284555] Starting subtest: bad-pixel-format-yf-tiled-ccs
[607.286042] Starting dynamic subtest: pipe-A-eDP-1
[607.296367] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[607.306384] Starting dynamic subtest: pipe-B-eDP-1
[607.317427] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[607.326894] Starting dynamic subtest: pipe-C-eDP-1
[607.336025] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[607.344244] Starting dynamic subtest: pipe-D-eDP-1
[607.353924] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[607.355856] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.005s)
[609.558891] [107/133] (439s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[609.642194] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[609.643737] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[609.736590] [108/133] (439s left) gem_exec_fence (basic-wait-all)
[609.790656] Starting subtest: basic-wait-all
[609.866009] Subtest basic-wait-all: SUCCESS (0.075s)
[611.594961] [109/133] (437s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[611.690617] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[612.704188] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.015s)
[612.835274] [110/133] (436s left) syncobj_timeline (wait-all-snapshot)
[612.886548] Starting subtest: wait-all-snapshot
[612.970429] Subtest wait-all-snapshot: SUCCESS (0.083s)
[613.055036] [111/133] (436s left) kms_chamelium_color (ctm-negative)
[613.147957] Subtest ctm-negative: SKIP (0.000s)
[613.188650] [112/133] (436s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[613.299937] Starting subtest: cursorB-vs-flipA-legacy
[613.301951] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[613.442768] [113/133] (436s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[613.561909] Starting subtest: flip-vs-cursor-varying-size
[622.483953] Subtest flip-vs-cursor-varying-size: SUCCESS (8.923s)
[623.282132] [114/133] (426s left) kms_flip (flip-vs-panning)
[623.374016] Starting subtest: flip-vs-panning
[623.375326] Starting dynamic subtest: A-eDP1
[632.096162] Dynamic subtest A-eDP1: SUCCESS (8.719s)
[632.108057] Starting dynamic subtest: B-eDP1
[640.835642] Dynamic subtest B-eDP1: SUCCESS (8.736s)
[640.848386] Starting dynamic subtest: C-eDP1
[649.563091] Dynamic subtest C-eDP1: SUCCESS (8.722s)
[649.573937] Starting dynamic subtest: D-eDP1
[658.303319] Dynamic subtest D-eDP1: SUCCESS (8.735s)
[658.306214] Subtest flip-vs-panning: SUCCESS (34.924s)
[659.472044] [115/133] (390s left) gem_create (create-ext-cpu-access-sanity-check)
[659.643580] Starting subtest: create-ext-cpu-access-sanity-check
[659.646649] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[659.712608] [116/133] (389s left) prime_busy (hang)
[659.770959] Starting subtest: hang
[659.771900] Starting dynamic subtest: rcs0
[686.030769] Dynamic subtest rcs0: SUCCESS (26.255s)
[686.039908] Starting dynamic subtest: bcs0
[693.199215] Dynamic subtest bcs0: SUCCESS (7.169s)
[693.208048] Starting dynamic subtest: vcs0
[700.160438] Dynamic subtest vcs0: SUCCESS (6.962s)
[700.169322] Starting dynamic subtest: vcs1
[707.199623] Dynamic subtest vcs1: SUCCESS (7.039s)
[707.209555] Starting dynamic subtest: vecs0
[714.173644] Dynamic subtest vecs0: SUCCESS (6.972s)
[714.184953] Starting dynamic subtest: ccs0
[728.022886] Dynamic subtest ccs0: SUCCESS (13.843s)
[728.024353] Subtest hang: SUCCESS (68.248s)
[728.146091] [117/133] (321s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[728.240532] Starting subtest: plane-lut1d-pre-ctm3x4
[728.388049] Starting dynamic subtest: pipe-A-plane-0
[728.588167] Dynamic subtest pipe-A-plane-0: SUCCESS (0.200s)
[728.597527] Starting dynamic subtest: pipe-A-plane-1
[728.754353] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[728.763634] Starting dynamic subtest: pipe-A-plane-2
[728.920664] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[730.184063] Starting dynamic subtest: pipe-B-plane-0
[730.368523] Dynamic subtest pipe-B-plane-0: SUCCESS (0.199s)
[730.378627] Starting dynamic subtest: pipe-B-plane-1
[730.535159] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[730.544433] Starting dynamic subtest: pipe-B-plane-2
[730.690809] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[731.881022] Starting dynamic subtest: pipe-C-plane-0
[732.039213] Dynamic subtest pipe-C-plane-0: SUCCESS (0.166s)
[732.048143] Starting dynamic subtest: pipe-C-plane-1
[732.206173] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[732.217467] Starting dynamic subtest: pipe-C-plane-2
[732.372610] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[733.644073] Starting dynamic subtest: pipe-D-plane-0
[733.780213] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[733.789336] Starting dynamic subtest: pipe-D-plane-1
[733.935661] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[733.946225] Starting dynamic subtest: pipe-D-plane-2
[734.103275] Dynamic subtest pipe-D-plane-2: SUCCESS (0.167s)
[734.411637] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (6.170s)
[735.198569] [118/133] (314s left) kms_psr (pr-sprite-mmap-gtt)
[735.294273] Starting subtest: pr-sprite-mmap-gtt
[735.296593] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[735.374140] [119/133] (314s left) i915_query (hwconfig_table)
[735.422222] Starting subtest: hwconfig_table
[735.535929] Subtest hwconfig_table: SUCCESS (0.001s)
[735.570929] [120/133] (314s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[735.665819] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[735.667793] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[735.755364] [121/133] (313s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[736.130222] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[736.908298] [122/133] (312s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[737.014811] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[737.016682] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[737.098440] [123/133] (312s left) gem_workarounds (basic-read)
[737.183625] Starting subtest: basic-read
[737.202839] Subtest basic-read: SUCCESS (0.019s)
[737.311365] [124/133] (312s left) gen9_exec_parse (secure-batches)
[737.372931] Subtest secure-batches: SKIP (0.000s)
[737.449751] [125/133] (312s left) syncobj_wait (multi-wait-for-submit-submitted)
[737.503315] Starting subtest: multi-wait-for-submit-submitted
[737.608530] Subtest multi-wait-for-submit-submitted: SUCCESS (0.105s)
[737.685529] [126/133] (312s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[737.793964] Starting subtest: y-tiled-64bpp-rotate-270
[737.795584] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[737.891469] [127/133] (312s left) gem_mmap_gtt (flink-race)
[737.943320] Subtest flink-race: SKIP (0.000s)
[737.998503] [128/133] (311s left) syncobj_wait (wait-all-delayed-signal)
[738.052015] Starting subtest: wait-all-delayed-signal
[738.153978] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[738.230702] [129/133] (311s left) gem_exec_whisper (basic-fds-priority)
[738.293898] Starting subtest: basic-fds-priority
[764.749896] Subtest basic-fds-priority: SUCCESS (26.430s)
[764.919420] [130/133] (285s left) kms_plane (plane-position-hole-dpms)
[765.010371] Starting subtest: plane-position-hole-dpms
[765.555179] Starting dynamic subtest: pipe-A-plane-1
[767.947671] Dynamic subtest pipe-A-plane-1: SUCCESS (2.391s)
[767.957120] Starting dynamic subtest: pipe-A-plane-2
[770.338443] Dynamic subtest pipe-A-plane-2: SUCCESS (2.391s)
[770.347990] Starting dynamic subtest: pipe-A-plane-3
[772.785646] Dynamic subtest pipe-A-plane-3: SUCCESS (2.446s)
[772.798671] Starting dynamic subtest: pipe-A-plane-4
[775.169074] Dynamic subtest pipe-A-plane-4: SUCCESS (2.380s)
[775.178187] Starting dynamic subtest: pipe-A-plane-5
[775.194497] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[776.353920] Starting dynamic subtest: pipe-B-plane-1
[778.776540] Dynamic subtest pipe-B-plane-1: SUCCESS (2.433s)
[778.785628] Starting dynamic subtest: pipe-B-plane-2
[781.203071] Dynamic subtest pipe-B-plane-2: SUCCESS (2.425s)
[781.212356] Starting dynamic subtest: pipe-B-plane-3
[783.583540] Dynamic subtest pipe-B-plane-3: SUCCESS (2.379s)
[783.593317] Starting dynamic subtest: pipe-B-plane-4
[785.960297] Dynamic subtest pipe-B-plane-4: SUCCESS (2.375s)
[785.969942] Starting dynamic subtest: pipe-B-plane-5
[785.986283] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[785.987459] Subtest plane-position-hole-dpms: SUCCESS (20.971s)
[786.752433] [131/133] (263s left) i915_pm_rpm (gem-mmap-type)
[788.710461] Starting subtest: gem-mmap-type
[788.712027] Starting dynamic subtest: wb-smem0
[791.887139] Dynamic subtest wb-smem0: SUCCESS (3.175s)
[791.897924] Starting dynamic subtest: wc-smem0
[795.074284] Dynamic subtest wc-smem0: SUCCESS (3.183s)
[795.083355] Starting dynamic subtest: uc-smem0
[797.953061] Dynamic subtest uc-smem0: SUCCESS (2.877s)
[797.954229] Subtest gem-mmap-type: SUCCESS (9.241s)
[798.048804] [132/133] (252s left) kms_vblank (ts-continuation-idle-hang)
[798.141658] Starting subtest: ts-continuation-idle-hang
[798.143057] Starting dynamic subtest: pipe-A-eDP-1
[824.300351] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.162s)
[824.312329] Starting dynamic subtest: pipe-D-eDP-1
[839.285438] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.986s)
[839.286812] Subtest ts-continuation-idle-hang: SUCCESS (41.152s)
[840.143129] [133/133] (210s left) syncobj_wait (invalid-reset-bad-pad)
[840.206347] Starting subtest: invalid-reset-bad-pad
[840.208112] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[840.295228] Closing watchdogs
results: parsing output: 0/ for test: gem_workarounds
results: parsing output: 1/ for test: api_intel_bb
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: kms_display_modes
results: parsing output: 4/ for test: kms_plane_alpha_blend
results: parsing output: 5/ for test: kms_psr2_sf
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: i915_drm_fdinfo
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_addfb_basic
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_softpin
results: parsing output: 13/ for test: gem_exec_params
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_exec_balancer
results: parsing output: 16/ for test: gem_exec_reloc
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_flip_scaled_crc
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_media_vme
results: parsing output: 24/ for test: kms_invalid_mode
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: kms_plane_scaling
results: parsing output: 27/ for test: gem_exec_schedule
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: gem_exec_balancer
results: parsing output: 30/ for test: kms_chamelium_edid
results: parsing output: 31/ for test: kms_content_protection
results: parsing output: 32/ for test: kms_psr2_sf
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_plane
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: gem_tiled_fence_blits
results: parsing output: 37/ for test: kms_ccs
results: parsing output: 38/ for test: kms_cursor_crc
results: parsing output: 39/ for test: core_auth
results: parsing output: 40/ for test: kms_getfb
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: gem_userptr_blits
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: gem_exec_gttfill
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: kms_cursor_edge_walk
results: parsing output: 47/ for test: gem_mmap_wc
results: parsing output: 48/ for test: gem_ctx_isolation
results: parsing output: 49/ for test: kms_pm_rpm
results: parsing output: 50/ for test: gem_pxp
results: parsing output: 51/ for test: gem_mmap_gtt
results: parsing output: 52/ for test: gem_mmap_gtt
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: fbdev
results: parsing output: 55/ for test: kms_plane_cursor
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_render_copy
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_universal_plane
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: gem_mmap_gtt
results: parsing output: 62/ for test: gem_render_copy
results: parsing output: 63/ for test: kms_dsc
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: gem_gpgpu_fill
results: parsing output: 68/ for test: gem_exec_params
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_exec_schedule
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_flip
results: parsing output: 73/ for test: gem_ctx_persistence
results: parsing output: 74/ for test: kms_pipe_b_c_ivb
results: parsing output: 75/ for test: perf
results: parsing output: 76/ for test: perf_pmu
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_softpin
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: gem_exec_reloc
results: parsing output: 82/ for test: gem_wait
results: parsing output: 83/ for test: drm_mm
results: parsing output: 84/ for test: gem_ctx_param
results: parsing output: 85/ for test: kms_atomic
results: parsing output: 86/ for test: i915_module_load
results: parsing output: 87/ for test: gem_exec_suspend
results: parsing output: 88/ for test: kms_cursor_legacy
results: parsing output: 89/ for test: kms_lease
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: gem_exec_async
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: kms_psr2_sf
results: parsing output: 94/ for test: perf_pmu
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: gem_exec_fence
results: parsing output: 99/ for test: gem_eio
results: parsing output: 100/ for test: kms_pm_rpm
results: parsing output: 101/ for test: kms_addfb_basic
results: parsing output: 102/ for test: gem_eio
results: parsing output: 103/ for test: api_intel_bb
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: kms_ccs
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_exec_fence
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: kms_chamelium_color
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: kms_cursor_legacy
results: parsing output: 113/ for test: kms_flip
results: parsing output: 114/ for test: gem_create
results: parsing output: 115/ for test: prime_busy
results: parsing output: 116/ for test: kms_color_pipeline
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: i915_query
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_chamelium_hpd
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_workarounds
results: parsing output: 123/ for test: gen9_exec_parse
results: parsing output: 124/ for test: syncobj_wait
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: gem_mmap_gtt
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: gem_exec_whisper
results: parsing output: 129/ for test: kms_plane
results: parsing output: 130/ for test: i915_pm_rpm
results: parsing output: 131/ for test: kms_vblank
results: parsing output: 132/ for test: syncobj_wait
Done.