[49.005597] Initializing watchdogs
[49.005662]   /dev/watchdog0
[49.022749] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[49.028998] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[49.031593] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[49.033545] [001/132] (960s left) gen9_exec_parse (basic-rejected-ctx-param)
[49.079024] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[49.121686] [002/132] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[49.216804] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[49.218207] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[49.297045] [003/132] (960s left) syncobj_timeline (32bits-limit)
[49.330838] Starting subtest: 32bits-limit
[49.332273] Subtest 32bits-limit: SUCCESS (0.001s)
[49.384985] [004/132] (960s left) gem_exec_schedule (lateslice)
[49.428520] Starting subtest: lateslice
[49.429255] Starting dynamic subtest: rcs0
[49.447156] Dynamic subtest rcs0: SUCCESS (0.018s)
[49.453586] Starting dynamic subtest: bcs0
[49.462970] Dynamic subtest bcs0: SUCCESS (0.015s)
[49.468877] Starting dynamic subtest: vcs0
[49.480169] Dynamic subtest vcs0: SUCCESS (0.016s)
[49.487869] Starting dynamic subtest: vcs1
[49.500079] Dynamic subtest vcs1: SUCCESS (0.019s)
[49.506509] Starting dynamic subtest: vecs0
[49.519150] Dynamic subtest vecs0: SUCCESS (0.018s)
[49.520013] Subtest lateslice: SUCCESS (0.088s)
[49.829324] [005/132] (959s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[49.920062] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[49.957353] [006/132] (959s left) kms_content_protection (legacy-hdcp14)
[50.051571] Starting subtest: legacy-hdcp14
[50.066795] Subtest legacy-hdcp14: SKIP (0.013s)
[50.145433] [007/132] (959s left) gem_gpgpu_fill (basic)
[50.181737] Starting subtest: basic
[50.182450] Starting dynamic subtest: smem
[50.186929] Dynamic subtest smem: SUCCESS (0.005s)
[50.187701] Subtest basic: SUCCESS (0.005s)
[50.301105] [008/132] (959s left) kms_big_fb (linear-16bpp-rotate-270)
[50.399371] Starting subtest: linear-16bpp-rotate-270
[50.487159] Subtest linear-16bpp-rotate-270: SKIP (0.085s)
[50.569889] [009/132] (959s left) gem_exec_reloc (basic-write-read-noreloc)
[50.610711] Starting subtest: basic-write-read-noreloc
[50.613944] Subtest basic-write-read-noreloc: SUCCESS (0.003s)
[50.725342] [010/132] (959s left) gem_mmap_gtt (basic-small-copy-odd)
[50.759460] Starting subtest: basic-small-copy-odd
[52.767768] Subtest basic-small-copy-odd: SUCCESS (1.959s)
[52.828595] [011/132] (957s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[52.969669] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[53.010876] [012/132] (956s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[53.101525] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[53.102905] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[53.188487] [013/132] (956s left) kms_lease (multimaster-lease)
[53.273786] Starting subtest: multimaster-lease
[53.276085] Subtest multimaster-lease: SUCCESS (0.002s)
[53.331217] [014/132] (956s left) kms_joiner (invalid-modeset-big-joiner)
[53.418418] Starting subtest: invalid-modeset-big-joiner
[53.419769] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[53.474801] [015/132] (956s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[53.564485] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[53.565962] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[53.656762] [016/132] (956s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[53.754501] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[53.755979] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[53.844746] [017/132] (956s left) kms_dsc (dsc-with-formats)
[53.929610] Starting subtest: dsc-with-formats
[53.941413] Subtest dsc-with-formats: SKIP (0.001s)
[53.984017] [018/132] (956s left) core_setmaster (master-drop-set-user)
[54.072777] Starting subtest: master-drop-set-user
[54.098787] Subtest master-drop-set-user: SUCCESS (0.026s)
[54.143385] [019/132] (956s left) kms_psr (pr-sprite-mmap-cpu)
[54.228460] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[54.268592] [020/132] (955s left) perf_pmu (init-wait)
[54.306765] Starting subtest: init-wait
[54.307509] Starting dynamic subtest: rcs0
[54.308251] Dynamic subtest rcs0: SUCCESS (0.001s)
[54.316570] Starting dynamic subtest: bcs0
[54.317303] Dynamic subtest bcs0: SUCCESS (0.000s)
[54.323663] Starting dynamic subtest: vcs0
[54.324348] Dynamic subtest vcs0: SUCCESS (0.001s)
[54.330521] Starting dynamic subtest: vcs1
[54.331206] Dynamic subtest vcs1: SUCCESS (0.001s)
[54.338565] Starting dynamic subtest: vecs0
[54.339340] Dynamic subtest vecs0: SUCCESS (0.001s)
[54.340085] Subtest init-wait: SUCCESS (0.005s)
[54.367610] [021/132] (955s left) gem_pxp (display-protected-crc)
[54.470432] Starting subtest: display-protected-crc
[55.039910] Subtest display-protected-crc: SUCCESS (0.561s)
[55.147830] [022/132] (955s left) gem_exec_reloc (basic-cpu-read-noreloc)
[55.186176] Starting subtest: basic-cpu-read-noreloc
[55.189059] Subtest basic-cpu-read-noreloc: SUCCESS (0.003s)
[55.298057] [023/132] (954s left) kms_vblank (wait-forked-hang)
[55.383443] Starting subtest: wait-forked-hang
[55.384929] Starting dynamic subtest: pipe-A-HDMI-A-1
[69.786805] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.303s)
[69.796382] Starting dynamic subtest: pipe-D-HDMI-A-1
[83.591034] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.786s)
[83.592469] Subtest wait-forked-hang: SUCCESS (28.095s)
[83.731804] [024/132] (926s left) prime_vgem (sync)
[83.831061] Starting subtest: sync
[83.831834] Starting dynamic subtest: rcs0
[83.868978] Dynamic subtest rcs0: SUCCESS (0.037s)
[83.883125] Starting dynamic subtest: bcs0
[83.886339] Dynamic subtest bcs0: SUCCESS (0.017s)
[83.893972] Starting dynamic subtest: vcs0
[83.905783] Dynamic subtest vcs0: SUCCESS (0.019s)
[83.914766] Starting dynamic subtest: vcs1
[83.925285] Dynamic subtest vcs1: SUCCESS (0.019s)
[83.932900] Starting dynamic subtest: vecs0
[83.950499] Dynamic subtest vecs0: SUCCESS (0.025s)
[83.951438] Subtest sync: SUCCESS (0.120s)
[84.060938] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true
[84.062500] [025/132] (926s left) syncobj_timeline (etime-single-wait-submitted)
[84.096387] Starting subtest: etime-single-wait-submitted
[84.198624] Subtest etime-single-wait-submitted: SUCCESS (0.101s)
[84.274279] [026/132] (926s left) kms_chamelium_color (ctm-green-to-red)
[84.361341] Subtest ctm-green-to-red: SKIP (0.000s)
[84.402202] [027/132] (926s left) prime_udl
[84.483525] [028/132] (926s left) gem_exec_schedule (preempt-self)
[84.529454] Starting subtest: preempt-self
[84.530213] Starting dynamic subtest: rcs0
[84.542840] Dynamic subtest rcs0: SUCCESS (0.013s)
[84.550129] Starting dynamic subtest: bcs0
[84.556390] Dynamic subtest bcs0: SUCCESS (0.013s)
[84.563250] Starting dynamic subtest: vcs0
[84.568913] Dynamic subtest vcs0: SUCCESS (0.012s)
[84.575707] Starting dynamic subtest: vcs1
[84.581097] Dynamic subtest vcs1: SUCCESS (0.012s)
[84.589075] Starting dynamic subtest: vecs0
[84.594245] Dynamic subtest vecs0: SUCCESS (0.013s)
[84.594967] Subtest preempt-self: SUCCESS (0.065s)
[84.919059] [029/132] (925s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[85.006347] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[86.102456] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (1.095s)
[86.229984] [030/132] (924s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[86.320450] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[86.321813] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[86.423395] [031/132] (924s left) gem_mmap_offset (perf)
[86.456175] Starting subtest: perf
[86.457299] Starting dynamic subtest: smem0
[86.658323] Dynamic subtest smem0: SUCCESS (0.202s)
[86.659084] Subtest perf: SUCCESS (0.202s)
[86.756303] [032/132] (923s left) gem_exec_reloc (basic-gtt-noreloc)
[86.795085] Starting subtest: basic-gtt-noreloc
[86.799574] Subtest basic-gtt-noreloc: SUCCESS (0.004s)
[86.910631] [033/132] (923s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[86.998437] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[86.999781] Subtest psr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[87.099907] [034/132] (923s left) gem_mmap_gtt (cpuset-basic-small-copy)
[87.134282] Starting subtest: cpuset-basic-small-copy
[90.208094] Subtest cpuset-basic-small-copy: SUCCESS (3.072s)
[90.265193] [035/132] (920s left) syncobj_basic (illegal-fd-to-handle)
[90.346821] Starting subtest: illegal-fd-to-handle
[90.347541] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[90.421290] [036/132] (920s left) syncobj_timeline (wait-all-interrupted)
[90.462291] Starting subtest: wait-all-interrupted
[90.565803] Subtest wait-all-interrupted: SUCCESS (0.103s)
[90.635544] [037/132] (920s left) gem_softpin (noreloc-interruptible)
[90.676092] Starting subtest: noreloc-interruptible
[96.106593] Subtest noreloc-interruptible: SUCCESS (5.418s)
[96.196145] [038/132] (914s left) syncobj_timeline (invalid-signal-illegal-handle)
[96.227951] Starting subtest: invalid-signal-illegal-handle
[96.228647] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[96.290563] [039/132] (914s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[96.324221] Starting subtest: multi-wait-available-submitted-signaled
[96.324980] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s)
[96.386465] [040/132] (914s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[96.477564] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[96.521141] [041/132] (914s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[96.609353] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[96.610792] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[96.714324] [042/132] (914s left) api_intel_bb (lot-of-buffers)
[96.747480] Starting subtest: lot-of-buffers
[98.093810] Subtest lot-of-buffers: SUCCESS (1.337s)
[98.202936] [043/132] (912s left) kms_rotation_crc (exhaust-fences)
[98.290271] Starting subtest: exhaust-fences
[99.417226] Subtest exhaust-fences: SUCCESS (1.127s)
[99.504920] [044/132] (911s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[99.595450] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[99.596808] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[99.696542] [045/132] (911s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[99.782886] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[99.783976] Starting dynamic subtest: pipe-A
[101.030315] Dynamic subtest pipe-A: SUCCESS (1.248s)
[101.043480] Starting dynamic subtest: pipe-B
[102.316214] Dynamic subtest pipe-B: SUCCESS (1.285s)
[102.326721] Starting dynamic subtest: pipe-C
[102.517264] Dynamic subtest pipe-C: SUCCESS (0.201s)
[102.524646] Starting dynamic subtest: pipe-D
[102.718010] Dynamic subtest pipe-D: SUCCESS (0.200s)
[102.719370] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (2.935s)
[102.894907] [046/132] (908s left) i915_suspend (basic-s3-without-i915)
[102.929517] Starting subtest: basic-s3-without-i915