[158.601937] Initializing watchdogs
[158.602299]   /dev/watchdog0
[158.644545] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[158.659690] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[158.667307] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[158.674259] [001/133] (960s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[158.895658] Starting subtest: pipe-fbc-rte
[158.910884] Subtest pipe-fbc-rte: SKIP (0.001s)
[159.053293] [002/133] (960s left) gem_exec_schedule (timeslicing)
[159.202572] Starting subtest: timeslicing
[159.205532] Starting dynamic subtest: rcs0
[159.221251] Dynamic subtest rcs0: SUCCESS (0.014s)
[159.250415] Starting dynamic subtest: bcs0
[159.253272] Dynamic subtest bcs0: SUCCESS (0.011s)
[159.278186] Starting dynamic subtest: vcs0
[159.280889] Dynamic subtest vcs0: SUCCESS (0.011s)
[159.300762] Starting dynamic subtest: vecs0
[159.303685] Dynamic subtest vecs0: SUCCESS (0.015s)
[159.306538] Subtest timeslicing: SUCCESS (0.057s)
[159.658982] [003/133] (959s left) kms_cursor_edge_walk (256x256-top-bottom)
[159.850559] Starting subtest: 256x256-top-bottom
[159.855207] Starting dynamic subtest: pipe-A-HDMI-A-1
[163.830197] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.978s)
[163.874817] Starting dynamic subtest: pipe-C-HDMI-A-1
[167.269604] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.432s)
[167.273644] Subtest 256x256-top-bottom: SUCCESS (7.417s)
[167.596294] [004/133] (951s left) kms_cursor_crc (cursor-dpms)
[167.784152] Starting subtest: cursor-dpms
[167.786173] Starting dynamic subtest: pipe-A-HDMI-A-1
[169.589074] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.802s)
[169.614256] Starting dynamic subtest: pipe-C-HDMI-A-1
[171.065819] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.469s)
[171.068085] Subtest cursor-dpms: SUCCESS (3.284s)
[171.464265] [005/133] (948s left) kms_psr (fbc-pr-dpms)
[171.668733] Subtest fbc-pr-dpms: SKIP (0.000s)
[171.765890] [006/133] (947s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[171.954722] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[171.958132] Starting dynamic subtest: pipe-A-HDMI-A-1
[171.982592] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.003s)
[172.022280] Starting dynamic subtest: pipe-A-HDMI-A-2
[172.051366] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.003s)
[172.089308] Starting dynamic subtest: pipe-B-HDMI-A-1
[172.119393] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.003s)
[172.159497] Starting dynamic subtest: pipe-B-HDMI-A-2
[172.177680] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.004s)
[172.198321] Starting dynamic subtest: pipe-C-HDMI-A-1
[172.214037] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[172.234621] Starting dynamic subtest: pipe-C-HDMI-A-2
[172.249907] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.003s)
[172.253058] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.038s)
[173.132291] [007/133] (946s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[173.325860] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[173.331201] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[184.597814] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (11.264s)
[184.624234] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[195.646573] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (11.042s)
[195.672928] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[206.641444] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.981s)
[206.646641] Subtest 2x-wf_vblank-ts-check-interruptible: SUCCESS (33.308s)
[207.283258] [008/133] (912s left) syncobj_timeline (signal-point-0)
[207.393375] Starting subtest: signal-point-0
[207.396325] Subtest signal-point-0: SUCCESS (0.003s)
[207.537601] [009/133] (912s left) gem_exec_params (invalid-flag)
[207.653743] Starting subtest: invalid-flag
[207.655637] Subtest invalid-flag: SUCCESS (0.001s)
[207.831098] [010/133] (912s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[208.017906] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[208.022571] Starting dynamic subtest: pipe-A-valid-mode
[209.117401] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.096s)
[209.119099] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SUCCESS (1.101s)
[209.527338] [011/133] (910s left) gem_close_race (multigpu-basic-process)
[209.666412] Starting subtest: multigpu-basic-process
[209.671560] Subtest multigpu-basic-process: SKIP (0.000s)
[209.947243] [012/133] (910s left) kms_universal_plane (universal-plane-functional)
[210.125213] Starting subtest: universal-plane-functional
[210.129632] Starting dynamic subtest: pipe-A-HDMI-A-1
[212.765116] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.636s)
[212.804429] Starting dynamic subtest: pipe-B-HDMI-A-2
[215.043931] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.276s)
[215.078647] Starting dynamic subtest: pipe-C-HDMI-A-1
[217.313345] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.263s)
[217.317051] Subtest universal-plane-functional: SUCCESS (7.190s)
[217.654582] [013/133] (902s left) perf (per-context-mode-unprivileged)
[217.899183] Starting subtest: per-context-mode-unprivileged
[217.904116] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[218.017248] [014/133] (902s left) gem_set_tiling_vs_gtt
[218.557961] [015/133] (901s left) api_intel_allocator (simple-allocator)
[218.660487] Starting subtest: simple-allocator
[218.662829] Starting dynamic subtest: basic
[218.669326] Dynamic subtest basic: SUCCESS (0.010s)
[218.689347] Starting dynamic subtest: parallel-one
[219.084805] Dynamic subtest parallel-one: SUCCESS (0.414s)
[219.106855] Starting dynamic subtest: print
[219.108388] Dynamic subtest print: SUCCESS (0.000s)
[219.128845] Starting dynamic subtest: reuse
[219.132482] Dynamic subtest reuse: SUCCESS (0.000s)
[219.151851] Starting dynamic subtest: reserve
[219.155284] Dynamic subtest reserve: SUCCESS (0.000s)
[219.174795] Starting dynamic subtest: fork-reopen-allocator
[219.177394] Dynamic subtest fork-reopen-allocator: SUCCESS (0.038s)
[219.179470] Subtest simple-allocator: SUCCESS (0.473s)
[219.272463] [016/133] (901s left) gem_exec_parallel (contexts)
[219.396048] Starting subtest: contexts
[219.398306] Starting dynamic subtest: rcs0
[223.562187] Dynamic subtest rcs0: SUCCESS (4.163s)
[223.583543] Starting dynamic subtest: bcs0
[228.278647] Dynamic subtest bcs0: SUCCESS (4.715s)
[228.310811] Starting dynamic subtest: vcs0
[238.305741] Dynamic subtest vcs0: SUCCESS (10.028s)
[238.335069] Starting dynamic subtest: vecs0
[242.442595] Dynamic subtest vecs0: SUCCESS (4.132s)
[242.446278] Subtest contexts: SUCCESS (23.045s)
[242.694256] [017/133] (877s left) gem_tiled_swapping (non-threaded)
[266.059045] Starting subtest: non-threaded
[288.564550] Subtest non-threaded: SUCCESS (22.493s)
[291.929671] [018/133] (828s left) gen9_exec_parse (allowed-all)
[292.288464] Starting subtest: allowed-all
[292.292807] Subtest allowed-all: SUCCESS (0.005s)
[292.563137] [019/133] (828s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[292.779301] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[292.786279] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[293.611036] [020/133] (827s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[293.835438] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[293.840592] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[293.992995] [021/133] (826s left) gem_vm_create (execbuf)
[294.107793] Starting subtest: execbuf
[294.122044] Subtest execbuf: SUCCESS (0.012s)
[294.280493] [022/133] (826s left) gem_mmap_wc (read)
[294.391248] Starting subtest: read
[294.418461] Subtest read: SUCCESS (0.030s)
[294.561591] [023/133] (826s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[294.775230] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[294.780083] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[294.941124] [024/133] (826s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[295.195491] Subtest parallel-dmabuf-import-out-fence: SKIP (0.000s)
[295.347545] [025/133] (825s left) i915_power (sanity)
[295.450703] Starting subtest: sanity
[299.485277] Subtest sanity: SUCCESS (4.029s)
[299.630407] [026/133] (821s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[299.810153] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[299.812074] Starting dynamic subtest: pipe-A-HDMI-A-1
[299.831896] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.003s)
[299.890278] Starting dynamic subtest: pipe-A-HDMI-A-2
[299.935062] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.003s)
[299.967154] Starting dynamic subtest: pipe-B-HDMI-A-1
[299.983452] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.003s)
[300.011278] Starting dynamic subtest: pipe-B-HDMI-A-2
[300.027238] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.003s)
[300.053977] Starting dynamic subtest: pipe-C-HDMI-A-1
[300.069014] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[300.095667] Starting dynamic subtest: pipe-C-HDMI-A-2
[300.110685] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s)
[300.113776] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.033s)
[300.882416] [027/133] (820s left) kms_psr (pr-primary-page-flip)
[301.073617] Subtest pr-primary-page-flip: SKIP (0.000s)
[301.189192] [028/133] (820s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[301.325365] Starting subtest: etime-single-wait-available-unsubmitted
[301.430624] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.105s)
[301.581801] [029/133] (820s left) i915_drm_fdinfo (busy-hang)
[301.698906] Starting subtest: busy-hang
[301.702380] Starting dynamic subtest: rcs0
[302.742177] Dynamic subtest rcs0: SUCCESS (1.042s)
[302.775367] Starting dynamic subtest: bcs0
[303.793832] Dynamic subtest bcs0: SUCCESS (1.049s)
[303.830588] Starting dynamic subtest: vcs0
[304.833210] Dynamic subtest vcs0: SUCCESS (1.035s)
[304.863616] Starting dynamic subtest: vecs0
[305.871157] Dynamic subtest vecs0: SUCCESS (1.039s)
[305.873874] Subtest busy-hang: SUCCESS (4.174s)
[306.015776] [030/133] (815s left) gem_ctx_sseu (engines)
[306.140251] Subtest engines: SKIP (0.000s)
[306.254613] [031/133] (815s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[306.449261] Starting subtest: fbc-rgb565-draw-blt
[309.239365] Subtest fbc-rgb565-draw-blt: SUCCESS (2.788s)
[309.532912] [032/133] (812s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[309.738657] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[309.855216] [033/133] (812s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[310.062235] Starting subtest: psr-1p-primscrn-cur-indfb-move
[310.067283] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[310.214304] [034/133] (811s left) prime_busy (hang-wait)
[310.330330] Starting subtest: hang-wait
[310.332185] Starting dynamic subtest: rcs0
[316.656303] Dynamic subtest rcs0: SUCCESS (6.322s)
[316.684861] Starting dynamic subtest: bcs0
[323.628387] Dynamic subtest bcs0: SUCCESS (6.969s)
[323.655628] Starting dynamic subtest: vcs0
[330.668670] Dynamic subtest vcs0: SUCCESS (7.038s)
[330.697458] Starting dynamic subtest: vecs0
[337.641972] Dynamic subtest vecs0: SUCCESS (6.974s)
[337.643971] Subtest hang-wait: SUCCESS (27.313s)
[337.782729] [035/133] (784s left) syncobj_wait (invalid-reset-zero-handles)
[337.903210] Starting subtest: invalid-reset-zero-handles
[337.907544] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[338.051779] [036/133] (784s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[338.263687] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[338.268258] Subtest psr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[338.413360] [037/133] (784s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[338.611524] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[340.730239] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SUCCESS (2.116s)
[340.930540] [038/133] (781s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[341.058851] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[341.063390] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[341.322235] [039/133] (781s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[341.449175] Starting subtest: invalid-bsd2-flag-on-blt
[341.451707] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.001s)
[341.602282] [040/133] (781s left) gem_userptr_blits (readonly-unsync)
[341.723347] Subtest readonly-unsync: SKIP (0.000s)
[341.916908] [041/133] (780s left) drm_read (empty-nonblock)
[342.397413] Starting subtest: empty-nonblock
[342.399265] Subtest empty-nonblock: SUCCESS (0.000s)
[342.700531] [042/133] (780s left) kms_chamelium_frames (hdmi-aspect-ratio)
[343.266137] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[343.561354] [043/133] (779s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[343.756083] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[343.758068] Starting dynamic subtest: pipe-A
[344.649121] Dynamic subtest pipe-A: SUCCESS (0.892s)
[344.680137] Starting dynamic subtest: pipe-B
[345.557173] Dynamic subtest pipe-B: SUCCESS (0.907s)
[345.588605] Starting dynamic subtest: pipe-C
[346.474868] Dynamic subtest pipe-C: SUCCESS (0.914s)
[346.479679] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (2.718s)
[347.089361] [044/133] (776s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[347.286865] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[347.292058] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[347.445956] [045/133] (775s left) kms_getfb (getfb-handle-not-fb)
[347.645207] Starting subtest: getfb-handle-not-fb
[347.648602] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[347.801400] [046/133] (775s left) gem_exec_balancer (bonded-true-hang)
[348.045746] Starting subtest: bonded-true-hang
[352.318837] Subtest bonded-true-hang: SUCCESS (4.273s)
[352.484864] [047/133] (770s left) gem_mmap_wc (bad-object)
[352.589154] Starting subtest: bad-object
[352.590894] Subtest bad-object: SUCCESS (0.001s)
[352.763723] [048/133] (770s left) gem_partial_pwrite_pread (reads-display)
[352.911149] Starting subtest: reads-display
[359.499784] Subtest reads-display: SUCCESS (6.593s)
[359.651094] [049/133] (763s left) kms_tv_load_detect (load-detect)
[359.759976] Subtest load-detect: SKIP (0.000s)
[359.877180] [050/133] (763s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[360.064330] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[360.068806] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[360.219603] [051/133] (763s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[360.419766] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[362.858945] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (2.443s)
[363.162727] [052/133] (760s left) gem_softpin (allocator-nopin-reserve)
[363.282908] Starting subtest: allocator-nopin-reserve
[363.517249] Subtest allocator-nopin-reserve: SUCCESS (0.230s)
[363.682344] [053/133] (760s left) kms_lease (lease-invalid-connector)
[363.878228] Starting subtest: lease-invalid-connector
[363.889556] Starting dynamic subtest: pipe-A-HDMI-A-1
[363.892298] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.000s)
[363.942124] Starting dynamic subtest: pipe-A-HDMI-A-2
[363.944074] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.000s)
[363.977595] Starting dynamic subtest: pipe-B-HDMI-A-1
[363.979156] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[364.014092] Starting dynamic subtest: pipe-B-HDMI-A-2
[364.015707] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.000s)
[364.043896] Starting dynamic subtest: pipe-C-HDMI-A-1
[364.045526] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.000s)
[364.072466] Starting dynamic subtest: pipe-C-HDMI-A-2
[364.075349] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.000s)
[364.078395] Subtest lease-invalid-connector: SUCCESS (0.041s)
[364.165866] [054/133] (759s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[364.365192] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[364.369058] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[364.519851] [055/133] (759s left) gem_exec_params (no-vebox)
[364.636086] Starting subtest: no-vebox
[364.639392] Subtest no-vebox: SUCCESS (0.002s)
[364.813873] [056/133] (759s left) gem_eio (in-flight-contexts-10ms)
[364.966285] Starting subtest: in-flight-contexts-10ms
[376.987408] Subtest in-flight-contexts-10ms: SUCCESS (12.016s)
[377.239927] [057/133] (747s left) kms_vblank (ts-continuation-dpms-suspend)
[377.427115] Starting subtest: ts-continuation-dpms-suspend
[377.429122] Starting dynamic subtest: pipe-A-HDMI-A-1
[395.515761] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.032s)
[395.613917] Starting dynamic subtest: pipe-A-HDMI-A-2