[91.460301] Initializing watchdogs
[91.460498]   /dev/watchdog0
[91.499517] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3184 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 605]
[91.513466] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[91.521787] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[91.528595] [001/133] (960s left) kms_plane_multiple (tiling-none)
[91.710616] Starting subtest: tiling-none
[91.712523] Starting dynamic subtest: pipe-A-HDMI-A-1
[93.482703] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.767s)
[93.505015] Starting dynamic subtest: pipe-A-HDMI-A-2
[94.911101] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.429s)
[94.931660] Starting dynamic subtest: pipe-B-HDMI-A-1
[96.307062] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.391s)
[96.328281] Starting dynamic subtest: pipe-B-HDMI-A-2
[97.737219] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.429s)
[97.755652] Starting dynamic subtest: pipe-C-HDMI-A-1
[99.120417] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.381s)
[99.137977] Starting dynamic subtest: pipe-C-HDMI-A-2
[100.490231] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.364s)
[100.492222] Subtest tiling-none: SUCCESS (8.777s)
[100.784328] [002/133] (951s left) gem_userptr_blits (access-control)
[100.952692] Starting subtest: access-control
[100.956731] Subtest access-control: SKIP (0.000s)
[101.136596] [003/133] (951s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[101.249792] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[101.252104] Starting dynamic subtest: smem
[101.625775] Dynamic subtest smem: SUCCESS (0.374s)
[101.628079] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SUCCESS (0.375s)
[101.884400] [004/133] (950s left) gem_ctx_exec (basic-norecovery)
[101.987758] Starting subtest: basic-norecovery
[102.022502] Subtest basic-norecovery: SUCCESS (0.032s)
[102.186079] [005/133] (950s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[102.286282] Starting subtest: multi-wait-for-submit-submitted-signaled
[102.288209] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.002s)
[102.417348] [006/133] (950s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[102.603552] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[104.678114] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SUCCESS (2.074s)
[104.901335] [007/133] (947s left) gem_mmap_offset (mmap-boundaries)
[105.000321] Starting subtest: mmap-boundaries
[105.003091] Starting dynamic subtest: smem0
[105.887275] Dynamic subtest smem0: SUCCESS (0.884s)
[105.890239] Subtest mmap-boundaries: SUCCESS (0.884s)
[106.053683] [008/133] (946s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[106.227223] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.000s)
[106.325503] [009/133] (946s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[106.495262] Starting subtest: addfb25-yf-tiled-legacy
[106.497441] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[106.636618] [010/133] (946s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[106.820418] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[106.824338] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[106.970292] [011/133] (945s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[107.155221] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[107.159084] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[107.303346] [012/133] (945s left) syncobj_timeline (reset-unsignaled)
[107.404524] Starting subtest: reset-unsignaled
[107.406773] Subtest reset-unsignaled: SUCCESS (0.000s)
[107.534361] [013/133] (945s left) core_auth (basic-auth)
[107.635212] Starting subtest: basic-auth
[107.637143] Subtest basic-auth: SUCCESS (0.001s)
[107.751252] [014/133] (945s left) kms_rotation_crc (primary-rotation-180)
[107.926968] Starting subtest: primary-rotation-180
[119.244860] Subtest primary-rotation-180: SUCCESS (11.321s)
[119.488575] [015/133] (933s left) kms_cursor_crc (cursor-onscreen-32x32)
[119.668956] Starting subtest: cursor-onscreen-32x32
[119.816113] Subtest cursor-onscreen-32x32: SKIP (0.144s)
[119.972881] [016/133] (933s left) syncobj_timeline (wait-for-submit-snapshot)
[120.074198] Starting subtest: wait-for-submit-snapshot
[120.158566] Subtest wait-for-submit-snapshot: SUCCESS (0.083s)
[120.287437] [017/133] (933s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[120.386811] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[120.491188] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.103s)
[120.658354] [018/133] (932s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[120.851936] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[120.856131] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[121.004824] [019/133] (932s left) kms_big_fb (linear-addfb)
[121.194149] Starting subtest: linear-addfb
[121.196290] Subtest linear-addfb: SUCCESS (0.000s)
[121.337388] [020/133] (932s left) kms_flip (basic-flip-vs-wf_vblank)
[121.510668] Starting subtest: basic-flip-vs-wf_vblank
[121.517078] Starting dynamic subtest: A-HDMI-A1
[122.921893] Dynamic subtest A-HDMI-A1: SUCCESS (1.408s)
[122.942644] Starting dynamic subtest: B-HDMI-A1
[124.070391] Dynamic subtest B-HDMI-A1: SUCCESS (1.146s)
[124.091324] Starting dynamic subtest: C-HDMI-A1
[125.221128] Dynamic subtest C-HDMI-A1: SUCCESS (1.148s)
[125.239358] Starting dynamic subtest: A-HDMI-A2
[126.381470] Dynamic subtest A-HDMI-A2: SUCCESS (1.158s)
[126.402296] Starting dynamic subtest: B-HDMI-A2
[127.524921] Dynamic subtest B-HDMI-A2: SUCCESS (1.140s)
[127.544243] Starting dynamic subtest: C-HDMI-A2
[128.669849] Dynamic subtest C-HDMI-A2: SUCCESS (1.142s)
[128.673657] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.160s)
[129.132505] [021/133] (924s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[129.327471] Starting subtest: 4-tiled-32bpp-rotate-90
[129.331352] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.000s)
[129.482026] [022/133] (924s left) gem_mmap_gtt (medium-copy-odd)
[129.582054] Starting subtest: medium-copy-odd
[134.545980] Subtest medium-copy-odd: SUCCESS (4.965s)
[134.705695] [023/133] (919s left) kms_vblank (query-idle-hang)
[135.005986] Starting subtest: query-idle-hang
[135.008019] Starting dynamic subtest: pipe-A-HDMI-A-1
[141.885658] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.879s)
[141.906311] Starting dynamic subtest: pipe-A-HDMI-A-2
[148.911186] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (7.019s)
[148.933611] Starting dynamic subtest: pipe-C-HDMI-A-1
[155.866237] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (6.948s)
[155.885051] Starting dynamic subtest: pipe-C-HDMI-A-2
[162.906083] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (7.036s)
[162.908109] Subtest query-idle-hang: SUCCESS (27.903s)
[163.153231] [024/133] (890s left) kms_pm_dc (dc9-dpms)
[164.345365] Starting subtest: dc9-dpms
[164.351230] Subtest dc9-dpms: SKIP (0.000s)
[164.481113] [025/133] (889s left) kms_addfb_basic (invalid-set-prop)
[164.579892] Starting subtest: invalid-set-prop
[164.582144] Subtest invalid-set-prop: SUCCESS (0.000s)
[164.803872] [026/133] (889s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[164.975383] Starting subtest: basic-flip-after-cursor-legacy
[166.334069] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.356s)
[166.599225] [027/133] (887s left) kms_addfb_basic (unused-modifier)
[166.701601] Starting subtest: unused-modifier
[166.703524] Subtest unused-modifier: SUCCESS (0.000s)
[166.918382] [028/133] (887s left) gem_exec_reloc (basic-write-gtt-noreloc)
[167.031987] Starting subtest: basic-write-gtt-noreloc
[167.040747] Subtest basic-write-gtt-noreloc: SUCCESS (0.009s)
[167.249352] [029/133] (887s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[167.424423] Starting subtest: plane-downscale-factor-0-5-with-rotation
[167.426713] Starting dynamic subtest: pipe-A
[171.001101] Dynamic subtest pipe-A: SKIP (3.576s)
[171.020512] Starting dynamic subtest: pipe-B
[174.651543] Dynamic subtest pipe-B: SKIP (3.646s)
[174.671785] Starting dynamic subtest: pipe-C
[178.254214] Dynamic subtest pipe-C: SKIP (3.600s)
[178.257999] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (10.829s)
[178.710705] [030/133] (875s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[180.820168] Starting subtest: modeset-lpsp-stress-no-wait
[180.940406] Subtest modeset-lpsp-stress-no-wait: SKIP (0.091s)
[181.291569] [031/133] (873s left) perf_pmu (busy-start)
[181.400568] Starting subtest: busy-start
[181.402726] Starting dynamic subtest: rcs0
[183.927288] Dynamic subtest rcs0: SUCCESS (2.525s)
[183.951023] Starting dynamic subtest: bcs0
[186.450874] Dynamic subtest bcs0: SUCCESS (2.519s)
[186.471038] Starting dynamic subtest: vcs0
[188.979227] Dynamic subtest vcs0: SUCCESS (2.527s)
[189.003861] Starting dynamic subtest: vecs0
[191.503527] Dynamic subtest vecs0: SUCCESS (2.521s)
[191.506085] Subtest busy-start: SUCCESS (10.105s)
[191.639419] [032/133] (863s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[191.816930] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[191.818950] Starting dynamic subtest: pipe-A
[192.121451] Dynamic subtest pipe-A: SUCCESS (0.307s)
[192.145531] Starting dynamic subtest: pipe-B
[192.465225] Dynamic subtest pipe-B: SUCCESS (0.341s)
[192.489015] Starting dynamic subtest: pipe-C
[192.519908] Dynamic subtest pipe-C: SUCCESS (0.049s)
[192.521872] Subtest planes-unity-scaling-downscale-factor-0-5: SUCCESS (0.705s)
[192.942631] [033/133] (861s left) kms_chamelium_audio (hdmi-audio)
[193.492928] Subtest hdmi-audio: SKIP (0.000s)
[193.738425] [034/133] (861s left) api_intel_bb (object-noreloc-purge-cache-simple)
[193.842518] Starting subtest: object-noreloc-purge-cache-simple
[193.850039] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.010s)
[193.991281] [035/133] (860s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[194.184777] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[196.923904] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (2.737s)
[197.189467] [036/133] (857s left) gem_softpin (evict-snoop)
[197.312269] Starting subtest: evict-snoop
[197.316380] Subtest evict-snoop: SKIP (0.000s)
[197.472271] [037/133] (857s left) perf_pmu (invalid-init)
[197.582440] Starting subtest: invalid-init
[197.584535] Subtest invalid-init: SUCCESS (0.001s)
[197.738852] [038/133] (857s left) gem_ctx_shared (exec-single-timeline)
[197.855105] Starting subtest: exec-single-timeline
[197.894235] Starting dynamic subtest: rcs0
[198.949687] Dynamic subtest rcs0: SUCCESS (1.090s)
[198.976442] Starting dynamic subtest: bcs0
[200.035469] Dynamic subtest bcs0: SUCCESS (1.083s)
[200.063424] Starting dynamic subtest: vcs0
[201.123353] Dynamic subtest vcs0: SUCCESS (1.084s)
[201.150983] Starting dynamic subtest: vecs0
[202.210537] Dynamic subtest vecs0: SUCCESS (1.084s)
[202.213578] Subtest exec-single-timeline: SUCCESS (4.356s)
[202.492477] [039/133] (852s left) kms_dsc (dsc-with-formats)
[202.669196] Subtest dsc-with-formats: SKIP (0.000s)
[202.767225] [040/133] (852s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[202.962573] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[204.522262] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.561s)
[204.774414] [041/133] (850s left) gem_ctx_persistence (legacy-engines-mixed-process)
[204.885225] Starting subtest: legacy-engines-mixed-process
[204.887539] Starting dynamic subtest: render
[205.325863] Dynamic subtest render: SUCCESS (0.438s)
[205.354885] Starting dynamic subtest: bsd
[205.716831] Dynamic subtest bsd: SUCCESS (0.388s)
[205.742182] Starting dynamic subtest: blt
[206.104980] Dynamic subtest blt: SUCCESS (0.383s)
[206.132712] Starting dynamic subtest: vebox
[206.489870] Dynamic subtest vebox: SUCCESS (0.382s)
[206.492867] Subtest legacy-engines-mixed-process: SUCCESS (1.607s)
[206.624355] [042/133] (848s left) gem_render_tiled_blits (basic)
[206.740400] Starting subtest: basic
[206.830238] Subtest basic: SUCCESS (0.093s)
[206.950048] [043/133] (848s left) gem_mmap_gtt (big-bo-tiledx)
[207.050493] Starting subtest: big-bo-tiledX
[207.410527] Subtest big-bo-tiledX: SUCCESS (0.357s)
[207.606446] [044/133] (848s left) kms_color_pipeline (plane-lut1d)
[207.929024] Starting subtest: plane-lut1d
[209.332146] Subtest plane-lut1d: SKIP (1.404s)
[209.594615] [045/133] (846s left) gem_exec_balancer (hog)
[209.720066] Starting subtest: hog
[213.859261] Subtest hog: SUCCESS (4.135s)
[214.111357] [046/133] (841s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[214.300651] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[214.304740] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[214.460410] [047/133] (841s left) gem_flink_race (flink_close)
[214.556455] Starting subtest: flink_close
[219.587826] Subtest flink_close: SUCCESS (5.031s)
[219.727437] [048/133] (836s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[219.909631] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[220.004820] [049/133] (836s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[220.189287] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[223.009598] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (2.820s)
[223.278074] [050/133] (832s left) prime_mmap (test_userptr)
[223.383168] Starting subtest: test_userptr
[223.385300] Starting dynamic subtest: test_userptr-smem
[223.387294] Dynamic subtest test_userptr-smem: SUCCESS (0.001s)
[223.389378] Subtest test_userptr: SUCCESS (0.004s)
[223.525579] [051/133] (832s left) gem_softpin (allocator-basic)
[223.635956] Starting subtest: allocator-basic
[223.849938] Subtest allocator-basic: SUCCESS (0.212s)
[224.009657] [052/133] (832s left) kms_cursor_crc (cursor-random-32x32)
[224.190814] Starting subtest: cursor-random-32x32
[224.338907] Subtest cursor-random-32x32: SKIP (0.144s)
[224.494176] [053/133] (832s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[225.207204] Starting subtest: syncobj-timeline-multiple-ext-nodes
[225.209334] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s)
[225.478513] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true
[225.486343] [054/133] (831s left) perf (low-oa-exponent-permissions)
[225.761557] Starting subtest: low-oa-exponent-permissions
[225.850158] Subtest low-oa-exponent-permissions: SUCCESS (0.091s)
[225.954569] [055/133] (830s left) i915_pm_rpm (sysfs-read)
[227.868629] Starting subtest: sysfs-read
[228.064983] Subtest sysfs-read: SUCCESS (0.194s)
[228.421753] [056/133] (828s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[228.600234] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[228.712472] [057/133] (828s left) gem_exec_whisper (basic-queues-priority)
[228.837184] Starting subtest: basic-queues-priority
[234.898879] Subtest basic-queues-priority: SUCCESS (6.058s)
[235.152349] [058/133] (821s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[235.329653] Starting subtest: crc-primary-suspend-y-tiled-ccs
[235.332098] Starting dynamic subtest: pipe-A-HDMI-A-1