[58.314843] Initializing watchdogs
[58.314887]   /dev/watchdog0
[58.328147] [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.332409] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.334515] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.337858] [001/133] (960s left) kms_vblank (ts-continuation-modeset-rpm)
[58.451879] Starting subtest: ts-continuation-modeset-rpm
[58.454151] Starting dynamic subtest: pipe-A-eDP-1
[61.001952] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.547s)
[61.015813] Starting dynamic subtest: pipe-D-eDP-1
[63.256075] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.252s)
[63.258803] Subtest ts-continuation-modeset-rpm: SUCCESS (4.803s)
[64.067141] [002/133] (954s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[64.188632] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[64.193044] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[64.309094] [003/133] (954s left) syncobj_timeline (invalid-wait-illegal-handle)
[64.360074] Starting subtest: invalid-wait-illegal-handle
[64.362185] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[64.488324] [004/133] (954s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[64.589263] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[64.593875] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[64.672886] [005/133] (954s left) kms_draw_crc (draw-method-render)
[64.775853] Starting subtest: draw-method-render
[64.778170] Starting dynamic subtest: xrgb8888-untiled
[65.018369] Dynamic subtest xrgb8888-untiled: SUCCESS (0.245s)
[65.025936] Starting dynamic subtest: rgb565-untiled
[65.229532] Dynamic subtest rgb565-untiled: SUCCESS (0.211s)
[65.237605] Starting dynamic subtest: xrgb2101010-untiled
[65.462902] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.233s)
[65.469252] Starting dynamic subtest: xbgr16161616f-untiled
[65.674205] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.211s)
[65.683297] Starting dynamic subtest: xrgb8888-xtiled
[65.796269] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[65.804194] Starting dynamic subtest: rgb565-xtiled
[65.907562] Dynamic subtest rgb565-xtiled: SUCCESS (0.111s)
[65.915250] Starting dynamic subtest: xrgb2101010-xtiled
[66.007672] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.100s)
[66.014148] Starting dynamic subtest: xbgr16161616f-xtiled
[66.141218] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[66.148891] Starting dynamic subtest: xrgb8888-4tiled
[66.263245] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.122s)
[66.271234] Starting dynamic subtest: rgb565-4tiled
[66.374539] Dynamic subtest rgb565-4tiled: SUCCESS (0.111s)
[66.382620] Starting dynamic subtest: xrgb2101010-4tiled
[66.485793] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.111s)
[66.492145] Starting dynamic subtest: xbgr16161616f-4tiled
[66.618979] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[66.620991] Subtest draw-method-render: SUCCESS (1.845s)
[66.830979] [006/133] (952s left) sw_sync (alloc_fence)
[66.873761] Starting subtest: alloc_fence
[66.876043] Subtest alloc_fence: SUCCESS (0.000s)
[66.960896] [007/133] (952s left) gem_close (many-handles-one-vma)
[67.115559] Starting subtest: many-handles-one-vma
[67.153781] Subtest many-handles-one-vma: SUCCESS (0.040s)
[67.328378] [008/133] (951s left) gem_userptr_blits (probe)
[67.492021] Starting subtest: probe
[67.680981] Subtest probe: SUCCESS (0.187s)
[67.906305] [009/133] (951s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[68.016148] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[68.095925] [010/133] (951s left) perf (polling)
[68.214161] Starting subtest: polling
[68.216075] Starting dynamic subtest: 0-rcs0
[78.239435] Dynamic subtest 0-rcs0: SUCCESS (10.023s)
[78.246958] Starting dynamic subtest: 1-vecs0
[88.262659] Dynamic subtest 1-vecs0: SUCCESS (10.022s)
[88.264954] Subtest polling: SUCCESS (20.045s)
[88.306504] [011/133] (930s left) gem_exec_balancer (bonded-sync)
[88.385560] Starting subtest: bonded-sync
[88.390360] Subtest bonded-sync: SKIP (0.000s)
[88.705488] [012/133] (930s left) gem_exec_schedule (fairslice-all)
[88.783197] Starting subtest: fairslice-all
[90.856486] Subtest fairslice-all: SUCCESS (2.078s)
[91.966086] [013/133] (927s left) perf_pmu (busy-accuracy-98)
[92.009491] Starting subtest: busy-accuracy-98
[92.011642] Starting dynamic subtest: rcs0
[95.052752] Dynamic subtest rcs0: SUCCESS (3.042s)
[95.062478] Starting dynamic subtest: bcs0
[98.106889] Dynamic subtest bcs0: SUCCESS (3.053s)
[98.116798] Starting dynamic subtest: vcs0
[101.146681] Dynamic subtest vcs0: SUCCESS (3.039s)
[101.156402] Starting dynamic subtest: vcs1
[104.184701] Dynamic subtest vcs1: SUCCESS (3.036s)
[104.192747] Starting dynamic subtest: vecs0
[107.225703] Dynamic subtest vecs0: SUCCESS (3.040s)
[107.236024] Starting dynamic subtest: ccs0
[110.278990] Dynamic subtest ccs0: SUCCESS (3.052s)
[110.281469] Subtest busy-accuracy-98: SUCCESS (18.268s)
[110.424220] [014/133] (908s left) prime_mmap_kms (buffer-sharing)
[110.537571] Starting subtest: buffer-sharing
[110.982221] Subtest buffer-sharing: SUCCESS (0.443s)
[111.793392] [015/133] (907s left) gem_exec_reloc (basic-write-gtt)
[111.870822] Subtest basic-write-gtt: SKIP (0.000s)
[111.958152] [016/133] (907s left) gem_exec_schedule (reorder-wide)
[112.157825] Subtest reorder-wide: SKIP (0.000s)
[112.363106] [017/133] (907s left) kms_psr (psr-sprite-plane-onoff)
[112.457355] Starting subtest: psr-sprite-plane-onoff
[112.459528] Starting dynamic subtest: eDP-1
[114.235889] Dynamic subtest eDP-1: SUCCESS (1.778s)
[114.238438] Subtest psr-sprite-plane-onoff: SUCCESS (1.779s)
[115.056958] [018/133] (904s left) gem_ctx_shared (exec-single-timeline)
[115.124843] Starting subtest: exec-single-timeline
[115.126832] Starting dynamic subtest: rcs0
[116.146156] Dynamic subtest rcs0: SUCCESS (1.021s)
[116.157162] Starting dynamic subtest: bcs0
[117.169877] Dynamic subtest bcs0: SUCCESS (1.023s)
[117.180844] Starting dynamic subtest: vcs0
[118.261059] Dynamic subtest vcs0: SUCCESS (1.090s)
[118.271939] Starting dynamic subtest: vcs1
[119.347472] Dynamic subtest vcs1: SUCCESS (1.085s)
[119.358227] Starting dynamic subtest: vecs0
[120.435734] Dynamic subtest vecs0: SUCCESS (1.087s)
[120.446988] Starting dynamic subtest: ccs0
[121.523065] Dynamic subtest ccs0: SUCCESS (1.086s)
[121.525848] Subtest exec-single-timeline: SUCCESS (6.399s)
[121.721926] [019/133] (897s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[121.830479] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[121.835073] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[121.948120] [020/133] (897s left) perf (short-reads)
[122.051498] Starting subtest: short-reads
[122.064879] Subtest short-reads: SUCCESS (0.014s)
[122.098247] [021/133] (897s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[122.194959] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[122.221122] Starting dynamic subtest: pipe-A-plane-0
[122.509957] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[122.517434] Starting dynamic subtest: pipe-A-plane-3
[122.754075] Dynamic subtest pipe-A-plane-3: SUCCESS (0.244s)
[122.762851] Starting dynamic subtest: pipe-A-plane-5
[122.766490] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[123.833378] Starting dynamic subtest: pipe-B-plane-0
[124.117077] Dynamic subtest pipe-B-plane-0: SUCCESS (0.289s)
[124.127306] Starting dynamic subtest: pipe-B-plane-3
[124.351469] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[124.367579] Starting dynamic subtest: pipe-B-plane-5
[124.372727] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[124.660763] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.464s)
[125.513696] [022/133] (894s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[125.622832] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[125.627274] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[125.736779] [023/133] (893s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[125.799558] Starting subtest: legacy-engines-hostile-preempt
[125.801593] Starting dynamic subtest: render
[125.896832] Dynamic subtest render: SUCCESS (0.098s)
[125.908228] Starting dynamic subtest: bsd1
[127.918576] Dynamic subtest bsd1: SUCCESS (2.018s)
[127.929374] Starting dynamic subtest: bsd2
[129.853872] Dynamic subtest bsd2: SUCCESS (1.933s)
[129.864296] Starting dynamic subtest: blt
[129.926526] Dynamic subtest blt: SUCCESS (0.072s)
[129.935440] Starting dynamic subtest: vebox
[131.944281] Dynamic subtest vebox: SUCCESS (2.015s)
[131.946825] Subtest legacy-engines-hostile-preempt: SUCCESS (6.145s)
[132.036212] [024/133] (887s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[132.138504] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[136.381314] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.246s)
[137.535178] [025/133] (882s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[137.588816] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[137.591224] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[137.713884] [026/133] (882s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[137.815647] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[137.819822] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[137.963040] [027/133] (881s left) kms_hdr (bpc-switch)
[138.086476] Starting subtest: bpc-switch
[139.185054] Starting dynamic subtest: pipe-A-eDP-1
[142.578784] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.394s)
[142.581182] Subtest bpc-switch: SUCCESS (4.495s)
[142.710598] [028/133] (877s left) kms_flip (2x-plain-flip-ts-check)
[142.808253] Starting subtest: 2x-plain-flip-ts-check
[142.822428] Subtest 2x-plain-flip-ts-check: SKIP (0.011s)
[142.930813] [029/133] (877s left) i915_pm_rps (thresholds-park)
[142.999285] Starting subtest: thresholds-park
[143.003771] Subtest thresholds-park: SKIP (0.001s)
[143.125296] [030/133] (876s left) kms_chamelium_color (ctm-blue-to-red)
[143.226774] Subtest ctm-blue-to-red: SKIP (0.000s)
[143.265801] [031/133] (876s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[143.372261] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[143.374565] Starting dynamic subtest: pipe-A-eDP-1
[143.383413] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[143.392826] Starting dynamic subtest: pipe-B-eDP-1
[143.401209] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[143.409062] Starting dynamic subtest: pipe-C-eDP-1
[143.417113] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[143.424468] Starting dynamic subtest: pipe-D-eDP-1
[143.432686] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[143.436757] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[145.531282] [032/133] (874s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[145.655968] Starting subtest: flip-vs-cursor-crc-atomic
[146.322884] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.665s)
[147.140709] [033/133] (872s left) kms_plane_alpha_blend (alpha-opaque-fb)
[147.231358] Starting subtest: alpha-opaque-fb
[147.516838] Starting dynamic subtest: pipe-A-eDP-1
[148.167933] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.649s)
[148.176908] Starting dynamic subtest: pipe-D-eDP-1
[149.455204] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.285s)
[149.457712] Subtest alpha-opaque-fb: SUCCESS (2.221s)
[150.307731] [034/133] (869s left) kms_big_fb (4-tiled-addfb)
[150.427339] Starting subtest: 4-tiled-addfb
[150.429493] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[150.545662] [035/133] (869s left) kms_atomic (crtc-invalid-params-fence)
[150.637864] Starting subtest: crtc-invalid-params-fence
[150.640179] Starting dynamic subtest: pipe-A-eDP-1
[151.044304] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.406s)
[151.046540] Subtest crtc-invalid-params-fence: SUCCESS (0.407s)
[151.930970] [036/133] (868s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[152.034378] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[156.470270] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.439s)
[157.622312] [037/133] (862s left) syncobj_wait (single-wait-for-submit-submitted)
[157.675830] Starting subtest: single-wait-for-submit-submitted
[157.777889] Subtest single-wait-for-submit-submitted: SUCCESS (0.101s)
[157.862716] [038/133] (862s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[157.972604] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[157.976750] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[158.097759] [039/133] (862s left) kms_cursor_edge_walk (128x128-left-edge)
[158.193621] Starting subtest: 128x128-left-edge
[158.195823] Starting dynamic subtest: pipe-A-eDP-1
[161.677368] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.482s)
[161.686092] Starting dynamic subtest: pipe-D-eDP-1
[164.799508] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.122s)
[164.801770] Subtest 128x128-left-edge: SUCCESS (6.607s)
[165.621724] [040/133] (854s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[165.720033] Starting subtest: fbc-psr-cursor-mmap-cpu
[165.722159] Starting dynamic subtest: eDP-1
[165.726301] Dynamic subtest eDP-1: SKIP (0.000s)
[165.730598] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s)
[165.825288] [041/133] (854s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[165.936865] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[165.939196] Starting dynamic subtest: pipe-A-eDP-1
[166.008132] Dynamic subtest pipe-A-eDP-1: SKIP (0.076s)
[166.016165] Starting dynamic subtest: pipe-B-eDP-1
[167.170068] Dynamic subtest pipe-B-eDP-1: SKIP (1.159s)
[167.174344] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.238s)
[168.362000] [042/133] (852s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[168.453104] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[168.836845] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[171.637012] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.799s)
[171.651262] Starting dynamic subtest: pipe-A-eDP-1-4
[173.812169] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s)
[173.825696] Starting dynamic subtest: pipe-A-eDP-1-4
[175.822191] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[175.835782] Starting dynamic subtest: pipe-A-eDP-1-x
[178.011608] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.188s)
[178.376328] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[181.167590] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.797s)
[181.181077] Starting dynamic subtest: pipe-B-eDP-1-4
[183.352738] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s)
[183.363665] Starting dynamic subtest: pipe-B-eDP-1-4
[185.362846] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.010s)
[185.373551] Starting dynamic subtest: pipe-B-eDP-1-x
[187.553726] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.190s)
[187.914826] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[190.702148] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.793s)
[190.712370] Starting dynamic subtest: pipe-C-eDP-1-4
[192.877758] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[192.887651] Starting dynamic subtest: pipe-C-eDP-1-4
[194.887461] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[194.896085] Starting dynamic subtest: pipe-C-eDP-1-x
[197.066216] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[197.425325] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[200.229465] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.809s)
[200.240081] Starting dynamic subtest: pipe-D-eDP-1-4
[202.404333] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.175s)
[202.412185] Starting dynamic subtest: pipe-D-eDP-1-4
[204.414293] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[204.422146] Starting dynamic subtest: pipe-D-eDP-1-x
[206.592486] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s)
[206.594831] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.140s)
[207.832273] [043/133] (812s left) gem_exec_whisper (basic-contexts-priority)
[207.908063] Starting subtest: basic-contexts-priority
[231.420117] Subtest basic-contexts-priority: SUCCESS (23.508s)
[231.623379] [044/133] (788s left) syncobj_wait (invalid-signal-bad-pad)
[231.678881] Starting subtest: invalid-signal-bad-pad
[231.681181] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[231.807071] [045/133] (788s left) gem_ctx_param (set-priority-not-supported)
[231.860846] Starting subtest: set-priority-not-supported
[231.865512] Subtest set-priority-not-supported: SKIP (0.000s)
[231.959096] [046/133] (788s left) kms_big_fb (linear-64bpp-rotate-270)
[232.059356] Starting subtest: linear-64bpp-rotate-270
[232.081079] Subtest linear-64bpp-rotate-270: SKIP (0.021s)
[232.227828] [047/133] (788s left) syncobj_wait (invalid-wait-illegal-handle)
[232.295502] Starting subtest: invalid-wait-illegal-handle
[232.297826] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[232.400254] [048/133] (788s left) kms_cursor_crc (cursor-onscreen-256x256)
[232.655299] Starting subtest: cursor-onscreen-256x256
[232.659504] Starting dynamic subtest: pipe-A-eDP-1
[234.790471] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.130s)
[234.844090] Starting dynamic subtest: pipe-D-eDP-1
[237.607069] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.766s)
[237.609026] Subtest cursor-onscreen-256x256: SUCCESS (4.948s)
[238.431109] [049/133] (782s left) gem_exec_schedule (preempt-queue-chain)
[238.497807] Subtest preempt-queue-chain: SKIP (0.000s)
[238.791973] [050/133] (781s left) syncobj_eventfd (timeline-wait-signaled)
[238.854776] Starting subtest: timeline-wait-signaled
[238.856753] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[238.977434] [051/133] (781s left) gem_workarounds (suspend-resume-context)
[239.048250] Starting subtest: suspend-resume-context
[255.140862] Subtest suspend-resume-context: SUCCESS (1.392s)
[255.304533] [052/133] (765s left) gem_spin_batch (spin-each)
[255.388030] Starting subtest: spin-each
[258.754956] Subtest spin-each: SUCCESS (3.346s)
[260.671567] [053/133] (760s left) vgem_basic (sysfs)
[260.808336] Starting subtest: sysfs
[260.810264] Subtest sysfs: SUCCESS (0.000s)
[260.872386] [FACT vgem_basic (sysfs)] new: kernel.kmod_is_loaded.vgem: true
[260.875834] [054/133] (760s left) kms_color (ctm-red-to-blue)
[260.980711] Starting subtest: ctm-red-to-blue
[260.982659] Starting dynamic subtest: pipe-A-eDP-1
[261.710889] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.729s)
[261.720557] Starting dynamic subtest: pipe-B-eDP-1
[263.168607] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.454s)
[263.178510] Starting dynamic subtest: pipe-C-eDP-1
[264.525829] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.353s)
[264.535467] Starting dynamic subtest: pipe-D-eDP-1
[265.865705] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.337s)
[265.867851] Subtest ctm-red-to-blue: SUCCESS (4.877s)
[266.670706] [055/133] (754s left) kms_psr (fbc-psr-suspend)
[266.765485] Starting subtest: fbc-psr-suspend
[266.767657] Starting dynamic subtest: eDP-1
[266.771661] Dynamic subtest eDP-1: SKIP (0.000s)
[266.775601] Subtest fbc-psr-suspend: SKIP (0.001s)
[266.848894] [056/133] (754s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[266.951663] Starting subtest: pr-overlay-plane-update-continuous-sf
[266.955828] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[267.032644] [057/133] (754s left) gem_shrink (reclaim)
[267.100851] Starting subtest: reclaim
[269.595670] Subtest reclaim: SUCCESS (2.491s)
[269.769845] [058/133] (751s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[269.871698] Starting subtest: psr-shrfb-scaledprimary
[275.664886] Subtest psr-shrfb-scaledprimary: SUCCESS (5.791s)
[275.816391] [059/133] (745s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[276.204498] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[277.000226] [060/133] (744s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[277.097864] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[277.100227] Starting dynamic subtest: pipe-A-default-mode
[279.844051] Dynamic subtest pipe-A-default-mode: SUCCESS (2.743s)
[279.846048] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.744s)
[280.721691] [061/133] (740s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[280.851988] Starting subtest: flip-vs-cursor-atomic-transitions
[288.343197] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.487s)
[289.151652] [062/133] (732s left) kms_big_fb (y-tiled-addfb-size-overflow)
[289.253486] Starting subtest: y-tiled-addfb-size-overflow
[289.258035] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[289.372900] [063/133] (731s left) gem_userptr_blits (coherency-unsync)
[289.447330] Subtest coherency-unsync: SKIP (0.000s)
[289.595256] [064/133] (731s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[289.695921] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[289.698177] Starting dynamic subtest: pipe-A-eDP-1
[290.145657] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.427s)
[290.155677] Starting dynamic subtest: pipe-B-eDP-1
[291.590129] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.437s)
[291.600621] Starting dynamic subtest: pipe-C-eDP-1
[292.933158] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.341s)
[292.943728] Starting dynamic subtest: pipe-D-eDP-1
[294.281009] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.343s)
[294.283009] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.555s)
[295.465994] [065/133] (725s left) i915_pm_freq_mult (media-freq)
[295.539455] Starting subtest: media-freq
[295.541860] Starting dynamic subtest: gt0
[295.546096] Dynamic subtest gt0: SKIP (0.000s)
[295.557051] Starting dynamic subtest: gt1
[295.561264] Dynamic subtest gt1: SKIP (0.000s)
[295.565412] Subtest media-freq: SKIP (0.002s)
[295.674948] [066/133] (725s left) gem_exec_fence (syncobj-invalid-flags)
[296.093491] Starting subtest: syncobj-invalid-flags
[296.095958] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[297.682896] [067/133] (723s left) kms_universal_plane (disable-primary-vs-flip)
[297.784721] Starting subtest: disable-primary-vs-flip
[297.787024] Starting dynamic subtest: pipe-A-eDP-1
[299.342192] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.554s)
[299.352031] Starting dynamic subtest: pipe-B-eDP-1
[301.620311] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.276s)
[301.630124] Starting dynamic subtest: pipe-C-eDP-1
[303.841973] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.219s)
[303.851974] Starting dynamic subtest: pipe-D-eDP-1
[305.999469] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.157s)
[306.001846] Subtest disable-primary-vs-flip: SUCCESS (8.213s)
[306.821597] [068/133] (714s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[306.933161] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[306.937309] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[307.050659] [069/133] (714s left) gem_mmap_gtt (zero-extend)
[307.108831] Subtest zero-extend: SKIP (0.000s)
[307.172569] [070/133] (714s left) syncobj_basic (bad-pad-handle-to-fd)
[307.226910] Starting subtest: bad-pad-handle-to-fd
[307.229032] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[307.349806] [071/133] (714s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[307.445270] Starting subtest: fbcpsr-1p-rte
[314.391932] Subtest fbcpsr-1p-rte: SUCCESS (6.947s)
[314.576143] [072/133] (707s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[314.677405] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[321.362487] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.686s)
[321.508638] [073/133] (700s left) gem_ccs (block-multicopy-compressed)
[321.563480] Starting subtest: block-multicopy-compressed
[321.567941] Subtest block-multicopy-compressed: SKIP (0.000s)
[321.700146] [074/133] (700s left) kms_flip (flip-vs-suspend)
[321.804889] Starting subtest: flip-vs-suspend
[321.807095] Starting dynamic subtest: A-eDP1
[371.031932] Dynamic subtest A-eDP1: SUCCESS (4.627s)
[371.046988] Starting dynamic subtest: B-eDP1
[420.014463] Dynamic subtest B-eDP1: SUCCESS (4.487s)
[420.031462] Starting dynamic subtest: C-eDP1
[469.041386] Dynamic subtest C-eDP1: SUCCESS (4.532s)
[469.052090] Starting dynamic subtest: D-eDP1
[518.044364] Dynamic subtest D-eDP1: SUCCESS (4.502s)
[518.050392] Subtest flip-vs-suspend: SUCCESS (18.159s)
[519.344903] [075/133] (502s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[519.454313] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[520.436099] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.980s)
[520.591776] [076/133] (501s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[520.689312] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[527.950671] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.249s)
[528.096027] [077/133] (493s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[528.161395] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[528.240743] [078/133] (493s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[528.367787] Starting subtest: plane-upscale-20x20-with-rotation
[528.370375] Starting dynamic subtest: pipe-A
[528.609163] Dynamic subtest pipe-A: SUCCESS (0.242s)
[528.619177] Starting dynamic subtest: pipe-B
[529.854223] Dynamic subtest pipe-B: SUCCESS (1.242s)
[529.863501] Starting dynamic subtest: pipe-C
[531.195295] Dynamic subtest pipe-C: SUCCESS (1.338s)
[531.210679] Starting dynamic subtest: pipe-D
[532.532259] Dynamic subtest pipe-D: SUCCESS (1.335s)
[532.534596] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.161s)
[533.730799] [079/133] (488s left) api_intel_bb (offset-control)
[533.784010] Starting subtest: offset-control
[533.790513] Subtest offset-control: SUCCESS (0.009s)
[533.945367] [080/133] (488s left) kms_flip (bo-too-big)
[534.052871] Starting subtest: bo-too-big
[534.055116] Starting dynamic subtest: A-eDP1
[535.361513] Dynamic subtest A-eDP1: SUCCESS (1.307s)
[535.373543] Starting dynamic subtest: B-eDP1
[536.691920] Dynamic subtest B-eDP1: SUCCESS (1.328s)
[536.707233] Starting dynamic subtest: C-eDP1
[538.033041] Dynamic subtest C-eDP1: SUCCESS (1.339s)
[538.043771] Starting dynamic subtest: D-eDP1
[539.367577] Dynamic subtest D-eDP1: SUCCESS (1.331s)
[539.370215] Subtest bo-too-big: SUCCESS (5.314s)
[540.596342] [081/133] (481s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[540.705507] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[549.209456] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.503s)
[549.347999] [082/133] (472s left) kms_prime (basic-crc-vgem)
[549.435762] Starting subtest: basic-crc-vgem
[549.438129] Starting dynamic subtest: second-to-first
[550.441022] Dynamic subtest second-to-first: SUCCESS (1.010s)
[550.443212] Subtest basic-crc-vgem: SUCCESS (1.010s)
[550.547503] [083/133] (471s left) gem_ctx_exec (basic-close-race)
[550.609354] Starting subtest: basic-close-race
[556.478195] Subtest basic-close-race: SUCCESS (5.869s)
[556.626689] [084/133] (465s left) gem_mmap_wc (bad-offset)
[556.694343] Subtest bad-offset: SKIP (0.000s)
[556.764990] [085/133] (465s left) sysfs_heartbeat_interval (mixed)
[556.835408] Starting subtest: mixed
[556.837885] Starting dynamic subtest: vecs0
[562.114246] Dynamic subtest vecs0: SUCCESS (5.282s)
[562.126112] Starting dynamic subtest: ccs0
[567.355539] Dynamic subtest ccs0: SUCCESS (5.239s)
[567.368228] Starting dynamic subtest: vcs0
[572.552493] Dynamic subtest vcs0: SUCCESS (5.195s)
[572.564113] Starting dynamic subtest: bcs0
[577.766270] Dynamic subtest bcs0: SUCCESS (5.211s)
[577.779169] Starting dynamic subtest: rcs0
[583.004486] Dynamic subtest rcs0: SUCCESS (5.236s)
[583.017516] Starting dynamic subtest: vcs1
[588.194786] Dynamic subtest vcs1: SUCCESS (5.187s)
[588.197769] Subtest mixed: SUCCESS (31.360s)
[588.288057] [086/133] (433s left) gem_lmem_swapping (heavy-multi)
[588.351156] Subtest heavy-multi: SKIP (0.000s)
[588.396152] [087/133] (433s left) gem_ctx_persistence (engines-hang)
[588.447366] Starting subtest: engines-hang
[588.450276] Starting dynamic subtest: rcs0
[588.577503] Dynamic subtest rcs0: SUCCESS (0.130s)
[588.590180] Starting dynamic subtest: bcs0
[588.705839] Dynamic subtest bcs0: SUCCESS (0.126s)
[588.717676] Starting dynamic subtest: vcs0
[588.827024] Dynamic subtest vcs0: SUCCESS (0.119s)
[588.842977] Starting dynamic subtest: vcs1
[588.929571] Dynamic subtest vcs1: SUCCESS (0.099s)
[588.941441] Starting dynamic subtest: vecs0
[589.003458] Dynamic subtest vecs0: SUCCESS (0.072s)
[589.013785] Starting dynamic subtest: ccs0
[589.155245] Dynamic subtest ccs0: SUCCESS (0.150s)
[589.157915] Subtest engines-hang: SUCCESS (0.709s)
[589.250915] [088/133] (433s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[589.352816] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[593.979596] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.628s)
[595.145631] [089/133] (427s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[595.263558] Starting subtest: verify-pxp-execution-after-suspend-resume
[602.368593] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.103s)
[602.525455] [090/133] (419s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[602.630281] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[602.635848] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[602.739011] [091/133] (419s left) kms_lease (page-flip-implicit-plane)
[602.839415] Starting subtest: page-flip-implicit-plane
[602.842313] Starting dynamic subtest: pipe-A-eDP-1
[603.310693] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.472s)
[603.324557] Starting dynamic subtest: pipe-B-eDP-1
[604.460191] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.147s)
[604.477690] Starting dynamic subtest: pipe-C-eDP-1
[605.577204] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.117s)
[605.588688] Starting dynamic subtest: pipe-D-eDP-1
[606.701538] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.123s)
[606.704342] Subtest page-flip-implicit-plane: SUCCESS (3.865s)
[607.549902] [092/133] (414s left) kms_addfb_basic (tile-pitch-mismatch)
[607.607396] Starting subtest: tile-pitch-mismatch
[607.612982] Subtest tile-pitch-mismatch: SKIP (0.000s)
[607.758127] [093/133] (414s left) syncobj_wait (multi-wait-all-submitted)
[607.824785] Starting subtest: multi-wait-all-submitted
[607.926258] Subtest multi-wait-all-submitted: SUCCESS (0.104s)
[608.012918] [094/133] (414s left) api_intel_allocator (two-level-inception)
[608.077461] Starting subtest: two-level-inception
[613.474624] Subtest two-level-inception: SUCCESS (5.399s)
[613.625840] [095/133] (409s left) gem_exec_balancer (waits)
[613.706071] Starting subtest: waits
[620.229165] Subtest waits: SUCCESS (6.518s)
[620.545931] [096/133] (402s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[620.641341] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[620.667453] Starting dynamic subtest: pipe-A-plane-0
[620.673407] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[620.683499] Starting dynamic subtest: pipe-A-plane-3
[620.689051] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[620.698689] Starting dynamic subtest: pipe-A-plane-5
[620.704536] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[621.741371] Starting dynamic subtest: pipe-B-plane-0
[621.747436] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[621.760002] Starting dynamic subtest: pipe-B-plane-3
[621.765336] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[621.774605] Starting dynamic subtest: pipe-B-plane-5
[621.780636] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[622.044471] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (1.401s)
[622.906360] [097/133] (399s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[623.010062] Starting subtest: x-tiled-32bpp-rotate-0
[624.376680] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.367s)
[624.543854] [098/133] (398s left) kms_psr (psr-cursor-mmap-cpu)
[624.647064] Starting subtest: psr-cursor-mmap-cpu
[624.649204] Starting dynamic subtest: eDP-1
[626.394697] Dynamic subtest eDP-1: SUCCESS (1.748s)
[626.397724] Subtest psr-cursor-mmap-cpu: SUCCESS (1.749s)
[627.267308] [099/133] (395s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[627.367472] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[634.553733] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.187s)
[634.679882] [100/133] (388s left) kms_content_protection (atomic-hdcp14)
[634.837382] Starting subtest: atomic-hdcp14
[634.843211] Subtest atomic-hdcp14: SKIP (0.000s)
[634.988012] [101/133] (387s left) kms_hdmi_inject (inject-audio)
[635.333449] Starting subtest: inject-audio
[635.606323] Subtest inject-audio: SUCCESS (0.274s)
[636.250684] [102/133] (386s left) core_hotunplug (unbind-rebind)
[636.346343] Starting subtest: unbind-rebind
[640.797756] Subtest unbind-rebind: SUCCESS (4.453s)
[640.839291] [103/133] (382s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[642.727323] Starting subtest: 2x-plain-flip-ts-check-interruptible
[642.737390] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.010s)
[642.826036] [104/133] (380s left) prime_vgem (basic-blt)
[642.908835] Starting subtest: basic-blt
[642.932523] Subtest basic-blt: SUCCESS (0.024s)
[643.090959] [105/133] (380s left) i915_pm_freq_api (freq-reset)
[643.148821] Starting subtest: freq-reset
[643.151813] Starting dynamic subtest: gt0
[643.299289] Dynamic subtest gt0: SUCCESS (0.148s)
[643.309791] Starting dynamic subtest: gt1
[643.431512] Dynamic subtest gt1: SUCCESS (0.132s)
[643.434496] Subtest freq-reset: SUCCESS (0.282s)
[643.533352] [106/133] (379s left) syncobj_wait (wait-all-delayed-signal)
[643.605066] Starting subtest: wait-all-delayed-signal
[643.706324] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[643.797607] [107/133] (379s left) kms_plane (plane-panning-bottom-right)
[643.889698] Starting subtest: plane-panning-bottom-right
[643.892280] Starting dynamic subtest: pipe-A
[645.552546] Dynamic subtest pipe-A: SUCCESS (1.664s)
[645.564077] Starting dynamic subtest: pipe-B
[647.822333] Dynamic subtest pipe-B: SUCCESS (2.265s)
[647.825418] Subtest plane-panning-bottom-right: SUCCESS (3.933s)
[648.660851] [108/133] (374s left) perf_pmu (invalid-open)
[648.703437] Starting subtest: invalid-open
[648.706049] Subtest invalid-open: SUCCESS (0.000s)
[648.833587] [109/133] (374s left) i915_drm_fdinfo (memory-info-active)
[648.874218] Starting subtest: memory-info-active
[648.876796] Starting dynamic subtest: smem0
[651.369195] Dynamic subtest smem0: SUCCESS (2.495s)
[651.372007] Subtest memory-info-active: SUCCESS (2.496s)
[651.457296] [110/133] (371s left) kms_chamelium_color (gamma)
[651.573068] Subtest gamma: SKIP (0.000s)
[651.621651] [111/133] (371s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[651.686054] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[651.690587] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[651.896283] [112/133] (371s left) kms_invalid_mode (bad-hsync-start)
[652.000898] Starting subtest: bad-hsync-start
[652.003306] Starting dynamic subtest: pipe-A-eDP-1
[652.280892] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[652.293516] Starting dynamic subtest: pipe-B-eDP-1
[652.295881] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[652.305637] Starting dynamic subtest: pipe-C-eDP-1
[652.308392] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[652.318249] Starting dynamic subtest: pipe-D-eDP-1
[652.320836] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[652.323434] Subtest bad-hsync-start: SUCCESS (0.290s)
[653.203785] [113/133] (370s left) gem_eio (in-flight-internal-10ms)
[653.361543] Starting subtest: in-flight-internal-10ms
[654.721001] Subtest in-flight-internal-10ms: SUCCESS (1.360s)
[654.855035] [114/133] (368s left) perf (mi-rpc)
[654.989397] Starting subtest: mi-rpc
[654.994648] Subtest mi-rpc: SKIP (0.000s)
[655.044485] [115/133] (368s left) kms_display_modes (extended-mode-basic)
[655.133970] Starting subtest: extended-mode-basic
[655.139383] Subtest extended-mode-basic: SKIP (0.000s)
[655.199422] [116/133] (368s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[655.285608] Starting subtest: fbc-psr2-cursor-mmap-gtt
[655.288018] Starting dynamic subtest: eDP-1
[655.292965] Dynamic subtest eDP-1: SKIP (0.000s)
[655.297990] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[655.370866] [117/133] (368s left) gem_exec_params (no-blt)
[655.439391] Starting subtest: no-blt
[655.442461] Subtest no-blt: SUCCESS (0.003s)
[655.587581] [118/133] (368s left) kms_cursor_crc (cursor-random-256x85)
[655.874001] Starting subtest: cursor-random-256x85
[655.921325] Subtest cursor-random-256x85: SKIP (0.042s)
[656.136788] [119/133] (367s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[656.241330] Starting subtest: psr-modesetfrombusy
[662.419059] Subtest psr-modesetfrombusy: SUCCESS (6.178s)
[662.566942] [120/133] (361s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[662.672847] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[662.676114] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[662.797194] [121/133] (361s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[662.908745] Starting subtest: yf-tiled-64bpp-rotate-270
[662.912747] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[663.025847] [122/133] (360s left) kms_pm_dc (dc5-retention-flops)
[664.133178] Starting subtest: dc5-retention-flops
[664.138391] Subtest dc5-retention-flops: SKIP (0.000s)
[664.218843] [123/133] (359s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[664.284573] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[664.393135] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[664.484018] [124/133] (359s left) syncobj_timeline (single-wait-available-submitted)
[664.542423] Starting subtest: single-wait-available-submitted
[664.545521] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[664.670811] [125/133] (359s left) gem_request_retire (retire-vma-not-inactive)
[664.735761] Starting subtest: retire-vma-not-inactive
[664.796312] Subtest retire-vma-not-inactive: SUCCESS (0.057s)
[664.963143] [126/133] (359s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[665.066935] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[665.069573] Starting dynamic subtest: pipe-A-eDP-1
[670.969374] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.910s)
[670.981284] Starting dynamic subtest: pipe-B-eDP-1
[677.616201] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.644s)
[677.618703] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.556s)
[678.514258] [127/133] (345s left) gem_exec_flush (basic-uc-prw-default)
[678.582535] Starting subtest: basic-uc-prw-default
[684.055867] Subtest basic-uc-prw-default: SUCCESS (5.474s)
[684.272574] [128/133] (339s left) gem_exec_suspend (basic-s3-devices)
[684.337441] Starting subtest: basic-S3-devices
[684.340405] Starting dynamic subtest: smem
[695.637223] Dynamic subtest smem: SUCCESS (11.295s)
[695.640391] Subtest basic-S3-devices: SUCCESS (11.298s)
[695.846991] [129/133] (328s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[695.951299] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[695.954096] Starting dynamic subtest: pipe-A-eDP-1
[695.978145] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[695.990776] Starting dynamic subtest: pipe-B-eDP-1
[696.015595] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[696.025252] Starting dynamic subtest: pipe-C-eDP-1
[696.051101] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[696.060435] Starting dynamic subtest: pipe-D-eDP-1
[696.086439] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[696.091465] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s)
[698.233170] [130/133] (326s left) kms_properties (crtc-properties-legacy)
[698.327317] Starting subtest: crtc-properties-legacy
[698.329991] Starting dynamic subtest: pipe-A-eDP-1
[698.765412] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.436s)
[698.776368] Starting dynamic subtest: pipe-B-eDP-1
[699.972752] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.208s)
[699.986575] Starting dynamic subtest: pipe-C-eDP-1
[701.326522] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.349s)
[701.337165] Starting dynamic subtest: pipe-D-eDP-1
[702.466853] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.141s)
[702.469296] Subtest crtc-properties-legacy: SUCCESS (4.140s)
[703.281834] [131/133] (321s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[703.378189] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[703.380549] Starting dynamic subtest: pipe-A-eDP-1
[703.406993] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[703.418098] Starting dynamic subtest: pipe-B-eDP-1
[703.443658] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[703.453790] Starting dynamic subtest: pipe-C-eDP-1
[703.480415] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[703.490958] Starting dynamic subtest: pipe-D-eDP-1
[703.517332] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[703.522405] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[705.659092] [132/133] (318s left) gem_softpin (softpin)
[705.729366] Starting subtest: softpin
[738.125450] Subtest softpin: SUCCESS (32.388s)
[738.272311] [133/133] (286s left) gen9_exec_parse (basic-rejected)
[738.346721] Subtest basic-rejected: SKIP (0.000s)
[738.424811] Closing watchdogs
results: parsing output: 0/ for test: kms_vblank
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: kms_flip_scaled_crc
results: parsing output: 4/ for test: kms_draw_crc
results: parsing output: 5/ for test: sw_sync
results: parsing output: 6/ for test: gem_close
results: parsing output: 7/ for test: gem_userptr_blits
results: parsing output: 8/ for test: gem_mmap_gtt
results: parsing output: 9/ for test: perf
results: parsing output: 10/ for test: gem_exec_balancer
results: parsing output: 11/ for test: gem_exec_schedule
results: parsing output: 12/ for test: perf_pmu
results: parsing output: 13/ for test: prime_mmap_kms
results: parsing output: 14/ for test: gem_exec_reloc
results: parsing output: 15/ for test: gem_exec_schedule
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: gem_ctx_shared
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: perf
results: parsing output: 20/ for test: kms_plane
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_ctx_persistence
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_hdr
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: i915_pm_rps
results: parsing output: 29/ for test: kms_chamelium_color
results: parsing output: 30/ for test: kms_ccs
results: parsing output: 31/ for test: kms_cursor_legacy
results: parsing output: 32/ for test: kms_plane_alpha_blend
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: kms_atomic
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: syncobj_wait
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_cursor_edge_walk
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: kms_psr2_sf
results: parsing output: 41/ for test: kms_async_flips
results: parsing output: 42/ for test: gem_exec_whisper
results: parsing output: 43/ for test: syncobj_wait
results: parsing output: 44/ for test: gem_ctx_param
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: kms_cursor_crc
results: parsing output: 48/ for test: gem_exec_schedule
results: parsing output: 49/ for test: syncobj_eventfd
results: parsing output: 50/ for test: gem_workarounds
results: parsing output: 51/ for test: gem_spin_batch
results: parsing output: 52/ for test: vgem_basic
results: parsing output: 53/ for test: kms_color
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: kms_psr2_sf
results: parsing output: 56/ for test: gem_shrink
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_chamelium_hpd
results: parsing output: 59/ for test: kms_flip_scaled_crc
results: parsing output: 60/ for test: kms_cursor_legacy
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: gem_userptr_blits
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: i915_pm_freq_mult
results: parsing output: 65/ for test: gem_exec_fence
results: parsing output: 66/ for test: kms_universal_plane
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_mmap_gtt
results: parsing output: 69/ for test: syncobj_basic
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_ccs
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_fenced_exec_thrash
results: parsing output: 77/ for test: kms_plane_scaling
results: parsing output: 78/ for test: api_intel_bb
results: parsing output: 79/ for test: kms_flip
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_prime
results: parsing output: 82/ for test: gem_ctx_exec
results: parsing output: 83/ for test: gem_mmap_wc
results: parsing output: 84/ for test: sysfs_heartbeat_interval
results: parsing output: 85/ for test: gem_lmem_swapping
results: parsing output: 86/ for test: gem_ctx_persistence
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_pxp
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_lease
results: parsing output: 91/ for test: kms_addfb_basic
results: parsing output: 92/ for test: syncobj_wait
results: parsing output: 93/ for test: api_intel_allocator
results: parsing output: 94/ for test: gem_exec_balancer
results: parsing output: 95/ for test: kms_plane
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_content_protection
results: parsing output: 100/ for test: kms_hdmi_inject
results: parsing output: 101/ for test: core_hotunplug
results: parsing output: 102/ for test: kms_flip
results: parsing output: 103/ for test: prime_vgem
results: parsing output: 104/ for test: i915_pm_freq_api
results: parsing output: 105/ for test: syncobj_wait
results: parsing output: 106/ for test: kms_plane
results: parsing output: 107/ for test: perf_pmu
results: parsing output: 108/ for test: i915_drm_fdinfo
results: parsing output: 109/ for test: kms_chamelium_color
results: parsing output: 110/ for test: gem_render_copy
results: parsing output: 111/ for test: kms_invalid_mode
results: parsing output: 112/ for test: gem_eio
results: parsing output: 113/ for test: perf
results: parsing output: 114/ for test: kms_display_modes
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: gem_exec_params
results: parsing output: 117/ for test: kms_cursor_crc
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_pm_dc
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: gem_request_retire
results: parsing output: 125/ for test: kms_psr2_sf
results: parsing output: 126/ for test: gem_exec_flush
results: parsing output: 127/ for test: gem_exec_suspend
results: parsing output: 128/ for test: kms_ccs
results: parsing output: 129/ for test: kms_properties
results: parsing output: 130/ for test: kms_ccs
results: parsing output: 131/ for test: gem_softpin
results: parsing output: 132/ for test: gen9_exec_parse
Done.