[73.963316] Initializing watchdogs
[73.963369]   /dev/watchdog0
[73.980148] [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]
[73.984689] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[73.987185] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[73.990865] [001/155] (960s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-pri-indfb-multidraw)
[74.117120] Starting subtest: fbcpsrhdr-1p-pri-indfb-multidraw
[74.121247] Subtest fbcpsrhdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[74.221831] [002/155] (960s left) gem_exec_fence (submit)
[74.392725] Starting subtest: submit
[74.397633] Subtest submit: SKIP (0.000s)
[76.413302] [FACT gem_exec_fence (submit)] new: kernel.kmod_is_loaded.vgem: true
[76.416580] [003/155] (958s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[76.516134] Starting subtest: psr2-cursor-plane-update-sf
[76.518462] Starting dynamic subtest: pipe-A-eDP-1
[77.136321] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.626s)
[77.145397] Starting dynamic subtest: pipe-B-eDP-1
[78.413473] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.276s)
[78.415643] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.904s)
[79.303212] [004/155] (955s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-pwrite)
[79.406601] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-pwrite
[79.411065] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[79.504800] [005/155] (955s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[79.593445] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[79.595655] Starting dynamic subtest: pipe-A-eDP-1
[79.617781] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[79.627548] Starting dynamic subtest: pipe-B-eDP-1
[79.648495] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[79.656072] Starting dynamic subtest: pipe-C-eDP-1
[79.677219] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[79.684490] Starting dynamic subtest: pipe-D-eDP-1
[79.706269] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[79.710609] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[81.868790] [006/155] (952s left) gem_exec_params (invalid-bsd-ring)
[81.931068] Starting subtest: invalid-bsd-ring
[81.932913] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[82.022112] [007/155] (952s left) kms_feature_discovery (dp-mst)
[82.110896] Starting subtest: dp-mst
[82.115325] Subtest dp-mst: SKIP (0.000s)
[82.188924] [008/155] (952s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc)
[82.287771] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc
[82.291649] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[82.381694] [009/155] (952s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-shrfb-pgflip-blt)
[82.477598] Starting subtest: psrhdr-1p-primscrn-shrfb-pgflip-blt
[82.481783] Subtest psrhdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[82.565980] [010/155] (952s left) gem_mmap_wc (bad-object)
[82.619446] Subtest bad-object: SKIP (0.000s)
[82.672892] [011/155] (952s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[82.726821] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[82.792338] [012/155] (952s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[82.887175] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[90.059051] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.176s)
[90.175236] [013/155] (944s left) gem_exec_schedule (wide)
[90.360050] Starting subtest: wide
[90.362481] Starting dynamic subtest: rcs0
[100.493631] Dynamic subtest rcs0: SUCCESS (10.133s)
[100.513114] Starting dynamic subtest: vcs0
[110.021903] Dynamic subtest vcs0: SUCCESS (9.527s)
[110.033470] Starting dynamic subtest: vcs1
[120.836348] Dynamic subtest vcs1: SUCCESS (10.815s)
[120.846745] Starting dynamic subtest: vecs0
[133.503503] Dynamic subtest vecs0: SUCCESS (12.666s)
[133.515412] Starting dynamic subtest: ccs0
[148.707949] Dynamic subtest ccs0: SUCCESS (15.203s)
[148.710563] Subtest wide: SUCCESS (58.347s)
[150.950889] [014/155] (884s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[151.053144] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[151.057090] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[151.136917] [015/155] (883s left) gem_vm_create (invalid-create)
[151.195980] Starting subtest: invalid-create
[151.198416] Subtest invalid-create: SUCCESS (0.002s)
[151.308160] [016/155] (883s left) kms_plane_cursor (primary)
[151.390156] Starting subtest: primary
[151.395225] Starting dynamic subtest: pipe-A-eDP-1-size-64
[153.929429] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.541s)
[153.953103] Starting dynamic subtest: pipe-A-eDP-1-size-128
[156.519598] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.572s)
[156.547605] Starting dynamic subtest: pipe-A-eDP-1-size-256
[159.098787] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.561s)
[159.410733] Starting dynamic subtest: pipe-B-eDP-1-size-64
[162.683532] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.282s)
[162.708946] Starting dynamic subtest: pipe-B-eDP-1-size-128
[165.251472] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.550s)
[165.276414] Starting dynamic subtest: pipe-B-eDP-1-size-256
[167.854610] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.583s)
[168.174754] Starting dynamic subtest: pipe-C-eDP-1-size-64
[171.065054] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.900s)
[171.091629] Starting dynamic subtest: pipe-C-eDP-1-size-128
[173.298283] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.214s)
[173.325547] Starting dynamic subtest: pipe-C-eDP-1-size-256
[175.532309] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.214s)
[175.848033] Starting dynamic subtest: pipe-D-eDP-1-size-64
[178.794424] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.957s)
[178.821921] Starting dynamic subtest: pipe-D-eDP-1-size-128
[181.005303] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.192s)
[181.031020] Starting dynamic subtest: pipe-D-eDP-1-size-256
[183.238682] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.214s)
[183.549443] Subtest primary: SUCCESS (32.158s)
[184.444600] [017/155] (850s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[184.547618] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[184.551978] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[184.647240] [018/155] (850s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[184.739658] Starting subtest: fbc-rgb565-draw-mmap-wc
[188.816806] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.083s)
[189.953120] [019/155] (845s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-onoff)
[190.052033] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-onoff
[190.056125] Subtest psrhdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[190.130940] [020/155] (845s left) i915_hangman (error-state-basic)
[190.195823] Starting subtest: error-state-basic
[190.352150] Subtest error-state-basic: SUCCESS (0.156s)
[190.432218] [021/155] (844s left) kms_cursor_edge_walk (256x256-top-edge)
[190.526106] Starting subtest: 256x256-top-edge
[190.528274] Starting dynamic subtest: pipe-A-eDP-1
[194.010875] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.484s)
[194.021970] Starting dynamic subtest: pipe-D-eDP-1
[197.234455] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.222s)
[197.236362] Subtest 256x256-top-edge: SUCCESS (6.708s)
[198.043283] [022/155] (837s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[198.138410] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[198.147752] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.011s)
[198.242088] [023/155] (837s left) kms_big_fb (linear-8bpp-rotate-90)
[198.343148] Starting subtest: linear-8bpp-rotate-90
[198.365987] Subtest linear-8bpp-rotate-90: SKIP (0.022s)
[198.503142] [024/155] (836s left) drm_buddy (drm_buddy)
[198.536684] Starting subtest: drm_buddy
[198.540926] Subtest drm_buddy: SKIP (0.000s)
[198.599755] [025/155] (836s left) kms_pm_rpm (modeset-lpsp)
[200.524633] Starting subtest: modeset-lpsp
[202.012310] Subtest modeset-lpsp: SUCCESS (1.489s)
[202.099661] [026/155] (833s left) kms_lease (lease-unleased-connector)
[202.192278] Starting subtest: lease-unleased-connector
[202.194698] Starting dynamic subtest: pipe-A-eDP-1
[202.196954] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[202.208564] Starting dynamic subtest: pipe-B-eDP-1
[202.210848] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s)
[202.221207] Starting dynamic subtest: pipe-C-eDP-1
[202.223368] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[202.231412] Starting dynamic subtest: pipe-D-eDP-1
[202.233298] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[202.235083] Subtest lease-unleased-connector: SUCCESS (0.032s)
[202.339879] [027/155] (833s left) kms_psr (fbc-psr-primary-blt)
[202.428072] Starting subtest: fbc-psr-primary-blt
[202.430403] Starting dynamic subtest: eDP-1
[202.434631] Dynamic subtest eDP-1: SKIP (0.000s)
[202.438723] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[202.505799] [028/155] (833s left) kms_frontbuffer_tracking (hdr-1p-primscrn-indfb-pgflip-blt)
[202.592421] Starting subtest: hdr-1p-primscrn-indfb-pgflip-blt
[202.596612] Subtest hdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[202.689387] [029/155] (832s left) gem_exec_fence (concurrent)
[202.855304] Starting subtest: concurrent
[202.859886] Subtest concurrent: SKIP (0.000s)
[204.394980] [030/155] (831s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[204.489254] Starting subtest: fbcpsr-rgb565-draw-blt
[211.579261] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.096s)
[211.716426] [031/155] (824s left) gem_pwrite_snooped
[211.848615] [032/155] (823s left) prime_self_import (reimport-vs-gem_close-race)
[211.885578] Starting subtest: reimport-vs-gem_close-race
[216.956216] Subtest reimport-vs-gem_close-race: SUCCESS (5.074s)
[217.054430] [033/155] (818s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[217.161249] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[217.165429] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[217.272339] [034/155] (818s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[217.373571] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[224.194060] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.827s)
[224.320291] [035/155] (811s left) api_intel_allocator (execbuf-with-allocator)
[224.379301] Starting subtest: execbuf-with-allocator
[224.383051] Subtest execbuf-with-allocator: SUCCESS (0.006s)
[224.496062] [036/155] (811s left) gem_partial_pwrite_pread (writes-after-reads)
[224.553217] Subtest writes-after-reads: SKIP (0.000s)
[224.628170] [037/155] (811s left) gem_tiled_swapping (non-threaded)
[224.677275] Subtest non-threaded: SKIP (0.000s)
[224.739091] [038/155] (811s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[224.840693] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[224.844669] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[224.936355] [039/155] (811s left) gem_ctx_isolation (preservation-s3)
[224.991081] Starting subtest: preservation-S3
[224.993325] Starting dynamic subtest: rcs0
[242.046092] Dynamic subtest rcs0: SUCCESS (1.808s)
[242.055790] Starting dynamic subtest: bcs0
[259.049519] Dynamic subtest bcs0: SUCCESS (1.748s)
[259.059487] Starting dynamic subtest: vcs0
[276.059883] Dynamic subtest vcs0: SUCCESS (3.236s)
[276.073598] Starting dynamic subtest: vcs1
[294.043245] Dynamic subtest vcs1: SUCCESS (5.026s)
[294.054370] Starting dynamic subtest: vecs0
[312.046301] Dynamic subtest vecs0: SUCCESS (5.001s)
[312.056961] Starting dynamic subtest: ccs0
[330.053233] Dynamic subtest ccs0: SUCCESS (3.203s)
[330.055501] Subtest preservation-S3: SUCCESS (20.031s)
[336.316789] [040/155] (705s left) gem_create (create-valid-nonaligned)
[336.380091] Starting subtest: create-valid-nonaligned
[336.382014] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[336.564995] [041/155] (705s left) gem_create (create-clear)
[336.619559] Starting subtest: create-clear
[336.621802] Starting dynamic subtest: smem0
[369.187852] Dynamic subtest smem0: SUCCESS (32.822s)
[369.190157] Subtest create-clear: SUCCESS (32.823s)
[369.396097] [042/155] (672s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[369.521094] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[369.525619] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s)
[369.678725] [043/155] (672s left) kms_flip (2x-busy-flip)
[369.784002] Starting subtest: 2x-busy-flip
[369.793396] Subtest 2x-busy-flip: SKIP (0.011s)
[369.871753] [044/155] (672s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[369.967517] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[369.972028] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[370.067783] [045/155] (672s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[370.184955] Starting subtest: cursorA-vs-flipA-atomic
[381.339079] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.147s)
[382.146572] [046/155] (660s left) gem_userptr_blits (dmabuf-unsync)
[382.203686] Subtest dmabuf-unsync: SKIP (0.000s)
[382.326818] [047/155] (660s left) gem_eio (wait-1us)
[382.551844] Starting subtest: wait-1us
[382.910933] Subtest wait-1us: SUCCESS (0.359s)
[383.033102] [048/155] (659s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-mmap-gtt)
[383.129582] Starting subtest: psrhdr-rgb565-draw-mmap-gtt
[383.133143] Subtest psrhdr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[383.245160] [049/155] (659s left) perf (disabled-read-error)
[383.353680] Starting subtest: disabled-read-error
[383.369281] Subtest disabled-read-error: SUCCESS (0.016s)
[383.419283] [050/155] (659s left) gem_exec_whisper (basic-queues-priority)
[383.481321] Starting subtest: basic-queues-priority
[406.393480] Subtest basic-queues-priority: SUCCESS (22.913s)
[406.591075] [051/155] (636s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[406.690293] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[406.692289] Starting dynamic subtest: pipe-A-eDP-1
[407.180399] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.463s)
[407.193312] Starting dynamic subtest: pipe-B-eDP-1
[408.666134] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.485s)
[408.677509] Starting dynamic subtest: pipe-C-eDP-1
[410.099579] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.434s)
[410.112507] Starting dynamic subtest: pipe-D-eDP-1
[411.512917] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.413s)
[411.514842] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.799s)
[412.697578] [052/155] (629s left) kms_invalid_mode (bad-hsync-end)
[412.791692] Starting subtest: bad-hsync-end
[412.794047] Starting dynamic subtest: pipe-A-eDP-1
[413.081321] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s)
[413.097305] Starting dynamic subtest: pipe-B-eDP-1
[413.099311] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[413.109567] Starting dynamic subtest: pipe-C-eDP-1
[413.111806] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[413.122140] Starting dynamic subtest: pipe-D-eDP-1
[413.124485] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[413.126799] Subtest bad-hsync-end: SUCCESS (0.298s)
[413.942682] [053/155] (628s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[414.054148] Starting subtest: psr-rgb565-draw-pwrite
[421.170908] Subtest psr-rgb565-draw-pwrite: SUCCESS (7.123s)
[421.299436] [054/155] (621s left) syncobj_timeline (host-signal-points)
[421.360770] Starting subtest: host-signal-points
[421.365313] Subtest host-signal-points: SUCCESS (0.004s)
[421.468610] [055/155] (621s left) kms_chamelium_hpd (hdmi-hpd-fast)
[421.840523] Subtest hdmi-hpd-fast: SKIP (0.000s)
[422.674826] [056/155] (620s left) gem_eio (kms)
[422.949731] Starting subtest: kms
[442.728368] Subtest kms: SUCCESS (19.777s)
[443.918292] [057/155] (598s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[444.017652] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[444.022074] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[444.111235] [058/155] (598s left) gem_fence_thrash (bo-write-verify-x)
[444.147158] Starting subtest: bo-write-verify-x
[444.163098] Subtest bo-write-verify-x: SKIP (0.015s)
[444.227045] [059/155] (598s left) kms_atomic_transition (plane-all-transition-nonblocking)
[444.320825] Starting subtest: plane-all-transition-nonblocking
[444.323347] Starting dynamic subtest: pipe-A-eDP-1
[446.819360] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.498s)
[447.128699] Starting dynamic subtest: pipe-B-eDP-1
[450.335213] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.220s)
[450.645111] Subtest plane-all-transition-nonblocking: SUCCESS (6.324s)
[451.470306] [060/155] (591s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[451.571290] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[451.575414] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[451.664972] [061/155] (591s left) gem_media_vme
[451.782109] [062/155] (591s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[451.883401] Starting subtest: bad-aux-stride-yf-tiled-ccs
[451.885620] Starting dynamic subtest: pipe-A-eDP-1
[451.907465] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[451.918881] Starting dynamic subtest: pipe-B-eDP-1
[451.939416] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[451.949704] Starting dynamic subtest: pipe-C-eDP-1
[451.970906] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[451.980450] Starting dynamic subtest: pipe-D-eDP-1
[452.002367] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[452.006777] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.004s)
[454.143481] [063/155] (589s left) perf (gen8-unprivileged-single-ctx-counters)
[454.226995] Starting subtest: gen8-unprivileged-single-ctx-counters
[454.231912] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[454.275879] [064/155] (588s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[454.366955] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[454.392667] Starting dynamic subtest: pipe-A-plane-0
[454.770298] Dynamic subtest pipe-A-plane-0: SUCCESS (0.377s)
[454.783924] Starting dynamic subtest: pipe-A-plane-3
[455.125621] Dynamic subtest pipe-A-plane-3: SUCCESS (0.353s)
[456.231249] Starting dynamic subtest: pipe-B-plane-0
[456.619150] Dynamic subtest pipe-B-plane-0: SUCCESS (0.400s)
[456.630319] Starting dynamic subtest: pipe-B-plane-3
[456.941599] Dynamic subtest pipe-B-plane-3: SUCCESS (0.321s)
[457.264829] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (2.896s)
[458.108793] [065/155] (585s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-blt)
[458.206129] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-blt
[458.210319] Subtest hdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[458.324779] [066/155] (584s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[458.423809] Starting subtest: plane-upscale-factor-0-25-with-rotation
[458.426004] Starting dynamic subtest: pipe-A
[458.649008] Dynamic subtest pipe-A: SUCCESS (0.227s)
[458.660300] Starting dynamic subtest: pipe-B
[459.991404] Dynamic subtest pipe-B: SUCCESS (1.341s)
[460.003888] Starting dynamic subtest: pipe-C
[461.341961] Dynamic subtest pipe-C: SUCCESS (1.349s)
[461.352583] Starting dynamic subtest: pipe-D
[462.655892] Dynamic subtest pipe-D: SUCCESS (1.312s)
[462.658244] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.234s)
[463.844109] [067/155] (579s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[463.945796] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[463.950268] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[464.043369] [068/155] (579s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[464.172759] Starting subtest: short-busy-flip-before-cursor-toggle
[464.177327] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[464.315252] [069/155] (579s left) sriov_basic (enable-vfs-bind-unbind-each)
[464.365689] Starting subtest: enable-vfs-bind-unbind-each
[464.368072] Starting dynamic subtest: numvfs-1
[464.372607] Dynamic subtest numvfs-1: SKIP (0.001s)
[464.384111] Starting dynamic subtest: numvfs-2
[464.388078] Dynamic subtest numvfs-2: SKIP (0.001s)
[464.398609] Starting dynamic subtest: numvfs-3
[464.402719] Dynamic subtest numvfs-3: SKIP (0.003s)
[464.412737] Starting dynamic subtest: numvfs-4
[464.416856] Dynamic subtest numvfs-4: SKIP (0.001s)
[464.427122] Starting dynamic subtest: numvfs-5
[464.431153] Dynamic subtest numvfs-5: SKIP (0.001s)
[464.440621] Starting dynamic subtest: numvfs-6
[464.444536] Dynamic subtest numvfs-6: SKIP (0.001s)
[464.454039] Starting dynamic subtest: numvfs-7
[464.457979] Dynamic subtest numvfs-7: SKIP (0.001s)
[464.467544] Starting dynamic subtest: numvfs-random
[464.471699] Dynamic subtest numvfs-random: SKIP (0.001s)
[464.475659] Subtest enable-vfs-bind-unbind-each: SKIP (0.014s)
[464.514470] [070/155] (578s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-blt)
[464.620871] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-blt
[464.624939] Subtest fbchdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[464.733080] [071/155] (578s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[464.832961] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[464.836550] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[464.906191] [072/155] (578s left) kms_chamelium_frames (hdmi-crc-fast)
[465.291345] Subtest hdmi-crc-fast: SKIP (0.000s)
[466.161490] [073/155] (577s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[466.264652] Starting subtest: fbc-psr2-cursor-mmap-gtt
[466.266874] Starting dynamic subtest: eDP-1
[466.271137] Dynamic subtest eDP-1: SKIP (0.000s)
[466.275356] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[466.340940] [074/155] (577s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[466.445330] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc
[466.450017] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[466.561339] [075/155] (577s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[466.659388] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[466.663868] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[466.763413] [076/155] (576s left) kms_psr (pr-primary-render)
[466.870696] Starting subtest: pr-primary-render
[466.874918] Subtest pr-primary-render: SKIP (0.000s)
[466.945545] [077/155] (576s left) gem_exec_reloc (basic-wc-read-active)
[467.009322] Subtest basic-wc-read-active: SKIP (0.000s)
[467.072743] [078/155] (576s left) kms_hdmi_inject (inject-audio)
[467.413657] Starting subtest: inject-audio
[467.705703] Subtest inject-audio: SUCCESS (0.294s)
[468.340571] [079/155] (575s left) i915_pm_rps (thresholds)
[468.398092] Starting subtest: thresholds
[468.402554] Subtest thresholds: SKIP (0.000s)
[468.501078] [080/155] (575s left) gem_tiled_blits (basic)
[468.562614] Subtest basic: SKIP (0.000s)
[468.639680] [081/155] (575s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[468.741712] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[468.745914] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[468.847924] [082/155] (575s left) gem_ctx_persistence (hostile)
[468.902518] Starting subtest: hostile
[479.052371] Subtest hostile: SUCCESS (10.146s)
[479.180121] [083/155] (564s left) kms_plane_multiple (2x-tiling-y)
[479.280891] Starting subtest: 2x-tiling-y
[479.285289] Subtest 2x-tiling-y: SKIP (0.000s)
[479.357832] [084/155] (564s left) gem_mmap_gtt (fault-concurrent)
[479.424234] Subtest fault-concurrent: SKIP (0.000s)
[479.486480] [085/155] (564s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-indfb-msflip-blt)
[479.577590] Starting subtest: fbcpsrhdr-2p-scndscrn-indfb-msflip-blt
[479.582052] Subtest fbcpsrhdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[479.673288] [086/155] (564s left) gen9_exec_parse (bb-secure)
[479.734557] Subtest bb-secure: SKIP (0.000s)
[479.813081] [087/155] (564s left) kms_plane_scaling (invalid-num-scalers)
[479.913476] Starting subtest: invalid-num-scalers
[479.915698] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[479.936298] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.018s)
[479.947621] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[479.966768] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.032s)
[479.977696] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[479.999916] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.032s)
[480.010430] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[480.032614] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.032s)
[480.034887] Subtest invalid-num-scalers: SUCCESS (0.121s)
[480.156033] [088/155] (564s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[480.252851] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[480.256399] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[480.363836] [089/155] (563s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[480.456794] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[487.155467] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.703s)
[487.296083] [090/155] (557s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-blt)
[487.395338] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-blt
[487.399707] Subtest hdr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[487.475834] [091/155] (556s left) gem_ccs (block-copy-compressed)
[487.529908] Starting subtest: block-copy-compressed
[487.534276] Subtest block-copy-compressed: SKIP (0.000s)
[487.628130] [092/155] (556s left) kms_psr (fbc-pr-cursor-blt)
[487.715094] Starting subtest: fbc-pr-cursor-blt
[487.719613] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[487.793347] [093/155] (556s left) gem_workarounds (reset-context)
[487.858403] Starting subtest: reset-context
[488.000397] Subtest reset-context: SUCCESS (0.141s)
[488.132832] [094/155] (556s left) gem_exec_balancer (bonded-dual)
[488.195751] Starting subtest: bonded-dual
[488.199287] Subtest bonded-dual: SKIP (0.000s)
[488.495109] [095/155] (556s left) gem_exec_nop (basic-series)
[488.565236] Starting subtest: basic-series
[504.329597] Subtest basic-series: SUCCESS (15.773s)
[504.549478] [096/155] (540s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-render)
[504.661308] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-render
[504.665439] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[504.750292] [097/155] (539s left) perf_pmu (init-busy)
[504.791615] Starting subtest: init-busy
[504.794011] Starting dynamic subtest: rcs0
[504.796211] Dynamic subtest rcs0: SUCCESS (0.001s)
[504.807244] Starting dynamic subtest: bcs0
[504.809144] Dynamic subtest bcs0: SUCCESS (0.000s)
[504.819353] Starting dynamic subtest: vcs0
[504.821272] Dynamic subtest vcs0: SUCCESS (0.001s)
[504.831671] Starting dynamic subtest: vcs1
[504.833536] Dynamic subtest vcs1: SUCCESS (0.001s)
[504.843442] Starting dynamic subtest: vecs0
[504.845697] Dynamic subtest vecs0: SUCCESS (0.001s)
[504.855999] Starting dynamic subtest: ccs0
[504.857913] Dynamic subtest ccs0: SUCCESS (0.000s)
[504.859818] Subtest init-busy: SUCCESS (0.008s)
[504.917722] [098/155] (539s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[505.013346] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[511.779356] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.770s)
[511.907107] [099/155] (532s left) kms_vblank (wait-idle-hang)
[512.010962] Starting subtest: wait-idle-hang
[512.013199] Starting dynamic subtest: pipe-A-eDP-1
[526.089543] Dynamic subtest pipe-A-eDP-1: SUCCESS (14.080s)
[526.105232] Starting dynamic subtest: pipe-D-eDP-1
[541.135268] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.045s)
[541.137175] Subtest wait-idle-hang: SUCCESS (29.129s)
[541.987496] [100/155] (502s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[542.088309] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[542.092720] Subtest hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[542.198797] [101/155] (502s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[542.293790] Starting subtest: random-ccs-data-y-tiled-ccs
[542.296021] Starting dynamic subtest: pipe-A-eDP-1
[542.320366] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[542.332667] Starting dynamic subtest: pipe-B-eDP-1
[542.355386] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[542.365917] Starting dynamic subtest: pipe-C-eDP-1
[542.389720] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[542.399843] Starting dynamic subtest: pipe-D-eDP-1
[542.423951] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[542.427985] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.005s)
[544.600720] [102/155] (500s left) i915_drm_fdinfo (busy-check-all)
[544.638610] Starting subtest: busy-check-all
[544.641226] Starting dynamic subtest: rcs0
[544.646118] Dynamic subtest rcs0: SKIP (0.005s)
[544.659081] Starting dynamic subtest: bcs0
[544.663316] Dynamic subtest bcs0: SKIP (0.000s)
[544.674089] Starting dynamic subtest: vcs0
[544.678236] Dynamic subtest vcs0: SKIP (0.000s)
[544.688710] Starting dynamic subtest: vcs1
[544.693044] Dynamic subtest vcs1: SKIP (0.000s)
[544.705225] Starting dynamic subtest: vecs0
[544.709379] Dynamic subtest vecs0: SKIP (0.000s)
[544.719101] Starting dynamic subtest: ccs0
[544.723255] Dynamic subtest ccs0: SKIP (0.000s)
[544.727417] Subtest busy-check-all: SKIP (0.010s)
[544.767243] [103/155] (500s left) syncobj_basic (bad-flags-handle-to-fd)
[544.850586] Starting subtest: bad-flags-handle-to-fd
[544.853130] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[544.961130] [104/155] (499s left) kms_content_protection (dp-mst-type-1)
[545.096922] Starting subtest: dp-mst-type-1
[545.101593] Subtest dp-mst-type-1: SKIP (0.000s)
[545.206203] [105/155] (499s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[545.338217] Starting subtest: 4-tiled-16bpp-rotate-0
[546.718037] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.380s)
[546.830350] [106/155] (498s left) gem_exec_params (invalid-fence-in)
[546.883031] Starting subtest: invalid-fence-in
[546.884949] Subtest invalid-fence-in: SUCCESS (0.000s)
[546.980752] [107/155] (498s left) gem_mmap_gtt (flink-race)
[547.032539] Subtest flink-race: SKIP (0.000s)
[547.093821] [108/155] (498s left) syncobj_timeline (invalid-signal-illegal-point)
[547.147632] Starting subtest: invalid-signal-illegal-point
[547.149516] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[547.246985] [109/155] (497s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-pgflip-blt)
[547.343621] Starting subtest: fbchdr-1p-primscrn-indfb-pgflip-blt
[547.347032] Subtest fbchdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[547.428484] [110/155] (497s left) kms_panel_fitting (legacy)
[547.516698] Starting subtest: legacy
[547.518474] Starting dynamic subtest: pipe-A-eDP-1
[548.038022] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.521s)
[548.068586] Starting dynamic subtest: pipe-B-eDP-1
[549.577320] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.520s)
[549.605958] Starting dynamic subtest: pipe-C-eDP-1
[551.086729] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.490s)
[551.115674] Starting dynamic subtest: pipe-D-eDP-1
[552.647003] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.542s)
[552.649511] Subtest legacy: SUCCESS (5.131s)
[553.882059] [111/155] (491s left) i915_suspend (debugfs-reader)
[553.941197] Starting subtest: debugfs-reader
[572.997832] Subtest debugfs-reader: SUCCESS (3.569s)
[578.188768] [112/155] (472s left) kms_psr (psr-cursor-plane-move)
[578.288579] Starting subtest: psr-cursor-plane-move
[578.291043] Starting dynamic subtest: eDP-1
[579.992901] Dynamic subtest eDP-1: SUCCESS (1.758s)
[579.995742] Subtest psr-cursor-plane-move: SUCCESS (1.759s)
[580.794348] [113/155] (469s left) gem_exec_schedule (pi-ringfull)
[580.971176] Starting subtest: pi-ringfull
[580.973998] Starting dynamic subtest: rcs0
[581.000939] Dynamic subtest rcs0: SUCCESS (0.032s)
[581.015716] Starting dynamic subtest: bcs0
[581.034460] Dynamic subtest bcs0: SUCCESS (0.034s)
[581.049608] Starting dynamic subtest: vcs0
[581.062278] Dynamic subtest vcs0: SUCCESS (0.028s)
[581.077858] Starting dynamic subtest: vcs1
[581.090179] Dynamic subtest vcs1: SUCCESS (0.028s)
[581.105536] Starting dynamic subtest: vecs0
[581.118557] Dynamic subtest vecs0: SUCCESS (0.028s)
[581.134261] Starting dynamic subtest: ccs0
[581.147528] Dynamic subtest ccs0: SUCCESS (0.029s)
[581.150005] Subtest pi-ringfull: SUCCESS (0.183s)
[581.365758] [114/155] (469s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[581.413789] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[581.516111] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.104s)
[581.611543] [115/155] (468s left) gem_ctx_param (get-priority-new-ctx)
[581.660511] Starting subtest: get-priority-new-ctx
[581.663068] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[581.767485] [116/155] (468s left) api_intel_bb (lot-of-buffers)
[581.816405] Starting subtest: lot-of-buffers
[582.862505] Subtest lot-of-buffers: SUCCESS (1.069s)
[583.351623] [117/155] (467s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[583.455992] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[584.539702] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.101s)
[584.663805] [118/155] (466s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[584.751695] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[584.755672] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[585.905442] [119/155] (464s left) kms_prime (basic-crc-hybrid)
[585.994986] Subtest basic-crc-hybrid: SKIP (0.000s)
[586.100236] [120/155] (464s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[586.190622] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[586.192737] Starting dynamic subtest: pipe-A-eDP-1
[603.228552] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.810s)
[603.242068] Starting dynamic subtest: pipe-B-eDP-1
[621.185205] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.810s)
[621.195453] Starting dynamic subtest: pipe-C-eDP-1
[639.156958] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.815s)
[639.168129] Starting dynamic subtest: pipe-D-eDP-1
[657.149629] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.803s)
[657.151959] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (10.245s)
[663.378524] [121/155] (392s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[663.437116] Starting subtest: multi-wait-for-submit-submitted-signaled
[663.439353] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[663.556799] [122/155] (392s left) prime_vgem (basic-gtt)
[663.633683] Starting subtest: basic-gtt
[663.637837] Subtest basic-gtt: SKIP (0.000s)
[663.732427] [123/155] (392s left) gem_exec_fence (syncobj-timeline-wait)
[664.306140] Starting subtest: syncobj-timeline-wait
[665.688326] Subtest syncobj-timeline-wait: SUCCESS (1.385s)
[667.746008] [124/155] (388s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[667.850690] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[668.654064] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.826s)
[668.828870] [125/155] (387s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[668.894644] Starting subtest: map-fixed-invalidate-overlap-busy
[668.899001] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[669.034222] [126/155] (387s left) gem_softpin (32b-excludes-last-page)
[669.089394] Starting subtest: 32b-excludes-last-page
[669.094219] Subtest 32b-excludes-last-page: SUCCESS (0.003s)
[669.242275] [127/155] (386s left) gem_exec_schedule (semaphore-codependency)
[669.319848] Starting subtest: semaphore-codependency
[669.325152] Subtest semaphore-codependency: SUCCESS (0.012s)
[669.676516] [128/155] (386s left) gem_pxp (hw-rejects-pxp-context)
[669.795013] Starting subtest: hw-rejects-pxp-context
[669.799562] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[669.923744] [129/155] (386s left) gem_spin_batch (spin-all-new)
[669.982423] Starting subtest: spin-all-new
[669.997749] Subtest spin-all-new: SUCCESS (0.014s)
[671.675582] [130/155] (384s left) kms_cursor_crc (cursor-offscreen-512x512)
[671.952870] Starting subtest: cursor-offscreen-512x512
[671.957327] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[672.105857] [131/155] (384s left) syncobj_timeline (wait-all-for-submit-complex)
[672.163128] Starting subtest: wait-all-for-submit-complex
[672.378452] Subtest wait-all-for-submit-complex: SUCCESS (0.217s)
[672.456398] [132/155] (383s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[672.549400] Starting subtest: plane-lut1d-post-ctm3x4
[672.693131] Starting dynamic subtest: pipe-A-plane-0
[672.867917] Dynamic subtest pipe-A-plane-0: SUCCESS (0.177s)
[672.879283] Starting dynamic subtest: pipe-A-plane-1
[673.032322] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[673.043564] Starting dynamic subtest: pipe-A-plane-2
[673.175004] Dynamic subtest pipe-A-plane-2: SUCCESS (0.144s)
[674.379310] Starting dynamic subtest: pipe-B-plane-0
[674.566592] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s)
[674.577940] Starting dynamic subtest: pipe-B-plane-1
[674.752898] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s)
[674.764605] Starting dynamic subtest: pipe-B-plane-2
[674.917816] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[676.133968] Starting dynamic subtest: pipe-C-plane-0
[676.267451] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[676.278713] Starting dynamic subtest: pipe-C-plane-1
[676.411615] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[676.423254] Starting dynamic subtest: pipe-C-plane-2
[676.542791] Dynamic subtest pipe-C-plane-2: SUCCESS (0.133s)
[677.711050] Starting dynamic subtest: pipe-D-plane-0
[677.866508] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[677.878520] Starting dynamic subtest: pipe-D-plane-1
[678.021803] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[678.033162] Starting dynamic subtest: pipe-D-plane-2
[678.175588] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[678.460585] Subtest plane-lut1d-post-ctm3x4: SUCCESS (5.972s)
[679.349519] [133/155] (376s left) kms_universal_plane (cursor-fb-leak)
[679.447474] Starting subtest: cursor-fb-leak
[679.449733] Starting dynamic subtest: pipe-A-eDP-1
[679.770246] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.326s)
[679.783069] Starting dynamic subtest: pipe-B-eDP-1
[681.106844] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.342s)
[681.123003] Starting dynamic subtest: pipe-C-eDP-1
[682.487222] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.383s)
[682.501255] Starting dynamic subtest: pipe-D-eDP-1
[683.882168] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.399s)
[683.885194] Subtest cursor-fb-leak: SUCCESS (4.459s)
[685.136165] [134/155] (371s left) gem_mmap_gtt (basic-small-copy)
[685.187509] Subtest basic-small-copy: SKIP (0.000s)
[685.253521] [135/155] (371s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[685.362513] Starting subtest: x-tiled-64bpp-rotate-180
[686.936614] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.580s)
[687.091896] [136/155] (369s left) kms_cursor_crc (cursor-random-32x32)
[687.238772] Starting subtest: cursor-random-32x32
[687.291173] Subtest cursor-random-32x32: SKIP (0.048s)
[687.557885] [137/155] (368s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[687.652416] Starting subtest: psr-2p-primscrn-cur-indfb-move
[687.655866] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[687.750060] [138/155] (368s left) gem_tiled_fence_blits (basic)
[687.808594] Subtest basic: SKIP (0.000s)
[687.882642] [139/155] (368s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[687.977082] Starting subtest: invalidate-primary-flip-overlay
[698.685193] Subtest invalidate-primary-flip-overlay: SUCCESS (10.726s)
[698.808074] [140/155] (357s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[698.901221] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[698.904785] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[698.997390] [141/155] (357s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[699.092399] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[699.095852] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[699.203697] [142/155] (357s left) perf_pmu (busy-double-start)
[699.244441] Starting subtest: busy-double-start
[699.246067] Starting dynamic subtest: rcs0
[702.890934] Dynamic subtest rcs0: FAIL (3.592s)
[702.903836] Starting dynamic subtest: bcs0
[706.407987] Dynamic subtest bcs0: SUCCESS (3.568s)
[706.422199] Starting dynamic subtest: vcs0
[710.147116] Dynamic subtest vcs0: SUCCESS (3.736s)
[710.159907] Starting dynamic subtest: vcs1
[714.134227] Dynamic subtest vcs1: SUCCESS (3.985s)
[714.147999] Starting dynamic subtest: vecs0
[718.149860] Dynamic subtest vecs0: SUCCESS (4.014s)
[718.162527] Starting dynamic subtest: ccs0
[721.783089] Dynamic subtest ccs0: FAIL (3.564s)
[721.785298] Subtest busy-double-start: FAIL (22.468s)
[721.830309] [143/155] (334s left) kms_async_flips (alternate-sync-async-flip)
[721.931704] Starting subtest: alternate-sync-async-flip
[722.303192] Starting dynamic subtest: pipe-A-eDP-1
[725.062652] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.761s)
[725.435100] Starting dynamic subtest: pipe-B-eDP-1
[728.243729] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.820s)
[728.625359] Starting dynamic subtest: pipe-C-eDP-1
[731.449384] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.836s)
[731.828856] Starting dynamic subtest: pipe-D-eDP-1
[734.650377] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.833s)
[734.652473] Subtest alternate-sync-async-flip: SUCCESS (12.724s)
[735.886291] [144/155] (320s left) kms_flip (2x-flip-vs-suspend-interruptible)
[735.982404] Starting subtest: 2x-flip-vs-suspend-interruptible
[735.987087] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.002s)
[736.087543] [145/155] (320s left) kms_joiner (basic-ultra-joiner)
[736.180745] Starting subtest: basic-ultra-joiner
[736.184728] Subtest basic-ultra-joiner: SKIP (0.000s)
[736.255169] [146/155] (320s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[736.356414] Starting subtest: fbc-farfromfence-mmap-gtt
[736.360577] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[736.457265] [147/155] (320s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[736.559225] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[740.146580] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.594s)
[741.295561] [148/155] (315s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt)
[741.389901] Starting subtest: fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt
[741.393926] Subtest fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[741.498061] [149/155] (315s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[741.594389] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[741.598429] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[741.700844] [150/155] (315s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-move)
[741.803569] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-move
[741.807488] Subtest fbchdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[741.890352] [151/155] (315s left) prime_mmap (test_invalid_sync_flags)
[741.951894] Starting subtest: test_invalid_sync_flags
[741.954043] Starting dynamic subtest: test_invalid_sync_flags-smem
[741.956170] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[741.958390] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[742.068778] [152/155] (315s left) perf (invalid-remove-userspace-config)
[742.160392] Starting subtest: invalid-remove-userspace-config
[742.172147] Subtest invalid-remove-userspace-config: SUCCESS (0.010s)
[742.219752] [153/155] (314s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[742.311139] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[742.314815] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[742.388375] [154/155] (314s left) kms_frontbuffer_tracking (fbcpsrhdr-suspend)
[742.476839] Starting subtest: fbcpsrhdr-suspend
[742.480112] Subtest fbcpsrhdr-suspend: SKIP (0.000s)
[742.574088] [155/155] (314s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-gtt)
[742.683250] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-gtt
[742.686839] Subtest fbcpsrhdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[742.781743] 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.