[61.759198] Initializing watchdogs
[61.759245]   /dev/watchdog0
[61.773975] [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]
[61.778767] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.781494] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.783253] [001/133] (960s left) gem_workarounds (suspend-resume-context)
[61.857092] Starting subtest: suspend-resume-context
[77.862178] Subtest suspend-resume-context: SUCCESS (1.696s)
[85.039346] [002/133] (944s left) api_intel_bb (crc32)
[85.096531] Starting subtest: crc32
[85.097482] Starting dynamic subtest: rcs0-smem0
[85.461739] Dynamic subtest rcs0-smem0: SUCCESS (0.350s)
[85.471334] Starting dynamic subtest: bcs0-smem0
[85.835065] Dynamic subtest bcs0-smem0: SUCCESS (0.366s)
[85.844948] Starting dynamic subtest: vcs0-smem0
[86.225087] Dynamic subtest vcs0-smem0: SUCCESS (0.383s)
[86.233748] Starting dynamic subtest: vcs1-smem0
[86.634868] Dynamic subtest vcs1-smem0: SUCCESS (0.402s)
[86.643928] Starting dynamic subtest: vecs0-smem0
[86.982299] Dynamic subtest vecs0-smem0: SUCCESS (0.342s)
[86.991496] Starting dynamic subtest: ccs0-smem0
[87.349133] Dynamic subtest ccs0-smem0: SUCCESS (0.361s)
[87.350385] Subtest crc32: SUCCESS (2.211s)
[87.447413] [003/133] (941s left) kms_psr (psr-sprite-plane-move)
[87.540242] Starting subtest: psr-sprite-plane-move
[87.541197] Starting dynamic subtest: eDP-1
[89.316066] Dynamic subtest eDP-1: SUCCESS (1.753s)
[89.317287] Subtest psr-sprite-plane-move: SUCCESS (1.754s)
[90.155835] [004/133] (939s left) kms_display_modes (extended-mode-basic)
[90.242499] Starting subtest: extended-mode-basic
[90.244273] Subtest extended-mode-basic: SKIP (0.000s)
[90.280384] [005/133] (939s left) kms_plane_alpha_blend (constant-alpha-mid)
[90.358141] Starting subtest: constant-alpha-mid
[90.650175] Starting dynamic subtest: pipe-A-eDP-1
[91.579905] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.921s)
[91.586827] Starting dynamic subtest: pipe-D-eDP-1
[93.104743] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.513s)
[93.105931] Subtest constant-alpha-mid: SUCCESS (2.726s)
[93.931205] [006/133] (935s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[94.019750] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[94.020742] Starting dynamic subtest: pipe-A-eDP-1
[105.359686] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.305s)
[105.366407] Starting dynamic subtest: pipe-B-eDP-1
[117.386604] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.018s)
[117.387472] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.326s)
[118.239047] [007/133] (911s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[118.341398] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[118.343125] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[118.426591] [008/133] (911s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[118.512490] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[118.514992] Starting dynamic subtest: A-eDP1
[122.162294] Dynamic subtest A-eDP1: SUCCESS (3.647s)
[122.169933] Starting dynamic subtest: B-eDP1
[125.369486] Dynamic subtest B-eDP1: SUCCESS (3.205s)
[125.376285] Starting dynamic subtest: C-eDP1
[128.471285] Dynamic subtest C-eDP1: SUCCESS (3.101s)
[128.478032] Starting dynamic subtest: D-eDP1
[131.588160] Dynamic subtest D-eDP1: SUCCESS (3.115s)
[131.590086] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.075s)
[132.372952] [009/133] (897s left) i915_drm_fdinfo (busy-hang)
[132.409777] Starting subtest: busy-hang
[132.410723] Starting dynamic subtest: rcs0
[132.430441] Dynamic subtest rcs0: SKIP (0.020s)
[132.439119] Starting dynamic subtest: bcs0
[132.441019] Dynamic subtest bcs0: SKIP (0.001s)
[132.447152] Starting dynamic subtest: vcs0
[132.448857] Dynamic subtest vcs0: SKIP (0.001s)
[132.455074] Starting dynamic subtest: vcs1
[132.456858] Dynamic subtest vcs1: SKIP (0.001s)
[132.462940] Starting dynamic subtest: vecs0
[132.464737] Dynamic subtest vecs0: SKIP (0.000s)
[132.472457] Starting dynamic subtest: ccs0
[132.474061] Dynamic subtest ccs0: SKIP (0.001s)
[132.475515] Subtest busy-hang: SKIP (0.027s)
[132.502445] [010/133] (897s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[132.583712] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[132.585388] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[132.676397] [011/133] (896s left) kms_addfb_basic (unused-modifier)
[132.727480] Starting subtest: unused-modifier
[132.728419] Subtest unused-modifier: SUCCESS (0.000s)
[132.847333] [012/133] (896s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[132.939667] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[132.941125] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[133.027345] [013/133] (896s left) gem_softpin (allocator-fork)
[133.075733] Starting subtest: allocator-fork
[135.307058] Subtest allocator-fork: SUCCESS (2.220s)
[135.403564] [014/133] (894s left) gem_exec_params (invalid-ring)
[135.458767] Starting subtest: invalid-ring
[135.459705] Subtest invalid-ring: SUCCESS (0.000s)
[135.548042] [015/133] (894s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[135.633974] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[142.223100] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.588s)
[142.352899] [016/133] (887s left) gem_exec_balancer (persistence)
[142.629184] Starting subtest: persistence
[143.577899] Subtest persistence: SUCCESS (0.947s)
[143.669430] [017/133] (886s left) gem_exec_reloc (basic-cpu-wc-active)
[143.731685] Subtest basic-cpu-wc-active: SKIP (0.000s)
[143.802691] [018/133] (886s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[143.897560] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[143.899016] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[143.992632] [019/133] (885s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[144.072294] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[144.074305] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[144.136034] [020/133] (885s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[144.223427] Starting subtest: yf-tiled-8bpp-rotate-90
[144.225216] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[144.310613] [021/133] (885s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[144.354153] Starting subtest: multi-wait-all-for-submit-available-submitted
[144.355037] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s)
[144.438604] [022/133] (885s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[144.540965] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[144.542754] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[144.628974] [023/133] (885s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[144.720606] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[144.722342] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[144.806234] [024/133] (885s left) gem_media_vme
[144.915212] [025/133] (885s left) kms_invalid_mode (clock-too-high)
[144.999990] Starting subtest: clock-too-high
[145.000809] Starting dynamic subtest: pipe-A-eDP-1
[145.002506] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[145.009330] Starting dynamic subtest: pipe-B-eDP-1
[145.011065] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[145.017301] Starting dynamic subtest: pipe-C-eDP-1
[145.018794] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[145.024910] Starting dynamic subtest: pipe-D-eDP-1
[145.026478] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[145.027990] Subtest clock-too-high: SKIP (0.007s)
[145.071925] [026/133] (885s left) kms_psr (fbc-psr2-primary-blt)
[145.169424] Starting subtest: fbc-psr2-primary-blt
[145.170507] Starting dynamic subtest: eDP-1
[145.172212] Dynamic subtest eDP-1: SKIP (0.000s)
[145.173973] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[145.237605] [027/133] (884s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[145.333527] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[145.334342] Starting dynamic subtest: pipe-A
[145.354557] Dynamic subtest pipe-A: SKIP (0.019s)
[145.361996] Starting dynamic subtest: pipe-B
[145.387959] Dynamic subtest pipe-B: SKIP (0.033s)
[145.394353] Starting dynamic subtest: pipe-C
[145.422054] Dynamic subtest pipe-C: SKIP (0.034s)
[145.428404] Starting dynamic subtest: pipe-D
[145.463174] Dynamic subtest pipe-D: SKIP (0.033s)
[145.464854] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.121s)
[145.569919] [028/133] (884s left) gem_exec_schedule (out-order)
[145.640875] Starting subtest: out-order
[145.642059] Starting dynamic subtest: rcs0
[145.742739] Dynamic subtest rcs0: SUCCESS (0.101s)
[145.752767] Starting dynamic subtest: vcs0
[145.826937] Dynamic subtest vcs0: SUCCESS (0.084s)
[145.835696] Starting dynamic subtest: vcs1
[145.903938] Dynamic subtest vcs1: SUCCESS (0.076s)
[145.913643] Starting dynamic subtest: vecs0
[145.983023] Dynamic subtest vecs0: SUCCESS (0.079s)
[145.992329] Starting dynamic subtest: ccs0
[146.072090] Dynamic subtest ccs0: SUCCESS (0.088s)
[146.073558] Subtest out-order: SUCCESS (0.431s)
[147.294593] [029/133] (882s left) kms_psr (psr2-no-drrs)
[147.389821] Starting subtest: psr2-no-drrs
[147.390735] Starting dynamic subtest: eDP-1
[148.988122] Dynamic subtest eDP-1: SUCCESS (1.597s)
[148.989483] Subtest psr2-no-drrs: SUCCESS (1.598s)
[149.778680] [030/133] (880s left) gem_exec_balancer (bonded-chain)
[149.834539] Starting subtest: bonded-chain
[156.890100] Subtest bonded-chain: SUCCESS (7.044s)
[157.185355] [031/133] (873s left) kms_chamelium_edid (hdmi-edid-read)
[157.566658] Subtest hdmi-edid-read: SKIP (0.000s)
[158.384721] [032/133] (871s left) kms_content_protection (dp-mst-lic-type-1)
[158.512108] Starting subtest: dp-mst-lic-type-1
[158.514094] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[158.634124] [033/133] (871s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[158.737167] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[158.739103] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[158.811379] [034/133] (871s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[158.907229] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[162.477333] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.568s)
[163.631146] [035/133] (866s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[163.733461] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[163.760487] Starting dynamic subtest: pipe-A-plane-0
[164.194069] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[164.202520] Starting dynamic subtest: pipe-A-plane-3
[164.449441] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[165.597408] Starting dynamic subtest: pipe-B-plane-0
[166.023756] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[166.032873] Starting dynamic subtest: pipe-B-plane-3
[166.279626] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[166.588801] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.854s)
[167.468539] [036/133] (862s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[167.557955] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[167.559754] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[167.639319] [037/133] (862s left) gem_tiled_fence_blits (normal)
[167.694135] Subtest normal: SKIP (0.000s)
[167.747777] [038/133] (862s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[167.834276] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[167.835131] Starting dynamic subtest: pipe-A-eDP-1
[167.851492] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[167.864130] Starting dynamic subtest: pipe-B-eDP-1
[167.873087] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[167.879621] Starting dynamic subtest: pipe-C-eDP-1
[167.887409] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[167.893851] Starting dynamic subtest: pipe-D-eDP-1
[167.902021] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[167.903633] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[170.130835] [039/133] (860s left) kms_cursor_crc (cursor-alpha-transparent)
[170.222288] Starting subtest: cursor-alpha-transparent
[170.223193] Starting dynamic subtest: pipe-A-eDP-1
[171.584846] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.350s)
[171.593751] Starting dynamic subtest: pipe-D-eDP-1
[172.381028] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.804s)
[172.381943] Subtest cursor-alpha-transparent: SUCCESS (2.159s)
[173.258828] [040/133] (857s left) core_auth (basic-auth)
[173.308605] Starting subtest: basic-auth
[173.309807] Subtest basic-auth: SUCCESS (0.001s)
[173.436464] [041/133] (857s left) kms_getfb (getfb-reject-nv12)
[173.535118] Starting subtest: getfb-reject-nv12
[173.536286] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[173.637827] [042/133] (856s left) kms_psr (fbc-psr-cursor-plane-move)
[173.722486] Starting subtest: fbc-psr-cursor-plane-move
[173.723310] Starting dynamic subtest: eDP-1
[173.724978] Dynamic subtest eDP-1: SKIP (0.000s)
[173.726731] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[173.786604] [043/133] (856s left) gem_userptr_blits (sync-overlap)
[173.846089] Starting subtest: sync-overlap
[173.847137] Subtest sync-overlap: SUCCESS (0.000s)
[173.971017] [044/133] (856s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[174.066420] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[174.892119] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.826s)
[175.060098] [045/133] (855s left) gem_exec_gttfill (multigpu-basic)
[175.245106] Starting subtest: multigpu-basic
[188.335027] Subtest multigpu-basic: SUCCESS (13.096s)
[188.374101] [046/133] (842s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[188.514477] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[188.515397] Starting dynamic subtest: pipe-A-eDP-1
[188.519124] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[188.527042] Starting dynamic subtest: pipe-B-eDP-1
[188.530741] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[188.538069] Starting dynamic subtest: pipe-C-eDP-1
[188.541950] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[188.549238] Starting dynamic subtest: pipe-D-eDP-1
[188.552820] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[188.554460] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[190.824126] [047/133] (839s left) kms_cursor_edge_walk (256x256-top-edge)
[190.918344] Starting subtest: 256x256-top-edge
[190.919160] Starting dynamic subtest: pipe-A-eDP-1
[194.394154] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.474s)
[194.401190] Starting dynamic subtest: pipe-D-eDP-1
[197.522356] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.128s)
[197.523337] Subtest 256x256-top-edge: SUCCESS (6.605s)
[198.337420] [048/133] (832s left) gem_mmap_wc (write-cpu-read-wc)
[198.392655] Subtest write-cpu-read-wc: SKIP (0.000s)
[198.445007] [049/133] (832s left) gem_ctx_isolation (preservation-s3)
[198.509473] Starting subtest: preservation-S3
[198.510435] Starting dynamic subtest: rcs0
[214.900279] Dynamic subtest rcs0: SUCCESS (1.725s)
[214.909148] Starting dynamic subtest: bcs0
[231.917961] Dynamic subtest bcs0: SUCCESS (1.731s)
[231.927152] Starting dynamic subtest: vcs0
[248.898119] Dynamic subtest vcs0: SUCCESS (2.703s)
[248.907465] Starting dynamic subtest: vcs1
[266.892746] Dynamic subtest vcs1: SUCCESS (5.048s)
[266.900300] Starting dynamic subtest: vecs0
[284.899181] Dynamic subtest vecs0: SUCCESS (4.993s)
[284.907615] Starting dynamic subtest: ccs0
[302.895556] Dynamic subtest ccs0: SUCCESS (3.229s)
[302.897017] Subtest preservation-S3: SUCCESS (19.435s)
[309.170358] [050/133] (727s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[311.316669] Starting subtest: dpms-mode-unset-non-lpsp
[312.481615] Subtest dpms-mode-unset-non-lpsp: SKIP (1.149s)
[312.863650] [051/133] (724s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[312.979241] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[313.124937] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.146s)
[313.224934] [052/133] (723s left) gem_mmap_gtt (basic-short)
[313.273148] Subtest basic-short: SKIP (0.000s)
[313.331295] [053/133] (723s left) gem_mmap_gtt (basic-write-gtt)
[313.379878] Subtest basic-write-gtt: SKIP (0.000s)
[313.432826] [054/133] (723s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[313.493027] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[313.600341] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[313.672180] [055/133] (723s left) fbdev (eof)
[313.706368] Starting subtest: eof
[313.707197] Subtest eof: SUCCESS (0.000s)
[313.769054] [056/133] (723s left) kms_plane_cursor (primary)
[313.851510] Starting subtest: primary
[313.853334] Starting dynamic subtest: pipe-A-eDP-1-size-64
[316.438714] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.564s)
[316.463377] Starting dynamic subtest: pipe-A-eDP-1-size-128
[319.089898] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.616s)
[319.114512] Starting dynamic subtest: pipe-A-eDP-1-size-256
[321.692058] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.572s)
[322.008298] Starting dynamic subtest: pipe-B-eDP-1-size-64
[325.368745] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.356s)
[325.394035] Starting dynamic subtest: pipe-B-eDP-1-size-128
[327.976012] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.583s)
[328.001160] Starting dynamic subtest: pipe-B-eDP-1-size-256
[330.537204] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.538s)
[330.858527] Starting dynamic subtest: pipe-C-eDP-1-size-64
[333.812169] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.958s)
[333.838655] Starting dynamic subtest: pipe-C-eDP-1-size-128
[336.059128] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.225s)
[336.085613] Starting dynamic subtest: pipe-C-eDP-1-size-256
[338.305866] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.225s)
[338.619622] Starting dynamic subtest: pipe-D-eDP-1-size-64
[341.562433] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.948s)
[341.588813] Starting dynamic subtest: pipe-D-eDP-1-size-128
[343.783983] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.202s)
[343.811141] Starting dynamic subtest: pipe-D-eDP-1-size-256
[345.983732] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.180s)
[346.291292] Subtest primary: SUCCESS (32.354s)
[347.086863] [057/133] (690s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[347.180978] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[356.031366] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.851s)
[356.136558] [058/133] (681s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[356.197031] Starting subtest: yf-tiled-to-vebox-y-tiled
[356.198780] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[356.386138] [059/133] (680s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[356.482520] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[356.484292] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[356.577032] [060/133] (680s left) kms_universal_plane (universal-plane-pageflip-windowed)
[356.666367] Starting subtest: universal-plane-pageflip-windowed
[356.667346] Starting dynamic subtest: pipe-A-eDP-1
[357.266893] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.602s)
[357.274273] Starting dynamic subtest: pipe-B-eDP-1
[358.511004] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.243s)
[358.518335] Starting dynamic subtest: pipe-C-eDP-1
[359.709590] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.197s)
[359.718820] Starting dynamic subtest: pipe-D-eDP-1
[360.946096] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.234s)
[360.946924] Subtest universal-plane-pageflip-windowed: SUCCESS (4.282s)
[361.810801] [061/133] (675s left) syncobj_timeline (wait-for-submit-complex)
[361.851599] Starting subtest: wait-for-submit-complex
[361.913496] Subtest wait-for-submit-complex: SUCCESS (0.061s)
[361.984211] [062/133] (675s left) gem_mmap_gtt (big-copy-xy)
[362.032146] Subtest big-copy-XY: SKIP (0.000s)
[362.088302] [063/133] (675s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[362.139463] Starting subtest: yf-tiled-ccs-to-x-tiled
[362.141337] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[362.318162] [064/133] (675s left) kms_dsc (dsc-basic)
[362.418083] Starting subtest: dsc-basic
[362.431365] Subtest dsc-basic: SKIP (0.000s)
[362.482870] [065/133] (674s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[362.583892] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[362.594372] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.011s)
[362.662478] [066/133] (674s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[362.750505] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[369.527823] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.776s)
[369.635031] [067/133] (667s left) kms_flip (flip-vs-suspend)
[369.721804] Starting subtest: flip-vs-suspend
[369.724091] Starting dynamic subtest: A-eDP1
[403.862613] Dynamic subtest A-eDP1: SUCCESS (4.346s)
[403.878626] Starting dynamic subtest: B-eDP1
[437.862781] Dynamic subtest B-eDP1: SUCCESS (4.156s)
[437.876752] Starting dynamic subtest: C-eDP1
[471.877906] Dynamic subtest C-eDP1: SUCCESS (4.166s)
[471.892601] Starting dynamic subtest: D-eDP1
[505.857919] Dynamic subtest D-eDP1: SUCCESS (4.175s)
[505.860849] Subtest flip-vs-suspend: SUCCESS (16.856s)
[513.088169] [068/133] (530s left) gem_gpgpu_fill (basic)
[513.156627] Starting subtest: basic
[513.157586] Starting dynamic subtest: smem
[513.175512] Dynamic subtest smem: SUCCESS (0.019s)
[513.176531] Subtest basic: SUCCESS (0.020s)
[513.301342] [069/133] (530s left) gem_exec_params (no-bsd)
[513.351686] Starting subtest: no-bsd
[513.356610] Subtest no-bsd: SUCCESS (0.005s)
[514.491005] [070/133] (529s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[514.578010] Starting subtest: psr-1p-primscrn-spr-indfb-move
[522.272358] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.614s)
[522.402977] [071/133] (521s left) gem_exec_schedule (semaphore-codependency)
[522.477360] Starting subtest: semaphore-codependency
[522.487948] Subtest semaphore-codependency: SUCCESS (0.012s)
[522.812475] [072/133] (520s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[522.907215] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[522.909208] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[523.015987] [073/133] (520s left) kms_flip (2x-flip-vs-fences)
[523.102584] Starting subtest: 2x-flip-vs-fences
[523.104239] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[523.205724] [074/133] (520s left) gem_ctx_persistence (legacy-engines-hostile)
[523.261146] Starting subtest: legacy-engines-hostile
[523.262547] Starting dynamic subtest: render
[523.302298] Dynamic subtest render: SUCCESS (0.041s)
[523.310843] Starting dynamic subtest: bsd1
[523.420005] Dynamic subtest bsd1: SUCCESS (0.115s)
[523.431882] Starting dynamic subtest: bsd2
[523.518043] Dynamic subtest bsd2: SUCCESS (0.095s)
[523.530117] Starting dynamic subtest: blt
[523.611021] Dynamic subtest blt: SUCCESS (0.090s)
[523.622332] Starting dynamic subtest: vebox
[523.708056] Dynamic subtest vebox: SUCCESS (0.094s)
[523.709688] Subtest legacy-engines-hostile: SUCCESS (0.445s)
[523.779897] [075/133] (519s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[523.837482] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[523.897211] [076/133] (519s left) perf (gen12-mi-rpc)
[524.021398] Starting subtest: gen12-mi-rpc
[524.022322] Starting dynamic subtest: rcs0
[524.042115] Dynamic subtest rcs0: SUCCESS (0.019s)
[524.043119] Subtest gen12-mi-rpc: SUCCESS (0.020s)
[524.085820] [077/133] (519s left) perf_pmu (init-sema)
[524.126809] Starting subtest: init-sema
[524.127869] Starting dynamic subtest: rcs0
[524.128797] Dynamic subtest rcs0: SUCCESS (0.002s)
[524.139228] Starting dynamic subtest: bcs0
[524.140304] Dynamic subtest bcs0: SUCCESS (0.000s)
[524.147369] Starting dynamic subtest: vcs0
[524.148204] Dynamic subtest vcs0: SUCCESS (0.000s)
[524.155359] Starting dynamic subtest: vcs1
[524.156208] Dynamic subtest vcs1: SUCCESS (0.000s)
[524.163171] Starting dynamic subtest: vecs0
[524.164052] Dynamic subtest vecs0: SUCCESS (0.000s)
[524.170810] Starting dynamic subtest: ccs0
[524.171629] Dynamic subtest ccs0: SUCCESS (0.000s)
[524.172429] Subtest init-sema: SUCCESS (0.007s)
[524.236740] [078/133] (519s left) syncobj_timeline (multi-wait-signaled)
[524.283840] Starting subtest: multi-wait-signaled
[524.284782] Subtest multi-wait-signaled: SUCCESS (0.001s)
[524.377165] [079/133] (519s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[524.464149] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[524.465866] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[524.552572] [080/133] (519s left) gem_softpin (overlap)
[524.602304] Starting subtest: overlap
[525.525919] Subtest overlap: SUCCESS (0.920s)
[525.665333] [081/133] (518s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[525.715548] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[525.834637] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.105s)
[525.893846] [082/133] (518s left) gem_exec_reloc (basic-gtt-noreloc)
[525.952645] Subtest basic-gtt-noreloc: SKIP (0.000s)
[526.030141] [083/133] (518s left) gem_wait (await)
[526.087210] Starting subtest: await
[526.088351] Starting dynamic subtest: all-engines
[527.231654] Dynamic subtest all-engines: SUCCESS (1.140s)
[527.248226] Starting dynamic subtest: rcs0
[528.288515] Dynamic subtest rcs0: SUCCESS (1.051s)
[528.317171] Starting dynamic subtest: bcs0
[529.348286] Dynamic subtest bcs0: SUCCESS (1.055s)
[529.365065] Starting dynamic subtest: vcs0
[530.402314] Dynamic subtest vcs0: SUCCESS (1.049s)
[530.418195] Starting dynamic subtest: vcs1
[531.456721] Dynamic subtest vcs1: SUCCESS (1.050s)
[531.472878] Starting dynamic subtest: vecs0
[532.511311] Dynamic subtest vecs0: SUCCESS (1.050s)
[532.528507] Starting dynamic subtest: ccs0
[533.568994] Dynamic subtest ccs0: SUCCESS (1.053s)
[533.572123] Subtest await: SUCCESS (7.463s)
[533.762589] [FACT gem_wait (await)] new: kernel.kmod_is_loaded.vgem: true
[533.764950] [084/133] (510s left) drm_mm (drm_mm)
[533.802666] Starting subtest: drm_mm
[533.807964] Starting dynamic subtest: drm_test_mm_init
[533.893776] Dynamic subtest drm_test_mm_init: SUCCESS (0.085s)
[533.907283] Starting dynamic subtest: drm_test_mm_debug
[533.972901] Dynamic subtest drm_test_mm_debug: SUCCESS (0.077s)
[533.982312] Starting dynamic subtest: drm_test_mm_align32
[534.062681] Dynamic subtest drm_test_mm_align32: SUCCESS (0.090s)
[534.071685] Starting dynamic subtest: drm_test_mm_align64
[534.164447] Dynamic subtest drm_test_mm_align64: SUCCESS (0.094s)
[534.177844] Starting dynamic subtest: drm_test_mm_lowest
[534.259611] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.101s)
[534.268662] Starting dynamic subtest: drm_test_mm_highest
[534.342744] Dynamic subtest drm_test_mm_highest: SUCCESS (0.082s)
[534.343741] Subtest drm_mm: SUCCESS (0.538s)
[534.478721] [085/133] (509s left) gem_ctx_param (basic)
[534.543588] Starting subtest: basic
[534.544592] Subtest basic: SUCCESS (0.001s)
[534.647039] [086/133] (509s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[534.745600] Starting subtest: plane-primary-overlay-mutable-zpos
[538.183783] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.432s)
[539.373820] [087/133] (504s left) i915_module_load (resize-bar)
[539.406984] Starting subtest: resize-bar
[539.412346] Subtest resize-bar: SKIP (0.006s)
[539.446936] [088/133] (504s left) gem_exec_suspend (basic-s3)
[539.501984] Starting subtest: basic-S3
[539.502836] Starting dynamic subtest: smem
[560.421678] Dynamic subtest smem: SUCCESS (6.922s)
[560.423290] Subtest basic-S3: SUCCESS (6.924s)
[566.629115] [089/133] (483s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[566.747627] Starting subtest: basic-flip-after-cursor-atomic
[567.676797] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.915s)
[568.488470] [090/133] (481s left) kms_lease (lease-revoke)
[568.575977] Starting subtest: lease-revoke
[568.576880] Starting dynamic subtest: pipe-A-eDP-1
[568.608621] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.032s)
[568.616635] Starting dynamic subtest: pipe-B-eDP-1
[568.639557] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.030s)
[568.652678] Starting dynamic subtest: pipe-C-eDP-1
[568.675527] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.033s)
[568.685236] Starting dynamic subtest: pipe-D-eDP-1
[568.704906] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.027s)
[568.705810] Subtest lease-revoke: SUCCESS (0.128s)
[568.826252] [091/133] (481s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[568.940489] Starting subtest: 4-tiled-64bpp-rotate-90
[568.961200] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.020s)
[569.076314] [092/133] (481s left) gem_exec_async (forked-writes)
[569.129887] Starting subtest: forked-writes
[569.130911] Starting dynamic subtest: rcs0
[569.159316] Dynamic subtest rcs0: SUCCESS (0.029s)
[569.167221] Starting dynamic subtest: bcs0
[569.182939] Dynamic subtest bcs0: SUCCESS (0.022s)
[569.190924] Starting dynamic subtest: vcs0
[569.204531] Dynamic subtest vcs0: SUCCESS (0.020s)
[569.214150] Starting dynamic subtest: vcs1
[569.229716] Dynamic subtest vcs1: SUCCESS (0.023s)
[569.237775] Starting dynamic subtest: vecs0
[569.253571] Dynamic subtest vecs0: SUCCESS (0.022s)
[569.263174] Starting dynamic subtest: ccs0
[569.277206] Dynamic subtest ccs0: SUCCESS (0.022s)
[569.278276] Subtest forked-writes: SUCCESS (0.146s)
[569.493375] [093/133] (480s left) kms_cursor_crc (cursor-random-32x10)
[569.646449] Starting subtest: cursor-random-32x10
[569.691616] Subtest cursor-random-32x10: SKIP (0.043s)
[569.935470] [094/133] (480s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[570.025040] Starting subtest: pr-cursor-plane-update-sf
[570.026832] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[570.109675] [095/133] (480s left) perf_pmu (all-busy-idle-check-all)
[570.147686] Starting subtest: all-busy-idle-check-all
[571.431576] Subtest all-busy-idle-check-all: SUCCESS (1.258s)
[571.514229] [096/133] (479s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[571.604381] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[571.606258] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[571.707795] [097/133] (478s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[571.805867] Starting subtest: fbcpsr-slowdraw
[597.216924] Subtest fbcpsr-slowdraw: SUCCESS (25.323s)
[597.336644] [098/133] (453s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[597.443479] Starting subtest: x-tiled-8bpp-rotate-180
[598.691789] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.248s)
[598.813697] [099/133] (451s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[599.373935] Starting subtest: syncobj-backward-timeline-chain-engines
[599.473938] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.109s)
[600.470368] [100/133] (450s left) gem_eio (in-flight-external)
[600.692512] Starting subtest: in-flight-external
[602.481141] Subtest in-flight-external: SUCCESS (1.790s)
[602.595086] [101/133] (448s left) kms_pm_rpm (pm-caching)
[604.610170] Starting subtest: pm-caching
[604.612962] Subtest pm-caching: SKIP (0.000s)
[604.980431] [102/133] (445s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[605.033583] Starting subtest: invalid-smem-bo-on-discrete
[605.035190] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[605.180438] [103/133] (445s left) gem_eio (in-flight-internal-immediate)
[605.391344] Starting subtest: in-flight-internal-immediate
[606.497304] Subtest in-flight-internal-immediate: SUCCESS (1.105s)
[606.621751] [104/133] (444s left) api_intel_bb (delta-check)
[606.666974] Starting subtest: delta-check
[606.673379] Subtest delta-check: SUCCESS (0.007s)
[606.781744] [105/133] (444s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[606.868914] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[606.869756] Starting dynamic subtest: pipe-A-eDP-1
[606.890146] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[606.899010] Starting dynamic subtest: pipe-B-eDP-1
[606.919214] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[606.935199] Starting dynamic subtest: pipe-C-eDP-1
[606.954864] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[606.965996] Starting dynamic subtest: pipe-D-eDP-1
[606.987618] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[606.989209] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.009s)
[609.137158] [106/133] (441s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[609.216802] Starting subtest: bad-pixel-format-yf-tiled-ccs
[609.217699] Starting dynamic subtest: pipe-A-eDP-1
[609.226288] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[609.235635] Starting dynamic subtest: pipe-B-eDP-1
[609.244212] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[609.254585] Starting dynamic subtest: pipe-C-eDP-1
[609.262886] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[609.270892] Starting dynamic subtest: pipe-D-eDP-1
[609.279286] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[609.280991] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s)
[611.516106] [107/133] (439s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[611.621104] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[611.622835] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[611.722691] [108/133] (439s left) gem_exec_fence (basic-wait-all)
[611.804398] Starting subtest: basic-wait-all
[611.889368] Subtest basic-wait-all: SUCCESS (0.086s)
[613.567749] [109/133] (437s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[613.661922] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[614.518346] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: FAIL (0.638s)
[614.549307] [110/133] (436s left) syncobj_timeline (wait-all-snapshot)
[614.602728] Starting subtest: wait-all-snapshot
[614.684252] Subtest wait-all-snapshot: SUCCESS (0.082s)
[614.757544] [111/133] (436s left) kms_chamelium_color (ctm-negative)
[614.843809] Subtest ctm-negative: SKIP (0.000s)
[614.888077] [112/133] (436s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[615.009197] Starting subtest: cursorB-vs-flipA-legacy
[615.011851] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[615.162173] [113/133] (435s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[615.278835] Starting subtest: flip-vs-cursor-varying-size
[624.158795] Subtest flip-vs-cursor-varying-size: SUCCESS (8.877s)
[625.012718] [114/133] (426s left) kms_flip (flip-vs-panning)
[625.100668] Starting subtest: flip-vs-panning
[625.101611] Starting dynamic subtest: A-eDP1
[633.833457] Dynamic subtest A-eDP1: SUCCESS (8.731s)
[633.844628] Starting dynamic subtest: B-eDP1
[642.570049] Dynamic subtest B-eDP1: SUCCESS (8.734s)
[642.592244] Starting dynamic subtest: C-eDP1
[651.299550] Dynamic subtest C-eDP1: SUCCESS (8.725s)
[651.311419] Starting dynamic subtest: D-eDP1
[660.035229] Dynamic subtest D-eDP1: SUCCESS (8.731s)
[660.039383] Subtest flip-vs-panning: SUCCESS (34.935s)
[661.190503] [115/133] (390s left) gem_create (create-ext-cpu-access-sanity-check)
[661.350909] Starting subtest: create-ext-cpu-access-sanity-check
[661.352709] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[661.421219] [116/133] (389s left) prime_busy (hang)
[661.479460] Starting subtest: hang
[661.480360] Starting dynamic subtest: rcs0
[687.930866] Dynamic subtest rcs0: SUCCESS (26.440s)
[687.941395] Starting dynamic subtest: bcs0
[695.084196] Dynamic subtest bcs0: SUCCESS (7.152s)
[695.094766] Starting dynamic subtest: vcs0
[702.057663] Dynamic subtest vcs0: SUCCESS (6.971s)
[702.065974] Starting dynamic subtest: vcs1
[709.097879] Dynamic subtest vcs1: SUCCESS (7.037s)
[709.107929] Starting dynamic subtest: vecs0
[716.071144] Dynamic subtest vecs0: SUCCESS (6.968s)
[716.080973] Starting dynamic subtest: ccs0
[729.976216] Dynamic subtest ccs0: SUCCESS (13.899s)
[729.977377] Subtest hang: SUCCESS (68.474s)
[730.079109] [117/133] (321s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[730.173509] Starting subtest: plane-lut1d-pre-ctm3x4
[730.348252] Starting dynamic subtest: pipe-A-plane-0
[730.521891] Dynamic subtest pipe-A-plane-0: SUCCESS (0.177s)
[730.532184] Starting dynamic subtest: pipe-A-plane-1
[730.688210] Dynamic subtest pipe-A-plane-1: SUCCESS (0.164s)
[730.696883] Starting dynamic subtest: pipe-A-plane-2
[730.855229] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[732.042874] Starting dynamic subtest: pipe-B-plane-0
[732.212663] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s)
[732.221531] Starting dynamic subtest: pipe-B-plane-1
[732.368372] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s)
[732.376840] Starting dynamic subtest: pipe-B-plane-2
[732.535303] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[733.742550] Starting dynamic subtest: pipe-C-plane-0
[733.890243] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[733.898953] Starting dynamic subtest: pipe-C-plane-1
[734.045762] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[734.056564] Starting dynamic subtest: pipe-C-plane-2
[734.212705] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[735.361759] Starting dynamic subtest: pipe-D-plane-0
[735.497909] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[735.506413] Starting dynamic subtest: pipe-D-plane-1
[735.642384] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[735.651052] Starting dynamic subtest: pipe-D-plane-2
[735.798271] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[736.083522] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (5.908s)
[736.931808] [118/133] (314s left) kms_psr (pr-sprite-mmap-gtt)
[737.013835] Starting subtest: pr-sprite-mmap-gtt
[737.015805] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[737.103523] [119/133] (314s left) i915_query (hwconfig_table)
[737.160160] Starting subtest: hwconfig_table
[737.283177] Subtest hwconfig_table: SUCCESS (0.001s)
[737.314922] [120/133] (314s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[737.402331] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[737.404191] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[737.493901] [121/133] (313s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[737.864575] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[738.633786] [122/133] (312s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[738.715008] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[738.716922] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[738.801945] [123/133] (312s left) gem_workarounds (basic-read)
[738.869584] Starting subtest: basic-read
[738.885083] Subtest basic-read: SUCCESS (0.017s)
[739.011278] [124/133] (312s left) gen9_exec_parse (secure-batches)
[739.074372] Subtest secure-batches: SKIP (0.000s)
[739.134113] [125/133] (312s left) syncobj_wait (multi-wait-for-submit-submitted)
[739.177413] Starting subtest: multi-wait-for-submit-submitted
[739.282132] Subtest multi-wait-for-submit-submitted: SUCCESS (0.102s)
[739.352167] [126/133] (312s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[739.443859] Starting subtest: y-tiled-64bpp-rotate-270
[739.445679] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[739.524983] [127/133] (312s left) gem_mmap_gtt (flink-race)
[739.581996] Subtest flink-race: SKIP (0.000s)
[739.639028] [128/133] (312s left) syncobj_wait (wait-all-delayed-signal)
[739.684101] Starting subtest: wait-all-delayed-signal
[739.788168] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[739.877091] [129/133] (311s left) gem_exec_whisper (basic-fds-priority)
[739.939777] Starting subtest: basic-fds-priority
[764.123743] Subtest basic-fds-priority: SUCCESS (24.167s)
[764.290355] [130/133] (287s left) kms_plane (plane-position-hole-dpms)
[764.380690] Starting subtest: plane-position-hole-dpms
[764.916241] Starting dynamic subtest: pipe-A-plane-1
[767.354709] Dynamic subtest pipe-A-plane-1: SUCCESS (2.439s)
[767.363536] Starting dynamic subtest: pipe-A-plane-2
[769.725186] Dynamic subtest pipe-A-plane-2: SUCCESS (2.370s)
[769.733805] Starting dynamic subtest: pipe-A-plane-3
[772.089821] Dynamic subtest pipe-A-plane-3: SUCCESS (2.365s)
[772.098859] Starting dynamic subtest: pipe-A-plane-4
[774.459354] Dynamic subtest pipe-A-plane-4: SUCCESS (2.369s)
[774.468045] Starting dynamic subtest: pipe-A-plane-5
[774.484652] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[775.641290] Starting dynamic subtest: pipe-B-plane-1
[778.049932] Dynamic subtest pipe-B-plane-1: SUCCESS (2.417s)
[778.061387] Starting dynamic subtest: pipe-B-plane-2
[780.402641] Dynamic subtest pipe-B-plane-2: SUCCESS (2.353s)
[780.414275] Starting dynamic subtest: pipe-B-plane-3
[782.772846] Dynamic subtest pipe-B-plane-3: SUCCESS (2.369s)
[782.781966] Starting dynamic subtest: pipe-B-plane-4
[785.147997] Dynamic subtest pipe-B-plane-4: SUCCESS (2.375s)
[785.156460] Starting dynamic subtest: pipe-B-plane-5
[785.173735] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[785.174568] Subtest plane-position-hole-dpms: SUCCESS (20.798s)
[785.949607] [131/133] (265s left) i915_pm_rpm (gem-mmap-type)
[787.583814] Starting subtest: gem-mmap-type
[787.585354] Starting dynamic subtest: wb-smem0
[791.293058] Dynamic subtest wb-smem0: SUCCESS (3.711s)
[791.302932] Starting dynamic subtest: wc-smem0
[794.474294] Dynamic subtest wc-smem0: SUCCESS (3.180s)
[794.483171] Starting dynamic subtest: uc-smem0
[797.661669] Dynamic subtest uc-smem0: SUCCESS (3.186s)
[797.662596] Subtest gem-mmap-type: SUCCESS (10.081s)
[797.755167] [132/133] (254s left) kms_vblank (ts-continuation-idle-hang)
[797.843565] Starting subtest: ts-continuation-idle-hang
[797.844464] Starting dynamic subtest: pipe-A-eDP-1
[824.222340] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.377s)
[824.232686] Starting dynamic subtest: pipe-D-eDP-1
[839.262368] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.035s)
[839.263257] Subtest ts-continuation-idle-hang: SUCCESS (41.417s)
[840.073808] [133/133] (211s left) syncobj_wait (invalid-reset-bad-pad)
[840.123560] Starting subtest: invalid-reset-bad-pad
[840.124419] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[840.206547] 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.