[160.540568] Initializing watchdogs
[160.540757]   /dev/watchdog0
[160.582194] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[160.597055] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[160.605148] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[160.611497] [001/156] (960s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[160.812919] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[160.818061] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[160.953813] [002/156] (960s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-render)
[161.163116] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-render
[161.167913] Subtest hdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[161.317104] [003/156] (959s left) kms_big_fb (linear-16bpp-rotate-0)
[161.547152] Starting subtest: linear-16bpp-rotate-0
[165.954070] Subtest linear-16bpp-rotate-0: SUCCESS (4.407s)
[166.337342] [004/156] (955s left) gem_exec_balancer (waits)
[166.473051] Starting subtest: waits
[170.894921] Subtest waits: SUCCESS (4.422s)
[171.208416] [005/156] (950s left) kms_vblank (wait-forked-busy)
[171.390870] Starting subtest: wait-forked-busy
[171.394464] Starting dynamic subtest: pipe-A-HDMI-A-1
[174.285608] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.895s)
[174.335849] Starting dynamic subtest: pipe-A-HDMI-A-2
[176.922496] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.630s)
[176.959625] Starting dynamic subtest: pipe-C-HDMI-A-1
[179.598238] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.663s)
[179.637275] Starting dynamic subtest: pipe-C-HDMI-A-2
[182.205671] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.601s)
[182.209406] Subtest wait-forked-busy: SUCCESS (10.818s)
[182.573201] [006/156] (938s left) kms_plane_lowres (tiling-none)
[182.755223] Starting subtest: tiling-none
[182.758117] Starting dynamic subtest: pipe-A-HDMI-A-1
[189.943731] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.189s)
[190.182859] Starting dynamic subtest: pipe-A-HDMI-A-2
[197.001683] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (6.837s)
[197.244668] Starting dynamic subtest: pipe-B-HDMI-A-1
[203.755741] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.533s)
[203.987924] Starting dynamic subtest: pipe-B-HDMI-A-2
[210.645547] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (6.687s)
[210.878951] Starting dynamic subtest: pipe-C-HDMI-A-1
[217.787485] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (6.935s)
[218.015662] Starting dynamic subtest: pipe-C-HDMI-A-2
[224.707934] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (6.718s)
[224.911101] Subtest tiling-none: SUCCESS (42.159s)
[225.351677] [007/156] (896s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-shrfb-msflip-blt)
[225.556221] Starting subtest: fbchdr-1p-primscrn-shrfb-msflip-blt
[225.561486] Subtest fbchdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[225.700850] [008/156] (896s left) gem_ctx_shared (q-independent)
[225.834398] Starting subtest: Q-independent
[225.837123] Starting dynamic subtest: rcs0
[225.907155] Dynamic subtest rcs0: SUCCESS (0.068s)
[225.943932] Starting dynamic subtest: bcs0
[225.984781] Dynamic subtest bcs0: SUCCESS (0.074s)
[226.013112] Starting dynamic subtest: vcs0
[226.054405] Dynamic subtest vcs0: SUCCESS (0.063s)
[226.079206] Starting dynamic subtest: vecs0
[226.113174] Dynamic subtest vecs0: SUCCESS (0.061s)
[226.118260] Subtest Q-independent: SUCCESS (0.281s)
[226.389961] [009/156] (895s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[226.595439] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[226.600106] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[226.736164] [010/156] (895s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-linear)
[226.934337] Starting subtest: fbcpsrhdr-tiling-linear
[226.940069] Subtest fbcpsrhdr-tiling-linear: SKIP (0.000s)
[227.086230] [011/156] (894s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[227.286400] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[229.796628] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SUCCESS (2.515s)
[230.021906] [012/156] (892s left) kms_selftest (drm_cmdline_parser)
[230.135287] Starting subtest: drm_cmdline_parser
[230.178165] Starting dynamic subtest: drm_test_cmdline_force_d_only
[230.230292] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.059s)
[230.256514] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[230.297046] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.058s)
[230.318667] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[230.341883] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.044s)
[230.362618] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[230.396567] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.052s)
[230.425112] Starting dynamic subtest: drm_test_cmdline_force_e_only
[230.448605] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.045s)
[230.479339] Starting dynamic subtest: drm_test_cmdline_res
[230.494079] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.038s)
[230.516417] Starting dynamic subtest: drm_test_cmdline_res_vesa
[230.556689] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.060s)
[230.579576] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[230.611059] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.047s)
[230.631431] Starting dynamic subtest: drm_test_cmdline_res_rblank
[230.658057] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.048s)
[230.685629] Starting dynamic subtest: drm_test_cmdline_res_bpp
[230.711264] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.046s)
[230.731747] Starting dynamic subtest: drm_test_cmdline_res_refresh
[230.758297] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.044s)
[230.783850] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[230.804316] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.038s)
[230.825536] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[230.851168] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.040s)
[230.871731] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[230.902736] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.048s)
[230.924674] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[230.945822] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.040s)
[230.972156] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[230.989635] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.037s)
[231.010897] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[231.043157] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.050s)
[231.068855] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[231.085328] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.035s)
[231.113257] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[231.135416] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.045s)
[231.164259] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[231.195573] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.053s)
[231.216767] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[231.244900] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.046s)
[231.266325] Starting dynamic subtest: drm_test_cmdline_name
[231.282732] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.036s)
[231.309578] Starting dynamic subtest: drm_test_cmdline_name_bpp
[231.333695] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.047s)
[231.360086] Starting dynamic subtest: drm_test_cmdline_name_option
[231.395860] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.053s)
[231.417608] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[231.449318] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.045s)
[231.470351] Starting dynamic subtest: drm_test_cmdline_rotate_0
[231.482958] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.038s)
[231.514521] Starting dynamic subtest: drm_test_cmdline_rotate_90
[231.550070] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.051s)
[231.572325] Starting dynamic subtest: drm_test_cmdline_rotate_180
[231.605578] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.050s)
[231.627602] Starting dynamic subtest: drm_test_cmdline_rotate_270
[231.657953] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.051s)
[231.680285] Starting dynamic subtest: drm_test_cmdline_hmirror
[231.721140] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.056s)
[231.742580] Starting dynamic subtest: drm_test_cmdline_vmirror
[231.762126] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.037s)
[231.784194] Starting dynamic subtest: drm_test_cmdline_margin_options
[231.809046] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.043s)
[231.829576] Starting dynamic subtest: drm_test_cmdline_multiple_options
[231.859300] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.044s)
[231.881046] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[231.903752] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.042s)
[231.925482] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[231.953578] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.049s)
[231.979109] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[232.010914] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.048s)
[232.031730] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[232.049033] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.038s)
[232.069542] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[232.099724] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.051s)
[232.125616] Starting dynamic subtest: drm_test_cmdline_invalid
[232.181148] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.071s)
[232.202064] Starting dynamic subtest: drm_test_cmdline_tv_options
[232.237111] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.054s)
[232.239413] Subtest drm_cmdline_parser: SUCCESS (2.104s)
[232.435160] [013/156] (889s left) vgem_basic (unload)
[232.540353] Starting subtest: unload
[261.577343] Subtest unload: SUCCESS (29.041s)
[261.793832] [FACT vgem_basic (unload)] new: kernel.kmod_is_loaded.vgem: true
[261.800201] [014/156] (860s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-msflip-blt)
[262.021448] Starting subtest: hdr-1p-primscrn-shrfb-msflip-blt
[262.026750] Subtest hdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[262.180426] [015/156] (860s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[262.378474] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[262.380482] Starting dynamic subtest: pipe-A
[263.498228] Dynamic subtest pipe-A: SUCCESS (1.119s)
[263.521447] Starting dynamic subtest: pipe-B
[264.679752] Dynamic subtest pipe-B: SUCCESS (1.179s)
[264.712278] Starting dynamic subtest: pipe-C
[265.150283] Dynamic subtest pipe-C: SUCCESS (0.464s)
[265.151980] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (2.773s)
[265.739796] [016/156] (856s left) gem_exec_schedule (u-lateslice)
[265.882132] Starting subtest: u-lateslice
[265.885177] Starting dynamic subtest: rcs0
[265.915818] Dynamic subtest rcs0: SUCCESS (0.032s)
[265.945817] Starting dynamic subtest: bcs0
[265.952938] Dynamic subtest bcs0: SUCCESS (0.031s)
[265.981241] Starting dynamic subtest: vcs0
[265.988712] Dynamic subtest vcs0: SUCCESS (0.033s)
[266.013100] Starting dynamic subtest: vecs0
[266.026053] Dynamic subtest vecs0: SUCCESS (0.031s)
[266.029338] Subtest u-lateslice: SUCCESS (0.145s)
[266.427462] [017/156] (856s left) gem_exec_suspend (basic-s3-devices)
[266.561379] Starting subtest: basic-S3-devices
[266.563468] Starting dynamic subtest: smem
[276.472650] Dynamic subtest smem: SUCCESS (9.912s)
[276.475254] Subtest basic-S3-devices: SUCCESS (9.917s)
[281.764043] [018/156] (845s left) gem_ctx_persistence (engines-persistence)
[281.891313] Starting subtest: engines-persistence
[281.894530] Starting dynamic subtest: rcs0
[282.682416] Dynamic subtest rcs0: SUCCESS (0.789s)
[282.709457] Starting dynamic subtest: bcs0
[283.452436] Dynamic subtest bcs0: SUCCESS (0.766s)
[283.479952] Starting dynamic subtest: vcs0
[284.202333] Dynamic subtest vcs0: SUCCESS (0.742s)
[284.226393] Starting dynamic subtest: vecs0
[284.984974] Dynamic subtest vecs0: SUCCESS (0.780s)
[284.987035] Subtest engines-persistence: SUCCESS (3.096s)
[285.141576] [019/156] (842s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[285.338245] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[287.871634] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SUCCESS (2.536s)
[288.093645] [020/156] (839s left) prime_busy (before)
[288.213108] Starting subtest: before
[288.228149] Starting dynamic subtest: rcs0
[288.240770] Dynamic subtest rcs0: SUCCESS (0.013s)
[288.277398] Starting dynamic subtest: bcs0
[288.281206] Dynamic subtest bcs0: SUCCESS (0.011s)
[288.306804] Starting dynamic subtest: vcs0
[288.309680] Dynamic subtest vcs0: SUCCESS (0.013s)
[288.331492] Starting dynamic subtest: vecs0
[288.334263] Dynamic subtest vecs0: SUCCESS (0.010s)
[288.398675] Subtest before: SUCCESS (0.186s)
[288.559110] [021/156] (839s left) gem_exec_balancer (hang)
[288.813033] Starting subtest: hang
[293.022960] Subtest hang: SUCCESS (4.215s)
[293.192918] [022/156] (834s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-move)
[293.407903] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-move
[293.413198] Subtest psrhdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[293.557468] [023/156] (834s left) gem_softpin (safe-alignment)
[293.685132] Starting subtest: safe-alignment
[293.710943] Subtest safe-alignment: SUCCESS (0.029s)
[293.904146] [024/156] (834s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[294.114647] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[297.039052] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SUCCESS (2.928s)
[297.238191] [025/156] (831s left) kms_rotation_crc (cursor-rotation-180)
[297.440165] Starting subtest: cursor-rotation-180
[299.467647] Subtest cursor-rotation-180: SUCCESS (2.033s)
[299.780627] [026/156] (828s left) gem_userptr_blits (sync-overlap)
[299.919421] Starting subtest: sync-overlap
[299.925047] Subtest sync-overlap: SUCCESS (0.003s)
[300.103236] [027/156] (828s left) kms_properties (invalid-properties-atomic)
[300.293103] Starting subtest: invalid-properties-atomic
[300.611125] Subtest invalid-properties-atomic: SUCCESS (0.319s)
[300.766253] [028/156] (827s left) syncobj_timeline (wait-all-for-submit-complex)
[300.879454] Starting subtest: wait-all-for-submit-complex
[301.106626] Subtest wait-all-for-submit-complex: SUCCESS (0.230s)
[301.266669] [029/156] (827s left) gem_ctx_persistence (heartbeat-close)
[301.386268] Starting subtest: heartbeat-close
[301.516862] Subtest heartbeat-close: SUCCESS (0.131s)
[301.682601] [030/156] (827s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[303.610743] Starting subtest: dpms-mode-unset-lpsp
[303.825926] Subtest dpms-mode-unset-lpsp: SKIP (0.211s)
[304.282370] [031/156] (824s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[304.501968] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[304.505251] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[304.665391] [032/156] (824s left) kms_psr (pr-dpms)
[304.853089] Subtest pr-dpms: SKIP (0.000s)
[304.972970] [033/156] (824s left) syncobj_wait (invalid-single-wait-unsubmitted)
[305.090312] Starting subtest: invalid-single-wait-unsubmitted
[305.093775] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[305.247484] [034/156] (824s left) gem_exec_await (wide-contexts)
[305.549625] Starting subtest: wide-contexts
[327.974527] Subtest wide-contexts: SUCCESS (22.412s)
[328.252964] [035/156] (801s left) api_intel_bb (offset-control)
[328.452478] Starting subtest: offset-control
[328.467830] Subtest offset-control: SUCCESS (0.015s)
[328.618302] [036/156] (800s left) vgem_basic (bad-handle)
[328.739741] Starting subtest: bad-handle
[328.741593] Subtest bad-handle: SUCCESS (0.000s)
[328.884284] [037/156] (800s left) kms_psr (fbc-psr2-cursor-render)
[329.086506] Subtest fbc-psr2-cursor-render: SKIP (0.000s)
[329.205998] [038/156] (800s left) kms_content_protection (lic-type-1)
[329.433475] Starting subtest: lic-type-1
[329.461778] Subtest lic-type-1: SKIP (0.022s)
[329.617576] [039/156] (800s left) kms_psr (fbc-psr-basic)
[329.809131] Subtest fbc-psr-basic: SKIP (0.000s)
[329.937907] [040/156] (799s left) kms_flip (flip-vs-suspend-interruptible)
[330.147828] Starting subtest: flip-vs-suspend-interruptible
[330.154747] Starting dynamic subtest: A-HDMI-A1