[89.933611] Initializing watchdogs
[89.933829]   /dev/watchdog0
[89.973313] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3184 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 605]
[89.987643] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[89.993802] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[89.999044] [001/133] (960s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[90.188971] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[90.282502] [002/133] (960s left) kms_prime (basic-crc-vgem)
[90.521157] Starting subtest: basic-crc-vgem
[90.524106] Starting dynamic subtest: second-to-first
[92.301127] Dynamic subtest second-to-first: SUCCESS (1.785s)
[92.302138] Subtest basic-crc-vgem: SUCCESS (1.786s)
[92.560294] [FACT kms_prime (basic-crc-vgem)] new: kernel.kmod_is_loaded.vgem: true
[92.563885] [003/133] (958s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[92.748275] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[92.750085] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[92.899742] [004/133] (957s left) i915_drm_fdinfo (most-busy-check-all)
[93.006673] Starting subtest: most-busy-check-all
[93.007669] Starting dynamic subtest: rcs0
[93.550741] Dynamic subtest rcs0: SUCCESS (0.543s)
[93.567519] Starting dynamic subtest: bcs0
[94.085225] Dynamic subtest bcs0: SUCCESS (0.534s)
[94.101772] Starting dynamic subtest: vcs0
[94.623757] Dynamic subtest vcs0: SUCCESS (0.537s)
[94.642483] Starting dynamic subtest: vecs0
[95.155824] Dynamic subtest vecs0: SUCCESS (0.532s)
[95.156888] Subtest most-busy-check-all: SUCCESS (2.149s)
[95.284794] [005/133] (955s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[95.470929] Starting subtest: fbc-shrfb-scaledprimary
[99.100493] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.629s)
[99.382297] [006/133] (951s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[99.478466] Starting subtest: single-wait-for-submit-unsubmitted
[99.585881] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[99.716498] [007/133] (951s left) gem_mmap_gtt (hang-busy)
[99.809103] Starting subtest: hang-busy
[115.100893] Subtest hang-busy: SUCCESS (15.288s)
[115.251578] [008/133] (935s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[115.431889] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[115.433710] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[115.584980] [009/133] (935s left) perf_pmu (idle)
[115.688818] Starting subtest: idle
[115.689895] Starting dynamic subtest: rcs0
[116.215682] Dynamic subtest rcs0: SUCCESS (0.525s)
[116.232409] Starting dynamic subtest: bcs0
[116.729173] Dynamic subtest bcs0: SUCCESS (0.514s)
[116.745971] Starting dynamic subtest: vcs0
[117.243894] Dynamic subtest vcs0: SUCCESS (0.513s)
[117.261400] Starting dynamic subtest: vecs0
[117.764159] Dynamic subtest vecs0: SUCCESS (0.519s)
[117.765546] Subtest idle: SUCCESS (2.075s)
[117.902701] [010/133] (933s left) gem_mmap_gtt (bad-object)
[117.999377] Starting subtest: bad-object
[118.000369] Subtest bad-object: SUCCESS (0.000s)
[118.157823] [011/133] (933s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[118.259726] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[118.261846] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.002s)
[118.387903] [012/133] (933s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[118.586330] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[118.803718] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.217s)
[119.035541] [013/133] (932s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[119.216737] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[119.219137] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[119.369817] [014/133] (932s left) i915_drm_fdinfo (virtual-busy-idle)
[119.473138] Starting subtest: virtual-busy-idle
[122.078713] Subtest virtual-busy-idle: SUCCESS (2.605s)
[122.205200] [015/133] (929s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[122.304467] Starting subtest: multi-wait-for-submit-submitted-signaled
[122.305388] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[122.435632] [016/133] (929s left) gem_ctx_persistence (engines-mixed)
[122.538262] Starting subtest: engines-mixed
[122.539339] Starting dynamic subtest: rcs0
[122.601733] Dynamic subtest rcs0: SUCCESS (0.063s)
[122.619840] Starting dynamic subtest: bcs0
[122.653908] Dynamic subtest bcs0: SUCCESS (0.050s)
[122.673116] Starting dynamic subtest: vcs0
[122.707034] Dynamic subtest vcs0: SUCCESS (0.052s)
[122.725667] Starting dynamic subtest: vecs0
[122.764984] Dynamic subtest vecs0: SUCCESS (0.056s)
[122.766698] Subtest engines-mixed: SUCCESS (0.227s)
[122.907229] [017/133] (928s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[123.091705] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[123.093445] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[123.237910] [018/133] (928s left) gem_tiled_partial_pwrite_pread (writes)
[123.344774] Starting subtest: writes
[125.223569] Subtest writes: SUCCESS (1.879s)
[125.389083] [019/133] (926s left) syncobj_timeline (invalid-signal-zero-handles)
[125.485656] Starting subtest: invalid-signal-zero-handles
[125.486645] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[125.620847] [020/133] (926s left) kms_flip (2x-flip-vs-wf_vblank)
[125.788706] Starting subtest: 2x-flip-vs-wf_vblank
[125.792424] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[127.490596] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (1.698s)
[127.510488] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[129.110290] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (1.614s)
[129.128239] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[130.715037] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (1.596s)
[130.716142] Subtest 2x-flip-vs-wf_vblank: SUCCESS (4.920s)
[131.280466] [021/133] (920s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[131.388846] Starting subtest: rel-constants-invalid-rel-gen5
[131.389899] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.001s)
[131.571532] [022/133] (920s left) kms_flip (flip-vs-rmfb)
[131.739848] Starting subtest: flip-vs-rmfb
[131.740913] Starting dynamic subtest: A-HDMI-A1
[137.326887] Dynamic subtest A-HDMI-A1: SUCCESS (5.585s)
[137.347253] Starting dynamic subtest: B-HDMI-A1
[142.687994] Dynamic subtest B-HDMI-A1: SUCCESS (5.358s)
[142.707386] Starting dynamic subtest: C-HDMI-A1
[148.053763] Dynamic subtest C-HDMI-A1: SUCCESS (5.363s)
[148.074254] Starting dynamic subtest: A-HDMI-A2
[153.414197] Dynamic subtest A-HDMI-A2: SUCCESS (5.356s)
[153.432032] Starting dynamic subtest: B-HDMI-A2
[158.773962] Dynamic subtest B-HDMI-A2: SUCCESS (5.357s)
[158.795326] Starting dynamic subtest: C-HDMI-A2
[164.134847] Dynamic subtest C-HDMI-A2: SUCCESS (5.356s)
[164.136629] Subtest flip-vs-rmfb: SUCCESS (32.396s)
[164.602428] [023/133] (887s left) gem_exec_schedule (implicit-boths)
[164.725207] Starting subtest: implicit-boths
[164.726288] Starting dynamic subtest: rcs0
[164.853104] Dynamic subtest rcs0: SUCCESS (0.123s)
[164.873476] Starting dynamic subtest: bcs0
[164.978296] Dynamic subtest bcs0: SUCCESS (0.125s)
[165.004097] Starting dynamic subtest: vcs0
[165.097101] Dynamic subtest vcs0: SUCCESS (0.115s)
[165.120091] Starting dynamic subtest: vecs0
[165.209076] Dynamic subtest vecs0: SUCCESS (0.110s)
[165.211768] Subtest implicit-boths: SUCCESS (0.482s)
[165.602583] [024/133] (886s left) kms_dirtyfb (default-dirtyfb-ioctl)
[165.772564] Starting subtest: default-dirtyfb-ioctl
[165.773512] Starting dynamic subtest: A-HDMI-A-1
[167.464798] Dynamic subtest A-HDMI-A-1: SUCCESS (1.689s)
[167.483460] Starting dynamic subtest: A-HDMI-A-2
[169.042821] Dynamic subtest A-HDMI-A-2: SUCCESS (1.576s)
[169.044115] Subtest default-dirtyfb-ioctl: SUCCESS (3.272s)
[169.316918] [025/133] (883s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[169.501698] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[171.029764] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.527s)
[171.301479] [026/133] (881s left) gem_pipe_control_store_loop (reused-buffer)
[171.412481] Starting subtest: reused-buffer
[173.565420] Subtest reused-buffer: SUCCESS (2.156s)
[173.718435] [027/133] (879s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[173.908588] Starting subtest: 4-tiled-addfb-size-offset-overflow
[173.912067] Subtest 4-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[174.052314] [028/133] (878s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[174.219632] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[174.220677] Starting dynamic subtest: pipe-A
[175.295378] Dynamic subtest pipe-A: SUCCESS (1.077s)
[175.316540] Starting dynamic subtest: pipe-B
[176.360325] Dynamic subtest pipe-B: SUCCESS (1.060s)
[176.379698] Starting dynamic subtest: pipe-C
[177.423359] Dynamic subtest pipe-C: SUCCESS (1.062s)
[177.426364] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (3.207s)
[177.936248] [029/133] (874s left) gem_mmap_gtt (basic-read)
[178.034813] Starting subtest: basic-read
[178.106168] Subtest basic-read: SUCCESS (0.069s)
[178.299225] [030/133] (874s left) vgem_basic (unload)
[178.392104] Starting subtest: unload
[207.421085] Subtest unload: SUCCESS (29.029s)
[207.607969] [031/133] (845s left) kms_psr2_su (page_flip-xrgb8888)
[207.704365] Subtest page_flip-XRGB8888: SKIP (0.000s)
[207.812977] [032/133] (845s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[207.981212] Starting subtest: cursor-vs-flip-varying-size
[252.789106] Subtest cursor-vs-flip-varying-size: SUCCESS (44.806s)
[253.090946] [033/133] (800s left) kms_cursor_crc (cursor-offscreen-max-size)
[253.281554] Starting subtest: cursor-offscreen-max-size
[253.284585] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[253.441602] [034/133] (799s left) kms_feature_discovery (dp-mst)
[253.612181] Starting subtest: dp-mst
[253.614363] Subtest dp-mst: SKIP (0.001s)
[253.755242] [035/133] (799s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[253.939987] Starting subtest: fbcpsr-tiling-4
[253.941931] Subtest fbcpsr-tiling-4: SKIP (0.000s)
[254.092219] [036/133] (799s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[254.264379] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[254.488340] Starting dynamic subtest: pipe-A-plane-0
[254.788371] Dynamic subtest pipe-A-plane-0: SUCCESS (0.299s)
[254.809139] Starting dynamic subtest: pipe-A-plane-1
[255.072083] Dynamic subtest pipe-A-plane-1: SUCCESS (0.280s)
[255.093862] Starting dynamic subtest: pipe-A-plane-2
[255.338204] Dynamic subtest pipe-A-plane-2: SUCCESS (0.263s)
[255.358970] Starting dynamic subtest: pipe-A-plane-3
[255.606497] Dynamic subtest pipe-A-plane-3: SUCCESS (0.264s)
[255.958638] Starting dynamic subtest: pipe-B-plane-0
[256.208988] Dynamic subtest pipe-B-plane-0: SUCCESS (0.266s)
[256.230647] Starting dynamic subtest: pipe-B-plane-1
[256.475377] Dynamic subtest pipe-B-plane-1: SUCCESS (0.263s)
[256.496976] Starting dynamic subtest: pipe-B-plane-2
[256.741530] Dynamic subtest pipe-B-plane-2: SUCCESS (0.263s)
[256.762664] Starting dynamic subtest: pipe-B-plane-3
[257.007435] Dynamic subtest pipe-B-plane-3: SUCCESS (0.263s)
[257.213353] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SUCCESS (2.944s)
[257.507743] [037/133] (796s left) syncobj_eventfd (timeline-wait-signaled)
[257.612150] Starting subtest: timeline-wait-signaled
[257.613698] Subtest timeline-wait-signaled: SUCCESS (0.001s)
[257.741879] [038/133] (796s left) kms_chamelium_color (ctm-red-to-blue)
[257.915521] Subtest ctm-red-to-blue: SKIP (0.000s)
[258.016460] [039/133] (795s left) gem_exec_reloc (basic-write-cpu)
[258.125579] Starting subtest: basic-write-cpu
[258.143492] Subtest basic-write-cpu: SUCCESS (0.017s)
[258.358106] [040/133] (795s left) kms_pm_backlight (fade)
[258.530700] Subtest fade: SKIP (0.000s)
[258.634132] [041/133] (795s left) vgem_basic (sysfs)
[258.741602] Starting subtest: sysfs
[258.743523] Subtest sysfs: SUCCESS (0.001s)
[258.858324] [042/133] (795s left) dumb_buffer (invalid-bpp)
[258.959292] Starting subtest: invalid-bpp
[258.960532] Subtest invalid-bpp: SUCCESS (0.000s)
[259.089240] [043/133] (795s left) kms_plane_lowres (tiling-4)
[259.257304] Starting subtest: tiling-4
[259.259065] Subtest tiling-4: SKIP (0.000s)
[259.389919] [044/133] (794s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[259.558697] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[259.559737] Starting dynamic subtest: pipe-A-HDMI-A-1
[260.384144] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.816s)
[260.405571] Starting dynamic subtest: pipe-A-HDMI-A-2
[261.217147] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.828s)
[261.239842] Starting dynamic subtest: pipe-B-HDMI-A-1
[262.092912] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.872s)
[262.112257] Starting dynamic subtest: pipe-B-HDMI-A-2
[262.903308] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.805s)
[262.921729] Starting dynamic subtest: pipe-C-HDMI-A-1
[262.957315] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.010s)
[262.977445] Starting dynamic subtest: pipe-C-HDMI-A-2
[263.013662] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.011s)
[263.014594] Subtest crc-sprite-planes-basic-y-tiled-ccs: SUCCESS (3.370s)
[263.662842] [045/133] (790s left) kms_psr (psr-cursor-mmap-cpu)
[263.843204] Subtest psr-cursor-mmap-cpu: SKIP (0.000s)
[263.942148] [046/133] (790s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[264.110493] Starting subtest: nonblocking-crc-frame-sequence
[264.111541] Starting dynamic subtest: pipe-A-HDMI-A-1
[265.145976] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.032s)
[265.167669] Starting dynamic subtest: pipe-B-HDMI-A-2
[265.856946] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.708s)
[265.881859] Starting dynamic subtest: pipe-C-HDMI-A-1
[266.579866] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.715s)
[266.580857] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.471s)
[266.849422] [047/133] (787s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[267.019124] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[267.122774] [048/133] (787s left) kms_content_protection (dp-mst-type-0-hdcp14)
[267.317975] Starting subtest: dp-mst-type-0-hdcp14
[267.322196] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[267.464830] [049/133] (787s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[267.631968] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[267.633986] Starting dynamic subtest: pipe-A-HDMI-A-1
[267.637734] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[267.660837] Starting dynamic subtest: pipe-A-HDMI-A-2
[267.664386] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[267.684706] Starting dynamic subtest: pipe-B-HDMI-A-1
[267.688334] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[267.706617] Starting dynamic subtest: pipe-B-HDMI-A-2
[267.710084] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[267.728323] Starting dynamic subtest: pipe-C-HDMI-A-1
[267.732139] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[267.750450] Starting dynamic subtest: pipe-C-HDMI-A-2
[267.754140] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[267.755814] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.033s)
[268.553261] [050/133] (786s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[268.738422] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[268.740521] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[268.887220] [051/133] (786s left) gem_softpin (allocator-nopin-reserve)
[268.991317] Starting subtest: allocator-nopin-reserve
[269.201868] Subtest allocator-nopin-reserve: SUCCESS (0.211s)
[269.374661] [052/133] (785s left) kms_async_flips (async-flip-suspend-resume)
[269.544826] Starting subtest: async-flip-suspend-resume
[270.098227] Starting dynamic subtest: pipe-A-HDMI-A-1
[289.699119] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.878s)
[289.721551] Starting dynamic subtest: pipe-A-HDMI-A-2