[57.891633] Initializing watchdogs
[57.891685]   /dev/watchdog0
[57.907884] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.913263] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.915796] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.919775] [001/155] (960s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-pri-indfb-multidraw)
[58.053172] Starting subtest: fbcpsrhdr-1p-pri-indfb-multidraw
[58.057665] Subtest fbcpsrhdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[58.159524] [002/155] (960s left) gem_exec_fence (submit)
[58.350981] Starting subtest: submit
[58.355779] Subtest submit: SKIP (0.000s)
[60.366984] [FACT gem_exec_fence (submit)] new: kernel.kmod_is_loaded.vgem: true
[60.370333] [003/155] (958s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[60.473327] Starting subtest: psr2-cursor-plane-update-sf
[60.475702] Starting dynamic subtest: pipe-A-eDP-1
[61.097473] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.622s)
[61.107745] Starting dynamic subtest: pipe-B-eDP-1
[62.385235] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.268s)
[62.387610] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.891s)
[63.279998] [004/155] (955s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-pwrite)
[63.379074] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-pwrite
[63.383425] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[63.465128] [005/155] (955s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[63.569994] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[63.572343] Starting dynamic subtest: pipe-A-eDP-1
[63.595836] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[63.604330] Starting dynamic subtest: pipe-B-eDP-1
[63.625774] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[63.633596] Starting dynamic subtest: pipe-C-eDP-1
[63.654676] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[63.663081] Starting dynamic subtest: pipe-D-eDP-1
[63.684528] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[63.688556] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[65.888998] [006/155] (952s left) gem_exec_params (invalid-bsd-ring)
[65.951425] Starting subtest: invalid-bsd-ring
[65.953891] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[66.061533] [007/155] (952s left) kms_feature_discovery (dp-mst)
[66.167986] Starting subtest: dp-mst
[66.172352] Subtest dp-mst: SKIP (0.000s)
[66.258979] [008/155] (952s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc)
[66.367769] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc
[66.372099] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[66.464112] [009/155] (952s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-shrfb-pgflip-blt)
[66.559153] Starting subtest: psrhdr-1p-primscrn-shrfb-pgflip-blt
[66.563367] Subtest psrhdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[66.653744] [010/155] (952s left) gem_mmap_wc (bad-object)
[66.706853] Subtest bad-object: SKIP (0.000s)
[66.759164] [011/155] (952s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[66.822513] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[66.885996] [012/155] (951s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[66.982057] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[74.239955] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.232s)
[74.342646] [013/155] (944s left) gem_exec_schedule (wide)
[74.520999] Starting subtest: wide
[74.523357] Starting dynamic subtest: rcs0
[84.670698] Dynamic subtest rcs0: SUCCESS (10.084s)
[84.679157] Starting dynamic subtest: vcs0
[96.183078] Dynamic subtest vcs0: SUCCESS (11.552s)
[96.192513] Starting dynamic subtest: vcs1
[107.994673] Dynamic subtest vcs1: SUCCESS (11.805s)
[108.004015] Starting dynamic subtest: vecs0
[119.734430] Dynamic subtest vecs0: SUCCESS (11.735s)
[119.745547] Starting dynamic subtest: ccs0
[134.476276] Dynamic subtest ccs0: SUCCESS (14.687s)
[134.478472] Subtest wide: SUCCESS (59.867s)
[135.531288] [014/155] (883s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[135.642840] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[135.647160] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[135.744034] [015/155] (883s left) gem_vm_create (invalid-create)
[135.809494] Starting subtest: invalid-create
[135.811699] Subtest invalid-create: SUCCESS (0.002s)
[135.930367] [016/155] (883s left) kms_plane_cursor (primary)
[136.027543] Starting subtest: primary
[136.031685] Starting dynamic subtest: pipe-A-eDP-1-size-64
[138.581438] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.555s)
[138.605660] Starting dynamic subtest: pipe-A-eDP-1-size-128
[141.183642] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.583s)
[141.208476] Starting dynamic subtest: pipe-A-eDP-1-size-256
[143.806742] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.605s)
[144.122171] Starting dynamic subtest: pipe-B-eDP-1-size-64
[147.417638] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.308s)
[147.442344] Starting dynamic subtest: pipe-B-eDP-1-size-128
[150.007418] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.572s)
[150.033446] Starting dynamic subtest: pipe-B-eDP-1-size-256
[152.585282] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.561s)
[152.902453] Starting dynamic subtest: pipe-C-eDP-1-size-64
[155.878159] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.987s)
[155.904114] Starting dynamic subtest: pipe-C-eDP-1-size-128
[158.111370] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.214s)
[158.138175] Starting dynamic subtest: pipe-C-eDP-1-size-256
[160.334965] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.203s)
[160.657498] Starting dynamic subtest: pipe-D-eDP-1-size-64
[163.603463] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.957s)
[163.630657] Starting dynamic subtest: pipe-D-eDP-1-size-128
[165.836712] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.214s)
[165.862286] Starting dynamic subtest: pipe-D-eDP-1-size-256
[168.103488] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.247s)
[168.411618] Subtest primary: SUCCESS (32.383s)
[169.243318] [017/155] (849s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[169.357332] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[169.361924] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[169.474350] [018/155] (849s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[169.569245] Starting subtest: fbc-rgb565-draw-mmap-wc
[173.607202] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.043s)
[174.751924] [019/155] (844s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-onoff)
[174.855790] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-onoff
[174.859851] Subtest psrhdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[174.965592] [020/155] (844s left) i915_hangman (error-state-basic)
[175.032290] Starting subtest: error-state-basic
[175.193325] Subtest error-state-basic: SUCCESS (0.160s)
[175.269563] [021/155] (843s left) kms_cursor_edge_walk (256x256-top-edge)
[175.355404] Starting subtest: 256x256-top-edge
[175.357664] Starting dynamic subtest: pipe-A-eDP-1
[178.810243] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.455s)
[178.820720] Starting dynamic subtest: pipe-D-eDP-1
[182.030765] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.218s)
[182.032796] Subtest 256x256-top-edge: SUCCESS (6.675s)
[182.850211] [022/155] (836s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[182.943985] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[182.956132] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.011s)
[183.038517] [023/155] (836s left) kms_big_fb (linear-8bpp-rotate-90)
[183.149323] Starting subtest: linear-8bpp-rotate-90
[183.169224] Subtest linear-8bpp-rotate-90: SKIP (0.019s)
[183.284541] [024/155] (836s left) drm_buddy (drm_buddy)
[183.321075] Starting subtest: drm_buddy
[183.325202] Subtest drm_buddy: SKIP (0.000s)
[183.372313] [025/155] (836s left) kms_pm_rpm (modeset-lpsp)
[185.396751] Starting subtest: modeset-lpsp
[186.907375] Subtest modeset-lpsp: SUCCESS (1.511s)
[187.026952] [026/155] (832s left) kms_lease (lease-unleased-connector)
[187.122272] Starting subtest: lease-unleased-connector
[187.124609] Starting dynamic subtest: pipe-A-eDP-1
[187.126789] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[187.136374] Starting dynamic subtest: pipe-B-eDP-1
[187.138591] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s)
[187.147659] Starting dynamic subtest: pipe-C-eDP-1
[187.149850] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[187.158665] Starting dynamic subtest: pipe-D-eDP-1
[187.160846] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.006s)
[187.162987] Subtest lease-unleased-connector: SUCCESS (0.029s)
[187.262577] [027/155] (832s left) kms_psr (fbc-psr-primary-blt)
[187.360052] Starting subtest: fbc-psr-primary-blt
[187.362346] Starting dynamic subtest: eDP-1
[187.366751] Dynamic subtest eDP-1: SKIP (0.000s)
[187.371164] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[187.435665] [028/155] (832s left) kms_frontbuffer_tracking (hdr-1p-primscrn-indfb-pgflip-blt)
[187.529871] Starting subtest: hdr-1p-primscrn-indfb-pgflip-blt
[187.533990] Subtest hdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[187.638042] [029/155] (831s left) gem_exec_fence (concurrent)
[187.820216] Starting subtest: concurrent
[187.824496] Subtest concurrent: SKIP (0.000s)
[189.390459] [030/155] (830s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[189.492896] Starting subtest: fbcpsr-rgb565-draw-blt
[196.581789] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.094s)
[196.711745] [031/155] (822s left) gem_pwrite_snooped
[196.857390] [032/155] (822s left) prime_self_import (reimport-vs-gem_close-race)
[196.890904] Starting subtest: reimport-vs-gem_close-race
[202.001465] Subtest reimport-vs-gem_close-race: SUCCESS (5.100s)
[202.082832] [033/155] (817s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[202.195204] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[202.199518] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[202.297049] [034/155] (817s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[202.408479] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[209.115762] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.714s)
[209.265284] [035/155] (810s left) api_intel_allocator (execbuf-with-allocator)
[209.335502] Starting subtest: execbuf-with-allocator
[209.341352] Subtest execbuf-with-allocator: SUCCESS (0.007s)
[209.466302] [036/155] (810s left) gem_partial_pwrite_pread (writes-after-reads)
[209.514945] Subtest writes-after-reads: SKIP (0.000s)
[209.588066] [037/155] (810s left) gem_tiled_swapping (non-threaded)
[209.641090] Subtest non-threaded: SKIP (0.000s)
[209.700536] [038/155] (810s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[209.807134] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[209.811402] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[209.905244] [039/155] (810s left) gem_ctx_isolation (preservation-s3)
[209.975517] Starting subtest: preservation-S3
[209.977848] Starting dynamic subtest: rcs0
[225.975189] Dynamic subtest rcs0: SUCCESS (2.131s)
[225.985369] Starting dynamic subtest: bcs0
[242.003178] Dynamic subtest bcs0: SUCCESS (1.286s)
[242.015438] Starting dynamic subtest: vcs0
[257.979123] Dynamic subtest vcs0: SUCCESS (2.865s)
[257.992025] Starting dynamic subtest: vcs1
[275.980970] Dynamic subtest vcs1: SUCCESS (4.853s)
[275.991786] Starting dynamic subtest: vecs0
[293.995088] Dynamic subtest vecs0: SUCCESS (4.883s)
[294.008610] Starting dynamic subtest: ccs0
[311.973815] Dynamic subtest ccs0: SUCCESS (3.056s)
[311.976229] Subtest preservation-S3: SUCCESS (19.080s)
[312.219558] [040/155] (707s left) gem_create (create-valid-nonaligned)
[312.289810] Starting subtest: create-valid-nonaligned
[312.292159] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[312.495823] [041/155] (707s left) gem_create (create-clear)
[312.546471] Starting subtest: create-clear
[312.549163] Starting dynamic subtest: smem0
[345.590307] Dynamic subtest smem0: SUCCESS (32.766s)
[345.592520] Subtest create-clear: SUCCESS (32.767s)
[345.793332] [042/155] (674s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[345.921543] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[345.926165] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s)
[346.066399] [043/155] (674s left) kms_flip (2x-busy-flip)
[346.171948] Starting subtest: 2x-busy-flip
[346.183300] Subtest 2x-busy-flip: SKIP (0.011s)
[346.265589] [044/155] (673s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[346.380965] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[346.385200] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[346.474770] [045/155] (673s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[346.587071] Starting subtest: cursorA-vs-flipA-atomic
[357.711229] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.122s)
[358.533624] [046/155] (661s left) gem_userptr_blits (dmabuf-unsync)
[358.604207] Subtest dmabuf-unsync: SKIP (0.000s)
[358.729112] [047/155] (661s left) gem_eio (wait-1us)
[358.964267] Starting subtest: wait-1us
[359.328799] Subtest wait-1us: SUCCESS (0.367s)
[359.468872] [048/155] (660s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-mmap-gtt)
[359.563565] Starting subtest: psrhdr-rgb565-draw-mmap-gtt
[359.567235] Subtest psrhdr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[359.687178] [049/155] (660s left) perf (disabled-read-error)
[359.807877] Starting subtest: disabled-read-error
[359.821900] Subtest disabled-read-error: SUCCESS (0.015s)
[359.874001] [050/155] (660s left) gem_exec_whisper (basic-queues-priority)
[359.938193] Starting subtest: basic-queues-priority
[382.778777] Subtest basic-queues-priority: SUCCESS (22.832s)
[382.967275] [051/155] (637s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[383.067485] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[383.069765] Starting dynamic subtest: pipe-A-eDP-1
[383.594114] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.497s)
[383.606756] Starting dynamic subtest: pipe-B-eDP-1
[385.129455] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.533s)
[385.139805] Starting dynamic subtest: pipe-C-eDP-1
[386.637579] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.508s)
[386.650294] Starting dynamic subtest: pipe-D-eDP-1
[388.011748] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.374s)
[388.014039] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.917s)
[389.194311] [052/155] (631s left) kms_invalid_mode (bad-hsync-end)
[389.292296] Starting subtest: bad-hsync-end
[389.294583] Starting dynamic subtest: pipe-A-eDP-1
[389.581257] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s)
[389.592191] Starting dynamic subtest: pipe-B-eDP-1
[389.594094] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[389.604025] Starting dynamic subtest: pipe-C-eDP-1
[389.606164] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[389.617126] Starting dynamic subtest: pipe-D-eDP-1
[389.619427] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[389.621897] Subtest bad-hsync-end: SUCCESS (0.298s)
[390.437615] [053/155] (630s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[390.532845] Starting subtest: psr-rgb565-draw-pwrite
[397.668917] Subtest psr-rgb565-draw-pwrite: SUCCESS (7.138s)
[397.807027] [054/155] (622s left) syncobj_timeline (host-signal-points)
[397.863904] Starting subtest: host-signal-points
[397.871073] Subtest host-signal-points: SUCCESS (0.008s)
[397.954270] [055/155] (622s left) kms_chamelium_hpd (hdmi-hpd-fast)
[398.338517] Subtest hdmi-hpd-fast: SKIP (0.000s)
[399.160847] [056/155] (621s left) gem_eio (kms)
[399.435590] Starting subtest: kms
[419.318349] Subtest kms: SUCCESS (19.883s)
[419.430917] [057/155] (601s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[419.545265] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[419.549692] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[419.645939] [058/155] (601s left) gem_fence_thrash (bo-write-verify-x)
[419.678780] Starting subtest: bo-write-verify-x
[419.693072] Subtest bo-write-verify-x: SKIP (0.013s)
[419.774951] [059/155] (601s left) kms_atomic_transition (plane-all-transition-nonblocking)
[419.866729] Starting subtest: plane-all-transition-nonblocking
[419.869043] Starting dynamic subtest: pipe-A-eDP-1
[422.360355] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[422.682749] Starting dynamic subtest: pipe-B-eDP-1
[425.904358] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.233s)
[426.200571] Subtest plane-all-transition-nonblocking: SUCCESS (6.337s)
[427.040876] [060/155] (593s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[427.147120] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[427.151427] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[427.248017] [061/155] (593s left) gem_media_vme
[427.390699] [062/155] (593s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[427.482512] Starting subtest: bad-aux-stride-yf-tiled-ccs
[427.484657] Starting dynamic subtest: pipe-A-eDP-1
[427.507775] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[427.520313] Starting dynamic subtest: pipe-B-eDP-1
[427.541544] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[427.551724] Starting dynamic subtest: pipe-C-eDP-1
[427.572494] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[427.582132] Starting dynamic subtest: pipe-D-eDP-1
[427.603255] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[427.607428] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.005s)
[429.806546] [063/155] (591s left) perf (gen8-unprivileged-single-ctx-counters)
[429.897697] Starting subtest: gen8-unprivileged-single-ctx-counters
[429.902407] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[429.942091] [064/155] (591s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[430.034213] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[430.059873] Starting dynamic subtest: pipe-A-plane-0
[430.471714] Dynamic subtest pipe-A-plane-0: SUCCESS (0.411s)
[430.483095] Starting dynamic subtest: pipe-A-plane-3
[430.792375] Dynamic subtest pipe-A-plane-3: SUCCESS (0.321s)
[431.890107] Starting dynamic subtest: pipe-B-plane-0
[432.324402] Dynamic subtest pipe-B-plane-0: SUCCESS (0.444s)
[432.335252] Starting dynamic subtest: pipe-B-plane-3
[432.669809] Dynamic subtest pipe-B-plane-3: SUCCESS (0.343s)
[432.981376] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (2.946s)
[433.858853] [065/155] (587s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-blt)
[433.968527] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-blt
[433.972784] Subtest hdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[434.050783] [066/155] (587s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[434.154000] Starting subtest: plane-upscale-factor-0-25-with-rotation
[434.156341] Starting dynamic subtest: pipe-A
[434.379268] Dynamic subtest pipe-A: SUCCESS (0.228s)
[434.390214] Starting dynamic subtest: pipe-B
[435.655229] Dynamic subtest pipe-B: SUCCESS (1.274s)
[435.670492] Starting dynamic subtest: pipe-C
[436.988537] Dynamic subtest pipe-C: SUCCESS (1.333s)
[437.001852] Starting dynamic subtest: pipe-D
[438.318729] Dynamic subtest pipe-D: SUCCESS (1.328s)
[438.321070] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.167s)
[439.499026] [067/155] (581s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[439.590804] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[439.595033] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[439.693907] [068/155] (581s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[439.805043] Starting subtest: short-busy-flip-before-cursor-toggle
[439.809543] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[439.962877] [069/155] (581s left) sriov_basic (enable-vfs-bind-unbind-each)
[440.018624] Starting subtest: enable-vfs-bind-unbind-each
[440.021271] Starting dynamic subtest: numvfs-1
[440.026368] Dynamic subtest numvfs-1: SKIP (0.001s)
[440.039466] Starting dynamic subtest: numvfs-2
[440.043675] Dynamic subtest numvfs-2: SKIP (0.001s)
[440.054166] Starting dynamic subtest: numvfs-3
[440.058170] Dynamic subtest numvfs-3: SKIP (0.001s)
[440.068355] Starting dynamic subtest: numvfs-4
[440.072653] Dynamic subtest numvfs-4: SKIP (0.000s)
[440.084530] Starting dynamic subtest: numvfs-5
[440.088528] Dynamic subtest numvfs-5: SKIP (0.000s)
[440.098359] Starting dynamic subtest: numvfs-6
[440.102747] Dynamic subtest numvfs-6: SKIP (0.000s)
[440.113481] Starting dynamic subtest: numvfs-7
[440.117546] Dynamic subtest numvfs-7: SKIP (0.001s)
[440.127005] Starting dynamic subtest: numvfs-random
[440.131106] Dynamic subtest numvfs-random: SKIP (0.000s)
[440.135251] Subtest enable-vfs-bind-unbind-each: SKIP (0.010s)
[440.174410] [070/155] (581s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-blt)
[440.276494] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-blt
[440.280597] Subtest fbchdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[440.384849] [071/155] (581s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[440.475328] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[440.478966] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[440.570071] [072/155] (580s left) kms_chamelium_frames (hdmi-crc-fast)
[440.949754] Subtest hdmi-crc-fast: SKIP (0.000s)
[441.812831] [073/155] (579s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[441.901785] Starting subtest: fbc-psr2-cursor-mmap-gtt
[441.904151] Starting dynamic subtest: eDP-1
[441.908554] Dynamic subtest eDP-1: SKIP (0.000s)
[441.912947] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[441.977844] [074/155] (579s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[442.074490] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc
[442.078842] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[442.182678] [075/155] (579s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[442.280989] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[442.285027] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[442.383009] [076/155] (579s left) kms_psr (pr-primary-render)
[442.481943] Starting subtest: pr-primary-render
[442.486306] Subtest pr-primary-render: SKIP (0.000s)
[442.554324] [077/155] (579s left) gem_exec_reloc (basic-wc-read-active)
[442.623337] Subtest basic-wc-read-active: SKIP (0.000s)
[442.708583] [078/155] (579s left) kms_hdmi_inject (inject-audio)
[443.054927] Starting subtest: inject-audio
[443.348260] Subtest inject-audio: SUCCESS (0.295s)
[443.903363] [079/155] (577s left) i915_pm_rps (thresholds)
[443.958660] Starting subtest: thresholds
[443.963046] Subtest thresholds: SKIP (0.001s)
[444.062692] [080/155] (577s left) gem_tiled_blits (basic)
[444.121930] Subtest basic: SKIP (0.000s)
[444.211127] [081/155] (577s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[444.313235] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[444.317489] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[444.409625] [082/155] (577s left) gem_ctx_persistence (hostile)
[444.469104] Starting subtest: hostile
[453.985675] Subtest hostile: SUCCESS (9.510s)
[454.108222] [083/155] (567s left) kms_plane_multiple (2x-tiling-y)
[454.211138] Starting subtest: 2x-tiling-y
[454.215317] Subtest 2x-tiling-y: SKIP (0.000s)
[454.296649] [084/155] (567s left) gem_mmap_gtt (fault-concurrent)
[454.354872] Subtest fault-concurrent: SKIP (0.000s)
[454.412394] [085/155] (567s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-indfb-msflip-blt)
[454.521669] Starting subtest: fbcpsrhdr-2p-scndscrn-indfb-msflip-blt
[454.525678] Subtest fbcpsrhdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[454.615993] [086/155] (567s left) gen9_exec_parse (bb-secure)
[454.684321] Subtest bb-secure: SKIP (0.000s)
[454.765087] [087/155] (567s left) kms_plane_scaling (invalid-num-scalers)
[454.866248] Starting subtest: invalid-num-scalers
[454.868521] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[454.887485] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.021s)
[454.897917] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[454.923700] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.034s)
[454.934500] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[454.960257] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.035s)
[454.970972] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[454.994805] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.034s)
[454.997036] Subtest invalid-num-scalers: SUCCESS (0.130s)
[455.112459] [088/155] (567s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[455.212202] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[455.215658] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[455.321369] [089/155] (566s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[455.420528] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[462.162891] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.744s)
[462.301387] [090/155] (559s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-blt)
[462.398020] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-blt
[462.402264] Subtest hdr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[462.501886] [091/155] (559s left) gem_ccs (block-copy-compressed)
[462.560125] Starting subtest: block-copy-compressed
[462.564650] Subtest block-copy-compressed: SKIP (0.000s)
[462.655042] [092/155] (559s left) kms_psr (fbc-pr-cursor-blt)
[462.739484] Starting subtest: fbc-pr-cursor-blt
[462.743482] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[462.811992] [093/155] (559s left) gem_workarounds (reset-context)
[462.869759] Starting subtest: reset-context
[463.016732] Subtest reset-context: SUCCESS (0.145s)
[463.166557] [094/155] (559s left) gem_exec_balancer (bonded-dual)
[463.233969] Starting subtest: bonded-dual
[463.237280] Subtest bonded-dual: SKIP (0.000s)
[463.546103] [095/155] (558s left) gem_exec_nop (basic-series)
[463.623708] Starting subtest: basic-series
[479.741341] Subtest basic-series: SUCCESS (16.120s)
[479.994057] [096/155] (542s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-render)
[480.116655] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-render
[480.121022] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[480.206872] [097/155] (542s left) perf_pmu (init-busy)
[480.246654] Starting subtest: init-busy
[480.249255] Starting dynamic subtest: rcs0
[480.251633] Dynamic subtest rcs0: SUCCESS (0.001s)
[480.264768] Starting dynamic subtest: bcs0
[480.266949] Dynamic subtest bcs0: SUCCESS (0.001s)
[480.277128] Starting dynamic subtest: vcs0
[480.279237] Dynamic subtest vcs0: SUCCESS (0.001s)
[480.290970] Starting dynamic subtest: vcs1
[480.293259] Dynamic subtest vcs1: SUCCESS (0.000s)
[480.303651] Starting dynamic subtest: vecs0
[480.305931] Dynamic subtest vecs0: SUCCESS (0.000s)
[480.316028] Starting dynamic subtest: ccs0
[480.317927] Dynamic subtest ccs0: SUCCESS (0.000s)
[480.319810] Subtest init-busy: SUCCESS (0.007s)
[480.361236] [098/155] (542s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[480.464962] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[487.156001] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.695s)
[487.296349] [099/155] (535s left) kms_vblank (wait-idle-hang)
[487.381746] Starting subtest: wait-idle-hang
[487.383916] Starting dynamic subtest: pipe-A-eDP-1
[513.467260] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.079s)
[513.482368] Starting dynamic subtest: pipe-D-eDP-1
[538.565217] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.088s)
[538.567426] Subtest wait-idle-hang: SUCCESS (51.171s)
[539.383671] [100/155] (483s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[539.489577] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[539.493818] Subtest hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[539.590164] [101/155] (483s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[539.682698] Starting subtest: random-ccs-data-y-tiled-ccs
[539.685078] Starting dynamic subtest: pipe-A-eDP-1
[539.710144] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[539.722646] Starting dynamic subtest: pipe-B-eDP-1
[539.746511] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[539.756558] Starting dynamic subtest: pipe-C-eDP-1
[539.780502] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[539.790852] Starting dynamic subtest: pipe-D-eDP-1
[539.815205] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[539.819255] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s)
[541.975857] [102/155] (480s left) i915_drm_fdinfo (busy-check-all)
[542.017761] Starting subtest: busy-check-all
[542.020020] Starting dynamic subtest: rcs0
[542.027219] Dynamic subtest rcs0: SKIP (0.005s)
[542.040515] Starting dynamic subtest: bcs0
[542.045162] Dynamic subtest bcs0: SKIP (0.000s)
[542.056106] Starting dynamic subtest: vcs0
[542.060336] Dynamic subtest vcs0: SKIP (0.000s)
[542.070303] Starting dynamic subtest: vcs1
[542.074573] Dynamic subtest vcs1: SKIP (0.000s)
[542.084565] Starting dynamic subtest: vecs0
[542.088643] Dynamic subtest vecs0: SKIP (0.000s)
[542.099079] Starting dynamic subtest: ccs0
[542.104089] Dynamic subtest ccs0: SKIP (0.000s)
[542.108736] Subtest busy-check-all: SKIP (0.010s)
[542.150862] [103/155] (480s left) syncobj_basic (bad-flags-handle-to-fd)
[542.232517] Starting subtest: bad-flags-handle-to-fd
[542.234922] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[542.343390] [104/155] (480s left) kms_content_protection (dp-mst-type-1)
[542.484413] Starting subtest: dp-mst-type-1
[542.489054] Subtest dp-mst-type-1: SKIP (0.000s)
[542.624837] [105/155] (480s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[542.720164] Starting subtest: 4-tiled-16bpp-rotate-0
[544.008684] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.290s)
[544.143238] [106/155] (478s left) gem_exec_params (invalid-fence-in)
[544.202970] Starting subtest: invalid-fence-in
[544.205329] Subtest invalid-fence-in: SUCCESS (0.000s)
[544.328339] [107/155] (478s left) gem_mmap_gtt (flink-race)
[544.377076] Subtest flink-race: SKIP (0.000s)
[544.438495] [108/155] (478s left) syncobj_timeline (invalid-signal-illegal-point)
[544.501488] Starting subtest: invalid-signal-illegal-point
[544.503373] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[544.599701] [109/155] (478s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-pgflip-blt)
[544.699670] Starting subtest: fbchdr-1p-primscrn-indfb-pgflip-blt
[544.703315] Subtest fbchdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[544.794623] [110/155] (478s left) kms_panel_fitting (legacy)
[544.888583] Starting subtest: legacy
[544.890215] Starting dynamic subtest: pipe-A-eDP-1
[545.398558] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.513s)
[545.426302] Starting dynamic subtest: pipe-B-eDP-1
[546.989087] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.570s)
[547.019041] Starting dynamic subtest: pipe-C-eDP-1
[548.545791] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.537s)
[548.574563] Starting dynamic subtest: pipe-D-eDP-1
[550.044735] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.481s)
[550.046873] Subtest legacy: SUCCESS (5.160s)
[551.269366] [111/155] (471s left) i915_suspend (debugfs-reader)
[551.340210] Starting subtest: debugfs-reader
[568.914944] Subtest debugfs-reader: SUCCESS (3.133s)
[569.127024] [112/155] (454s left) kms_psr (psr-cursor-plane-move)
[569.242403] Starting subtest: psr-cursor-plane-move
[569.246817] Starting dynamic subtest: eDP-1
[570.978111] Dynamic subtest eDP-1: SUCCESS (1.682s)
[570.980499] Subtest psr-cursor-plane-move: SUCCESS (1.683s)
[571.855670] [113/155] (451s left) gem_exec_schedule (pi-ringfull)
[572.040543] Starting subtest: pi-ringfull
[572.042507] Starting dynamic subtest: rcs0
[572.069257] Dynamic subtest rcs0: SUCCESS (0.032s)
[572.084354] Starting dynamic subtest: bcs0
[572.101068] Dynamic subtest bcs0: SUCCESS (0.030s)
[572.118184] Starting dynamic subtest: vcs0
[572.130180] Dynamic subtest vcs0: SUCCESS (0.027s)
[572.144945] Starting dynamic subtest: vcs1
[572.160842] Dynamic subtest vcs1: SUCCESS (0.029s)
[572.179667] Starting dynamic subtest: vecs0
[572.191394] Dynamic subtest vecs0: SUCCESS (0.029s)
[572.207950] Starting dynamic subtest: ccs0
[572.220182] Dynamic subtest ccs0: SUCCESS (0.027s)
[572.222474] Subtest pi-ringfull: SUCCESS (0.180s)
[572.464528] [114/155] (450s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[572.524232] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[572.632315] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.103s)
[572.714729] [115/155] (450s left) gem_ctx_param (get-priority-new-ctx)
[572.771284] Starting subtest: get-priority-new-ctx
[572.773712] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[572.880059] [116/155] (450s left) api_intel_bb (lot-of-buffers)
[572.940209] Starting subtest: lot-of-buffers
[574.035637] Subtest lot-of-buffers: SUCCESS (1.073s)
[574.341735] [117/155] (449s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[574.447134] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[575.465720] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.001s)
[575.602549] [118/155] (447s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[575.701391] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[575.705353] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[576.833651] [119/155] (446s left) kms_prime (basic-crc-hybrid)
[576.920906] Subtest basic-crc-hybrid: SKIP (0.000s)
[577.029413] [120/155] (446s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[577.118018] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[577.119978] Starting dynamic subtest: pipe-A-eDP-1
[593.125576] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.368s)
[593.137664] Starting dynamic subtest: pipe-B-eDP-1
[610.159522] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.479s)
[610.171159] Starting dynamic subtest: pipe-C-eDP-1
[627.107462] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.415s)
[627.119293] Starting dynamic subtest: pipe-D-eDP-1
[644.107506] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.349s)
[644.109941] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.617s)
[645.280502] [121/155] (378s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[645.344260] Starting subtest: multi-wait-for-submit-submitted-signaled
[645.346685] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[645.461371] [122/155] (378s left) prime_vgem (basic-gtt)
[645.566621] Starting subtest: basic-gtt
[645.571228] Subtest basic-gtt: SKIP (0.000s)
[645.695201] [123/155] (378s left) gem_exec_fence (syncobj-timeline-wait)
[646.257626] Starting subtest: syncobj-timeline-wait
[647.283067] Subtest syncobj-timeline-wait: SUCCESS (0.998s)
[647.511098] [124/155] (376s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[647.622496] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[648.466829] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.826s)
[648.644626] [125/155] (375s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[648.711199] Starting subtest: map-fixed-invalidate-overlap-busy
[648.715713] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[648.837067] [126/155] (375s left) gem_softpin (32b-excludes-last-page)
[648.900581] Starting subtest: 32b-excludes-last-page
[648.906721] Subtest 32b-excludes-last-page: SUCCESS (0.004s)
[649.035809] [127/155] (374s left) gem_exec_schedule (semaphore-codependency)
[649.108004] Starting subtest: semaphore-codependency
[649.113761] Subtest semaphore-codependency: SUCCESS (0.012s)
[649.474059] [128/155] (374s left) gem_pxp (hw-rejects-pxp-context)
[649.608414] Starting subtest: hw-rejects-pxp-context
[649.613017] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[649.717850] [129/155] (374s left) gem_spin_batch (spin-all-new)
[649.777022] Starting subtest: spin-all-new
[649.791747] Subtest spin-all-new: SUCCESS (0.013s)
[651.337790] [130/155] (372s left) kms_cursor_crc (cursor-offscreen-512x512)
[651.609668] Starting subtest: cursor-offscreen-512x512
[651.614230] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[651.758040] [131/155] (372s left) syncobj_timeline (wait-all-for-submit-complex)
[651.811674] Starting subtest: wait-all-for-submit-complex
[652.026329] Subtest wait-all-for-submit-complex: SUCCESS (0.211s)
[652.117245] [132/155] (372s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[652.209760] Starting subtest: plane-lut1d-post-ctm3x4
[652.357654] Starting dynamic subtest: pipe-A-plane-0
[652.549476] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s)
[652.561030] Starting dynamic subtest: pipe-A-plane-1
[652.740306] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s)
[652.751956] Starting dynamic subtest: pipe-A-plane-2
[652.909140] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[654.172408] Starting dynamic subtest: pipe-B-plane-0
[654.342777] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s)
[654.355321] Starting dynamic subtest: pipe-B-plane-1
[654.511458] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[654.528028] Starting dynamic subtest: pipe-B-plane-2
[654.680862] Dynamic subtest pipe-B-plane-2: SUCCESS (0.165s)
[655.952186] Starting dynamic subtest: pipe-C-plane-0
[656.076959] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[656.091046] Starting dynamic subtest: pipe-C-plane-1
[656.235751] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[656.247036] Starting dynamic subtest: pipe-C-plane-2
[656.390879] Dynamic subtest pipe-C-plane-2: SUCCESS (0.154s)
[657.584318] Starting dynamic subtest: pipe-D-plane-0
[657.739683] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[657.751098] Starting dynamic subtest: pipe-D-plane-1
[657.896512] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[657.908313] Starting dynamic subtest: pipe-D-plane-2
[658.064225] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[658.352508] Subtest plane-lut1d-post-ctm3x4: SUCCESS (6.084s)
[659.210008] [133/155] (365s left) kms_universal_plane (cursor-fb-leak)
[659.307503] Starting subtest: cursor-fb-leak
[659.309354] Starting dynamic subtest: pipe-A-eDP-1
[659.619487] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.311s)
[659.636909] Starting dynamic subtest: pipe-B-eDP-1
[660.989494] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.360s)
[661.003207] Starting dynamic subtest: pipe-C-eDP-1
[662.376055] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.377s)
[662.387552] Starting dynamic subtest: pipe-D-eDP-1
[663.691126] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.311s)
[663.693600] Subtest cursor-fb-leak: SUCCESS (4.367s)
[664.840911] [134/155] (359s left) gem_mmap_gtt (basic-small-copy)
[664.899163] Subtest basic-small-copy: SKIP (0.000s)
[664.961890] [135/155] (359s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[665.064582] Starting subtest: x-tiled-64bpp-rotate-180
[666.648253] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.581s)
[666.808094] [136/155] (357s left) kms_cursor_crc (cursor-random-32x32)
[666.954270] Starting subtest: cursor-random-32x32
[667.001309] Subtest cursor-random-32x32: SKIP (0.043s)
[667.296505] [137/155] (357s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[667.413878] Starting subtest: psr-2p-primscrn-cur-indfb-move
[667.417245] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[667.518054] [138/155] (356s left) gem_tiled_fence_blits (basic)
[667.576306] Subtest basic: SKIP (0.000s)
[667.662729] [139/155] (356s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[667.747292] Starting subtest: invalidate-primary-flip-overlay
[678.451893] Subtest invalidate-primary-flip-overlay: SUCCESS (10.695s)
[678.579118] [140/155] (346s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[678.680302] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[678.683868] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[678.788580] [141/155] (345s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[678.879385] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[678.882735] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[678.967504] [142/155] (345s left) perf_pmu (busy-double-start)
[679.003762] Starting subtest: busy-double-start
[679.005304] Starting dynamic subtest: rcs0
[682.644877] Dynamic subtest rcs0: FAIL (3.590s)
[682.656988] Starting dynamic subtest: bcs0
[686.168468] Dynamic subtest bcs0: SUCCESS (3.575s)
[686.180540] Starting dynamic subtest: vcs0
[689.773174] Dynamic subtest vcs0: SUCCESS (3.602s)
[689.786444] Starting dynamic subtest: vcs1
[693.800355] Dynamic subtest vcs1: SUCCESS (4.024s)
[693.813755] Starting dynamic subtest: vecs0
[697.779506] Dynamic subtest vecs0: SUCCESS (3.976s)
[697.793759] Starting dynamic subtest: ccs0
[701.420082] Dynamic subtest ccs0: FAIL (3.567s)
[701.422403] Subtest busy-double-start: FAIL (22.346s)
[701.469767] [143/155] (323s left) kms_async_flips (alternate-sync-async-flip)
[701.565458] Starting subtest: alternate-sync-async-flip
[701.941673] Starting dynamic subtest: pipe-A-eDP-1
[704.692071] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.750s)
[705.078461] Starting dynamic subtest: pipe-B-eDP-1
[707.901396] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.833s)
[708.281818] Starting dynamic subtest: pipe-C-eDP-1
[711.095621] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.822s)
[711.470458] Starting dynamic subtest: pipe-D-eDP-1
[714.298044] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.836s)
[714.300098] Subtest alternate-sync-async-flip: SUCCESS (12.733s)
[715.541906] [144/155] (309s left) kms_flip (2x-flip-vs-suspend-interruptible)
[715.642855] Starting subtest: 2x-flip-vs-suspend-interruptible
[715.647497] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.002s)
[715.750094] [145/155] (309s left) kms_joiner (basic-ultra-joiner)
[715.853000] Starting subtest: basic-ultra-joiner
[715.857096] Subtest basic-ultra-joiner: SKIP (0.000s)
[715.921792] [146/155] (308s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[716.015228] Starting subtest: fbc-farfromfence-mmap-gtt
[716.019615] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[716.108945] [147/155] (308s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[716.208627] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[719.734828] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.531s)
[720.963691] [148/155] (303s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt)
[721.064653] Starting subtest: fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt
[721.068725] Subtest fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[721.157902] [149/155] (303s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[721.253246] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[721.257618] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[721.362073] [150/155] (303s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-move)
[721.463546] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-move
[721.467798] Subtest fbchdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[721.571655] [151/155] (303s left) prime_mmap (test_invalid_sync_flags)
[721.628216] Starting subtest: test_invalid_sync_flags
[721.630518] Starting dynamic subtest: test_invalid_sync_flags-smem
[721.632552] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[721.634502] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[721.726830] [152/155] (303s left) perf (invalid-remove-userspace-config)
[721.819068] Starting subtest: invalid-remove-userspace-config
[721.832652] Subtest invalid-remove-userspace-config: SUCCESS (0.011s)
[721.885332] [153/155] (303s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[721.974328] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[721.978076] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[722.063283] [154/155] (303s left) kms_frontbuffer_tracking (fbcpsrhdr-suspend)
[722.158364] Starting subtest: fbcpsrhdr-suspend
[722.161705] Subtest fbcpsrhdr-suspend: SKIP (0.000s)
[722.250626] [155/155] (303s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-gtt)
[722.343134] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-gtt
[722.346596] Subtest fbcpsrhdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[722.448311] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_exec_fence
results: parsing output: 2/ for test: kms_psr2_sf
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: gem_exec_params
results: parsing output: 6/ for test: kms_feature_discovery
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_mmap_wc
results: parsing output: 10/ for test: gem_exec_reloc
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_exec_schedule
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_vm_create
results: parsing output: 15/ for test: kms_plane_cursor
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: i915_hangman
results: parsing output: 20/ for test: kms_cursor_edge_walk
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: drm_buddy
results: parsing output: 24/ for test: kms_pm_rpm
results: parsing output: 25/ for test: kms_lease
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_exec_fence
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_pwrite_snooped
results: parsing output: 31/ for test: prime_self_import
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: api_intel_allocator
results: parsing output: 35/ for test: gem_partial_pwrite_pread
results: parsing output: 36/ for test: gem_tiled_swapping
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_ctx_isolation
results: parsing output: 39/ for test: gem_create
results: parsing output: 40/ for test: gem_create
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: gem_userptr_blits
results: parsing output: 46/ for test: gem_eio
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: perf
results: parsing output: 49/ for test: gem_exec_whisper
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: kms_invalid_mode
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: kms_chamelium_hpd
results: parsing output: 55/ for test: gem_eio
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_fence_thrash
results: parsing output: 58/ for test: kms_atomic_transition
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_media_vme
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: perf
results: parsing output: 63/ for test: kms_plane
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_plane_scaling
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: sriov_basic
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_psr2_sf
results: parsing output: 71/ for test: kms_chamelium_frames
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: gem_exec_reloc
results: parsing output: 77/ for test: kms_hdmi_inject
results: parsing output: 78/ for test: i915_pm_rps
results: parsing output: 79/ for test: gem_tiled_blits
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_ctx_persistence
results: parsing output: 82/ for test: kms_plane_multiple
results: parsing output: 83/ for test: gem_mmap_gtt
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gen9_exec_parse
results: parsing output: 86/ for test: kms_plane_scaling
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gem_ccs
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: gem_workarounds
results: parsing output: 93/ for test: gem_exec_balancer
results: parsing output: 94/ for test: gem_exec_nop
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: perf_pmu
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_vblank
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: i915_drm_fdinfo
results: parsing output: 102/ for test: syncobj_basic
results: parsing output: 103/ for test: kms_content_protection
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: gem_exec_params
results: parsing output: 106/ for test: gem_mmap_gtt
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_panel_fitting
results: parsing output: 110/ for test: i915_suspend
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: gem_exec_schedule
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: gem_ctx_param
results: parsing output: 115/ for test: api_intel_bb
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: kms_prime
results: parsing output: 119/ for test: kms_ccs
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: prime_vgem
results: parsing output: 122/ for test: gem_exec_fence
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: gem_userptr_blits
results: parsing output: 125/ for test: gem_softpin
results: parsing output: 126/ for test: gem_exec_schedule
results: parsing output: 127/ for test: gem_pxp
results: parsing output: 128/ for test: gem_spin_batch
results: parsing output: 129/ for test: kms_cursor_crc
results: parsing output: 130/ for test: syncobj_timeline
results: parsing output: 131/ for test: kms_color_pipeline
results: parsing output: 132/ for test: kms_universal_plane
results: parsing output: 133/ for test: gem_mmap_gtt
results: parsing output: 134/ for test: kms_big_fb
results: parsing output: 135/ for test: kms_cursor_crc
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: gem_tiled_fence_blits
results: parsing output: 138/ for test: kms_psr_stress_test
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: perf_pmu
results: parsing output: 142/ for test: kms_async_flips
results: parsing output: 143/ for test: kms_flip
results: parsing output: 144/ for test: kms_joiner
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: prime_mmap
results: parsing output: 151/ for test: perf
results: parsing output: 152/ for test: kms_flip_scaled_crc
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: kms_frontbuffer_tracking
Done.