[91.031972] Initializing watchdogs
[91.032206]   /dev/watchdog0
[91.074607] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[91.089723] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[91.097664] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[91.103517] [001/156] (960s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[91.307100] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[91.311459] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[91.454972] [002/156] (960s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-render)
[91.666172] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-render
[91.671214] Subtest hdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[91.835197] [003/156] (959s left) kms_big_fb (linear-16bpp-rotate-0)
[92.044148] Starting subtest: linear-16bpp-rotate-0
[96.425752] Subtest linear-16bpp-rotate-0: SUCCESS (4.379s)
[96.791467] [004/156] (955s left) gem_exec_balancer (waits)
[96.927841] Starting subtest: waits
[101.497133] Subtest waits: SUCCESS (4.566s)
[101.759202] [005/156] (950s left) kms_vblank (wait-forked-busy)
[101.939892] Starting subtest: wait-forked-busy
[101.946431] Starting dynamic subtest: pipe-A-HDMI-A-1
[104.809604] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.862s)
[104.851082] Starting dynamic subtest: pipe-A-HDMI-A-2
[107.472063] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.652s)
[107.501672] Starting dynamic subtest: pipe-C-HDMI-A-1
[110.078883] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.597s)
[110.114641] Starting dynamic subtest: pipe-C-HDMI-A-2
[112.680061] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.595s)
[112.682165] Subtest wait-forked-busy: SUCCESS (10.740s)
[113.017669] [006/156] (939s left) kms_plane_lowres (tiling-none)
[113.205800] Starting subtest: tiling-none
[113.209478] Starting dynamic subtest: pipe-A-HDMI-A-1
[120.237072] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.032s)
[120.475357] Starting dynamic subtest: pipe-A-HDMI-A-2
[127.220338] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (6.765s)
[127.459273] Starting dynamic subtest: pipe-B-HDMI-A-1
[134.005545] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.565s)
[134.228215] Starting dynamic subtest: pipe-B-HDMI-A-2
[140.725815] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (6.518s)
[140.954990] Starting dynamic subtest: pipe-C-HDMI-A-1
[147.480642] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (6.543s)
[147.732309] Starting dynamic subtest: pipe-C-HDMI-A-2
[154.213732] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (6.511s)
[154.458100] Subtest tiling-none: SUCCESS (41.248s)
[154.910102] [007/156] (897s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-shrfb-msflip-blt)
[155.112164] Starting subtest: fbchdr-1p-primscrn-shrfb-msflip-blt
[155.115877] Subtest fbchdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[155.253472] [008/156] (896s left) gem_ctx_shared (q-independent)
[155.384900] Starting subtest: Q-independent
[155.387196] Starting dynamic subtest: rcs0
[155.457159] Dynamic subtest rcs0: SUCCESS (0.072s)
[155.491238] Starting dynamic subtest: bcs0
[155.538847] Dynamic subtest bcs0: SUCCESS (0.071s)
[155.566158] Starting dynamic subtest: vcs0
[155.597068] Dynamic subtest vcs0: SUCCESS (0.061s)
[155.625858] Starting dynamic subtest: vecs0
[155.653981] Dynamic subtest vecs0: SUCCESS (0.057s)
[155.656396] Subtest Q-independent: SUCCESS (0.271s)
[155.921435] [009/156] (896s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[156.113116] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[156.117133] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[156.252616] [010/156] (896s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-linear)
[156.452654] Starting subtest: fbcpsrhdr-tiling-linear
[156.458116] Subtest fbcpsrhdr-tiling-linear: SKIP (0.000s)
[156.613521] [011/156] (895s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[156.814438] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[159.382203] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SUCCESS (2.567s)
[159.616763] [012/156] (892s left) kms_selftest (drm_cmdline_parser)
[159.726257] Starting subtest: drm_cmdline_parser
[159.758725] Starting dynamic subtest: drm_test_cmdline_force_d_only
[159.818223] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.059s)
[159.839752] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[159.873147] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.052s)
[159.898311] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[159.923667] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.044s)
[159.943623] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[159.984870] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.054s)
[160.004742] Starting dynamic subtest: drm_test_cmdline_force_e_only
[160.034948] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.050s)
[160.055425] Starting dynamic subtest: drm_test_cmdline_res
[160.094264] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.048s)
[160.123475] Starting dynamic subtest: drm_test_cmdline_res_vesa
[160.143842] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.052s)
[160.163152] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[160.199333] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.051s)
[160.220160] Starting dynamic subtest: drm_test_cmdline_res_rblank
[160.253179] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.051s)
[160.279535] Starting dynamic subtest: drm_test_cmdline_res_bpp
[160.315106] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.054s)
[160.334522] Starting dynamic subtest: drm_test_cmdline_res_refresh
[160.363254] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.045s)
[160.382425] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[160.423129] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.059s)
[160.445446] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[160.479051] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.049s)
[160.498428] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[160.526738] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.047s)
[160.550963] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[160.581135] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.046s)
[160.600553] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[160.635236] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.054s)
[160.660611] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[160.676083] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.036s)
[160.696471] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[160.734209] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.054s)
[160.763241] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[160.783098] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.040s)
[160.808328] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[160.841584] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.046s)
[160.861320] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[160.895972] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.050s)
[160.916487] Starting dynamic subtest: drm_test_cmdline_name
[160.933561] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.040s)
[160.962691] Starting dynamic subtest: drm_test_cmdline_name_bpp
[160.976526] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.034s)
[160.996370] Starting dynamic subtest: drm_test_cmdline_name_option
[161.030398] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.049s)
[161.051371] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[161.082959] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.051s)
[161.107698] Starting dynamic subtest: drm_test_cmdline_rotate_0
[161.137358] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.049s)
[161.162847] Starting dynamic subtest: drm_test_cmdline_rotate_90
[161.197386] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.053s)
[161.219494] Starting dynamic subtest: drm_test_cmdline_rotate_180
[161.258998] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.056s)
[161.285389] Starting dynamic subtest: drm_test_cmdline_rotate_270
[161.309561] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.041s)
[161.331644] Starting dynamic subtest: drm_test_cmdline_hmirror
[161.349652] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.038s)
[161.373301] Starting dynamic subtest: drm_test_cmdline_vmirror
[161.382562] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.029s)
[161.401992] Starting dynamic subtest: drm_test_cmdline_margin_options
[161.426671] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.044s)
[161.451285] Starting dynamic subtest: drm_test_cmdline_multiple_options
[161.480388] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.044s)
[161.499945] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[161.533859] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.052s)
[161.554376] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[161.589602] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.049s)
[161.608852] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[161.645211] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.050s)
[161.665565] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[161.692326] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.043s)
[161.712351] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[161.738218] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.044s)
[161.759199] Starting dynamic subtest: drm_test_cmdline_invalid
[161.829243] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.084s)
[161.850739] Starting dynamic subtest: drm_test_cmdline_tv_options
[161.908646] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.070s)
[161.909813] Subtest drm_cmdline_parser: SUCCESS (2.178s)
[162.086212] [013/156] (890s left) vgem_basic (unload)
[162.189230] Starting subtest: unload
[191.242101] Subtest unload: SUCCESS (29.054s)
[191.455423] [FACT vgem_basic (unload)] new: kernel.kmod_is_loaded.vgem: true
[191.462433] [014/156] (861s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-msflip-blt)
[191.657338] Starting subtest: hdr-1p-primscrn-shrfb-msflip-blt
[191.660410] Subtest hdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[191.811496] [015/156] (861s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[191.997083] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[191.999638] Starting dynamic subtest: pipe-A
[193.114119] Dynamic subtest pipe-A: SUCCESS (1.115s)
[193.153526] Starting dynamic subtest: pipe-B
[194.282049] Dynamic subtest pipe-B: SUCCESS (1.165s)
[194.311243] Starting dynamic subtest: pipe-C
[194.769154] Dynamic subtest pipe-C: SUCCESS (0.481s)
[194.770441] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (2.773s)
[195.383122] [016/156] (857s left) gem_exec_schedule (u-lateslice)
[195.520740] Starting subtest: u-lateslice
[195.522778] Starting dynamic subtest: rcs0
[195.555937] Dynamic subtest rcs0: SUCCESS (0.036s)
[195.586703] Starting dynamic subtest: bcs0
[195.597635] Dynamic subtest bcs0: SUCCESS (0.029s)
[195.630391] Starting dynamic subtest: vcs0
[195.634692] Dynamic subtest vcs0: SUCCESS (0.025s)
[195.659346] Starting dynamic subtest: vecs0
[195.660540] Dynamic subtest vecs0: SUCCESS (0.027s)
[195.661669] Subtest u-lateslice: SUCCESS (0.133s)
[196.065672] [017/156] (856s left) gem_exec_suspend (basic-s3-devices)
[196.195114] Starting subtest: basic-S3-devices
[196.201564] Starting dynamic subtest: smem
[206.010292] Dynamic subtest smem: SUCCESS (9.812s)
[206.012257] Subtest basic-S3-devices: SUCCESS (9.817s)
[212.297074] [018/156] (846s left) gem_ctx_persistence (engines-persistence)
[212.426590] Starting subtest: engines-persistence
[212.429175] Starting dynamic subtest: rcs0
[213.173649] Dynamic subtest rcs0: SUCCESS (0.751s)
[213.203143] Starting dynamic subtest: bcs0
[213.944701] Dynamic subtest bcs0: SUCCESS (0.764s)
[213.973822] Starting dynamic subtest: vcs0
[214.716713] Dynamic subtest vcs0: SUCCESS (0.767s)
[214.746605] Starting dynamic subtest: vecs0
[215.478747] Dynamic subtest vecs0: SUCCESS (0.757s)
[215.482994] Subtest engines-persistence: SUCCESS (3.060s)
[215.633205] [019/156] (843s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[215.855231] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[218.351134] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SUCCESS (2.499s)
[218.566182] [020/156] (840s left) prime_busy (before)
[218.680095] Starting subtest: before
[218.696446] Starting dynamic subtest: rcs0
[218.705933] Dynamic subtest rcs0: SUCCESS (0.011s)
[218.737290] Starting dynamic subtest: bcs0
[218.738834] Dynamic subtest bcs0: SUCCESS (0.013s)
[218.764347] Starting dynamic subtest: vcs0
[218.765372] Dynamic subtest vcs0: SUCCESS (0.014s)
[218.786208] Starting dynamic subtest: vecs0
[218.787643] Dynamic subtest vecs0: SUCCESS (0.012s)
[218.877419] Subtest before: SUCCESS (0.195s)
[219.036277] [021/156] (840s left) gem_exec_balancer (hang)
[219.281396] Starting subtest: hang
[223.584151] Subtest hang: SUCCESS (4.300s)
[223.782154] [022/156] (835s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-move)
[223.998023] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-move
[224.001092] Subtest psrhdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[224.150785] [023/156] (835s left) gem_softpin (safe-alignment)
[224.273419] Starting subtest: safe-alignment
[224.304040] Subtest safe-alignment: SUCCESS (0.031s)
[224.495977] [024/156] (835s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[224.712540] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[227.633692] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SUCCESS (2.921s)
[227.833432] [025/156] (831s left) kms_rotation_crc (cursor-rotation-180)
[228.023098] Starting subtest: cursor-rotation-180
[230.000616] Subtest cursor-rotation-180: SUCCESS (1.978s)
[230.312870] [026/156] (829s left) gem_userptr_blits (sync-overlap)
[230.454202] Starting subtest: sync-overlap
[230.455943] Subtest sync-overlap: SUCCESS (0.000s)
[230.629629] [027/156] (829s left) kms_properties (invalid-properties-atomic)
[230.827276] Starting subtest: invalid-properties-atomic
[231.142182] Subtest invalid-properties-atomic: SUCCESS (0.318s)
[231.296141] [028/156] (828s left) syncobj_timeline (wait-all-for-submit-complex)
[231.402580] Starting subtest: wait-all-for-submit-complex
[231.639194] Subtest wait-all-for-submit-complex: SUCCESS (0.233s)
[231.796169] [029/156] (828s left) gem_ctx_persistence (heartbeat-close)
[231.910260] Starting subtest: heartbeat-close
[232.050702] Subtest heartbeat-close: SUCCESS (0.140s)
[232.212395] [030/156] (828s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[234.145373] Starting subtest: dpms-mode-unset-lpsp
[234.363108] Subtest dpms-mode-unset-lpsp: SKIP (0.217s)
[234.834547] [031/156] (825s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[235.050949] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[235.056289] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[235.200759] [032/156] (825s left) kms_psr (pr-dpms)
[235.397357] Subtest pr-dpms: SKIP (0.000s)
[235.519768] [033/156] (825s left) syncobj_wait (invalid-single-wait-unsubmitted)
[235.632655] Starting subtest: invalid-single-wait-unsubmitted
[235.634110] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.001s)
[235.780661] [034/156] (824s left) gem_exec_await (wide-contexts)
[236.088138] Starting subtest: wide-contexts
[258.461068] Subtest wide-contexts: SUCCESS (22.374s)
[258.739783] [035/156] (802s left) api_intel_bb (offset-control)
[259.010865] Starting subtest: offset-control
[259.026563] Subtest offset-control: SUCCESS (0.017s)
[259.230350] [036/156] (801s left) vgem_basic (bad-handle)
[259.360025] Starting subtest: bad-handle
[259.363214] Subtest bad-handle: SUCCESS (0.000s)
[259.496873] [037/156] (801s left) kms_psr (fbc-psr2-cursor-render)
[259.691200] Subtest fbc-psr2-cursor-render: SKIP (0.000s)
[259.801418] [038/156] (801s left) kms_content_protection (lic-type-1)
[260.023710] Starting subtest: lic-type-1
[260.058988] Subtest lic-type-1: SKIP (0.024s)
[260.210284] [039/156] (801s left) kms_psr (fbc-psr-basic)
[260.410075] Subtest fbc-psr-basic: SKIP (0.000s)
[260.528503] [040/156] (800s left) kms_flip (flip-vs-suspend-interruptible)
[260.719264] Starting subtest: flip-vs-suspend-interruptible
[260.726774] Starting dynamic subtest: A-HDMI-A1