[88.987929] Initializing watchdogs
[88.988162]   /dev/watchdog0
[89.027421] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3184 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 605]
[89.041514] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[89.047513] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[89.052959] [001/132] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[89.257049] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[89.259894] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[89.420704] [002/132] (960s left) kms_psr (fbc-psr-sprite-render)
[89.589651] Subtest fbc-psr-sprite-render: SKIP (0.000s)
[89.682182] [003/132] (960s left) kms_psr (fbc-psr-dpms)
[89.849991] Subtest fbc-psr-dpms: SKIP (0.000s)
[89.932487] [004/132] (959s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[90.098909] Starting subtest: basic-max-pipe-crc-check
[90.100837] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[90.182437] [005/132] (959s left) kms_cdclk (mode-transition)
[90.276166] Subtest mode-transition: SKIP (0.000s)
[90.365512] [006/132] (959s left) kms_cursor_crc (cursor-offscreen-32x10)
[90.545661] Starting subtest: cursor-offscreen-32x10
[90.694240] Subtest cursor-offscreen-32x10: SKIP (0.148s)
[90.858683] [007/132] (959s left) syncobj_timeline (wait-all-delayed-signal)
[90.954073] Starting subtest: wait-all-delayed-signal
[91.057389] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[91.186640] [008/132] (958s left) api_intel_bb (misplaced-blitter)
[91.279514] Starting subtest: misplaced-blitter
[91.295880] Subtest misplaced-blitter: SUCCESS (0.013s)
[91.458162] [009/132] (958s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[91.556358] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[91.665157] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.107s)
[91.792871] [010/132] (958s left) gem_softpin (allocator-fork)
[91.911305] Starting subtest: allocator-fork
[94.251012] Subtest allocator-fork: SUCCESS (2.341s)
[94.378210] [011/132] (955s left) kms_feature_discovery (psr2)
[94.550572] Starting subtest: psr2
[94.552517] Subtest psr2: SKIP (0.000s)
[94.674383] [012/132] (955s left) prime_mmap (test_userptr)
[94.768823] Starting subtest: test_userptr
[94.771155] Starting dynamic subtest: test_userptr-smem
[94.772070] Dynamic subtest test_userptr-smem: SUCCESS (0.001s)
[94.772960] Subtest test_userptr: SUCCESS (0.003s)
[94.910532] [013/132] (955s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[95.021699] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[95.023060] Starting dynamic subtest: smem
[95.263825] Dynamic subtest smem: SUCCESS (0.242s)
[95.265032] Subtest y-tiled-ccs-to-y-tiled-ccs: SUCCESS (0.243s)
[95.494353] [014/132] (955s left) syncobj_wait (single-wait-all-for-submit-submitted)
[95.592586] Starting subtest: single-wait-all-for-submit-submitted
[95.696974] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.103s)
[95.823314] [015/132] (954s left) gem_exec_schedule (pi-ringfull)
[96.073461] Starting subtest: pi-ringfull
[96.075025] Starting dynamic subtest: rcs0
[96.192681] Dynamic subtest rcs0: SUCCESS (0.103s)
[96.209366] Starting dynamic subtest: bcs0
[96.230929] Dynamic subtest bcs0: SUCCESS (0.051s)
[96.260067] Starting dynamic subtest: vcs0
[96.281848] Dynamic subtest vcs0: SUCCESS (0.050s)
[96.311269] Starting dynamic subtest: vecs0
[96.328355] Dynamic subtest vecs0: SUCCESS (0.051s)
[96.329496] Subtest pi-ringfull: SUCCESS (0.258s)
[96.571756] [FACT gem_exec_schedule (pi-ringfull)] new: kernel.kmod_is_loaded.vgem: true
[96.575465] [016/132] (954s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[96.769943] Starting subtest: y-tiled-32bpp-rotate-180
[101.787093] Subtest y-tiled-32bpp-rotate-180: SUCCESS (5.015s)
[102.321416] [017/132] (948s left) gem_exec_fence (syncobj-wait)
[102.841463] Starting subtest: syncobj-wait
[102.875405] Subtest syncobj-wait: SUCCESS (0.034s)
[103.303225] [018/132] (947s left) kms_joiner (basic-big-joiner)
[103.477530] Starting subtest: basic-big-joiner
[103.480406] Subtest basic-big-joiner: SKIP (0.000s)
[103.604174] [019/132] (947s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[103.786823] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[103.788641] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[103.938354] [020/132] (947s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[104.105730] Starting subtest: cursorB-vs-flipB-atomic-transitions
[115.391216] Subtest cursorB-vs-flipB-atomic-transitions: SUCCESS (11.281s)
[115.676174] [021/132] (935s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[115.884723] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[115.886900] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[116.042759] [022/132] (935s left) i915_drm_fdinfo (most-busy-check-all)
[116.145571] Starting subtest: most-busy-check-all
[116.146593] Starting dynamic subtest: rcs0
[116.678222] Dynamic subtest rcs0: SUCCESS (0.532s)
[116.697894] Starting dynamic subtest: bcs0
[117.207264] Dynamic subtest bcs0: SUCCESS (0.527s)
[117.227246] Starting dynamic subtest: vcs0
[117.738372] Dynamic subtest vcs0: SUCCESS (0.530s)
[117.758441] Starting dynamic subtest: vecs0
[118.270307] Dynamic subtest vecs0: SUCCESS (0.530s)
[118.271298] Subtest most-busy-check-all: SUCCESS (2.126s)
[118.409475] [023/132] (932s left) api_intel_allocator (fork-simple-once)
[118.502751] Starting subtest: fork-simple-once
[118.536491] Subtest fork-simple-once: SUCCESS (0.034s)
[118.675709] [024/132] (932s left) gem_exec_schedule (u-independent)
[118.797907] Starting subtest: u-independent
[118.798856] Starting dynamic subtest: rcs0
[118.965905] Dynamic subtest rcs0: SUCCESS (0.168s)
[118.990338] Starting dynamic subtest: bcs0
[119.135947] Dynamic subtest bcs0: SUCCESS (0.168s)
[119.157412] Starting dynamic subtest: vcs0
[119.292633] Dynamic subtest vcs0: SUCCESS (0.155s)
[119.314305] Starting dynamic subtest: vecs0
[119.453582] Dynamic subtest vecs0: SUCCESS (0.159s)
[119.454566] Subtest u-independent: SUCCESS (0.657s)
[119.826026] [025/132] (931s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[120.007504] Starting subtest: fbc-rgb101010-draw-mmap-wc
[123.088501] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (3.081s)
[123.342126] [026/132] (928s left) kms_cursor_crc (cursor-random-256x85)
[123.527325] Starting subtest: cursor-random-256x85
[123.562954] Starting dynamic subtest: pipe-A-HDMI-A-1
[127.755064] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.189s)
[127.829435] Starting dynamic subtest: pipe-C-HDMI-A-1
[131.728894] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.910s)
[131.730044] Subtest cursor-random-256x85: SUCCESS (8.202s)
[132.030853] [027/132] (919s left) gem_eio (wait-wedge-10ms)
[132.150777] Starting subtest: wait-wedge-10ms
[132.240280] Subtest wait-wedge-10ms: SUCCESS (0.088s)
[132.465044] [028/132] (919s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[132.635808] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[132.748246] [029/132] (919s left) sysfs_timeslice_duration (invalid)
[132.853903] Starting subtest: invalid
[132.854915] Starting dynamic subtest: vecs0
[132.855814] Dynamic subtest vecs0: SUCCESS (0.002s)
[132.875689] Starting dynamic subtest: vcs0
[132.876694] Dynamic subtest vcs0: SUCCESS (0.001s)
[132.893812] Starting dynamic subtest: bcs0
[132.894984] Dynamic subtest bcs0: SUCCESS (0.001s)
[132.912252] Starting dynamic subtest: rcs0
[132.913165] Dynamic subtest rcs0: SUCCESS (0.001s)
[132.914093] Subtest invalid: SUCCESS (0.014s)
[132.997827] [030/132] (918s left) gem_mmap_wc (read-write-distinct)
[133.092563] Starting subtest: read-write-distinct
[133.122256] Subtest read-write-distinct: SUCCESS (0.028s)
[133.281595] [031/132] (918s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[133.449051] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[133.452114] Starting dynamic subtest: pipe-A-valid-mode
[134.387444] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.930s)
[134.388460] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SUCCESS (0.934s)
[134.679904] [032/132] (917s left) gem_userptr_blits (unsync-overlap)
[134.787492] Subtest unsync-overlap: SKIP (0.000s)
[134.980867] [033/132] (917s left) gem_eio (hibernate)
[135.095198] Starting subtest: hibernate
[149.980054] Subtest hibernate: SUCCESS (14.701s)
[157.089466] [034/132] (902s left) gem_watchdog (default-virtual)
[157.216784] Starting subtest: default-virtual
[158.245797] Subtest default-virtual: SUCCESS (1.028s)
[158.385689] [035/132] (901s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[158.555941] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[158.557039] Starting dynamic subtest: pipe-A-HDMI-A-1
[158.567111] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[158.588598] Starting dynamic subtest: pipe-A-HDMI-A-2
[158.618752] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s)
[158.640749] Starting dynamic subtest: pipe-B-HDMI-A-1
[158.671576] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[158.691463] Starting dynamic subtest: pipe-B-HDMI-A-2
[158.699890] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[158.719296] Starting dynamic subtest: pipe-C-HDMI-A-1
[158.727361] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[158.746619] Starting dynamic subtest: pipe-C-HDMI-A-2
[158.754903] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[158.756687] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SKIP (0.027s)
[159.452198] [036/132] (900s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[159.638493] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[159.865107] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.225s)
[160.102399] [037/132] (899s left) kms_properties (connector-properties-legacy)
[160.274614] Starting subtest: connector-properties-legacy
[160.275573] Starting dynamic subtest: pipe-A-HDMI-A-1
[162.070146] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.790s)
[162.090948] Starting dynamic subtest: pipe-A-HDMI-A-2
[163.721280] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.651s)
[163.722271] Subtest connector-properties-legacy: SUCCESS (3.451s)
[164.017913] [038/132] (895s left) i915_query (hwconfig_table)
[164.114922] Starting subtest: hwconfig_table
[164.116949] Subtest hwconfig_table: SKIP (0.000s)
[164.251711] [039/132] (895s left) gem_exec_balancer (busy)
[164.374185] Starting subtest: busy
[166.468448] Subtest busy: SUCCESS (2.095s)
[166.735124] [040/132] (893s left) gem_exec_params (rel-constants-invalid)
[166.838949] Starting subtest: rel-constants-invalid
[166.840084] Subtest rel-constants-invalid: SUCCESS (0.001s)
[167.003900] [041/132] (892s left) gem_mmap_gtt (zero-extend)
[167.099825] Starting subtest: zero-extend
[167.100967] Subtest zero-extend: SUCCESS (0.000s)
[167.234907] [042/132] (892s left) kms_plane_scaling (invalid-num-scalers)
[167.404348] Starting subtest: invalid-num-scalers
[167.431252] Starting dynamic subtest: pipe-A-HDMI-A-1-invalid-num-scalers
[167.496160] Dynamic subtest pipe-A-HDMI-A-1-invalid-num-scalers: SUCCESS (0.065s)
[167.546508] Starting dynamic subtest: pipe-A-HDMI-A-2-invalid-num-scalers
[167.592945] Dynamic subtest pipe-A-HDMI-A-2-invalid-num-scalers: SUCCESS (0.067s)
[167.638276] Starting dynamic subtest: pipe-B-HDMI-A-1-invalid-num-scalers
[167.686549] Dynamic subtest pipe-B-HDMI-A-1-invalid-num-scalers: SUCCESS (0.067s)
[167.733458] Starting dynamic subtest: pipe-B-HDMI-A-2-invalid-num-scalers
[167.779915] Dynamic subtest pipe-B-HDMI-A-2-invalid-num-scalers: SUCCESS (0.064s)
[167.825233] Starting dynamic subtest: pipe-C-HDMI-A-1-invalid-num-scalers
[167.914677] Dynamic subtest pipe-C-HDMI-A-1-invalid-num-scalers: SUCCESS (0.108s)
[167.960263] Starting dynamic subtest: pipe-C-HDMI-A-2-invalid-num-scalers
[168.049270] Dynamic subtest pipe-C-HDMI-A-2-invalid-num-scalers: SUCCESS (0.108s)
[168.050251] Subtest invalid-num-scalers: SUCCESS (0.647s)
[168.235397] [043/132] (891s left) kms_tiled_display (basic-test-pattern)
[168.486170] Starting subtest: basic-test-pattern
[169.615361] Subtest basic-test-pattern: FAIL (0.913s)
[169.699637] [044/132] (890s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[169.801448] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[169.805076] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.002s)
[169.948478] [045/132] (890s left) kms_color (invalid-ctm-matrix-sizes)
[170.069318] Starting subtest: invalid-ctm-matrix-sizes
[170.070558] Starting dynamic subtest: pipe-A
[170.081176] Dynamic subtest pipe-A: SUCCESS (0.011s)
[170.103621] Starting dynamic subtest: pipe-B
[170.104563] Dynamic subtest pipe-B: SUCCESS (0.012s)
[170.124675] Starting dynamic subtest: pipe-C
[170.125716] Dynamic subtest pipe-C: SUCCESS (0.016s)
[170.126703] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.046s)
[170.247494] [046/132] (890s left) gem_exec_flush (basic-batch-kernel-default-wb)
[170.370339] Starting subtest: basic-batch-kernel-default-wb
[176.146630] Subtest basic-batch-kernel-default-wb: SUCCESS (5.775s)
[176.395904] [047/132] (884s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[176.518933] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[176.520018] Starting dynamic subtest: pipe-A-HDMI-A-1
[194.691176] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.197s)
[194.712416] Starting dynamic subtest: pipe-A-HDMI-A-2