[94.663569] Initializing watchdogs
[94.663753]   /dev/watchdog0
[94.706189] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[94.720980] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[94.729897] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[94.736769] [001/156] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[94.950435] Starting subtest: psr-2p-primscrn-spr-indfb-move
[94.956400] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[95.107679] [002/156] (960s left) kms_cursor_crc (cursor-offscreen-256x85)
[95.332074] Starting subtest: cursor-offscreen-256x85
[95.426238] Starting dynamic subtest: pipe-A-HDMI-A-1
[98.365786] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.937s)
[98.477057] Starting dynamic subtest: pipe-C-HDMI-A-1
[101.065739] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.629s)
[101.068841] Subtest cursor-offscreen-256x85: SUCCESS (5.732s)
[101.509299] [003/156] (953s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[101.624523] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[101.626279] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.002s)
[101.763962] [004/156] (953s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[101.953321] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.000s)
[102.054842] [005/156] (953s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[102.241728] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[102.245603] Starting dynamic subtest: pipe-A-HDMI-A-1
[102.265133] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.002s)
[102.308584] Starting dynamic subtest: pipe-A-HDMI-A-2
[102.348391] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.002s)
[102.372373] Starting dynamic subtest: pipe-B-HDMI-A-1
[102.382491] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.002s)
[102.401368] Starting dynamic subtest: pipe-B-HDMI-A-2
[102.412813] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.002s)
[102.432174] Starting dynamic subtest: pipe-C-HDMI-A-1
[102.455180] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[102.474098] Starting dynamic subtest: pipe-C-HDMI-A-2
[102.494098] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s)
[102.496071] Subtest ccs-on-another-bo-yf-tiled-ccs: SUCCESS (0.026s)
[103.295759] [006/156] (952s left) sysfs_timeslice_duration (idempotent)
[103.420182] Starting subtest: idempotent
[103.421280] Starting dynamic subtest: vecs0
[103.423556] Dynamic subtest vecs0: SUCCESS (0.002s)
[103.454349] Starting dynamic subtest: vcs0
[103.456110] Dynamic subtest vcs0: SUCCESS (0.002s)
[103.475189] Starting dynamic subtest: bcs0
[103.476688] Dynamic subtest bcs0: SUCCESS (0.002s)
[103.496883] Starting dynamic subtest: rcs0
[103.498663] Dynamic subtest rcs0: SUCCESS (0.002s)
[103.500297] Subtest idempotent: SUCCESS (0.012s)
[103.574909] [007/156] (952s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[103.760620] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[103.763120] Starting dynamic subtest: pipe-A-HDMI-A-1
[103.839917] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.015s)
[103.878374] Starting dynamic subtest: pipe-A-HDMI-A-2
[104.002443] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.014s)
[104.037232] Starting dynamic subtest: pipe-B-HDMI-A-1
[104.087589] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.015s)
[104.108467] Starting dynamic subtest: pipe-B-HDMI-A-2
[104.156533] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.014s)
[104.174987] Starting dynamic subtest: pipe-C-HDMI-A-1
[104.227379] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.018s)
[104.246627] Starting dynamic subtest: pipe-C-HDMI-A-2
[104.294910] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.021s)
[104.297224] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.120s)
[104.980108] [008/156] (950s left) gem_exec_flush (basic-wb-prw-default)
[105.118389] Starting subtest: basic-wb-prw-default
[110.537534] Subtest basic-wb-prw-default: SUCCESS (5.421s)
[110.795073] [009/156] (945s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-blt)
[110.996049] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-blt
[110.998533] Subtest hdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[111.129595] [010/156] (944s left) kms_cursor_crc (cursor-tearing-position-change)
[111.319049] Starting subtest: cursor-tearing-position-change
[111.324599] Starting dynamic subtest: pipe-A-HDMI-A-1
[112.166641] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.841s)
[112.208258] Starting dynamic subtest: pipe-C-HDMI-A-1
[112.713955] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.546s)
[112.716281] Subtest cursor-tearing-position-change: SUCCESS (1.395s)
[113.067786] [011/156] (943s left) kms_dsc (dsc-with-bpc-formats)
[113.263069] Subtest dsc-with-bpc-formats: SKIP (0.000s)
[113.358774] [012/156] (942s left) gem_softpin (evict-prime-sanity-check)
[113.483698] Starting subtest: evict-prime-sanity-check
[113.485642] Starting dynamic subtest: rcs0
[114.595892] Dynamic subtest rcs0: SUCCESS (1.112s)
[114.619856] Starting dynamic subtest: bcs0
[115.696220] Dynamic subtest bcs0: SUCCESS (1.100s)
[115.719444] Starting dynamic subtest: vcs0
[116.801223] Dynamic subtest vcs0: SUCCESS (1.100s)
[116.823686] Starting dynamic subtest: vecs0
[117.909103] Dynamic subtest vecs0: SUCCESS (1.107s)
[117.931819] Starting dynamic subtest: all
[119.007612] Dynamic subtest all: SUCCESS (1.098s)
[119.009021] Subtest evict-prime-sanity-check: SUCCESS (5.526s)
[119.153665] [013/156] (937s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-onoff)
[119.367701] Starting subtest: hdr-2p-scndscrn-spr-indfb-onoff
[119.371076] Subtest hdr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[119.518887] [014/156] (936s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[119.731135] Starting subtest: 4-tiled-32bpp-rotate-270
[119.734769] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.000s)
[119.869361] [015/156] (936s left) kms_vrr (negative-basic)
[120.060304] Starting subtest: negative-basic
[120.066049] Subtest negative-basic: SKIP (0.000s)
[120.186605] [016/156] (936s left) perf (enable-disable)
[120.399520] Starting subtest: enable-disable
[120.401925] Starting dynamic subtest: 0-rcs0
[123.603423] Dynamic subtest 0-rcs0: SUCCESS (3.203s)
[123.604643] Subtest enable-disable: SUCCESS (3.204s)
[123.705966] [017/156] (932s left) gem_partial_pwrite_pread (write-uncached)
[123.820619] Starting subtest: write-uncached
[138.356418] Subtest write-uncached: SUCCESS (14.535s)
[138.506760] [018/156] (918s left) syncobj_wait (multi-wait-submitted)
[138.617385] Starting subtest: multi-wait-submitted
[138.727680] Subtest multi-wait-submitted: SUCCESS (0.109s)
[138.883109] [019/156] (917s left) gem_exec_whisper (basic-queues-priority)
[139.015224] Starting subtest: basic-queues-priority
[145.074325] Subtest basic-queues-priority: SUCCESS (6.059s)
[145.354092] [020/156] (911s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[146.155961] Starting subtest: syncobj-stationary-timeline-chain-engines
[146.280218] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.123s)
[146.544207] [FACT gem_exec_fence (syncobj-stationary-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[146.550485] [021/156] (910s left) kms_frontbuffer_tracking (psrhdr-slowdraw)
[146.751416] Starting subtest: psrhdr-slowdraw
[146.754197] Subtest psrhdr-slowdraw: SKIP (0.000s)
[146.898711] [022/156] (910s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[147.111131] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[149.022763] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (1.906s)
[149.333203] [023/156] (907s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[149.541436] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[152.034504] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.492s)
[152.263614] [024/156] (904s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[152.457364] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[152.460654] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[152.617140] [025/156] (904s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-render)
[152.816558] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-render
[152.819110] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[152.967203] [026/156] (904s left) gem_mmap_wc (copy)
[153.069619] Starting subtest: copy
[153.294285] Subtest copy: SUCCESS (0.221s)
[153.435266] [027/156] (904s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[153.627103] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[153.631421] Starting dynamic subtest: pipe-A-valid-mode
[154.556365] Dynamic subtest pipe-A-valid-mode: SKIP (0.925s)
[154.558567] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.929s)
[155.125812] [028/156] (902s left) perf_pmu (init-busy)
[155.233604] Starting subtest: init-busy
[155.236081] Starting dynamic subtest: rcs0
[155.237267] Dynamic subtest rcs0: SUCCESS (0.003s)
[155.276118] Starting dynamic subtest: bcs0
[155.277599] Dynamic subtest bcs0: SUCCESS (0.002s)
[155.299726] Starting dynamic subtest: vcs0
[155.300856] Dynamic subtest vcs0: SUCCESS (0.002s)
[155.323255] Starting dynamic subtest: vecs0
[155.324768] Dynamic subtest vecs0: SUCCESS (0.002s)
[155.326730] Subtest init-busy: SUCCESS (0.012s)
[155.416232] [029/156] (902s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[155.611186] Starting subtest: primary-y-tiled-reflect-x-90
[155.615173] Subtest primary-y-tiled-reflect-x-90: SKIP (0.004s)
[155.757285] [030/156] (902s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[155.940109] Starting subtest: cursorA-vs-flipA-legacy
[167.211131] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.276s)
[167.558553] [031/156] (890s left) gem_exec_reloc (basic-gtt-wc)
[167.684827] Starting subtest: basic-gtt-wc
[167.701409] Subtest basic-gtt-wc: SUCCESS (0.016s)
[167.940993] [032/156] (890s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[168.134271] Starting subtest: fbc-rgb565-draw-mmap-cpu
[170.893428] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (2.760s)
[171.223376] [033/156] (886s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[171.419264] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[174.045218] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SUCCESS (2.623s)
[174.258422] [034/156] (883s left) kms_psr (psr2-primary-page-flip)
[174.446309] Subtest psr2-primary-page-flip: SKIP (0.000s)
[174.567837] [035/156] (883s left) kms_addfb_basic (unused-handle)
[174.674176] Starting subtest: unused-handle
[174.676768] Subtest unused-handle: SUCCESS (0.000s)
[174.907561] [036/156] (883s left) gem_exec_store (dword)
[175.039742] Starting subtest: dword
[175.041138] Starting dynamic subtest: rcs0
[175.068353] Dynamic subtest rcs0: SUCCESS (0.029s)
[175.097548] Starting dynamic subtest: bcs0
[175.100164] Dynamic subtest bcs0: SUCCESS (0.014s)
[175.131772] Starting dynamic subtest: vcs0
[175.133606] Dynamic subtest vcs0: SUCCESS (0.020s)
[175.156405] Starting dynamic subtest: vecs0
[175.158288] Dynamic subtest vecs0: SUCCESS (0.017s)
[175.159815] Subtest dword: SUCCESS (0.088s)
[175.389508] [037/156] (883s left) kms_color_pipeline (plane-lut1d-lut1d)
[175.587092] Starting subtest: plane-lut1d-lut1d
[177.251185] Subtest plane-lut1d-lut1d: SKIP (1.668s)
[177.603529] [038/156] (881s left) gem_ctx_isolation (preservation-s3)
[177.733154] Starting subtest: preservation-S3
[177.735915] Starting dynamic subtest: rcs0