[43.561862] Initializing watchdogs
[43.561924]   /dev/watchdog0
[43.577249] [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]
[43.582803] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[43.585514] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[43.587303] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[43.680800] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[43.682224] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[43.780393] [002/133] (960s left) syncobj_timeline (wait-for-submit-delayed-submit)
[43.814228] Starting subtest: wait-for-submit-delayed-submit
[43.916657] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[44.007018] [003/133] (960s left) kms_chamelium_hpd (dp-hpd)
[44.147459] Subtest dp-hpd: SKIP (0.000s)
[44.239624] [004/133] (959s left) kms_cursor_edge_walk (256x256-top-bottom)
[44.325937] Starting subtest: 256x256-top-bottom
[44.327686] Starting dynamic subtest: pipe-A-HDMI-A-1
[46.095897] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.758s)
[46.103445] Starting dynamic subtest: pipe-D-HDMI-A-1
[47.781183] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.658s)
[47.781964] Subtest 256x256-top-bottom: SUCCESS (3.419s)
[47.899951] [005/133] (956s left) gem_mmap_offset (clear)
[47.941209] Starting subtest: clear
[47.951744] Starting dynamic subtest: smem0
[70.466703] Dynamic subtest smem0: SUCCESS (22.433s)
[70.467393] Subtest clear: SUCCESS (22.433s)
[70.612566] [006/133] (933s left) kms_joiner (basic-force-big-joiner)
[70.768566] Starting subtest: basic-force-big-joiner
[70.769937] Subtest basic-force-big-joiner: SKIP (0.000s)
[70.836250] [007/133] (933s left) gem_exec_balancer (waits)
[70.880820] Starting subtest: waits
[77.737545] Subtest waits: SUCCESS (6.854s)
[77.932889] [008/133] (926s left) gem_exec_whisper (basic-queues)
[77.974137] Starting subtest: basic-queues
[79.726211] Subtest basic-queues: SUCCESS (1.751s)
[79.911953] [009/133] (924s left) gem_exec_suspend (basic-s3)
[79.952641] Starting subtest: basic-S3
[79.953344] Starting dynamic subtest: smem
[97.753238] Dynamic subtest smem: SUCCESS (2.726s)
[97.753965] Subtest basic-S3: SUCCESS (2.726s)
[105.952120] [010/133] (906s left) kms_psr (psr2-sprite-render)
[106.044618] Subtest psr2-sprite-render: SKIP (0.000s)
[106.087040] [011/133] (906s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[106.179205] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[106.180587] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[106.310959] [012/133] (906s left) kms_content_protection (atomic)
[106.406129] Starting subtest: atomic
[106.419627] Subtest atomic: SKIP (0.012s)
[106.520788] [013/133] (906s left) kms_async_flips (invalid-async-flip)
[106.605979] Starting subtest: invalid-async-flip
[106.732129] Starting dynamic subtest: pipe-A-HDMI-A-1
[106.864861] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.131s)
[106.995241] Starting dynamic subtest: pipe-B-HDMI-A-1
[107.101849] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.113s)
[107.224205] Starting dynamic subtest: pipe-C-HDMI-A-1
[107.323040] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.104s)
[107.431584] Starting dynamic subtest: pipe-D-HDMI-A-1
[107.517887] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.092s)
[107.518649] Subtest invalid-async-flip: SUCCESS (0.899s)
[107.739271] [014/133] (904s left) kms_flip (blocking-absolute-wf_vblank)
[107.836584] Starting subtest: blocking-absolute-wf_vblank
[107.838041] Starting dynamic subtest: A-HDMI-A1
[115.621658] Dynamic subtest A-HDMI-A1: SUCCESS (7.693s)
[115.628737] Starting dynamic subtest: B-HDMI-A1
[123.318640] Dynamic subtest B-HDMI-A1: SUCCESS (7.663s)
[123.326659] Starting dynamic subtest: C-HDMI-A1
[130.980741] Dynamic subtest C-HDMI-A1: SUCCESS (7.650s)
[130.987311] Starting dynamic subtest: D-HDMI-A1
[138.611132] Dynamic subtest D-HDMI-A1: SUCCESS (7.651s)
[138.613000] Subtest blocking-absolute-wf_vblank: SUCCESS (30.663s)
[138.783003] [015/133] (873s left) gem_exec_schedule (reorder-wide)
[138.957063] Starting subtest: reorder-wide
[138.958091] Starting dynamic subtest: rcs0
[139.060580] Dynamic subtest rcs0: SUCCESS (0.103s)
[139.072318] Starting dynamic subtest: bcs0
[139.131943] Dynamic subtest bcs0: SUCCESS (0.071s)
[139.143266] Starting dynamic subtest: vcs0
[139.202790] Dynamic subtest vcs0: SUCCESS (0.070s)
[139.213951] Starting dynamic subtest: vcs1
[139.275940] Dynamic subtest vcs1: SUCCESS (0.073s)
[139.287113] Starting dynamic subtest: vecs0
[139.347356] Dynamic subtest vecs0: SUCCESS (0.071s)
[139.348407] Subtest reorder-wide: SUCCESS (0.390s)
[139.547309] [FACT gem_exec_schedule (reorder-wide)] new: kernel.kmod_is_loaded.vgem: true
[139.548933] [016/133] (873s left) gem_watchdog (default-virtual)
[139.586631] Starting subtest: default-virtual
[140.858396] Subtest default-virtual: SUCCESS (1.262s)
[140.959734] [017/133] (871s left) gem_pwrite (basic-self)
[140.991210] Starting subtest: basic-self
[141.029588] Subtest basic-self: SUCCESS (0.038s)
[141.120581] [018/133] (871s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[141.206417] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[141.246674] [019/133] (871s left) kms_cursor_legacy (forked-move)
[141.329952] Starting subtest: forked-move
[141.330627] Starting dynamic subtest: pipe-A
[146.780027] Dynamic subtest pipe-A: SUCCESS (5.415s)
[146.787704] Starting dynamic subtest: pipe-B
[152.202675] Dynamic subtest pipe-B: SUCCESS (5.422s)
[152.211146] Starting dynamic subtest: pipe-C
[157.623082] Dynamic subtest pipe-C: SUCCESS (5.419s)
[157.632740] Starting dynamic subtest: pipe-D
[163.061201] Dynamic subtest pipe-D: SUCCESS (5.436s)
[163.070212] Starting dynamic subtest: all-pipes
[168.505516] Dynamic subtest all-pipes: SUCCESS (5.442s)
[168.506469] Subtest forked-move: SUCCESS (27.136s)
[168.565656] [020/133] (844s left) vgem_basic (debugfs)
[168.599459] Starting subtest: debugfs
[168.600143] Subtest debugfs: SUCCESS (0.000s)
[168.679650] [021/133] (844s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[168.771099] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[168.772483] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[168.875088] [022/133] (844s left) kms_plane_lowres (tiling-yf)
[168.961109] Starting subtest: tiling-yf
[168.962505] Subtest tiling-yf: SKIP (0.000s)
[169.028989] [023/133] (843s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[169.115556] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[169.132094] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.015s)
[169.222141] [024/133] (843s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[169.304968] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[169.305644] Starting dynamic subtest: pipe-A-valid-mode
[170.095590] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.789s)
[170.096349] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (0.790s)
[170.250633] [025/133] (842s left) kms_vrr (flip-basic)
[170.340076] Starting subtest: flip-basic
[170.342163] Subtest flip-basic: SKIP (0.000s)
[170.410024] [026/133] (842s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[170.497760] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[170.499158] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[170.603793] [027/133] (842s left) kms_flip (modeset-vs-vblank-race-interruptible)
[170.691582] Starting subtest: modeset-vs-vblank-race-interruptible
[170.694206] Starting dynamic subtest: A-HDMI-A1
[173.548083] Dynamic subtest A-HDMI-A1: SUCCESS (2.853s)
[173.559087] Starting dynamic subtest: B-HDMI-A1
[176.398846] Dynamic subtest B-HDMI-A1: SUCCESS (2.849s)
[176.410110] Starting dynamic subtest: C-HDMI-A1
[179.268869] Dynamic subtest C-HDMI-A1: SUCCESS (2.867s)
[179.280272] Starting dynamic subtest: D-HDMI-A1
[182.070312] Dynamic subtest D-HDMI-A1: SUCCESS (2.799s)
[182.072617] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (11.377s)
[182.267026] [028/133] (830s left) kms_addfb_basic (bad-pitch-63)
[182.309907] Starting subtest: bad-pitch-63
[182.310642] Subtest bad-pitch-63: SUCCESS (0.000s)
[182.469979] [029/133] (830s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[182.558031] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[182.559388] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[182.689195] [030/133] (830s left) syncobj_wait (invalid-reset-one-illegal-handle)
[182.722407] Starting subtest: invalid-reset-one-illegal-handle
[182.723102] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[182.800339] [031/133] (830s left) gem_ctx_persistence (legacy-engines-queued)
[182.837552] Starting subtest: legacy-engines-queued
[182.838253] Starting dynamic subtest: render
[182.903998] Dynamic subtest render: SUCCESS (0.065s)
[182.921998] Starting dynamic subtest: bsd1
[182.971998] Dynamic subtest bsd1: SUCCESS (0.065s)
[182.990689] Starting dynamic subtest: bsd2
[183.032842] Dynamic subtest bsd2: SUCCESS (0.058s)
[183.051150] Starting dynamic subtest: blt
[183.088058] Dynamic subtest blt: SUCCESS (0.052s)
[183.106455] Starting dynamic subtest: vebox
[183.153002] Dynamic subtest vebox: SUCCESS (0.062s)
[183.154082] Subtest legacy-engines-queued: SUCCESS (0.316s)
[183.245398] [032/133] (830s left) syncobj_wait (invalid-single-wait-unsubmitted)
[183.279006] Starting subtest: invalid-single-wait-unsubmitted
[183.279696] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[183.369864] [033/133] (830s left) gem_pxp (verify-pxp-stale-ctx-execution)
[183.471798] Starting subtest: verify-pxp-stale-ctx-execution
[184.538605] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.065s)
[184.652679] [034/133] (828s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[184.685333] Starting subtest: cpuset-basic-small-copy-odd
[188.245021] Subtest cpuset-basic-small-copy-odd: SUCCESS (3.558s)
[188.355378] [035/133] (825s left) kms_cursor_crc (cursor-onscreen-512x170)
[188.505279] Starting subtest: cursor-onscreen-512x170
[188.506593] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[188.632378] [036/133] (824s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[188.721018] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[188.722375] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[188.840807] [037/133] (824s left) kms_chamelium_color (ctm-0-25)
[188.924862] Subtest ctm-0-25: SKIP (0.000s)
[188.964976] [038/133] (824s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[189.005477] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[189.114140] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.108s)
[189.199971] [039/133] (824s left) gem_exec_fence (syncobj-timeline-unused-fence)
[189.674840] Starting subtest: syncobj-timeline-unused-fence
[189.675681] Subtest syncobj-timeline-unused-fence: SUCCESS (0.005s)
[189.860265] [040/133] (823s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[189.947257] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[189.948643] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[190.058146] [041/133] (823s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[190.147007] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[190.148354] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[190.276229] [042/133] (823s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[190.410194] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[190.500576] [043/133] (823s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[190.589273] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[190.590007] Starting dynamic subtest: pipe-A
[191.840608] Dynamic subtest pipe-A: SUCCESS (1.250s)
[191.849749] Starting dynamic subtest: pipe-B
[193.083220] Dynamic subtest pipe-B: SUCCESS (1.241s)
[193.092118] Starting dynamic subtest: pipe-C
[193.283251] Dynamic subtest pipe-C: SUCCESS (0.199s)
[193.291686] Starting dynamic subtest: pipe-D
[193.484349] Dynamic subtest pipe-D: SUCCESS (0.200s)
[193.485032] Subtest plane-downscale-factor-0-5-with-pixel-format: SUCCESS (2.895s)
[193.690916] [044/133] (820s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[193.736422] Starting subtest: y-tiled-to-vebox-x-tiled
[193.737150] Starting dynamic subtest: smem
[193.831364] Dynamic subtest smem: SUCCESS (0.094s)
[193.832116] Subtest y-tiled-to-vebox-x-tiled: SUCCESS (0.095s)
[194.028404] [045/133] (819s left) gen9_exec_parse (batch-without-end)
[194.064724] Subtest batch-without-end: SKIP (0.000s)
[194.107573] [046/133] (819s left) syncobj_timeline (etime-single-wait-submitted)
[194.140555] Starting subtest: etime-single-wait-submitted
[194.241946] Subtest etime-single-wait-submitted: SUCCESS (0.101s)
[194.336097] [047/133] (819s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[194.434177] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[194.435531] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[194.552253] [048/133] (819s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[194.640045] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[194.641390] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[194.752711] [049/133] (819s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[194.837206] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[194.838974] Starting dynamic subtest: pipe-A-HDMI-A-1
[211.393195] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.398s)
[211.401936] Starting dynamic subtest: pipe-B-HDMI-A-1
[228.379210] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.347s)
[228.387806] Starting dynamic subtest: pipe-C-HDMI-A-1
[245.383361] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.349s)
[245.391935] Starting dynamic subtest: pipe-D-HDMI-A-1
[262.382699] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.341s)
[262.383414] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SUCCESS (5.441s)
[271.657825] [050/133] (751s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[271.759243] Starting subtest: plane-use-after-nonblocking-unbind
[271.761065] Starting dynamic subtest: pipe-A-HDMI-A-1
[271.817903] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.056s)
[271.884934] Starting dynamic subtest: pipe-B-HDMI-A-1
[272.041209] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.160s)
[272.092153] Subtest plane-use-after-nonblocking-unbind: SUCCESS (0.326s)
[272.239257] [051/133] (750s left) gem_partial_pwrite_pread (reads-uncached)
[272.282212] Starting subtest: reads-uncached
[274.203455] Subtest reads-uncached: SUCCESS (1.892s)
[274.330849] [052/133] (748s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[274.367259] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[274.367978] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[274.455508] [053/133] (748s left) i915_pm_rc6_residency (rc6-fence)
[274.494948] Starting subtest: rc6-fence
[274.500780] Starting dynamic subtest: gt0
[292.878883] Dynamic subtest gt0: SUCCESS (18.259s)
[292.879750] Subtest rc6-fence: SUCCESS (18.265s)
[292.944546] [054/133] (730s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[293.035095] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[293.036480] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[293.148875] [055/133] (730s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[293.238593] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[293.240006] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[293.357442] [056/133] (730s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[293.450698] Starting subtest: yf-tiled-16bpp-rotate-180
[293.452050] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[293.583912] [057/133] (729s left) gem_ctx_param (root-set)
[293.620736] Starting subtest: root-set
[293.621478] Subtest root-set: SUCCESS (0.000s)
[293.698070] [058/133] (729s left) gem_exec_fence (syncobj-invalid-wait)
[294.019110] Starting subtest: syncobj-invalid-wait
[294.019786] Subtest syncobj-invalid-wait: SUCCESS (0.000s)
[294.316660] [059/133] (729s left) kms_lease (invalid-create-leases)
[294.402809] Starting subtest: invalid-create-leases
[294.407890] Subtest invalid-create-leases: SUCCESS (0.005s)
[294.490211] [060/133] (729s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[294.574748] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[294.576943] Starting dynamic subtest: pipe-A-HDMI-A-1
[294.583882] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[294.593637] Starting dynamic subtest: pipe-B-HDMI-A-1
[294.600636] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[294.610080] Starting dynamic subtest: pipe-C-HDMI-A-1
[294.616848] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[294.627311] Starting dynamic subtest: pipe-D-HDMI-A-1
[294.634369] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[294.635721] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SKIP (0.008s)
[294.818503] [061/133] (728s left) kms_sequence (queue-busy)
[294.911351] Starting subtest: queue-busy
[294.912073] Starting dynamic subtest: pipe-A-HDMI-A-1
[296.205726] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.292s)
[296.214348] Starting dynamic subtest: pipe-B-HDMI-A-1
[297.476045] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.267s)
[297.485656] Starting dynamic subtest: pipe-C-HDMI-A-1
[298.748186] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.268s)
[298.758389] Starting dynamic subtest: pipe-D-HDMI-A-1
[300.023081] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.273s)
[300.023775] Subtest queue-busy: SUCCESS (5.108s)
[300.147861] [062/133] (723s left) prime_vgem (basic-fence-blt)
[300.223475] Starting subtest: basic-fence-blt
[300.306527] Subtest basic-fence-blt: SUCCESS (0.083s)
[300.446561] [063/133] (723s left) i915_suspend (basic-s3-without-i915)
[300.479302] Starting subtest: basic-s3-without-i915