[87.604980] Initializing watchdogs
[87.605264]   /dev/watchdog0
[87.643549] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3184 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 605]
[87.657692] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[87.664356] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[87.670157] [001/133] (960s left) prime_vgem (basic-fence-flip)
[87.874892] Starting subtest: basic-fence-flip
[88.356020] Subtest basic-fence-flip: SUCCESS (0.479s)
[88.518037] [FACT prime_vgem (basic-fence-flip)] new: kernel.kmod_is_loaded.vgem: true
[88.521326] [002/133] (959s left) kms_getfb (getfb-handle-protection)
[88.687787] Starting subtest: getfb-handle-protection
[88.715430] Subtest getfb-handle-protection: SUCCESS (0.029s)
[88.868753] [003/133] (959s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[89.036977] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[89.037946] Starting dynamic subtest: pipe-A-HDMI-A-1
[89.041549] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[89.058869] Starting dynamic subtest: pipe-A-HDMI-A-2
[89.070695] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[89.087684] Starting dynamic subtest: pipe-B-HDMI-A-1
[89.100659] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[89.117822] Starting dynamic subtest: pipe-B-HDMI-A-2
[89.129487] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[89.146707] Starting dynamic subtest: pipe-C-HDMI-A-1
[89.154595] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[89.168966] Starting dynamic subtest: pipe-C-HDMI-A-2
[89.172302] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[89.173962] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SKIP (0.019s)
[89.940859] [004/133] (958s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[90.129917] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[90.345732] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.215s)
[90.587673] [005/133] (957s left) perf_pmu (busy-idle)
[90.692398] Starting subtest: busy-idle
[90.693328] Starting dynamic subtest: rcs0
[91.341702] Dynamic subtest rcs0: SUCCESS (0.649s)
[91.360558] Starting dynamic subtest: bcs0
[91.992971] Dynamic subtest bcs0: SUCCESS (0.650s)
[92.009423] Starting dynamic subtest: vcs0
[92.636366] Dynamic subtest vcs0: SUCCESS (0.642s)
[92.655560] Starting dynamic subtest: vecs0
[93.278739] Dynamic subtest vecs0: SUCCESS (0.641s)
[93.280341] Subtest busy-idle: SUCCESS (2.587s)
[93.410205] [006/133] (955s left) api_intel_bb (blit-reloc-purge-cache)
[93.505666] Starting subtest: blit-reloc-purge-cache
[93.525261] Subtest blit-reloc-purge-cache: SUCCESS (0.020s)
[93.678299] [007/133] (955s left) syncobj_timeline (wait-all-for-submit-snapshot)
[93.777794] Starting subtest: wait-all-for-submit-snapshot
[93.864382] Subtest wait-all-for-submit-snapshot: SUCCESS (0.086s)
[93.996418] [008/133] (954s left) gem_wait (wait)
[94.128951] Starting subtest: wait
[94.131213] Starting dynamic subtest: all-engines
[95.170633] Dynamic subtest all-engines: SUCCESS (1.042s)
[95.193172] Starting dynamic subtest: rcs0
[96.203726] Dynamic subtest rcs0: SUCCESS (1.032s)
[96.221277] Starting dynamic subtest: bcs0
[97.239234] Dynamic subtest bcs0: SUCCESS (1.032s)
[97.255498] Starting dynamic subtest: vcs0
[98.269344] Dynamic subtest vcs0: SUCCESS (1.031s)
[98.286331] Starting dynamic subtest: vecs0
[99.298937] Dynamic subtest vecs0: SUCCESS (1.029s)
[99.300549] Subtest wait: SUCCESS (5.171s)
[99.579422] [009/133] (949s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[99.770992] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[101.126251] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (1.355s)
[101.476452] [010/133] (947s left) gem_exec_schedule (implicit-read-write)
[101.596741] Starting subtest: implicit-read-write
[101.598048] Starting dynamic subtest: rcs0
[101.725331] Dynamic subtest rcs0: SUCCESS (0.125s)
[101.743885] Starting dynamic subtest: bcs0
[101.847501] Dynamic subtest bcs0: SUCCESS (0.121s)
[101.875777] Starting dynamic subtest: vcs0
[101.973509] Dynamic subtest vcs0: SUCCESS (0.123s)
[101.991752] Starting dynamic subtest: vecs0
[102.086130] Dynamic subtest vecs0: SUCCESS (0.115s)
[102.087651] Subtest implicit-read-write: SUCCESS (0.490s)
[102.480390] [011/133] (946s left) i915_pm_freq_api (freq-suspend)
[102.586783] Subtest freq-suspend: SKIP (0.000s)
[102.688584] [012/133] (946s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[102.860220] Starting subtest: cursor-rapid-movement-32x10
[103.004580] Subtest cursor-rapid-movement-32x10: SKIP (0.142s)
[103.161615] [013/133] (946s left) kms_psr (pr-sprite-blt)
[103.331456] Subtest pr-sprite-blt: SKIP (0.000s)
[103.433467] [014/133] (945s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[103.536262] Starting subtest: invalid-bsd2-flag-on-blt
[103.537157] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.001s)
[103.693958] [015/133] (945s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[103.875157] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[103.876939] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[104.039753] [016/133] (945s left) syncobj_wait (invalid-reset-illegal-handle)
[104.135081] Starting subtest: invalid-reset-illegal-handle
[104.136218] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[104.293429] [017/133] (945s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[104.464317] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[104.465334] Starting dynamic subtest: pipe-A-HDMI-A-1
[104.474495] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[104.491711] Starting dynamic subtest: pipe-A-HDMI-A-2
[104.500789] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[104.517981] Starting dynamic subtest: pipe-B-HDMI-A-1
[104.529426] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[104.550411] Starting dynamic subtest: pipe-B-HDMI-A-2
[104.559713] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[104.577526] Starting dynamic subtest: pipe-C-HDMI-A-1
[104.585606] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[104.602459] Starting dynamic subtest: pipe-C-HDMI-A-2
[104.611788] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[104.613443] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SKIP (0.016s)
[105.352467] [018/133] (944s left) gem_exec_params (cliprects_ptr-dirt)
[105.456217] Starting subtest: cliprects_ptr-dirt
[105.457312] Subtest cliprects_ptr-dirt: SUCCESS (0.001s)
[105.605398] [019/133] (944s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[105.714608] Starting subtest: writes-after-reads-snoop
[123.843278] Subtest writes-after-reads-snoop: SUCCESS (18.128s)
[124.004803] [020/133] (925s left) kms_selftest (drm_dp_mst_helper)
[124.108303] Starting subtest: drm_dp_mst_helper
[124.140970] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[124.212418] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.071s)
[124.231057] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[124.282489] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.069s)
[124.300756] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[124.354757] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.073s)
[124.356031] Subtest drm_dp_mst_helper: SUCCESS (0.248s)
[124.538851] [021/133] (925s left) prime_self_import (basic-with_one_bo_two_files)
[124.630362] Starting subtest: basic-with_one_bo_two_files
[124.636527] Subtest basic-with_one_bo_two_files: SUCCESS (0.006s)
[124.787263] [022/133] (925s left) syncobj_timeline (invalid-transfer-bad-pad)
[124.883165] Starting subtest: invalid-transfer-bad-pad
[124.884139] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[125.018355] [023/133] (925s left) gem_flink_basic (basic)
[125.113564] Starting subtest: basic
[125.114570] Subtest basic: SUCCESS (0.000s)
[125.256346] [024/133] (924s left) syncobj_wait (invalid-wait-bad-flags)
[125.357385] Starting subtest: invalid-wait-bad-flags
[125.358517] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[125.492153] [025/133] (924s left) kms_busy (extended-pageflip-hang-newfb)
[125.672761] Starting subtest: extended-pageflip-hang-newfb
[125.673823] Starting dynamic subtest: pipe-A
[129.947118] Dynamic subtest pipe-A: SUCCESS (4.271s)
[129.969054] Starting dynamic subtest: pipe-C
[133.900346] Dynamic subtest pipe-C: SUCCESS (3.946s)
[133.903192] Subtest extended-pageflip-hang-newfb: SUCCESS (8.229s)
[134.211064] [026/133] (916s left) kms_flip (plain-flip-ts-check-interruptible)
[134.390081] Starting subtest: plain-flip-ts-check-interruptible
[134.393176] Starting dynamic subtest: A-HDMI-A1
[140.274735] Dynamic subtest A-HDMI-A1: SUCCESS (5.880s)
[140.295110] Starting dynamic subtest: B-HDMI-A1
[145.940221] Dynamic subtest B-HDMI-A1: SUCCESS (5.661s)
[145.958524] Starting dynamic subtest: C-HDMI-A1
[151.585263] Dynamic subtest C-HDMI-A1: SUCCESS (5.645s)
[151.602984] Starting dynamic subtest: A-HDMI-A2
[157.251457] Dynamic subtest A-HDMI-A2: SUCCESS (5.665s)
[157.270037] Starting dynamic subtest: B-HDMI-A2
[162.895931] Dynamic subtest B-HDMI-A2: SUCCESS (5.643s)
[162.915541] Starting dynamic subtest: C-HDMI-A2
[168.547202] Dynamic subtest C-HDMI-A2: SUCCESS (5.649s)
[168.548146] Subtest plain-flip-ts-check-interruptible: SUCCESS (34.156s)
[169.008526] [027/133] (881s left) gem_mmap (big-bo)
[169.102089] Starting subtest: big-bo
[170.695678] Subtest big-bo: SUCCESS (1.590s)
[170.838572] [028/133] (879s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[171.131737] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[171.135581] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[171.290765] [029/133] (879s left) syncobj_timeline (wait-any-snapshot)
[171.398861] Starting subtest: wait-any-snapshot
[171.484074] Subtest wait-any-snapshot: SUCCESS (0.086s)
[171.630627] [030/133] (879s left) gem_mmap (bad-size)
[171.724645] Starting subtest: bad-size
[171.725548] Subtest bad-size: SUCCESS (0.002s)
[171.873647] [031/133] (878s left) syncobj_timeline (multi-wait-for-submit-signaled)
[171.968050] Starting subtest: multi-wait-for-submit-signaled
[171.970070] Subtest multi-wait-for-submit-signaled: SUCCESS (0.002s)
[172.111094] [032/133] (878s left) gem_pxp (reject-modify-context-protection-off-2)
[174.749665] Starting subtest: reject-modify-context-protection-off-2
[174.751612] Subtest reject-modify-context-protection-off-2: SKIP (0.000s)
[174.874737] [033/133] (876s left) kms_cursor_edge_walk (128x128-left-edge)
[175.045691] Starting subtest: 128x128-left-edge
[175.049553] Starting dynamic subtest: pipe-A-HDMI-A-1
[178.947351] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.898s)
[178.969468] Starting dynamic subtest: pipe-C-HDMI-A-1
[182.397115] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.446s)
[182.398093] Subtest 128x128-left-edge: SUCCESS (7.352s)
[182.650892] [034/133] (868s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[182.749099] Starting subtest: etime-multi-wait-for-submit-submitted
[182.858124] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.109s)
[183.000214] [035/133] (868s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[183.168817] Starting subtest: 2x-long-cursor-vs-flip-atomic
[234.284323] Subtest 2x-long-cursor-vs-flip-atomic: SUCCESS (51.113s)
[234.569668] [036/133] (816s left) i915_pm_rps (engine-order)
[234.678768] Starting subtest: engine-order
[246.089383] Subtest engine-order: SUCCESS (11.411s)
[246.333100] [037/133] (804s left) kms_vblank (ts-continuation-suspend)
[246.498435] Starting subtest: ts-continuation-suspend
[246.499368] Starting dynamic subtest: pipe-A-HDMI-A-1
[264.857810] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.322s)
[264.912210] Starting dynamic subtest: pipe-A-HDMI-A-2