[98.765408] Initializing watchdogs
[98.765606]   /dev/watchdog0
[98.806512] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[98.821343] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[98.827431] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[98.832439] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[99.052805] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[99.058303] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[99.198790] [002/133] (960s left) kms_concurrent (multi-plane-atomic-lowres)
[99.384476] Starting subtest: multi-plane-atomic-lowres
[99.387080] Starting dynamic subtest: pipe-A-HDMI-A-1
[100.480209] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.101s)
[100.522126] Starting dynamic subtest: pipe-A-HDMI-A-2
[101.225306] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.744s)
[101.251466] Starting dynamic subtest: pipe-B-HDMI-A-1
[101.934652] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.702s)
[101.969290] Starting dynamic subtest: pipe-B-HDMI-A-2
[102.729708] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.791s)
[102.777711] Starting dynamic subtest: pipe-C-HDMI-A-1
[103.547193] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.812s)
[103.585140] Starting dynamic subtest: pipe-C-HDMI-A-2
[104.281103] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.732s)
[104.282202] Subtest multi-plane-atomic-lowres: SUCCESS (4.907s)
[104.560191] [003/133] (954s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[104.681234] Starting subtest: invalid-single-wait-unsubmitted
[104.683591] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[104.807182] [004/133] (954s left) gem_exec_reloc (basic-wc-cpu-active)
[104.935224] Starting subtest: basic-wc-cpu-active
[105.085139] Subtest basic-wc-cpu-active: SUCCESS (0.149s)
[105.309754] [005/133] (954s left) sw_sync (sync_multi_producer_single_consumer)
[105.413171] Starting subtest: sync_multi_producer_single_consumer
[106.491483] Subtest sync_multi_producer_single_consumer: SUCCESS (1.079s)
[106.612455] [006/133] (953s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[107.192822] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[107.457051] [007/133] (952s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[107.568121] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[107.678095] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.107s)
[107.842724] [008/133] (952s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[108.028155] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[108.119482] [009/133] (951s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[108.233826] Starting subtest: single-wait-for-submit-available-submitted
[108.235486] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.001s)
[108.364647] [010/133] (951s left) gem_exec_flush (basic-wb-rw-default)
[108.496207] Starting subtest: basic-wb-rw-default
[113.912779] Subtest basic-wb-rw-default: SUCCESS (5.420s)
[114.195402] [011/133] (945s left) gem_exec_schedule (pi-distinct-iova)
[114.457488] Starting subtest: pi-distinct-iova
[114.459711] Starting dynamic subtest: rcs0
[114.526444] Dynamic subtest rcs0: SUCCESS (0.068s)
[114.557313] Starting dynamic subtest: bcs0
[114.622799] Dynamic subtest bcs0: SUCCESS (0.091s)
[114.664869] Starting dynamic subtest: vcs0
[114.679275] Dynamic subtest vcs0: SUCCESS (0.057s)
[114.712184] Starting dynamic subtest: vecs0
[114.747183] Dynamic subtest vecs0: SUCCESS (0.067s)
[114.749327] Subtest pi-distinct-iova: SUCCESS (0.288s)
[114.997591] [012/133] (945s left) gem_ctx_param (set-priority-invalid-size)
[115.103527] Starting subtest: set-priority-invalid-size
[115.104807] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[115.232273] [013/133] (945s left) kms_properties (get_properties-sanity-atomic)
[115.412076] Starting subtest: get_properties-sanity-atomic
[115.419364] Subtest get_properties-sanity-atomic: SUCCESS (0.007s)
[115.546644] [014/133] (944s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[115.667207] Starting subtest: y-tiled-ccs-to-x-tiled
[115.670967] Starting dynamic subtest: smem
[115.891503] Dynamic subtest smem: SUCCESS (0.223s)
[115.892667] Subtest y-tiled-ccs-to-x-tiled: SUCCESS (0.224s)
[116.134279] [015/133] (944s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[116.321097] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[116.324154] Subtest psr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[116.462404] [016/133] (944s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[116.649688] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[116.651722] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[116.779058] [017/133] (943s left) gem_exec_schedule (preempt-self)
[116.923221] Starting subtest: preempt-self
[116.924315] Starting dynamic subtest: rcs0
[116.952421] Dynamic subtest rcs0: SUCCESS (0.030s)
[116.973276] Starting dynamic subtest: bcs0
[116.996651] Dynamic subtest bcs0: SUCCESS (0.037s)
[117.025979] Starting dynamic subtest: vcs0
[117.028278] Dynamic subtest vcs0: SUCCESS (0.030s)
[117.057566] Starting dynamic subtest: vecs0
[117.058694] Dynamic subtest vecs0: SUCCESS (0.032s)
[117.060189] Subtest preempt-self: SUCCESS (0.135s)
[117.446818] [018/133] (943s left) gem_mmap_gtt (big-bo)
[117.550534] Starting subtest: big-bo
[118.525226] Subtest big-bo: SUCCESS (0.969s)
[118.694723] [019/133] (942s left) gem_softpin (full)
[118.925941] Starting subtest: full
[118.944929] Subtest full: SUCCESS (0.018s)
[119.081715] [020/133] (941s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[119.295287] Starting subtest: yf-tiled-32bpp-rotate-270
[124.300084] Subtest yf-tiled-32bpp-rotate-270: SUCCESS (5.002s)
[124.701991] [021/133] (936s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[124.915235] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[124.918704] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.001s)
[125.063735] [022/133] (935s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[125.285264] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[128.133041] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (2.848s)
[128.431441] [023/133] (932s left) kms_psr2_su (page_flip-xrgb8888)
[128.541605] Subtest page_flip-XRGB8888: SKIP (0.000s)
[128.636176] [024/133] (932s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[128.833420] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[128.840109] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.003s)
[128.963211] [025/133] (932s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[129.154246] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.000s)
[129.253330] [026/133] (932s left) kms_plane (plane-position-hole-dpms)
[129.445305] Starting subtest: plane-position-hole-dpms
[130.204446] Starting dynamic subtest: pipe-A-plane-1
[131.064186] Dynamic subtest pipe-A-plane-1: SUCCESS (0.856s)
[131.106412] Starting dynamic subtest: pipe-A-plane-2
[131.877772] Dynamic subtest pipe-A-plane-2: SUCCESS (0.814s)
[131.920363] Starting dynamic subtest: pipe-A-plane-3
[132.713613] Dynamic subtest pipe-A-plane-3: SUCCESS (0.833s)
[132.737139] Starting dynamic subtest: pipe-A-plane-4
[132.741356] Dynamic subtest pipe-A-plane-4: SUCCESS (0.015s)
[133.240644] Starting dynamic subtest: pipe-B-plane-1
[134.023051] Dynamic subtest pipe-B-plane-1: SUCCESS (0.821s)
[134.071527] Starting dynamic subtest: pipe-B-plane-2
[134.810047] Dynamic subtest pipe-B-plane-2: SUCCESS (0.787s)
[134.853246] Starting dynamic subtest: pipe-B-plane-3
[135.643240] Dynamic subtest pipe-B-plane-3: SUCCESS (0.828s)
[135.679221] Starting dynamic subtest: pipe-B-plane-4
[135.685298] Dynamic subtest pipe-B-plane-4: SUCCESS (0.014s)
[135.689035] Subtest plane-position-hole-dpms: SUCCESS (6.217s)
[135.965089] [027/133] (925s left) vgem_basic (setversion)
[136.174085] Starting subtest: setversion
[136.178611] Subtest setversion: SUCCESS (0.000s)
[136.285865] [FACT vgem_basic (setversion)] new: kernel.kmod_is_loaded.vgem: true
[136.289860] [028/133] (925s left) kms_flip (2x-flip-vs-dpms-on-nop)
[136.484435] Starting subtest: 2x-flip-vs-dpms-on-nop
[136.486719] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[138.213698] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (1.724s)
[138.239298] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[139.871082] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (1.652s)
[139.896307] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[141.528048] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (1.650s)
[141.533206] Subtest 2x-flip-vs-dpms-on-nop: SUCCESS (5.048s)
[142.190700] [029/133] (919s left) kms_addfb_basic (invalid-get-prop)
[142.312287] Starting subtest: invalid-get-prop
[142.314103] Subtest invalid-get-prop: SUCCESS (0.000s)
[142.539488] [030/133] (919s left) perf_pmu (busy-idle-no-semaphores)
[142.656802] Starting subtest: busy-idle-no-semaphores
[142.657974] Starting dynamic subtest: rcs0
[143.289665] Dynamic subtest rcs0: SUCCESS (0.633s)
[143.314469] Starting dynamic subtest: bcs0
[143.922103] Dynamic subtest bcs0: SUCCESS (0.630s)
[143.948098] Starting dynamic subtest: vcs0
[144.560816] Dynamic subtest vcs0: SUCCESS (0.636s)
[144.584352] Starting dynamic subtest: vecs0
[145.197259] Dynamic subtest vecs0: SUCCESS (0.632s)
[145.199130] Subtest busy-idle-no-semaphores: SUCCESS (2.542s)
[145.390951] [031/133] (916s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[145.599360] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[145.602414] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[145.742580] [032/133] (916s left) gem_softpin (32b-excludes-last-page)
[145.857870] Starting subtest: 32b-excludes-last-page
[145.860754] Subtest 32b-excludes-last-page: SUCCESS (0.005s)
[146.006768] [033/133] (915s left) kms_cursor_edge_walk (256x256-left-edge)
[146.199071] Starting subtest: 256x256-left-edge
[146.199955] Starting dynamic subtest: pipe-A-HDMI-A-1
[150.098136] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.896s)
[150.146243] Starting dynamic subtest: pipe-C-HDMI-A-1
[153.498401] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.397s)
[153.501083] Subtest 256x256-left-edge: SUCCESS (7.305s)
[153.808249] [034/133] (908s left) kms_dsc (dsc-fractional-bpp)
[153.991840] Subtest dsc-fractional-bpp: SKIP (0.000s)
[154.103723] [035/133] (908s left) gem_ctx_param (invalid-set-ringsize)
[154.217072] Starting subtest: invalid-set-ringsize
[154.218381] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[154.362796] [036/133] (907s left) gem_ccs (ctrl-surf-copy-new-ctx)
[154.477416] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[154.587223] [037/133] (907s left) kms_vblank (query-busy)
[154.768071] Starting subtest: query-busy
[154.774698] Starting dynamic subtest: pipe-A-HDMI-A-1
[157.616387] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.843s)
[157.665063] Starting dynamic subtest: pipe-A-HDMI-A-2
[160.241943] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.618s)
[160.294093] Starting dynamic subtest: pipe-C-HDMI-A-1
[162.829944] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.580s)
[162.871359] Starting dynamic subtest: pipe-C-HDMI-A-2
[165.434273] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.599s)
[165.435793] Subtest query-busy: SUCCESS (10.666s)
[165.769301] [038/133] (896s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[165.982222] Starting subtest: fbc-rgb101010-draw-blt
[169.025596] Subtest fbc-rgb101010-draw-blt: SUCCESS (3.044s)
[169.306295] [039/133] (893s left) gem_exec_balancer (invalid-balancer)
[169.438206] Starting subtest: invalid-balancer
[173.946914] Subtest invalid-balancer: SUCCESS (4.509s)
[174.254105] [040/133] (888s left) gem_ctx_sseu (invalid-args)
[174.374131] Subtest invalid-args: SKIP (0.000s)
[174.492934] [041/133] (888s left) gem_create (create-invalid-size)
[174.596221] Starting subtest: create-invalid-size
[174.598135] Subtest create-invalid-size: SUCCESS (0.000s)
[174.876485] [042/133] (887s left) perf_pmu (frequency)
[174.992575] Starting subtest: frequency
[174.996738] Starting dynamic subtest: gt0
[177.084231] Dynamic subtest gt0: SUCCESS (2.084s)
[177.106845] Starting dynamic subtest: idle-gt0
[177.592582] Dynamic subtest idle-gt0: SUCCESS (0.506s)
[177.597563] Subtest frequency: SUCCESS (2.605s)
[177.770404] [043/133] (885s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[177.884701] Starting subtest: multi-wait-available-submitted-signaled
[177.892122] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.003s)
[178.039858] [044/133] (884s left) kms_psr (fbc-psr-cursor-render)
[178.216128] Subtest fbc-psr-cursor-render: SKIP (0.000s)
[178.332245] [045/133] (884s left) gem_wait (write-wait)
[178.474980] Starting subtest: write-wait
[178.477660] Starting dynamic subtest: all-engines
[179.531067] Dynamic subtest all-engines: SUCCESS (1.059s)
[179.561099] Starting dynamic subtest: rcs0
[180.569903] Dynamic subtest rcs0: SUCCESS (1.035s)
[180.599823] Starting dynamic subtest: bcs0
[181.607139] Dynamic subtest bcs0: SUCCESS (1.035s)
[181.638436] Starting dynamic subtest: vcs0
[182.652093] Dynamic subtest vcs0: SUCCESS (1.042s)
[182.682028] Starting dynamic subtest: vecs0
[183.691452] Dynamic subtest vecs0: SUCCESS (1.036s)
[183.694275] Subtest write-wait: SUCCESS (5.219s)
[183.990890] [046/133] (879s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[184.184880] Starting subtest: fbcpsr-rgb565-draw-blt
[184.188153] Subtest fbcpsr-rgb565-draw-blt: SKIP (0.000s)
[184.340729] [047/133] (878s left) gem_workarounds (suspend-resume-fd)
[184.488974] Starting subtest: suspend-resume-fd