[116.340140] Initializing watchdogs
[116.340312]   /dev/watchdog0
[116.382504] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[116.397409] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[116.405235] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[116.413203] [001/155] (960s left) kms_addfb_basic (unused-modifier)
[116.541231] Starting subtest: unused-modifier
[116.546654] Subtest unused-modifier: SUCCESS (0.000s)
[116.785505] [002/155] (960s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[117.007807] Starting subtest: dp-mst-type-1-suspend-resume
[117.014834] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[117.160554] [003/155] (959s left) gem_ctx_shared (q-in-order)
[117.304739] Starting subtest: Q-in-order
[117.309206] Starting dynamic subtest: rcs0
[117.478462] Dynamic subtest rcs0: SUCCESS (0.172s)
[117.515113] Starting dynamic subtest: bcs0
[117.597322] Dynamic subtest bcs0: SUCCESS (0.113s)
[117.621145] Starting dynamic subtest: vcs0
[117.696904] Dynamic subtest vcs0: SUCCESS (0.099s)
[117.725162] Starting dynamic subtest: vecs0
[117.792081] Dynamic subtest vecs0: SUCCESS (0.096s)
[117.797148] Subtest Q-in-order: SUCCESS (0.488s)
[118.102411] [FACT gem_ctx_shared (q-in-order)] new: kernel.kmod_is_loaded.vgem: true
[118.109229] [004/155] (959s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-pgflip-blt)
[118.313505] Starting subtest: hdr-2p-scndscrn-indfb-pgflip-blt
[119.668549] Subtest hdr-2p-scndscrn-indfb-pgflip-blt: SUCCESS (1.355s)
[119.876621] [005/155] (957s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[120.080522] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[120.197794] [006/155] (957s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[120.403596] Starting subtest: primary-x-tiled-reflect-x-180
[120.410042] Subtest primary-x-tiled-reflect-x-180: SKIP (0.004s)
[120.559657] [007/155] (956s left) perf_pmu (most-busy-check-all)
[120.699196] Starting subtest: most-busy-check-all
[120.703766] Starting dynamic subtest: rcs0
[121.230166] Dynamic subtest rcs0: SUCCESS (0.534s)
[121.253669] Starting dynamic subtest: bcs0
[121.750205] Dynamic subtest bcs0: SUCCESS (0.519s)
[121.773479] Starting dynamic subtest: vcs0
[122.276910] Dynamic subtest vcs0: SUCCESS (0.526s)
[122.301419] Starting dynamic subtest: vecs0
[122.802938] Dynamic subtest vecs0: SUCCESS (0.524s)
[122.806658] Subtest most-busy-check-all: SUCCESS (2.109s)
[122.957601] [008/155] (954s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-msflip-blt)
[123.166202] Starting subtest: psrhdr-2p-scndscrn-indfb-msflip-blt
[123.174548] Subtest psrhdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[123.310447] [009/155] (954s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[123.427469] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[123.539437] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.111s)
[123.693391] [010/155] (954s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[123.903109] Starting subtest: yf-tiled-64bpp-rotate-180
[123.912420] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[124.075116] [011/155] (953s left) i915_pm_rc6_residency (rc6-accuracy)
[124.190590] Starting subtest: rc6-accuracy
[124.194098] Starting dynamic subtest: gt0
[127.369510] Dynamic subtest gt0: SUCCESS (3.176s)
[127.374288] Subtest rc6-accuracy: SUCCESS (3.179s)
[127.509384] [012/155] (950s left) api_intel_allocator (gem-pool)
[127.631718] Starting subtest: gem-pool
[127.637647] Subtest gem-pool: SUCCESS (0.015s)
[127.792844] [013/155] (950s left) api_intel_bb (purge-bb)
[127.900711] Starting subtest: purge-bb
[127.904712] Subtest purge-bb: SUCCESS (0.006s)
[128.076423] [014/155] (950s left) gem_ctx_param (invalid-ctx-set)
[128.190502] Starting subtest: invalid-ctx-set
[128.193517] Subtest invalid-ctx-set: SUCCESS (0.000s)
[128.341939] [015/155] (950s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-plflip-blt)
[128.550481] Starting subtest: hdr-2p-primscrn-shrfb-plflip-blt
[129.735430] Subtest hdr-2p-primscrn-shrfb-plflip-blt: SUCCESS (1.187s)
[129.928579] [016/155] (948s left) syncobj_wait (invalid-reset-bad-pad)
[130.052611] Starting subtest: invalid-reset-bad-pad
[130.056478] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[130.211145] [017/155] (948s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[130.424417] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[130.430772] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[130.595282] [018/155] (948s left) syncobj_timeline (multi-wait-all-available-submitted)
[130.706733] Starting subtest: multi-wait-all-available-submitted
[130.710176] Subtest multi-wait-all-available-submitted: SUCCESS (0.002s)
[130.891405] [019/155] (947s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[131.069150] Starting subtest: cursorB-vs-flipB-atomic
[142.410582] Subtest cursorB-vs-flipB-atomic: SUCCESS (11.340s)
[142.764851] [020/155] (936s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[142.984056] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[142.990698] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[143.145683] [021/155] (935s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-move)
[143.368713] Starting subtest: fbchdr-1p-primscrn-spr-indfb-move
[144.291076] Subtest fbchdr-1p-primscrn-spr-indfb-move: SUCCESS (0.921s)
[144.604889] [022/155] (934s left) gem_exec_fence (syncobj-timeline-unused-fence)
[145.313883] Starting subtest: syncobj-timeline-unused-fence
[145.321706] Subtest syncobj-timeline-unused-fence: SUCCESS (0.007s)
[145.605349] [023/155] (933s left) kms_chamelium_edid (hdmi-edid-read)
[146.215844] Subtest hdmi-edid-read: SKIP (0.000s)
[146.534440] [024/155] (932s left) kms_psr (psr2-primary-page-flip)
[146.740460] Subtest psr2-primary-page-flip: SKIP (0.000s)
[146.858758] [025/155] (932s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-onoff)
[147.070099] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-onoff
[148.230937] Subtest fbchdr-2p-scndscrn-cur-indfb-onoff: SUCCESS (1.159s)
[148.439837] [026/155] (931s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[148.666409] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[151.515531] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SUCCESS (2.854s)
[151.847449] [027/155] (927s left) gem_create (create-ext-cpu-access-sanity-check)
[152.083738] Starting subtest: create-ext-cpu-access-sanity-check
[152.092665] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[152.233330] [028/155] (927s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[152.419600] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[152.423776] Starting dynamic subtest: pipe-A-HDMI-A-1
[152.475443] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[152.516738] Starting dynamic subtest: pipe-A-HDMI-A-2
[152.567924] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[152.590528] Starting dynamic subtest: pipe-B-HDMI-A-1
[152.626270] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[152.650226] Starting dynamic subtest: pipe-B-HDMI-A-2
[152.686309] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s)
[152.709531] Starting dynamic subtest: pipe-C-HDMI-A-1
[152.743419] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[152.767666] Starting dynamic subtest: pipe-C-HDMI-A-2
[152.802089] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[152.808303] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.020s)
[153.473539] [029/155] (926s left) kms_plane_multiple (tiling-4)
[153.666355] Starting subtest: tiling-4
[153.672163] Subtest tiling-4: SKIP (0.000s)
[153.811146] [030/155] (926s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[153.943559] Starting subtest: tiled-to-tiled
[154.071390] Subtest tiled-to-tiled: SUCCESS (0.125s)
[154.243130] [031/155] (925s left) gem_mmap_gtt (basic-write)
[154.374872] Starting subtest: basic-write
[154.773980] Subtest basic-write: SUCCESS (0.402s)
[154.926506] [032/155] (925s left) kms_plane_scaling (invalid-num-scalers)
[155.108977] Starting subtest: invalid-num-scalers
[155.150500] Starting dynamic subtest: pipe-A-HDMI-A-1-invalid-num-scalers
[155.254490] Dynamic subtest pipe-A-HDMI-A-1-invalid-num-scalers: SUCCESS (0.106s)
[155.344577] Starting dynamic subtest: pipe-A-HDMI-A-2-invalid-num-scalers
[155.432227] Dynamic subtest pipe-A-HDMI-A-2-invalid-num-scalers: SUCCESS (0.131s)
[155.514288] Starting dynamic subtest: pipe-B-HDMI-A-1-invalid-num-scalers
[155.599940] Dynamic subtest pipe-B-HDMI-A-1-invalid-num-scalers: SUCCESS (0.129s)
[155.683521] Starting dynamic subtest: pipe-B-HDMI-A-2-invalid-num-scalers
[155.755547] Dynamic subtest pipe-B-HDMI-A-2-invalid-num-scalers: SUCCESS (0.119s)
[155.849307] Starting dynamic subtest: pipe-C-HDMI-A-1-invalid-num-scalers
[155.985553] Dynamic subtest pipe-C-HDMI-A-1-invalid-num-scalers: SUCCESS (0.191s)
[156.073286] Starting dynamic subtest: pipe-C-HDMI-A-2-invalid-num-scalers
[156.192362] Dynamic subtest pipe-C-HDMI-A-2-invalid-num-scalers: SUCCESS (0.163s)
[156.196446] Subtest invalid-num-scalers: SUCCESS (1.081s)
[156.381729] [033/155] (923s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[156.584382] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[168.077164] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SUCCESS (11.429s)
[168.968377] [034/155] (911s left) vgem_basic (debugfs)
[169.420558] Starting subtest: debugfs
[169.423657] Subtest debugfs: SUCCESS (0.001s)
[169.526392] [035/155] (911s left) kms_cursor_crc (cursor-sliding-64x64)
[169.743611] Starting subtest: cursor-sliding-64x64
[169.810632] Starting dynamic subtest: pipe-A-HDMI-A-1
[173.874176] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.059s)
[173.996346] Starting dynamic subtest: pipe-C-HDMI-A-1
[177.762587] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.807s)
[177.767588] Subtest cursor-sliding-64x64: SUCCESS (8.013s)
[178.195826] [036/155] (902s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[178.327189] Starting subtest: wait-all-for-submit-delayed-submit
[178.430138] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.105s)
[178.627226] [037/155] (902s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[178.840260] Starting subtest: addfb25-x-tiled-legacy
[178.844420] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[178.999217] [038/155] (902s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[179.117542] Starting subtest: etime-single-wait-all-available-unsubmitted
[179.224183] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.107s)
[179.377328] [039/155] (902s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[179.565662] Starting subtest: plane-upscale-factor-0-25-with-rotation
[179.570342] Starting dynamic subtest: pipe-A
[184.266561] Dynamic subtest pipe-A: SKIP (4.691s)
[184.367767] Starting dynamic subtest: pipe-B
[188.719220] Dynamic subtest pipe-B: SKIP (4.453s)
[188.765466] Starting dynamic subtest: pipe-C
[193.940094] Dynamic subtest pipe-C: SKIP (5.217s)
[193.949230] Subtest plane-upscale-factor-0-25-with-rotation: SKIP (14.371s)
[194.525522] [040/155] (887s left) kms_sequence (get-forked-busy)
[194.769567] Starting subtest: get-forked-busy
[194.772840] Starting dynamic subtest: pipe-A-HDMI-A-1
[197.715700] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.942s)
[197.770551] Starting dynamic subtest: pipe-A-HDMI-A-2
[200.434750] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.714s)
[200.491486] Starting dynamic subtest: pipe-B-HDMI-A-1
[203.122087] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.678s)
[203.177556] Starting dynamic subtest: pipe-B-HDMI-A-2
[205.820309] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.696s)
[205.859307] Starting dynamic subtest: pipe-C-HDMI-A-1
[208.458194] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.632s)
[208.512603] Starting dynamic subtest: pipe-C-HDMI-A-2
[211.084107] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.615s)
[211.090472] Subtest get-forked-busy: SUCCESS (16.319s)
[211.468794] [041/155] (870s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[211.692337] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[213.646056] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SUCCESS (1.955s)
[213.896200] [042/155] (867s left) kms_getfb (getfb-handle-protection)
[214.097177] Starting subtest: getfb-handle-protection
[214.123612] Subtest getfb-handle-protection: SUCCESS (0.029s)
[214.291104] [043/155] (867s left) perf (polling)
[214.588333] Starting subtest: polling
[214.594271] Starting dynamic subtest: 0-rcs0
[224.618930] Dynamic subtest 0-rcs0: SUCCESS (10.033s)
[224.622803] Subtest polling: SUCCESS (10.037s)
[224.733486] [044/155] (857s left) gem_tiling_max_stride
[225.049820] [045/155] (857s left) kms_dp_link_training (uhbr-mst)
[225.241054] Starting subtest: uhbr-mst
[225.248662] Subtest uhbr-mst: SKIP (0.000s)
[225.402224] [046/155] (856s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-render)
[225.623296] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-render
[226.519463] Subtest hdr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (0.895s)
[226.812840] [047/155] (855s left) gem_mmap_wc (fault-concurrent)
[226.943488] Starting subtest: fault-concurrent
[227.264926] Subtest fault-concurrent: SUCCESS (0.327s)
[227.441392] [048/155] (855s left) kms_fb_coherency (memset-crc)
[227.642327] Starting subtest: memset-crc
[227.645504] Starting dynamic subtest: mmap-gtt
[228.575062] Dynamic subtest mmap-gtt: SUCCESS (0.938s)
[228.843990] Starting dynamic subtest: mmap-offset-wc
[229.200033] Dynamic subtest mmap-offset-wc: SUCCESS (0.409s)
[229.464232] Starting dynamic subtest: mmap-offset-uc
[230.254915] Dynamic subtest mmap-offset-uc: SUCCESS (0.840s)
[230.499987] Starting dynamic subtest: mmap-legacy-wc
[230.910527] Dynamic subtest mmap-legacy-wc: SUCCESS (0.435s)
[231.124817] Subtest memset-crc: SUCCESS (3.487s)
[231.488446] [049/155] (851s left) gem_softpin (noreloc-s3)
[231.620317] Starting subtest: noreloc-S3