[58.922730] Initializing watchdogs
[58.922781]   /dev/watchdog0
[58.937281] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.941723] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.944103] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.947099] [001/133] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[59.082644] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[65.715917] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.637s)
[65.843197] [002/133] (953s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[66.221532] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[67.117329] [003/133] (952s left) kms_busy (basic-hang)
[67.262195] Starting subtest: basic-hang
[67.264592] Starting dynamic subtest: flip-pipe-A
[67.985655] Dynamic subtest flip-pipe-A: SUCCESS (0.723s)
[67.996674] Starting dynamic subtest: modeset-pipe-A
[71.421091] Dynamic subtest modeset-pipe-A: SUCCESS (3.432s)
[71.430921] Starting dynamic subtest: flip-pipe-D
[72.620239] Dynamic subtest flip-pipe-D: SUCCESS (1.199s)
[72.629657] Starting dynamic subtest: modeset-pipe-D
[75.971316] Dynamic subtest modeset-pipe-D: SUCCESS (3.352s)
[75.973706] Subtest basic-hang: SUCCESS (8.712s)
[76.774347] [004/133] (942s left) gem_exec_parallel (userptr)
[76.849220] Starting subtest: userptr
[76.851572] Starting dynamic subtest: rcs0
[78.277479] Dynamic subtest rcs0: SUCCESS (1.428s)
[78.286654] Starting dynamic subtest: bcs0
[79.763193] Dynamic subtest bcs0: SUCCESS (1.485s)
[79.773378] Starting dynamic subtest: vcs0
[81.879092] Dynamic subtest vcs0: SUCCESS (2.113s)
[81.889838] Starting dynamic subtest: vcs1
[83.858629] Dynamic subtest vcs1: SUCCESS (1.979s)
[83.868240] Starting dynamic subtest: vecs0
[85.848381] Dynamic subtest vecs0: SUCCESS (1.987s)
[85.858712] Starting dynamic subtest: ccs0
[87.333159] Dynamic subtest ccs0: SUCCESS (1.485s)
[87.335615] Subtest userptr: SUCCESS (10.484s)
[87.518312] [005/133] (932s left) kms_flip (2x-flip-vs-panning)
[87.623069] Starting subtest: 2x-flip-vs-panning
[87.635718] Subtest 2x-flip-vs-panning: SKIP (0.012s)
[87.714718] [006/133] (931s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[87.922261] Starting subtest: cursor-rapid-movement-128x128
[87.926762] Starting dynamic subtest: pipe-A-eDP-1
[88.489889] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.562s)
[88.517114] Starting dynamic subtest: pipe-D-eDP-1
[89.685133] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.174s)
[89.687556] Subtest cursor-rapid-movement-128x128: SUCCESS (1.762s)
[90.541531] [007/133] (929s left) kms_color (ctm-0-25)
[90.630351] Starting subtest: ctm-0-25
[90.632585] Starting dynamic subtest: pipe-A-eDP-1
[94.063248] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.433s)
[94.071462] Starting dynamic subtest: pipe-B-eDP-1
[98.200909] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.135s)
[98.209614] Starting dynamic subtest: pipe-C-eDP-1
[102.156324] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.956s)
[102.164066] Starting dynamic subtest: pipe-D-eDP-1
[106.154081] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.996s)
[106.156606] Subtest ctm-0-25: SUCCESS (15.522s)
[106.971974] [008/133] (912s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[107.075253] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[107.079229] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[107.168067] [009/133] (912s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[107.264309] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[107.268780] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[107.360288] [010/133] (912s left) kms_psr (psr-primary-render)
[107.446808] Starting subtest: psr-primary-render
[107.449098] Starting dynamic subtest: eDP-1
[109.178927] Dynamic subtest eDP-1: SUCCESS (1.732s)
[109.181243] Subtest psr-primary-render: SUCCESS (1.732s)
[110.050796] [011/133] (909s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[110.150887] Starting subtest: plane-scaler-unity-scaling-with-rotation
[110.153341] Starting dynamic subtest: pipe-A
[110.377366] Dynamic subtest pipe-A: SUCCESS (0.228s)
[110.385580] Starting dynamic subtest: pipe-B
[111.630813] Dynamic subtest pipe-B: SUCCESS (1.253s)
[111.638552] Starting dynamic subtest: pipe-C
[112.951627] Dynamic subtest pipe-C: SUCCESS (1.318s)
[112.965083] Starting dynamic subtest: pipe-D
[114.284695] Dynamic subtest pipe-D: SUCCESS (1.332s)
[114.287130] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.136s)
[115.478196] [012/133] (904s left) gem_exec_balancer (bonded-semaphore)
[115.546360] Starting subtest: bonded-semaphore
[115.551233] Subtest bonded-semaphore: SKIP (0.000s)
[115.833036] [013/133] (904s left) syncobj_eventfd (binary-wait)
[115.889284] Starting subtest: binary-wait
[115.898311] Subtest binary-wait: SUCCESS (0.010s)
[115.972580] [014/133] (904s left) kms_psr (fbc-psr-primary-render)
[116.070127] Starting subtest: fbc-psr-primary-render
[116.072455] Starting dynamic subtest: eDP-1
[116.076879] Dynamic subtest eDP-1: SKIP (0.000s)
[116.081293] Subtest fbc-psr-primary-render: SKIP (0.001s)
[116.144234] [015/133] (903s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[116.223352] Starting subtest: primary-y-tiled-reflect-x-0
[116.296510] Subtest primary-y-tiled-reflect-x-0: SKIP (0.071s)
[116.396715] [016/133] (903s left) gem_spin_batch (resubmit)
[116.461457] Starting subtest: resubmit
[116.463750] Starting dynamic subtest: rcs0
[116.469090] Dynamic subtest rcs0: SUCCESS (0.007s)
[116.478975] Starting dynamic subtest: bcs0
[116.481249] Dynamic subtest bcs0: SUCCESS (0.004s)
[116.489717] Starting dynamic subtest: vcs0
[116.491976] Dynamic subtest vcs0: SUCCESS (0.003s)
[116.499384] Starting dynamic subtest: vcs1
[116.501628] Dynamic subtest vcs1: SUCCESS (0.003s)
[116.508862] Starting dynamic subtest: vecs0
[116.511092] Dynamic subtest vecs0: SUCCESS (0.003s)
[116.518475] Starting dynamic subtest: ccs0
[116.520724] Dynamic subtest ccs0: SUCCESS (0.003s)
[116.522982] Subtest resubmit: SUCCESS (0.026s)
[116.722007] [017/133] (903s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[116.846213] Starting subtest: cursor-vs-flip-varying-size
[148.101206] Subtest cursor-vs-flip-varying-size: SUCCESS (31.253s)
[148.921605] [018/133] (871s left) kms_fbcon_fbt (fbc)
[148.980221] Starting subtest: fbc
[155.352207] Subtest fbc: SUCCESS (6.371s)
[156.442887] [019/133] (863s left) gem_busy (parallel)
[156.631454] Starting subtest: parallel
[156.633411] Starting dynamic subtest: rcs0
[157.909454] Dynamic subtest rcs0: SUCCESS (1.279s)
[157.923178] Starting dynamic subtest: bcs0
[159.893397] Dynamic subtest bcs0: SUCCESS (1.981s)
[159.905078] Starting dynamic subtest: vcs0
[161.941739] Dynamic subtest vcs0: SUCCESS (2.045s)
[161.952027] Starting dynamic subtest: vcs1
[163.925381] Dynamic subtest vcs1: SUCCESS (1.981s)
[163.935909] Starting dynamic subtest: vecs0
[165.909423] Dynamic subtest vecs0: SUCCESS (1.982s)
[165.920459] Starting dynamic subtest: ccs0
[167.893570] Dynamic subtest ccs0: SUCCESS (1.982s)
[167.896090] Subtest parallel: SUCCESS (11.264s)
[168.160828] [020/133] (852s left) kms_plane (pixel-format-4-tiled-modifier)
[168.260062] Starting subtest: pixel-format-4-tiled-modifier
[168.285707] Starting dynamic subtest: pipe-A-plane-0
[168.941149] Dynamic subtest pipe-A-plane-0: SUCCESS (0.656s)
[168.949180] Starting dynamic subtest: pipe-A-plane-3
[169.351989] Dynamic subtest pipe-A-plane-3: SUCCESS (0.409s)
[169.360219] Starting dynamic subtest: pipe-A-plane-5
[169.363548] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[170.442797] Starting dynamic subtest: pipe-B-plane-0
[171.081282] Dynamic subtest pipe-B-plane-0: SUCCESS (0.644s)
[171.089725] Starting dynamic subtest: pipe-B-plane-3
[171.535850] Dynamic subtest pipe-B-plane-3: SUCCESS (0.454s)
[171.543934] Starting dynamic subtest: pipe-B-plane-5
[171.547478] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[171.843572] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.585s)
[172.720272] [021/133] (847s left) i915_drm_fdinfo (busy-idle-check-all)
[172.766500] Starting subtest: busy-idle-check-all
[172.769032] Starting dynamic subtest: rcs0
[172.773826] Dynamic subtest rcs0: SKIP (0.004s)
[172.783599] Starting dynamic subtest: bcs0
[172.788090] Dynamic subtest bcs0: SKIP (0.000s)
[172.795504] Starting dynamic subtest: vcs0
[172.799665] Dynamic subtest vcs0: SKIP (0.000s)
[172.807348] Starting dynamic subtest: vcs1
[172.811620] Dynamic subtest vcs1: SKIP (0.000s)
[172.819143] Starting dynamic subtest: vecs0
[172.823438] Dynamic subtest vecs0: SKIP (0.000s)
[172.830874] Starting dynamic subtest: ccs0
[172.835184] Dynamic subtest ccs0: SKIP (0.000s)
[172.839490] Subtest busy-idle-check-all: SKIP (0.008s)
[172.875588] [022/133] (847s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[172.996567] Starting subtest: read-crc-frame-sequence
[172.998941] Starting dynamic subtest: pipe-A-eDP-1
[173.717615] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.721s)
[173.733512] Starting dynamic subtest: pipe-B-eDP-1
[175.103902] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.383s)
[175.113241] Starting dynamic subtest: pipe-C-eDP-1
[176.487481] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.382s)
[176.496226] Starting dynamic subtest: pipe-D-eDP-1
[177.828552] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.340s)
[177.830934] Subtest read-crc-frame-sequence: SUCCESS (4.833s)
[178.663223] [023/133] (841s left) prime_vgem (sync)
[178.826157] Starting subtest: sync
[178.828559] Starting dynamic subtest: rcs0
[178.867411] Dynamic subtest rcs0: SUCCESS (0.043s)
[178.875620] Starting dynamic subtest: bcs0
[178.914075] Dynamic subtest bcs0: SUCCESS (0.046s)
[178.922101] Starting dynamic subtest: vcs0
[178.962201] Dynamic subtest vcs0: SUCCESS (0.047s)
[178.969975] Starting dynamic subtest: vcs1
[179.007578] Dynamic subtest vcs1: SUCCESS (0.045s)
[179.015505] Starting dynamic subtest: vecs0
[179.053081] Dynamic subtest vecs0: SUCCESS (0.045s)
[179.060916] Starting dynamic subtest: ccs0
[179.097902] Dynamic subtest ccs0: SUCCESS (0.044s)
[179.100189] Subtest sync: SUCCESS (0.274s)
[179.218866] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true
[179.222133] [024/133] (841s left) kms_cursor_crc (cursor-tearing-position-change)
[179.344798] Starting subtest: cursor-tearing-position-change
[179.347022] Starting dynamic subtest: pipe-A-eDP-1
[179.919342] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.570s)
[179.928064] Starting dynamic subtest: pipe-D-eDP-1
[181.188372] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.270s)
[181.196418] Subtest cursor-tearing-position-change: SUCCESS (1.843s)
[182.047430] [025/133] (838s left) kms_content_protection (atomic-dpms)
[182.182711] Starting subtest: atomic-dpms
[182.187338] Subtest atomic-dpms: SKIP (0.000s)
[182.314025] [026/133] (838s left) kms_pm_rpm (modeset-pc8-residency-stress)
[184.046892] Starting subtest: modeset-pc8-residency-stress
[184.052726] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[184.558595] [027/133] (835s left) gen7_exec_parse (basic-offset)
[184.615639] Subtest basic-offset: SKIP (0.000s)
[184.696941] [028/133] (835s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[184.803606] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[184.808062] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[184.905349] [029/133] (835s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[185.006501] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[185.010579] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[185.128524] [030/133] (835s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[185.233189] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[185.237160] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[185.328873] [031/133] (835s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[185.430611] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[189.604775] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.177s)
[190.745687] [032/133] (830s left) kms_psr (fbc-psr2-primary-blt)
[190.842458] Starting subtest: fbc-psr2-primary-blt
[190.844746] Starting dynamic subtest: eDP-1
[190.849217] Dynamic subtest eDP-1: SKIP (0.000s)
[190.853662] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[190.917372] [033/133] (829s left) gem_eio (in-flight-contexts-10ms)
[191.156339] Starting subtest: in-flight-contexts-10ms
[204.914575] Subtest in-flight-contexts-10ms: SUCCESS (13.756s)
[205.073614] [034/133] (815s left) drm_read (short-buffer-nonblock)
[205.213345] Starting subtest: short-buffer-nonblock
[205.215637] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[205.328243] [035/133] (815s left) syncobj_timeline (invalid-signal-bad-pad)
[205.376858] Starting subtest: invalid-signal-bad-pad
[205.378970] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[205.470467] [036/133] (815s left) gem_exec_fence (syncobj-timeline-export)
[206.030334] Starting subtest: syncobj-timeline-export
[206.036922] Subtest syncobj-timeline-export: SUCCESS (0.008s)
[207.013982] [037/133] (813s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[207.105705] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[207.110700] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[207.213986] [038/133] (813s left) i915_query (query-regions-unallocated)
[207.267405] Starting subtest: query-regions-unallocated
[207.269637] Subtest query-regions-unallocated: SUCCESS (0.000s)
[207.362361] [039/133] (813s left) gem_partial_pwrite_pread (write-snoop)
[207.429268] Subtest write-snoop: SKIP (0.000s)
[207.503220] [040/133] (813s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[207.598281] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[207.602121] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[207.683472] [041/133] (813s left) gem_softpin (invalid)
[207.731740] Starting subtest: invalid
[207.740771] Subtest invalid: SUCCESS (0.008s)
[207.846054] [042/133] (813s left) kms_pm_rpm (fences)
[210.089284] Starting subtest: fences
[210.094824] Subtest fences: SKIP (0.000s)
[210.456758] [043/133] (810s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[210.517022] Starting subtest: etime-multi-wait-all-submitted-signaled
[210.625809] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.108s)
[210.702676] [044/133] (810s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[210.768735] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[210.773144] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[210.955697] [045/133] (810s left) kms_feature_discovery (display-1x)
[211.047775] Starting subtest: display-1x
[211.049973] Subtest display-1x: SUCCESS (0.000s)
[211.133662] [046/133] (810s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[211.192268] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[211.194638] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[211.301228] [047/133] (810s left) kms_async_flips (crc-atomic)
[211.385604] Starting subtest: crc-atomic
[211.759994] Starting dynamic subtest: pipe-A-eDP-1
[214.650049] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.889s)
[215.052764] Starting dynamic subtest: pipe-B-eDP-1
[217.921020] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.874s)
[218.295688] Starting dynamic subtest: pipe-C-eDP-1
[221.142358] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.855s)
[221.508080] Starting dynamic subtest: pipe-D-eDP-1
[224.368806] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.869s)
[224.371134] Subtest crc-atomic: SUCCESS (12.985s)
[225.556420] [048/133] (795s left) gem_exec_schedule (manyslice)
[225.627145] Starting subtest: manyslice
[225.629374] Starting dynamic subtest: rcs0
[230.763517] Dynamic subtest rcs0: SUCCESS (5.145s)
[230.772597] Starting dynamic subtest: bcs0
[238.416577] Dynamic subtest bcs0: SUCCESS (7.650s)
[238.429335] Starting dynamic subtest: vcs0
[244.495627] Dynamic subtest vcs0: SUCCESS (6.078s)
[244.511305] Starting dynamic subtest: vcs1
[250.076619] Dynamic subtest vcs1: SUCCESS (5.578s)
[250.088890] Starting dynamic subtest: vecs0
[256.156330] Dynamic subtest vecs0: SUCCESS (6.079s)
[256.168353] Starting dynamic subtest: ccs0
[263.369178] Dynamic subtest ccs0: SUCCESS (7.211s)
[263.372058] Subtest manyslice: SUCCESS (37.751s)
[263.675244] [049/133] (757s left) kms_plane_multiple (tiling-y)
[263.777095] Starting subtest: tiling-y
[263.781445] Subtest tiling-y: SKIP (0.000s)
[263.847405] [050/133] (757s left) kms_vblank (query-idle)
[263.932664] Starting subtest: query-idle
[263.934794] Starting dynamic subtest: pipe-A-eDP-1
[265.674323] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.742s)
[265.688631] Starting dynamic subtest: pipe-D-eDP-1
[268.073915] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.394s)
[268.075872] Subtest query-idle: SUCCESS (4.141s)
[268.902444] [051/133] (752s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[269.014096] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[269.018377] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[269.109351] [052/133] (752s left) kms_properties (get_properties-sanity-non-atomic)
[269.192977] Starting subtest: get_properties-sanity-non-atomic
[269.195204] Subtest get_properties-sanity-non-atomic: SUCCESS (0.001s)
[269.269835] [053/133] (752s left) gem_ctx_param (invalid-ctx-get)
[269.318926] Starting subtest: invalid-ctx-get
[269.321406] Subtest invalid-ctx-get: SUCCESS (0.000s)
[269.392976] [054/133] (752s left) kms_hdr (invalid-metadata-sizes)
[269.487062] Starting subtest: invalid-metadata-sizes
[269.493743] Subtest invalid-metadata-sizes: SKIP (0.000s)
[269.571750] [055/133] (752s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[269.649046] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[269.651285] Starting dynamic subtest: pipe-A-eDP-1
[269.660273] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[269.673073] Starting dynamic subtest: pipe-B-eDP-1
[269.682492] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[269.695055] Starting dynamic subtest: pipe-C-eDP-1
[269.703633] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[269.716020] Starting dynamic subtest: pipe-D-eDP-1
[269.724521] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[269.728702] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[271.954745] [056/133] (749s left) syncobj_wait (reset-signaled)
[272.010404] Starting subtest: reset-signaled
[272.012639] Subtest reset-signaled: SUCCESS (0.000s)
[272.118175] [057/133] (749s left) api_intel_bb (purge-bb)
[272.169523] Starting subtest: purge-bb
[272.172168] Subtest purge-bb: SUCCESS (0.003s)
[272.300303] [058/133] (749s left) perf_pmu (render-node-busy-idle)
[272.369885] Starting subtest: render-node-busy-idle
[272.372185] Starting dynamic subtest: rcs0
[273.061889] Dynamic subtest rcs0: SUCCESS (0.691s)
[273.073824] Starting dynamic subtest: bcs0
[273.726671] Dynamic subtest bcs0: SUCCESS (0.662s)
[273.738908] Starting dynamic subtest: vcs0
[274.901311] Dynamic subtest vcs0: SUCCESS (1.171s)
[274.913767] Starting dynamic subtest: vcs1
[276.884712] Dynamic subtest vcs1: SUCCESS (1.980s)
[276.897670] Starting dynamic subtest: vecs0
[278.933110] Dynamic subtest vecs0: SUCCESS (2.046s)
[278.945890] Starting dynamic subtest: ccs0
[279.595442] Dynamic subtest ccs0: SUCCESS (0.660s)
[279.598270] Subtest render-node-busy-idle: SUCCESS (7.226s)
[279.682577] [059/133] (742s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[279.800664] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[279.804712] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[279.903421] [060/133] (742s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[279.999188] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[280.001393] Starting dynamic subtest: pipe-A-eDP-1
[280.024826] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[280.035501] Starting dynamic subtest: pipe-B-eDP-1
[280.058096] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[280.066667] Starting dynamic subtest: pipe-C-eDP-1
[280.089093] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[280.097437] Starting dynamic subtest: pipe-D-eDP-1
[280.120600] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[280.124498] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[282.316170] [061/133] (739s left) gem_exec_reloc (basic-write-cpu-noreloc)
[282.369739] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[282.451581] [062/133] (739s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[282.562430] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[282.566837] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[282.671897] [063/133] (739s left) prime_mmap_coherency (read)
[282.728516] Starting subtest: read
[288.105582] Subtest read: SUCCESS (5.375s)
[288.233142] [064/133] (733s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[288.337497] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[289.337521] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.001s)
[289.460465] [065/133] (732s left) kms_psr (fbc-pr-dpms)
[289.567196] Starting subtest: fbc-pr-dpms
[289.571234] Subtest fbc-pr-dpms: SKIP (0.000s)
[289.639103] [066/133] (732s left) syncobj_wait (wait-all-snapshot)
[289.688049] Starting subtest: wait-all-snapshot
[289.769831] Subtest wait-all-snapshot: SUCCESS (0.082s)
[289.857492] [067/133] (732s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[289.969864] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[289.971842] Starting dynamic subtest: pipe-A-eDP-1
[290.078496] Dynamic subtest pipe-A-eDP-1: SKIP (0.111s)
[290.089677] Starting dynamic subtest: pipe-B-eDP-1
[291.201461] Dynamic subtest pipe-B-eDP-1: SKIP (1.120s)
[291.206057] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.233s)
[292.386334] [068/133] (729s left) kms_vrr (lobf)
[292.483890] Starting subtest: lobf
[292.488329] Subtest lobf: SKIP (0.000s)
[292.561418] [069/133] (729s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[292.609764] Starting subtest: multi-wait-all-for-submit-submitted
[292.713311] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.103s)
[292.801134] [070/133] (729s left) kms_invalid_mode (zero-clock)
[292.885729] Starting subtest: zero-clock
[292.888214] Starting dynamic subtest: pipe-A-eDP-1
[293.167716] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[293.177533] Starting dynamic subtest: pipe-B-eDP-1
[293.179737] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[293.188342] Starting dynamic subtest: pipe-C-eDP-1
[293.190635] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[293.199463] Starting dynamic subtest: pipe-D-eDP-1
[293.201757] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[293.204095] Subtest zero-clock: SUCCESS (0.292s)
[294.026076] [071/133] (728s left) sysfs_heartbeat_interval (idempotent)
[294.082369] Starting subtest: idempotent
[294.084588] Starting dynamic subtest: vecs0
[294.086819] Dynamic subtest vecs0: SUCCESS (0.001s)
[294.095989] Starting dynamic subtest: ccs0
[294.097880] Dynamic subtest ccs0: SUCCESS (0.001s)
[294.106274] Starting dynamic subtest: vcs0
[294.108109] Dynamic subtest vcs0: SUCCESS (0.000s)
[294.116527] Starting dynamic subtest: bcs0
[294.118420] Dynamic subtest bcs0: SUCCESS (0.001s)
[294.127174] Starting dynamic subtest: rcs0
[294.129270] Dynamic subtest rcs0: SUCCESS (0.000s)
[294.137777] Starting dynamic subtest: vcs1
[294.139661] Dynamic subtest vcs1: SUCCESS (0.000s)
[294.141559] Subtest idempotent: SUCCESS (0.008s)
[294.184905] [072/133] (728s left) gem_exec_schedule (u-fairslice)
[294.259666] Starting subtest: u-fairslice
[294.261607] Starting dynamic subtest: rcs0
[296.274090] Dynamic subtest rcs0: SUCCESS (2.021s)
[296.285783] Starting dynamic subtest: bcs0
[298.294679] Dynamic subtest bcs0: SUCCESS (2.019s)
[298.304529] Starting dynamic subtest: vcs0
[300.320275] Dynamic subtest vcs0: SUCCESS (2.023s)
[300.330100] Starting dynamic subtest: vcs1
[302.340322] Dynamic subtest vcs1: SUCCESS (2.020s)
[302.350184] Starting dynamic subtest: vecs0
[304.362510] Dynamic subtest vecs0: SUCCESS (2.019s)
[304.373044] Starting dynamic subtest: ccs0
[306.391822] Dynamic subtest ccs0: SUCCESS (2.030s)
[306.394091] Subtest u-fairslice: SUCCESS (12.139s)
[306.709421] [073/133] (715s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[306.827215] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[306.831273] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[306.922743] [074/133] (715s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[307.026828] Starting subtest: y-tiled-16bpp-rotate-0
[307.031204] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[307.124915] [075/133] (715s left) gem_ctx_persistence (many-contexts)
[307.195533] Starting subtest: many-contexts
[352.421993] Subtest many-contexts: SUCCESS (45.224s)
[352.510460] [076/133] (670s left) gem_close_race (basic-threads)
[352.585743] Starting subtest: basic-threads
[354.008365] Subtest basic-threads: SUCCESS (1.425s)
[354.211402] [077/133] (668s left) i915_pm_rps (reset)
[354.271057] Starting subtest: reset
[362.725612] Subtest reset: SUCCESS (8.453s)
[362.852869] [078/133] (659s left) kms_force_connector_basic (force-edid)
[362.930984] Starting subtest: force-edid
[363.299136] Subtest force-edid: SUCCESS (0.370s)
[363.457505] [079/133] (659s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[363.559346] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[363.563455] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[364.740294] [080/133] (658s left) kms_lease (lease-invalid-plane)
[364.846071] Starting subtest: lease-invalid-plane
[364.848286] Starting dynamic subtest: pipe-A-eDP-1
[364.850513] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[364.859399] Starting dynamic subtest: pipe-B-eDP-1
[364.861688] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[364.870588] Starting dynamic subtest: pipe-C-eDP-1
[364.872793] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[364.881574] Starting dynamic subtest: pipe-D-eDP-1
[364.883493] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[364.885345] Subtest lease-invalid-plane: SUCCESS (0.004s)
[364.923553] [081/133] (657s left) gem_lmem_swapping (random)
[364.966150] Subtest random: SKIP (0.000s)
[365.007717] [082/133] (657s left) kms_cursor_legacy (forked-bo)
[365.131192] Starting subtest: forked-bo
[365.133658] Starting dynamic subtest: pipe-A
[370.594554] Dynamic subtest pipe-A: SUCCESS (5.460s)
[370.606354] Starting dynamic subtest: pipe-B
[376.063404] Dynamic subtest pipe-B: SUCCESS (5.466s)
[376.076743] Starting dynamic subtest: pipe-C
[381.542391] Dynamic subtest pipe-C: SUCCESS (5.477s)
[381.554379] Starting dynamic subtest: pipe-D
[387.023752] Dynamic subtest pipe-D: SUCCESS (5.478s)
[387.035412] Starting dynamic subtest: all-pipes
[392.532156] Dynamic subtest all-pipes: SUCCESS (5.504s)
[392.534591] Subtest forked-bo: SUCCESS (27.396s)
[392.679395] [083/133] (630s left) kms_flip (flip-vs-fences-interruptible)
[392.782615] Starting subtest: flip-vs-fences-interruptible
[392.787186] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[392.878578] [084/133] (630s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[392.963182] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[392.965504] Starting dynamic subtest: pipe-A-eDP-1
[392.988073] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[392.999727] Starting dynamic subtest: pipe-B-eDP-1
[393.021071] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[393.029553] Starting dynamic subtest: pipe-C-eDP-1
[393.051075] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[393.059869] Starting dynamic subtest: pipe-D-eDP-1
[393.081217] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[393.085457] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[395.243587] [085/133] (627s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[395.309429] Starting subtest: yf-tiled-ccs-to-x-tiled
[395.313921] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[395.504975] [086/133] (627s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[395.603430] Starting subtest: 4-tiled-64bpp-rotate-270
[395.624068] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.020s)
[395.738929] [087/133] (627s left) gem_exec_capture (capture-recoverable)
[395.793641] Starting subtest: capture-recoverable
[395.799428] Subtest capture-recoverable: SUCCESS (0.003s)
[395.914242] [088/133] (627s left) api_intel_allocator (two-level-inception-interruptible)
[395.958388] Starting subtest: two-level-inception-interruptible
[401.364373] Subtest two-level-inception-interruptible: SUCCESS (5.406s)
[401.500656] [089/133] (621s left) dmabuf (all-tests)
[401.535901] Starting subtest: all-tests
[401.538099] Starting dynamic subtest: sanitycheck
[401.712524] Dynamic subtest sanitycheck: SUCCESS (0.176s)
[401.723041] Starting dynamic subtest: dma_fence
[401.929853] Dynamic subtest dma_fence: SUCCESS (0.214s)
[401.942696] Starting dynamic subtest: dma_fence_chain
[411.178550] Dynamic subtest dma_fence_chain: SUCCESS (9.246s)
[411.190666] Starting dynamic subtest: dma_fence_unwrap
[411.273454] Dynamic subtest dma_fence_unwrap: SUCCESS (0.092s)
[411.285901] Starting dynamic subtest: dma_resv
[411.369227] Dynamic subtest dma_resv: SUCCESS (0.094s)
[411.372101] Subtest all-tests: SUCCESS (9.835s)
[411.437277] [090/133] (611s left) kms_chamelium_edid (vga-edid-read)
[411.829845] Subtest vga-edid-read: SKIP (0.000s)
[412.613015] [091/133] (610s left) syncobj_basic (bad-flags-handle-to-fd)
[412.670830] Starting subtest: bad-flags-handle-to-fd
[412.673124] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[412.775334] [092/133] (610s left) perf (invalid-remove-userspace-config)
[412.892229] Starting subtest: invalid-remove-userspace-config
[412.900027] Subtest invalid-remove-userspace-config: SUCCESS (0.008s)
[412.940796] [093/133] (610s left) gem_lmem_swapping (heavy-multi)
[412.984995] Subtest heavy-multi: SKIP (0.000s)
[413.030540] [094/133] (610s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[413.155256] Starting subtest: cursorB-vs-flipA-legacy
[413.159813] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[413.298660] [095/133] (610s left) kms_psr (pr-cursor-plane-move)
[413.391234] Starting subtest: pr-cursor-plane-move
[413.395163] Subtest pr-cursor-plane-move: SKIP (0.000s)
[413.481599] [096/133] (609s left) gem_watchdog (default-physical)
[413.554956] Starting subtest: default-physical
[415.314593] Subtest default-physical: SUCCESS (1.772s)
[415.401622] [097/133] (608s left) kms_flip (absolute-wf_vblank-interruptible)
[415.492364] Starting subtest: absolute-wf_vblank-interruptible
[415.494815] Starting dynamic subtest: A-eDP1
[424.174339] Dynamic subtest A-eDP1: SUCCESS (8.680s)
[424.186997] Starting dynamic subtest: B-eDP1
[432.855238] Dynamic subtest B-eDP1: SUCCESS (8.680s)
[432.866178] Starting dynamic subtest: C-eDP1
[441.556505] Dynamic subtest C-eDP1: SUCCESS (8.700s)
[441.566112] Starting dynamic subtest: D-eDP1
[450.253620] Dynamic subtest D-eDP1: SUCCESS (8.696s)
[450.258652] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.765s)
[451.427729] [098/133] (572s left) prime_mmap_coherency (write)
[451.493674] Starting subtest: write
[456.873098] Subtest write: SUCCESS (5.377s)
[457.004291] [099/133] (566s left) gem_userptr_blits (usage-restrictions)
[457.061872] Starting subtest: usage-restrictions
[457.064113] Subtest usage-restrictions: SUCCESS (0.000s)
[457.174370] [100/133] (566s left) gem_pipe_control_store_loop (reused-buffer)
[457.247904] Starting subtest: reused-buffer
[459.400273] Subtest reused-buffer: SUCCESS (2.154s)
[459.528312] [101/133] (564s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[459.652487] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[477.565919] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.914s)
[478.433030] [102/133] (545s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[478.539244] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[478.543630] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[478.643115] [103/133] (545s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[478.714458] Subtest writes-after-reads: SKIP (0.000s)
[478.792341] [104/133] (545s left) gem_exec_params (no-blt)
[478.842460] Starting subtest: no-blt
[478.844761] Subtest no-blt: SUCCESS (0.002s)
[478.971479] [105/133] (544s left) gem_pwrite_snooped
[479.123226] [106/133] (544s left) gem_exec_reloc (basic-write-wc-noreloc)
[479.181447] Subtest basic-write-wc-noreloc: SKIP (0.000s)
[479.252357] [107/133] (544s left) gem_fenced_exec_thrash (2-spare-fences)
[479.319667] Subtest 2-spare-fences: SKIP (0.000s)
[479.400932] [108/133] (544s left) kms_vblank (invalid)
[479.503568] Starting subtest: invalid
[479.505197] Starting dynamic subtest: pipe-A-eDP-1
[479.902248] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.399s)
[479.904613] Subtest invalid: SUCCESS (0.401s)
[480.730684] [109/133] (543s left) gem_mmap_gtt (big-bo-tiledy)
[480.798267] Subtest big-bo-tiledY: SKIP (0.000s)
[480.860924] [110/133] (543s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[480.962777] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[480.965097] Starting dynamic subtest: pipe-A-default-mode
[482.167738] Dynamic subtest pipe-A-default-mode: SKIP (1.202s)
[482.172232] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.204s)
[482.312102] [111/133] (541s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[482.411076] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[482.415455] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[482.507410] [112/133] (541s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[482.599634] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[482.610778] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.010s)
[482.687340] [113/133] (541s left) kms_addfb_basic (unused-modifier)
[482.742173] Starting subtest: unused-modifier
[482.744464] Subtest unused-modifier: SUCCESS (0.000s)
[482.886530] [114/133] (541s left) kms_psr (psr2-dpms)
[482.980858] Starting subtest: psr2-dpms
[482.983066] Starting dynamic subtest: eDP-1
[485.894146] Dynamic subtest eDP-1: SUCCESS (2.911s)
[485.896373] Subtest psr2-dpms: SUCCESS (2.912s)
[486.748945] [115/133] (537s left) gem_ccs (large-ctrl-surf-copy)
[486.811616] Starting subtest: large-ctrl-surf-copy
[486.816108] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[486.923618] [116/133] (537s left) gem_ctx_persistence (engines-queued)
[486.998426] Starting subtest: engines-queued
[487.000763] Starting dynamic subtest: rcs0
[487.080982] Dynamic subtest rcs0: SUCCESS (0.082s)
[487.093495] Starting dynamic subtest: bcs0
[487.137956] Dynamic subtest bcs0: SUCCESS (0.054s)
[487.149682] Starting dynamic subtest: vcs0
[488.884427] Dynamic subtest vcs0: SUCCESS (1.742s)
[488.897770] Starting dynamic subtest: vcs1
[490.867230] Dynamic subtest vcs1: SUCCESS (1.980s)
[490.879819] Starting dynamic subtest: vecs0
[492.852677] Dynamic subtest vecs0: SUCCESS (1.982s)
[492.866252] Starting dynamic subtest: ccs0
[493.043218] Dynamic subtest ccs0: SUCCESS (0.189s)
[493.045843] Subtest engines-queued: SUCCESS (6.045s)
[493.126422] [117/133] (531s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[493.224431] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[493.228782] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[493.299566] [118/133] (531s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[493.395857] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs
[493.398100] Starting dynamic subtest: pipe-A-eDP-1
[493.420945] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[493.433556] Starting dynamic subtest: pipe-B-eDP-1
[493.454588] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[493.463558] Starting dynamic subtest: pipe-C-eDP-1
[493.484531] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[493.493069] Starting dynamic subtest: pipe-D-eDP-1
[493.513813] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[493.517631] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.011s)
[495.645374] [119/133] (528s left) gem_exec_reloc (basic-cpu-gtt-active)
[495.714839] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[495.791749] [120/133] (528s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[495.898960] Starting subtest: x-tiled-64bpp-rotate-0
[497.444628] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.546s)
[497.623373] [121/133] (526s left) syncobj_timeline (wait-all-snapshot)
[497.691042] Starting subtest: wait-all-snapshot
[497.770794] Subtest wait-all-snapshot: SUCCESS (0.082s)
[497.857816] [122/133] (526s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[497.961544] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[507.454658] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.491s)
[507.591453] [123/133] (517s left) kms_async_flips (crc)
[507.702144] Starting subtest: crc
[508.092318] Starting dynamic subtest: pipe-A-eDP-1
[511.009738] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.915s)
[511.396372] Starting dynamic subtest: pipe-B-eDP-1
[514.324379] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.934s)
[514.707468] Starting dynamic subtest: pipe-C-eDP-1
[517.582467] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.894s)
[517.953811] Starting dynamic subtest: pipe-D-eDP-1
[520.797392] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.853s)
[520.799796] Subtest crc: SUCCESS (13.099s)
[522.023937] [124/133] (502s left) kms_cursor_crc (cursor-onscreen-512x170)
[522.316598] Starting subtest: cursor-onscreen-512x170
[522.321323] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[522.443458] [125/133] (502s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[522.540432] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[522.544449] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[522.635136] [126/133] (502s left) gem_exec_reloc (basic-write-cpu-active)
[522.694043] Subtest basic-write-cpu-active: SKIP (0.000s)
[522.772832] [127/133] (502s left) gem_exec_whisper (basic-contexts-forked-all)
[522.828440] Starting subtest: basic-contexts-forked-all
[545.812092] Subtest basic-contexts-forked-all: SUCCESS (22.980s)
[545.994864] [128/133] (478s left) i915_hangman (engine-error-state-capture)
[546.066334] Starting subtest: engine-error-state-capture
[546.068656] Starting dynamic subtest: rcs0
[549.875614] Dynamic subtest rcs0: SUCCESS (3.808s)
[549.890296] Starting dynamic subtest: bcs0
[555.891300] Dynamic subtest bcs0: SUCCESS (6.012s)
[555.905569] Starting dynamic subtest: vcs0
[561.843642] Dynamic subtest vcs0: SUCCESS (5.949s)
[561.856526] Starting dynamic subtest: vcs1
[567.859876] Dynamic subtest vcs1: SUCCESS (6.013s)
[567.872493] Starting dynamic subtest: vecs0
[573.811206] Dynamic subtest vecs0: SUCCESS (5.948s)
[573.824214] Starting dynamic subtest: ccs0
[578.866963] Dynamic subtest ccs0: SUCCESS (5.053s)
[578.869762] Subtest engine-error-state-capture: SUCCESS (32.802s)
[578.965351] [129/133] (445s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[579.063052] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[579.065420] Starting dynamic subtest: pipe-A
[580.110519] Dynamic subtest pipe-A: SUCCESS (1.050s)
[580.124040] Starting dynamic subtest: pipe-B
[582.196838] Dynamic subtest pipe-B: SUCCESS (2.084s)
[582.207264] Starting dynamic subtest: pipe-C
[583.353839] Dynamic subtest pipe-C: SUCCESS (1.156s)
[583.363282] Starting dynamic subtest: pipe-D
[584.548971] Dynamic subtest pipe-D: SUCCESS (1.194s)
[584.551360] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.489s)
[585.716722] [130/133] (439s left) gem_exec_async (forked-writes)
[585.777656] Starting subtest: forked-writes
[585.780105] Starting dynamic subtest: rcs0
[585.803443] Dynamic subtest rcs0: SUCCESS (0.025s)
[585.813363] Starting dynamic subtest: bcs0
[585.825792] Dynamic subtest bcs0: SUCCESS (0.022s)
[585.836240] Starting dynamic subtest: vcs0
[585.848757] Dynamic subtest vcs0: SUCCESS (0.022s)
[585.858379] Starting dynamic subtest: vcs1
[585.870913] Dynamic subtest vcs1: SUCCESS (0.021s)
[585.880604] Starting dynamic subtest: vecs0
[585.894065] Dynamic subtest vecs0: SUCCESS (0.022s)
[585.903828] Starting dynamic subtest: ccs0
[585.915314] Dynamic subtest ccs0: SUCCESS (0.020s)
[585.917578] Subtest forked-writes: SUCCESS (0.138s)
[586.154591] [131/133] (438s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[586.252048] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[587.076040] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.826s)
[587.242274] [132/133] (437s left) gem_pread (self)
[587.300257] Subtest self: SKIP (0.000s)
[587.355495] [133/133] (437s left) gem_mmap_offset (blt-coherency)
[587.415451] Starting subtest: blt-coherency
[587.422262] Subtest blt-coherency: SUCCESS (0.009s)
[587.540029] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_chamelium_hpd
results: parsing output: 2/ for test: kms_busy
results: parsing output: 3/ for test: gem_exec_parallel
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: kms_cursor_crc
results: parsing output: 6/ for test: kms_color
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: kms_plane_scaling
results: parsing output: 11/ for test: gem_exec_balancer
results: parsing output: 12/ for test: syncobj_eventfd
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: kms_rotation_crc
results: parsing output: 15/ for test: gem_spin_batch
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: kms_fbcon_fbt
results: parsing output: 18/ for test: gem_busy
results: parsing output: 19/ for test: kms_plane
results: parsing output: 20/ for test: i915_drm_fdinfo
results: parsing output: 21/ for test: kms_pipe_crc_basic
results: parsing output: 22/ for test: prime_vgem
results: parsing output: 23/ for test: kms_cursor_crc
results: parsing output: 24/ for test: kms_content_protection
results: parsing output: 25/ for test: kms_pm_rpm
results: parsing output: 26/ for test: gen7_exec_parse
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_psr
results: parsing output: 32/ for test: gem_eio
results: parsing output: 33/ for test: drm_read
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: gem_exec_fence
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: i915_query
results: parsing output: 38/ for test: gem_partial_pwrite_pread
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_softpin
results: parsing output: 41/ for test: kms_pm_rpm
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: gem_render_copy
results: parsing output: 44/ for test: kms_feature_discovery
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: kms_async_flips
results: parsing output: 47/ for test: gem_exec_schedule
results: parsing output: 48/ for test: kms_plane_multiple
results: parsing output: 49/ for test: kms_vblank
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_properties
results: parsing output: 52/ for test: gem_ctx_param
results: parsing output: 53/ for test: kms_hdr
results: parsing output: 54/ for test: kms_ccs
results: parsing output: 55/ for test: syncobj_wait
results: parsing output: 56/ for test: api_intel_bb
results: parsing output: 57/ for test: perf_pmu
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: gem_exec_reloc
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: prime_mmap_coherency
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: syncobj_wait
results: parsing output: 66/ for test: kms_psr2_sf
results: parsing output: 67/ for test: kms_vrr
results: parsing output: 68/ for test: syncobj_wait
results: parsing output: 69/ for test: kms_invalid_mode
results: parsing output: 70/ for test: sysfs_heartbeat_interval
results: parsing output: 71/ for test: gem_exec_schedule
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: gem_ctx_persistence
results: parsing output: 75/ for test: gem_close_race
results: parsing output: 76/ for test: i915_pm_rps
results: parsing output: 77/ for test: kms_force_connector_basic
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: kms_lease
results: parsing output: 80/ for test: gem_lmem_swapping
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: kms_flip
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: gem_render_copy
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: gem_exec_capture
results: parsing output: 87/ for test: api_intel_allocator
results: parsing output: 88/ for test: dmabuf
results: parsing output: 89/ for test: kms_chamelium_edid
results: parsing output: 90/ for test: syncobj_basic
results: parsing output: 91/ for test: perf
results: parsing output: 92/ for test: gem_lmem_swapping
results: parsing output: 93/ for test: kms_cursor_legacy
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: gem_watchdog
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: prime_mmap_coherency
results: parsing output: 98/ for test: gem_userptr_blits
results: parsing output: 99/ for test: gem_pipe_control_store_loop
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 103/ for test: gem_exec_params
results: parsing output: 104/ for test: gem_pwrite_snooped
results: parsing output: 105/ for test: gem_exec_reloc
results: parsing output: 106/ for test: gem_fenced_exec_thrash
results: parsing output: 107/ for test: kms_vblank
results: parsing output: 108/ for test: gem_mmap_gtt
results: parsing output: 109/ for test: kms_flip_scaled_crc
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_flip
results: parsing output: 112/ for test: kms_addfb_basic
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: gem_ccs
results: parsing output: 115/ for test: gem_ctx_persistence
results: parsing output: 116/ for test: kms_psr2_sf
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: gem_exec_reloc
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_async_flips
results: parsing output: 123/ for test: kms_cursor_crc
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_exec_reloc
results: parsing output: 126/ for test: gem_exec_whisper
results: parsing output: 127/ for test: i915_hangman
results: parsing output: 128/ for test: kms_plane_scaling
results: parsing output: 129/ for test: gem_exec_async
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: gem_pread
results: parsing output: 132/ for test: gem_mmap_offset
Done.