[68.696553] Initializing watchdogs
[68.696618]   /dev/watchdog0
[68.711798] [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.717313] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[68.719783] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[68.721684] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[68.821790] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[68.823192] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[68.928538] [002/133] (960s left) syncobj_timeline (wait-for-submit-delayed-submit)
[68.961142] Starting subtest: wait-for-submit-delayed-submit
[69.064490] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[69.156583] [003/133] (960s left) kms_chamelium_hpd (dp-hpd)
[69.294147] Subtest dp-hpd: SKIP (0.000s)
[69.379036] [004/133] (959s left) kms_cursor_edge_walk (256x256-top-bottom)
[69.470061] Starting subtest: 256x256-top-bottom
[69.471352] Starting dynamic subtest: pipe-A-HDMI-A-1
[71.230088] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.760s)
[71.236965] Starting dynamic subtest: pipe-D-HDMI-A-1
[72.888014] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.658s)
[72.888787] Subtest 256x256-top-bottom: SUCCESS (3.422s)
[72.996937] [005/133] (956s left) gem_mmap_offset (clear)
[73.034365] Starting subtest: clear
[73.035772] Starting dynamic subtest: smem0
[95.759093] Dynamic subtest smem0: SUCCESS (22.720s)
[95.759828] Subtest clear: SUCCESS (22.721s)
[95.876715] [006/133] (933s left) kms_joiner (basic-force-big-joiner)
[96.018564] Starting subtest: basic-force-big-joiner
[96.019933] Subtest basic-force-big-joiner: SKIP (0.000s)
[96.096565] [007/133] (933s left) gem_exec_balancer (waits)
[96.140459] Starting subtest: waits
[103.029720] Subtest waits: SUCCESS (6.880s)
[103.215595] [008/133] (926s left) gem_exec_whisper (basic-queues)
[103.257137] Starting subtest: basic-queues
[104.956384] Subtest basic-queues: SUCCESS (1.698s)
[105.145063] [009/133] (924s left) gem_exec_suspend (basic-s3)
[105.183867] Starting subtest: basic-S3
[105.184594] Starting dynamic subtest: smem
[122.729922] Dynamic subtest smem: SUCCESS (2.792s)
[122.730646] Subtest basic-S3: SUCCESS (2.793s)
[130.942736] [010/133] (906s left) kms_psr (psr2-sprite-render)
[131.033100] Subtest psr2-sprite-render: SKIP (0.000s)
[131.074482] [011/133] (906s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[131.163396] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[131.164783] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[131.293369] [012/133] (906s left) kms_content_protection (atomic)
[131.387121] Starting subtest: atomic
[131.400550] Subtest atomic: SKIP (0.012s)
[131.515479] [013/133] (906s left) kms_async_flips (invalid-async-flip)
[131.597399] Starting subtest: invalid-async-flip
[131.718470] Starting dynamic subtest: pipe-A-HDMI-A-1
[131.845092] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.130s)
[131.962028] Starting dynamic subtest: pipe-B-HDMI-A-1
[132.056787] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.106s)
[132.160784] Starting dynamic subtest: pipe-C-HDMI-A-1
[132.251441] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.102s)
[132.360677] Starting dynamic subtest: pipe-D-HDMI-A-1
[132.443408] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.094s)
[132.444146] Subtest invalid-async-flip: SUCCESS (0.869s)
[132.660871] [014/133] (905s left) kms_flip (blocking-absolute-wf_vblank)
[132.750180] Starting subtest: blocking-absolute-wf_vblank
[132.752524] Starting dynamic subtest: A-HDMI-A1
[140.529564] Dynamic subtest A-HDMI-A1: SUCCESS (7.871s)
[140.536461] Starting dynamic subtest: B-HDMI-A1
[148.238230] Dynamic subtest B-HDMI-A1: SUCCESS (7.741s)
[148.245951] Starting dynamic subtest: C-HDMI-A1
[155.970959] Dynamic subtest C-HDMI-A1: SUCCESS (7.750s)
[155.978527] Starting dynamic subtest: D-HDMI-A1
[163.596478] Dynamic subtest D-HDMI-A1: SUCCESS (7.649s)
[163.597205] Subtest blocking-absolute-wf_vblank: SUCCESS (31.019s)
[163.752740] [015/133] (874s left) gem_exec_schedule (reorder-wide)
[163.927210] Starting subtest: reorder-wide
[163.928529] Starting dynamic subtest: rcs0
[164.034150] Dynamic subtest rcs0: SUCCESS (0.107s)
[164.046364] Starting dynamic subtest: bcs0
[164.106269] Dynamic subtest bcs0: SUCCESS (0.071s)
[164.117863] Starting dynamic subtest: vcs0
[164.178860] Dynamic subtest vcs0: SUCCESS (0.072s)
[164.190455] Starting dynamic subtest: vcs1
[164.249979] Dynamic subtest vcs1: SUCCESS (0.070s)
[164.261302] Starting dynamic subtest: vecs0
[164.325869] Dynamic subtest vecs0: SUCCESS (0.075s)
[164.326896] Subtest reorder-wide: SUCCESS (0.399s)
[164.510120] [FACT gem_exec_schedule (reorder-wide)] new: kernel.kmod_is_loaded.vgem: true
[164.511674] [016/133] (873s left) gem_watchdog (default-virtual)
[164.549631] Starting subtest: default-virtual
[165.819890] Subtest default-virtual: SUCCESS (1.262s)
[165.915637] [017/133] (871s left) gem_pwrite (basic-self)
[165.946942] Starting subtest: basic-self
[165.985472] Subtest basic-self: SUCCESS (0.038s)
[166.073390] [018/133] (871s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[166.159283] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[166.203128] [019/133] (871s left) kms_cursor_legacy (forked-move)
[166.288650] Starting subtest: forked-move
[166.289400] Starting dynamic subtest: pipe-A
[171.737645] Dynamic subtest pipe-A: SUCCESS (5.413s)
[171.746524] Starting dynamic subtest: pipe-B
[177.168053] Dynamic subtest pipe-B: SUCCESS (5.432s)
[177.177111] Starting dynamic subtest: pipe-C
[182.608636] Dynamic subtest pipe-C: SUCCESS (5.439s)
[182.619672] Starting dynamic subtest: pipe-D
[188.037789] Dynamic subtest pipe-D: SUCCESS (5.430s)
[188.046747] Starting dynamic subtest: all-pipes
[193.461909] Dynamic subtest all-pipes: SUCCESS (5.427s)
[193.462914] Subtest forked-move: SUCCESS (27.144s)
[193.526137] [020/133] (844s left) vgem_basic (debugfs)
[193.560916] Starting subtest: debugfs
[193.561634] Subtest debugfs: SUCCESS (0.001s)
[193.641694] [021/133] (844s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[193.732595] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[193.734025] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[193.836391] [022/133] (844s left) kms_plane_lowres (tiling-yf)
[193.921456] Starting subtest: tiling-yf
[193.922823] Subtest tiling-yf: SKIP (0.000s)
[194.001144] [023/133] (844s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[194.084341] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[194.093853] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.009s)
[194.227190] [024/133] (843s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[194.312779] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[194.313550] Starting dynamic subtest: pipe-A-valid-mode
[195.106294] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.793s)
[195.107008] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (0.794s)
[195.257737] [025/133] (842s left) kms_vrr (flip-basic)
[195.344657] Starting subtest: flip-basic
[195.346795] Subtest flip-basic: SKIP (0.000s)
[195.425915] [026/133] (842s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[195.514304] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[195.515695] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[195.645820] [027/133] (842s left) kms_flip (modeset-vs-vblank-race-interruptible)
[195.734141] Starting subtest: modeset-vs-vblank-race-interruptible
[195.736770] Starting dynamic subtest: A-HDMI-A1
[198.548465] Dynamic subtest A-HDMI-A1: SUCCESS (2.813s)
[198.557388] Starting dynamic subtest: B-HDMI-A1
[201.345753] Dynamic subtest B-HDMI-A1: SUCCESS (2.797s)
[201.354727] Starting dynamic subtest: C-HDMI-A1
[204.165508] Dynamic subtest C-HDMI-A1: SUCCESS (2.820s)
[204.174909] Starting dynamic subtest: D-HDMI-A1
[207.040202] Dynamic subtest D-HDMI-A1: SUCCESS (2.874s)
[207.042409] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (11.312s)
[207.227086] [028/133] (831s left) kms_addfb_basic (bad-pitch-63)
[207.268727] Starting subtest: bad-pitch-63
[207.269506] Subtest bad-pitch-63: SUCCESS (0.000s)
[207.456979] [029/133] (830s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[207.546069] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[207.547504] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[207.646082] [030/133] (830s left) syncobj_wait (invalid-reset-one-illegal-handle)
[207.679947] Starting subtest: invalid-reset-one-illegal-handle
[207.680666] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[207.772873] [031/133] (830s left) gem_ctx_persistence (legacy-engines-queued)
[207.811568] Starting subtest: legacy-engines-queued
[207.812265] Starting dynamic subtest: render
[207.859261] Dynamic subtest render: SUCCESS (0.047s)
[207.876005] Starting dynamic subtest: bsd1
[207.909365] Dynamic subtest bsd1: SUCCESS (0.047s)
[207.926383] Starting dynamic subtest: bsd2
[207.982470] Dynamic subtest bsd2: SUCCESS (0.070s)
[208.001176] Starting dynamic subtest: blt
[208.058450] Dynamic subtest blt: SUCCESS (0.073s)
[208.077267] Starting dynamic subtest: vebox
[208.131408] Dynamic subtest vebox: SUCCESS (0.070s)
[208.132539] Subtest legacy-engines-queued: SUCCESS (0.322s)
[208.223084] [032/133] (830s left) syncobj_wait (invalid-single-wait-unsubmitted)
[208.255697] Starting subtest: invalid-single-wait-unsubmitted
[208.256379] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[208.346596] [033/133] (830s left) gem_pxp (verify-pxp-stale-ctx-execution)
[208.447680] Starting subtest: verify-pxp-stale-ctx-execution
[209.512761] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.065s)
[209.644733] [034/133] (828s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[209.677751] Starting subtest: cpuset-basic-small-copy-odd
[213.263855] Subtest cpuset-basic-small-copy-odd: SUCCESS (3.587s)
[213.344456] [035/133] (825s left) kms_cursor_crc (cursor-onscreen-512x170)
[213.481859] Starting subtest: cursor-onscreen-512x170
[213.483191] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[213.607320] [036/133] (825s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[213.696830] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[213.698197] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[213.813520] [037/133] (824s left) kms_chamelium_color (ctm-0-25)
[213.897286] Subtest ctm-0-25: SKIP (0.000s)
[213.938981] [038/133] (824s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[213.981137] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[214.088342] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.107s)
[214.171611] [039/133] (824s left) gem_exec_fence (syncobj-timeline-unused-fence)
[214.635100] Starting subtest: syncobj-timeline-unused-fence
[214.635949] Subtest syncobj-timeline-unused-fence: SUCCESS (0.005s)
[214.832929] [040/133] (823s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[214.923485] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[214.924826] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[215.055292] [041/133] (823s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[215.143486] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[215.144849] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[215.254271] [042/133] (823s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[215.390301] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[215.489117] [043/133] (823s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[215.578953] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[215.579823] Starting dynamic subtest: pipe-A
[216.827681] Dynamic subtest pipe-A: SUCCESS (1.249s)
[216.837338] Starting dynamic subtest: pipe-B
[218.138824] Dynamic subtest pipe-B: SUCCESS (1.311s)
[218.149408] Starting dynamic subtest: pipe-C
[218.338522] Dynamic subtest pipe-C: SUCCESS (0.199s)
[218.350018] Starting dynamic subtest: pipe-D
[218.539545] Dynamic subtest pipe-D: SUCCESS (0.200s)
[218.540268] Subtest plane-downscale-factor-0-5-with-pixel-format: SUCCESS (2.963s)
[218.730502] [044/133] (820s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[218.772217] Starting subtest: y-tiled-to-vebox-x-tiled
[218.772939] Starting dynamic subtest: smem
[218.866629] Dynamic subtest smem: SUCCESS (0.094s)
[218.867415] Subtest y-tiled-to-vebox-x-tiled: SUCCESS (0.095s)
[219.059405] [045/133] (819s left) gen9_exec_parse (batch-without-end)
[219.096663] Subtest batch-without-end: SKIP (0.000s)
[219.139630] [046/133] (819s left) syncobj_timeline (etime-single-wait-submitted)
[219.174106] Starting subtest: etime-single-wait-submitted
[219.280454] Subtest etime-single-wait-submitted: SUCCESS (0.106s)
[219.376716] [047/133] (819s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[219.477687] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[219.479055] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[219.591557] [048/133] (819s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[219.686823] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[219.688151] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[219.788117] [049/133] (819s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[219.876884] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[219.879091] Starting dynamic subtest: pipe-A-HDMI-A-1
[236.349305] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.403s)
[236.361839] Starting dynamic subtest: pipe-B-HDMI-A-1
[253.343414] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.361s)
[253.352259] Starting dynamic subtest: pipe-C-HDMI-A-1
[270.307314] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.296s)
[270.316179] Starting dynamic subtest: pipe-D-HDMI-A-1
[286.310937] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.355s)
[286.311659] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SUCCESS (5.422s)
[295.551750] [050/133] (752s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[295.646558] Starting subtest: plane-use-after-nonblocking-unbind
[295.647261] Starting dynamic subtest: pipe-A-HDMI-A-1
[295.699862] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.053s)
[295.766358] Starting dynamic subtest: pipe-B-HDMI-A-1
[295.922428] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.164s)
[295.962499] Subtest plane-use-after-nonblocking-unbind: SUCCESS (0.316s)
[296.113157] [051/133] (752s left) gem_partial_pwrite_pread (reads-uncached)
[296.150864] Starting subtest: reads-uncached
[297.933451] Subtest reads-uncached: SUCCESS (1.817s)
[298.072912] [052/133] (750s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[298.105694] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[298.106506] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[298.190545] [053/133] (750s left) i915_pm_rc6_residency (rc6-fence)
[298.222146] Starting subtest: rc6-fence
[298.225892] Starting dynamic subtest: gt0
[316.533794] Dynamic subtest gt0: SUCCESS (18.437s)
[316.534715] Subtest rc6-fence: SUCCESS (18.442s)
[316.603911] [054/133] (731s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[316.693261] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[316.694625] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[316.821013] [055/133] (731s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[316.909420] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[316.910778] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[317.019735] [056/133] (731s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[317.115312] Starting subtest: yf-tiled-16bpp-rotate-180
[317.116740] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[317.238812] [057/133] (731s left) gem_ctx_param (root-set)
[317.270550] Starting subtest: root-set
[317.271305] Subtest root-set: SUCCESS (0.000s)
[317.359576] [058/133] (731s left) gem_exec_fence (syncobj-invalid-wait)
[317.690406] Starting subtest: syncobj-invalid-wait
[317.691077] Subtest syncobj-invalid-wait: SUCCESS (0.001s)
[318.001691] [059/133] (730s left) kms_lease (invalid-create-leases)
[318.086030] Starting subtest: invalid-create-leases
[318.091173] Subtest invalid-create-leases: SUCCESS (0.005s)
[318.164293] [060/133] (730s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[318.250038] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[318.250764] Starting dynamic subtest: pipe-A-HDMI-A-1
[318.257614] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[318.268225] Starting dynamic subtest: pipe-B-HDMI-A-1
[318.275099] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[318.284973] Starting dynamic subtest: pipe-C-HDMI-A-1
[318.291542] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[318.299210] Starting dynamic subtest: pipe-D-HDMI-A-1
[318.306028] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[318.307357] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[318.501946] [061/133] (730s left) kms_sequence (queue-busy)
[318.588786] Starting subtest: queue-busy
[318.589511] Starting dynamic subtest: pipe-A-HDMI-A-1
[319.878136] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.290s)
[319.887327] Starting dynamic subtest: pipe-B-HDMI-A-1
[321.148079] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.270s)
[321.157812] Starting dynamic subtest: pipe-C-HDMI-A-1
[322.412223] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.264s)
[322.421355] Starting dynamic subtest: pipe-D-HDMI-A-1
[323.686352] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.274s)
[323.687045] Subtest queue-busy: SUCCESS (5.106s)
[323.818361] [062/133] (724s left) prime_vgem (basic-fence-blt)
[323.907383] Starting subtest: basic-fence-blt
[323.989170] Subtest basic-fence-blt: SUCCESS (0.082s)
[324.132689] [063/133] (724s left) i915_suspend (basic-s3-without-i915)
[324.163838] Starting subtest: basic-s3-without-i915