[92.584550] Initializing watchdogs
[92.584802]   /dev/watchdog0
[92.624982] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[92.639668] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[92.647858] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[92.653870] [001/133] (960s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[92.860254] Starting subtest: primary-yf-tiled-reflect-x-0
[92.863679] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.003s)
[93.008821] [002/133] (960s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[93.199212] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[93.301766] [003/133] (960s left) i915_pm_rps (fence-order)
[93.431133] Starting subtest: fence-order
[95.794979] Subtest fence-order: SUCCESS (2.358s)
[95.964909] [004/133] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[96.160572] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[96.164752] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[96.326698] [005/133] (957s left) kms_sequence (queue-busy)
[96.517183] Starting subtest: queue-busy
[96.519934] Starting dynamic subtest: pipe-A-HDMI-A-1
[99.516122] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.992s)
[99.538297] Starting dynamic subtest: pipe-A-HDMI-A-2
[102.182120] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.666s)
[102.213091] Starting dynamic subtest: pipe-B-HDMI-A-1
[104.822108] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.632s)
[104.851834] Starting dynamic subtest: pipe-B-HDMI-A-2
[107.440343] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.616s)
[107.469868] Starting dynamic subtest: pipe-C-HDMI-A-1
[110.101639] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.654s)
[110.125889] Starting dynamic subtest: pipe-C-HDMI-A-2
[112.744168] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.636s)
[112.747282] Subtest queue-busy: SUCCESS (16.224s)
[113.061950] [006/133] (940s left) kms_pm_rpm (dpms-non-lpsp)
[115.031331] Starting subtest: dpms-non-lpsp
[115.165329] Subtest dpms-non-lpsp: SUCCESS (0.137s)
[115.488496] [007/133] (938s left) kms_plane (plane-panning-top-left)
[115.668198] Starting subtest: plane-panning-top-left
[115.679439] Starting dynamic subtest: pipe-A
[116.901831] Dynamic subtest pipe-A: SUCCESS (1.221s)
[116.930668] Starting dynamic subtest: pipe-B
[117.762193] Dynamic subtest pipe-B: SUCCESS (0.859s)
[117.764791] Subtest plane-panning-top-left: SUCCESS (2.090s)
[118.076950] [008/133] (935s left) core_auth (many-magics)
[118.188865] Starting subtest: many-magics
[119.329536] Subtest many-magics: SUCCESS (1.144s)
[119.474711] [009/133] (934s left) gem_ctx_persistence (engines-hang)
[119.584851] Starting subtest: engines-hang
[119.586530] Starting dynamic subtest: rcs0
[119.622453] Dynamic subtest rcs0: SUCCESS (0.037s)
[119.644838] Starting dynamic subtest: bcs0
[119.648276] Dynamic subtest bcs0: SKIP (0.006s)
[119.667295] Starting dynamic subtest: vcs0
[119.668937] Dynamic subtest vcs0: SUCCESS (0.037s)
[119.691088] Starting dynamic subtest: vecs0
[119.694968] Dynamic subtest vecs0: SUCCESS (0.027s)
[119.696662] Subtest engines-hang: SUCCESS (0.110s)
[119.827762] [010/133] (934s left) gem_exec_reloc (basic-write-cpu-active)
[119.942962] Starting subtest: basic-write-cpu-active
[120.085552] Subtest basic-write-cpu-active: SUCCESS (0.144s)
[120.304900] [011/133] (933s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[120.489953] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.000s)
[120.584345] [012/133] (933s left) gem_exec_reloc (basic-write-gtt-noreloc)
[120.711183] Starting subtest: basic-write-gtt-noreloc
[120.719161] Subtest basic-write-gtt-noreloc: SUCCESS (0.011s)
[120.941728] [013/133] (933s left) prime_busy (hang)
[121.055178] Starting subtest: hang
[121.056912] Starting dynamic subtest: rcs0
[127.661067] Dynamic subtest rcs0: SUCCESS (6.604s)
[127.681593] Starting dynamic subtest: bcs0
[134.636974] Dynamic subtest bcs0: SUCCESS (6.973s)
[134.663313] Starting dynamic subtest: vcs0
[141.614027] Dynamic subtest vcs0: SUCCESS (6.975s)
[141.640939] Starting dynamic subtest: vecs0
[148.651995] Dynamic subtest vecs0: SUCCESS (7.039s)
[148.654277] Subtest hang: SUCCESS (27.598s)
[148.795188] [014/133] (905s left) gem_reg_read (bad-register)
[148.892155] Starting subtest: bad-register
[148.894241] Subtest bad-register: SUCCESS (0.000s)
[149.028235] [015/133] (905s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[149.205929] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[149.209159] Starting dynamic subtest: pipe-A-HDMI-A-1
[149.232235] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[149.271390] Starting dynamic subtest: pipe-A-HDMI-A-2
[149.301218] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s)
[149.338252] Starting dynamic subtest: pipe-B-HDMI-A-1
[149.368420] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[149.393841] Starting dynamic subtest: pipe-B-HDMI-A-2
[149.410409] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s)
[149.429927] Starting dynamic subtest: pipe-C-HDMI-A-1
[149.444923] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[149.464238] Starting dynamic subtest: pipe-C-HDMI-A-2
[149.479227] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[149.482280] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.021s)
[150.287764] [016/133] (904s left) gem_pxp (regular-baseline-src-copy-readible)
[152.931280] Starting subtest: regular-baseline-src-copy-readible
[152.934660] Subtest regular-baseline-src-copy-readible: SKIP (0.000s)
[153.078788] [017/133] (901s left) kms_feature_discovery (psr1)
[153.260107] Starting subtest: psr1
[153.265194] Subtest psr1: SKIP (0.000s)
[153.422296] [018/133] (901s left) gem_exec_whisper (basic-queues-forked-all)
[153.559845] Starting subtest: basic-queues-forked-all
[163.907253] Subtest basic-queues-forked-all: SUCCESS (10.354s)
[164.161418] [019/133] (890s left) kms_cursor_crc (cursor-onscreen-256x85)
[164.351768] Starting subtest: cursor-onscreen-256x85
[164.393101] Starting dynamic subtest: pipe-A-HDMI-A-1
[167.130971] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.734s)
[167.245275] Starting dynamic subtest: pipe-C-HDMI-A-1
[169.634375] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.439s)
[169.636044] Subtest cursor-onscreen-256x85: SUCCESS (5.282s)
[169.947067] [020/133] (884s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[170.137129] Starting subtest: basic-flip-after-cursor-varying-size
[171.513872] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.373s)
[171.833094] [021/133] (883s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[172.030308] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[172.033623] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[172.167883] [022/133] (882s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[172.342468] Starting subtest: coverage-vs-premult-vs-constant
[172.498057] Starting dynamic subtest: pipe-A-HDMI-A-1
[173.227718] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.731s)
[173.277417] Starting dynamic subtest: pipe-C-HDMI-A-1
[173.867405] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.624s)
[173.873234] Subtest coverage-vs-premult-vs-constant: SUCCESS (1.521s)
[174.176309] [023/133] (880s left) kms_flip (basic-plain-flip)
[174.368626] Starting subtest: basic-plain-flip
[174.370266] Starting dynamic subtest: A-HDMI-A1
[175.549095] Dynamic subtest A-HDMI-A1: SUCCESS (1.179s)
[175.570090] Starting dynamic subtest: B-HDMI-A1
[176.476859] Dynamic subtest B-HDMI-A1: SUCCESS (0.923s)
[176.497841] Starting dynamic subtest: C-HDMI-A1
[177.344607] Dynamic subtest C-HDMI-A1: SUCCESS (0.870s)
[177.370209] Starting dynamic subtest: A-HDMI-A2
[178.257510] Dynamic subtest A-HDMI-A2: SUCCESS (0.906s)
[178.279241] Starting dynamic subtest: B-HDMI-A2
[179.183250] Dynamic subtest B-HDMI-A2: SUCCESS (0.923s)
[179.208181] Starting dynamic subtest: C-HDMI-A2
[180.067086] Dynamic subtest C-HDMI-A2: SUCCESS (0.876s)
[180.070177] Subtest basic-plain-flip: SUCCESS (5.701s)
[180.578989] [024/133] (874s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[180.690389] Starting subtest: multi-wait-available-unsubmitted-signaled
[180.695176] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.004s)
[180.838324] [025/133] (874s left) i915_hangman (gt-error-state-capture)
[180.970318] Starting subtest: gt-error-state-capture
[180.973173] Starting dynamic subtest: rcs0
[191.101240] Dynamic subtest rcs0: SUCCESS (10.132s)
[191.138146] Starting dynamic subtest: bcs0
[201.049176] Dynamic subtest bcs0: SUCCESS (9.946s)
[201.077289] Starting dynamic subtest: vcs0
[211.061468] Dynamic subtest vcs0: SUCCESS (10.006s)
[211.087396] Starting dynamic subtest: vecs0
[221.016092] Dynamic subtest vecs0: SUCCESS (9.948s)
[221.018957] Subtest gt-error-state-capture: SUCCESS (40.042s)
[221.183372] [026/133] (834s left) gem_exec_balancer (nohangcheck)
[221.438794] Starting subtest: nohangcheck
[225.817184] Subtest nohangcheck: SUCCESS (4.377s)
[225.981613] [027/133] (829s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[226.081187] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[226.083130] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[226.218818] [028/133] (829s left) api_intel_bb (add-remove-objects)
[226.318373] Starting subtest: add-remove-objects
[226.332057] Subtest add-remove-objects: SUCCESS (0.013s)
[226.487348] [029/133] (829s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[226.698363] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[229.665438] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (2.965s)
[229.968471] [030/133] (825s left) gem_userptr_blits (vma-merge)
[230.120660] Starting subtest: vma-merge
[230.289264] Subtest vma-merge: SUCCESS (0.167s)
[230.466512] [031/133] (825s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[230.671797] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[230.676671] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[230.817229] [032/133] (825s left) gem_exec_fence (syncobj-wait)
[231.446602] Starting subtest: syncobj-wait
[231.473449] Subtest syncobj-wait: SUCCESS (0.028s)
[231.887276] [FACT gem_exec_fence (syncobj-wait)] new: kernel.kmod_is_loaded.vgem: true
[231.892701] [033/133] (824s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[232.075121] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[232.081280] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[232.840451] [034/133] (823s left) i915_suspend (forcewake)
[232.946367] Starting subtest: forcewake