[56.331697] Initializing watchdogs
[56.331758]   /dev/watchdog0
[56.346873] [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]
[56.352444] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.355266] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.357089] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[56.450484] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[56.451828] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[56.624986] [002/133] (960s left) syncobj_timeline (wait-for-submit-delayed-submit)
[56.657447] Starting subtest: wait-for-submit-delayed-submit
[56.760519] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[56.888926] [003/133] (960s left) kms_chamelium_hpd (dp-hpd)
[57.023782] Subtest dp-hpd: SKIP (0.000s)
[57.100255] [004/133] (959s left) kms_cursor_edge_walk (256x256-top-bottom)
[57.186373] Starting subtest: 256x256-top-bottom
[57.187085] Starting dynamic subtest: pipe-A-HDMI-A-1
[60.902561] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.716s)
[60.908427] Starting dynamic subtest: pipe-D-HDMI-A-1
[64.514061] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (3.610s)
[64.514805] Subtest 256x256-top-bottom: SUCCESS (7.328s)
[64.677579] [005/133] (952s left) gem_mmap_offset (clear)
[64.711976] Starting subtest: clear
[64.714993] Starting dynamic subtest: smem0
[87.078871] Dynamic subtest smem0: SUCCESS (22.368s)
[87.079556] Subtest clear: SUCCESS (22.368s)
[87.247648] [006/133] (929s left) kms_joiner (basic-force-big-joiner)
[87.390465] Starting subtest: basic-force-big-joiner
[87.391814] Subtest basic-force-big-joiner: SKIP (0.000s)
[87.498375] [007/133] (929s left) gem_exec_balancer (waits)
[87.543163] Starting subtest: waits
[94.496394] Subtest waits: SUCCESS (6.942s)
[94.733732] [008/133] (922s left) gem_exec_whisper (basic-queues)
[94.775934] Starting subtest: basic-queues
[96.533069] Subtest basic-queues: SUCCESS (1.756s)
[96.784146] [009/133] (920s left) gem_exec_suspend (basic-s3)
[96.824138] Starting subtest: basic-S3
[96.824918] Starting dynamic subtest: smem
[114.154136] Dynamic subtest smem: SUCCESS (2.839s)
[114.154933] Subtest basic-S3: SUCCESS (2.840s)
[122.409578] [010/133] (902s left) kms_psr (psr2-sprite-render)
[122.509090] Subtest psr2-sprite-render: SKIP (0.000s)
[122.547591] [011/133] (902s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[122.636494] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[122.637920] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[122.774363] [012/133] (902s left) kms_content_protection (atomic)
[122.869291] Starting subtest: atomic
[122.882414] Subtest atomic: SKIP (0.011s)
[123.041028] [013/133] (902s left) kms_async_flips (invalid-async-flip)
[123.124965] Starting subtest: invalid-async-flip
[123.311362] Starting dynamic subtest: pipe-A-HDMI-A-1
[123.509812] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.198s)
[123.675420] Starting dynamic subtest: pipe-B-HDMI-A-1
[123.785512] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.117s)
[123.949208] Starting dynamic subtest: pipe-C-HDMI-A-1
[124.062475] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.119s)
[124.222959] Starting dynamic subtest: pipe-D-HDMI-A-1
[124.324876] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.109s)
[124.325574] Subtest invalid-async-flip: SUCCESS (1.200s)
[124.623631] [014/133] (900s left) kms_flip (blocking-absolute-wf_vblank)
[124.711516] Starting subtest: blocking-absolute-wf_vblank
[124.713118] Starting dynamic subtest: A-HDMI-A1
[132.531626] Dynamic subtest A-HDMI-A1: SUCCESS (7.814s)
[132.541225] Starting dynamic subtest: B-HDMI-A1
[140.306677] Dynamic subtest B-HDMI-A1: SUCCESS (7.756s)
[140.313939] Starting dynamic subtest: C-HDMI-A1
[148.067739] Dynamic subtest C-HDMI-A1: SUCCESS (7.758s)
[148.076546] Starting dynamic subtest: D-HDMI-A1
[155.815483] Dynamic subtest D-HDMI-A1: SUCCESS (7.761s)
[155.819252] Subtest blocking-absolute-wf_vblank: SUCCESS (31.099s)
[156.060374] [015/133] (869s left) gem_exec_schedule (reorder-wide)
[156.233548] Starting subtest: reorder-wide
[156.234493] Starting dynamic subtest: rcs0
[156.334636] Dynamic subtest rcs0: SUCCESS (0.102s)
[156.344750] Starting dynamic subtest: bcs0
[156.407785] Dynamic subtest bcs0: SUCCESS (0.072s)
[156.418813] Starting dynamic subtest: vcs0
[156.478615] Dynamic subtest vcs0: SUCCESS (0.070s)
[156.488848] Starting dynamic subtest: vcs1
[156.554883] Dynamic subtest vcs1: SUCCESS (0.074s)
[156.564678] Starting dynamic subtest: vecs0
[156.625831] Dynamic subtest vecs0: SUCCESS (0.072s)
[156.626710] Subtest reorder-wide: SUCCESS (0.394s)
[156.852385] [FACT gem_exec_schedule (reorder-wide)] new: kernel.kmod_is_loaded.vgem: true
[156.853936] [016/133] (868s left) gem_watchdog (default-virtual)
[156.892157] Starting subtest: default-virtual
[158.165459] Subtest default-virtual: SUCCESS (1.264s)
[158.269871] [017/133] (867s left) gem_pwrite (basic-self)
[158.301736] Starting subtest: basic-self
[158.341485] Subtest basic-self: SUCCESS (0.040s)
[158.485039] [018/133] (867s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[158.570674] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[158.624385] [019/133] (866s left) kms_cursor_legacy (forked-move)
[158.707997] Starting subtest: forked-move
[158.708720] Starting dynamic subtest: pipe-A
[164.157831] Dynamic subtest pipe-A: SUCCESS (5.414s)
[164.166567] Starting dynamic subtest: pipe-B
[169.593158] Dynamic subtest pipe-B: SUCCESS (5.434s)
[169.601509] Starting dynamic subtest: pipe-C
[175.021308] Dynamic subtest pipe-C: SUCCESS (5.427s)
[175.029741] Starting dynamic subtest: pipe-D
[180.446837] Dynamic subtest pipe-D: SUCCESS (5.424s)
[180.456525] Starting dynamic subtest: all-pipes
[185.883971] Dynamic subtest all-pipes: SUCCESS (5.436s)
[185.884809] Subtest forked-move: SUCCESS (27.136s)
[185.970336] [020/133] (839s left) vgem_basic (debugfs)
[186.016530] Starting subtest: debugfs
[186.017357] Subtest debugfs: SUCCESS (0.001s)
[186.139815] [021/133] (839s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[186.228244] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[186.229664] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[186.394075] [022/133] (839s left) kms_plane_lowres (tiling-yf)
[186.478222] Starting subtest: tiling-yf
[186.479595] Subtest tiling-yf: SKIP (0.000s)
[186.594651] [023/133] (839s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[186.686234] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[186.688448] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.009s)
[186.818756] [024/133] (838s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[186.902141] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[186.902870] Starting dynamic subtest: pipe-A-valid-mode
[187.644385] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.741s)
[187.645095] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (0.742s)
[187.854438] [025/133] (837s left) kms_vrr (flip-basic)
[187.937115] Starting subtest: flip-basic
[187.939097] Subtest flip-basic: SKIP (0.000s)
[188.081638] [026/133] (837s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[188.166981] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[188.168318] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[188.308704] [027/133] (837s left) kms_flip (modeset-vs-vblank-race-interruptible)
[188.395047] Starting subtest: modeset-vs-vblank-race-interruptible
[188.396981] Starting dynamic subtest: A-HDMI-A1
[191.447782] Dynamic subtest A-HDMI-A1: SUCCESS (3.050s)
[191.463847] Starting dynamic subtest: B-HDMI-A1
[194.439028] Dynamic subtest B-HDMI-A1: SUCCESS (2.989s)
[194.455241] Starting dynamic subtest: C-HDMI-A1
[197.418174] Dynamic subtest C-HDMI-A1: SUCCESS (2.977s)
[197.427286] Starting dynamic subtest: D-HDMI-A1
[200.459350] Dynamic subtest D-HDMI-A1: SUCCESS (3.039s)
[200.463893] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (12.067s)
[200.683497] [028/133] (825s left) kms_addfb_basic (bad-pitch-63)
[200.724577] Starting subtest: bad-pitch-63
[200.725379] Subtest bad-pitch-63: SUCCESS (0.000s)
[200.950251] [029/133] (825s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[201.037108] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[201.038576] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[201.197510] [030/133] (824s left) syncobj_wait (invalid-reset-one-illegal-handle)
[201.232027] Starting subtest: invalid-reset-one-illegal-handle
[201.232729] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[201.347820] [031/133] (824s left) gem_ctx_persistence (legacy-engines-queued)
[201.386129] Starting subtest: legacy-engines-queued
[201.387840] Starting dynamic subtest: render
[201.459180] Dynamic subtest render: SUCCESS (0.072s)
[201.471885] Starting dynamic subtest: bsd1
[201.526141] Dynamic subtest bsd1: SUCCESS (0.065s)
[201.543455] Starting dynamic subtest: bsd2
[201.602063] Dynamic subtest bsd2: SUCCESS (0.074s)
[201.619296] Starting dynamic subtest: blt
[201.674168] Dynamic subtest blt: SUCCESS (0.070s)
[201.691706] Starting dynamic subtest: vebox
[201.743129] Dynamic subtest vebox: SUCCESS (0.067s)
[201.744103] Subtest legacy-engines-queued: SUCCESS (0.358s)
[201.879391] [032/133] (824s left) syncobj_wait (invalid-single-wait-unsubmitted)
[201.913427] Starting subtest: invalid-single-wait-unsubmitted
[201.914112] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[202.052339] [033/133] (824s left) gem_pxp (verify-pxp-stale-ctx-execution)
[202.153449] Starting subtest: verify-pxp-stale-ctx-execution
[203.217933] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.065s)
[203.394828] [034/133] (822s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[203.427980] Starting subtest: cpuset-basic-small-copy-odd
[206.979297] Subtest cpuset-basic-small-copy-odd: SUCCESS (3.551s)
[207.098718] [035/133] (819s left) kms_cursor_crc (cursor-onscreen-512x170)
[207.246406] Starting subtest: cursor-onscreen-512x170
[207.247712] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[207.402824] [036/133] (818s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[207.489109] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[207.490489] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[207.630650] [037/133] (818s left) kms_chamelium_color (ctm-0-25)
[207.714540] Subtest ctm-0-25: SKIP (0.000s)
[207.765642] [038/133] (818s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[207.807092] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[207.912794] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s)
[208.049364] [039/133] (818s left) gem_exec_fence (syncobj-timeline-unused-fence)
[208.481968] Starting subtest: syncobj-timeline-unused-fence
[208.482967] Subtest syncobj-timeline-unused-fence: SUCCESS (0.005s)
[208.693275] [040/133] (817s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[208.780699] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[208.782139] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[208.939476] [041/133] (817s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[209.027454] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[209.028841] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[209.186466] [042/133] (817s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[209.315725] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[209.398264] [043/133] (817s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[209.484521] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[209.485207] Starting dynamic subtest: pipe-A
[212.050453] Dynamic subtest pipe-A: SUCCESS (2.565s)
[212.066312] Starting dynamic subtest: pipe-B
[214.580877] Dynamic subtest pipe-B: SUCCESS (2.529s)
[214.593732] Starting dynamic subtest: pipe-C
[214.910051] Dynamic subtest pipe-C: SUCCESS (0.327s)
[214.926293] Starting dynamic subtest: pipe-D
[215.240507] Dynamic subtest pipe-D: SUCCESS (0.329s)
[215.241842] Subtest plane-downscale-factor-0-5-with-pixel-format: SUCCESS (5.757s)
[215.485927] [044/133] (811s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[215.526541] Starting subtest: y-tiled-to-vebox-x-tiled
[215.527230] Starting dynamic subtest: smem
[215.620271] Dynamic subtest smem: SUCCESS (0.094s)
[215.621034] Subtest y-tiled-to-vebox-x-tiled: SUCCESS (0.095s)
[215.841404] [045/133] (810s left) gen9_exec_parse (batch-without-end)
[215.877889] Subtest batch-without-end: SKIP (0.000s)
[215.923422] [046/133] (810s left) syncobj_timeline (etime-single-wait-submitted)
[215.957185] Starting subtest: etime-single-wait-submitted
[216.064104] Subtest etime-single-wait-submitted: SUCCESS (0.107s)
[216.205851] [047/133] (810s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[216.303555] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[216.304884] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[216.472453] [048/133] (810s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[216.574942] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[216.576315] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[216.736791] [049/133] (810s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[216.820638] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[216.822416] Starting dynamic subtest: pipe-A-HDMI-A-1
[233.893228] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.619s)
[233.911613] Starting dynamic subtest: pipe-B-HDMI-A-1
[250.872420] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.521s)
[250.890607] Starting dynamic subtest: pipe-C-HDMI-A-1
[267.863718] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.544s)
[267.882341] Starting dynamic subtest: pipe-D-HDMI-A-1
[284.893183] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.458s)
[284.894307] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SUCCESS (6.158s)
[293.163833] [050/133] (741s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[293.270100] Starting subtest: plane-use-after-nonblocking-unbind
[293.270930] Starting dynamic subtest: pipe-A-HDMI-A-1
[293.359646] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.088s)
[293.434086] Starting dynamic subtest: pipe-B-HDMI-A-1
[293.600326] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.173s)
[293.643732] Subtest plane-use-after-nonblocking-unbind: SUCCESS (0.373s)
[293.806989] [051/133] (741s left) gem_partial_pwrite_pread (reads-uncached)
[293.844243] Starting subtest: reads-uncached
[295.574165] Subtest reads-uncached: SUCCESS (1.730s)
[295.738622] [052/133] (739s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[295.772600] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[295.773290] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[295.912386] [053/133] (739s left) i915_pm_rc6_residency (rc6-fence)
[295.944969] Starting subtest: rc6-fence
[295.949920] Starting dynamic subtest: gt0
[314.241064] Dynamic subtest gt0: SUCCESS (18.266s)
[314.242090] Subtest rc6-fence: SUCCESS (18.273s)
[314.353960] [054/133] (720s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[314.442726] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[314.444078] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[314.585066] [055/133] (720s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[314.671996] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[314.673389] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[314.832397] [056/133] (720s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[314.924603] Starting subtest: yf-tiled-16bpp-rotate-180
[314.925920] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[315.096365] [057/133] (720s left) gem_ctx_param (root-set)
[315.128881] Starting subtest: root-set
[315.129581] Subtest root-set: SUCCESS (0.000s)
[315.248664] [058/133] (720s left) gem_exec_fence (syncobj-invalid-wait)
[315.563341] Starting subtest: syncobj-invalid-wait
[315.564087] Subtest syncobj-invalid-wait: SUCCESS (0.000s)
[315.934940] [059/133] (719s left) kms_lease (invalid-create-leases)
[316.021129] Starting subtest: invalid-create-leases
[316.024091] Subtest invalid-create-leases: SUCCESS (0.003s)
[316.119044] [060/133] (719s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[316.201126] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[316.202877] Starting dynamic subtest: pipe-A-HDMI-A-1
[316.209169] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[316.217028] Starting dynamic subtest: pipe-B-HDMI-A-1
[316.223349] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[316.231405] Starting dynamic subtest: pipe-C-HDMI-A-1
[316.237710] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[316.245301] Starting dynamic subtest: pipe-D-HDMI-A-1
[316.251822] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[316.253111] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[316.457555] [061/133] (718s left) kms_sequence (queue-busy)
[316.541157] Starting subtest: queue-busy
[316.542900] Starting dynamic subtest: pipe-A-HDMI-A-1
[319.355410] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.812s)
[319.364783] Starting dynamic subtest: pipe-B-HDMI-A-1
[322.051530] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.694s)
[322.060810] Starting dynamic subtest: pipe-C-HDMI-A-1
[324.757634] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.703s)
[324.766665] Starting dynamic subtest: pipe-D-HDMI-A-1
[327.468525] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.709s)
[327.469229] Subtest queue-busy: SUCCESS (10.926s)
[327.623668] [062/133] (707s left) prime_vgem (basic-fence-blt)
[327.700631] Starting subtest: basic-fence-blt
[327.781010] Subtest basic-fence-blt: SUCCESS (0.080s)
[327.909297] [063/133] (707s left) i915_suspend (basic-s3-without-i915)
[327.940176] Starting subtest: basic-s3-without-i915