[89.267824] Initializing watchdogs
[89.268014]   /dev/watchdog0
[89.307810] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3184 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 605]
[89.323735] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[89.331461] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[89.337197] [001/133] (960s left) gem_cs_tlb (engines)
[89.471174] Starting subtest: engines
[89.473742] Starting dynamic subtest: rcs0
[91.628751] Dynamic subtest rcs0: SUCCESS (2.157s)
[91.645813] Starting dynamic subtest: bcs0
[93.786597] Dynamic subtest bcs0: SUCCESS (2.157s)
[93.803300] Starting dynamic subtest: vcs0
[95.943347] Dynamic subtest vcs0: SUCCESS (2.155s)
[95.959539] Starting dynamic subtest: vecs0
[98.098420] Dynamic subtest vecs0: SUCCESS (2.155s)
[98.100274] Subtest engines: SUCCESS (8.627s)
[98.234093] [002/133] (951s left) kms_pm_rpm (fences)
[100.172520] Starting subtest: fences
[103.136473] Subtest fences: SUCCESS (2.967s)
[103.384107] [003/133] (946s left) kms_properties (plane-properties-legacy)
[103.556193] Starting subtest: plane-properties-legacy
[103.558059] Starting dynamic subtest: pipe-A-HDMI-A-1
[104.468854] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.906s)
[104.488014] Starting dynamic subtest: pipe-B-HDMI-A-2
[105.035109] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.564s)
[105.051990] Starting dynamic subtest: pipe-C-HDMI-A-1
[105.607901] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.572s)
[105.609923] Subtest plane-properties-legacy: SUCCESS (2.051s)
[105.881287] [004/133] (944s left) i915_hangman (engine-error-state-capture)
[106.003102] Starting subtest: engine-error-state-capture
[106.004865] Starting dynamic subtest: rcs0
[110.555494] Dynamic subtest rcs0: SUCCESS (4.551s)
[110.572992] Starting dynamic subtest: bcs0
[114.586024] Dynamic subtest bcs0: SUCCESS (4.027s)
[114.603808] Starting dynamic subtest: vcs0
[118.540991] Dynamic subtest vcs0: SUCCESS (3.956s)
[118.559373] Starting dynamic subtest: vecs0
[122.572485] Dynamic subtest vecs0: SUCCESS (4.029s)
[122.574396] Subtest engine-error-state-capture: SUCCESS (16.569s)
[122.753418] [005/133] (927s left) kms_cursor_crc (cursor-size-hints)
[122.926696] Starting subtest: cursor-size-hints
[122.930845] Starting dynamic subtest: pipe-A-HDMI-A-1
[123.803102] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.873s)
[123.822134] Starting dynamic subtest: pipe-C-HDMI-A-1
[124.346151] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.539s)
[124.348144] Subtest cursor-size-hints: SUCCESS (1.419s)
[124.638445] [006/133] (925s left) kms_psr (psr-primary-render)
[124.813477] Subtest psr-primary-render: SKIP (0.000s)
[124.912601] [007/133] (925s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[125.079210] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[125.081143] Starting dynamic subtest: pipe-A-HDMI-A-1
[125.099107] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[125.116218] Starting dynamic subtest: pipe-A-HDMI-A-2
[125.135058] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[125.153327] Starting dynamic subtest: pipe-B-HDMI-A-1
[125.172041] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[125.189164] Starting dynamic subtest: pipe-B-HDMI-A-2
[125.207540] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[125.224245] Starting dynamic subtest: pipe-C-HDMI-A-1
[125.242747] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[125.259829] Starting dynamic subtest: pipe-C-HDMI-A-2
[125.278042] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[125.281812] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SKIP (0.016s)
[125.960732] [008/133] (924s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[126.150210] Starting subtest: psr-rgb565-draw-pwrite
[126.153877] Subtest psr-rgb565-draw-pwrite: SKIP (0.000s)
[126.294777] [009/133] (924s left) gem_exec_balancer (full-late-pulse)
[126.415618] Starting subtest: full-late-pulse
[130.877534] Subtest full-late-pulse: SUCCESS (4.462s)
[131.127575] [010/133] (919s left) kms_getfb (getfb2-handle-zero)
[131.298358] Starting subtest: getfb2-handle-zero
[131.300257] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[131.469192] [011/133] (919s left) gem_ctx_shared (q-smoketest-all)
[131.593507] Starting subtest: Q-smoketest-all
[163.890615] Subtest Q-smoketest-all: SUCCESS (32.287s)
[164.143558] [012/133] (886s left) gem_exec_nop (basic-series)
[164.285805] Starting subtest: basic-series
[167.361305] Subtest basic-series: SUCCESS (3.077s)
[167.627532] [013/133] (883s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[167.812123] Starting subtest: fbcpsr-1p-rte
[167.816075] Subtest fbcpsr-1p-rte: SKIP (0.000s)
[167.961713] [014/133] (882s left) kms_prop_blob (invalid-get-prop-any)
[168.061160] Starting subtest: invalid-get-prop-any
[168.063166] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[168.194680] [015/133] (882s left) kms_feature_discovery (chamelium)
[168.366334] Starting subtest: chamelium
[168.370016] Subtest chamelium: SKIP (0.000s)
[168.513860] [016/133] (882s left) gem_exec_schedule (out-order)
[168.642358] Starting subtest: out-order
[168.644453] Starting dynamic subtest: rcs0
[168.767229] Dynamic subtest rcs0: SUCCESS (0.123s)
[168.789352] Starting dynamic subtest: bcs0
[168.906290] Dynamic subtest bcs0: SUCCESS (0.137s)
[168.927369] Starting dynamic subtest: vcs0
[169.022979] Dynamic subtest vcs0: SUCCESS (0.115s)
[169.042996] Starting dynamic subtest: vecs0
[169.138157] Dynamic subtest vecs0: SUCCESS (0.115s)
[169.140451] Subtest out-order: SUCCESS (0.494s)
[169.528344] [017/133] (881s left) gem_ctx_param (invalid-ctx-get)
[169.627685] Starting subtest: invalid-ctx-get
[169.629873] Subtest invalid-ctx-get: SUCCESS (0.000s)
[169.761610] [018/133] (881s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[169.944483] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[169.948053] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[170.094454] [019/133] (881s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[170.280312] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[170.284014] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[170.428302] [020/133] (880s left) gem_lmem_swapping (basic)
[170.540740] Subtest basic: SKIP (0.000s)
[170.636378] [021/133] (880s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[170.806055] Starting subtest: plane-lut1d-ctm3x4
[172.210191] Subtest plane-lut1d-ctm3x4: SKIP (1.400s)
[172.463939] [022/133] (879s left) perf (polling-small-buf)
[172.665085] Starting subtest: polling-small-buf
[172.766628] Subtest polling-small-buf: SUCCESS (0.099s)
[172.860469] [023/133] (878s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[173.047047] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[175.455197] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SUCCESS (2.408s)
[175.663570] [024/133] (876s left) kms_plane (pixel-format-linear-modifier)
[175.860324] Starting subtest: pixel-format-linear-modifier
[176.065336] Starting dynamic subtest: pipe-A-plane-0
[179.631385] Dynamic subtest pipe-A-plane-0: SUCCESS (3.566s)
[179.651486] Starting dynamic subtest: pipe-A-plane-1
[183.181283] Dynamic subtest pipe-A-plane-1: SUCCESS (3.549s)
[183.200374] Starting dynamic subtest: pipe-A-plane-2
[184.748036] Dynamic subtest pipe-A-plane-2: SUCCESS (1.566s)
[184.768493] Starting dynamic subtest: pipe-A-plane-3
[186.298842] Dynamic subtest pipe-A-plane-3: SUCCESS (1.549s)
[186.318281] Starting dynamic subtest: pipe-A-plane-4
[186.515732] Dynamic subtest pipe-A-plane-4: SUCCESS (0.215s)
[186.857441] Starting dynamic subtest: pipe-B-plane-0
[190.394107] Dynamic subtest pipe-B-plane-0: SUCCESS (3.550s)
[190.415778] Starting dynamic subtest: pipe-B-plane-1
[193.940160] Dynamic subtest pipe-B-plane-1: SUCCESS (3.548s)
[193.959475] Starting dynamic subtest: pipe-B-plane-2
[195.490230] Dynamic subtest pipe-B-plane-2: SUCCESS (1.549s)
[195.509416] Starting dynamic subtest: pipe-B-plane-3
[197.056952] Dynamic subtest pipe-B-plane-3: SUCCESS (1.565s)
[197.077456] Starting dynamic subtest: pipe-B-plane-4
[197.274955] Dynamic subtest pipe-B-plane-4: SUCCESS (0.216s)
[197.474984] Subtest pixel-format-linear-modifier: SUCCESS (21.616s)
[197.750896] [025/133] (854s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[197.940596] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[197.945851] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[208.923039] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (10.977s)
[208.946801] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[220.008168] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (11.081s)
[220.030284] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[230.921606] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.909s)
[230.923779] Subtest 2x-wf_vblank-ts-check-interruptible: SUCCESS (32.981s)
[231.477524] [026/133] (820s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[231.591476] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[231.595716] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[231.829907] [027/133] (820s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[232.004351] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[232.006214] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[234.167919] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (2.161s)
[234.190465] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[235.917330] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (1.744s)
[235.937349] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[237.602641] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (1.683s)
[237.604770] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (5.602s)
[237.888788] [028/133] (814s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[238.067138] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[238.069112] Starting dynamic subtest: pipe-A-HDMI-A-1
[238.088206] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.002s)
[238.109922] Starting dynamic subtest: pipe-A-HDMI-A-2
[238.134051] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.002s)
[238.154969] Starting dynamic subtest: pipe-B-HDMI-A-1
[238.172363] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.002s)
[238.192383] Starting dynamic subtest: pipe-B-HDMI-A-2
[238.208726] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.002s)
[238.227743] Starting dynamic subtest: pipe-C-HDMI-A-1
[238.246565] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[238.265501] Starting dynamic subtest: pipe-C-HDMI-A-2
[238.283977] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[238.285867] Subtest ccs-on-another-bo-yf-tiled-ccs: SUCCESS (0.032s)
[238.981252] [029/133] (813s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[239.519122] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[239.764234] [030/133] (812s left) i915_pm_rpm (gem-execbuf-stress)
[241.644587] Starting subtest: gem-execbuf-stress
[241.647440] Starting dynamic subtest: smem0
[244.181796] Dynamic subtest smem0: SUCCESS (2.539s)
[244.201316] Starting dynamic subtest: extra-wait-smem0
[296.719240] Dynamic subtest extra-wait-smem0: SUCCESS (52.533s)
[296.721632] Subtest gem-execbuf-stress: SUCCESS (55.080s)
[297.060371] [031/133] (755s left) gem_exec_reloc (basic-cpu-wc-active)
[297.172017] Starting subtest: basic-cpu-wc-active
[297.314220] Subtest basic-cpu-wc-active: SUCCESS (0.143s)
[297.540579] [032/133] (754s left) gem_exec_reloc (basic-write-cpu-noreloc)
[297.655704] Starting subtest: basic-write-cpu-noreloc
[297.660391] Subtest basic-write-cpu-noreloc: SUCCESS (0.007s)
[297.860567] [033/133] (754s left) kms_addfb_basic (invalid-set-prop)
[297.960386] Starting subtest: invalid-set-prop
[297.962303] Subtest invalid-set-prop: SUCCESS (0.000s)
[298.189580] [034/133] (754s left) i915_query (query-garbage)
[298.288064] Starting subtest: query-garbage
[298.290114] Subtest query-garbage: SUCCESS (0.000s)
[298.425961] [035/133] (754s left) gem_exec_reloc (basic-gtt-cpu)
[298.534959] Starting subtest: basic-gtt-cpu
[298.552392] Subtest basic-gtt-cpu: SUCCESS (0.019s)
[298.760623] [036/133] (753s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[298.933228] Starting subtest: disable-crc-after-crtc
[298.935216] Starting dynamic subtest: pipe-A-HDMI-A-1
[299.985267] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.050s)
[300.009114] Starting dynamic subtest: pipe-B-HDMI-A-2
[300.752809] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.763s)
[300.777174] Starting dynamic subtest: pipe-C-HDMI-A-1
[301.531685] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.772s)
[301.533757] Subtest disable-crc-after-crtc: SUCCESS (2.601s)
[301.818765] [037/133] (751s left) kms_lease (master-vs-lease)
[301.993187] Starting subtest: master-vs-lease
[301.995359] Subtest master-vs-lease: SUCCESS (0.002s)
[302.119919] [038/133] (750s left) kms_flip_event_leak (basic)
[302.296168] Starting subtest: basic
[302.297966] Starting dynamic subtest: pipe-A-HDMI-A-1
[302.939810] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.644s)
[302.963148] Starting dynamic subtest: pipe-A-HDMI-A-2
[303.330434] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.388s)
[303.353939] Starting dynamic subtest: pipe-B-HDMI-A-1
[303.689866] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.355s)
[303.716082] Starting dynamic subtest: pipe-B-HDMI-A-2
[304.051215] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.355s)
[304.074896] Starting dynamic subtest: pipe-C-HDMI-A-1
[304.424492] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.370s)
[304.447126] Starting dynamic subtest: pipe-C-HDMI-A-2
[304.803215] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.370s)
[304.805583] Subtest basic: SUCCESS (2.510s)
[305.086977] [039/133] (747s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[305.263982] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[305.268153] Starting dynamic subtest: pipe-A-valid-mode
[305.756458] Dynamic subtest pipe-A-valid-mode: SKIP (0.489s)
[305.760340] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SKIP (0.494s)
[306.181494] [040/133] (746s left) gem_exec_schedule (u-fairslice-all)
[306.313887] Starting subtest: u-fairslice-all
[308.401685] Subtest u-fairslice-all: SUCCESS (2.091s)
[308.797671] [041/133] (744s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[308.985101] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[308.989163] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[309.130447] [042/133] (744s left) gem_mmap_wc (write-read-distinct)
[309.232752] Starting subtest: write-read-distinct
[309.237691] Subtest write-read-distinct: SUCCESS (0.008s)
[309.396296] [043/133] (743s left) vgem_basic (bad-pad)
[309.570421] Starting subtest: bad-pad
[309.572394] Subtest bad-pad: SUCCESS (0.000s)
[309.680085] [FACT vgem_basic (bad-pad)] new: kernel.kmod_is_loaded.vgem: true
[309.688400] [044/133] (743s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[309.877521] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[309.882376] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[310.040285] [045/133] (743s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[310.227356] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[312.789955] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SUCCESS (2.558s)
[312.988867] [046/133] (740s left) api_intel_allocator (fork-simple-stress)
[313.090973] Starting subtest: fork-simple-stress
[318.560364] Subtest fork-simple-stress: SUCCESS (5.471s)
[318.705787] [047/133] (734s left) kms_psr (fbc-pr-primary-mmap-gtt)
[318.889546] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[319.001237] [048/133] (734s left) perf (blocking)
[319.204188] Starting subtest: blocking
[319.206162] Starting dynamic subtest: 0-rcs0
[329.250303] Dynamic subtest 0-rcs0: SUCCESS (10.043s)
[329.252546] Subtest blocking: SUCCESS (10.046s)
[329.359656] [049/133] (724s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[329.546060] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[329.549938] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[329.690661] [050/133] (724s left) gem_mmap_gtt (isolation)
[329.789994] Starting subtest: isolation
[329.795989] Subtest isolation: SUCCESS (0.003s)
[329.939325] [051/133] (724s left) kms_dp_link_training (non-uhbr-sst)
[330.114934] Starting subtest: non-uhbr-sst
[330.126530] Subtest non-uhbr-sst: SKIP (0.000s)
[330.258485] [052/133] (723s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[330.435045] Starting subtest: addfb25-x-tiled-legacy
[330.437029] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[330.591428] [053/133] (723s left) kms_psr (pr-sprite-mmap-gtt)
[330.772604] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[330.881401] [054/133] (723s left) kms_cursor_crc (cursor-offscreen-64x21)
[331.059475] Starting subtest: cursor-offscreen-64x21
[331.099108] Starting dynamic subtest: pipe-A-HDMI-A-1
[333.917120] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.818s)
[333.993010] Starting dynamic subtest: pipe-C-HDMI-A-1
[336.483311] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.509s)
[336.485392] Subtest cursor-offscreen-64x21: SUCCESS (5.425s)
[336.795225] [055/133] (717s left) gen9_exec_parse (allowed-single)
[336.919567] Starting subtest: allowed-single
[336.924841] Subtest allowed-single: SUCCESS (0.008s)
[337.211550] [056/133] (717s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[337.428026] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[337.432034] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[337.577690] [057/133] (717s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[337.768250] Starting subtest: fbcpsr-tiling-linear
[337.772058] Subtest fbcpsr-tiling-linear: SKIP (0.000s)
[337.911837] [058/133] (716s left) dmabuf_sync_file (export-basic)
[338.025439] Starting subtest: export-basic
[338.027503] Subtest export-basic: SUCCESS (0.004s)
[338.159659] [059/133] (716s left) i915_suspend (forcewake)
[338.259071] Starting subtest: forcewake