[89.870781] Initializing watchdogs
[89.871019]   /dev/watchdog0
[89.912841] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[89.927708] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[89.937772] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[89.944412] [001/132] (960s left) gem_mmap_offset (ptrace)
[90.063400] Starting subtest: ptrace
[90.071313] Starting dynamic subtest: smem0-gtt
[90.139414] Dynamic subtest smem0-gtt: SUCCESS (0.066s)
[90.157275] Starting dynamic subtest: smem0-wb
[90.194231] Dynamic subtest smem0-wb: SUCCESS (0.055s)
[90.212229] Starting dynamic subtest: smem0-wc
[90.251068] Dynamic subtest smem0-wc: SUCCESS (0.056s)
[90.271096] Starting dynamic subtest: smem0-uc
[90.312415] Dynamic subtest smem0-uc: SUCCESS (0.057s)
[90.313927] Subtest ptrace: SUCCESS (0.250s)
[90.480209] [002/132] (960s left) kms_lease (lease-uevent)
[90.671671] Starting subtest: lease-uevent
[91.716300] Subtest lease-uevent: SUCCESS (1.046s)
[91.872569] [003/132] (958s left) gem_exec_fence (submit-chain)
[92.141916] Starting subtest: submit-chain
[92.167588] Subtest submit-chain: SUCCESS (0.028s)
[92.948245] [FACT gem_exec_fence (submit-chain)] new: kernel.kmod_is_loaded.vgem: true
[92.953745] [004/132] (957s left) perf_pmu (init-sema)
[93.071084] Starting subtest: init-sema
[93.074284] Starting dynamic subtest: rcs0
[93.076627] Dynamic subtest rcs0: SUCCESS (0.004s)
[93.107040] Starting dynamic subtest: bcs0
[93.109613] Dynamic subtest bcs0: SUCCESS (0.002s)
[93.129767] Starting dynamic subtest: vcs0
[93.131573] Dynamic subtest vcs0: SUCCESS (0.001s)
[93.150893] Starting dynamic subtest: vecs0
[93.152081] Dynamic subtest vecs0: SUCCESS (0.003s)
[93.153115] Subtest init-sema: SUCCESS (0.012s)
[93.237393] [005/132] (957s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[93.437272] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[93.440473] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[93.616787] [006/132] (957s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[93.760145] Starting subtest: stress-mm-invalidate-close-overlap
[95.908199] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.149s)
[96.087058] [007/132] (954s left) gem_lmem_swapping (parallel-random-engines)
[96.204096] Subtest parallel-random-engines: SKIP (0.000s)
[96.309227] [008/132] (954s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[96.518520] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[99.027973] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (2.510s)
[99.337316] [009/132] (951s left) gem_exec_schedule (u-submit-golden-slice)
[99.503638] Starting subtest: u-submit-golden-slice
[99.509809] Starting dynamic subtest: rcs0
[99.575176] Dynamic subtest rcs0: SUCCESS (0.065s)
[99.601114] Starting dynamic subtest: bcs0
[99.628319] Dynamic subtest bcs0: SUCCESS (0.056s)
[99.654403] Starting dynamic subtest: vcs0
[99.685106] Dynamic subtest vcs0: SUCCESS (0.053s)
[99.709578] Starting dynamic subtest: vecs0
[99.738252] Dynamic subtest vecs0: SUCCESS (0.053s)
[99.742478] Subtest u-submit-golden-slice: SUCCESS (0.234s)
[100.141492] [010/132] (951s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[100.359219] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[102.140308] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.782s)
[102.450449] [011/132] (948s left) gem_workarounds (basic-read-fd)
[102.586126] Starting subtest: basic-read-fd
[102.610786] Subtest basic-read-fd: SUCCESS (0.022s)
[102.785959] [012/132] (948s left) syncobj_timeline (reset-during-wait-for-submit)
[102.887831] Starting subtest: reset-during-wait-for-submit
[102.998658] Subtest reset-during-wait-for-submit: SUCCESS (0.107s)
[103.151601] [013/132] (948s left) kms_hdr (bpc-switch)
[103.329073] Starting subtest: bpc-switch
[132.018267] Subtest bpc-switch: SKIP (28.685s)
[132.555468] [014/132] (919s left) kms_async_flips (test-time-stamp)
[132.778599] Starting subtest: test-time-stamp
[133.402369] Starting dynamic subtest: pipe-A-HDMI-A-1
[133.589675] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.189s)
[133.956473] Starting dynamic subtest: pipe-A-HDMI-A-2
[134.131099] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.194s)
[134.501239] Starting dynamic subtest: pipe-B-HDMI-A-1
[134.748580] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.266s)
[135.112737] Starting dynamic subtest: pipe-B-HDMI-A-2
[135.306449] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.215s)
[135.663718] Starting dynamic subtest: pipe-C-HDMI-A-1
[135.833460] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.192s)
[136.213596] Starting dynamic subtest: pipe-C-HDMI-A-2
[136.383880] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.199s)
[136.385186] Subtest test-time-stamp: SUCCESS (3.603s)
[137.026519] [015/132] (914s left) kms_psr (pr-primary-mmap-gtt)
[137.232562] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[137.352561] [016/132] (914s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[137.534567] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[137.650518] [017/132] (914s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[137.778097] Starting subtest: no-spare-fences-busy
[139.966970] Subtest no-spare-fences-busy: SUCCESS (2.185s)
[140.125832] [018/132] (911s left) vgem_basic (bad-flag)
[140.252681] Starting subtest: bad-flag
[140.254111] Subtest bad-flag: SUCCESS (0.000s)
[140.373311] [019/132] (911s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[140.589443] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[142.606284] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SUCCESS (2.012s)
[142.858566] [020/132] (909s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[142.966490] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[143.071752] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.105s)
[143.210275] [021/132] (909s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[143.406578] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (0.000s)
[143.521189] [022/132] (908s left) syncobj_timeline (single-wait-available-signaled)
[143.631779] Starting subtest: single-wait-available-signaled
[143.633370] Subtest single-wait-available-signaled: SUCCESS (0.001s)
[143.791451] [023/132] (908s left) kms_content_protection (lic-type-1)
[144.001276] Starting subtest: lic-type-1
[144.022894] Subtest lic-type-1: SKIP (0.019s)
[144.179445] [024/132] (908s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[144.426388] Subtest parallel-dmabuf-import-out-fence: SKIP (0.000s)
[144.596286] [025/132] (908s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[144.813558] Starting subtest: psr-rgb565-draw-mmap-gtt
[144.816540] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[144.967727] [026/132] (907s left) gem_pwrite_snooped
[145.261361] [027/132] (907s left) gem_ringfill (engines-basic)
[145.635441] Starting subtest: engines-basic
[145.639801] Starting dynamic subtest: rcs0
[145.662281] Dynamic subtest rcs0: SUCCESS (0.023s)
[145.697998] Starting dynamic subtest: bcs0
[145.699731] Dynamic subtest bcs0: SUCCESS (0.022s)
[145.724042] Starting dynamic subtest: vcs0
[145.725346] Dynamic subtest vcs0: SUCCESS (0.020s)
[145.750266] Starting dynamic subtest: vecs0
[145.751691] Dynamic subtest vecs0: SUCCESS (0.019s)
[145.753388] Subtest engines-basic: SUCCESS (0.099s)
[145.891243] [028/132] (907s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[146.101628] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[146.105857] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[146.258347] [029/132] (906s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[146.455856] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[146.458577] Starting dynamic subtest: pipe-A
[146.847240] Dynamic subtest pipe-A: SUCCESS (0.391s)
[146.873828] Starting dynamic subtest: pipe-B
[147.261656] Dynamic subtest pipe-B: SUCCESS (0.411s)
[147.304123] Starting dynamic subtest: pipe-C
[147.341076] Dynamic subtest pipe-C: SUCCESS (0.077s)
[147.344470] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (0.891s)
[147.822516] [030/132] (905s left) kms_psr (fbc-psr2-no-drrs)
[148.029051] Subtest fbc-psr2-no-drrs: SKIP (0.000s)
[148.147553] [031/132] (905s left) gem_exec_params (invalid-ring)
[148.260289] Starting subtest: invalid-ring
[148.262157] Subtest invalid-ring: SUCCESS (0.001s)
[148.425845] [032/132] (904s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[148.533885] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[148.536299] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.001s)
[148.706966] [033/132] (904s left) gem_ctx_persistence (engines-persistence)
[148.822659] Starting subtest: engines-persistence
[148.823932] Starting dynamic subtest: rcs0
[149.552540] Dynamic subtest rcs0: SUCCESS (0.729s)
[149.579598] Starting dynamic subtest: bcs0
[150.326957] Dynamic subtest bcs0: SUCCESS (0.768s)
[150.351424] Starting dynamic subtest: vcs0
[151.089918] Dynamic subtest vcs0: SUCCESS (0.761s)
[151.116944] Starting dynamic subtest: vecs0
[151.865865] Dynamic subtest vecs0: SUCCESS (0.772s)
[151.868926] Subtest engines-persistence: SUCCESS (3.046s)
[152.027138] [034/132] (901s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[152.235215] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[152.237466] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[152.406581] [035/132] (901s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[152.616312] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[152.620058] Subtest psr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[152.775352] [036/132] (901s left) perf (invalid-oa-format-id)
[152.996478] Starting subtest: invalid-oa-format-id
[153.023454] Subtest invalid-oa-format-id: SUCCESS (0.030s)
[153.141570] [037/132] (900s left) gem_busy (semaphore)
[153.413062] Starting subtest: semaphore
[153.414364] Starting dynamic subtest: rcs0
[153.437963] Dynamic subtest rcs0: SUCCESS (0.026s)
[153.462297] Starting dynamic subtest: bcs0
[153.476766] Dynamic subtest bcs0: SUCCESS (0.034s)
[153.514863] Starting dynamic subtest: vcs0
[153.517518] Dynamic subtest vcs0: SUCCESS (0.023s)
[153.539096] Starting dynamic subtest: vecs0
[153.540361] Dynamic subtest vecs0: SUCCESS (0.021s)
[153.541381] Subtest semaphore: SUCCESS (0.128s)
[153.810944] [038/132] (900s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[154.011783] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[157.010989] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (3.001s)
[157.254728] [039/132] (896s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[157.461104] Starting subtest: x-tiled-8bpp-rotate-270
[157.767530] Subtest x-tiled-8bpp-rotate-270: SKIP (0.305s)
[158.027706] [040/132] (896s left) gem_mmap_gtt (basic-short)
[158.139477] Starting subtest: basic-short
[158.167315] Subtest basic-short: SUCCESS (0.028s)
[158.325906] [041/132] (895s left) kms_plane_multiple (2x-tiling-none)
[158.511163] Starting subtest: 2x-tiling-none
[158.521480] Starting dynamic subtest: pipe-A-HDMI-A-1-pipe-B-HDMI-A-2
[158.964747] Dynamic subtest pipe-A-HDMI-A-1-pipe-B-HDMI-A-2: SUCCESS (0.449s)
[159.015527] Starting dynamic subtest: pipe-A-HDMI-A-1-pipe-C-HDMI-A-2
[159.733087] Dynamic subtest pipe-A-HDMI-A-1-pipe-C-HDMI-A-2: SUCCESS (0.746s)
[159.780490] Starting dynamic subtest: pipe-A-HDMI-A-2-pipe-B-HDMI-A-1
[160.702655] Dynamic subtest pipe-A-HDMI-A-2-pipe-B-HDMI-A-1: SUCCESS (0.948s)
[160.745748] Starting dynamic subtest: pipe-A-HDMI-A-2-pipe-C-HDMI-A-1
[161.432040] Dynamic subtest pipe-A-HDMI-A-2-pipe-C-HDMI-A-1: SUCCESS (0.707s)
[161.506079] Starting dynamic subtest: pipe-B-HDMI-A-1-pipe-A-HDMI-A-2
[162.165931] Dynamic subtest pipe-B-HDMI-A-1-pipe-A-HDMI-A-2: SUCCESS (0.692s)
[162.208324] Starting dynamic subtest: pipe-B-HDMI-A-1-pipe-C-HDMI-A-2
[162.945148] Dynamic subtest pipe-B-HDMI-A-1-pipe-C-HDMI-A-2: SUCCESS (0.757s)
[162.996556] Starting dynamic subtest: pipe-B-HDMI-A-2-pipe-A-HDMI-A-1
[163.843876] Dynamic subtest pipe-B-HDMI-A-2-pipe-A-HDMI-A-1: SUCCESS (0.876s)
[163.889062] Starting dynamic subtest: pipe-B-HDMI-A-2-pipe-C-HDMI-A-1
[164.601295] Dynamic subtest pipe-B-HDMI-A-2-pipe-C-HDMI-A-1: SUCCESS (0.735s)
[164.654655] Starting dynamic subtest: pipe-C-HDMI-A-1-pipe-A-HDMI-A-2
[165.311523] Dynamic subtest pipe-C-HDMI-A-1-pipe-A-HDMI-A-2: SUCCESS (0.688s)
[165.357116] Starting dynamic subtest: pipe-C-HDMI-A-1-pipe-B-HDMI-A-2
[166.056925] Dynamic subtest pipe-C-HDMI-A-1-pipe-B-HDMI-A-2: SUCCESS (0.723s)
[166.102093] Starting dynamic subtest: pipe-C-HDMI-A-2-pipe-A-HDMI-A-1
[167.004469] Dynamic subtest pipe-C-HDMI-A-2-pipe-A-HDMI-A-1: SUCCESS (0.922s)
[167.061344] Starting dynamic subtest: pipe-C-HDMI-A-2-pipe-B-HDMI-A-1
[167.719464] Dynamic subtest pipe-C-HDMI-A-2-pipe-B-HDMI-A-1: SUCCESS (0.694s)
[167.754067] Subtest 2x-tiling-none: SUCCESS (9.244s)
[168.456460] [042/132] (885s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[169.090921] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[169.383899] [043/132] (885s left) syncobj_wait (wait-any-complex)
[169.505686] Starting subtest: wait-any-complex
[169.570349] Subtest wait-any-complex: SUCCESS (0.067s)
[169.729679] [044/132] (884s left) gem_mmap_wc (coherency)
[169.838314] Starting subtest: coherency
[169.912371] Subtest coherency: SUCCESS (0.077s)
[170.065561] [045/132] (884s left) syncobj_wait (reset-multiple-signaled)
[170.171117] Starting subtest: reset-multiple-signaled
[170.173097] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[170.344667] [046/132] (884s left) gen9_exec_parse (bb-secure)
[170.474761] Starting subtest: bb-secure
[170.476123] Subtest bb-secure: SUCCESS (0.004s)
[170.750236] [047/132] (884s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[170.872926] Starting subtest: x-tiled-to-vebox-y-tiled
[170.876154] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[171.132203] [048/132] (883s left) gem_workarounds (suspend-resume)
[171.278134] Starting subtest: suspend-resume