[86.120381] Initializing watchdogs
[86.120619]   /dev/watchdog0
[86.159208] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3184 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 605]
[86.173483] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[86.181654] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[86.189276] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[86.409549] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[86.413495] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[86.564809] [002/133] (960s left) kms_psr (fbc-psr-sprite-render)
[86.745511] Subtest fbc-psr-sprite-render: SKIP (0.000s)
[86.824338] [003/133] (960s left) kms_psr (fbc-psr-dpms)
[86.995798] Subtest fbc-psr-dpms: SKIP (0.000s)
[87.093728] [004/133] (959s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[87.264279] Starting subtest: basic-max-pipe-crc-check
[87.267859] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[87.358565] [005/133] (959s left) kms_cdclk (mode-transition)
[87.457867] Subtest mode-transition: SKIP (0.000s)
[87.547111] [006/133] (959s left) kms_cursor_crc (cursor-offscreen-32x10)
[87.733700] Starting subtest: cursor-offscreen-32x10
[87.884596] Subtest cursor-offscreen-32x10: SKIP (0.148s)
[88.047480] [007/133] (959s left) syncobj_timeline (wait-all-delayed-signal)
[88.148196] Starting subtest: wait-all-delayed-signal
[88.253056] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[88.380415] [008/133] (958s left) api_intel_bb (misplaced-blitter)
[88.480178] Starting subtest: misplaced-blitter
[88.494255] Subtest misplaced-blitter: SUCCESS (0.014s)
[88.683463] [009/133] (958s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[88.784165] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[88.889909] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.103s)
[89.015748] [010/133] (958s left) gem_softpin (allocator-fork)
[89.131652] Starting subtest: allocator-fork
[91.465853] Subtest allocator-fork: SUCCESS (2.335s)
[91.617151] [011/133] (955s left) kms_feature_discovery (psr2)
[91.790152] Starting subtest: psr2
[91.793786] Subtest psr2: SKIP (0.000s)
[91.916349] [012/133] (955s left) prime_mmap (test_userptr)
[92.015192] Starting subtest: test_userptr
[92.017246] Starting dynamic subtest: test_userptr-smem
[92.019161] Dynamic subtest test_userptr-smem: SUCCESS (0.001s)
[92.020935] Subtest test_userptr: SUCCESS (0.002s)
[92.168162] [013/133] (955s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[92.281469] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[92.283292] Starting dynamic subtest: smem
[92.513338] Dynamic subtest smem: SUCCESS (0.230s)
[92.516694] Subtest y-tiled-ccs-to-y-tiled-ccs: SUCCESS (0.231s)
[92.753044] [014/133] (954s left) gem_tiled_blits (interruptible)
[93.501879] Starting subtest: interruptible
[126.498647] Subtest interruptible: SUCCESS (32.997s)
[126.692422] [015/133] (921s left) syncobj_wait (single-wait-all-for-submit-submitted)
[126.924078] Starting subtest: single-wait-all-for-submit-submitted
[127.034034] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.108s)
[127.165919] [016/133] (920s left) gem_exec_schedule (pi-ringfull)
[127.421809] Starting subtest: pi-ringfull
[127.424398] Starting dynamic subtest: rcs0
[127.584079] Dynamic subtest rcs0: SUCCESS (0.164s)
[127.604524] Starting dynamic subtest: bcs0
[127.632479] Dynamic subtest bcs0: SUCCESS (0.048s)
[127.653674] Starting dynamic subtest: vcs0
[127.682163] Dynamic subtest vcs0: SUCCESS (0.049s)
[127.702506] Starting dynamic subtest: vecs0
[127.732133] Dynamic subtest vecs0: SUCCESS (0.048s)
[127.735314] Subtest pi-ringfull: SUCCESS (0.312s)
[127.970331] [FACT gem_exec_schedule (pi-ringfull)] new: kernel.kmod_is_loaded.vgem: true
[127.976907] [017/133] (919s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[128.180269] Starting subtest: y-tiled-32bpp-rotate-180
[132.053471] Subtest y-tiled-32bpp-rotate-180: SUCCESS (3.871s)
[132.458194] [018/133] (915s left) gem_exec_fence (syncobj-wait)
[132.975209] Starting subtest: syncobj-wait
[133.011178] Subtest syncobj-wait: SUCCESS (0.035s)
[133.407129] [019/133] (914s left) kms_joiner (basic-big-joiner)
[133.602522] Starting subtest: basic-big-joiner
[133.606513] Subtest basic-big-joiner: SKIP (0.000s)
[133.742617] [020/133] (914s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[133.924917] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[133.928718] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[134.075431] [021/133] (914s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[134.248025] Starting subtest: cursorB-vs-flipB-atomic-transitions
[145.520991] Subtest cursorB-vs-flipB-atomic-transitions: SUCCESS (11.273s)
[145.817919] [022/133] (902s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[146.024392] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[146.028942] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[146.183244] [023/133] (902s left) i915_drm_fdinfo (most-busy-check-all)
[146.284574] Starting subtest: most-busy-check-all
[146.286567] Starting dynamic subtest: rcs0
[146.817258] Dynamic subtest rcs0: SUCCESS (0.532s)
[146.837391] Starting dynamic subtest: bcs0
[147.345365] Dynamic subtest bcs0: SUCCESS (0.527s)
[147.366250] Starting dynamic subtest: vcs0
[147.876765] Dynamic subtest vcs0: SUCCESS (0.527s)
[147.898275] Starting dynamic subtest: vecs0
[148.404439] Dynamic subtest vecs0: SUCCESS (0.528s)
[148.408051] Subtest most-busy-check-all: SUCCESS (2.121s)
[148.551254] [024/133] (900s left) api_intel_allocator (fork-simple-once)
[148.646420] Starting subtest: fork-simple-once
[148.679481] Subtest fork-simple-once: SUCCESS (0.034s)
[148.832824] [025/133] (899s left) gem_exec_schedule (u-independent)
[148.951808] Starting subtest: u-independent
[148.953867] Starting dynamic subtest: rcs0
[149.130520] Dynamic subtest rcs0: SUCCESS (0.178s)
[149.155097] Starting dynamic subtest: bcs0
[149.302041] Dynamic subtest bcs0: SUCCESS (0.170s)
[149.326518] Starting dynamic subtest: vcs0
[149.461703] Dynamic subtest vcs0: SUCCESS (0.158s)
[149.487272] Starting dynamic subtest: vecs0
[149.622587] Dynamic subtest vecs0: SUCCESS (0.159s)
[149.624544] Subtest u-independent: SUCCESS (0.672s)
[150.001162] [026/133] (898s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[150.183553] Starting subtest: fbc-rgb101010-draw-mmap-wc
[153.174555] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (2.992s)
[153.431893] [027/133] (895s left) kms_cursor_crc (cursor-random-256x85)
[153.635228] Starting subtest: cursor-random-256x85
[153.672246] Starting dynamic subtest: pipe-A-HDMI-A-1
[157.789223] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.112s)
[157.861065] Starting dynamic subtest: pipe-C-HDMI-A-1
[161.692138] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.845s)
[161.694263] Subtest cursor-random-256x85: SUCCESS (8.055s)
[161.994210] [028/133] (886s left) gem_eio (wait-wedge-10ms)
[162.117680] Starting subtest: wait-wedge-10ms
[162.205956] Subtest wait-wedge-10ms: SUCCESS (0.091s)
[162.443292] [029/133] (886s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[162.619159] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[162.718060] [030/133] (886s left) sysfs_timeslice_duration (invalid)
[162.824876] Starting subtest: invalid
[162.827148] Starting dynamic subtest: vecs0
[162.829110] Dynamic subtest vecs0: SUCCESS (0.001s)
[162.849725] Starting dynamic subtest: vcs0
[162.851589] Dynamic subtest vcs0: SUCCESS (0.001s)
[162.871789] Starting dynamic subtest: bcs0
[162.873737] Dynamic subtest bcs0: SUCCESS (0.001s)
[162.893459] Starting dynamic subtest: rcs0
[162.895765] Dynamic subtest rcs0: SUCCESS (0.001s)
[162.898780] Subtest invalid: SUCCESS (0.013s)
[162.982907] [031/133] (886s left) gem_mmap_wc (read-write-distinct)
[163.087343] Starting subtest: read-write-distinct
[163.096349] Subtest read-write-distinct: SUCCESS (0.008s)
[163.256874] [032/133] (886s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[163.432289] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[163.434231] Starting dynamic subtest: pipe-A-valid-mode
[164.305157] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.870s)
[164.307129] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SUCCESS (0.874s)
[164.605906] [033/133] (884s left) gem_userptr_blits (unsync-overlap)
[164.723803] Subtest unsync-overlap: SKIP (0.000s)
[164.922945] [034/133] (884s left) gem_eio (hibernate)
[165.037337] Starting subtest: hibernate
[179.629396] Subtest hibernate: SUCCESS (14.589s)
[185.892177] [035/133] (869s left) gem_watchdog (default-virtual)
[186.041952] Starting subtest: default-virtual
[187.072106] Subtest default-virtual: SUCCESS (1.028s)
[187.193928] [036/133] (868s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[187.371162] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[187.373212] Starting dynamic subtest: pipe-A-HDMI-A-1
[187.392012] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[187.415951] Starting dynamic subtest: pipe-A-HDMI-A-2
[187.437027] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[187.460964] Starting dynamic subtest: pipe-B-HDMI-A-1
[187.479328] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[187.502764] Starting dynamic subtest: pipe-B-HDMI-A-2
[187.521504] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[187.544781] Starting dynamic subtest: pipe-C-HDMI-A-1
[187.562846] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[187.586450] Starting dynamic subtest: pipe-C-HDMI-A-2
[187.604457] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[187.608022] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SKIP (0.024s)
[188.280162] [037/133] (867s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[188.466618] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[188.690029] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.220s)
[188.928618] [038/133] (866s left) kms_properties (connector-properties-legacy)
[189.102285] Starting subtest: connector-properties-legacy
[189.104644] Starting dynamic subtest: pipe-A-HDMI-A-1
[190.888707] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.784s)
[190.916658] Starting dynamic subtest: pipe-A-HDMI-A-2
[192.571261] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.677s)
[192.573628] Subtest connector-properties-legacy: SUCCESS (3.471s)
[192.868030] [039/133] (863s left) i915_query (hwconfig_table)
[192.968194] Starting subtest: hwconfig_table
[192.972184] Subtest hwconfig_table: SKIP (0.000s)
[193.117788] [040/133] (863s left) gem_exec_balancer (busy)
[193.240181] Starting subtest: busy
[195.337668] Subtest busy: SUCCESS (2.097s)
[195.602897] [041/133] (860s left) gem_exec_params (rel-constants-invalid)
[195.729477] Starting subtest: rel-constants-invalid
[195.731633] Subtest rel-constants-invalid: SUCCESS (0.000s)
[195.882139] [042/133] (860s left) gem_mmap_gtt (zero-extend)
[195.985950] Starting subtest: zero-extend
[195.987907] Subtest zero-extend: SUCCESS (0.000s)
[196.135605] [043/133] (860s left) kms_plane_scaling (invalid-num-scalers)
[196.309682] Starting subtest: invalid-num-scalers
[196.332091] Starting dynamic subtest: pipe-A-HDMI-A-1-invalid-num-scalers
[196.396947] Dynamic subtest pipe-A-HDMI-A-1-invalid-num-scalers: SUCCESS (0.064s)
[196.443719] Starting dynamic subtest: pipe-A-HDMI-A-2-invalid-num-scalers
[196.489983] Dynamic subtest pipe-A-HDMI-A-2-invalid-num-scalers: SUCCESS (0.066s)
[196.537186] Starting dynamic subtest: pipe-B-HDMI-A-1-invalid-num-scalers
[196.581692] Dynamic subtest pipe-B-HDMI-A-1-invalid-num-scalers: SUCCESS (0.066s)
[196.629768] Starting dynamic subtest: pipe-B-HDMI-A-2-invalid-num-scalers
[196.670246] Dynamic subtest pipe-B-HDMI-A-2-invalid-num-scalers: SUCCESS (0.063s)
[196.717939] Starting dynamic subtest: pipe-C-HDMI-A-1-invalid-num-scalers
[196.803963] Dynamic subtest pipe-C-HDMI-A-1-invalid-num-scalers: SUCCESS (0.107s)
[196.855424] Starting dynamic subtest: pipe-C-HDMI-A-2-invalid-num-scalers
[196.936768] Dynamic subtest pipe-C-HDMI-A-2-invalid-num-scalers: SUCCESS (0.106s)
[196.938787] Subtest invalid-num-scalers: SUCCESS (0.632s)
[197.118594] [044/133] (859s left) kms_tiled_display (basic-test-pattern)
[197.368163] Starting subtest: basic-test-pattern
[198.742334] Subtest basic-test-pattern: FAIL (0.890s)
[198.833603] [045/133] (857s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[198.963902] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[198.966348] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.002s)
[199.115592] [046/133] (857s left) kms_color (invalid-ctm-matrix-sizes)
[199.241154] Starting subtest: invalid-ctm-matrix-sizes
[199.243074] Starting dynamic subtest: pipe-A
[199.248634] Dynamic subtest pipe-A: SUCCESS (0.011s)
[199.276703] Starting dynamic subtest: pipe-B
[199.278556] Dynamic subtest pipe-B: SUCCESS (0.015s)
[199.303236] Starting dynamic subtest: pipe-C
[199.306420] Dynamic subtest pipe-C: SUCCESS (0.016s)
[199.308453] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.049s)
[199.432409] [047/133] (857s left) gem_exec_flush (basic-batch-kernel-default-wb)
[199.551973] Starting subtest: basic-batch-kernel-default-wb
[205.332424] Subtest basic-batch-kernel-default-wb: SUCCESS (5.780s)
[205.596980] [048/133] (851s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[205.723646] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[205.726476] Starting dynamic subtest: pipe-A-HDMI-A-1