[60.602797] Initializing watchdogs
[60.602858]   /dev/watchdog0
[60.618082] [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]
[60.623523] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.625947] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.627864] [001/133] (960s left) kms_color (ctm-blue-to-red)
[60.718365] Starting subtest: ctm-blue-to-red
[60.719056] Starting dynamic subtest: pipe-A-HDMI-A-1
[61.024384] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.305s)
[61.029759] Starting dynamic subtest: pipe-B-HDMI-A-1
[61.307291] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.281s)
[61.312962] Starting dynamic subtest: pipe-C-HDMI-A-1
[61.594886] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.287s)
[61.600844] Starting dynamic subtest: pipe-D-HDMI-A-1
[61.886237] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.290s)
[61.886975] Subtest ctm-blue-to-red: SUCCESS (1.165s)
[62.038170] [002/133] (959s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[62.082371] Starting subtest: yf-tiled-to-vebox-y-tiled
[62.083074] Starting dynamic subtest: smem
[62.180844] Dynamic subtest smem: SUCCESS (0.098s)
[62.181553] Subtest yf-tiled-to-vebox-y-tiled: SUCCESS (0.098s)
[62.372335] [003/133] (958s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[62.460193] Starting subtest: crc-primary-basic-y-tiled-ccs
[62.460886] Starting dynamic subtest: pipe-A-HDMI-A-1
[62.467349] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[62.472573] Starting dynamic subtest: pipe-B-HDMI-A-1
[62.479109] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[62.484260] Starting dynamic subtest: pipe-C-HDMI-A-1
[62.490783] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[62.495823] Starting dynamic subtest: pipe-D-HDMI-A-1
[62.502496] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[62.503815] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s)
[62.699307] [004/133] (958s left) gem_mmap_gtt (basic-small-copy-odd)
[62.732938] Starting subtest: basic-small-copy-odd
[64.609720] Subtest basic-small-copy-odd: SUCCESS (1.873s)
[64.670726] [005/133] (956s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[64.814819] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[65.440270] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.624s)
[65.545021] [006/133] (955s left) kms_chamelium_frames (vga-frame-dump)
[65.682096] Subtest vga-frame-dump: SKIP (0.000s)
[65.767268] [007/133] (955s left) gem_eio (wait-wedge-10ms)
[65.820489] Starting subtest: wait-wedge-10ms
[66.083718] Subtest wait-wedge-10ms: SUCCESS (0.263s)
[66.203720] [008/133] (955s left) gem_tiled_blits (normal)
[66.294422] Starting subtest: normal
[76.699835] Subtest normal: SUCCESS (10.397s)
[76.819947] [009/133] (944s left) kms_plane_alpha_blend (alpha-transparent-fb)
[76.962435] Starting subtest: alpha-transparent-fb
[77.033021] Starting dynamic subtest: pipe-A-HDMI-A-1
[77.321220] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.288s)
[77.329482] Starting dynamic subtest: pipe-D-HDMI-A-1
[77.633157] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.311s)
[77.633928] Subtest alpha-transparent-fb: SUCCESS (0.671s)
[77.783927] [010/133] (943s left) gem_exec_fence (syncobj-import)
[78.139480] Starting subtest: syncobj-import
[78.141352] Subtest syncobj-import: SUCCESS (0.003s)
[78.449094] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[78.461069] [011/133] (943s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[78.530782] Starting subtest: etime-multi-wait-for-submit-submitted
[78.623523] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.102s)
[78.695744] [012/133] (942s left) kms_big_fb (y-tiled-addfb-size-overflow)
[78.796089] Starting subtest: y-tiled-addfb-size-overflow
[78.796794] Subtest y-tiled-addfb-size-overflow: SUCCESS (0.000s)
[78.875740] [013/133] (942s left) gem_create (create-ext-cpu-access-sanity-check)
[79.029276] Starting subtest: create-ext-cpu-access-sanity-check
[79.031129] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[79.085546] [014/133] (942s left) gem_lmem_swapping (heavy-multi)
[79.121621] Subtest heavy-multi: SKIP (0.000s)
[79.162527] [015/133] (942s left) kms_psr (fbc-pr-cursor-render)
[79.246439] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[79.290126] [016/133] (942s left) gem_ctx_persistence (engines-mixed)
[79.328539] Starting subtest: engines-mixed
[79.329346] Starting dynamic subtest: rcs0
[79.372644] Dynamic subtest rcs0: SUCCESS (0.044s)
[79.385722] Starting dynamic subtest: bcs0
[79.432541] Dynamic subtest bcs0: SUCCESS (0.059s)
[79.449017] Starting dynamic subtest: vcs0
[79.491562] Dynamic subtest vcs0: SUCCESS (0.058s)
[79.504985] Starting dynamic subtest: vcs1
[79.544688] Dynamic subtest vcs1: SUCCESS (0.053s)
[79.560902] Starting dynamic subtest: vecs0
[79.597540] Dynamic subtest vecs0: SUCCESS (0.052s)
[79.598619] Subtest engines-mixed: SUCCESS (0.270s)
[79.670659] [017/133] (942s left) syncobj_wait (multi-wait-all-submitted)
[79.704580] Starting subtest: multi-wait-all-submitted
[79.807552] Subtest multi-wait-all-submitted: SUCCESS (0.102s)
[79.875311] [018/133] (941s left) dumb_buffer (map-valid)
[79.908328] Starting subtest: map-valid
[79.909056] Subtest map-valid: SUCCESS (0.000s)
[80.005116] [019/133] (941s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[80.093403] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[80.094777] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[80.194851] [020/133] (941s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[80.283313] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[80.284009] Starting dynamic subtest: pipe-A-valid-mode
[81.311290] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.027s)
[81.312034] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SUCCESS (1.028s)
[81.452381] [021/133] (940s left) kms_pm_rpm (modeset-non-lpsp-stress)
[82.870309] Starting subtest: modeset-non-lpsp-stress
[84.076072] Subtest modeset-non-lpsp-stress: SKIP (1.205s)
[84.249898] [022/133] (937s left) gem_exec_alignment (many)
[84.290368] Starting subtest: many
[117.183362] Subtest many: SUCCESS (32.881s)
[117.794335] [023/133] (904s left) kms_psr (fbc-psr2-primary-blt)
[117.928493] Subtest fbc-psr2-primary-blt: SKIP (0.000s)
[117.973667] [024/133] (904s left) kms_chamelium_audio (hdmi-audio-edid)
[118.111758] Subtest hdmi-audio-edid: SKIP (0.000s)
[118.212762] [025/133] (903s left) kms_psr (pr-primary-mmap-cpu)
[118.298592] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[118.343244] [026/133] (903s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[118.383312] Starting subtest: multi-wait-available-unsubmitted-submitted
[118.384076] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[118.459864] [027/133] (903s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[118.548010] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[118.589483] [028/133] (903s left) sysfs_heartbeat_interval (invalid)
[118.627206] Starting subtest: invalid
[118.627931] Starting dynamic subtest: vecs0
[118.628612] Dynamic subtest vecs0: SUCCESS (0.000s)
[118.635397] Starting dynamic subtest: vcs0
[118.636095] Dynamic subtest vcs0: SUCCESS (0.000s)
[118.642619] Starting dynamic subtest: bcs0
[118.643312] Dynamic subtest bcs0: SUCCESS (0.000s)
[118.650022] Starting dynamic subtest: rcs0
[118.650772] Dynamic subtest rcs0: SUCCESS (0.000s)
[118.657364] Starting dynamic subtest: vcs1
[118.658065] Dynamic subtest vcs1: SUCCESS (0.000s)
[118.658735] Subtest invalid: SUCCESS (0.003s)
[118.688488] [029/133] (903s left) kms_sequence (queue-busy)
[118.773726] Starting subtest: queue-busy
[118.774490] Starting dynamic subtest: pipe-A-HDMI-A-1
[120.066510] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.292s)
[120.074780] Starting dynamic subtest: pipe-B-HDMI-A-1
[121.330934] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.263s)
[121.339271] Starting dynamic subtest: pipe-C-HDMI-A-1
[122.604900] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.273s)
[122.612943] Starting dynamic subtest: pipe-D-HDMI-A-1
[123.890063] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.283s)
[123.890788] Subtest queue-busy: SUCCESS (5.117s)
[124.005019] [030/133] (898s left) kms_vrr (flip-basic-fastset)
[124.095419] Starting subtest: flip-basic-fastset
[124.097461] Subtest flip-basic-fastset: SKIP (0.000s)
[124.151938] [031/133] (898s left) gem_userptr_blits (stress-mm-invalidate-close)
[124.196253] Starting subtest: stress-mm-invalidate-close
[126.352852] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[126.451636] [032/133] (895s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[126.548399] Starting subtest: 4-tiled-32bpp-rotate-0
[126.549768] Subtest 4-tiled-32bpp-rotate-0: SKIP (0.000s)
[126.646229] [033/133] (895s left) gem_userptr_blits (set-cache-level)
[126.684337] Starting subtest: set-cache-level
[126.685034] Subtest set-cache-level: SUCCESS (0.000s)
[126.796957] [034/133] (895s left) kms_async_flips (async-flip-dpms)
[126.881714] Starting subtest: async-flip-dpms
[127.000332] Starting dynamic subtest: pipe-A-HDMI-A-1
[129.448902] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.448s)
[129.588394] Starting dynamic subtest: pipe-B-HDMI-A-1
[131.997802] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.414s)
[132.130650] Starting dynamic subtest: pipe-C-HDMI-A-1
[134.533020] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.406s)
[134.687235] Starting dynamic subtest: pipe-D-HDMI-A-1
[137.202905] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.502s)
[137.204119] Subtest async-flip-dpms: SUCCESS (10.302s)
[137.439638] [035/133] (885s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[137.530422] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[140.003453] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.473s)
[140.102213] [036/133] (882s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[140.191368] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[140.192744] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[140.267492] [037/133] (882s left) gem_mmap_gtt (hang)
[140.300543] Starting subtest: hang
[145.756775] Subtest hang: SUCCESS (5.455s)
[145.841304] [038/133] (876s left) gem_media_fill (media-fill)
[145.883809] Starting subtest: media-fill
[145.884498] Starting dynamic subtest: smem
[145.887425] Dynamic subtest smem: SUCCESS (0.004s)
[145.888236] Subtest media-fill: SUCCESS (0.005s)
[146.090988] [039/133] (876s left) perf_pmu (semaphore-busy)
[146.130576] Starting subtest: semaphore-busy
[146.131302] Starting dynamic subtest: rcs0
[147.692634] Dynamic subtest rcs0: SUCCESS (1.552s)
[147.708560] Starting dynamic subtest: bcs0
[149.247991] Dynamic subtest bcs0: SUCCESS (1.554s)
[149.258441] Starting dynamic subtest: vcs0
[150.797099] Dynamic subtest vcs0: SUCCESS (1.548s)
[150.813036] Starting dynamic subtest: vcs1
[152.344859] Dynamic subtest vcs1: SUCCESS (1.546s)
[152.355560] Starting dynamic subtest: vecs0
[153.891605] Dynamic subtest vecs0: SUCCESS (1.545s)
[153.892564] Subtest semaphore-busy: SUCCESS (7.752s)
[153.974959] [040/133] (868s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[154.061501] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[154.062867] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[154.124934] [041/133] (868s left) i915_query (query-topology-kernel-writes)
[154.157499] Starting subtest: query-topology-kernel-writes
[154.158235] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[154.223014] [042/133] (868s left) i915_query (query-garbage)
[154.254412] Starting subtest: query-garbage
[154.255172] Subtest query-garbage: SUCCESS (0.000s)
[154.323680] [043/133] (868s left) kms_dsc (dsc-with-output-formats)
[154.407791] Starting subtest: dsc-with-output-formats
[154.414352] Subtest dsc-with-output-formats: SKIP (0.001s)
[154.465332] [044/133] (868s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[154.550797] Starting subtest: bad-aux-stride-y-tiled-ccs
[154.551497] Starting dynamic subtest: pipe-A-HDMI-A-1
[154.558323] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[154.565724] Starting dynamic subtest: pipe-B-HDMI-A-1
[154.572515] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[154.579809] Starting dynamic subtest: pipe-C-HDMI-A-1
[154.586553] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[154.593672] Starting dynamic subtest: pipe-D-HDMI-A-1
[154.600307] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[154.601619] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.006s)
[154.791479] [045/133] (868s left) gem_mmap_gtt (hang-user)
[154.825593] Starting subtest: hang-user
[191.099027] Subtest hang-user: SUCCESS (36.269s)
[191.190832] [046/133] (831s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[191.279537] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[191.281024] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[191.362586] [047/133] (831s left) kms_atomic_transition (modeset-transition-nonblocking)
[191.447065] Starting subtest: modeset-transition-nonblocking
[191.447844] Starting dynamic subtest: 1x-outputs
[192.645336] Dynamic subtest 1x-outputs: SUCCESS (1.198s)
[192.646167] Subtest modeset-transition-nonblocking: SUCCESS (1.199s)
[192.782441] [048/133] (830s left) kms_rotation_crc (primary-rotation-90)
[192.871166] Starting subtest: primary-rotation-90
[197.398384] Subtest primary-rotation-90: SUCCESS (4.527s)
[197.584100] [049/133] (825s left) kms_addfb_basic (bad-pitch-1024)
[197.618047] Starting subtest: bad-pitch-1024
[197.618795] Subtest bad-pitch-1024: SUCCESS (0.000s)
[197.768981] [050/133] (825s left) sw_sync (sync_multi_consumer)
[197.802502] Starting subtest: sync_multi_consumer
[198.338835] Subtest sync_multi_consumer: SUCCESS (0.528s)
[198.400039] [051/133] (824s left) syncobj_wait (invalid-reset-zero-handles)
[198.434998] Starting subtest: invalid-reset-zero-handles
[198.435729] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[198.494069] [052/133] (824s left) kms_hdr (static-toggle-suspend)
[198.578043] Starting subtest: static-toggle-suspend
[198.580118] Subtest static-toggle-suspend: SKIP (0.001s)
[198.633910] [053/133] (824s left) gem_softpin (allocator-fork)
[198.671867] Starting subtest: allocator-fork
[200.899733] Subtest allocator-fork: SUCCESS (2.219s)
[200.996061] [054/133] (822s left) gem_exec_params (no-bsd)
[201.032173] Starting subtest: no-bsd
[201.033887] Subtest no-bsd: SUCCESS (0.001s)
[201.137279] [055/133] (822s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[201.227752] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[201.229125] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[201.328256] [056/133] (821s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[201.411995] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[201.413400] Subtest pixel-format-4-tiled-modifier-source-clamping: SKIP (0.000s)
[201.468292] [057/133] (821s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[201.551874] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[201.553277] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[201.610673] [058/133] (821s left) i915_hangman (engine-error-state-capture)
[201.652612] Starting subtest: engine-error-state-capture
[201.653318] Starting dynamic subtest: rcs0
[205.376808] Dynamic subtest rcs0: SUCCESS (3.724s)
[205.387968] Starting dynamic subtest: bcs0
[209.411704] Dynamic subtest bcs0: SUCCESS (4.033s)
[209.426712] Starting dynamic subtest: vcs0
[213.379655] Dynamic subtest vcs0: SUCCESS (3.966s)
[213.390482] Starting dynamic subtest: vcs1
[217.411927] Dynamic subtest vcs1: SUCCESS (4.031s)
[217.428759] Starting dynamic subtest: vecs0
[221.374730] Dynamic subtest vecs0: SUCCESS (3.961s)
[221.375833] Subtest engine-error-state-capture: SUCCESS (19.723s)
[221.444031] [059/133] (801s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[221.536492] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[221.537859] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[221.631102] [060/133] (801s left) gem_exec_schedule (manyslice)
[221.672981] Starting subtest: manyslice
[221.673780] Starting dynamic subtest: rcs0
[222.224500] Dynamic subtest rcs0: SUCCESS (0.542s)
[222.232430] Starting dynamic subtest: bcs0
[222.537499] Dynamic subtest bcs0: SUCCESS (0.312s)
[222.545622] Starting dynamic subtest: vcs0
[222.846597] Dynamic subtest vcs0: SUCCESS (0.308s)
[222.854712] Starting dynamic subtest: vcs1
[223.221042] Dynamic subtest vcs1: SUCCESS (0.374s)
[223.228961] Starting dynamic subtest: vecs0
[223.557419] Dynamic subtest vecs0: SUCCESS (0.336s)
[223.558137] Subtest manyslice: SUCCESS (1.876s)
[223.850336] [061/133] (799s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[223.940701] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[223.942142] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[224.027515] [062/133] (799s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[224.121870] Starting subtest: x-tiled-64bpp-rotate-180
[225.661930] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.540s)
[225.783232] [063/133] (797s left) kms_atomic_interruptible (legacy-setmode)
[225.871262] Starting subtest: legacy-setmode
[225.872869] Starting dynamic subtest: pipe-A-HDMI-A-1
[232.078039] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.205s)
[232.078838] Subtest legacy-setmode: SUCCESS (6.207s)
[232.209147] [064/133] (791s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[232.297213] Starting subtest: cursor-vs-flip-legacy
[261.910848] Subtest cursor-vs-flip-legacy: SUCCESS (29.613s)
[262.052485] [065/133] (761s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[262.145455] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[262.146832] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[262.233022] [066/133] (761s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[262.266235] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[262.266968] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[262.326949] [067/133] (761s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[262.411133] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[262.431053] Starting dynamic subtest: pipe-A-plane-0
[262.922748] Dynamic subtest pipe-A-plane-0: SUCCESS (0.491s)
[262.934441] Starting dynamic subtest: pipe-A-plane-3
[263.331209] Dynamic subtest pipe-A-plane-3: SUCCESS (0.407s)
[263.344891] Starting dynamic subtest: pipe-A-plane-5
[263.639618] Dynamic subtest pipe-A-plane-5: SUCCESS (0.307s)
[263.802234] Starting dynamic subtest: pipe-B-plane-0
[264.245550] Dynamic subtest pipe-B-plane-0: SUCCESS (0.450s)
[264.260772] Starting dynamic subtest: pipe-B-plane-3
[264.662230] Dynamic subtest pipe-B-plane-3: SUCCESS (0.415s)
[264.677525] Starting dynamic subtest: pipe-B-plane-5
[264.995742] Dynamic subtest pipe-B-plane-5: SUCCESS (0.332s)
[265.069348] Subtest pixel-format-y-tiled-modifier-source-clamping: SUCCESS (2.658s)
[265.238034] [068/133] (758s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[265.333377] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.000s)
[265.381558] [069/133] (758s left) kms_cursor_crc (cursor-offscreen-32x10)
[265.472777] Starting subtest: cursor-offscreen-32x10
[265.523985] Subtest cursor-offscreen-32x10: SKIP (0.051s)
[265.611552] [070/133] (758s left) drm_read (short-buffer-nonblock)
[265.717378] Starting subtest: short-buffer-nonblock
[265.718107] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[265.829634] [071/133] (758s left) kms_flip (dpms-vs-vblank-race-interruptible)
[265.920055] Starting subtest: dpms-vs-vblank-race-interruptible
[265.922896] Starting dynamic subtest: A-HDMI-A1
[268.771934] Dynamic subtest A-HDMI-A1: SUCCESS (2.849s)
[268.782010] Starting dynamic subtest: B-HDMI-A1
[271.576358] Dynamic subtest B-HDMI-A1: SUCCESS (2.802s)
[271.585113] Starting dynamic subtest: C-HDMI-A1
[274.332723] Dynamic subtest C-HDMI-A1: SUCCESS (2.754s)
[274.340488] Starting dynamic subtest: D-HDMI-A1
[277.146635] Dynamic subtest D-HDMI-A1: SUCCESS (2.814s)
[277.150272] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (11.230s)
[277.325134] [072/133] (746s left) kms_chamelium_edid (hdmi-edid-read)
[277.477426] Subtest hdmi-edid-read: SKIP (0.000s)
[277.569824] [073/133] (746s left) syncobj_timeline (invalid-signal-illegal-handle)
[277.608021] Starting subtest: invalid-signal-illegal-handle
[277.608758] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[277.671410] [074/133] (746s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[277.760741] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[277.762115] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[277.854768] [075/133] (746s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[277.944098] Starting subtest: psr-2p-pri-indfb-multidraw
[277.945452] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[278.048048] [076/133] (746s left) syncobj_timeline (wait-any-interrupted)
[278.082511] Starting subtest: wait-any-interrupted
[278.183671] Subtest wait-any-interrupted: SUCCESS (0.102s)
[278.255273] [077/133] (745s left) kms_psr (psr-sprite-plane-move)
[278.343809] Subtest psr-sprite-plane-move: SKIP (0.000s)
[278.382864] [078/133] (745s left) gem_exec_balancer (parallel-bb-first)
[278.541166] Subtest parallel-bb-first: SKIP (0.000s)
[278.613243] [079/133] (745s left) sw_sync (sync_multi_producer_single_consumer)
[278.644137] Starting subtest: sync_multi_producer_single_consumer
[279.726452] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[279.771249] [080/133] (744s left) syncobj_timeline (device-signal-unordered)
[279.805118] Starting subtest: device-signal-unordered
[279.805814] Subtest device-signal-unordered: SUCCESS (0.001s)
[279.862023] [081/133] (744s left) core_auth (getclient-master-drop)
[279.893522] Starting subtest: getclient-master-drop
[279.896170] Subtest getclient-master-drop: SUCCESS (0.002s)
[279.953954] [082/133] (744s left) gem_mmap_gtt (basic-copy)
[279.986798] Starting subtest: basic-copy
[280.457982] Subtest basic-copy: SUCCESS (0.464s)
[280.543456] [083/133] (743s left) kms_addfb_basic (bad-pitch-65536)
[280.576801] Starting subtest: bad-pitch-65536
[280.577531] Subtest bad-pitch-65536: SUCCESS (0.000s)
[280.716880] [084/133] (743s left) gem_exec_whisper (basic-fds)
[280.759968] Starting subtest: basic-fds
[283.714681] Subtest basic-fds: SUCCESS (2.954s)
[283.895439] [085/133] (740s left) gem_exec_reloc (basic-concurrent0)
[283.933528] Starting subtest: basic-concurrent0
[289.382465] Subtest basic-concurrent0: SUCCESS (5.400s)
[289.445518] [086/133] (735s left) gen7_exec_parse (chained-batch)
[289.481765] Subtest chained-batch: SKIP (0.000s)
[289.526992] [087/133] (734s left) gem_exec_fence (basic-busy-all)
[289.567858] Starting subtest: basic-busy-all
[289.614347] Subtest basic-busy-all: SUCCESS (0.046s)
[290.226833] [088/133] (734s left) kms_cursor_crc (cursor-random-128x128)
[290.317193] Starting subtest: cursor-random-128x128
[290.322224] Starting dynamic subtest: pipe-A-HDMI-A-1
[292.227731] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.906s)
[292.265102] Starting dynamic subtest: pipe-D-HDMI-A-1
[294.138077] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.879s)
[294.138845] Subtest cursor-random-128x128: SUCCESS (3.821s)
[294.280144] [089/133] (730s left) vgem_basic (dmabuf-export)
[294.327421] Starting subtest: dmabuf-export
[294.352666] Subtest dmabuf-export: SUCCESS (0.026s)
[294.444835] [090/133] (730s left) i915_pm_rpm (gem-evict-pwrite)
[295.837190] Starting subtest: gem-evict-pwrite
[297.113362] Subtest gem-evict-pwrite: SUCCESS (1.278s)
[297.295786] [091/133] (727s left) syncobj_wait (wait-all-complex)
[297.332939] Starting subtest: wait-all-complex
[297.556949] Subtest wait-all-complex: SUCCESS (0.215s)
[297.622741] [092/133] (727s left) kms_busy (extended-pageflip-hang-oldfb)
[297.713740] Starting subtest: extended-pageflip-hang-oldfb
[297.714488] Starting dynamic subtest: pipe-A
[297.839210] Dynamic subtest pipe-A: SUCCESS (0.125s)
[297.851378] Starting dynamic subtest: pipe-D
[297.999068] Dynamic subtest pipe-D: SUCCESS (0.155s)
[297.999827] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.287s)
[298.132142] [093/133] (726s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[298.224220] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[298.225670] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[298.310587] [094/133] (726s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[298.405580] Starting subtest: yf-tiled-addfb-size-overflow
[298.406987] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[298.495389] [095/133] (726s left) gem_ctx_create (basic)
[298.538157] Starting subtest: basic
[298.538970] Subtest basic: SUCCESS (0.000s)
[298.713652] [096/133] (726s left) gem_exec_reloc (basic-write-read)
[298.750910] Starting subtest: basic-write-read
[298.755811] Subtest basic-write-read: SUCCESS (0.005s)
[298.869479] [097/133] (726s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[298.958516] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (0.000s)
[298.999537] [098/133] (725s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[299.092287] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[299.093710] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[299.172235] [099/133] (725s left) kms_cursor_crc (cursor-tearing-position-change)
[299.259026] Starting subtest: cursor-tearing-position-change
[299.260763] Starting dynamic subtest: pipe-A-HDMI-A-1
[299.527688] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.266s)
[299.538684] Starting dynamic subtest: pipe-D-HDMI-A-1
[299.758902] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.228s)
[299.759685] Subtest cursor-tearing-position-change: SUCCESS (0.499s)
[299.916410] [100/133] (725s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[300.010905] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[300.012287] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[300.106765] [101/133] (724s left) kms_big_fb (linear-64bpp-rotate-270)
[300.202289] Starting subtest: linear-64bpp-rotate-270
[300.244217] Subtest linear-64bpp-rotate-270: SKIP (0.040s)
[300.348298] [102/133] (724s left) gem_ctx_persistence (smoketest)
[300.386551] Starting subtest: smoketest
[338.658584] Subtest smoketest: SUCCESS (38.272s)
[338.738920] [103/133] (686s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[338.835741] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[338.837102] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[338.938132] [104/133] (686s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[339.026850] Starting subtest: psr-rgb565-draw-pwrite
[339.028246] Subtest psr-rgb565-draw-pwrite: SKIP (0.000s)
[339.117734] [105/133] (686s left) template (b)
[339.151309] Starting subtest: B
[339.152075] Subtest B: SUCCESS (0.000s)
[339.210857] [106/133] (686s left) kms_lease (simple-lease)
[339.298773] Starting subtest: simple-lease
[339.301049] Starting dynamic subtest: pipe-A-HDMI-A-1
[339.513723] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.214s)
[339.525075] Starting dynamic subtest: pipe-B-HDMI-A-1
[339.714437] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.198s)
[339.725015] Starting dynamic subtest: pipe-C-HDMI-A-1
[339.911539] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.194s)
[339.923315] Starting dynamic subtest: pipe-D-HDMI-A-1
[340.122324] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.209s)
[340.124267] Subtest simple-lease: SUCCESS (0.825s)
[340.239312] [107/133] (685s left) gem_exec_params (sol-reset-invalid)
[340.279101] Starting subtest: sol-reset-invalid
[340.281600] Subtest sol-reset-invalid: SUCCESS (0.001s)
[340.388744] [108/133] (684s left) gem_pxp (create-regular-context-2)
[340.492098] Starting subtest: create-regular-context-2
[340.493037] Subtest create-regular-context-2: SUCCESS (0.001s)
[340.584720] [109/133] (684s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[340.674497] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[340.676390] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[340.792910] [110/133] (684s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[340.880009] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[340.880724] Starting dynamic subtest: pipe-A-valid-mode
[342.091128] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.210s)
[342.091960] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (1.212s)
[342.215760] [111/133] (683s left) gem_reg_read (timestamp-moving)
[342.252547] Starting subtest: timestamp-moving
[343.262148] Subtest timestamp-moving: SUCCESS (1.001s)
[343.327826] [112/133] (682s left) kms_flip (absolute-wf_vblank)
[343.415710] Starting subtest: absolute-wf_vblank
[343.418353] Starting dynamic subtest: A-HDMI-A1
[351.110026] Dynamic subtest A-HDMI-A1: SUCCESS (7.671s)
[351.117414] Starting dynamic subtest: B-HDMI-A1
[358.774199] Dynamic subtest B-HDMI-A1: SUCCESS (7.653s)
[358.781465] Starting dynamic subtest: C-HDMI-A1
[366.434914] Dynamic subtest C-HDMI-A1: SUCCESS (7.657s)
[366.442996] Starting dynamic subtest: D-HDMI-A1
[374.091828] Dynamic subtest D-HDMI-A1: SUCCESS (7.655s)
[374.092499] Subtest absolute-wf_vblank: SUCCESS (30.652s)
[374.225714] [113/133] (651s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[374.318827] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[375.580234] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (1.261s)
[375.692218] [114/133] (649s left) perf_pmu (faulting-read)
[375.730469] Starting subtest: faulting-read
[375.731266] Starting dynamic subtest: gtt
[375.733404] Dynamic subtest gtt: SUCCESS (0.001s)
[375.743563] Starting dynamic subtest: wb
[375.744272] Dynamic subtest wb: SUCCESS (0.001s)
[375.751907] Starting dynamic subtest: wc
[375.752600] Dynamic subtest wc: SUCCESS (0.001s)
[375.759848] Starting dynamic subtest: uc
[375.760563] Dynamic subtest uc: SUCCESS (0.001s)
[375.761253] Subtest faulting-read: SUCCESS (0.009s)
[375.849318] [115/133] (649s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[375.938925] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[375.939676] Starting dynamic subtest: pipe-A
[376.084199] Dynamic subtest pipe-A: SUCCESS (0.145s)
[376.093351] Starting dynamic subtest: pipe-B
[376.211234] Dynamic subtest pipe-B: SUCCESS (0.126s)
[376.220503] Starting dynamic subtest: pipe-C
[376.354537] Dynamic subtest pipe-C: SUCCESS (0.142s)
[376.364400] Starting dynamic subtest: pipe-D
[376.488907] Dynamic subtest pipe-D: SUCCESS (0.133s)
[376.490910] Subtest planes-upscale-20x20-downscale-factor-0-75: SUCCESS (0.551s)
[376.669527] [116/133] (648s left) gem_exec_balancer (parallel-out-fence)
[376.829300] Subtest parallel-out-fence: SKIP (0.000s)
[376.903555] [117/133] (648s left) perf_pmu (busy-double-start)
[376.938686] Starting subtest: busy-double-start
[376.939374] Starting dynamic subtest: rcs0
[380.480590] Dynamic subtest rcs0: SUCCESS (3.541s)
[380.493919] Starting dynamic subtest: bcs0
[384.027595] Dynamic subtest bcs0: SUCCESS (3.545s)
[384.039166] Starting dynamic subtest: vcs0
[387.571653] Dynamic subtest vcs0: SUCCESS (3.541s)
[387.584182] Starting dynamic subtest: vcs1
[391.114702] Dynamic subtest vcs1: SUCCESS (3.541s)
[391.126262] Starting dynamic subtest: vecs0
[394.655531] Dynamic subtest vecs0: SUCCESS (3.538s)
[394.656553] Subtest busy-double-start: SUCCESS (17.718s)
[394.730731] [118/133] (631s left) i915_suspend (basic-s3-without-i915)
[394.762095] Starting subtest: basic-s3-without-i915