[60.738393] Initializing watchdogs
[60.738448]   /dev/watchdog0
[60.753040] [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]
[60.757559] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.759909] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.763436] [001/155] (960s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-pri-indfb-multidraw)
[60.884785] Starting subtest: fbcpsrhdr-1p-pri-indfb-multidraw
[60.889418] Subtest fbcpsrhdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[60.978241] [002/155] (960s left) gem_exec_fence (submit)
[61.153538] Starting subtest: submit
[61.158221] Subtest submit: SKIP (0.000s)
[63.374312] [FACT gem_exec_fence (submit)] new: kernel.kmod_is_loaded.vgem: true
[63.377675] [003/155] (957s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[63.474123] Starting subtest: psr2-cursor-plane-update-sf
[63.476490] Starting dynamic subtest: pipe-A-eDP-1
[64.091735] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.621s)
[64.101069] Starting dynamic subtest: pipe-B-eDP-1
[65.346481] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.257s)
[65.348820] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.880s)
[66.218501] [004/155] (955s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-pwrite)
[66.312991] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-pwrite
[66.317303] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[66.434313] [005/155] (954s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[66.529596] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[66.531804] Starting dynamic subtest: pipe-A-eDP-1
[66.554205] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[66.563867] Starting dynamic subtest: pipe-B-eDP-1
[66.585200] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[66.592427] Starting dynamic subtest: pipe-C-eDP-1
[66.613937] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[66.621413] Starting dynamic subtest: pipe-D-eDP-1
[66.643796] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[66.647969] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.002s)
[68.789294] [006/155] (952s left) gem_exec_params (invalid-bsd-ring)
[68.851805] Starting subtest: invalid-bsd-ring
[68.853598] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[68.951895] [007/155] (952s left) kms_feature_discovery (dp-mst)
[69.045318] Starting subtest: dp-mst
[69.049512] Subtest dp-mst: SKIP (0.000s)
[69.120089] [008/155] (952s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc)
[69.218731] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc
[69.222983] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[69.316468] [009/155] (952s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-shrfb-pgflip-blt)
[69.416490] Starting subtest: psrhdr-1p-primscrn-shrfb-pgflip-blt
[69.420683] Subtest psrhdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[69.535500] [010/155] (952s left) gem_mmap_wc (bad-object)
[69.596707] Subtest bad-object: SKIP (0.000s)
[69.657909] [011/155] (952s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[69.718469] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[69.780683] [012/155] (951s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[69.882592] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[77.356937] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.483s)
[77.459129] [013/155] (944s left) gem_exec_schedule (wide)
[77.637788] Starting subtest: wide
[77.644810] Starting dynamic subtest: rcs0
[87.499190] Dynamic subtest rcs0: SUCCESS (9.860s)
[87.516955] Starting dynamic subtest: vcs0
[98.284085] Dynamic subtest vcs0: SUCCESS (10.786s)
[98.293106] Starting dynamic subtest: vcs1
[110.701512] Dynamic subtest vcs1: SUCCESS (12.416s)
[110.712736] Starting dynamic subtest: vecs0
[121.931359] Dynamic subtest vecs0: SUCCESS (11.230s)
[121.943715] Starting dynamic subtest: ccs0
[136.501555] Dynamic subtest ccs0: SUCCESS (14.569s)
[136.504352] Subtest wide: SUCCESS (58.863s)
[138.297908] [014/155] (883s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[138.417925] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[138.422631] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[138.516827] [015/155] (883s left) gem_vm_create (invalid-create)
[138.573681] Starting subtest: invalid-create
[138.575988] Subtest invalid-create: SUCCESS (0.002s)
[138.695099] [016/155] (883s left) kms_plane_cursor (primary)
[138.784996] Starting subtest: primary
[138.789073] Starting dynamic subtest: pipe-A-eDP-1-size-64
[141.325646] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.542s)
[141.349601] Starting dynamic subtest: pipe-A-eDP-1-size-128
[143.915781] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.572s)
[143.938989] Starting dynamic subtest: pipe-A-eDP-1-size-256
[146.516314] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.583s)
[146.835375] Starting dynamic subtest: pipe-B-eDP-1-size-64
[150.121525] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.296s)
[150.146507] Starting dynamic subtest: pipe-B-eDP-1-size-128
[152.733160] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.594s)
[152.756635] Starting dynamic subtest: pipe-B-eDP-1-size-256
[155.303663] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.552s)
[155.637215] Starting dynamic subtest: pipe-C-eDP-1-size-64
[158.559488] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.934s)
[158.585949] Starting dynamic subtest: pipe-C-eDP-1-size-128
[160.792316] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.214s)
[160.818334] Starting dynamic subtest: pipe-C-eDP-1-size-256
[162.992275] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.181s)
[163.315686] Starting dynamic subtest: pipe-D-eDP-1-size-64
[166.340762] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.037s)
[166.367103] Starting dynamic subtest: pipe-D-eDP-1-size-128
[168.541386] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.181s)
[168.567809] Starting dynamic subtest: pipe-D-eDP-1-size-256
[170.773949] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.214s)
[171.086824] Subtest primary: SUCCESS (32.300s)
[171.933935] [017/155] (849s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[172.035789] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[172.039801] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[172.154491] [018/155] (849s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[172.247759] Starting subtest: fbc-rgb565-draw-mmap-wc
[176.265877] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.023s)
[177.451424] [019/155] (844s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-onoff)
[177.551797] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-onoff
[177.556316] Subtest psrhdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[177.641312] [020/155] (844s left) i915_hangman (error-state-basic)
[177.708195] Starting subtest: error-state-basic
[177.862841] Subtest error-state-basic: SUCCESS (0.155s)
[177.947612] [021/155] (844s left) kms_cursor_edge_walk (256x256-top-edge)
[178.042739] Starting subtest: 256x256-top-edge
[178.045471] Starting dynamic subtest: pipe-A-eDP-1
[181.511118] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.471s)
[181.520088] Starting dynamic subtest: pipe-D-eDP-1
[184.733847] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.220s)
[184.736055] Subtest 256x256-top-edge: SUCCESS (6.694s)
[185.543062] [022/155] (836s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[185.643330] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[185.651091] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.010s)
[185.759378] [023/155] (836s left) kms_big_fb (linear-8bpp-rotate-90)
[185.858910] Starting subtest: linear-8bpp-rotate-90
[185.879384] Subtest linear-8bpp-rotate-90: SKIP (0.020s)
[185.980439] [024/155] (836s left) drm_buddy (drm_buddy)
[186.012914] Starting subtest: drm_buddy
[186.017371] Subtest drm_buddy: SKIP (0.001s)
[186.069754] [025/155] (836s left) kms_pm_rpm (modeset-lpsp)
[187.604787] Starting subtest: modeset-lpsp
[189.083916] Subtest modeset-lpsp: SUCCESS (1.484s)
[189.204640] [026/155] (833s left) kms_lease (lease-unleased-connector)
[189.291184] Starting subtest: lease-unleased-connector
[189.293558] Starting dynamic subtest: pipe-A-eDP-1
[189.298453] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.009s)
[189.307556] Starting dynamic subtest: pipe-B-eDP-1
[189.309902] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s)
[189.320568] Starting dynamic subtest: pipe-C-eDP-1
[189.322844] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[189.331581] Starting dynamic subtest: pipe-D-eDP-1
[189.333418] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[189.335319] Subtest lease-unleased-connector: SUCCESS (0.034s)
[189.434786] [027/155] (832s left) kms_psr (fbc-psr-primary-blt)
[189.535616] Starting subtest: fbc-psr-primary-blt
[189.537980] Starting dynamic subtest: eDP-1
[189.542476] Dynamic subtest eDP-1: SKIP (0.000s)
[189.546763] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[189.610348] [028/155] (832s left) kms_frontbuffer_tracking (hdr-1p-primscrn-indfb-pgflip-blt)
[189.713653] Starting subtest: hdr-1p-primscrn-indfb-pgflip-blt
[189.717991] Subtest hdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[189.829392] [029/155] (832s left) gem_exec_fence (concurrent)
[190.009819] Starting subtest: concurrent
[190.014203] Subtest concurrent: SKIP (0.000s)
[191.365086] [030/155] (831s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[191.460891] Starting subtest: fbcpsr-rgb565-draw-blt
[198.519958] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.064s)
[198.665490] [031/155] (823s left) gem_pwrite_snooped
[198.792366] [032/155] (823s left) prime_self_import (reimport-vs-gem_close-race)
[198.825392] Starting subtest: reimport-vs-gem_close-race
[203.913395] Subtest reimport-vs-gem_close-race: SUCCESS (5.088s)
[203.988860] [033/155] (818s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[204.081777] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[204.086129] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[204.159776] [034/155] (818s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[204.257737] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[211.056906] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.805s)
[211.201168] [035/155] (811s left) api_intel_allocator (execbuf-with-allocator)
[211.256462] Starting subtest: execbuf-with-allocator
[211.259805] Subtest execbuf-with-allocator: SUCCESS (0.006s)
[211.373520] [036/155] (811s left) gem_partial_pwrite_pread (writes-after-reads)
[211.429568] Subtest writes-after-reads: SKIP (0.000s)
[211.502081] [037/155] (811s left) gem_tiled_swapping (non-threaded)
[211.560841] Subtest non-threaded: SKIP (0.000s)
[211.619587] [038/155] (811s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[211.721901] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[211.726099] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[211.814868] [039/155] (810s left) gem_ctx_isolation (preservation-s3)
[211.876984] Starting subtest: preservation-S3
[211.879215] Starting dynamic subtest: rcs0
[227.848950] Dynamic subtest rcs0: SUCCESS (1.431s)
[227.862448] Starting dynamic subtest: bcs0
[243.833612] Dynamic subtest bcs0: SUCCESS (1.339s)
[243.846063] Starting dynamic subtest: vcs0
[259.830114] Dynamic subtest vcs0: SUCCESS (2.743s)
[259.842910] Starting dynamic subtest: vcs1
[277.850131] Dynamic subtest vcs1: SUCCESS (5.055s)
[277.863332] Starting dynamic subtest: vecs0
[295.849822] Dynamic subtest vecs0: SUCCESS (4.999s)
[295.862677] Starting dynamic subtest: ccs0
[313.849815] Dynamic subtest ccs0: SUCCESS (3.214s)
[313.852163] Subtest preservation-S3: SUCCESS (18.788s)
[314.066785] [040/155] (708s left) gem_create (create-valid-nonaligned)
[314.125433] Starting subtest: create-valid-nonaligned
[314.128056] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[314.321902] [041/155] (708s left) gem_create (create-clear)
[314.371158] Starting subtest: create-clear
[314.373396] Starting dynamic subtest: smem0
[347.000556] Dynamic subtest smem0: SUCCESS (32.688s)
[347.002607] Subtest create-clear: SUCCESS (32.690s)
[347.193671] [042/155] (675s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[347.314885] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[347.319284] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s)
[347.459421] [043/155] (675s left) kms_flip (2x-busy-flip)
[347.543724] Starting subtest: 2x-busy-flip
[347.552624] Subtest 2x-busy-flip: SKIP (0.011s)
[347.631569] [044/155] (675s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[347.735453] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[347.740039] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[347.844134] [045/155] (675s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[347.951987] Starting subtest: cursorA-vs-flipA-atomic
[359.101268] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.146s)
[359.960113] [046/155] (663s left) gem_userptr_blits (dmabuf-unsync)
[360.021818] Subtest dmabuf-unsync: SKIP (0.000s)
[360.147454] [047/155] (662s left) gem_eio (wait-1us)
[360.370154] Starting subtest: wait-1us
[360.714231] Subtest wait-1us: SUCCESS (0.344s)
[360.863716] [048/155] (662s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-mmap-gtt)
[360.952451] Starting subtest: psrhdr-rgb565-draw-mmap-gtt
[360.956061] Subtest psrhdr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[361.050958] [049/155] (662s left) perf (disabled-read-error)
[361.158749] Starting subtest: disabled-read-error
[361.173855] Subtest disabled-read-error: SUCCESS (0.017s)
[361.214596] [050/155] (662s left) gem_exec_whisper (basic-queues-priority)
[361.281955] Starting subtest: basic-queues-priority
[384.525677] Subtest basic-queues-priority: SUCCESS (23.246s)
[384.723917] [051/155] (638s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[384.826831] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[384.829148] Starting dynamic subtest: pipe-A-eDP-1
[385.301331] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.446s)
[385.314656] Starting dynamic subtest: pipe-B-eDP-1
[386.782397] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.479s)
[386.794633] Starting dynamic subtest: pipe-C-eDP-1
[388.149633] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.366s)
[388.162689] Starting dynamic subtest: pipe-D-eDP-1
[389.489735] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.339s)
[389.492079] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.635s)
[390.682884] [052/155] (632s left) kms_invalid_mode (bad-hsync-end)
[390.771003] Starting subtest: bad-hsync-end
[390.773377] Starting dynamic subtest: pipe-A-eDP-1
[391.051447] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[391.063387] Starting dynamic subtest: pipe-B-eDP-1
[391.065475] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[391.076343] Starting dynamic subtest: pipe-C-eDP-1
[391.078717] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[391.089480] Starting dynamic subtest: pipe-D-eDP-1
[391.092141] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[391.094519] Subtest bad-hsync-end: SUCCESS (0.289s)
[391.908484] [053/155] (631s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[392.005896] Starting subtest: psr-rgb565-draw-pwrite
[398.952428] Subtest psr-rgb565-draw-pwrite: SUCCESS (6.954s)
[399.059876] [054/155] (624s left) syncobj_timeline (host-signal-points)
[399.120070] Starting subtest: host-signal-points
[399.125260] Subtest host-signal-points: SUCCESS (0.004s)
[399.220657] [055/155] (624s left) kms_chamelium_hpd (hdmi-hpd-fast)
[399.589300] Subtest hdmi-hpd-fast: SKIP (0.000s)
[400.444125] [056/155] (623s left) gem_eio (kms)
[400.704606] Starting subtest: kms
[419.345982] Subtest kms: SUCCESS (18.640s)
[419.470554] [057/155] (604s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[419.576231] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[419.580142] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[419.683096] [058/155] (603s left) gem_fence_thrash (bo-write-verify-x)
[419.718352] Starting subtest: bo-write-verify-x
[419.754865] Subtest bo-write-verify-x: SKIP (0.035s)
[419.812874] [059/155] (603s left) kms_atomic_transition (plane-all-transition-nonblocking)
[419.912047] Starting subtest: plane-all-transition-nonblocking
[419.914311] Starting dynamic subtest: pipe-A-eDP-1
[422.405190] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[422.724476] Starting dynamic subtest: pipe-B-eDP-1
[425.939579] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.227s)
[426.239488] Subtest plane-all-transition-nonblocking: SUCCESS (6.327s)
[427.052986] [060/155] (596s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[427.174698] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[427.178833] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[427.297694] [061/155] (596s left) gem_media_vme
[427.424108] [062/155] (596s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[427.518662] Starting subtest: bad-aux-stride-yf-tiled-ccs
[427.520928] Starting dynamic subtest: pipe-A-eDP-1
[427.543787] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[427.555761] Starting dynamic subtest: pipe-B-eDP-1
[427.577381] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[427.587433] Starting dynamic subtest: pipe-C-eDP-1
[427.608928] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[427.618493] Starting dynamic subtest: pipe-D-eDP-1
[427.640629] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[427.645137] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.006s)
[429.846365] [063/155] (593s left) perf (gen8-unprivileged-single-ctx-counters)
[429.952194] Starting subtest: gen8-unprivileged-single-ctx-counters
[429.956607] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[429.995977] [064/155] (593s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[430.082766] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[430.108481] Starting dynamic subtest: pipe-A-plane-0
[430.508341] Dynamic subtest pipe-A-plane-0: SUCCESS (0.400s)
[430.519013] Starting dynamic subtest: pipe-A-plane-3
[430.864266] Dynamic subtest pipe-A-plane-3: SUCCESS (0.355s)
[432.019330] Starting dynamic subtest: pipe-B-plane-0
[432.421217] Dynamic subtest pipe-B-plane-0: SUCCESS (0.411s)
[432.435773] Starting dynamic subtest: pipe-B-plane-3
[432.756111] Dynamic subtest pipe-B-plane-3: SUCCESS (0.332s)
[433.063438] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (2.980s)
[433.907952] [065/155] (589s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-blt)
[434.017118] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-blt
[434.021351] Subtest hdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[434.134457] [066/155] (589s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[434.240593] Starting subtest: plane-upscale-factor-0-25-with-rotation
[434.243007] Starting dynamic subtest: pipe-A
[434.466807] Dynamic subtest pipe-A: SUCCESS (0.226s)
[434.480116] Starting dynamic subtest: pipe-B
[435.768248] Dynamic subtest pipe-B: SUCCESS (1.300s)
[435.779548] Starting dynamic subtest: pipe-C
[437.101972] Dynamic subtest pipe-C: SUCCESS (1.333s)
[437.114212] Starting dynamic subtest: pipe-D
[438.435607] Dynamic subtest pipe-D: SUCCESS (1.333s)
[438.437873] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.196s)
[439.638327] [067/155] (584s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[439.737000] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[439.741464] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[439.847130] [068/155] (584s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[439.962900] Starting subtest: short-busy-flip-before-cursor-toggle
[439.967302] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[440.106742] [069/155] (583s left) sriov_basic (enable-vfs-bind-unbind-each)
[440.163325] Starting subtest: enable-vfs-bind-unbind-each
[440.165630] Starting dynamic subtest: numvfs-1
[440.170078] Dynamic subtest numvfs-1: SKIP (0.001s)
[440.181013] Starting dynamic subtest: numvfs-2
[440.185066] Dynamic subtest numvfs-2: SKIP (0.001s)
[440.197419] Starting dynamic subtest: numvfs-3
[440.201682] Dynamic subtest numvfs-3: SKIP (0.001s)
[440.213713] Starting dynamic subtest: numvfs-4
[440.217895] Dynamic subtest numvfs-4: SKIP (0.001s)
[440.228263] Starting dynamic subtest: numvfs-5
[440.232707] Dynamic subtest numvfs-5: SKIP (0.001s)
[440.243206] Starting dynamic subtest: numvfs-6
[440.247610] Dynamic subtest numvfs-6: SKIP (0.000s)
[440.257841] Starting dynamic subtest: numvfs-7
[440.262268] Dynamic subtest numvfs-7: SKIP (0.000s)
[440.272376] Starting dynamic subtest: numvfs-random
[440.276772] Dynamic subtest numvfs-random: SKIP (0.000s)
[440.281171] Subtest enable-vfs-bind-unbind-each: SKIP (0.009s)
[440.320290] [070/155] (583s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-blt)
[440.423353] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-blt
[440.427600] Subtest fbchdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[440.519453] [071/155] (583s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[440.627102] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[440.630407] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[440.696598] [072/155] (583s left) kms_chamelium_frames (hdmi-crc-fast)
[441.074812] Subtest hdmi-crc-fast: SKIP (0.000s)
[441.930423] [073/155] (582s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[442.034922] Starting subtest: fbc-psr2-cursor-mmap-gtt
[442.036889] Starting dynamic subtest: eDP-1
[442.040993] Dynamic subtest eDP-1: SKIP (0.000s)
[442.045212] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[442.110407] [074/155] (582s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[442.205483] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc
[442.209829] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[442.329472] [075/155] (581s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[442.432129] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[442.436271] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[442.541897] [076/155] (581s left) kms_psr (pr-primary-render)
[442.641608] Starting subtest: pr-primary-render
[442.645715] Subtest pr-primary-render: SKIP (0.000s)
[442.719998] [077/155] (581s left) gem_exec_reloc (basic-wc-read-active)
[442.779905] Subtest basic-wc-read-active: SKIP (0.000s)
[442.844340] [078/155] (581s left) kms_hdmi_inject (inject-audio)
[443.180019] Starting subtest: inject-audio
[443.473341] Subtest inject-audio: SUCCESS (0.294s)
[444.104953] [079/155] (580s left) i915_pm_rps (thresholds)
[444.164931] Starting subtest: thresholds
[444.169668] Subtest thresholds: SKIP (0.001s)
[444.269312] [080/155] (580s left) gem_tiled_blits (basic)
[444.330576] Subtest basic: SKIP (0.000s)
[444.413943] [081/155] (580s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[444.517862] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[444.522663] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[444.613496] [082/155] (580s left) gem_ctx_persistence (hostile)
[444.670420] Starting subtest: hostile
[454.165438] Subtest hostile: SUCCESS (9.491s)
[454.298887] [083/155] (570s left) kms_plane_multiple (2x-tiling-y)
[454.391493] Starting subtest: 2x-tiling-y
[454.395686] Subtest 2x-tiling-y: SKIP (0.000s)
[454.464254] [084/155] (570s left) gem_mmap_gtt (fault-concurrent)
[454.524647] Subtest fault-concurrent: SKIP (0.000s)
[454.588793] [085/155] (570s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-indfb-msflip-blt)
[454.698191] Starting subtest: fbcpsrhdr-2p-scndscrn-indfb-msflip-blt
[454.702282] Subtest fbcpsrhdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[454.797740] [086/155] (569s left) gen9_exec_parse (bb-secure)
[454.848832] Subtest bb-secure: SKIP (0.000s)
[454.931009] [087/155] (569s left) kms_plane_scaling (invalid-num-scalers)
[455.023962] Starting subtest: invalid-num-scalers
[455.026155] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[455.042202] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.017s)
[455.055203] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[455.072836] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.029s)
[455.083864] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[455.104209] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.029s)
[455.115228] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[455.134367] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.029s)
[455.136627] Subtest invalid-num-scalers: SUCCESS (0.111s)
[455.240560] [088/155] (569s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[455.338946] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[455.342416] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[455.462575] [089/155] (569s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[455.567773] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[462.229986] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.668s)
[462.367996] [090/155] (562s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-blt)
[462.474593] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-blt
[462.478774] Subtest hdr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[462.594651] [091/155] (562s left) gem_ccs (block-copy-compressed)
[462.653621] Starting subtest: block-copy-compressed
[462.657854] Subtest block-copy-compressed: SKIP (0.000s)
[462.759665] [092/155] (562s left) kms_psr (fbc-pr-cursor-blt)
[462.848929] Starting subtest: fbc-pr-cursor-blt
[462.853178] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[462.921671] [093/155] (562s left) gem_workarounds (reset-context)
[462.988312] Starting subtest: reset-context
[463.141188] Subtest reset-context: SUCCESS (0.152s)
[463.264308] [094/155] (561s left) gem_exec_balancer (bonded-dual)
[463.315783] Starting subtest: bonded-dual
[463.319763] Subtest bonded-dual: SKIP (0.000s)
[463.630603] [095/155] (561s left) gem_exec_nop (basic-series)
[463.694742] Starting subtest: basic-series
[479.577802] Subtest basic-series: SUCCESS (15.892s)
[479.809666] [096/155] (545s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-render)
[479.917142] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-render
[479.921178] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[480.018588] [097/155] (545s left) perf_pmu (init-busy)
[480.056796] Starting subtest: init-busy
[480.059265] Starting dynamic subtest: rcs0
[480.061600] Dynamic subtest rcs0: SUCCESS (0.001s)
[480.074315] Starting dynamic subtest: bcs0
[480.076598] Dynamic subtest bcs0: SUCCESS (0.000s)
[480.088061] Starting dynamic subtest: vcs0
[480.090280] Dynamic subtest vcs0: SUCCESS (0.000s)
[480.100637] Starting dynamic subtest: vcs1
[480.102821] Dynamic subtest vcs1: SUCCESS (0.000s)
[480.113848] Starting dynamic subtest: vecs0
[480.115767] Dynamic subtest vecs0: SUCCESS (0.000s)
[480.128271] Starting dynamic subtest: ccs0
[480.130731] Dynamic subtest ccs0: SUCCESS (0.000s)
[480.132914] Subtest init-busy: SUCCESS (0.007s)
[480.175091] [098/155] (545s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[480.265949] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[486.916763] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.656s)
[487.062830] [099/155] (538s left) kms_vblank (wait-idle-hang)
[487.157708] Starting subtest: wait-idle-hang
[487.159999] Starting dynamic subtest: pipe-A-eDP-1
[513.379320] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.225s)
[513.396108] Starting dynamic subtest: pipe-D-eDP-1
[528.352167] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.978s)
[528.354631] Subtest wait-idle-hang: SUCCESS (41.208s)
[529.165972] [100/155] (496s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[529.263468] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[529.267889] Subtest hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[529.379649] [101/155] (496s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[529.472901] Starting subtest: random-ccs-data-y-tiled-ccs
[529.475171] Starting dynamic subtest: pipe-A-eDP-1
[529.500026] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[529.512465] Starting dynamic subtest: pipe-B-eDP-1
[529.536445] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[529.546914] Starting dynamic subtest: pipe-C-eDP-1
[529.570853] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[529.580787] Starting dynamic subtest: pipe-D-eDP-1
[529.604714] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[529.609021] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s)
[531.748446] [102/155] (493s left) i915_drm_fdinfo (busy-check-all)
[531.789821] Starting subtest: busy-check-all
[531.791945] Starting dynamic subtest: rcs0
[531.796931] Dynamic subtest rcs0: SKIP (0.005s)
[531.808323] Starting dynamic subtest: bcs0
[531.813014] Dynamic subtest bcs0: SKIP (0.000s)
[531.823536] Starting dynamic subtest: vcs0
[531.828248] Dynamic subtest vcs0: SKIP (0.000s)
[531.840715] Starting dynamic subtest: vcs1
[531.845287] Dynamic subtest vcs1: SKIP (0.000s)
[531.856301] Starting dynamic subtest: vecs0
[531.860828] Dynamic subtest vecs0: SKIP (0.000s)
[531.874193] Starting dynamic subtest: ccs0
[531.879101] Dynamic subtest ccs0: SKIP (0.000s)
[531.883695] Subtest busy-check-all: SKIP (0.012s)
[531.923426] [103/155] (493s left) syncobj_basic (bad-flags-handle-to-fd)
[532.012584] Starting subtest: bad-flags-handle-to-fd
[532.015272] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[532.130735] [104/155] (493s left) kms_content_protection (dp-mst-type-1)
[532.266403] Starting subtest: dp-mst-type-1
[532.271068] Subtest dp-mst-type-1: SKIP (0.000s)
[532.373601] [105/155] (493s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[532.468261] Starting subtest: 4-tiled-16bpp-rotate-0
[533.833351] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.367s)
[533.970358] [106/155] (491s left) gem_exec_params (invalid-fence-in)
[534.032142] Starting subtest: invalid-fence-in
[534.033989] Subtest invalid-fence-in: SUCCESS (0.000s)
[534.151076] [107/155] (491s left) gem_mmap_gtt (flink-race)
[534.207235] Subtest flink-race: SKIP (0.000s)
[534.281478] [108/155] (491s left) syncobj_timeline (invalid-signal-illegal-point)
[534.336128] Starting subtest: invalid-signal-illegal-point
[534.338038] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[534.426258] [109/155] (491s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-pgflip-blt)
[534.532757] Starting subtest: fbchdr-1p-primscrn-indfb-pgflip-blt
[534.536336] Subtest fbchdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[534.626713] [110/155] (491s left) kms_panel_fitting (legacy)
[534.724076] Starting subtest: legacy
[534.726047] Starting dynamic subtest: pipe-A-eDP-1
[535.234590] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.512s)
[535.262792] Starting dynamic subtest: pipe-B-eDP-1
[536.736185] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.483s)
[536.764447] Starting dynamic subtest: pipe-C-eDP-1
[538.230240] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.474s)
[538.258251] Starting dynamic subtest: pipe-D-eDP-1
[539.736028] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.487s)
[539.738252] Subtest legacy: SUCCESS (5.013s)
[540.964083] [111/155] (484s left) i915_suspend (debugfs-reader)
[541.026143] Starting subtest: debugfs-reader
[558.807709] Subtest debugfs-reader: SUCCESS (3.168s)
[558.909614] [112/155] (467s left) kms_psr (psr-cursor-plane-move)
[559.013690] Starting subtest: psr-cursor-plane-move
[559.015982] Starting dynamic subtest: eDP-1
[560.789998] Dynamic subtest eDP-1: SUCCESS (1.783s)
[560.792464] Subtest psr-cursor-plane-move: SUCCESS (1.784s)
[561.613053] [113/155] (464s left) gem_exec_schedule (pi-ringfull)
[561.793962] Starting subtest: pi-ringfull
[561.796505] Starting dynamic subtest: rcs0
[561.827076] Dynamic subtest rcs0: SUCCESS (0.035s)
[561.841827] Starting dynamic subtest: bcs0
[561.860065] Dynamic subtest bcs0: SUCCESS (0.032s)
[561.874967] Starting dynamic subtest: vcs0
[561.891788] Dynamic subtest vcs0: SUCCESS (0.031s)
[561.907084] Starting dynamic subtest: vcs1
[561.921623] Dynamic subtest vcs1: SUCCESS (0.029s)
[561.938108] Starting dynamic subtest: vecs0
[561.950419] Dynamic subtest vecs0: SUCCESS (0.028s)
[561.965066] Starting dynamic subtest: ccs0
[561.979650] Dynamic subtest ccs0: SUCCESS (0.029s)
[561.982052] Subtest pi-ringfull: SUCCESS (0.189s)
[562.200902] [114/155] (463s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[562.251527] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[562.358036] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.107s)
[562.436115] [115/155] (463s left) gem_ctx_param (get-priority-new-ctx)
[562.486658] Starting subtest: get-priority-new-ctx
[562.489187] Subtest get-priority-new-ctx: SUCCESS (0.002s)
[562.622047] [116/155] (463s left) api_intel_bb (lot-of-buffers)
[562.679719] Starting subtest: lot-of-buffers
[563.695033] Subtest lot-of-buffers: SUCCESS (1.019s)
[564.236453] [117/155] (461s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[564.330967] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[565.427853] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.101s)
[565.538278] [118/155] (460s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[565.628687] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[565.633182] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[566.803640] [119/155] (459s left) kms_prime (basic-crc-hybrid)
[566.883735] Subtest basic-crc-hybrid: SKIP (0.000s)
[567.001423] [120/155] (459s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[567.098809] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[567.101059] Starting dynamic subtest: pipe-A-eDP-1
[583.033861] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.411s)
[583.045756] Starting dynamic subtest: pipe-B-eDP-1
[599.977274] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.451s)
[599.994269] Starting dynamic subtest: pipe-C-eDP-1
[616.953023] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.364s)
[616.967162] Starting dynamic subtest: pipe-D-eDP-1
[633.925406] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.346s)
[633.927669] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.576s)
[635.111861] [121/155] (391s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[635.164101] Starting subtest: multi-wait-for-submit-submitted-signaled
[635.166462] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[635.256679] [122/155] (391s left) prime_vgem (basic-gtt)
[635.329783] Starting subtest: basic-gtt
[635.334170] Subtest basic-gtt: SKIP (0.000s)
[635.420549] [123/155] (390s left) gem_exec_fence (syncobj-timeline-wait)
[635.977558] Starting subtest: syncobj-timeline-wait
[637.515814] Subtest syncobj-timeline-wait: SUCCESS (1.546s)
[639.595272] [124/155] (386s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[639.701863] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[640.501713] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.804s)
[640.664933] [125/155] (385s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[640.735476] Starting subtest: map-fixed-invalidate-overlap-busy
[640.739617] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[640.865616] [126/155] (385s left) gem_softpin (32b-excludes-last-page)
[640.925565] Starting subtest: 32b-excludes-last-page
[640.931414] Subtest 32b-excludes-last-page: SUCCESS (0.004s)
[641.066092] [127/155] (385s left) gem_exec_schedule (semaphore-codependency)
[641.136368] Starting subtest: semaphore-codependency
[641.141227] Subtest semaphore-codependency: SUCCESS (0.012s)
[641.472494] [128/155] (385s left) gem_pxp (hw-rejects-pxp-context)
[641.591511] Starting subtest: hw-rejects-pxp-context
[641.596088] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[641.710953] [129/155] (384s left) gem_spin_batch (spin-all-new)
[641.776192] Starting subtest: spin-all-new
[641.790601] Subtest spin-all-new: SUCCESS (0.014s)
[643.540430] [130/155] (383s left) kms_cursor_crc (cursor-offscreen-512x512)
[643.806932] Starting subtest: cursor-offscreen-512x512
[643.811285] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[643.960941] [131/155] (382s left) syncobj_timeline (wait-all-for-submit-complex)
[644.025169] Starting subtest: wait-all-for-submit-complex
[644.238257] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[644.320279] [132/155] (382s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[644.404691] Starting subtest: plane-lut1d-post-ctm3x4
[644.540024] Starting dynamic subtest: pipe-A-plane-0
[644.683733] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[644.696830] Starting dynamic subtest: pipe-A-plane-1
[644.850130] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[644.861247] Starting dynamic subtest: pipe-A-plane-2
[644.984911] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[646.163158] Starting dynamic subtest: pipe-B-plane-0
[646.307622] Dynamic subtest pipe-B-plane-0: SUCCESS (0.155s)
[646.320062] Starting dynamic subtest: pipe-B-plane-1
[646.485541] Dynamic subtest pipe-B-plane-1: SUCCESS (0.177s)
[646.499759] Starting dynamic subtest: pipe-B-plane-2
[646.629915] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[647.830059] Starting dynamic subtest: pipe-C-plane-0
[647.964359] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[647.976954] Starting dynamic subtest: pipe-C-plane-1
[648.108841] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[648.123701] Starting dynamic subtest: pipe-C-plane-2
[648.263858] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[649.438492] Starting dynamic subtest: pipe-D-plane-0
[649.573207] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[649.585292] Starting dynamic subtest: pipe-D-plane-1
[649.739702] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[649.751016] Starting dynamic subtest: pipe-D-plane-2
[649.895359] Dynamic subtest pipe-D-plane-2: SUCCESS (0.154s)
[650.178632] Subtest plane-lut1d-post-ctm3x4: SUCCESS (5.784s)
[651.084575] [133/155] (375s left) kms_universal_plane (cursor-fb-leak)
[651.175275] Starting subtest: cursor-fb-leak
[651.177594] Starting dynamic subtest: pipe-A-eDP-1
[651.492226] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.319s)
[651.506212] Starting dynamic subtest: pipe-B-eDP-1
[652.847862] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.356s)
[652.863212] Starting dynamic subtest: pipe-C-eDP-1
[654.223287] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.375s)
[654.239216] Starting dynamic subtest: pipe-D-eDP-1
[655.543264] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.319s)
[655.545530] Subtest cursor-fb-leak: SUCCESS (4.376s)
[656.781417] [134/155] (370s left) gem_mmap_gtt (basic-small-copy)
[656.845041] Subtest basic-small-copy: SKIP (0.000s)
[656.904389] [135/155] (370s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[657.009089] Starting subtest: x-tiled-64bpp-rotate-180
[658.463930] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.456s)
[658.643441] [136/155] (368s left) kms_cursor_crc (cursor-random-32x32)
[658.785072] Starting subtest: cursor-random-32x32
[658.837688] Subtest cursor-random-32x32: SKIP (0.046s)
[659.109867] [137/155] (367s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[659.215912] Starting subtest: psr-2p-primscrn-cur-indfb-move
[659.219980] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[659.322296] [138/155] (367s left) gem_tiled_fence_blits (basic)
[659.377477] Subtest basic: SKIP (0.000s)
[659.443063] [139/155] (367s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[659.524755] Starting subtest: invalidate-primary-flip-overlay
[670.207921] Subtest invalidate-primary-flip-overlay: SUCCESS (10.685s)
[670.334007] [140/155] (356s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[670.434990] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[670.438398] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[670.518894] [141/155] (356s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[670.621136] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[670.624807] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[670.713160] [142/155] (356s left) perf_pmu (busy-double-start)
[670.750635] Starting subtest: busy-double-start
[670.752449] Starting dynamic subtest: rcs0
[674.395744] Dynamic subtest rcs0: FAIL (3.587s)
[674.410440] Starting dynamic subtest: bcs0
[677.928654] Dynamic subtest bcs0: SUCCESS (3.588s)
[677.942114] Starting dynamic subtest: vcs0
[682.039752] Dynamic subtest vcs0: SUCCESS (4.109s)
[682.058642] Starting dynamic subtest: vcs1
[686.018867] Dynamic subtest vcs1: SUCCESS (3.977s)
[686.031570] Starting dynamic subtest: vecs0
[690.056917] Dynamic subtest vecs0: SUCCESS (4.036s)
[690.071394] Starting dynamic subtest: ccs0
[693.696228] Dynamic subtest ccs0: FAIL (3.569s)
[693.698077] Subtest busy-double-start: FAIL (22.877s)
[693.747805] [143/155] (333s left) kms_async_flips (alternate-sync-async-flip)
[693.852991] Starting subtest: alternate-sync-async-flip
[694.226544] Starting dynamic subtest: pipe-A-eDP-1
[697.007273] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.783s)
[697.388861] Starting dynamic subtest: pipe-B-eDP-1
[700.214690] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.838s)
[700.586520] Starting dynamic subtest: pipe-C-eDP-1
[703.403484] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.829s)
[703.771526] Starting dynamic subtest: pipe-D-eDP-1
[706.614692] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.855s)
[706.616860] Subtest alternate-sync-async-flip: SUCCESS (12.768s)
[707.855973] [144/155] (319s left) kms_flip (2x-flip-vs-suspend-interruptible)
[707.956695] Starting subtest: 2x-flip-vs-suspend-interruptible
[707.961247] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.002s)
[708.060350] [145/155] (319s left) kms_joiner (basic-ultra-joiner)
[708.163529] Starting subtest: basic-ultra-joiner
[708.167661] Subtest basic-ultra-joiner: SKIP (0.000s)
[708.228702] [146/155] (319s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[708.318798] Starting subtest: fbc-farfromfence-mmap-gtt
[708.323189] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[708.423651] [147/155] (319s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[708.531023] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[712.072324] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.548s)
[713.265494] [148/155] (314s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt)
[713.362877] Starting subtest: fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt
[713.367196] Subtest fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[713.461985] [149/155] (314s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[713.569317] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[713.573571] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[713.684966] [150/155] (313s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-move)
[713.786097] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-move
[713.790278] Subtest fbchdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[713.907003] [151/155] (313s left) prime_mmap (test_invalid_sync_flags)
[713.965992] Starting subtest: test_invalid_sync_flags
[713.968364] Starting dynamic subtest: test_invalid_sync_flags-smem
[713.970516] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[713.972658] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[714.096713] [152/155] (313s left) perf (invalid-remove-userspace-config)
[714.185011] Starting subtest: invalid-remove-userspace-config
[714.194607] Subtest invalid-remove-userspace-config: SUCCESS (0.009s)
[714.241617] [153/155] (313s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[714.339680] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[714.343507] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[714.413949] [154/155] (313s left) kms_frontbuffer_tracking (fbcpsrhdr-suspend)
[714.512105] Starting subtest: fbcpsrhdr-suspend
[714.515474] Subtest fbcpsrhdr-suspend: SKIP (0.000s)
[714.626361] [155/155] (313s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-gtt)
[714.732724] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-gtt
[714.735993] Subtest fbcpsrhdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[714.838461] 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.