[68.585112] Initializing watchdogs
[68.585170]   /dev/watchdog0
[68.600469] [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]
[68.606299] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[68.608782] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[68.610605] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[68.710604] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[68.712069] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[68.811582] [002/133] (960s left) syncobj_timeline (wait-for-submit-delayed-submit)
[68.845331] Starting subtest: wait-for-submit-delayed-submit
[68.947459] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[69.027700] [003/133] (960s left) kms_chamelium_hpd (dp-hpd)
[69.171876] Subtest dp-hpd: SKIP (0.000s)
[69.261425] [004/133] (959s left) kms_cursor_edge_walk (256x256-top-bottom)
[69.349433] Starting subtest: 256x256-top-bottom
[69.350100] Starting dynamic subtest: pipe-A-HDMI-A-1
[71.106123] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.755s)
[71.112219] Starting dynamic subtest: pipe-D-HDMI-A-1
[72.778539] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.670s)
[72.779239] Subtest 256x256-top-bottom: SUCCESS (3.429s)
[72.907616] [005/133] (956s left) gem_mmap_offset (clear)
[72.939588] Starting subtest: clear
[72.941514] Starting dynamic subtest: smem0
[95.661120] Dynamic subtest smem0: SUCCESS (22.717s)
[95.661901] Subtest clear: SUCCESS (22.717s)
[95.798377] [006/133] (933s left) kms_joiner (basic-force-big-joiner)
[95.937461] Starting subtest: basic-force-big-joiner
[95.938791] Subtest basic-force-big-joiner: SKIP (0.000s)
[96.010822] [007/133] (933s left) gem_exec_balancer (waits)
[96.054430] Starting subtest: waits
[102.952224] Subtest waits: SUCCESS (6.863s)
[103.149971] [008/133] (926s left) gem_exec_whisper (basic-queues)
[103.191465] Starting subtest: basic-queues
[104.876528] Subtest basic-queues: SUCCESS (1.684s)
[105.053764] [009/133] (924s left) gem_exec_suspend (basic-s3)
[105.093584] Starting subtest: basic-S3
[105.094328] Starting dynamic subtest: smem
[122.703441] Dynamic subtest smem: SUCCESS (2.801s)
[122.704166] Subtest basic-S3: SUCCESS (2.801s)
[135.947155] [010/133] (906s left) kms_psr (psr2-sprite-render)
[136.044771] Subtest psr2-sprite-render: SKIP (0.000s)
[136.086230] [011/133] (906s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[136.174126] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[136.175510] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[136.276185] [012/133] (906s left) kms_content_protection (atomic)
[136.367526] Starting subtest: atomic
[136.380921] Subtest atomic: SKIP (0.012s)
[136.489616] [013/133] (906s left) kms_async_flips (invalid-async-flip)
[136.573175] Starting subtest: invalid-async-flip
[136.698019] Starting dynamic subtest: pipe-A-HDMI-A-1
[136.833744] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.135s)
[136.965759] Starting dynamic subtest: pipe-B-HDMI-A-1
[137.058008] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.100s)
[137.174583] Starting dynamic subtest: pipe-C-HDMI-A-1
[137.272142] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.106s)
[137.398855] Starting dynamic subtest: pipe-D-HDMI-A-1
[137.486236] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.093s)
[137.487001] Subtest invalid-async-flip: SUCCESS (0.908s)
[137.735769] [014/133] (904s left) kms_flip (blocking-absolute-wf_vblank)
[137.827757] Starting subtest: blocking-absolute-wf_vblank
[137.829370] Starting dynamic subtest: A-HDMI-A1
[145.564661] Dynamic subtest A-HDMI-A1: SUCCESS (7.690s)
[145.571634] Starting dynamic subtest: B-HDMI-A1
[153.242378] Dynamic subtest B-HDMI-A1: SUCCESS (7.656s)
[153.248921] Starting dynamic subtest: C-HDMI-A1
[160.872696] Dynamic subtest C-HDMI-A1: SUCCESS (7.649s)
[160.883726] Starting dynamic subtest: D-HDMI-A1
[168.530150] Dynamic subtest D-HDMI-A1: SUCCESS (7.655s)
[168.532217] Subtest blocking-absolute-wf_vblank: SUCCESS (30.658s)
[168.704405] [015/133] (874s left) gem_exec_schedule (reorder-wide)
[168.878403] Starting subtest: reorder-wide
[168.879381] Starting dynamic subtest: rcs0
[168.983019] Dynamic subtest rcs0: SUCCESS (0.104s)
[168.994638] Starting dynamic subtest: bcs0
[169.056212] Dynamic subtest bcs0: SUCCESS (0.072s)
[169.067284] Starting dynamic subtest: vcs0
[169.127870] Dynamic subtest vcs0: SUCCESS (0.071s)
[169.139899] Starting dynamic subtest: vcs1
[169.199959] Dynamic subtest vcs1: SUCCESS (0.071s)
[169.210703] Starting dynamic subtest: vecs0
[169.270717] Dynamic subtest vecs0: SUCCESS (0.070s)
[169.271751] Subtest reorder-wide: SUCCESS (0.393s)
[169.454722] [FACT gem_exec_schedule (reorder-wide)] new: kernel.kmod_is_loaded.vgem: true
[169.456433] [016/133] (873s left) gem_watchdog (default-virtual)
[169.494683] Starting subtest: default-virtual
[170.766331] Subtest default-virtual: SUCCESS (1.263s)
[170.881630] [017/133] (871s left) gem_pwrite (basic-self)
[170.912971] Starting subtest: basic-self
[170.951065] Subtest basic-self: SUCCESS (0.038s)
[171.032409] [018/133] (871s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[171.121758] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[171.193429] [019/133] (871s left) kms_cursor_legacy (forked-move)
[171.281270] Starting subtest: forked-move
[171.281998] Starting dynamic subtest: pipe-A
[176.726731] Dynamic subtest pipe-A: SUCCESS (5.411s)
[176.734876] Starting dynamic subtest: pipe-B
[182.161687] Dynamic subtest pipe-B: SUCCESS (5.434s)
[182.170111] Starting dynamic subtest: pipe-C
[187.587473] Dynamic subtest pipe-C: SUCCESS (5.424s)
[187.595719] Starting dynamic subtest: pipe-D
[193.013360] Dynamic subtest pipe-D: SUCCESS (5.424s)
[193.023464] Starting dynamic subtest: all-pipes
[198.451702] Dynamic subtest all-pipes: SUCCESS (5.435s)
[198.452672] Subtest forked-move: SUCCESS (27.131s)
[198.495424] [020/133] (844s left) vgem_basic (debugfs)
[198.532522] Starting subtest: debugfs
[198.533281] Subtest debugfs: SUCCESS (0.000s)
[198.612559] [021/133] (844s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[198.707059] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[198.708390] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[198.812963] [022/133] (844s left) kms_plane_lowres (tiling-yf)
[198.897007] Starting subtest: tiling-yf
[198.898372] Subtest tiling-yf: SKIP (0.000s)
[198.967481] [023/133] (844s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[199.049858] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[199.059277] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.009s)
[199.154472] [024/133] (843s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[199.239177] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[199.239847] Starting dynamic subtest: pipe-A-valid-mode
[200.091417] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.851s)
[200.092177] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (0.852s)
[200.241347] [025/133] (842s left) kms_vrr (flip-basic)
[200.329407] Starting subtest: flip-basic
[200.331486] Subtest flip-basic: SKIP (0.000s)
[200.411381] [026/133] (842s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[200.500118] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[200.501480] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[200.602472] [027/133] (842s left) kms_flip (modeset-vs-vblank-race-interruptible)
[200.691057] Starting subtest: modeset-vs-vblank-race-interruptible
[200.693324] Starting dynamic subtest: A-HDMI-A1
[203.535572] Dynamic subtest A-HDMI-A1: SUCCESS (2.841s)
[203.546398] Starting dynamic subtest: B-HDMI-A1
[206.333801] Dynamic subtest B-HDMI-A1: SUCCESS (2.796s)
[206.349290] Starting dynamic subtest: C-HDMI-A1
[209.182536] Dynamic subtest C-HDMI-A1: SUCCESS (2.846s)
[209.191035] Starting dynamic subtest: D-HDMI-A1
[211.968439] Dynamic subtest D-HDMI-A1: SUCCESS (2.783s)
[211.971117] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (11.276s)
[212.165166] [028/133] (831s left) kms_addfb_basic (bad-pitch-63)
[212.214245] Starting subtest: bad-pitch-63
[212.214939] Subtest bad-pitch-63: SUCCESS (0.000s)
[212.385014] [029/133] (830s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[212.473245] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[212.474586] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[212.601458] [030/133] (830s left) syncobj_wait (invalid-reset-one-illegal-handle)
[212.636497] Starting subtest: invalid-reset-one-illegal-handle
[212.637279] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[212.716983] [031/133] (830s left) gem_ctx_persistence (legacy-engines-queued)
[212.753510] Starting subtest: legacy-engines-queued
[212.755334] Starting dynamic subtest: render
[212.804171] Dynamic subtest render: SUCCESS (0.049s)
[212.820459] Starting dynamic subtest: bsd1
[212.851015] Dynamic subtest bsd1: SUCCESS (0.044s)
[212.865693] Starting dynamic subtest: bsd2
[212.906182] Dynamic subtest bsd2: SUCCESS (0.052s)
[212.922414] Starting dynamic subtest: blt
[212.968107] Dynamic subtest blt: SUCCESS (0.059s)
[212.985777] Starting dynamic subtest: vebox
[213.024052] Dynamic subtest vebox: SUCCESS (0.053s)
[213.025255] Subtest legacy-engines-queued: SUCCESS (0.271s)
[213.108838] [032/133] (830s left) syncobj_wait (invalid-single-wait-unsubmitted)
[213.142029] Starting subtest: invalid-single-wait-unsubmitted
[213.142703] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[213.223449] [033/133] (830s left) gem_pxp (verify-pxp-stale-ctx-execution)
[213.323680] Starting subtest: verify-pxp-stale-ctx-execution
[214.400887] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.078s)
[214.537429] [034/133] (828s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[214.571253] Starting subtest: cpuset-basic-small-copy-odd
[218.166206] Subtest cpuset-basic-small-copy-odd: SUCCESS (3.593s)
[218.241756] [035/133] (825s left) kms_cursor_crc (cursor-onscreen-512x170)
[218.390507] Starting subtest: cursor-onscreen-512x170
[218.391987] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[218.504239] [036/133] (825s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[218.596410] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[218.597819] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[218.696459] [037/133] (824s left) kms_chamelium_color (ctm-0-25)
[218.783779] Subtest ctm-0-25: SKIP (0.000s)
[218.830597] [038/133] (824s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[218.872056] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[218.975240] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.103s)
[219.073697] [039/133] (824s left) gem_exec_fence (syncobj-timeline-unused-fence)
[219.538918] Starting subtest: syncobj-timeline-unused-fence
[219.539896] Subtest syncobj-timeline-unused-fence: SUCCESS (0.005s)
[219.722669] [040/133] (824s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[219.810016] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[219.811393] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[219.923256] [041/133] (823s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[220.013258] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[220.014607] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[220.122147] [042/133] (823s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[220.258838] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[220.356016] [043/133] (823s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[220.443945] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[220.444677] Starting dynamic subtest: pipe-A
[221.713007] Dynamic subtest pipe-A: SUCCESS (1.269s)
[221.731911] Starting dynamic subtest: pipe-B
[222.981411] Dynamic subtest pipe-B: SUCCESS (1.266s)
[222.991992] Starting dynamic subtest: pipe-C
[223.183023] Dynamic subtest pipe-C: SUCCESS (0.200s)
[223.200718] Starting dynamic subtest: pipe-D
[223.384688] Dynamic subtest pipe-D: SUCCESS (0.200s)
[223.385475] Subtest plane-downscale-factor-0-5-with-pixel-format: SUCCESS (2.941s)
[223.581272] [044/133] (820s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[223.621830] Starting subtest: y-tiled-to-vebox-x-tiled
[223.622518] Starting dynamic subtest: smem
[223.716137] Dynamic subtest smem: SUCCESS (0.094s)
[223.716833] Subtest y-tiled-to-vebox-x-tiled: SUCCESS (0.095s)
[223.920643] [045/133] (820s left) gen9_exec_parse (batch-without-end)
[223.957468] Subtest batch-without-end: SKIP (0.000s)
[224.001466] [046/133] (820s left) syncobj_timeline (etime-single-wait-submitted)
[224.034928] Starting subtest: etime-single-wait-submitted
[224.143297] Subtest etime-single-wait-submitted: SUCCESS (0.108s)
[224.236516] [047/133] (819s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[224.336667] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[224.338107] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[224.461456] [048/133] (819s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[224.553307] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[224.554667] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[224.669788] [049/133] (819s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[224.756472] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[224.757186] Starting dynamic subtest: pipe-A-HDMI-A-1
[241.353029] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.446s)
[241.361669] Starting dynamic subtest: pipe-B-HDMI-A-1
[258.329356] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.352s)
[258.340549] Starting dynamic subtest: pipe-C-HDMI-A-1
[274.328257] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.332s)
[274.337721] Starting dynamic subtest: pipe-D-HDMI-A-1
[291.324695] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.337s)
[291.325393] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SUCCESS (5.476s)
[303.573073] [050/133] (752s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[303.661653] Starting subtest: plane-use-after-nonblocking-unbind
[303.662580] Starting dynamic subtest: pipe-A-HDMI-A-1
[303.717134] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.054s)
[303.784746] Starting dynamic subtest: pipe-B-HDMI-A-1
[303.946383] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.169s)
[303.986193] Subtest plane-use-after-nonblocking-unbind: SUCCESS (0.324s)
[304.131389] [051/133] (752s left) gem_partial_pwrite_pread (reads-uncached)
[304.168230] Starting subtest: reads-uncached
[306.024083] Subtest reads-uncached: SUCCESS (1.850s)
[306.145832] [052/133] (750s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[306.180026] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[306.180769] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[306.265564] [053/133] (750s left) i915_pm_rc6_residency (rc6-fence)
[306.297696] Starting subtest: rc6-fence
[306.302856] Starting dynamic subtest: gt0
[324.617288] Dynamic subtest gt0: SUCCESS (18.269s)
[324.618211] Subtest rc6-fence: SUCCESS (18.276s)
[324.686533] [054/133] (731s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[324.776953] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[324.778402] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[324.903528] [055/133] (731s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[324.994497] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[324.995886] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[325.107209] [056/133] (731s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[325.200221] Starting subtest: yf-tiled-16bpp-rotate-180
[325.201576] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[325.312784] [057/133] (731s left) gem_ctx_param (root-set)
[325.345482] Starting subtest: root-set
[325.346157] Subtest root-set: SUCCESS (0.000s)
[325.436407] [058/133] (731s left) gem_exec_fence (syncobj-invalid-wait)
[325.762195] Starting subtest: syncobj-invalid-wait
[325.762958] Subtest syncobj-invalid-wait: SUCCESS (0.000s)
[326.072534] [059/133] (730s left) kms_lease (invalid-create-leases)
[326.156765] Starting subtest: invalid-create-leases
[326.159653] Subtest invalid-create-leases: SUCCESS (0.003s)
[326.224917] [060/133] (730s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[326.309714] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[326.310423] Starting dynamic subtest: pipe-A-HDMI-A-1
[326.317022] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[326.324710] Starting dynamic subtest: pipe-B-HDMI-A-1
[326.331477] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[326.339026] Starting dynamic subtest: pipe-C-HDMI-A-1
[326.345565] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[326.353051] Starting dynamic subtest: pipe-D-HDMI-A-1
[326.359736] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[326.361041] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[326.561173] [061/133] (730s left) kms_sequence (queue-busy)
[326.647873] Starting subtest: queue-busy
[326.648581] Starting dynamic subtest: pipe-A-HDMI-A-1
[327.950155] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.300s)
[327.961962] Starting dynamic subtest: pipe-B-HDMI-A-1
[329.232128] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.279s)
[329.240960] Starting dynamic subtest: pipe-C-HDMI-A-1
[330.509359] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.274s)
[330.518312] Starting dynamic subtest: pipe-D-HDMI-A-1
[331.786510] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.275s)
[331.787209] Subtest queue-busy: SUCCESS (5.137s)
[331.924369] [062/133] (724s left) prime_vgem (basic-fence-blt)
[331.993326] Starting subtest: basic-fence-blt
[332.074828] Subtest basic-fence-blt: SUCCESS (0.081s)
[332.169611] [063/133] (724s left) i915_suspend (basic-s3-without-i915)
[332.201698] Starting subtest: basic-s3-without-i915