[44.256745] Initializing watchdogs
[44.256806]   /dev/watchdog0
[44.272084] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[44.277964] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[44.281039] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[44.282896] [001/132] (960s left) kms_flip (wf_vblank-ts-check-interruptible)
[44.378097] Starting subtest: wf_vblank-ts-check-interruptible
[44.380640] Starting dynamic subtest: A-HDMI-A1
[63.251274] Dynamic subtest A-HDMI-A1: FAIL (18.941s)
[63.258021] Starting dynamic subtest: B-HDMI-A1
[70.968709] Dynamic subtest B-HDMI-A1: SUCCESS (7.867s)
[70.974192] Starting dynamic subtest: C-HDMI-A1
[78.829256] Dynamic subtest C-HDMI-A1: SUCCESS (7.865s)
[78.834671] Starting dynamic subtest: D-HDMI-A1
[86.595445] Dynamic subtest D-HDMI-A1: SUCCESS (7.766s)
[86.597614] Subtest wf_vblank-ts-check-interruptible: FAIL (42.450s)
[86.743236] [002/132] (918s left) gem_mmap_gtt (ptrace)
[86.778271] Starting subtest: ptrace
[86.877923] Subtest ptrace: SUCCESS (0.099s)
[86.956074] [003/132] (917s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[87.042532] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[87.043242] Starting dynamic subtest: pipe-A
[88.287082] Dynamic subtest pipe-A: SUCCESS (1.245s)
[88.293007] Starting dynamic subtest: pipe-B
[89.520264] Dynamic subtest pipe-B: SUCCESS (1.233s)
[89.526082] Starting dynamic subtest: pipe-C
[89.720743] Dynamic subtest pipe-C: SUCCESS (0.200s)
[89.729280] Starting dynamic subtest: pipe-D
[89.920540] Dynamic subtest pipe-D: SUCCESS (0.200s)
[89.921296] Subtest plane-downscale-factor-0-5-with-pixel-format: SUCCESS (2.879s)
[90.087710] [004/132] (914s left) kms_psr (fbc-psr-sprite-render)
[90.179293] Subtest fbc-psr-sprite-render: SKIP (0.000s)
[90.219282] [005/132] (914s left) sw_sync (alloc_timeline)
[90.254509] Starting subtest: alloc_timeline
[90.255338] Subtest alloc_timeline: SUCCESS (0.000s)
[90.308714] [006/132] (914s left) gem_exec_schedule (preempt-queue-chain)
[90.357563] Starting subtest: preempt-queue-chain
[90.358256] Starting dynamic subtest: rcs0
[90.513175] Dynamic subtest rcs0: SUCCESS (0.147s)
[90.519416] Starting dynamic subtest: bcs0
[90.648080] Dynamic subtest bcs0: SUCCESS (0.138s)
[90.654120] Starting dynamic subtest: vcs0
[90.784917] Dynamic subtest vcs0: SUCCESS (0.137s)
[90.791338] Starting dynamic subtest: vcs1
[90.928736] Dynamic subtest vcs1: SUCCESS (0.137s)
[90.935117] Starting dynamic subtest: vecs0
[91.062852] Dynamic subtest vecs0: SUCCESS (0.136s)
[91.063724] Subtest preempt-queue-chain: SUCCESS (0.697s)
[91.357152] [007/132] (913s left) kms_flip (2x-plain-flip)
[91.444406] Starting subtest: 2x-plain-flip
[91.453333] Subtest 2x-plain-flip: SKIP (0.009s)
[91.519827] [008/132] (913s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[91.609972] Subtest psr2-overlay-plane-update-continuous-sf: SKIP (0.000s)
[91.649058] [009/132] (913s left) kms_psr (pr-dpms)
[91.734487] Subtest pr-dpms: SKIP (0.000s)
[91.776007] [010/132] (913s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[91.871412] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[91.872762] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[91.944775] [011/132] (913s left) gem_exec_nop (basic-sequential)
[91.988616] Starting subtest: basic-sequential
[95.327284] Subtest basic-sequential: SUCCESS (3.339s)
[95.529323] [012/132] (909s left) kms_lease (empty-lease)
[95.621432] Starting subtest: empty-lease
[95.622145] Starting dynamic subtest: pipe-A-HDMI-A-1
[95.622877] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[95.629692] Starting dynamic subtest: pipe-B-HDMI-A-1
[95.630407] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[95.636654] Starting dynamic subtest: pipe-C-HDMI-A-1
[95.637358] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.000s)
[95.643145] Starting dynamic subtest: pipe-D-HDMI-A-1
[95.643834] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.000s)
[95.644537] Subtest empty-lease: SUCCESS (0.008s)
[95.696594] [013/132] (909s left) syncobj_timeline (signal)
[95.731016] Starting subtest: signal
[95.731773] Subtest signal: SUCCESS (0.000s)
[95.787182] [014/132] (909s left) syncobj_wait (wait-for-submit-delayed-submit)
[95.821148] Starting subtest: wait-for-submit-delayed-submit
[95.924168] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[95.988209] [015/132] (909s left) kms_vblank (wait-forked)
[96.072663] Starting subtest: wait-forked
[96.073341] Starting dynamic subtest: pipe-A-HDMI-A-1
[97.287699] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.214s)
[97.296782] Starting dynamic subtest: pipe-D-HDMI-A-1
[98.497925] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.207s)
[98.498841] Subtest wait-forked: SUCCESS (2.426s)
[98.645626] [016/132] (906s left) kms_psr (fbc-pr-sprite-render)
[98.737433] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[98.780341] [017/132] (906s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[98.869567] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[98.870966] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[98.973532] [018/132] (906s left) api_intel_allocator (two-level-inception)
[99.006809] Starting subtest: two-level-inception
[104.455899] Subtest two-level-inception: SUCCESS (5.416s)
[104.538229] [019/132] (900s left) gem_close_race (multigpu-basic-process)
[104.582464] Starting subtest: multigpu-basic-process
[104.583845] Subtest multigpu-basic-process: SKIP (0.000s)
[104.749547] [020/132] (900s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[104.840490] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[104.841856] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[104.947462] [021/132] (900s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[105.035767] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[105.037198] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[105.126309] [022/132] (900s left) gem_madvise (dontneed-before-mmap)
[105.158035] Starting subtest: dontneed-before-mmap
[105.163625] Subtest dontneed-before-mmap: SUCCESS (0.006s)
[105.245485] [023/132] (900s left) gem_partial_pwrite_pread (reads)
[105.283589] Starting subtest: reads
[107.033633] Subtest reads: SUCCESS (1.751s)
[107.128495] [024/132] (898s left) gem_exec_whisper (basic-queues)
[107.171687] Starting subtest: basic-queues
[108.873972] Subtest basic-queues: SUCCESS (1.702s)
[109.053022] [025/132] (896s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[109.152115] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[109.153489] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[109.237829] [026/132] (896s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[109.322888] Starting subtest: short-flip-after-cursor-toggle
[109.848159] Subtest short-flip-after-cursor-toggle: SUCCESS (0.525s)
[109.981618] [027/132] (895s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[110.080684] Starting subtest: 4-tiled-16bpp-rotate-180
[110.082031] Subtest 4-tiled-16bpp-rotate-180: SKIP (0.000s)
[110.174243] [028/132] (895s left) gem_mmap_wc (read)
[110.208097] Starting subtest: read
[110.215485] Subtest read: SUCCESS (0.008s)
[110.305947] [029/132] (895s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[110.390981] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[110.392449] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (0.000s)
[110.448381] [030/132] (895s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[110.544785] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[110.546120] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[110.642480] [031/132] (895s left) kms_cursor_crc (cursor-random-512x512)
[110.731476] Starting subtest: cursor-random-512x512
[110.732827] Subtest cursor-random-512x512: SKIP (0.001s)
[110.812319] [032/132] (895s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[110.906535] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[110.907963] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[110.998256] [033/132] (894s left) gem_caching (writes)
[111.036592] Starting subtest: writes
[120.479972] Subtest writes: SUCCESS (9.444s)
[120.581736] [034/132] (885s left) gem_basic (create-fd-close)
[120.614928] Starting subtest: create-fd-close
[120.616346] Subtest create-fd-close: SUCCESS (0.000s)
[120.697059] [035/132] (885s left) kms_getfb (getfb-handle-not-fb)
[120.786611] Starting subtest: getfb-handle-not-fb
[120.787350] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[120.888719] [036/132] (885s left) kms_cursor_edge_walk (256x256-top-edge)
[120.972575] Starting subtest: 256x256-top-edge
[120.973266] Starting dynamic subtest: pipe-A-HDMI-A-1
[122.728946] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.756s)
[122.737651] Starting dynamic subtest: pipe-D-HDMI-A-1
[124.391218] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.660s)
[124.391913] Subtest 256x256-top-edge: SUCCESS (3.420s)
[124.501910] [037/132] (881s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[124.607559] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[124.609005] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[124.694820] [038/132] (881s left) api_intel_bb (render-ccs)
[124.727902] Starting subtest: render-ccs
[125.080878] Subtest render-ccs: SUCCESS (0.345s)
[125.178497] [039/132] (880s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[125.211423] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[125.328390] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.108s)
[125.386144] [040/132] (880s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[125.473384] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[126.763158] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (1.289s)
[126.880102] [041/132] (879s left) kms_pm_dc (dc5-dpms-negative)
[127.974089] Starting subtest: dc5-dpms-negative
[132.226656] Subtest dc5-dpms-negative: SUCCESS (4.218s)
[132.258493] [042/132] (874s left) gen9_exec_parse (allowed-all)
[132.297727] Subtest allowed-all: SKIP (0.000s)
[132.337926] [043/132] (873s left) gem_exec_params (larger-than-life-batch)
[132.374232] Starting subtest: larger-than-life-batch
[134.592300] Subtest larger-than-life-batch: SUCCESS (2.217s)
[134.711995] [044/132] (871s left) kms_addfb_basic (unused-pitches)
[134.793091] Starting subtest: unused-pitches
[134.793904] Subtest unused-pitches: SUCCESS (0.000s)
[134.934773] [045/132] (871s left) kms_prop_blob (invalid-set-prop)
[134.968429] Starting subtest: invalid-set-prop
[134.969130] Subtest invalid-set-prop: SUCCESS (0.000s)
[135.033275] [046/132] (871s left) drm_read (empty-nonblock)
[135.162839] Starting subtest: empty-nonblock
[135.163549] Subtest empty-nonblock: SUCCESS (0.000s)
[135.276214] [047/132] (871s left) gem_ccs (ctrl-surf-copy)
[135.316195] Starting subtest: ctrl-surf-copy
[135.317625] Subtest ctrl-surf-copy: SKIP (0.000s)
[135.387896] [048/132] (871s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[135.472731] Starting subtest: nonblocking-crc-frame-sequence
[135.474327] Starting dynamic subtest: pipe-A-HDMI-A-1
[135.827780] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.353s)
[135.836388] Starting dynamic subtest: pipe-B-HDMI-A-1
[136.157841] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.329s)
[136.166413] Starting dynamic subtest: pipe-C-HDMI-A-1
[136.484838] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.325s)
[136.493288] Starting dynamic subtest: pipe-D-HDMI-A-1
[136.834956] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.347s)
[136.835753] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.362s)
[136.937548] [049/132] (869s left) syncobj_wait (multi-wait-all-submitted)
[136.982355] Starting subtest: multi-wait-all-submitted
[137.087876] Subtest multi-wait-all-submitted: SUCCESS (0.105s)
[137.152680] [050/132] (869s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[137.186464] Starting subtest: multi-wait-all-available-submitted-signaled
[137.187199] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.001s)
[137.245380] [051/132] (869s left) gem_reg_read (bad-register)
[137.280055] Starting subtest: bad-register
[137.280760] Subtest bad-register: SUCCESS (0.000s)
[137.344590] [052/132] (869s left) gem_pxp (create-valid-protected-context)
[137.445797] Starting subtest: create-valid-protected-context
[137.446752] Subtest create-valid-protected-context: SUCCESS (0.001s)
[137.533694] [053/132] (869s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[137.620852] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[137.621553] Starting dynamic subtest: pipe-A
[137.986348] Dynamic subtest pipe-A: SUCCESS (0.366s)
[137.995124] Starting dynamic subtest: pipe-B
[138.420870] Dynamic subtest pipe-B: SUCCESS (0.434s)
[138.431877] Starting dynamic subtest: pipe-C
[138.856464] Dynamic subtest pipe-C: SUCCESS (0.435s)
[138.863894] Starting dynamic subtest: pipe-D
[139.289985] Dynamic subtest pipe-D: SUCCESS (0.433s)
[139.290717] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (1.670s)
[139.465689] [054/132] (867s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[139.556193] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[139.557708] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[139.613342] [055/132] (867s left) sysfs_preempt_timeout (idempotent)
[139.651345] Starting subtest: idempotent
[139.653031] Starting dynamic subtest: vecs0
[139.653814] Dynamic subtest vecs0: SUCCESS (0.001s)
[139.661077] Starting dynamic subtest: vcs0
[139.661763] Dynamic subtest vcs0: SUCCESS (0.001s)
[139.668660] Starting dynamic subtest: bcs0
[139.669348] Dynamic subtest bcs0: SUCCESS (0.000s)
[139.676199] Starting dynamic subtest: rcs0
[139.676875] Dynamic subtest rcs0: SUCCESS (0.001s)
[139.683726] Starting dynamic subtest: vcs1
[139.684419] Dynamic subtest vcs1: SUCCESS (0.001s)
[139.685116] Subtest idempotent: SUCCESS (0.007s)
[139.712887] [056/132] (867s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[139.810031] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[140.382649] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.572s)
[140.503011] [057/132] (866s left) kms_rotation_crc (primary-rotation-90)
[140.587794] Starting subtest: primary-rotation-90
[145.560757] Subtest primary-rotation-90: SUCCESS (4.973s)
[145.742100] [058/132] (861s left) gem_exec_params (no-bsd)
[145.779122] Starting subtest: no-bsd
[145.780829] Subtest no-bsd: SUCCESS (0.001s)
[145.870456] [059/132] (861s left) gem_ctx_persistence (legacy-engines-mixed)
[145.908164] Starting subtest: legacy-engines-mixed
[145.908885] Starting dynamic subtest: render
[145.954623] Dynamic subtest render: SUCCESS (0.045s)
[145.971414] Starting dynamic subtest: bsd1
[146.010576] Dynamic subtest bsd1: SUCCESS (0.053s)
[146.027644] Starting dynamic subtest: bsd2
[146.058815] Dynamic subtest bsd2: SUCCESS (0.046s)
[146.076635] Starting dynamic subtest: blt
[146.125720] Dynamic subtest blt: SUCCESS (0.064s)
[146.144595] Starting dynamic subtest: vebox
[146.174771] Dynamic subtest vebox: SUCCESS (0.047s)
[146.175797] Subtest legacy-engines-mixed: SUCCESS (0.267s)
[146.253056] [060/132] (860s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[146.286623] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[146.328897] [061/132] (860s left) i915_suspend (basic-s3-without-i915)
[146.362237] Starting subtest: basic-s3-without-i915