[90.463894] Initializing watchdogs
[90.464143]   /dev/watchdog0
[90.502664] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[90.518052] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[90.525599] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[90.531835] [001/133] (960s left) kms_psr (fbc-psr2-suspend)
[90.732192] Subtest fbc-psr2-suspend: SKIP (0.000s)
[90.827032] [002/133] (960s left) gem_vm_create (execbuf)
[90.946045] Starting subtest: execbuf
[90.959599] Subtest execbuf: SUCCESS (0.011s)
[91.117370] [003/133] (960s left) prime_vgem (basic-fence-blt)
[91.322408] Starting subtest: basic-fence-blt
[91.443822] Subtest basic-fence-blt: SUCCESS (0.120s)
[91.596251] [FACT prime_vgem (basic-fence-blt)] new: kernel.kmod_is_loaded.vgem: true
[91.601311] [004/133] (959s left) gem_exec_parallel (contexts)
[91.723419] Starting subtest: contexts
[91.725615] Starting dynamic subtest: rcs0
[96.092137] Dynamic subtest rcs0: SUCCESS (4.363s)
[96.115832] Starting dynamic subtest: bcs0
[110.055567] Dynamic subtest bcs0: SUCCESS (13.960s)
[110.073522] Starting dynamic subtest: vcs0
[114.475125] Dynamic subtest vcs0: SUCCESS (4.417s)
[114.518117] Starting dynamic subtest: vecs0
[125.548196] Dynamic subtest vecs0: SUCCESS (11.072s)
[125.551214] Subtest contexts: SUCCESS (33.817s)
[125.822746] [005/133] (925s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[125.929187] Starting subtest: etime-multi-wait-available-unsubmitted
[126.037949] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.106s)
[126.171146] [006/133] (925s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[126.349083] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[126.352208] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[127.094468] [007/133] (924s left) syncobj_timeline (device-signal-unordered)
[127.199261] Starting subtest: device-signal-unordered
[127.204158] Subtest device-signal-unordered: SUCCESS (0.003s)
[127.350272] [008/133] (924s left) gem_userptr_blits (coherency-unsync)
[127.474239] Subtest coherency-unsync: SKIP (0.000s)
[127.669637] [009/133] (924s left) kms_draw_crc (draw-method-mmap-cpu)
[127.850080] Starting subtest: draw-method-mmap-cpu
[127.852086] Starting dynamic subtest: xrgb8888-untiled
[128.340646] Dynamic subtest xrgb8888-untiled: SUCCESS (0.492s)
[128.361224] Starting dynamic subtest: rgb565-untiled
[128.605273] Dynamic subtest rgb565-untiled: SUCCESS (0.263s)
[128.624172] Starting dynamic subtest: xrgb2101010-untiled
[128.870290] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.266s)
[128.893077] Starting dynamic subtest: xbgr16161616f-untiled
[129.152880] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.283s)
[129.171618] Starting dynamic subtest: xrgb8888-xtiled
[129.337138] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.183s)
[129.356091] Starting dynamic subtest: rgb565-xtiled
[129.520349] Dynamic subtest rgb565-xtiled: SUCCESS (0.182s)
[129.539080] Starting dynamic subtest: xrgb2101010-xtiled
[129.685414] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.163s)
[129.704830] Starting dynamic subtest: xbgr16161616f-xtiled
[129.869042] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.183s)
[129.889082] Starting dynamic subtest: xrgb8888-ytiled
[130.058046] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.184s)
[130.076991] Starting dynamic subtest: rgb565-ytiled
[130.238938] Dynamic subtest rgb565-ytiled: SUCCESS (0.180s)
[130.258258] Starting dynamic subtest: xrgb2101010-ytiled
[130.405531] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.165s)
[130.424177] Starting dynamic subtest: xbgr16161616f-ytiled
[130.587325] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.182s)
[130.589716] Subtest draw-method-mmap-cpu: SUCCESS (2.740s)
[130.829924] [010/133] (921s left) prime_mmap (test_forked)
[130.936068] Starting subtest: test_forked
[130.937751] Starting dynamic subtest: test_forked-smem
[130.968801] Dynamic subtest test_forked-smem: SUCCESS (0.033s)
[130.970611] Subtest test_forked: SUCCESS (0.034s)
[131.115813] [011/133] (920s left) kms_plane (pixel-format-y-tiled-modifier)
[131.294083] Starting subtest: pixel-format-y-tiled-modifier
[131.536987] Starting dynamic subtest: pipe-A-plane-0
[132.404400] Dynamic subtest pipe-A-plane-0: SUCCESS (0.866s)
[132.423738] Starting dynamic subtest: pipe-A-plane-1
[133.205700] Dynamic subtest pipe-A-plane-1: SUCCESS (0.799s)
[133.224570] Starting dynamic subtest: pipe-A-plane-2
[133.786941] Dynamic subtest pipe-A-plane-2: SUCCESS (0.582s)
[133.806363] Starting dynamic subtest: pipe-A-plane-3
[134.352955] Dynamic subtest pipe-A-plane-3: SUCCESS (0.566s)
[134.371643] Starting dynamic subtest: pipe-A-plane-4
[134.380372] Dynamic subtest pipe-A-plane-4: SKIP (0.000s)
[134.744561] Starting dynamic subtest: pipe-B-plane-0
[135.479445] Dynamic subtest pipe-B-plane-0: SUCCESS (0.750s)
[135.499405] Starting dynamic subtest: pipe-B-plane-1
[136.245312] Dynamic subtest pipe-B-plane-1: SUCCESS (0.766s)
[136.263261] Starting dynamic subtest: pipe-B-plane-2
[136.828187] Dynamic subtest pipe-B-plane-2: SUCCESS (0.583s)
[136.846473] Starting dynamic subtest: pipe-B-plane-3
[137.394767] Dynamic subtest pipe-B-plane-3: SUCCESS (0.566s)
[137.416426] Starting dynamic subtest: pipe-B-plane-4
[137.423310] Dynamic subtest pipe-B-plane-4: SKIP (0.000s)
[137.612557] Subtest pixel-format-y-tiled-modifier: SUCCESS (6.316s)
[137.957284] [012/133] (914s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[138.154813] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[138.165667] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[138.305976] [013/133] (913s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[138.417110] Starting subtest: untiled-to-tiled
[138.545652] Subtest untiled-to-tiled: SUCCESS (0.126s)
[138.689425] [014/133] (913s left) i915_hangman (gt-engine-hang)
[138.813149] Starting subtest: gt-engine-hang
[138.818212] Starting dynamic subtest: rcs0
[139.396972] Dynamic subtest rcs0: SUCCESS (0.583s)
[139.419383] Starting dynamic subtest: bcs0
[139.981762] Dynamic subtest bcs0: SUCCESS (0.583s)
[140.002391] Starting dynamic subtest: vcs0
[140.557053] Dynamic subtest vcs0: SUCCESS (0.572s)
[140.576398] Starting dynamic subtest: vecs0
[141.139200] Dynamic subtest vecs0: SUCCESS (0.579s)
[141.140874] Subtest gt-engine-hang: SUCCESS (2.326s)
[141.291831] [015/133] (911s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[141.482485] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[143.497241] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (2.013s)
[143.770294] [016/133] (908s left) kms_frontbuffer_tracking (psr-2p-rte)
[143.961414] Starting subtest: psr-2p-rte
[143.966055] Subtest psr-2p-rte: SKIP (0.000s)
[144.104918] [017/133] (908s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[144.303597] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[144.307115] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[144.454348] [018/133] (908s left) kms_atomic_interruptible (legacy-pageflip)
[144.647200] Starting subtest: legacy-pageflip
[144.649065] Starting dynamic subtest: pipe-A-HDMI-A-1
[151.522294] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.870s)
[151.524458] Subtest legacy-pageflip: SUCCESS (6.875s)
[151.817703] [019/133] (900s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[152.014697] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[155.306404] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (3.291s)
[155.583393] [020/133] (897s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[155.789797] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[155.794484] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[155.948680] [021/133] (896s left) gem_mmap_gtt (fault-concurrent-x)
[156.052111] Starting subtest: fault-concurrent-X
[162.367376] Subtest fault-concurrent-X: SUCCESS (6.313s)
[162.517869] [022/133] (890s left) kms_flip (2x-wf_vblank-ts-check)
[162.726090] Starting subtest: 2x-wf_vblank-ts-check
[162.736159] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[173.892724] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (11.156s)
[173.915359] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[184.957521] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (11.060s)
[184.979988] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[195.970076] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (11.004s)
[195.973041] Subtest 2x-wf_vblank-ts-check: SUCCESS (33.242s)
[196.653857] [023/133] (856s left) syncobj_wait (wait-any-snapshot)
[196.757863] Starting subtest: wait-any-snapshot
[196.846252] Subtest wait-any-snapshot: SUCCESS (0.086s)
[196.993932] [024/133] (856s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[197.182060] Starting subtest: cursorA-vs-flipA-atomic-transitions
[208.482205] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.301s)
[208.851548] [025/133] (844s left) kms_frontbuffer_tracking (fbc-2p-rte)
[209.077211] Starting subtest: fbc-2p-rte
[213.608829] Subtest fbc-2p-rte: SUCCESS (4.533s)
[213.871642] [026/133] (839s left) gem_userptr_blits (input-checking)
[213.987230] Starting subtest: input-checking
[213.988939] Subtest input-checking: SUCCESS (0.000s)
[214.171767] [027/133] (839s left) syncobj_timeline (single-wait-for-submit-signaled)
[214.285274] Starting subtest: single-wait-for-submit-signaled
[214.288891] Subtest single-wait-for-submit-signaled: SUCCESS (0.001s)
[214.420226] [028/133] (839s left) gem_exec_capture (userptr)
[214.538347] Starting subtest: userptr
[215.827361] Subtest userptr: SUCCESS (1.293s)
[215.972847] [029/133] (837s left) kms_pipe_crc_basic (bad-source)
[216.159589] Starting subtest: bad-source
[216.161333] Subtest bad-source: SUCCESS (0.001s)
[216.305531] [030/133] (837s left) gem_exec_whisper (basic-normal-all)
[216.440549] Starting subtest: basic-normal-all
[222.905656] Subtest basic-normal-all: SUCCESS (6.465s)
[223.159628] [031/133] (830s left) perf_pmu (idle)
[223.266176] Starting subtest: idle
[223.268728] Starting dynamic subtest: rcs0
[223.777636] Dynamic subtest rcs0: SUCCESS (0.512s)
[223.802611] Starting dynamic subtest: bcs0
[224.298309] Dynamic subtest bcs0: SUCCESS (0.513s)
[224.319543] Starting dynamic subtest: vcs0
[224.817813] Dynamic subtest vcs0: SUCCESS (0.515s)
[224.838376] Starting dynamic subtest: vecs0
[225.338232] Dynamic subtest vecs0: SUCCESS (0.515s)
[225.340021] Subtest idle: SUCCESS (2.070s)
[225.493328] [032/133] (828s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[225.703593] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[225.708238] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[225.856425] [033/133] (828s left) kms_cursor_crc (cursor-random-256x85)
[226.052165] Starting subtest: cursor-random-256x85
[226.098113] Starting dynamic subtest: pipe-A-HDMI-A-1
[230.270306] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.173s)
[230.367022] Starting dynamic subtest: pipe-C-HDMI-A-1
[234.275417] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.928s)
[234.277250] Subtest cursor-random-256x85: SUCCESS (8.219s)
[234.643418] [034/133] (819s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[234.825244] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[234.830469] Starting dynamic subtest: pipe-A-valid-mode
[235.733340] Dynamic subtest pipe-A-valid-mode: SKIP (0.900s)
[235.736408] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (0.904s)
[236.304176] [035/133] (817s left) gem_exec_fence (syncobj-invalid-flags)
[236.904548] Starting subtest: syncobj-invalid-flags
[236.906648] Subtest syncobj-invalid-flags: SUCCESS (0.003s)
[237.302862] [036/133] (817s left) kms_async_flips (alternate-sync-async-flip)
[237.490138] Starting subtest: alternate-sync-async-flip
[238.094860] Starting dynamic subtest: pipe-A-HDMI-A-1
[240.311329] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.216s)
[240.684197] Starting dynamic subtest: pipe-A-HDMI-A-2
[242.829280] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.172s)
[243.221416] Starting dynamic subtest: pipe-B-HDMI-A-1
[245.384905] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.194s)
[245.745219] Starting dynamic subtest: pipe-B-HDMI-A-2
[247.898273] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.172s)
[248.258013] Starting dynamic subtest: pipe-C-HDMI-A-1
[250.481882] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.243s)
[250.835281] Starting dynamic subtest: pipe-C-HDMI-A-2
[252.995838] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.189s)
[253.000358] Subtest alternate-sync-async-flip: SUCCESS (15.508s)
[253.644727] [037/133] (800s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[253.847190] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[253.852413] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[256.299124] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (2.446s)
[256.334208] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[258.405117] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (2.093s)
[258.428198] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[260.340164] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (1.928s)
[260.341839] Subtest 2x-flip-vs-dpms-off-vs-modeset: SUCCESS (6.496s)
[260.712912] [038/133] (793s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[260.931313] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[260.936364] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.001s)
[261.084748] [039/133] (793s left) kms_psr (psr-primary-mmap-cpu)
[261.282532] Subtest psr-primary-mmap-cpu: SKIP (0.000s)
[261.396813] [040/133] (793s left) gem_softpin (noreloc-s3)
[261.520232] Starting subtest: noreloc-S3
[282.742856] Subtest noreloc-S3: SUCCESS (5.481s)
[292.923773] [041/133] (771s left) gem_exec_schedule (preempt-hang)
[293.184135] Starting subtest: preempt-hang
[293.185974] Starting dynamic subtest: rcs0
[293.449894] Dynamic subtest rcs0: SUCCESS (0.251s)
[293.477971] Starting dynamic subtest: bcs0
[293.730886] Dynamic subtest bcs0: SUCCESS (0.269s)
[293.759926] Starting dynamic subtest: vcs0
[293.979727] Dynamic subtest vcs0: SUCCESS (0.236s)
[294.009370] Starting dynamic subtest: vecs0
[294.231999] Dynamic subtest vecs0: SUCCESS (0.245s)
[294.239247] Subtest preempt-hang: SUCCESS (1.015s)
[294.528968] [042/133] (770s left) syncobj_wait (wait-all-for-submit-snapshot)
[294.636469] Starting subtest: wait-all-for-submit-snapshot
[294.722692] Subtest wait-all-for-submit-snapshot: SUCCESS (0.084s)
[294.870866] [043/133] (770s left) gen7_exec_parse (basic-rejected)
[294.990757] Subtest basic-rejected: SKIP (0.000s)
[295.113749] [044/133] (770s left) gem_exec_reloc (basic-cpu-wc-active)
[295.231846] Starting subtest: basic-cpu-wc-active
[295.370884] Subtest basic-cpu-wc-active: SUCCESS (0.136s)
[295.621498] [045/133] (769s left) gem_mmap_gtt (basic-read-write-distinct)
[295.726840] Starting subtest: basic-read-write-distinct
[295.735995] Subtest basic-read-write-distinct: SUCCESS (0.011s)
[295.895822] [046/133] (769s left) kms_atomic (plane-invalid-params)
[296.096670] Starting subtest: plane-invalid-params
[296.098302] Starting dynamic subtest: pipe-A-HDMI-A-1
[296.717972] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.606s)
[296.719737] Subtest plane-invalid-params: SUCCESS (0.612s)
[297.068549] [047/133] (768s left) gem_ctx_persistence (engines-cleanup)
[297.187891] Starting subtest: engines-cleanup
[297.189673] Starting dynamic subtest: rcs0
[297.223188] Dynamic subtest rcs0: SUCCESS (0.032s)
[297.252009] Starting dynamic subtest: bcs0
[297.259329] Dynamic subtest bcs0: SUCCESS (0.029s)
[297.288176] Starting dynamic subtest: vcs0
[297.290014] Dynamic subtest vcs0: SUCCESS (0.014s)
[297.314004] Starting dynamic subtest: vecs0
[297.320056] Dynamic subtest vecs0: SUCCESS (0.038s)
[297.322746] Subtest engines-cleanup: SUCCESS (0.132s)
[297.476852] [048/133] (768s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[297.697502] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[297.701909] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[297.848340] [049/133] (767s left) kms_lease (invalid-create-leases)
[298.045609] Starting subtest: invalid-create-leases
[298.048631] Subtest invalid-create-leases: SUCCESS (0.010s)
[298.204527] [050/133] (767s left) i915_drm_fdinfo (memory-info-shared)
[298.322752] Starting subtest: memory-info-shared
[298.325744] Starting dynamic subtest: smem0
[298.363027] Dynamic subtest smem0: SUCCESS (0.039s)
[298.368911] Subtest memory-info-shared: SUCCESS (0.042s)
[298.524000] [051/133] (767s left) syncobj_wait (invalid-wait-bad-flags)
[298.633814] Starting subtest: invalid-wait-bad-flags
[298.636666] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[298.781969] [052/133] (767s left) i915_suspend (fence-restore-untiled)
[298.891755] Starting subtest: fence-restore-untiled