[54.723649] Initializing watchdogs
[54.723716]   /dev/watchdog0
[54.738924] [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]
[54.744930] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[54.747754] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[54.749751] [001/133] (960s left) api_intel_bb (render-ccs)
[54.786391] Starting subtest: render-ccs
[55.134137] Subtest render-ccs: SUCCESS (0.339s)
[55.242290] [002/133] (960s left) gem_mmap_gtt (basic-small-bo-tiledx)
[55.275036] Starting subtest: basic-small-bo-tiledX
[55.592188] Subtest basic-small-bo-tiledX: SUCCESS (0.316s)
[55.713592] [003/133] (959s left) kms_flip (2x-plain-flip-interruptible)
[55.854628] Starting subtest: 2x-plain-flip-interruptible
[55.864247] Subtest 2x-plain-flip-interruptible: SKIP (0.009s)
[55.929955] [004/133] (959s left) gem_exec_schedule (u-semaphore-user)
[55.986487] Starting subtest: u-semaphore-user
[55.995515] Subtest u-semaphore-user: SUCCESS (0.009s)
[56.298579] [005/133] (959s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[56.383642] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[56.384946] Starting dynamic subtest: pipe-A
[56.513929] Dynamic subtest pipe-A: SUCCESS (0.130s)
[56.520564] Starting dynamic subtest: pipe-B
[56.676815] Dynamic subtest pipe-B: SUCCESS (0.162s)
[56.682330] Starting dynamic subtest: pipe-C
[56.819304] Dynamic subtest pipe-C: SUCCESS (0.142s)
[56.825032] Starting dynamic subtest: pipe-D
[56.954827] Dynamic subtest pipe-D: SUCCESS (0.135s)
[56.956136] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SUCCESS (0.571s)
[57.130663] [006/133] (958s left) gem_lmem_swapping (random-engines)
[57.173208] Subtest random-engines: SKIP (0.000s)
[57.206001] [007/133] (958s left) kms_big_fb (linear-64bpp-rotate-180)
[57.303173] Starting subtest: linear-64bpp-rotate-180
[58.968417] Subtest linear-64bpp-rotate-180: SUCCESS (1.662s)
[59.082152] [008/133] (956s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[59.179376] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[59.180803] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[59.267736] [009/133] (956s left) gem_pxp (fail-invalid-protected-context)
[59.368614] Starting subtest: fail-invalid-protected-context
[59.369896] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[59.447213] [010/133] (956s left) kms_getfb (getfb-repeated-different-handles)
[59.532888] Starting subtest: getfb-repeated-different-handles
[59.533657] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[59.640691] [011/133] (955s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[59.730706] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[59.732078] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[59.811994] [012/133] (955s left) prime_vgem (basic-gtt)
[59.903365] Starting subtest: basic-gtt
[59.914639] Subtest basic-gtt: SUCCESS (0.011s)
[60.014891] [FACT prime_vgem (basic-gtt)] new: kernel.kmod_is_loaded.vgem: true
[60.016880] [013/133] (955s left) gem_exec_reloc (basic-write-wc-active)
[60.054672] Starting subtest: basic-write-wc-active
[60.186903] Subtest basic-write-wc-active: SUCCESS (0.123s)
[60.294246] [014/133] (955s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[60.332594] Starting subtest: yf-tiled-ccs-to-y-tiled
[60.333288] Starting dynamic subtest: smem
[60.432481] Dynamic subtest smem: SUCCESS (0.099s)
[60.433194] Subtest yf-tiled-ccs-to-y-tiled: SUCCESS (0.100s)
[60.609379] [015/133] (955s left) kms_psr (psr2-cursor-render)
[60.695655] Subtest psr2-cursor-render: SKIP (0.000s)
[60.732841] [016/133] (955s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[60.821564] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[60.822990] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[60.926504] [017/133] (954s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[60.961098] Starting subtest: etime-single-wait-for-submit-unsubmitted
[61.064652] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[61.125441] [018/133] (954s left) gem_exec_capture (capture)
[61.164429] Starting subtest: capture
[61.165605] Starting dynamic subtest: rcs0-smem
[62.442836] Dynamic subtest rcs0-smem: SUCCESS (1.277s)
[62.448742] Starting dynamic subtest: bcs0-smem
[63.722270] Dynamic subtest bcs0-smem: SUCCESS (1.270s)
[63.728226] Starting dynamic subtest: vcs0-smem
[64.994518] Dynamic subtest vcs0-smem: SUCCESS (1.270s)
[65.000203] Starting dynamic subtest: vcs1-smem
[66.266390] Dynamic subtest vcs1-smem: SUCCESS (1.270s)
[66.272041] Starting dynamic subtest: vecs0-smem
[67.538708] Dynamic subtest vecs0-smem: SUCCESS (1.271s)
[67.539395] Subtest capture: SUCCESS (6.360s)
[67.650361] [019/133] (948s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[67.740666] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[67.742029] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[67.831786] [020/133] (948s left) gem_wait (wait)
[67.876642] Starting subtest: wait
[67.877370] Starting dynamic subtest: all-engines
[68.915491] Dynamic subtest all-engines: SUCCESS (1.037s)
[68.923892] Starting dynamic subtest: rcs0
[69.939397] Dynamic subtest rcs0: SUCCESS (1.022s)
[69.948255] Starting dynamic subtest: bcs0
[70.964367] Dynamic subtest bcs0: SUCCESS (1.024s)
[70.973279] Starting dynamic subtest: vcs0
[71.988297] Dynamic subtest vcs0: SUCCESS (1.023s)
[71.996871] Starting dynamic subtest: vcs1
[73.014477] Dynamic subtest vcs1: SUCCESS (1.025s)
[73.022531] Starting dynamic subtest: vecs0
[74.041645] Dynamic subtest vecs0: SUCCESS (1.026s)
[74.042670] Subtest wait: SUCCESS (6.161s)
[74.238461] [021/133] (941s left) perf_pmu (faulting-read)
[74.273451] Starting subtest: faulting-read
[74.274161] Starting dynamic subtest: gtt
[74.274839] Dynamic subtest gtt: SUCCESS (0.001s)
[74.281092] Starting dynamic subtest: wb
[74.281790] Dynamic subtest wb: SUCCESS (0.000s)
[74.288727] Starting dynamic subtest: wc
[74.289425] Dynamic subtest wc: SUCCESS (0.000s)
[74.296258] Starting dynamic subtest: uc
[74.296940] Dynamic subtest uc: SUCCESS (0.000s)
[74.297617] Subtest faulting-read: SUCCESS (0.003s)
[74.370736] [022/133] (941s left) kms_flip (2x-flip-vs-fences-interruptible)
[74.459215] Starting subtest: 2x-flip-vs-fences-interruptible
[74.468783] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.009s)
[74.529139] [023/133] (941s left) kms_draw_crc (fill-fb)
[74.613884] Starting subtest: fill-fb
[74.819172] Subtest fill-fb: SUCCESS (0.205s)
[74.921946] [024/133] (941s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[76.314521] Starting subtest: modeset-non-lpsp-stress-no-wait
[76.418031] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.104s)
[76.519764] [025/133] (939s left) syncobj_wait (multi-wait-all-submitted-signaled)
[76.556574] Starting subtest: multi-wait-all-submitted-signaled
[76.664661] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.107s)
[76.749903] [026/133] (939s left) gem_render_copy_redux (interruptible)
[76.787520] Starting subtest: interruptible
[77.128052] Subtest interruptible: SUCCESS (0.332s)
[77.220089] [027/133] (939s left) kms_prop_blob (invalid-get-prop)
[77.253007] Starting subtest: invalid-get-prop
[77.253781] Subtest invalid-get-prop: SUCCESS (0.000s)
[77.318280] [028/133] (938s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[77.403803] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[77.404528] Starting dynamic subtest: pipe-A-HDMI-A-1
[77.422287] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[77.430512] Starting dynamic subtest: pipe-B-HDMI-A-1
[77.448925] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[77.456990] Starting dynamic subtest: pipe-C-HDMI-A-1
[77.474769] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[77.482279] Starting dynamic subtest: pipe-D-HDMI-A-1
[77.499693] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.002s)
[77.501125] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.011s)
[77.647892] [029/133] (938s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[77.746343] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[77.747806] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[77.826283] [030/133] (938s left) gem_exec_gttfill (engines)
[77.868580] Starting subtest: engines
[77.869315] Starting dynamic subtest: rcs0
[100.896715] Dynamic subtest rcs0: SUCCESS (23.022s)
[100.905291] Starting dynamic subtest: bcs0
[123.881805] Dynamic subtest bcs0: SUCCESS (22.985s)
[123.888682] Starting dynamic subtest: vcs0
[146.843646] Dynamic subtest vcs0: SUCCESS (22.962s)
[146.851437] Starting dynamic subtest: vcs1
[170.005639] Dynamic subtest vcs1: SUCCESS (23.162s)
[170.012606] Starting dynamic subtest: vecs0
[193.337220] Dynamic subtest vecs0: SUCCESS (23.331s)
[193.337962] Subtest engines: SUCCESS (115.466s)
[193.524704] [031/133] (822s left) gem_workarounds (reset-fd)
[193.620784] Starting subtest: reset-fd
[193.631441] Subtest reset-fd: SUCCESS (0.010s)
[193.733535] [032/133] (822s left) gem_ctx_persistence (idempotent)
[193.770358] Starting subtest: idempotent
[193.771160] Subtest idempotent: SUCCESS (0.000s)
[193.835860] [033/133] (822s left) kms_atomic (crtc-invalid-params)
[193.925443] Starting subtest: crtc-invalid-params
[193.926871] Starting dynamic subtest: pipe-A-HDMI-A-1
[194.080495] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.153s)
[194.081206] Subtest crtc-invalid-params: SUCCESS (0.155s)
[194.203151] [034/133] (822s left) gem_exec_balancer (parallel-bb-first)
[194.368593] Subtest parallel-bb-first: SKIP (0.000s)
[194.456993] [035/133] (822s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[194.541455] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[203.559265] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.017s)
[203.677800] [036/133] (812s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[203.772535] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[203.773905] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[203.847583] [037/133] (812s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[203.883552] Starting subtest: protected-encrypted-src-copy-not-readible
[203.960799] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.077s)
[204.062363] [038/133] (812s left) gem_exec_flush (basic-wb-prw-default)
[204.104092] Starting subtest: basic-wb-prw-default
[209.534329] Subtest basic-wb-prw-default: SUCCESS (5.430s)
[209.732948] [039/133] (807s left) syncobj_wait (wait-any-snapshot)
[209.773031] Starting subtest: wait-any-snapshot
[209.855510] Subtest wait-any-snapshot: SUCCESS (0.082s)
[209.940795] [040/133] (806s left) gem_exec_reloc (basic-gtt-noreloc)
[209.978656] Starting subtest: basic-gtt-noreloc
[209.982673] Subtest basic-gtt-noreloc: SUCCESS (0.004s)
[210.093618] [041/133] (806s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[210.179535] Starting subtest: addfb25-y-tiled-small-legacy
[210.180234] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[210.270965] [042/133] (806s left) gem_softpin (softpin)
[210.310764] Starting subtest: softpin
[242.661738] Subtest softpin: SUCCESS (32.341s)
[242.755746] [043/133] (774s left) kms_vblank (wait-busy-hang)
[242.844362] Starting subtest: wait-busy-hang
[242.845027] Starting dynamic subtest: pipe-A-HDMI-A-1
[256.658558] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (13.813s)
[256.669039] Starting dynamic subtest: pipe-D-HDMI-A-1
[270.467067] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.805s)
[270.467803] Subtest wait-busy-hang: SUCCESS (27.623s)
[270.614334] [044/133] (746s left) gem_gpgpu_fill (basic)
[270.653587] Starting subtest: basic
[270.654307] Starting dynamic subtest: smem
[270.659279] Dynamic subtest smem: SUCCESS (0.006s)
[270.659979] Subtest basic: SUCCESS (0.006s)
[270.768664] [045/133] (746s left) gem_spin_batch (resubmit-new)
[270.809557] Starting subtest: resubmit-new
[270.810300] Starting dynamic subtest: rcs0
[270.812234] Dynamic subtest rcs0: SUCCESS (0.003s)
[270.819774] Starting dynamic subtest: bcs0
[270.820444] Dynamic subtest bcs0: SUCCESS (0.002s)
[270.827900] Starting dynamic subtest: vcs0
[270.828580] Dynamic subtest vcs0: SUCCESS (0.003s)
[270.835191] Starting dynamic subtest: vcs1
[270.835878] Dynamic subtest vcs1: SUCCESS (0.003s)
[270.842434] Starting dynamic subtest: vecs0
[270.843115] Dynamic subtest vecs0: SUCCESS (0.002s)
[270.843778] Subtest resubmit-new: SUCCESS (0.015s)
[271.006809] [046/133] (746s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[271.092591] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[271.093300] Starting dynamic subtest: pipe-A-HDMI-A-1
[271.099886] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[271.107197] Starting dynamic subtest: pipe-B-HDMI-A-1
[271.113717] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[271.120794] Starting dynamic subtest: pipe-C-HDMI-A-1
[271.127283] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[271.133933] Starting dynamic subtest: pipe-D-HDMI-A-1
[271.140570] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[271.141884] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[271.322546] [047/133] (745s left) kms_pm_rpm (dpms-non-lpsp)
[272.713804] Starting subtest: dpms-non-lpsp
[272.715760] Subtest dpms-non-lpsp: SKIP (0.001s)
[272.903481] [048/133] (744s left) kms_lease (lease-again)
[272.990670] Starting subtest: lease-again
[272.991343] Starting dynamic subtest: pipe-A-HDMI-A-1
[272.992985] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[273.001005] Starting dynamic subtest: pipe-B-HDMI-A-1
[273.001743] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[273.008788] Starting dynamic subtest: pipe-C-HDMI-A-1
[273.009475] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[273.016322] Starting dynamic subtest: pipe-D-HDMI-A-1
[273.017004] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[273.017699] Subtest lease-again: SUCCESS (0.010s)
[273.055277] [049/133] (744s left) kms_psr (fbc-pr-primary-page-flip)
[273.141703] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[273.190773] [050/133] (744s left) kms_psr2_su (page_flip-nv12)
[273.224202] Subtest page_flip-NV12: SKIP (0.000s)
[273.269816] [051/133] (743s left) gem_ctx_param (get-priority-new-ctx)
[273.302454] Starting subtest: get-priority-new-ctx
[273.303149] Subtest get-priority-new-ctx: SUCCESS (0.000s)
[273.366738] [052/133] (743s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[273.450891] Starting subtest: cursorB-vs-flipA-legacy
[273.453878] Subtest cursorB-vs-flipA-legacy: SKIP (0.002s)
[273.514375] [053/133] (743s left) kms_plane (pixel-format-linear-modifier)
[273.600689] Starting subtest: pixel-format-linear-modifier
[273.620313] Starting dynamic subtest: pipe-A-plane-0
[276.104123] Dynamic subtest pipe-A-plane-0: SUCCESS (2.484s)
[276.120806] Starting dynamic subtest: pipe-A-plane-3
[278.312381] Dynamic subtest pipe-A-plane-3: SUCCESS (2.207s)
[278.325665] Starting dynamic subtest: pipe-A-plane-5
[279.496280] Dynamic subtest pipe-A-plane-5: SUCCESS (1.183s)
[279.512604] Starting dynamic subtest: pipe-A-plane-7
[279.604629] Dynamic subtest pipe-A-plane-7: SUCCESS (0.107s)
[279.761837] Starting dynamic subtest: pipe-B-plane-0
[282.213529] Dynamic subtest pipe-B-plane-0: SUCCESS (2.459s)
[282.230460] Starting dynamic subtest: pipe-B-plane-3
[284.455522] Dynamic subtest pipe-B-plane-3: SUCCESS (2.240s)
[284.472505] Starting dynamic subtest: pipe-B-plane-5
[285.664220] Dynamic subtest pipe-B-plane-5: SUCCESS (1.207s)
[285.681155] Starting dynamic subtest: pipe-B-plane-7
[285.772455] Dynamic subtest pipe-B-plane-7: SUCCESS (0.107s)
[285.854792] Subtest pixel-format-linear-modifier: SUCCESS (12.255s)
[285.980012] [054/133] (731s left) kms_plane (plane-panning-bottom-right)
[286.072706] Starting subtest: plane-panning-bottom-right
[286.073402] Starting dynamic subtest: pipe-A
[286.429945] Dynamic subtest pipe-A: SUCCESS (0.356s)
[286.437857] Starting dynamic subtest: pipe-B
[286.778558] Dynamic subtest pipe-B: SUCCESS (0.346s)
[286.779255] Subtest plane-panning-bottom-right: SUCCESS (0.706s)
[286.899012] [055/133] (730s left) i915_suspend (basic-s3-without-i915)
[286.933964] Starting subtest: basic-s3-without-i915