[89.135172] Initializing watchdogs
[89.135373]   /dev/watchdog0
[89.175635] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[89.190685] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[89.198442] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[89.204412] [001/131] (960s left) gem_ctx_persistence (legacy-engines-cleanup)
[89.343640] Starting subtest: legacy-engines-cleanup
[89.345675] Starting dynamic subtest: render
[89.368109] Dynamic subtest render: SUCCESS (0.024s)
[89.395225] Starting dynamic subtest: bsd
[89.399185] Dynamic subtest bsd: SUCCESS (0.025s)
[89.421409] Starting dynamic subtest: blt
[89.429356] Dynamic subtest blt: SUCCESS (0.031s)
[89.449287] Starting dynamic subtest: vebox
[89.461087] Dynamic subtest vebox: SUCCESS (0.028s)
[89.463299] Subtest legacy-engines-cleanup: SUCCESS (0.119s)
[89.624456] [002/131] (960s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[89.802080] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[89.805513] Starting dynamic subtest: pipe-A
[90.137863] Dynamic subtest pipe-A: SUCCESS (0.336s)
[90.172911] Starting dynamic subtest: pipe-B
[90.533191] Dynamic subtest pipe-B: SUCCESS (0.395s)
[90.567261] Starting dynamic subtest: pipe-C
[90.602274] Dynamic subtest pipe-C: SUCCESS (0.065s)
[90.604471] Subtest planes-downscale-factor-0-5-upscale-20x20: SUCCESS (0.798s)
[91.099184] [003/131] (958s left) gem_ctx_engines (execute-oneforall)
[91.226202] Starting subtest: execute-oneforall
[91.837182] Subtest execute-oneforall: SUCCESS (0.611s)
[92.082551] [004/131] (957s left) gem_mmap_gtt (fault-concurrent)
[92.180824] Starting subtest: fault-concurrent
[98.140213] Subtest fault-concurrent: SUCCESS (5.951s)
[98.284455] [005/131] (951s left) gem_mmap_offset (clear)
[98.388168] Starting subtest: clear
[98.393080] Starting dynamic subtest: smem0
[120.455237] Dynamic subtest smem0: SUCCESS (22.054s)
[120.460940] Subtest clear: SUCCESS (22.055s)
[120.624442] [006/131] (929s left) gem_ctx_param (set-priority-not-supported)
[120.866966] Starting subtest: set-priority-not-supported
[120.872257] Subtest set-priority-not-supported: SKIP (0.000s)
[121.004291] [007/131] (929s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[121.129107] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[121.130792] Starting dynamic subtest: smem
[121.495458] Dynamic subtest smem: SUCCESS (0.367s)
[121.497231] Subtest mixed-tiled-to-yf-tiled-ccs: SUCCESS (0.368s)
[121.742224] [008/131] (928s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[121.940210] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[121.943330] Starting dynamic subtest: pipe-A-HDMI-A-1
[121.964797] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.003s)
[122.008499] Starting dynamic subtest: pipe-A-HDMI-A-2
[122.035398] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.003s)
[122.074337] Starting dynamic subtest: pipe-B-HDMI-A-1
[122.101432] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.002s)
[122.139483] Starting dynamic subtest: pipe-B-HDMI-A-2
[122.166544] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.002s)
[122.188277] Starting dynamic subtest: pipe-C-HDMI-A-1
[122.204575] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[122.226092] Starting dynamic subtest: pipe-C-HDMI-A-2
[122.241956] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[122.243621] Subtest ccs-on-another-bo-y-tiled-ccs: SUCCESS (0.038s)
[123.075118] [009/131] (927s left) kms_atomic_transition (plane-all-transition)
[123.252218] Starting subtest: plane-all-transition
[123.254232] Starting dynamic subtest: pipe-A-HDMI-A-1
[127.722773] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.466s)
[128.045026] Starting dynamic subtest: pipe-A-HDMI-A-2
[132.418441] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (4.391s)
[132.697266] Starting dynamic subtest: pipe-B-HDMI-A-1
[137.362506] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (4.707s)
[137.694516] Starting dynamic subtest: pipe-B-HDMI-A-2
[142.906592] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (5.254s)
[143.140803] Subtest plane-all-transition: SUCCESS (19.887s)
[143.542575] [010/131] (906s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[143.790396] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[143.794611] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.001s)
[143.931511] [011/131] (906s left) gem_exec_schedule (u-semaphore-codependency)
[144.090108] Starting subtest: u-semaphore-codependency
[144.124434] Subtest u-semaphore-codependency: SUCCESS (0.034s)
[144.515918] [012/131] (906s left) kms_atomic (atomic-plane-damage)
[144.719073] Starting subtest: atomic-plane-damage
[145.846171] Subtest atomic-plane-damage: SKIP (1.127s)
[146.360581] [013/131] (904s left) gem_exec_fence (syncobj-timeline-chain-engines)
[147.202219] Starting subtest: syncobj-timeline-chain-engines
[147.337621] Subtest syncobj-timeline-chain-engines: SUCCESS (0.136s)
[147.600291] [FACT gem_exec_fence (syncobj-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[147.606656] [014/131] (903s left) kms_selftest (drm_cmdline_parser)
[147.724542] Starting subtest: drm_cmdline_parser
[147.741073] Starting dynamic subtest: drm_test_cmdline_force_d_only
[147.822678] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.084s)
[147.848656] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[147.881413] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.052s)
[147.907303] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[147.952583] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.065s)
[147.978300] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[148.016563] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.058s)
[148.042485] Starting dynamic subtest: drm_test_cmdline_force_e_only
[148.076603] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.054s)
[148.102355] Starting dynamic subtest: drm_test_cmdline_res
[148.133910] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.051s)
[148.160234] Starting dynamic subtest: drm_test_cmdline_res_vesa
[148.196328] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.054s)
[148.222112] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[148.259521] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.058s)
[148.289683] Starting dynamic subtest: drm_test_cmdline_res_rblank
[148.330962] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.064s)
[148.357929] Starting dynamic subtest: drm_test_cmdline_res_bpp
[148.392783] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.055s)
[148.422014] Starting dynamic subtest: drm_test_cmdline_res_refresh
[148.453023] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.048s)
[148.478810] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[148.515266] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.057s)
[148.541307] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[148.576976] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.056s)
[148.608335] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[148.652253] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.066s)
[148.678244] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[148.714327] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.058s)
[148.741238] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[148.782261] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.060s)
[148.808235] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[148.835725] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.047s)
[148.861793] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[148.891688] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.049s)
[148.921046] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[148.956072] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.051s)
[148.979052] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[149.007983] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.048s)
[149.032167] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[149.066758] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.055s)
[149.087463] Starting dynamic subtest: drm_test_cmdline_name
[149.143098] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.069s)
[149.168210] Starting dynamic subtest: drm_test_cmdline_name_bpp
[149.195265] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.050s)
[149.221182] Starting dynamic subtest: drm_test_cmdline_name_option
[149.248099] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.048s)
[149.277116] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[149.306946] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.051s)
[149.335095] Starting dynamic subtest: drm_test_cmdline_rotate_0
[149.364141] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.048s)
[149.390181] Starting dynamic subtest: drm_test_cmdline_rotate_90
[149.417111] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.050s)
[149.441810] Starting dynamic subtest: drm_test_cmdline_rotate_180
[149.460081] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.037s)
[149.483946] Starting dynamic subtest: drm_test_cmdline_rotate_270
[149.513885] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.052s)
[149.537467] Starting dynamic subtest: drm_test_cmdline_hmirror
[149.579090] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.060s)
[149.604270] Starting dynamic subtest: drm_test_cmdline_vmirror
[149.645672] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.064s)
[149.670455] Starting dynamic subtest: drm_test_cmdline_margin_options
[149.710051] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.056s)
[149.730234] Starting dynamic subtest: drm_test_cmdline_multiple_options
[149.766167] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.056s)
[149.791670] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[149.819647] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.049s)
[149.844543] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[149.870903] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.051s)
[149.896284] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[149.941712] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.062s)
[149.966986] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[150.002691] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.059s)
[150.030932] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[150.063052] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.051s)
[150.085659] Starting dynamic subtest: drm_test_cmdline_invalid
[150.156251] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.090s)
[150.183283] Starting dynamic subtest: drm_test_cmdline_tv_options
[150.246255] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.082s)
[150.248850] Subtest drm_cmdline_parser: SUCCESS (2.529s)
[150.421470] [015/131] (900s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[150.622111] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[150.624063] Starting dynamic subtest: pipe-A-valid-mode
[151.639916] Dynamic subtest pipe-A-valid-mode: SKIP (1.008s)
[151.642980] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (1.014s)
[152.177977] [016/131] (898s left) kms_content_protection (type1)
[152.397904] Starting subtest: type1
[152.437711] Subtest type1: SKIP (0.036s)
[152.583300] [017/131] (898s left) gem_exec_params (invalid-bsd1-flag-on-render)
[152.710660] Starting subtest: invalid-bsd1-flag-on-render
[152.712440] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.001s)
[152.892723] [018/131] (898s left) kms_psr (psr2-cursor-plane-move)
[153.104081] Subtest psr2-cursor-plane-move: SKIP (0.000s)
[153.207611] [019/131] (898s left) perf (gen8-unprivileged-single-ctx-counters)
[153.500063] Starting subtest: gen8-unprivileged-single-ctx-counters
[153.625266] Subtest gen8-unprivileged-single-ctx-counters: SUCCESS (0.137s)
[153.749757] [020/131] (897s left) kms_psr (pr-cursor-mmap-gtt)
[153.954942] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[154.069624] [021/131] (897s left) kms_chamelium_frames (dp-crc-single)
[154.712232] Subtest dp-crc-single: SKIP (0.000s)
[155.065403] [022/131] (896s left) syncobj_timeline (wait-any-snapshot)
[155.184098] Starting subtest: wait-any-snapshot
[155.265141] Subtest wait-any-snapshot: SUCCESS (0.083s)
[155.425867] [023/131] (896s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[155.646109] Starting subtest: x-tiled-64bpp-rotate-0
[160.433186] Subtest x-tiled-64bpp-rotate-0: SUCCESS (4.787s)
[160.997230] [024/131] (890s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[161.212946] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[161.218158] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[161.365761] [025/131] (890s left) kms_psr (psr-no-drrs)
[161.544231] Subtest psr-no-drrs: SKIP (0.000s)
[161.656099] [026/131] (890s left) kms_psr (fbc-psr2-basic)
[161.851468] Subtest fbc-psr2-basic: SKIP (0.000s)
[161.972795] [027/131] (890s left) perf (blocking-parameterized)
[162.178477] Starting subtest: blocking-parameterized
[182.215765] Subtest blocking-parameterized: SUCCESS (20.036s)
[182.335585] [028/131] (869s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[182.532149] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[182.656579] [029/131] (869s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[183.224177] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[183.611195] [030/131] (868s left) sw_sync (timeline_closed_signaled)
[183.721602] Starting subtest: timeline_closed_signaled
[183.726058] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[183.858347] [031/131] (868s left) kms_vrr (flipline)
[184.047138] Starting subtest: flipline
[184.054182] Subtest flipline: SKIP (0.000s)
[184.196395] [032/131] (868s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[184.305984] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[184.410127] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.104s)
[184.561798] [033/131] (868s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[184.782285] Starting subtest: cursor-rapid-movement-256x256
[184.856039] Starting dynamic subtest: pipe-A-HDMI-A-1
[185.796320] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.938s)
[185.941471] Starting dynamic subtest: pipe-C-HDMI-A-1
[186.509323] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.613s)
[186.511841] Subtest cursor-rapid-movement-256x256: SUCCESS (1.729s)
[186.858653] [034/131] (865s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[187.070056] Starting subtest: yf-tiled-8bpp-rotate-270
[187.075047] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[187.211182] [035/131] (865s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[187.414139] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[187.419156] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[187.562715] [036/131] (865s left) kms_prime (basic-crc-hybrid)
[187.797165] Subtest basic-crc-hybrid: SKIP (0.000s)
[187.986578] [037/131] (865s left) gem_userptr_blits (huge-split)
[188.144318] Starting subtest: huge-split
[188.153669] Subtest huge-split: SUCCESS (0.009s)
[188.296834] [038/131] (864s left) perf_pmu (invalid-init)
[188.415200] Starting subtest: invalid-init
[188.418376] Subtest invalid-init: SUCCESS (0.001s)
[188.564361] [039/131] (864s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[188.776113] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[191.566485] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SUCCESS (2.791s)
[191.774940] [040/131] (861s left) gem_exec_params (rel-constants-invalid)
[191.891439] Starting subtest: rel-constants-invalid
[191.894432] Subtest rel-constants-invalid: SUCCESS (0.001s)
[192.044479] [041/131] (861s left) gen9_exec_parse (secure-batches)
[192.174703] Starting subtest: secure-batches
[192.177353] Subtest secure-batches: SUCCESS (0.000s)
[192.445520] [042/131] (861s left) prime_busy (before-wait)
[192.561211] Starting subtest: before-wait
[192.575132] Starting dynamic subtest: rcs0
[192.586692] Dynamic subtest rcs0: SUCCESS (0.013s)
[192.614069] Starting dynamic subtest: bcs0
[192.615810] Dynamic subtest bcs0: SUCCESS (0.016s)
[192.642785] Starting dynamic subtest: vcs0
[192.646189] Dynamic subtest vcs0: SUCCESS (0.015s)
[192.667235] Starting dynamic subtest: vecs0
[192.669089] Dynamic subtest vecs0: SUCCESS (0.012s)
[192.759292] Subtest before-wait: SUCCESS (0.198s)
[192.941959] [043/131] (860s left) sysfs_timeslice_duration (duration)
[193.062521] Starting subtest: duration
[193.072127] Starting dynamic subtest: vecs0
[193.154860] Dynamic subtest vecs0: SUCCESS (0.086s)
[193.189867] Starting dynamic subtest: vcs0
[193.230375] Dynamic subtest vcs0: SUCCESS (0.074s)
[193.260052] Starting dynamic subtest: bcs0
[193.317325] Dynamic subtest bcs0: SUCCESS (0.083s)
[193.346175] Starting dynamic subtest: rcs0
[193.406868] Dynamic subtest rcs0: SUCCESS (0.084s)
[193.408975] Subtest duration: SUCCESS (0.346s)
[193.560517] [044/131] (860s left) gem_exec_schedule (u-submit-late-slice)
[193.698383] Starting subtest: u-submit-late-slice
[193.701194] Starting dynamic subtest: rcs0
[193.749583] Dynamic subtest rcs0: SUCCESS (0.051s)
[193.782206] Starting dynamic subtest: bcs0
[193.798746] Dynamic subtest bcs0: SUCCESS (0.049s)
[193.837285] Starting dynamic subtest: vcs0
[193.848142] Dynamic subtest vcs0: SUCCESS (0.044s)
[193.876629] Starting dynamic subtest: vecs0
[193.898760] Dynamic subtest vecs0: SUCCESS (0.050s)
[193.907992] Subtest u-submit-late-slice: SUCCESS (0.209s)
[194.311905] [045/131] (859s left) gem_render_copy (x-tiled)
[194.435125] Starting subtest: x-tiled
[194.436966] Starting dynamic subtest: smem
[194.650986] Dynamic subtest smem: SUCCESS (0.214s)
[194.653029] Subtest x-tiled: SUCCESS (0.217s)
[194.943847] [046/131] (859s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[195.143197] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[196.362243] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (1.217s)
[196.712061] [047/131] (857s left) kms_cursor_crc (cursor-suspend)
[196.898185] Starting subtest: cursor-suspend
[196.899947] Starting dynamic subtest: pipe-A-HDMI-A-1