[91.291595] Initializing watchdogs
[91.291767]   /dev/watchdog0
[91.331307] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[91.346420] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[91.352897] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[91.361383] [001/133] (960s left) gem_userptr_blits (mmap-offset-banned)
[91.522384] Starting subtest: mmap-offset-banned
[91.527291] Starting dynamic subtest: gtt
[91.535064] Dynamic subtest gtt: SUCCESS (0.001s)
[91.557658] Starting dynamic subtest: wb
[91.562417] Dynamic subtest wb: SUCCESS (0.001s)
[91.581401] Starting dynamic subtest: wc
[91.585477] Dynamic subtest wc: SUCCESS (0.000s)
[91.605579] Starting dynamic subtest: uc
[91.609474] Dynamic subtest uc: SUCCESS (0.000s)
[91.614742] Subtest mmap-offset-banned: SUCCESS (0.005s)
[91.716842] [002/133] (960s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[91.827689] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[91.831016] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.002s)
[91.969296] [003/133] (960s left) prime_busy (before-wait)
[92.084070] Starting subtest: before-wait
[92.102919] Starting dynamic subtest: rcs0
[92.112332] Dynamic subtest rcs0: SUCCESS (0.012s)
[92.133548] Starting dynamic subtest: bcs0
[92.139085] Dynamic subtest bcs0: SUCCESS (0.017s)
[92.159723] Starting dynamic subtest: vcs0
[92.163910] Dynamic subtest vcs0: SUCCESS (0.016s)
[92.182307] Starting dynamic subtest: vecs0
[92.186563] Dynamic subtest vecs0: SUCCESS (0.014s)
[92.274990] Subtest before-wait: SUCCESS (0.189s)
[92.436867] [004/133] (959s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[92.693298] Starting subtest: yf-tiled-8bpp-rotate-0
[92.701976] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[92.837683] [005/133] (959s left) kms_busy (basic)
[93.035198] Starting subtest: basic
[93.041054] Starting dynamic subtest: flip
[94.121670] Dynamic subtest flip: SUCCESS (1.077s)
[94.148091] Starting dynamic subtest: modeset
[95.557140] Dynamic subtest modeset: SUCCESS (1.437s)
[95.561983] Subtest basic: SUCCESS (2.520s)
[95.958935] [006/133] (956s left) gen3_render_linear_blits
[96.183757] [007/133] (956s left) gem_ppgtt (blt-vs-render-ctxn)
[96.297024] Starting subtest: blt-vs-render-ctxN
[129.422343] Subtest blt-vs-render-ctxN: SUCCESS (33.121s)
[129.580063] [008/133] (922s left) kms_frontbuffer_tracking (psr-suspend)
[129.925460] Starting subtest: psr-suspend
[129.934992] Subtest psr-suspend: SKIP (0.000s)
[130.073269] [009/133] (922s left) syncobj_wait (wait-all-for-submit-complex)
[130.202671] Starting subtest: wait-all-for-submit-complex
[130.433469] Subtest wait-all-for-submit-complex: SUCCESS (0.228s)
[130.571476] [010/133] (922s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[132.532550] Starting subtest: modeset-lpsp-stress-no-wait
[132.637356] Subtest modeset-lpsp-stress-no-wait: SKIP (0.099s)
[132.942566] [011/133] (919s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[133.135876] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[133.143151] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SKIP (0.000s)
[133.279398] [012/133] (919s left) kms_psr (fbc-psr-sprite-plane-onoff)
[133.475071] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.000s)
[133.572094] [013/133] (919s left) perf_pmu (event-wait)
[133.693780] Starting subtest: event-wait
[133.697845] Starting dynamic subtest: rcs0
[133.707136] Dynamic subtest rcs0: SKIP (0.000s)
[133.716277] Subtest event-wait: SKIP (0.001s)
[133.842675] [014/133] (919s left) sw_sync (sync_busy_fork_unixsocket)
[133.957074] Starting subtest: sync_busy_fork_unixsocket
[133.980144] Subtest sync_busy_fork_unixsocket: SUCCESS (0.029s)
[134.092456] [015/133] (919s left) kms_psr (fbc-pr-no-drrs)
[134.277220] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[134.386255] [016/133] (918s left) gem_exec_whisper (basic-contexts-priority-all)
[134.521759] Starting subtest: basic-contexts-priority-all
[147.296592] Subtest basic-contexts-priority-all: SUCCESS (12.772s)
[147.549290] [017/133] (905s left) gem_exec_balancer (parallel-balancer)
[147.799218] Subtest parallel-balancer: SKIP (0.000s)
[147.949957] [018/133] (905s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[148.153805] Starting subtest: 4-tiled-32bpp-rotate-0
[148.160418] Subtest 4-tiled-32bpp-rotate-0: SKIP (0.000s)
[148.298695] [019/133] (905s left) gem_tiled_swapping (non-threaded)
[169.762380] Starting subtest: non-threaded
[189.324103] Subtest non-threaded: SUCCESS (19.545s)
[194.358174] [020/133] (859s left) api_intel_bb (blit-reloc-keep-cache)
[194.666949] Starting subtest: blit-reloc-keep-cache
[194.692279] Subtest blit-reloc-keep-cache: SUCCESS (0.028s)
[194.883275] [021/133] (859s left) syncobj_timeline (transfer-timeline-point)
[195.022472] Starting subtest: transfer-timeline-point
[195.026129] Subtest transfer-timeline-point: SUCCESS (0.002s)
[195.169256] [022/133] (859s left) gem_mmap_offset (mmap-unmap)
[195.282056] Starting subtest: mmap-unmap
[195.288035] Starting dynamic subtest: smem0
[284.675487] Dynamic subtest smem0: SUCCESS (89.398s)
[284.681085] Subtest mmap-unmap: SUCCESS (89.401s)
[284.835350] [023/133] (769s left) gem_mmap_gtt (basic-read-write-distinct)
[284.946372] Starting subtest: basic-read-write-distinct
[284.955161] Subtest basic-read-write-distinct: SUCCESS (0.011s)
[285.100898] [024/133] (769s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[285.363263] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[285.379379] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.003s)
[285.520590] [025/133] (769s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[285.729962] Starting subtest: psr-rgb565-draw-mmap-cpu
[285.736368] Subtest psr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[285.882372] [026/133] (768s left) gem_ctx_engines (invalid-engines)
[286.022441] Starting subtest: invalid-engines
[286.037172] Subtest invalid-engines: SUCCESS (0.018s)
[286.287237] [027/133] (768s left) gem_exec_reloc (basic-write-cpu-active)
[286.412037] Starting subtest: basic-write-cpu-active
[286.551270] Subtest basic-write-cpu-active: SUCCESS (0.138s)
[286.770929] [028/133] (768s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[286.946082] Starting subtest: random-ccs-data-yf-tiled-ccs
[286.951219] Starting dynamic subtest: pipe-A-HDMI-A-1
[287.394057] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.428s)
[287.419810] Starting dynamic subtest: pipe-A-HDMI-A-2
[287.811025] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.407s)
[287.837458] Starting dynamic subtest: pipe-B-HDMI-A-1
[288.281605] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.471s)
[288.307461] Starting dynamic subtest: pipe-B-HDMI-A-2
[288.688146] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.392s)
[288.738309] Starting dynamic subtest: pipe-C-HDMI-A-1
[288.781791] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[288.811908] Starting dynamic subtest: pipe-C-HDMI-A-2
[288.846368] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[288.849548] Subtest random-ccs-data-yf-tiled-ccs: SUCCESS (1.720s)
[289.436970] [029/133] (765s left) kms_atomic (plane-invalid-params-fence)
[289.640548] Starting subtest: plane-invalid-params-fence
[289.644595] Starting dynamic subtest: pipe-A-HDMI-A-1
[290.212545] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.575s)
[290.216723] Subtest plane-invalid-params-fence: SUCCESS (0.579s)
[290.536530] [030/133] (764s left) kms_universal_plane (cursor-fb-leak)
[290.728924] Starting subtest: cursor-fb-leak
[290.733235] Starting dynamic subtest: pipe-A-HDMI-A-1
[291.353033] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.627s)
[291.386173] Starting dynamic subtest: pipe-B-HDMI-A-2
[291.936432] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.580s)
[291.976301] Starting dynamic subtest: pipe-C-HDMI-A-1
[292.501312] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.556s)
[292.506356] Subtest cursor-fb-leak: SUCCESS (1.778s)
[293.008894] [031/133] (762s left) kms_content_protection (content-type-change)
[293.216551] Starting subtest: content-type-change
[293.235171] Subtest content-type-change: SKIP (0.013s)
[293.390442] [032/133] (761s left) gem_sync (basic-store-each)
[293.537420] Starting subtest: basic-store-each
[295.971586] Subtest basic-store-each: SUCCESS (2.442s)
[296.268256] [033/133] (759s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[297.045389] Starting subtest: syncobj-backward-timeline-chain-engines
[297.163443] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.119s)
[297.444542] [FACT gem_exec_fence (syncobj-backward-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[297.452347] [034/133] (758s left) kms_plane_multiple (tiling-y)
[297.642389] Starting subtest: tiling-y
[297.648552] Starting dynamic subtest: pipe-A-HDMI-A-1
[299.613560] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.968s)
[299.647099] Starting dynamic subtest: pipe-A-HDMI-A-2
[301.524817] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.911s)
[301.554559] Starting dynamic subtest: pipe-B-HDMI-A-1
[303.414119] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.884s)
[303.442866] Starting dynamic subtest: pipe-B-HDMI-A-2
[305.239391] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.820s)
[305.284264] Starting dynamic subtest: pipe-C-HDMI-A-1
[307.099515] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.857s)
[307.139976] Starting dynamic subtest: pipe-C-HDMI-A-2
[308.891321] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.784s)
[308.902196] Subtest tiling-y: SUCCESS (11.252s)
[309.281804] [035/133] (746s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[309.619128] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[309.626724] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[309.816703] [036/133] (746s left) kms_3d (basic)
[309.948331] Starting subtest: basic
[314.862074] Subtest basic: SUCCESS (4.919s)
[315.378085] [037/133] (740s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[315.964072] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[316.260717] [038/133] (739s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[316.483940] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[316.491715] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[316.650808] [039/133] (739s left) gem_exec_reloc (basic-wc-cpu-active)
[316.773119] Starting subtest: basic-wc-cpu-active
[316.915091] Subtest basic-wc-cpu-active: SUCCESS (0.138s)
[317.168717] [040/133] (739s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[317.354061] Starting subtest: cursorB-vs-flipA-atomic
[328.751212] Subtest cursorB-vs-flipA-atomic: SUCCESS (11.395s)
[329.129787] [041/133] (727s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[329.321085] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[329.325057] Starting dynamic subtest: pipe-A-valid-mode
[330.347127] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.019s)
[330.353191] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (1.025s)
[330.735208] [042/133] (725s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[330.944082] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[330.950769] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[331.099108] [043/133] (725s left) kms_vrr (flip-suspend)
[331.295950] Starting subtest: flip-suspend
[331.311656] Subtest flip-suspend: SKIP (0.000s)
[331.452292] [044/133] (725s left) syncobj_timeline (invalid-query-zero-handles)
[331.568273] Starting subtest: invalid-query-zero-handles
[331.571942] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[331.730708] [045/133] (725s left) gem_ctx_freq (sysfs)
[331.862416] Starting subtest: sysfs
[331.866597] Starting dynamic subtest: gt0
[336.757646] Dynamic subtest gt0: SUCCESS (4.899s)
[336.761793] Subtest sysfs: SUCCESS (4.902s)
[336.932761] [046/133] (720s left) syncobj_wait (single-wait-all-signaled)
[337.049268] Starting subtest: single-wait-all-signaled
[337.052482] Subtest single-wait-all-signaled: SUCCESS (0.001s)
[337.196473] [047/133] (719s left) kms_plane (pixel-format-y-tiled-modifier)
[337.389062] Starting subtest: pixel-format-y-tiled-modifier
[337.588716] Starting dynamic subtest: pipe-A-plane-0
[338.409129] Dynamic subtest pipe-A-plane-0: SUCCESS (0.819s)
[338.437654] Starting dynamic subtest: pipe-A-plane-1
[339.207112] Dynamic subtest pipe-A-plane-1: SUCCESS (0.794s)
[339.234440] Starting dynamic subtest: pipe-A-plane-2
[339.773618] Dynamic subtest pipe-A-plane-2: SUCCESS (0.564s)
[339.801400] Starting dynamic subtest: pipe-A-plane-3
[340.339344] Dynamic subtest pipe-A-plane-3: SUCCESS (0.564s)
[340.386405] Starting dynamic subtest: pipe-A-plane-4
[340.396312] Dynamic subtest pipe-A-plane-4: SKIP (0.000s)
[340.747597] Starting dynamic subtest: pipe-B-plane-0
[341.468963] Dynamic subtest pipe-B-plane-0: SUCCESS (0.748s)
[341.497568] Starting dynamic subtest: pipe-B-plane-1
[342.267341] Dynamic subtest pipe-B-plane-1: SUCCESS (0.798s)
[342.300356] Starting dynamic subtest: pipe-B-plane-2
[342.839073] Dynamic subtest pipe-B-plane-2: SUCCESS (0.561s)
[342.867025] Starting dynamic subtest: pipe-B-plane-3
[343.410344] Dynamic subtest pipe-B-plane-3: SUCCESS (0.564s)
[343.455826] Starting dynamic subtest: pipe-B-plane-4
[343.462371] Dynamic subtest pipe-B-plane-4: SKIP (0.000s)
[343.609749] Subtest pixel-format-y-tiled-modifier: SUCCESS (6.222s)
[343.928705] [048/133] (713s left) syncobj_timeline (wait-any-snapshot)
[344.099433] Starting subtest: wait-any-snapshot
[344.184066] Subtest wait-any-snapshot: SUCCESS (0.086s)
[344.338353] [049/133] (712s left) kms_color (ctm-negative)
[344.532777] Starting subtest: ctm-negative
[344.536136] Starting dynamic subtest: pipe-A-HDMI-A-1
[345.508525] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.976s)
[345.541155] Starting dynamic subtest: pipe-A-HDMI-A-2
[346.230517] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.716s)
[346.287074] Starting dynamic subtest: pipe-B-HDMI-A-1
[346.893398] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.658s)
[346.945321] Starting dynamic subtest: pipe-B-HDMI-A-2
[347.561192] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.663s)
[347.595314] Starting dynamic subtest: pipe-C-HDMI-A-1
[348.243720] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.681s)
[348.299111] Starting dynamic subtest: pipe-C-HDMI-A-2
[348.903807] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.655s)
[348.910046] Subtest ctm-negative: SUCCESS (4.375s)
[349.220867] [050/133] (708s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[349.442319] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[349.449813] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[349.603953] [051/133] (707s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[349.794103] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[349.931756] [052/133] (707s left) core_setmaster_vs_auth
[350.248308] [053/133] (707s left) kms_flip (flip-vs-expired-vblank)
[350.438100] Starting subtest: flip-vs-expired-vblank
[350.442052] Starting dynamic subtest: A-HDMI-A1
[356.107960] Dynamic subtest A-HDMI-A1: SUCCESS (5.670s)
[356.136618] Starting dynamic subtest: B-HDMI-A1
[360.123338] Dynamic subtest B-HDMI-A1: FAIL (3.627s)
[360.150163] Starting dynamic subtest: C-HDMI-A1
[365.106570] Dynamic subtest C-HDMI-A1: SUCCESS (5.365s)
[365.138466] Starting dynamic subtest: A-HDMI-A2
[370.549321] Dynamic subtest A-HDMI-A2: SUCCESS (5.438s)
[370.582548] Starting dynamic subtest: B-HDMI-A2
[375.947195] Dynamic subtest B-HDMI-A2: SUCCESS (5.389s)
[375.975738] Starting dynamic subtest: C-HDMI-A2
[381.357299] Dynamic subtest C-HDMI-A2: SUCCESS (5.402s)
[381.366061] Subtest flip-vs-expired-vblank: FAIL (30.924s)
[381.891493] [054/133] (676s left) kms_vblank (ts-continuation-dpms-suspend)
[382.083989] Starting subtest: ts-continuation-dpms-suspend
[382.087370] Starting dynamic subtest: pipe-A-HDMI-A-1
[399.869008] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.034s)
[399.986326] Starting dynamic subtest: pipe-A-HDMI-A-2