[94.769812] Initializing watchdogs
[94.769982]   /dev/watchdog0
[94.810932] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[94.825863] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[94.834660] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[94.842526] [001/133] (960s left) i915_pm_sseu (full-enable)
[95.472486] Starting subtest: full-enable
[95.494453] Subtest full-enable: SUCCESS (0.020s)
[95.658792] [002/133] (959s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[95.844535] Starting subtest: cursorB-vs-flipB-legacy
[107.375013] Subtest cursorB-vs-flipB-legacy: SUCCESS (11.530s)
[107.716230] [003/133] (947s left) syncobj_wait (invalid-single-wait-unsubmitted)
[107.840931] Starting subtest: invalid-single-wait-unsubmitted
[107.845283] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.001s)
[107.977366] [004/133] (947s left) gem_exec_schedule (preempt-queue-contexts-chain)
[108.126178] Starting subtest: preempt-queue-contexts-chain
[108.130188] Starting dynamic subtest: rcs0
[108.995281] Dynamic subtest rcs0: SUCCESS (0.868s)
[109.024489] Starting dynamic subtest: bcs0
[109.856500] Dynamic subtest bcs0: SUCCESS (0.861s)
[109.903659] Starting dynamic subtest: vcs0
[110.724712] Dynamic subtest vcs0: SUCCESS (0.864s)
[110.776207] Starting dynamic subtest: vecs0
[111.552664] Dynamic subtest vecs0: SUCCESS (0.823s)
[111.557226] Subtest preempt-queue-contexts-chain: SUCCESS (3.425s)
[111.947312] [005/133] (943s left) syncobj_timeline (single-wait-all-available-submitted)
[112.063292] Starting subtest: single-wait-all-available-submitted
[112.066660] Subtest single-wait-all-available-submitted: SUCCESS (0.002s)
[112.196313] [006/133] (943s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[112.327805] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[112.331450] Starting dynamic subtest: smem
[112.569465] Dynamic subtest smem: SUCCESS (0.244s)
[112.573544] Subtest y-tiled-ccs-to-y-tiled-ccs: SUCCESS (0.246s)
[112.860827] [007/133] (943s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[113.076926] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[113.085080] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[113.230280] [008/133] (942s left) kms_sequence (get-busy)
[113.428066] Starting subtest: get-busy
[113.432070] Starting dynamic subtest: pipe-A-HDMI-A-1
[116.328642] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.899s)
[116.367661] Starting dynamic subtest: pipe-A-HDMI-A-2
[118.965586] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.635s)
[119.032584] Starting dynamic subtest: pipe-B-HDMI-A-1
[121.624643] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.648s)
[121.662151] Starting dynamic subtest: pipe-B-HDMI-A-2
[124.245664] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.618s)
[124.270502] Starting dynamic subtest: pipe-C-HDMI-A-1
[126.869395] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.613s)
[126.896185] Starting dynamic subtest: pipe-C-HDMI-A-2
[129.466811] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.601s)
[129.473232] Subtest get-busy: SUCCESS (16.046s)
[129.757332] [009/133] (926s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[129.978168] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[133.182340] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SUCCESS (3.201s)
[133.365089] [010/133] (922s left) gem_mmap_offset (partial-mmap)
[133.481487] Starting subtest: partial-mmap
[133.487129] Starting dynamic subtest: smem0
[133.490950] Dynamic subtest smem0: SUCCESS (0.009s)
[133.495571] Subtest partial-mmap: SUCCESS (0.010s)
[133.664779] [011/133] (922s left) kms_big_fb (linear-64bpp-rotate-180)
[133.887972] Starting subtest: linear-64bpp-rotate-180
[139.510127] Subtest linear-64bpp-rotate-180: SUCCESS (5.627s)
[140.023408] [012/133] (916s left) syncobj_timeline (reset-signaled)
[140.143996] Starting subtest: reset-signaled
[140.147263] Subtest reset-signaled: SUCCESS (0.003s)
[140.313282] [013/133] (916s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[140.527553] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[140.535767] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[140.671745] [014/133] (915s left) gem_ctx_persistence (userptr)
[140.800282] Starting subtest: userptr
[140.906395] Subtest userptr: SUCCESS (0.110s)
[141.070976] [015/133] (915s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[141.284425] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[143.365986] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SUCCESS (2.087s)
[143.584253] [016/133] (913s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[143.788038] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[143.893198] [017/133] (912s left) i915_drm_fdinfo (isolation)
[144.017822] Starting subtest: isolation
[144.023341] Starting dynamic subtest: rcs0
[144.553169] Dynamic subtest rcs0: SUCCESS (0.534s)
[144.577642] Starting dynamic subtest: bcs0
[145.089261] Dynamic subtest bcs0: SUCCESS (0.533s)
[145.114137] Starting dynamic subtest: vcs0
[145.620971] Dynamic subtest vcs0: SUCCESS (0.532s)
[145.645438] Starting dynamic subtest: vecs0
[146.155601] Dynamic subtest vecs0: SUCCESS (0.532s)
[146.159450] Subtest isolation: SUCCESS (2.138s)
[146.341354] [018/133] (910s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[146.457228] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[146.557404] [019/133] (910s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[146.666631] Starting subtest: multi-wait-for-submit-unsubmitted
[146.778138] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[146.916313] [020/133] (910s left) syncobj_wait (wait-zero-handles)
[147.029634] Starting subtest: wait-zero-handles
[147.033266] Subtest wait-zero-handles: SUCCESS (0.000s)
[147.167197] [021/133] (910s left) gem_exec_balancer (parallel-balancer)
[147.416356] Subtest parallel-balancer: SKIP (0.000s)
[147.568303] [022/133] (909s left) gem_ccs (large-ctrl-surf-copy)
[147.694262] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[147.804692] [023/133] (909s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[147.982634] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[147.988231] Starting dynamic subtest: pipe-A-HDMI-A-1
[148.033622] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[148.083059] Starting dynamic subtest: pipe-A-HDMI-A-2
[148.138824] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.002s)
[148.167018] Starting dynamic subtest: pipe-B-HDMI-A-1
[148.205098] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[148.228469] Starting dynamic subtest: pipe-B-HDMI-A-2
[148.261512] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.002s)
[148.283518] Starting dynamic subtest: pipe-C-HDMI-A-1
[148.318739] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[148.340444] Starting dynamic subtest: pipe-C-HDMI-A-2
[148.372481] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s)
[148.379331] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SKIP (0.030s)
[148.932030] [024/133] (908s left) api_intel_allocator (reserve-simple)
[149.057824] Starting subtest: reserve-simple
[149.068890] Subtest reserve-simple: SUCCESS (0.012s)
[149.212674] [025/133] (908s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[149.413500] Starting subtest: 2x-cursor-vs-flip-atomic
[179.528164] Subtest 2x-cursor-vs-flip-atomic: SUCCESS (30.117s)
[179.828935] [026/133] (877s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[180.037149] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[182.024360] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SUCCESS (1.992s)
[182.256292] [027/133] (875s left) gem_userptr_blits (coherency-unsync)
[182.398942] Subtest coherency-unsync: SKIP (0.000s)
[182.610395] [028/133] (875s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[182.824231] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[182.831321] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[182.962082] [029/133] (874s left) gem_exec_fence (syncobj-timeline-signal)
[183.746773] Starting subtest: syncobj-timeline-signal
[183.757600] Subtest syncobj-timeline-signal: SUCCESS (0.013s)
[184.033558] [FACT gem_exec_fence (syncobj-timeline-signal)] new: kernel.kmod_is_loaded.vgem: true
[184.040456] [030/133] (874s left) kms_prop_blob (basic)
[184.157554] Starting subtest: basic
[184.161483] Subtest basic: SUCCESS (0.000s)
[184.319431] [031/133] (873s left) kms_hdr (bpc-switch)
[184.502516] Starting subtest: bpc-switch
[212.863464] Subtest bpc-switch: SKIP (28.352s)
[213.392941] [032/133] (844s left) kms_big_fb (4-tiled-addfb-size-overflow)
[213.627643] Starting subtest: 4-tiled-addfb-size-overflow
[213.635195] Subtest 4-tiled-addfb-size-overflow: SKIP (0.000s)
[213.792163] [033/133] (844s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[213.995451] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[214.006075] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[214.146091] [034/133] (844s left) i915_pm_freq_api (freq-reset-multiple)
[214.273848] Subtest freq-reset-multiple: SKIP (0.000s)
[214.396188] [035/133] (844s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[214.591900] Starting subtest: coverage-vs-premult-vs-constant
[214.770350] Starting dynamic subtest: pipe-A-HDMI-A-1
[215.529523] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.760s)
[215.579167] Starting dynamic subtest: pipe-C-HDMI-A-1
[216.140972] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.609s)
[216.145603] Subtest coverage-vs-premult-vs-constant: SUCCESS (1.556s)
[216.493931] [036/133] (842s left) gem_watchdog (default-virtual)
[216.643479] Starting subtest: default-virtual
[217.661928] Subtest default-virtual: SUCCESS (1.028s)
[217.799753] [037/133] (840s left) gem_exec_store (cachelines)
[217.938580] Starting subtest: cachelines
[217.943094] Starting dynamic subtest: rcs0
[217.977877] Dynamic subtest rcs0: SUCCESS (0.038s)
[218.002509] Starting dynamic subtest: bcs0
[218.007052] Dynamic subtest bcs0: SUCCESS (0.020s)
[218.033266] Starting dynamic subtest: vcs0
[218.036900] Dynamic subtest vcs0: SUCCESS (0.023s)
[218.060161] Starting dynamic subtest: vecs0
[218.064117] Dynamic subtest vecs0: SUCCESS (0.019s)
[218.068093] Subtest cachelines: SUCCESS (0.115s)
[218.324262] [038/133] (840s left) gem_mmap (basic)
[218.435817] Starting subtest: basic
[218.454819] Subtest basic: SUCCESS (0.001s)
[218.591093] [039/133] (840s left) kms_psr (psr-primary-page-flip)
[218.790060] Subtest psr-primary-page-flip: SKIP (0.000s)
[218.919272] [040/133] (840s left) kms_flip (basic-flip-vs-modeset)
[219.128120] Starting subtest: basic-flip-vs-modeset
[219.132498] Starting dynamic subtest: A-HDMI-A1
[220.385109] Dynamic subtest A-HDMI-A1: SUCCESS (1.252s)
[220.407976] Starting dynamic subtest: B-HDMI-A1
[221.128959] Dynamic subtest B-HDMI-A1: SUCCESS (0.732s)
[221.153931] Starting dynamic subtest: C-HDMI-A1
[221.870122] Dynamic subtest C-HDMI-A1: SUCCESS (0.736s)
[221.896136] Starting dynamic subtest: A-HDMI-A2
[222.603869] Dynamic subtest A-HDMI-A2: SUCCESS (0.729s)
[222.642077] Starting dynamic subtest: B-HDMI-A2
[223.365948] Dynamic subtest B-HDMI-A2: SUCCESS (0.757s)
[223.392318] Starting dynamic subtest: C-HDMI-A2
[224.042139] Dynamic subtest C-HDMI-A2: SUCCESS (0.676s)
[224.047094] Subtest basic-flip-vs-modeset: SUCCESS (4.920s)
[224.463245] [041/133] (834s left) kms_properties (invalid-properties-legacy)
[224.671525] Starting subtest: invalid-properties-legacy
[224.836908] Subtest invalid-properties-legacy: SUCCESS (0.170s)
[225.022827] [042/133] (834s left) gem_ctx_engines (execute-oneforall)
[225.158796] Starting subtest: execute-oneforall
[225.769078] Subtest execute-oneforall: SUCCESS (0.601s)
[226.027353] [043/133] (833s left) gem_exec_flush (basic-wb-set-default)
[226.166053] Starting subtest: basic-wb-set-default
[231.581571] Subtest basic-wb-set-default: SUCCESS (5.418s)
[231.861950] [044/133] (827s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[232.081385] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[233.188862] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (1.108s)
[233.513375] [045/133] (826s left) perf_pmu (interrupts-sync)
[233.642294] Starting subtest: interrupts-sync
[234.764656] Subtest interrupts-sync: SUCCESS (1.122s)
[234.929675] [046/133] (824s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[235.145111] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[235.153079] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[235.317610] [047/133] (824s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[235.546087] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[237.356616] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.811s)
[237.629743] [048/133] (822s left) kms_chamelium_color (ctm-green-to-red)
[237.820860] Subtest ctm-green-to-red: SKIP (0.000s)
[237.939278] [049/133] (822s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[238.152634] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[238.270509] [050/133] (821s left) gem_softpin (allocator-fork)
[238.403061] Starting subtest: allocator-fork
[240.792167] Subtest allocator-fork: SUCCESS (2.391s)
[240.963440] [051/133] (819s left) gem_caching (reads)
[241.084311] Starting subtest: reads
[247.664516] Subtest reads: SUCCESS (6.575s)
[247.828826] [052/133] (812s left) kms_explicit_fence (multiplane-atomic-fence-wait)
[248.045794] Starting subtest: multiplane-atomic-fence-wait
[248.573261] Subtest multiplane-atomic-fence-wait: SUCCESS (0.529s)
[249.153100] [053/133] (811s left) gem_exec_params (no-bsd)
[249.292188] Starting subtest: no-bsd
[249.295933] Subtest no-bsd: SUCCESS (0.003s)
[249.450326] [054/133] (811s left) gem_userptr_blits (access-control)
[249.626948] Starting subtest: access-control
[249.634734] Subtest access-control: SKIP (0.000s)
[249.782188] [055/133] (810s left) gem_lmem_swapping (random)
[249.907890] Subtest random: SKIP (0.000s)
[250.028174] [056/133] (810s left) kms_addfb_basic (size-max)
[250.215318] Starting subtest: size-max
[250.219527] Subtest size-max: SUCCESS (0.000s)
[250.385419] [057/133] (810s left) kms_atomic (plane-invalid-params)
[250.582946] Starting subtest: plane-invalid-params
[250.585813] Starting dynamic subtest: pipe-A-HDMI-A-1
[251.170544] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.586s)
[251.173761] Subtest plane-invalid-params: SUCCESS (0.592s)
[251.506340] [058/133] (809s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[251.713235] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[251.718192] Starting dynamic subtest: pipe-A-HDMI-A-1
[251.871899] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.011s)
[251.918773] Starting dynamic subtest: pipe-A-HDMI-A-2
[252.041848] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.011s)
[252.066458] Starting dynamic subtest: pipe-B-HDMI-A-1
[252.187098] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.011s)
[252.211781] Starting dynamic subtest: pipe-B-HDMI-A-2
[252.387290] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.011s)
[252.434303] Starting dynamic subtest: pipe-C-HDMI-A-1
[252.557796] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.011s)
[252.582598] Starting dynamic subtest: pipe-C-HDMI-A-2
[252.716326] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.011s)
[252.722528] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.099s)
[252.844455] [059/133] (808s left) sw_sync (alloc_merge_fence)
[252.953463] Starting subtest: alloc_merge_fence
[252.957464] Subtest alloc_merge_fence: SUCCESS (0.001s)
[253.098459] [060/133] (808s left) gem_exec_parallel (contexts)
[253.231249] Starting subtest: contexts
[253.234520] Starting dynamic subtest: rcs0
[257.757788] Dynamic subtest rcs0: SUCCESS (4.527s)
[257.790740] Starting dynamic subtest: bcs0
[262.711100] Dynamic subtest bcs0: SUCCESS (4.949s)
[262.744801] Starting dynamic subtest: vcs0
[267.138706] Dynamic subtest vcs0: SUCCESS (4.423s)
[267.171453] Starting dynamic subtest: vecs0
[271.529679] Dynamic subtest vecs0: SUCCESS (4.387s)
[271.532945] Subtest contexts: SUCCESS (18.300s)
[271.838452] [061/133] (789s left) gem_exec_parallel (userptr)
[271.976298] Starting subtest: userptr
[271.980143] Starting dynamic subtest: rcs0
[275.245055] Dynamic subtest rcs0: SUCCESS (3.268s)
[275.272745] Starting dynamic subtest: bcs0
[278.694635] Dynamic subtest bcs0: SUCCESS (3.446s)
[278.722345] Starting dynamic subtest: vcs0
[281.970817] Dynamic subtest vcs0: SUCCESS (3.273s)
[282.004789] Starting dynamic subtest: vecs0
[285.606859] Dynamic subtest vecs0: SUCCESS (3.633s)
[285.611276] Subtest userptr: SUCCESS (13.633s)
[285.888509] [062/133] (775s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[286.110578] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[288.552765] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (2.446s)
[288.892516] [063/133] (772s left) kms_psr (pr-sprite-plane-onoff)
[289.089395] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[289.218165] [064/133] (772s left) kms_psr (fbc-psr-basic)
[289.430581] Subtest fbc-psr-basic: SKIP (0.000s)
[289.551988] [065/133] (772s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[289.674520] Starting subtest: write-cpu-read-wc-unflushed
[289.847723] Subtest write-cpu-read-wc-unflushed: SUCCESS (0.106s)
[290.318237] [066/133] (771s left) kms_plane_scaling (planes-downscale-factor-0-75)
[290.779386] Starting subtest: planes-downscale-factor-0-75
[290.846486] Starting dynamic subtest: pipe-A
[291.044429] Dynamic subtest pipe-A: SUCCESS (0.324s)
[291.142590] Starting dynamic subtest: pipe-B
[291.380029] Dynamic subtest pipe-B: SUCCESS (0.445s)
[291.434331] Starting dynamic subtest: pipe-C
[291.480146] Dynamic subtest pipe-C: SUCCESS (0.096s)
[291.483901] Subtest planes-downscale-factor-0-75: SUCCESS (0.877s)
[292.060672] [067/133] (770s left) kms_vblank (ts-continuation-dpms-suspend)
[292.266570] Starting subtest: ts-continuation-dpms-suspend
[292.269630] Starting dynamic subtest: pipe-A-HDMI-A-1