[59.217972] Initializing watchdogs
[59.218024]   /dev/watchdog0
[59.233308] [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]
[59.238017] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.240438] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.242385] [001/133] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[59.338256] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[59.340052] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[59.422121] [002/133] (960s left) i915_pm_rps (engine-order)
[59.473757] Starting subtest: engine-order
[65.878984] Subtest engine-order: SUCCESS (6.386s)
[65.992240] [003/133] (953s left) gem_mmap_offset (clear-via-pagefault)
[66.033909] Starting subtest: clear-via-pagefault
[66.034721] Starting dynamic subtest: smem0
[98.228446] Dynamic subtest smem0: SUCCESS (32.172s)
[98.229505] Subtest clear-via-pagefault: SUCCESS (32.173s)
[98.359667] [004/133] (921s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[99.488862] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[99.794217] [005/133] (920s left) kms_flip (basic-flip-vs-dpms)
[99.886089] Starting subtest: basic-flip-vs-dpms
[99.887049] Starting dynamic subtest: A-eDP1
[102.526356] Dynamic subtest A-eDP1: SUCCESS (2.639s)
[102.533802] Starting dynamic subtest: B-eDP1
[104.698210] Dynamic subtest B-eDP1: SUCCESS (2.170s)
[104.705461] Starting dynamic subtest: C-eDP1
[106.767200] Dynamic subtest C-eDP1: SUCCESS (2.068s)
[106.777086] Starting dynamic subtest: D-eDP1
[108.848831] Dynamic subtest D-eDP1: SUCCESS (2.080s)
[108.849871] Subtest basic-flip-vs-dpms: SUCCESS (8.964s)
[109.643766] [006/133] (910s left) drm_buddy (drm_buddy)
[109.685017] Starting subtest: drm_buddy
[109.687580] Subtest drm_buddy: SKIP (0.001s)
[109.739593] [007/133] (910s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[109.822084] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[116.545615] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.724s)
[116.640460] [008/133] (903s left) kms_addfb_basic (size-max)
[116.728772] Starting subtest: size-max
[116.729602] Subtest size-max: SUCCESS (0.000s)
[116.807164] [009/133] (903s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[116.906553] Starting subtest: x-tiled-16bpp-rotate-90
[116.926309] Subtest x-tiled-16bpp-rotate-90: SKIP (0.019s)
[117.034166] [010/133] (902s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[117.415665] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[118.253059] [011/133] (901s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[118.340644] Starting subtest: yf-tiled-32bpp-rotate-270
[118.343231] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[118.428576] [012/133] (901s left) kms_psr (fbc-psr-primary-render)
[118.520431] Starting subtest: fbc-psr-primary-render
[118.521525] Starting dynamic subtest: eDP-1
[118.523264] Dynamic subtest eDP-1: SKIP (0.000s)
[118.524948] Subtest fbc-psr-primary-render: SKIP (0.000s)
[118.584260] [013/133] (901s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[118.669235] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[122.414594] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.746s)
[123.590267] [014/133] (896s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[123.685225] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[123.687013] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[123.776100] [015/133] (896s left) gem_spin_batch (resubmit)
[123.831494] Starting subtest: resubmit
[123.832532] Starting dynamic subtest: rcs0
[123.841667] Dynamic subtest rcs0: SUCCESS (0.010s)
[123.849697] Starting dynamic subtest: bcs0
[123.850606] Dynamic subtest bcs0: SUCCESS (0.002s)
[123.857837] Starting dynamic subtest: vcs0
[123.858716] Dynamic subtest vcs0: SUCCESS (0.002s)
[123.865174] Starting dynamic subtest: vcs1
[123.866115] Dynamic subtest vcs1: SUCCESS (0.002s)
[123.872489] Starting dynamic subtest: vecs0
[123.873405] Dynamic subtest vecs0: SUCCESS (0.002s)
[123.879936] Starting dynamic subtest: ccs0
[123.880834] Dynamic subtest ccs0: SUCCESS (0.002s)
[123.881766] Subtest resubmit: SUCCESS (0.022s)
[124.074304] [016/133] (896s left) kms_atomic (atomic-invalid-params)
[124.163943] Starting subtest: atomic-invalid-params
[124.165290] Starting dynamic subtest: pipe-A-eDP-1
[124.569907] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.406s)
[124.570837] Subtest atomic-invalid-params: SUCCESS (0.407s)
[125.402597] [017/133] (894s left) gem_exec_schedule (u-submit-late-slice)
[125.462347] Starting subtest: u-submit-late-slice
[125.463209] Starting dynamic subtest: rcs0
[125.496306] Dynamic subtest rcs0: SUCCESS (0.034s)
[125.503843] Starting dynamic subtest: bcs0
[125.525900] Dynamic subtest bcs0: SUCCESS (0.029s)
[125.535986] Starting dynamic subtest: vcs0
[125.560604] Dynamic subtest vcs0: SUCCESS (0.034s)
[125.570284] Starting dynamic subtest: vcs1
[125.590286] Dynamic subtest vcs1: SUCCESS (0.029s)
[125.597347] Starting dynamic subtest: vecs0
[125.616706] Dynamic subtest vecs0: SUCCESS (0.026s)
[125.623400] Starting dynamic subtest: ccs0
[125.655289] Dynamic subtest ccs0: SUCCESS (0.038s)
[125.656468] Subtest u-submit-late-slice: SUCCESS (0.193s)
[126.953096] [018/133] (893s left) vgem_basic (mmap)
[127.034517] Starting subtest: mmap
[127.052372] Subtest mmap: SUCCESS (0.019s)
[127.133425] [FACT vgem_basic (mmap)] new: kernel.kmod_is_loaded.vgem: true
[127.135546] [019/133] (893s left) gem_exec_suspend (basic-s3)
[127.206839] Starting subtest: basic-S3
[127.207889] Starting dynamic subtest: smem
[147.320845] Dynamic subtest smem: SUCCESS (6.703s)
[147.322625] Subtest basic-S3: SUCCESS (6.704s)
[153.523860] [020/133] (872s left) syncobj_timeline (wait-any-snapshot)
[153.592772] Starting subtest: wait-any-snapshot
[153.675758] Subtest wait-any-snapshot: SUCCESS (0.081s)
[153.748851] [021/133] (872s left) kms_universal_plane (universal-plane-sanity)
[153.842973] Starting subtest: universal-plane-sanity
[153.844055] Starting dynamic subtest: pipe-A-eDP-1
[154.454003] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.603s)
[154.462153] Starting dynamic subtest: pipe-B-eDP-1
[155.697432] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.229s)
[155.707138] Starting dynamic subtest: pipe-C-eDP-1
[156.921344] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.211s)
[156.929667] Starting dynamic subtest: pipe-D-eDP-1
[158.172531] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.240s)
[158.173334] Subtest universal-plane-sanity: SUCCESS (4.288s)
[159.045581] [022/133] (867s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[159.138681] Starting subtest: y-tiled-32bpp-rotate-90
[159.140862] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[159.231570] [023/133] (867s left) kms_lease (simple-lease)
[159.315309] Starting subtest: simple-lease
[159.316348] Starting dynamic subtest: pipe-A-eDP-1
[159.820545] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.501s)
[159.829410] Starting dynamic subtest: pipe-B-eDP-1
[161.333038] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.504s)
[161.342247] Starting dynamic subtest: pipe-C-eDP-1
[162.814563] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.473s)
[162.823023] Starting dynamic subtest: pipe-D-eDP-1
[164.224623] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.404s)
[164.225669] Subtest simple-lease: SUCCESS (4.887s)
[165.043746] [024/133] (861s left) kms_big_fb (linear-64bpp-rotate-90)
[165.140857] Starting subtest: linear-64bpp-rotate-90
[165.161091] Subtest linear-64bpp-rotate-90: SKIP (0.020s)
[165.292582] [025/133] (861s left) kms_properties (connector-properties-atomic)
[165.394015] Starting subtest: connector-properties-atomic
[165.395014] Starting dynamic subtest: pipe-A-eDP-1
[173.340190] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.928s)
[173.348365] Starting dynamic subtest: pipe-None-DP-1
[173.350117] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[173.357101] Starting dynamic subtest: pipe-None-HDMI-A-1
[173.358777] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[173.365761] Starting dynamic subtest: pipe-None-DP-2
[173.367458] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[173.374408] Starting dynamic subtest: pipe-None-HDMI-A-2
[173.376063] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[173.383445] Starting dynamic subtest: pipe-None-DP-3
[173.385251] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[173.392486] Starting dynamic subtest: pipe-None-DP-4
[173.394275] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[173.395165] Subtest connector-properties-atomic: SUCCESS (7.938s)
[174.220620] [026/133] (852s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[174.323346] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[174.324234] Starting dynamic subtest: pipe-A-eDP-1
[180.186371] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.858s)
[180.199782] Starting dynamic subtest: pipe-B-eDP-1
[186.844321] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.655s)
[186.845164] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.516s)
[187.715048] [027/133] (838s left) kms_vblank (crtc-id)
[187.812491] Starting subtest: crtc-id
[187.815223] Starting dynamic subtest: pipe-A-eDP-1
[188.271564] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.455s)
[188.281158] Starting dynamic subtest: pipe-D-eDP-1
[189.372103] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.100s)
[189.372962] Subtest crtc-id: SUCCESS (1.561s)
[190.213791] [028/133] (836s left) kms_cursor_crc (cursor-sliding-max-size)
[190.512921] Starting subtest: cursor-sliding-max-size
[190.524449] Subtest cursor-sliding-max-size: SKIP (0.000s)
[190.652592] [029/133] (836s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[190.735309] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[190.737034] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[190.805241] [030/133] (835s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[190.855088] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[190.856006] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[190.943013] [031/133] (835s left) gem_render_copy (y-tiled-ccs-to-linear)
[190.988789] Starting subtest: y-tiled-ccs-to-linear
[190.990876] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[191.180775] [032/133] (835s left) gem_sync (basic-store-each)
[191.244706] Starting subtest: basic-store-each
[193.856036] Subtest basic-store-each: SUCCESS (2.613s)
[194.039097] [033/133] (832s left) gem_exercise_blt (fast-copy)
[194.088058] Starting subtest: fast-copy
[194.088889] Starting dynamic subtest: linear-smem-smem
[194.116156] Dynamic subtest linear-smem-smem: SUCCESS (0.028s)
[194.125390] Starting dynamic subtest: xmajor-smem-smem
[194.135475] Dynamic subtest xmajor-smem-smem: SUCCESS (0.019s)
[194.142831] Starting dynamic subtest: tile4-smem-smem
[194.156894] Dynamic subtest tile4-smem-smem: SUCCESS (0.020s)
[194.164486] Starting dynamic subtest: tile64-smem-smem
[194.177227] Dynamic subtest tile64-smem-smem: SUCCESS (0.020s)
[194.178208] Subtest fast-copy: SUCCESS (0.089s)
[194.306396] [034/133] (832s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[194.401035] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[194.401924] Starting dynamic subtest: pipe-A-eDP-1
[194.411351] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[194.423615] Starting dynamic subtest: pipe-B-eDP-1
[194.433270] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[194.442765] Starting dynamic subtest: pipe-C-eDP-1
[194.451289] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[194.458408] Starting dynamic subtest: pipe-D-eDP-1
[194.467626] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[194.469214] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[196.652004] [035/133] (830s left) prime_busy (hang)
[196.701336] Starting subtest: hang
[196.702421] Starting dynamic subtest: rcs0
[222.860257] Dynamic subtest rcs0: SUCCESS (26.151s)
[222.870258] Starting dynamic subtest: bcs0
[229.948936] Dynamic subtest bcs0: SUCCESS (7.088s)
[229.959534] Starting dynamic subtest: vcs0
[236.987220] Dynamic subtest vcs0: SUCCESS (7.035s)
[236.997287] Starting dynamic subtest: vcs1
[243.978038] Dynamic subtest vcs1: SUCCESS (6.986s)
[243.986880] Starting dynamic subtest: vecs0
[250.939329] Dynamic subtest vecs0: SUCCESS (6.957s)
[250.953499] Starting dynamic subtest: ccs0
[264.835370] Dynamic subtest ccs0: SUCCESS (13.904s)
[264.836950] Subtest hang: SUCCESS (68.126s)
[264.952289] [036/133] (761s left) kms_dp_link_training (uhbr-sst)
[265.046000] Starting subtest: uhbr-sst
[265.049547] Subtest uhbr-sst: SKIP (0.000s)
[265.116353] [037/133] (761s left) fbdev (pan)
[265.145964] Starting subtest: pan
[265.170025] Subtest pan: SUCCESS (0.025s)
[265.235279] [038/133] (761s left) kms_content_protection (legacy)
[265.375344] Starting subtest: legacy
[265.377321] Subtest legacy: SKIP (0.000s)
[265.497613] [039/133] (761s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[265.584837] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[265.586568] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[265.655040] [040/133] (761s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[265.738413] Starting subtest: fbc-farfromfence-mmap-gtt
[265.740138] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[265.851425] [041/133] (761s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[265.947142] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[265.948061] Starting dynamic subtest: pipe-A-eDP-1
[266.023945] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s)
[266.033146] Starting dynamic subtest: pipe-B-eDP-1
[267.136888] Dynamic subtest pipe-B-eDP-1: SKIP (1.112s)
[267.138826] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.192s)
[268.320146] [042/133] (758s left) kms_pm_dc (dc3co-vpb-simulation)
[269.422307] Starting subtest: dc3co-vpb-simulation
[278.254793] Subtest dc3co-vpb-simulation: SKIP (8.787s)
[278.364735] [043/133] (748s left) api_intel_bb (destroy-bb)
[278.418958] Starting subtest: destroy-bb
[278.425837] Subtest destroy-bb: SUCCESS (0.008s)
[278.508192] [044/133] (748s left) gem_ctx_exec (basic-norecovery)
[278.556500] Starting subtest: basic-norecovery
[278.825919] Subtest basic-norecovery: SUCCESS (0.269s)
[278.938008] [045/133] (748s left) gem_ctx_param (set-priority-invalid-size)
[278.991385] Starting subtest: set-priority-invalid-size
[278.992278] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[279.070239] [046/133] (748s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[279.166335] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[279.167217] Starting dynamic subtest: pipe-A-eDP-1
[279.188949] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[279.197800] Starting dynamic subtest: pipe-B-eDP-1
[279.219671] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[279.227999] Starting dynamic subtest: pipe-C-eDP-1
[279.250000] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[279.260084] Starting dynamic subtest: pipe-D-eDP-1
[279.281435] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[279.283085] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.008s)
[281.494339] [047/133] (745s left) gem_ctx_shared (q-in-order)
[281.557042] Starting subtest: Q-in-order
[281.558866] Starting dynamic subtest: rcs0
[281.687480] Dynamic subtest rcs0: SUCCESS (0.120s)
[281.695939] Starting dynamic subtest: vcs0
[281.774239] Dynamic subtest vcs0: SUCCESS (0.094s)
[281.787554] Starting dynamic subtest: vcs1
[281.870469] Dynamic subtest vcs1: SUCCESS (0.093s)
[281.888842] Starting dynamic subtest: vecs0
[281.958172] Dynamic subtest vecs0: SUCCESS (0.087s)
[281.974920] Starting dynamic subtest: ccs0
[282.051589] Dynamic subtest ccs0: SUCCESS (0.092s)
[282.053004] Subtest Q-in-order: SUCCESS (0.494s)
[283.393195] [048/133] (743s left) kms_flip (2x-modeset-vs-vblank-race)
[283.475154] Starting subtest: 2x-modeset-vs-vblank-race
[283.486563] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[283.562121] [049/133] (743s left) kms_flip (flip-vs-panning-interruptible)
[283.651437] Starting subtest: flip-vs-panning-interruptible
[283.653574] Starting dynamic subtest: A-eDP1
[292.400668] Dynamic subtest A-eDP1: SUCCESS (8.746s)
[292.412313] Starting dynamic subtest: B-eDP1
[301.138515] Dynamic subtest B-eDP1: SUCCESS (8.735s)
[301.148825] Starting dynamic subtest: C-eDP1
[309.869580] Dynamic subtest C-eDP1: SUCCESS (8.728s)
[309.879335] Starting dynamic subtest: D-eDP1
[318.604039] Dynamic subtest D-eDP1: SUCCESS (8.731s)
[318.607863] Subtest flip-vs-panning-interruptible: SUCCESS (34.951s)
[319.763261] [050/133] (707s left) gem_mmap_gtt (cpuset-big-copy-xy)
[319.817527] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[319.872763] [051/133] (707s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[319.971094] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[319.972717] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[320.066116] [052/133] (707s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[320.125831] Starting subtest: etime-single-wait-all-available-unsubmitted
[320.234041] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.107s)
[320.308325] [053/133] (707s left) syncobj_timeline (invalid-wait-illegal-handle)
[320.369521] Starting subtest: invalid-wait-illegal-handle
[320.370426] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[320.483840] [054/133] (707s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[320.591696] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[327.519682] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.926s)
[327.679624] [055/133] (699s left) kms_psr (pr-cursor-mmap-gtt)
[327.775486] Starting subtest: pr-cursor-mmap-gtt
[327.777384] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[327.847802] [056/133] (699s left) perf_pmu (busy-idle-no-semaphores)
[327.882245] Starting subtest: busy-idle-no-semaphores
[327.883152] Starting dynamic subtest: rcs0
[328.552685] Dynamic subtest rcs0: SUCCESS (0.660s)
[328.563397] Starting dynamic subtest: bcs0
[329.204788] Dynamic subtest bcs0: SUCCESS (0.649s)
[329.215575] Starting dynamic subtest: vcs0
[329.858811] Dynamic subtest vcs0: SUCCESS (0.651s)
[329.869671] Starting dynamic subtest: vcs1
[331.934733] Dynamic subtest vcs1: SUCCESS (2.073s)
[331.945741] Starting dynamic subtest: vecs0
[333.915716] Dynamic subtest vecs0: SUCCESS (1.977s)
[333.929465] Starting dynamic subtest: ccs0
[335.968992] Dynamic subtest ccs0: SUCCESS (2.051s)
[335.970332] Subtest busy-idle-no-semaphores: SUCCESS (8.076s)
[336.080358] [057/133] (691s left) syncobj_timeline (wait-for-submit-snapshot)
[336.127892] Starting subtest: wait-for-submit-snapshot
[336.211577] Subtest wait-for-submit-snapshot: SUCCESS (0.084s)
[336.291735] [058/133] (691s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[336.387569] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[336.389295] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[336.482797] [059/133] (691s left) perf (mi-rpc)
[336.585200] Starting subtest: mi-rpc
[336.586806] Subtest mi-rpc: SKIP (0.000s)
[336.633596] [060/133] (691s left) gem_create (create-invalid-size)
[336.678553] Starting subtest: create-invalid-size
[336.679489] Subtest create-invalid-size: SUCCESS (0.000s)
[336.857985] [061/133] (690s left) kms_vblank (wait-idle)
[336.943299] Starting subtest: wait-idle
[336.944140] Starting dynamic subtest: pipe-A-eDP-1
[338.707137] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.763s)
[338.717273] Starting dynamic subtest: pipe-D-eDP-1
[341.148543] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.438s)
[341.149450] Subtest wait-idle: SUCCESS (4.205s)
[341.967430] [062/133] (685s left) gem_exec_schedule (semaphore-codependency)
[342.030518] Starting subtest: semaphore-codependency
[342.042930] Subtest semaphore-codependency: SUCCESS (0.012s)
[342.368174] [063/133] (685s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[342.464424] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[342.466154] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[342.561597] [064/133] (685s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[342.653027] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[342.663884] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.011s)
[342.764701] [065/133] (685s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[342.854569] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[349.643347] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.788s)
[349.751913] [066/133] (678s left) gem_exec_balancer (full)
[349.809243] Starting subtest: full
[354.220688] Subtest full: SUCCESS (4.408s)
[354.534907] [067/133] (673s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[354.638247] Starting subtest: nonblocking-crc-frame-sequence
[354.639183] Starting dynamic subtest: pipe-A-eDP-1
[355.384201] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.745s)
[355.392613] Starting dynamic subtest: pipe-B-eDP-1
[356.806943] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.421s)
[356.815442] Starting dynamic subtest: pipe-C-eDP-1
[358.180196] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.371s)
[358.188416] Starting dynamic subtest: pipe-D-eDP-1
[359.517074] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.335s)
[359.517895] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.877s)
[360.311374] [068/133] (667s left) gen9_exec_parse (secure-batches)
[360.361658] Subtest secure-batches: SKIP (0.000s)
[360.423349] [069/133] (667s left) kms_plane_lowres (tiling-none)
[360.507768] Starting subtest: tiling-none
[360.508695] Starting dynamic subtest: pipe-A-eDP-1
[360.510485] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[360.814887] Starting dynamic subtest: pipe-B-eDP-1
[360.816961] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[360.825242] Starting dynamic subtest: pipe-C-eDP-1
[360.827157] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[360.837764] Starting dynamic subtest: pipe-D-eDP-1
[360.839878] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[360.842093] Subtest tiling-none: SKIP (0.306s)
[361.659292] [070/133] (666s left) kms_plane (pixel-format-y-tiled-ccs-modifier)
[361.742224] Starting subtest: pixel-format-y-tiled-ccs-modifier
[361.743985] Subtest pixel-format-y-tiled-ccs-modifier: SKIP (0.000s)
[361.839577] [071/133] (666s left) gem_fence_thrash (bo-copy)
[361.869634] Starting subtest: bo-copy
[361.885240] Subtest bo-copy: SKIP (0.015s)
[361.936794] [072/133] (666s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[362.024432] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[369.169041] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.143s)
[369.299812] [073/133] (658s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[369.406490] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[369.408295] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[369.497680] [074/133] (658s left) kms_async_flips (crc)
[369.573058] Starting subtest: crc
[369.966457] Starting dynamic subtest: pipe-A-eDP-1
[372.890213] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.923s)
[373.266189] Starting dynamic subtest: pipe-B-eDP-1
[376.197024] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.938s)
[376.576337] Starting dynamic subtest: pipe-C-eDP-1
[379.420447] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.852s)
[379.783152] Starting dynamic subtest: pipe-D-eDP-1
[382.636540] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.863s)
[382.637521] Subtest crc: SUCCESS (13.063s)
[383.820614] [075/133] (644s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[383.912538] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[383.914321] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[384.004724] [076/133] (644s left) perf_pmu (busy-accuracy-2)
[384.043615] Starting subtest: busy-accuracy-2
[384.044549] Starting dynamic subtest: rcs0
[387.091964] Dynamic subtest rcs0: SUCCESS (3.042s)
[387.102583] Starting dynamic subtest: bcs0
[390.151452] Dynamic subtest bcs0: SUCCESS (3.057s)
[390.162029] Starting dynamic subtest: vcs0
[393.200151] Dynamic subtest vcs0: SUCCESS (3.047s)
[393.210688] Starting dynamic subtest: vcs1
[396.246476] Dynamic subtest vcs1: SUCCESS (3.045s)
[396.256866] Starting dynamic subtest: vecs0
[399.293597] Dynamic subtest vecs0: SUCCESS (3.044s)
[399.304069] Starting dynamic subtest: ccs0
[402.357550] Dynamic subtest ccs0: SUCCESS (3.061s)
[402.358609] Subtest busy-accuracy-2: SUCCESS (18.312s)
[402.464758] [077/133] (625s left) perf (short-reads)
[402.558771] Starting subtest: short-reads
[402.573107] Subtest short-reads: SUCCESS (0.014s)
[402.618531] [078/133] (625s left) gem_exec_schedule (preempt-queue-contexts)
[402.690653] Subtest preempt-queue-contexts: SKIP (0.000s)
[402.984181] [079/133] (625s left) i915_query (engine-info-invalid)
[403.037248] Starting subtest: engine-info-invalid
[403.038221] Subtest engine-info-invalid: SUCCESS (0.000s)
[403.126452] [080/133] (625s left) gem_pxp (reject-modify-context-protection-off-3)
[403.242406] Starting subtest: reject-modify-context-protection-off-3
[403.243574] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[403.356420] [081/133] (625s left) gem_exec_params (invalid-batch-start-offset)
[403.423226] Starting subtest: invalid-batch-start-offset
[403.424359] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[403.541489] [082/133] (625s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[403.640317] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[410.981990] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.344s)
[411.137032] [083/133] (617s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[411.230256] Starting subtest: primary-yf-tiled-reflect-x-270
[411.231892] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[411.302106] [084/133] (617s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[411.390596] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[411.391494] Starting dynamic subtest: pipe-A-default-mode
[414.072138] Dynamic subtest pipe-A-default-mode: SUCCESS (2.681s)
[414.073033] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.682s)
[414.931544] [085/133] (613s left) perf_pmu (frequency)
[414.965228] Starting subtest: frequency
[414.969451] Starting dynamic subtest: gt0
[417.087075] Dynamic subtest gt0: SUCCESS (2.113s)
[417.096937] Starting dynamic subtest: idle-gt0
[417.621630] Dynamic subtest idle-gt0: SUCCESS (0.525s)
[417.632269] Starting dynamic subtest: gt1
[422.331465] Dynamic subtest gt1: SUCCESS (4.706s)
[422.342332] Starting dynamic subtest: idle-gt1
[422.837711] Dynamic subtest idle-gt1: SUCCESS (0.504s)
[422.838815] Subtest frequency: SUCCESS (7.867s)
[422.927998] [086/133] (605s left) kms_getfb (getfb2-accept-nv12)
[423.019049] Starting subtest: getfb2-accept-nv12
[423.019821] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[423.117149] [087/133] (605s left) gem_ctx_persistence (legacy-engines-hostile)
[423.179143] Starting subtest: legacy-engines-hostile
[423.180042] Starting dynamic subtest: render
[423.263523] Dynamic subtest render: SUCCESS (0.083s)
[423.275203] Starting dynamic subtest: bsd1
[423.334439] Dynamic subtest bsd1: SUCCESS (0.069s)
[423.346224] Starting dynamic subtest: bsd2
[423.444924] Dynamic subtest bsd2: SUCCESS (0.107s)
[423.457689] Starting dynamic subtest: blt
[423.515758] Dynamic subtest blt: SUCCESS (0.068s)
[423.526554] Starting dynamic subtest: vebox
[423.652686] Dynamic subtest vebox: SUCCESS (0.134s)
[423.654285] Subtest legacy-engines-hostile: SUCCESS (0.474s)
[423.727489] [088/133] (605s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[423.821341] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[423.822222] Starting dynamic subtest: pipe-A
[423.841046] Dynamic subtest pipe-A: SKIP (0.018s)
[423.849609] Starting dynamic subtest: pipe-B
[423.872768] Dynamic subtest pipe-B: SKIP (0.032s)
[423.881232] Starting dynamic subtest: pipe-C
[423.904621] Dynamic subtest pipe-C: SKIP (0.032s)
[423.912744] Starting dynamic subtest: pipe-D
[423.936633] Dynamic subtest pipe-D: SKIP (0.032s)
[423.938303] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.115s)
[424.046466] [089/133] (604s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[424.112334] Starting subtest: y-tiled-to-vebox-x-tiled
[424.114125] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[424.303350] [090/133] (604s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[424.611331] Starting subtest: cursor-rapid-movement-512x170
[424.613142] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[424.784462] [091/133] (604s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[424.866395] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[424.867307] Starting dynamic subtest: pipe-A-eDP-1
[427.074451] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.208s)
[427.089897] Starting dynamic subtest: pipe-B-eDP-1
[429.453771] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.377s)
[429.468115] Starting dynamic subtest: pipe-C-eDP-1
[431.538453] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.081s)
[431.548370] Starting dynamic subtest: pipe-D-eDP-1
[433.820356] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.280s)
[433.821265] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.955s)
[434.975959] [092/133] (593s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[435.070899] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[435.074073] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[435.175606] [093/133] (593s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[435.276380] Starting subtest: 4-tiled-64bpp-rotate-90
[435.296000] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s)
[435.405824] [094/133] (593s left) prime_vgem (basic-fence-flip)
[435.464142] Starting subtest: basic-fence-flip
[435.758520] Subtest basic-fence-flip: SUCCESS (0.294s)
[435.871915] [095/133] (593s left) gem_exec_suspend (basic)
[435.934703] Starting subtest: basic
[435.935769] Starting dynamic subtest: smem
[437.302859] Dynamic subtest smem: SUCCESS (1.358s)
[437.304322] Subtest basic: SUCCESS (1.360s)
[437.487868] [096/133] (591s left) i915_drm_fdinfo (busy-hang)
[437.523935] Starting subtest: busy-hang
[437.524778] Starting dynamic subtest: rcs0
[437.552322] Dynamic subtest rcs0: SKIP (0.028s)
[437.563874] Starting dynamic subtest: bcs0
[437.566004] Dynamic subtest bcs0: SKIP (0.001s)
[437.574157] Starting dynamic subtest: vcs0
[437.575880] Dynamic subtest vcs0: SKIP (0.000s)
[437.584003] Starting dynamic subtest: vcs1
[437.585814] Dynamic subtest vcs1: SKIP (0.001s)
[437.593775] Starting dynamic subtest: vecs0
[437.595615] Dynamic subtest vecs0: SKIP (0.000s)
[437.604360] Starting dynamic subtest: ccs0
[437.606022] Dynamic subtest ccs0: SKIP (0.001s)
[437.607825] Subtest busy-hang: SKIP (0.034s)
[437.637618] [097/133] (591s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[437.697294] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[437.801811] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.103s)
[437.874361] [098/133] (591s left) kms_color_pipeline (plane-lut1d)
[437.968559] Starting subtest: plane-lut1d
[438.093133] Starting dynamic subtest: pipe-A-plane-0
[438.334769] Dynamic subtest pipe-A-plane-0: FAIL (0.169s)
[438.344394] Starting dynamic subtest: pipe-A-plane-1
[438.509665] Dynamic subtest pipe-A-plane-1: FAIL (0.172s)
[438.518872] Starting dynamic subtest: pipe-A-plane-2
[438.693411] Dynamic subtest pipe-A-plane-2: FAIL (0.177s)
[439.769079] Starting dynamic subtest: pipe-B-plane-0
[440.028294] Dynamic subtest pipe-B-plane-0: FAIL (0.167s)
[440.037226] Starting dynamic subtest: pipe-B-plane-1
[440.207094] Dynamic subtest pipe-B-plane-1: FAIL (0.173s)
[440.215642] Starting dynamic subtest: pipe-B-plane-2
[440.379091] Dynamic subtest pipe-B-plane-2: FAIL (0.166s)
[441.497576] Starting dynamic subtest: pipe-C-plane-0
[441.749197] Dynamic subtest pipe-C-plane-0: FAIL (0.140s)
[441.757293] Starting dynamic subtest: pipe-C-plane-1
[441.886678] Dynamic subtest pipe-C-plane-1: FAIL (0.132s)
[441.894789] Starting dynamic subtest: pipe-C-plane-2
[442.063466] Dynamic subtest pipe-C-plane-2: FAIL (0.166s)
[443.126486] Starting dynamic subtest: pipe-D-plane-0
[443.400789] Dynamic subtest pipe-D-plane-0: FAIL (0.140s)
[443.409702] Starting dynamic subtest: pipe-D-plane-1
[443.579304] Dynamic subtest pipe-D-plane-1: FAIL (0.144s)
[443.589467] Starting dynamic subtest: pipe-D-plane-2
[443.787456] Dynamic subtest pipe-D-plane-2: FAIL (0.166s)
[443.858464] Subtest plane-lut1d: FAIL (5.889s)
[444.689587] [099/133] (584s left) kms_pm_rpm (modeset-lpsp-stress)
[446.424846] Starting subtest: modeset-lpsp-stress
[462.901028] Subtest modeset-lpsp-stress: SUCCESS (16.475s)
[462.984658] [100/133] (566s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[463.541231] Starting subtest: syncobj-timeline-invalid-flags
[463.542093] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[465.312358] [101/133] (563s left) syncobj_wait (single-wait-all-submitted)
[465.373784] Starting subtest: single-wait-all-submitted
[465.481363] Subtest single-wait-all-submitted: SUCCESS (0.107s)
[465.556778] [102/133] (563s left) i915_hangman (detector)
[465.623165] Starting subtest: detector
[465.624008] Starting dynamic subtest: rcs0
[476.307746] Dynamic subtest rcs0: SUCCESS (10.674s)
[476.316439] Starting dynamic subtest: bcs0
[488.276313] Dynamic subtest bcs0: SUCCESS (11.964s)
[488.287187] Starting dynamic subtest: vcs0
[500.308988] Dynamic subtest vcs0: SUCCESS (12.028s)
[500.320720] Starting dynamic subtest: vcs1
[512.212536] Dynamic subtest vcs1: SUCCESS (11.899s)
[512.223134] Starting dynamic subtest: vecs0
[523.284845] Dynamic subtest vecs0: SUCCESS (11.067s)
[523.296379] Starting dynamic subtest: ccs0
[534.292679] Dynamic subtest ccs0: SUCCESS (11.003s)
[534.293775] Subtest detector: SUCCESS (68.652s)
[534.361898] [103/133] (494s left) gem_eio (reset-stress)
[534.559421] Starting subtest: reset-stress
[534.560402] Starting dynamic subtest: render
[538.597548] Dynamic subtest render: SUCCESS (4.037s)
[538.613101] Starting dynamic subtest: bsd1
[556.753430] Dynamic subtest bsd1: SUCCESS (18.151s)
[556.769041] Starting dynamic subtest: bsd2
[574.755611] Dynamic subtest bsd2: SUCCESS (17.998s)
[574.771430] Starting dynamic subtest: blt
[574.772962] Dynamic subtest blt: SKIP (0.000s)
[574.781055] Starting dynamic subtest: vebox
[592.727687] Dynamic subtest vebox: SUCCESS (17.965s)
[592.729121] Subtest reset-stress: SUCCESS (58.156s)
[594.322777] [104/133] (435s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[594.424784] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[594.426636] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[594.513072] [105/133] (434s left) gem_create (create-size-update)
[594.566584] Starting subtest: create-size-update
[594.567492] Subtest create-size-update: SUCCESS (0.000s)
[594.775070] [106/133] (434s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[594.872889] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[594.874872] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[594.963727] [107/133] (434s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[595.058587] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[595.059484] Starting dynamic subtest: pipe-A-eDP-1
[595.068009] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[595.076935] Starting dynamic subtest: pipe-B-eDP-1
[595.085469] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[595.093754] Starting dynamic subtest: pipe-C-eDP-1
[595.101820] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[595.110192] Starting dynamic subtest: pipe-D-eDP-1
[595.118524] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[595.120157] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[597.345626] [108/133] (432s left) api_intel_bb (blit-noreloc-purge-cache)
[597.402910] Starting subtest: blit-noreloc-purge-cache
[597.412537] Subtest blit-noreloc-purge-cache: SUCCESS (0.010s)
[597.529931] [109/133] (432s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[597.602013] Starting subtest: basic-batch-kernel-default-cmd
[597.603878] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[597.815322] [110/133] (431s left) gem_exec_balancer (smoke)
[597.893213] Starting subtest: smoke
[620.575133] Subtest smoke: SUCCESS (22.632s)
[622.369203] [111/133] (407s left) kms_properties (crtc-properties-legacy)
[622.455226] Starting subtest: crtc-properties-legacy
[622.456046] Starting dynamic subtest: pipe-A-eDP-1
[622.890898] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.434s)
[622.899471] Starting dynamic subtest: pipe-B-eDP-1
[624.103685] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.211s)
[624.112672] Starting dynamic subtest: pipe-C-eDP-1
[625.210339] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.105s)
[625.218865] Starting dynamic subtest: pipe-D-eDP-1
[626.359561] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.148s)
[626.360533] Subtest crtc-properties-legacy: SUCCESS (3.903s)
[627.149873] [112/133] (402s left) gem_basic (bad-close)
[627.192166] Starting subtest: bad-close
[627.194006] Subtest bad-close: SUCCESS (0.000s)
[627.283018] [113/133] (402s left) kms_psr (psr-primary-blt)
[627.367366] Starting subtest: psr-primary-blt
[627.368277] Starting dynamic subtest: eDP-1
[629.061105] Dynamic subtest eDP-1: SUCCESS (1.692s)
[629.061991] Subtest psr-primary-blt: SUCCESS (1.693s)
[629.926018] [114/133] (399s left) kms_cursor_crc (cursor-onscreen-512x170)
[630.216270] Starting subtest: cursor-onscreen-512x170
[630.218088] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[630.357885] [115/133] (399s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[630.450503] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[630.452450] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[630.548753] [116/133] (399s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[630.633676] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[630.634726] Starting dynamic subtest: pipe-A-eDP-1
[630.646352] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[630.658852] Starting dynamic subtest: pipe-B-eDP-1
[630.662327] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[630.670447] Starting dynamic subtest: pipe-C-eDP-1
[630.673667] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[630.681587] Starting dynamic subtest: pipe-D-eDP-1
[630.684725] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[630.686336] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[632.891951] [117/133] (396s left) kms_flip_event_leak (basic)
[632.986253] Starting subtest: basic
[632.987477] Starting dynamic subtest: pipe-A-eDP-1
[633.409634] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.423s)
[633.419948] Starting dynamic subtest: pipe-B-eDP-1
[634.514250] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.104s)
[634.522916] Starting dynamic subtest: pipe-C-eDP-1
[635.629773] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.113s)
[635.639677] Starting dynamic subtest: pipe-D-eDP-1
[636.744275] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.114s)
[636.745021] Subtest basic: SUCCESS (3.760s)
[637.602870] [118/133] (392s left) gem_userptr_blits (stress-purge)
[637.654452] Starting subtest: stress-purge
[643.077044] Subtest stress-purge: SUCCESS (5.423s)
[643.219350] [119/133] (386s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[643.364956] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[643.522836] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.157s)
[643.642411] [120/133] (386s left) kms_psr (fbc-psr2-cursor-blt)
[643.741036] Starting subtest: fbc-psr2-cursor-blt
[643.741859] Starting dynamic subtest: eDP-1
[643.743587] Dynamic subtest eDP-1: SKIP (0.000s)
[643.745362] Subtest fbc-psr2-cursor-blt: SKIP (0.001s)
[643.817240] [121/133] (386s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[643.898741] Starting subtest: fbcpsr-2p-rte
[643.900441] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[643.993213] [122/133] (386s left) kms_flip (basic-plain-flip)
[644.087530] Starting subtest: basic-plain-flip
[644.089686] Starting dynamic subtest: A-eDP1
[645.812005] Dynamic subtest A-eDP1: SUCCESS (1.723s)
[645.829299] Starting dynamic subtest: B-eDP1
[647.444741] Dynamic subtest B-eDP1: SUCCESS (1.631s)
[647.456577] Starting dynamic subtest: C-eDP1
[649.082584] Dynamic subtest C-eDP1: SUCCESS (1.633s)
[649.098448] Starting dynamic subtest: D-eDP1
[650.816937] Dynamic subtest D-eDP1: SUCCESS (1.732s)
[650.820289] Subtest basic-plain-flip: SUCCESS (6.733s)
[651.982787] [123/133] (378s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[652.078580] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[652.080206] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[652.170529] [124/133] (377s left) kms_psr (psr2-sprite-render)
[652.265781] Starting subtest: psr2-sprite-render
[652.266683] Starting dynamic subtest: eDP-1
[653.982415] Dynamic subtest eDP-1: SUCCESS (1.717s)
[653.983245] Subtest psr2-sprite-render: SUCCESS (1.718s)
[654.849540] [125/133] (375s left) gem_exec_params (batch-first)
[654.906318] Starting subtest: batch-first
[654.912532] Subtest batch-first: SUCCESS (0.006s)
[655.018783] [126/133] (375s left) kms_flip (flip-vs-absolute-wf_vblank)
[655.098797] Starting subtest: flip-vs-absolute-wf_vblank
[655.102369] Starting dynamic subtest: A-eDP1
[663.999731] Dynamic subtest A-eDP1: SUCCESS (8.900s)
[664.011255] Starting dynamic subtest: B-eDP1
[672.918627] Dynamic subtest B-eDP1: SUCCESS (8.917s)
[672.930680] Starting dynamic subtest: C-eDP1
[681.877359] Dynamic subtest C-eDP1: SUCCESS (8.921s)
[681.887068] Starting dynamic subtest: D-eDP1
[690.813376] Dynamic subtest D-eDP1: SUCCESS (8.935s)
[690.814825] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.685s)
[692.008305] [127/133] (338s left) syncobj_wait (single-wait-all-signaled)
[692.064292] Starting subtest: single-wait-all-signaled
[692.065374] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[692.133247] [128/133] (338s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[692.227428] Starting subtest: fbc-dirtyfb-ioctl
[692.228326] Starting dynamic subtest: A-eDP-1
[694.790982] Dynamic subtest A-eDP-1: SUCCESS (2.563s)
[694.791802] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.564s)
[695.583472] [129/133] (334s left) syncobj_basic (bad-flags-handle-to-fd)
[695.647002] Starting subtest: bad-flags-handle-to-fd
[695.647992] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[695.759065] [130/133] (334s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[695.807841] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[695.913431] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.105s)
[695.986398] [131/133] (334s left) kms_addfb_basic (bad-pitch-65536)
[696.041351] Starting subtest: bad-pitch-65536
[696.042259] Subtest bad-pitch-65536: SUCCESS (0.000s)
[696.174532] [132/133] (334s left) prime_mmap (test_aperture_limit)
[696.218077] Starting subtest: test_aperture_limit
[696.218936] Starting dynamic subtest: test_aperture_limit-smem
[696.229708] Dynamic subtest test_aperture_limit-smem: SKIP (0.010s)
[696.232009] Subtest test_aperture_limit: SKIP (0.011s)
[696.302115] [133/133] (334s left) kms_joiner (basic-force-ultra-joiner)
[696.391737] Starting subtest: basic-force-ultra-joiner
[696.393418] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[696.454817] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: i915_pm_rps
results: parsing output: 2/ for test: gem_mmap_offset
results: parsing output: 3/ for test: kms_chamelium_hpd
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: drm_buddy
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_addfb_basic
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: kms_chamelium_frames
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_spin_batch
results: parsing output: 15/ for test: kms_atomic
results: parsing output: 16/ for test: gem_exec_schedule
results: parsing output: 17/ for test: vgem_basic
results: parsing output: 18/ for test: gem_exec_suspend
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: kms_universal_plane
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_lease
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_properties
results: parsing output: 25/ for test: kms_psr2_sf
results: parsing output: 26/ for test: kms_vblank
results: parsing output: 27/ for test: kms_cursor_crc
results: parsing output: 28/ for test: kms_plane
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: gem_render_copy
results: parsing output: 31/ for test: gem_sync
results: parsing output: 32/ for test: gem_exercise_blt
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: prime_busy
results: parsing output: 35/ for test: kms_dp_link_training
results: parsing output: 36/ for test: fbdev
results: parsing output: 37/ for test: kms_content_protection
results: parsing output: 38/ for test: kms_psr2_sf
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_psr2_sf
results: parsing output: 41/ for test: kms_pm_dc
results: parsing output: 42/ for test: api_intel_bb
results: parsing output: 43/ for test: gem_ctx_exec
results: parsing output: 44/ for test: gem_ctx_param
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: gem_ctx_shared
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: gem_mmap_gtt
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: perf_pmu
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: perf
results: parsing output: 59/ for test: gem_create
results: parsing output: 60/ for test: kms_vblank
results: parsing output: 61/ for test: gem_exec_schedule
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_exec_balancer
results: parsing output: 66/ for test: kms_pipe_crc_basic
results: parsing output: 67/ for test: gen9_exec_parse
results: parsing output: 68/ for test: kms_plane_lowres
results: parsing output: 69/ for test: kms_plane
results: parsing output: 70/ for test: gem_fence_thrash
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_async_flips
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: perf_pmu
results: parsing output: 76/ for test: perf
results: parsing output: 77/ for test: gem_exec_schedule
results: parsing output: 78/ for test: i915_query
results: parsing output: 79/ for test: gem_pxp
results: parsing output: 80/ for test: gem_exec_params
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_rotation_crc
results: parsing output: 83/ for test: kms_flip_scaled_crc
results: parsing output: 84/ for test: perf_pmu
results: parsing output: 85/ for test: kms_getfb
results: parsing output: 86/ for test: gem_ctx_persistence
results: parsing output: 87/ for test: kms_plane_scaling
results: parsing output: 88/ for test: gem_render_copy
results: parsing output: 89/ for test: kms_cursor_crc
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: prime_vgem
results: parsing output: 94/ for test: gem_exec_suspend
results: parsing output: 95/ for test: i915_drm_fdinfo
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: kms_color_pipeline
results: parsing output: 98/ for test: kms_pm_rpm
results: parsing output: 99/ for test: gem_exec_fence
results: parsing output: 100/ for test: syncobj_wait
results: parsing output: 101/ for test: i915_hangman
results: parsing output: 102/ for test: gem_eio
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: gem_create
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: api_intel_bb
results: parsing output: 108/ for test: gem_exec_flush
results: parsing output: 109/ for test: gem_exec_balancer
results: parsing output: 110/ for test: kms_properties
results: parsing output: 111/ for test: gem_basic
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: kms_cursor_crc
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: kms_flip_event_leak
results: parsing output: 117/ for test: gem_userptr_blits
results: parsing output: 118/ for test: gem_pxp
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_flip
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: gem_exec_params
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: syncobj_wait
results: parsing output: 127/ for test: kms_dirtyfb
results: parsing output: 128/ for test: syncobj_basic
results: parsing output: 129/ for test: syncobj_wait
results: parsing output: 130/ for test: kms_addfb_basic
results: parsing output: 131/ for test: prime_mmap
results: parsing output: 132/ for test: kms_joiner
Done.