[48.851154] Initializing watchdogs
[48.851216]   /dev/watchdog0
[48.868796] [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]
[48.874418] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[48.877086] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[48.878817] [001/131] (960s left) api_intel_allocator (gem-pool)
[48.913902] Starting subtest: gem-pool
[48.919395] Subtest gem-pool: SUCCESS (0.006s)
[49.062436] [002/131] (960s left) gem_bad_reloc (negative-reloc)
[49.100336] Starting subtest: negative-reloc
[49.102402] Subtest negative-reloc: SUCCESS (0.001s)
[49.229680] [003/131] (960s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[49.319463] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[49.351986] [004/131] (960s left) kms_vblank (wait-forked-busy-hang)
[49.435376] Starting subtest: wait-forked-busy-hang
[49.436060] Starting dynamic subtest: pipe-A-HDMI-A-1
[63.635674] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.200s)
[63.645500] Starting dynamic subtest: pipe-D-HDMI-A-1
[77.446456] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.807s)
[77.447239] Subtest wait-forked-busy-hang: SUCCESS (28.012s)
[77.628353] [005/131] (931s left) kms_fence_pin_leak
[79.143793] [006/131] (930s left) gem_exec_schedule (implicit-boths)
[79.187498] Starting subtest: implicit-boths
[79.188219] Starting dynamic subtest: rcs0
[79.249094] Dynamic subtest rcs0: SUCCESS (0.062s)
[79.257875] Starting dynamic subtest: bcs0
[79.312099] Dynamic subtest bcs0: SUCCESS (0.062s)
[79.321554] Starting dynamic subtest: vcs0
[79.375770] Dynamic subtest vcs0: SUCCESS (0.063s)
[79.387170] Starting dynamic subtest: vcs1
[79.441589] Dynamic subtest vcs1: SUCCESS (0.065s)
[79.453099] Starting dynamic subtest: vecs0
[79.507661] Dynamic subtest vecs0: SUCCESS (0.065s)
[79.508864] Subtest implicit-boths: SUCCESS (0.321s)
[79.818010] [007/131] (929s left) gem_render_copy_redux (flink)
[79.856403] Starting subtest: flink
[80.615225] Subtest flink: SUCCESS (0.759s)
[80.759133] [008/131] (928s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[80.852412] Starting subtest: pipe-fbc-rte
[80.856315] Subtest pipe-fbc-rte: SKIP (0.000s)
[80.958460] [009/131] (928s left) kms_cursor_crc (cursor-offscreen-512x512)
[81.045781] Starting subtest: cursor-offscreen-512x512
[81.047836] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[81.150562] [010/131] (928s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[81.246260] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[81.580035] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.334s)
[81.721303] [011/131] (928s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[81.753771] Starting subtest: framebuffer-vs-set-tiling
[81.754452] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[81.917698] [012/131] (927s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[82.000459] Starting subtest: addfb25-y-tiled-legacy
[82.001161] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[82.099989] [013/131] (927s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[82.183381] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[82.184075] Starting dynamic subtest: pipe-A
[82.323068] Dynamic subtest pipe-A: SUCCESS (0.140s)
[82.329229] Starting dynamic subtest: pipe-B
[82.448038] Dynamic subtest pipe-B: SUCCESS (0.125s)
[82.460925] Starting dynamic subtest: pipe-C
[82.582665] Dynamic subtest pipe-C: SUCCESS (0.134s)
[82.590825] Starting dynamic subtest: pipe-D
[82.708224] Dynamic subtest pipe-D: SUCCESS (0.125s)
[82.709493] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (0.526s)
[82.889826] [014/131] (926s left) perf (gen12-oa-tlb-invalidate)
[82.989187] Starting subtest: gen12-oa-tlb-invalidate
[82.989880] Starting dynamic subtest: 0-rcs0
[93.080402] Dynamic subtest 0-rcs0: SUCCESS (10.056s)
[93.081443] Subtest gen12-oa-tlb-invalidate: SUCCESS (10.057s)
[93.138839] [015/131] (916s left) perf (stress-open-close)
[93.241380] Starting subtest: stress-open-close
[93.242133] Starting dynamic subtest: 0-rcs0
[95.409110] Dynamic subtest 0-rcs0: SUCCESS (2.168s)
[95.409813] Subtest stress-open-close: SUCCESS (2.168s)
[95.442133] [016/131] (914s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[95.531503] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[95.532869] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[95.650968] [017/131] (914s left) kms_pm_rpm (universal-planes)
[97.041359] Starting subtest: universal-planes
[97.042272] Starting dynamic subtest: plane-33
[105.360251] Dynamic subtest plane-33: SUCCESS (8.319s)
[105.369305] Starting dynamic subtest: plane-63
[113.740034] Dynamic subtest plane-63: SUCCESS (8.379s)
[113.755590] Starting dynamic subtest: plane-93
[121.916862] Dynamic subtest plane-93: SUCCESS (8.176s)
[121.924144] Starting dynamic subtest: plane-123
[130.194640] Dynamic subtest plane-123: SUCCESS (8.275s)
[130.203387] Starting dynamic subtest: plane-133
[138.554644] Dynamic subtest plane-133: SUCCESS (8.361s)
[138.563680] Starting dynamic subtest: plane-143
[146.743840] Dynamic subtest plane-143: SUCCESS (8.188s)
[146.753271] Starting dynamic subtest: plane-153
[154.930452] Dynamic subtest plane-153: SUCCESS (8.186s)
[154.945306] Starting dynamic subtest: plane-163
[163.212682] Dynamic subtest plane-163: SUCCESS (8.282s)
[163.213742] Subtest universal-planes: SUCCESS (66.174s)
[163.393381] [018/131] (846s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[163.481400] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[163.482800] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[163.600427] [019/131] (846s left) gem_exec_params (readonly)
[163.634484] Starting subtest: readonly
[163.636053] Subtest readonly: SUCCESS (0.001s)
[163.766989] [020/131] (846s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[163.802048] Starting subtest: legacy-engines-hostile-preempt
[163.802741] Starting dynamic subtest: render
[163.902860] Dynamic subtest render: SUCCESS (0.100s)
[163.921045] Starting dynamic subtest: bsd1
[164.016113] Dynamic subtest bsd1: SUCCESS (0.112s)
[164.022560] Starting dynamic subtest: bsd2
[164.118668] Dynamic subtest bsd2: SUCCESS (0.101s)
[164.137453] Starting dynamic subtest: blt
[164.228672] Dynamic subtest blt: SUCCESS (0.108s)
[164.243670] Starting dynamic subtest: vebox
[164.335661] Dynamic subtest vebox: SUCCESS (0.105s)
[164.336977] Subtest legacy-engines-hostile-preempt: SUCCESS (0.534s)
[164.424688] [021/131] (845s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[164.457074] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[164.558660] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.101s)
[164.649919] [022/131] (845s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[164.683082] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[164.790633] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.107s)
[164.874610] [023/131] (845s left) core_setmaster (master-drop-set-root)
[164.956983] Starting subtest: master-drop-set-root
[164.962108] Subtest master-drop-set-root: SUCCESS (0.006s)
[165.004650] [024/131] (845s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[165.093682] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[165.095074] Subtest psr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[165.216720] [025/131] (845s left) gem_pwrite (basic-self)
[165.248227] Starting subtest: basic-self
[165.286619] Subtest basic-self: SUCCESS (0.038s)
[165.408429] [026/131] (844s left) kms_joiner (invalid-modeset-big-joiner)
[165.492845] Starting subtest: invalid-modeset-big-joiner
[165.494199] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[165.571525] [027/131] (844s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[165.658687] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[167.012957] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (1.354s)
[167.141739] [028/131] (843s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[167.231701] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[168.604903] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (1.374s)
[168.767634] [029/131] (841s left) perf_pmu (render-node-busy-idle)
[168.803509] Starting subtest: render-node-busy-idle
[168.804266] Starting dynamic subtest: rcs0
[169.469395] Dynamic subtest rcs0: SUCCESS (0.666s)
[169.479189] Starting dynamic subtest: bcs0
[170.102264] Dynamic subtest bcs0: SUCCESS (0.632s)
[170.112070] Starting dynamic subtest: vcs0
[170.749235] Dynamic subtest vcs0: SUCCESS (0.646s)
[170.758841] Starting dynamic subtest: vcs1
[171.399151] Dynamic subtest vcs1: SUCCESS (0.649s)
[171.408774] Starting dynamic subtest: vecs0
[172.042358] Dynamic subtest vecs0: SUCCESS (0.642s)
[172.043452] Subtest render-node-busy-idle: SUCCESS (3.240s)
[172.131248] [030/131] (838s left) i915_hangman (detector)
[172.176281] Starting subtest: detector
[172.176984] Starting dynamic subtest: rcs0
[182.065174] Dynamic subtest rcs0: SUCCESS (9.889s)
[182.085063] Starting dynamic subtest: bcs0
[192.034946] Dynamic subtest bcs0: SUCCESS (9.969s)
[192.051453] Starting dynamic subtest: vcs0
[202.076771] Dynamic subtest vcs0: SUCCESS (10.041s)
[202.092686] Starting dynamic subtest: vcs1
[212.064046] Dynamic subtest vcs1: SUCCESS (9.986s)
[212.083034] Starting dynamic subtest: vecs0
[222.044024] Dynamic subtest vecs0: SUCCESS (9.979s)
[222.045408] Subtest detector: SUCCESS (49.870s)
[222.139631] [031/131] (788s left) gem_ctx_engines (execute-allforone)
[222.179555] Starting subtest: execute-allforone
[222.184726] Subtest execute-allforone: SUCCESS (0.005s)
[222.382511] [032/131] (788s left) gem_ctx_param (non-root-set)
[222.417403] Starting subtest: non-root-set
[222.438239] Subtest non-root-set: SUCCESS (0.020s)
[222.540088] [033/131] (788s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[222.635500] Starting subtest: 4-tiled-8bpp-rotate-0
[222.636962] Subtest 4-tiled-8bpp-rotate-0: SKIP (0.000s)
[222.737964] [034/131] (787s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[222.821775] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[222.823330] Starting dynamic subtest: pipe-A-HDMI-A-1
[222.825994] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[222.832736] Starting dynamic subtest: pipe-B-HDMI-A-1
[222.835444] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[222.842132] Starting dynamic subtest: pipe-C-HDMI-A-1
[222.844862] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[222.851471] Starting dynamic subtest: pipe-D-HDMI-A-1
[222.854232] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[222.855556] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SKIP (0.005s)
[223.060855] [035/131] (787s left) i915_suspend (basic-s3-without-i915)
[223.091194] Starting subtest: basic-s3-without-i915