[58.797077] Initializing watchdogs
[58.797137]   /dev/watchdog0
[58.812303] [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.816722] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.818993] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.822273] [001/133] (960s left) gem_create (create-ext-placement-all)
[59.020899] Starting subtest: create-ext-placement-all
[59.023461] Subtest create-ext-placement-all: SUCCESS (0.000s)
[59.145966] [002/133] (960s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[59.217091] Starting subtest: map-fixed-invalidate-overlap
[59.221460] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[59.395674] [003/133] (960s left) gem_pipe_control_store_loop (fresh-buffer)
[59.468174] Starting subtest: fresh-buffer
[61.622252] Subtest fresh-buffer: SUCCESS (2.156s)
[61.783409] [004/133] (957s left) gem_mmap_offset (mmap-boundaries)
[61.850500] Starting subtest: mmap-boundaries
[61.852488] Starting dynamic subtest: smem0
[62.132354] Dynamic subtest smem0: SUCCESS (0.283s)
[62.135056] Subtest mmap-boundaries: SUCCESS (0.284s)
[62.269766] [005/133] (957s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[62.382011] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[69.775982] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.404s)
[69.983463] [006/133] (949s left) kms_atomic (atomic-plane-damage)
[70.092205] Starting subtest: atomic-plane-damage
[70.171906] Starting dynamic subtest: pipe-A-eDP-1
[70.702493] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.531s)
[70.704975] Subtest atomic-plane-damage: SUCCESS (0.609s)
[71.597303] [007/133] (947s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[71.700064] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[71.702257] Starting dynamic subtest: pipe-A-eDP-1
[71.767404] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.067s)
[71.775494] Starting dynamic subtest: pipe-B-eDP-1
[71.832083] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.062s)
[71.840136] Starting dynamic subtest: pipe-C-eDP-1
[71.891634] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.060s)
[71.899298] Starting dynamic subtest: pipe-D-eDP-1
[71.956131] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.064s)
[71.958339] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.256s)
[74.295430] [008/133] (945s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[74.412562] Starting subtest: psr-rgb101010-draw-mmap-wc
[81.500495] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.102s)
[81.648977] [009/133] (938s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[81.711712] Starting subtest: yf-tiled-to-vebox-x-tiled
[81.715830] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[81.914087] [010/133] (937s left) syncobj_timeline (wait-all-complex)
[81.980790] Starting subtest: wait-all-complex
[82.194085] Subtest wait-all-complex: SUCCESS (0.213s)
[82.289136] [011/133] (937s left) gem_pxp (create-valid-protected-context)
[82.415584] Starting subtest: create-valid-protected-context
[82.418066] Subtest create-valid-protected-context: SUCCESS (0.002s)
[82.561394] [012/133] (937s left) gem_exec_flush (basic-wb-rw-default)
[82.629342] Starting subtest: basic-wb-rw-default
[88.074541] Subtest basic-wb-rw-default: SUCCESS (5.448s)
[88.280594] [013/133] (931s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[88.387394] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[88.389665] Starting dynamic subtest: pipe-A-eDP-1
[88.410485] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[88.423322] Starting dynamic subtest: pipe-B-eDP-1
[88.442819] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[88.452133] Starting dynamic subtest: pipe-C-eDP-1
[88.471052] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[88.478295] Starting dynamic subtest: pipe-D-eDP-1
[88.497204] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[88.499051] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[90.732563] [014/133] (929s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[90.850282] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[94.993858] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.147s)
[96.152232] [015/133] (923s left) kms_cursor_edge_walk (256x256-top-bottom)
[96.246261] Starting subtest: 256x256-top-bottom
[96.248635] Starting dynamic subtest: pipe-A-eDP-1
[99.677335] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.432s)
[99.691868] Starting dynamic subtest: pipe-D-eDP-1
[102.795461] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.119s)
[102.797813] Subtest 256x256-top-bottom: SUCCESS (6.552s)
[103.626864] [016/133] (916s left) kms_force_connector_basic (force-load-detect)
[103.713817] Starting subtest: force-load-detect
[103.718211] Subtest force-load-detect: SKIP (0.000s)
[103.852725] [017/133] (916s left) syncobj_wait (invalid-signal-zero-handles)
[103.916039] Starting subtest: invalid-signal-zero-handles
[103.918364] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[104.051511] [018/133] (915s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[108.993050] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[108.995465] Starting dynamic subtest: pipe-A-eDP-1
[109.783045] Dynamic subtest pipe-A-eDP-1: SKIP (0.786s)
[109.792134] Starting dynamic subtest: pipe-B-eDP-1
[110.912410] Dynamic subtest pipe-B-eDP-1: SKIP (1.129s)
[110.916840] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.919s)
[112.131322] [019/133] (907s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[112.248348] Starting subtest: fbcpsr-rgb565-draw-render
[119.309414] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.073s)
[119.476750] [020/133] (900s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[119.581978] Starting subtest: primary-4-tiled-reflect-x-0
[126.947813] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.366s)
[128.170297] [021/133] (891s left) kms_setmode (clone-exclusive-crtc)
[128.235378] Starting subtest: clone-exclusive-crtc
[128.242505] Subtest clone-exclusive-crtc: SKIP (0.001s)
[128.366006] [022/133] (891s left) kms_addfb_basic (too-high)
[128.466993] Starting subtest: too-high
[128.469232] Subtest too-high: SUCCESS (0.001s)
[128.594462] [023/133] (891s left) perf_pmu (busy-accuracy-2)
[128.637196] Starting subtest: busy-accuracy-2
[128.638988] Starting dynamic subtest: rcs0
[131.676768] Dynamic subtest rcs0: SUCCESS (3.038s)
[131.687092] Starting dynamic subtest: bcs0
[134.735730] Dynamic subtest bcs0: SUCCESS (3.057s)
[134.746395] Starting dynamic subtest: vcs0
[137.778960] Dynamic subtest vcs0: SUCCESS (3.042s)
[137.789749] Starting dynamic subtest: vcs1
[140.824732] Dynamic subtest vcs1: SUCCESS (3.044s)
[140.835489] Starting dynamic subtest: vecs0
[143.868620] Dynamic subtest vecs0: SUCCESS (3.043s)
[143.878559] Starting dynamic subtest: ccs0
[146.929120] Dynamic subtest ccs0: SUCCESS (3.059s)
[146.931681] Subtest busy-accuracy-2: SUCCESS (18.292s)
[147.067189] [024/133] (873s left) kms_psr (pr-primary-mmap-gtt)
[147.174451] Starting subtest: pr-primary-mmap-gtt
[147.178809] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[147.268224] [025/133] (873s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[147.374732] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[147.379077] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[147.516993] [026/133] (872s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[147.615085] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[147.619040] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[147.753716] [027/133] (872s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[147.854785] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[147.856941] Starting dynamic subtest: pipe-A-default-mode
[150.580793] Dynamic subtest pipe-A-default-mode: SUCCESS (2.724s)
[150.583083] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.725s)
[151.458860] [028/133] (868s left) i915_drm_fdinfo (idle)
[151.500539] Starting subtest: idle
[151.502499] Starting dynamic subtest: rcs0
[152.102433] Dynamic subtest rcs0: SUCCESS (0.602s)
[152.113366] Starting dynamic subtest: bcs0
[152.609239] Dynamic subtest bcs0: SUCCESS (0.504s)
[152.620799] Starting dynamic subtest: vcs0
[153.114301] Dynamic subtest vcs0: SUCCESS (0.503s)
[153.125654] Starting dynamic subtest: vcs1
[153.619266] Dynamic subtest vcs1: SUCCESS (0.503s)
[153.630584] Starting dynamic subtest: vecs0
[154.124366] Dynamic subtest vecs0: SUCCESS (0.503s)
[154.135514] Starting dynamic subtest: ccs0
[154.630040] Dynamic subtest ccs0: SUCCESS (0.503s)
[154.632741] Subtest idle: SUCCESS (3.130s)
[154.728710] [029/133] (865s left) core_setmaster (master-drop-set-shared-fd)
[154.826147] Starting subtest: master-drop-set-shared-fd
[154.834567] Subtest master-drop-set-shared-fd: SUCCESS (0.011s)
[154.871824] [030/133] (865s left) kms_chamelium_color (ctm-negative)
[154.972979] Subtest ctm-negative: SKIP (0.000s)
[155.013855] [031/133] (865s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[155.068157] Starting subtest: multi-wait-for-submit-available-submitted
[155.070471] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[155.200507] [032/133] (865s left) syncobj_timeline (invalid-signal-illegal-point)
[155.258999] Starting subtest: invalid-signal-illegal-point
[155.261281] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[155.391937] [033/133] (865s left) gem_mmap (bad-offset)
[155.462687] Subtest bad-offset: SKIP (0.000s)
[155.524957] [034/133] (865s left) i915_hangman (gt-error-state-capture)
[155.586989] Starting subtest: gt-error-state-capture
[155.589391] Starting dynamic subtest: rcs0
[165.874800] Dynamic subtest rcs0: SUCCESS (10.288s)
[165.886299] Starting dynamic subtest: bcs0
[177.843786] Dynamic subtest bcs0: SUCCESS (11.967s)
[177.855315] Starting dynamic subtest: vcs0
[187.890573] Dynamic subtest vcs0: SUCCESS (10.045s)
[187.901990] Starting dynamic subtest: vcs1
[199.858743] Dynamic subtest vcs1: SUCCESS (11.966s)
[199.870422] Starting dynamic subtest: vecs0
[211.827471] Dynamic subtest vecs0: SUCCESS (11.967s)
[211.838957] Starting dynamic subtest: ccs0
[223.860689] Dynamic subtest ccs0: SUCCESS (12.031s)
[223.863784] Subtest gt-error-state-capture: SUCCESS (68.275s)
[223.964331] [035/133] (796s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[224.068869] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[224.071194] Starting dynamic subtest: pipe-A-eDP-1
[224.080160] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[224.093629] Starting dynamic subtest: pipe-B-eDP-1
[224.102671] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[224.114879] Starting dynamic subtest: pipe-C-eDP-1
[224.123568] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[224.135737] Starting dynamic subtest: pipe-D-eDP-1
[224.145100] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[224.149610] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[226.321353] [036/133] (794s left) gem_exec_whisper (basic-fds)
[226.394933] Starting subtest: basic-fds
[233.374311] Subtest basic-fds: SUCCESS (6.976s)
[233.579823] [037/133] (787s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[233.679179] Starting subtest: psr-1p-primscrn-cur-indfb-move
[241.074197] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.397s)
[241.254361] [038/133] (779s left) gem_exec_schedule (preempt-user)
[241.332145] Starting subtest: preempt-user
[241.334338] Starting dynamic subtest: rcs0
[241.346135] Dynamic subtest rcs0: SUCCESS (0.023s)
[241.356221] Starting dynamic subtest: bcs0
[241.364808] Dynamic subtest bcs0: SUCCESS (0.018s)
[241.373679] Starting dynamic subtest: vcs0
[241.385049] Dynamic subtest vcs0: SUCCESS (0.020s)
[241.395200] Starting dynamic subtest: vcs1
[241.405471] Dynamic subtest vcs1: SUCCESS (0.020s)
[241.414173] Starting dynamic subtest: vecs0
[241.425044] Dynamic subtest vecs0: SUCCESS (0.019s)
[241.433809] Starting dynamic subtest: ccs0
[241.446334] Dynamic subtest ccs0: SUCCESS (0.021s)
[241.448680] Subtest preempt-user: SUCCESS (0.124s)
[243.024716] [039/133] (777s left) kms_psr (psr2-primary-mmap-cpu)
[243.133174] Starting subtest: psr2-primary-mmap-cpu
[243.135500] Starting dynamic subtest: eDP-1
[244.884300] Dynamic subtest eDP-1: SUCCESS (1.751s)
[244.886555] Subtest psr2-primary-mmap-cpu: SUCCESS (1.752s)
[245.787331] [040/133] (775s left) gem_ctx_param (invalid-size-set)
[245.855851] Starting subtest: invalid-size-set
[245.858304] Subtest invalid-size-set: SUCCESS (0.001s)
[245.989932] [041/133] (774s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[246.093113] Starting subtest: bad-aux-stride-y-tiled-ccs
[246.095376] Starting dynamic subtest: pipe-A-eDP-1
[246.117588] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[246.130920] Starting dynamic subtest: pipe-B-eDP-1
[246.152376] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[246.164580] Starting dynamic subtest: pipe-C-eDP-1
[246.187280] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[246.197095] Starting dynamic subtest: pipe-D-eDP-1
[246.219064] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[246.223361] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[248.345386] [042/133] (772s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[248.451542] Starting subtest: blocking-absolute-wf_vblank-interruptible
[248.453913] Starting dynamic subtest: A-eDP1
[257.176799] Dynamic subtest A-eDP1: SUCCESS (8.723s)
[257.192896] Starting dynamic subtest: B-eDP1
[265.909462] Dynamic subtest B-eDP1: SUCCESS (8.729s)
[265.920093] Starting dynamic subtest: C-eDP1
[274.619683] Dynamic subtest C-eDP1: SUCCESS (8.708s)
[274.630556] Starting dynamic subtest: D-eDP1
[283.345288] Dynamic subtest D-eDP1: SUCCESS (8.724s)
[283.347722] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.894s)
[284.582265] [043/133] (736s left) kms_psr2_su (page_flip-nv12)
[284.648226] Subtest page_flip-NV12: SKIP (0.000s)
[284.717217] [044/133] (736s left) gem_exec_balancer (sliced)
[284.792448] Starting subtest: sliced
[284.797041] Subtest sliced: SKIP (0.000s)
[285.159213] [045/133] (735s left) kms_plane_lowres (tiling-x)
[285.247749] Starting subtest: tiling-x
[285.250025] Starting dynamic subtest: pipe-A-eDP-1
[285.254236] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[285.549271] Starting dynamic subtest: pipe-B-eDP-1
[285.554035] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[285.564074] Starting dynamic subtest: pipe-C-eDP-1
[285.568898] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[285.577463] Starting dynamic subtest: pipe-D-eDP-1
[285.581700] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[285.585697] Subtest tiling-x: SKIP (0.300s)
[286.410373] [046/133] (734s left) kms_vblank (query-busy-hang)
[286.514327] Starting subtest: query-busy-hang
[286.516557] Starting dynamic subtest: pipe-A-eDP-1
[312.658490] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.141s)
[312.672417] Starting dynamic subtest: pipe-D-eDP-1
[337.690431] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.029s)
[337.692839] Subtest query-busy-hang: SUCCESS (51.175s)
[338.565294] [047/133] (682s left) gem_exec_balancer (hang)
[338.943053] Starting subtest: hang
[340.915618] Subtest hang: SUCCESS (1.972s)
[341.077963] [048/133] (680s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[341.187371] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[341.191613] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[341.326387] [049/133] (679s left) kms_flip (bo-too-big)
[341.415591] Starting subtest: bo-too-big
[341.417465] Starting dynamic subtest: A-eDP1
[342.689631] Dynamic subtest A-eDP1: SUCCESS (1.276s)
[342.700542] Starting dynamic subtest: B-eDP1
[344.017334] Dynamic subtest B-eDP1: SUCCESS (1.327s)
[344.032186] Starting dynamic subtest: C-eDP1
[345.352658] Dynamic subtest C-eDP1: SUCCESS (1.332s)
[345.362284] Starting dynamic subtest: D-eDP1
[346.679518] Dynamic subtest D-eDP1: SUCCESS (1.326s)
[346.684137] Subtest bo-too-big: SUCCESS (5.273s)
[347.908546] [050/133] (673s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[347.981723] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[347.986118] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[348.191115] [051/133] (673s left) kms_cursor_legacy (single-bo)
[348.318122] Starting subtest: single-bo
[348.320026] Starting dynamic subtest: pipe-A
[353.700042] Dynamic subtest pipe-A: SUCCESS (5.379s)
[353.714543] Starting dynamic subtest: pipe-B
[359.083079] Dynamic subtest pipe-B: SUCCESS (5.380s)
[359.094571] Starting dynamic subtest: pipe-C
[364.465242] Dynamic subtest pipe-C: SUCCESS (5.379s)
[364.476372] Starting dynamic subtest: pipe-D
[369.847759] Dynamic subtest pipe-D: SUCCESS (5.379s)
[369.859362] Starting dynamic subtest: all-pipes
[375.236672] Dynamic subtest all-pipes: SUCCESS (5.387s)
[375.239062] Subtest single-bo: SUCCESS (26.918s)
[375.407904] [052/133] (645s left) kms_pm_rpm (basic-pci-d3-state)
[377.034747] Starting subtest: basic-pci-d3-state
[378.504229] Subtest basic-pci-d3-state: SUCCESS (1.470s)
[378.626621] [053/133] (642s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[378.739813] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[383.198496] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.461s)
[384.378633] [054/133] (637s left) kms_pm_rpm (legacy-planes)
[386.112276] Starting subtest: legacy-planes
[386.114429] Starting dynamic subtest: plane-63
[394.709213] Dynamic subtest plane-63: SUCCESS (8.600s)
[394.721653] Starting dynamic subtest: plane-93
[403.030645] Dynamic subtest plane-93: SUCCESS (8.319s)
[403.041920] Starting dynamic subtest: plane-123
[411.305953] Dynamic subtest plane-123: SUCCESS (8.272s)
[411.317409] Starting dynamic subtest: plane-133
[419.879212] Dynamic subtest plane-133: SUCCESS (8.570s)
[419.881936] Subtest legacy-planes: SUCCESS (33.772s)
[420.268194] [055/133] (601s left) prime_self_import (basic-with_one_bo)
[420.306425] Starting subtest: basic-with_one_bo
[420.333575] Subtest basic-with_one_bo: SUCCESS (0.027s)
[420.474297] [056/133] (601s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[420.577274] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[420.581476] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[420.713896] [057/133] (600s left) kms_flip (modeset-vs-vblank-race)
[420.810424] Starting subtest: modeset-vs-vblank-race
[420.812659] Starting dynamic subtest: A-eDP1
[425.470331] Dynamic subtest A-eDP1: SUCCESS (4.661s)
[425.491652] Starting dynamic subtest: B-eDP1
[430.184047] Dynamic subtest B-eDP1: SUCCESS (4.710s)
[430.197124] Starting dynamic subtest: C-eDP1
[434.810047] Dynamic subtest C-eDP1: SUCCESS (4.623s)
[434.828869] Starting dynamic subtest: D-eDP1
[439.434343] Dynamic subtest D-eDP1: SUCCESS (4.622s)
[439.436619] Subtest modeset-vs-vblank-race: SUCCESS (18.630s)
[440.637985] [058/133] (580s left) gem_lmem_swapping (heavy-verify-random-ccs)
[440.683699] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[440.733634] [059/133] (580s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[440.841327] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[440.845161] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[440.950794] [060/133] (580s left) kms_chamelium_color (gamma)
[441.055707] Subtest gamma: SKIP (0.000s)
[441.118950] [061/133] (580s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[441.236260] Starting subtest: cursorB-vs-flipA-varying-size
[441.240515] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[441.403839] [062/133] (580s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[441.504846] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[446.004015] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.502s)
[447.235936] [063/133] (574s left) dumb_buffer (map-valid)
[447.283413] Starting subtest: map-valid
[447.285572] Subtest map-valid: SUCCESS (0.000s)
[447.411452] [064/133] (574s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[447.506661] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[447.508858] Starting dynamic subtest: pipe-A-default-mode
[447.829754] Dynamic subtest pipe-A-default-mode: SKIP (0.322s)
[447.834246] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.324s)
[448.673774] [065/133] (573s left) perf (i915-ref-count)
[448.761847] Starting subtest: i915-ref-count
[448.822157] Subtest i915-ref-count: SUCCESS (0.061s)
[448.876433] [066/133] (573s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[448.971411] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[448.975596] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[449.099491] [067/133] (572s left) gem_softpin (noreloc-interruptible)
[449.169404] Starting subtest: noreloc-interruptible
[454.589014] Subtest noreloc-interruptible: SUCCESS (5.420s)
[454.737619] [068/133] (567s left) kms_psr (fbc-psr2-primary-render)
[454.862909] Starting subtest: fbc-psr2-primary-render
[454.865173] Starting dynamic subtest: eDP-1
[454.869390] Dynamic subtest eDP-1: SKIP (0.000s)
[454.873611] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[454.966365] [069/133] (567s left) kms_lease (atomic-implicit-crtc)
[455.076134] Starting subtest: atomic-implicit-crtc
[455.078285] Starting dynamic subtest: pipe-A-eDP-1
[455.089385] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[455.098950] Starting dynamic subtest: pipe-B-eDP-1
[455.110115] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[455.119062] Starting dynamic subtest: pipe-C-eDP-1
[455.129389] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[455.137682] Starting dynamic subtest: pipe-D-eDP-1
[455.148174] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[455.150065] Subtest atomic-implicit-crtc: SUCCESS (0.036s)
[455.239656] [070/133] (566s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[455.332895] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[455.716456] Starting dynamic subtest: pipe-A-eDP-1
[458.530333] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.812s)
[458.899467] Starting dynamic subtest: pipe-B-eDP-1
[461.659121] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.768s)
[462.028311] Starting dynamic subtest: pipe-C-eDP-1
[464.792514] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.769s)
[465.162827] Starting dynamic subtest: pipe-D-eDP-1
[467.920213] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.763s)
[467.922517] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.588s)
[469.135962] [071/133] (553s left) gem_exec_reloc (basic-wc-read-active)
[469.204717] Subtest basic-wc-read-active: SKIP (0.000s)
[469.290378] [072/133] (552s left) gem_readwrite (new-obj)
[469.354812] Subtest new-obj: SKIP (0.000s)
[469.423924] [073/133] (552s left) gem_mmap_gtt (basic-short)
[469.478797] Subtest basic-short: SKIP (0.000s)
[469.544869] [074/133] (552s left) kms_plane_multiple (tiling-yf)
[469.648390] Starting subtest: tiling-yf
[469.653020] Subtest tiling-yf: SKIP (0.000s)
[469.748352] [075/133] (552s left) kms_content_protection (dp-mst-type-0-hdcp14)
[469.900293] Starting subtest: dp-mst-type-0-hdcp14
[469.904751] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[470.070676] [076/133] (552s left) gem_ctx_shared (q-in-order)
[470.141043] Starting subtest: Q-in-order
[470.143132] Starting dynamic subtest: rcs0
[470.318969] Dynamic subtest rcs0: SUCCESS (0.176s)
[470.335071] Starting dynamic subtest: vcs0
[470.396033] Dynamic subtest vcs0: SUCCESS (0.077s)
[470.413099] Starting dynamic subtest: vcs1
[470.474139] Dynamic subtest vcs1: SUCCESS (0.077s)
[470.490984] Starting dynamic subtest: vecs0
[470.550575] Dynamic subtest vecs0: SUCCESS (0.075s)
[470.566660] Starting dynamic subtest: ccs0
[470.638662] Dynamic subtest ccs0: SUCCESS (0.087s)
[470.641165] Subtest Q-in-order: SUCCESS (0.498s)
[472.019139] [FACT gem_ctx_shared (q-in-order)] new: kernel.kmod_is_loaded.vgem: true
[472.022435] [077/133] (550s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[472.079926] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[472.184971] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[472.286283] [078/133] (550s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[472.410223] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[479.205993] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.797s)
[479.382424] [079/133] (543s left) kms_big_fb (linear-8bpp-rotate-270)
[479.494860] Starting subtest: linear-8bpp-rotate-270
[479.516623] Subtest linear-8bpp-rotate-270: SKIP (0.021s)
[479.669166] [080/133] (542s left) api_intel_allocator (standalone)
[479.725595] Starting subtest: standalone
[479.741609] Subtest standalone: SUCCESS (0.018s)
[479.898250] [081/133] (542s left) core_auth (getclient-master-drop)
[479.951959] Starting subtest: getclient-master-drop
[479.975670] Subtest getclient-master-drop: SUCCESS (0.025s)
[480.115092] [082/133] (542s left) kms_psr (fbc-psr2-basic)
[480.206345] Starting subtest: fbc-psr2-basic
[480.208655] Starting dynamic subtest: eDP-1
[480.212787] Dynamic subtest eDP-1: SKIP (0.000s)
[480.216432] Subtest fbc-psr2-basic: SKIP (0.001s)
[480.300689] [083/133] (542s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[480.448346] Starting subtest: cursor-rapid-movement-32x32
[480.494556] Subtest cursor-rapid-movement-32x32: SKIP (0.042s)
[480.808303] [084/133] (541s left) gem_exec_schedule (noreorder-priority)
[480.999674] Starting subtest: noreorder-priority
[481.002122] Starting dynamic subtest: rcs0
[482.138552] Dynamic subtest rcs0: SUCCESS (1.139s)
[482.149978] Starting dynamic subtest: vcs0
[483.946357] Dynamic subtest vcs0: SUCCESS (1.804s)
[483.958251] Starting dynamic subtest: vcs1
[485.883839] Dynamic subtest vcs1: SUCCESS (1.935s)
[485.895865] Starting dynamic subtest: vecs0
[487.866836] Dynamic subtest vecs0: SUCCESS (1.981s)
[487.879249] Starting dynamic subtest: ccs0
[489.044290] Dynamic subtest ccs0: SUCCESS (1.176s)
[489.047063] Subtest noreorder-priority: SUCCESS (8.046s)
[489.257012] [085/133] (533s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[489.364987] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[489.367273] Starting dynamic subtest: pipe-A-eDP-1
[489.391034] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[489.401209] Starting dynamic subtest: pipe-B-eDP-1
[489.423765] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[489.432285] Starting dynamic subtest: pipe-C-eDP-1
[489.454762] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[489.463068] Starting dynamic subtest: pipe-D-eDP-1
[489.487436] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[489.491677] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[491.700668] [086/133] (531s left) core_auth (many-magics)
[491.760818] Starting subtest: many-magics
[492.685870] Subtest many-magics: SUCCESS (0.927s)
[492.897026] [087/133] (529s left) i915_suspend (fence-restore-tiled2untiled)
[492.949414] Starting subtest: fence-restore-tiled2untiled
[492.953542] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[493.076943] [088/133] (529s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[493.169099] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[493.171289] Starting dynamic subtest: pipe-A
[493.191396] Dynamic subtest pipe-A: SKIP (0.018s)
[493.201074] Starting dynamic subtest: pipe-B
[493.223794] Dynamic subtest pipe-B: SKIP (0.032s)
[493.233229] Starting dynamic subtest: pipe-C
[493.256510] Dynamic subtest pipe-C: SKIP (0.032s)
[493.265364] Starting dynamic subtest: pipe-D
[493.288950] Dynamic subtest pipe-D: SKIP (0.032s)
[493.293190] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.117s)
[493.427655] [089/133] (529s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[493.537339] Starting subtest: y-tiled-64bpp-rotate-0
[493.541604] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[493.677656] [090/133] (529s left) gem_ctx_persistence (saturated-hostile)
[493.736499] Starting subtest: saturated-hostile
[493.738868] Starting dynamic subtest: rcs0
[494.605421] Dynamic subtest rcs0: SUCCESS (0.868s)
[494.617684] Starting dynamic subtest: bcs0
[495.404552] Dynamic subtest bcs0: SUCCESS (0.797s)
[495.416641] Starting dynamic subtest: vcs0
[496.196064] Dynamic subtest vcs0: SUCCESS (0.790s)
[496.207790] Starting dynamic subtest: vcs1
[497.021112] Dynamic subtest vcs1: SUCCESS (0.823s)
[497.032946] Starting dynamic subtest: vecs0
[497.847187] Dynamic subtest vecs0: SUCCESS (0.824s)
[497.858861] Starting dynamic subtest: ccs0
[498.705984] Dynamic subtest ccs0: SUCCESS (0.857s)
[498.708514] Subtest saturated-hostile: SUCCESS (4.970s)
[498.813615] [091/133] (524s left) kms_prop_blob (invalid-get-prop)
[498.874190] Starting subtest: invalid-get-prop
[498.876510] Subtest invalid-get-prop: SUCCESS (0.000s)
[499.025222] [092/133] (524s left) gem_mmap_gtt (basic-write)
[499.076995] Subtest basic-write: SKIP (0.000s)
[499.146224] [093/133] (523s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[499.271546] Starting subtest: cursorA-vs-flipA-varying-size
[510.387269] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.113s)
[511.229371] [094/133] (511s left) gem_linear_blits (interruptible)
[511.633551] Starting subtest: interruptible
[515.940079] Subtest interruptible: SUCCESS (4.304s)
[516.074381] [095/133] (507s left) gem_exec_params (sol-reset-invalid)
[516.183512] Starting subtest: sol-reset-invalid
[516.189463] Subtest sol-reset-invalid: SUCCESS (0.004s)
[518.003884] [096/133] (505s left) kms_color_pipeline (plane-lut1d)
[518.112204] Starting subtest: plane-lut1d
[518.125610] Starting dynamic subtest: pipe-A-eDP-1
[518.837277] Dynamic subtest pipe-A-eDP-1: FAIL (0.332s)
[519.577649] Starting dynamic subtest: pipe-B-eDP-1
[520.381841] Dynamic subtest pipe-B-eDP-1: FAIL (0.292s)
[520.926555] Starting dynamic subtest: pipe-C-eDP-1
[521.761139] Dynamic subtest pipe-C-eDP-1: FAIL (0.258s)
[522.253062] Starting dynamic subtest: pipe-D-eDP-1
[523.116938] Dynamic subtest pipe-D-eDP-1: FAIL (0.279s)
[523.119314] Subtest plane-lut1d: FAIL (4.701s)
[523.656602] [097/133] (499s left) gem_wait (busy)
[523.728933] Starting subtest: busy
[523.731246] Starting dynamic subtest: all-engines
[524.949073] Dynamic subtest all-engines: SUCCESS (1.218s)
[524.961502] Starting dynamic subtest: rcs0
[525.490360] Dynamic subtest rcs0: SUCCESS (0.540s)
[525.502396] Starting dynamic subtest: bcs0
[526.032598] Dynamic subtest bcs0: SUCCESS (0.540s)
[526.043762] Starting dynamic subtest: vcs0
[527.892939] Dynamic subtest vcs0: SUCCESS (1.857s)
[527.904314] Starting dynamic subtest: vcs1
[529.876749] Dynamic subtest vcs1: SUCCESS (1.981s)
[529.888758] Starting dynamic subtest: vecs0
[531.924993] Dynamic subtest vecs0: SUCCESS (2.045s)
[531.937507] Starting dynamic subtest: ccs0
[532.466446] Dynamic subtest ccs0: SUCCESS (0.540s)
[532.469048] Subtest busy: SUCCESS (8.737s)
[532.689866] [098/133] (490s left) sriov_basic (enable-vfs-autoprobe-on)
[532.739054] Starting subtest: enable-vfs-autoprobe-on
[532.741284] Starting dynamic subtest: numvfs-1
[532.811823] Dynamic subtest numvfs-1: FAIL (0.005s)
[532.820723] Starting dynamic subtest: numvfs-2
[532.889106] Dynamic subtest numvfs-2: FAIL (0.004s)
[532.898642] Starting dynamic subtest: numvfs-3
[532.967161] Dynamic subtest numvfs-3: FAIL (0.004s)
[532.976863] Starting dynamic subtest: numvfs-4
[533.044623] Dynamic subtest numvfs-4: FAIL (0.003s)
[533.054892] Starting dynamic subtest: numvfs-5
[533.128060] Dynamic subtest numvfs-5: FAIL (0.004s)
[533.138697] Starting dynamic subtest: numvfs-6
[533.211480] Dynamic subtest numvfs-6: FAIL (0.004s)
[533.222097] Starting dynamic subtest: numvfs-7
[533.295804] Dynamic subtest numvfs-7: FAIL (0.004s)
[533.306553] Starting dynamic subtest: numvfs-random
[533.376635] Dynamic subtest numvfs-random: FAIL (0.004s)
[533.387541] Starting dynamic subtest: numvfs-all
[533.459575] Dynamic subtest numvfs-all: FAIL (0.493s)
[533.461579] Subtest enable-vfs-autoprobe-on: FAIL (0.532s)
[533.501425] [099/133] (489s left) kms_chamelium_frames (vga-frame-dump)
[533.917906] Subtest vga-frame-dump: SKIP (0.000s)
[534.743585] [100/133] (488s left) gem_eio (throttle)
[534.955245] Starting subtest: throttle
[535.226618] Subtest throttle: SUCCESS (0.272s)
[535.409470] [101/133] (488s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-mmap-wc)
[535.507884] Starting subtest: psr-abgr161616f-draw-mmap-wc
[535.511802] Subtest psr-abgr161616f-draw-mmap-wc: SKIP (0.000s)
[535.623283] [102/133] (487s left) gem_softpin (allocator-nopin)
[535.680516] Starting subtest: allocator-nopin
[535.788789] Subtest allocator-nopin: SUCCESS (0.107s)
[535.959605] [103/133] (487s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[536.063938] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[536.765860] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.703s)
[536.974876] [104/133] (486s left) kms_flip (busy-flip)
[537.078424] Starting subtest: busy-flip
[537.080661] Starting dynamic subtest: A-eDP1
[538.788872] Dynamic subtest A-eDP1: SUCCESS (1.712s)
[538.801294] Starting dynamic subtest: B-eDP1
[540.440222] Dynamic subtest B-eDP1: SUCCESS (1.650s)
[540.450709] Starting dynamic subtest: C-eDP1
[542.062673] Dynamic subtest C-eDP1: SUCCESS (1.621s)
[542.073875] Starting dynamic subtest: D-eDP1
[543.704390] Dynamic subtest D-eDP1: SUCCESS (1.641s)
[543.706748] Subtest busy-flip: SUCCESS (6.632s)
[544.995905] [105/133] (478s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[545.108462] Starting subtest: x-tiled-16bpp-rotate-270
[545.127963] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[545.280946] [106/133] (478s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-render)
[545.386756] Starting subtest: fbcpsr-abgr161616f-draw-render
[545.390797] Subtest fbcpsr-abgr161616f-draw-render: SKIP (0.000s)
[545.517241] [107/133] (478s left) kms_getfb (getfb2-accept-nv12)
[545.623277] Starting subtest: getfb2-accept-nv12
[545.625420] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[545.748626] [108/133] (477s left) gem_ctx_exec (basic-nohangcheck)
[545.840593] Starting subtest: basic-nohangcheck
[546.100062] Subtest basic-nohangcheck: SUCCESS (0.262s)
[546.252534] [109/133] (477s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[546.373405] Starting subtest: short-flip-before-cursor-atomic-transitions
[547.333019] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.957s)
[548.235794] [110/133] (475s left) kms_cursor_crc (cursor-offscreen-256x256)
[548.474853] Starting subtest: cursor-offscreen-256x256
[548.480053] Starting dynamic subtest: pipe-A-eDP-1
[550.414889] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.934s)
[550.444206] Starting dynamic subtest: pipe-D-eDP-1
[553.028463] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.590s)
[553.030815] Subtest cursor-offscreen-256x256: SUCCESS (4.550s)
[553.910752] [111/133] (469s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[554.026262] Starting subtest: 4-tiled-8bpp-rotate-0
[555.251085] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.224s)
[555.438914] [112/133] (468s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[555.504567] Subtest writes-after-reads: SKIP (0.000s)
[555.578437] [113/133] (468s left) kms_frontbuffer_tracking (psr-slowdraw)
[555.679596] Starting subtest: psr-slowdraw
[580.932030] Subtest psr-slowdraw: SUCCESS (25.254s)
[581.071582] [114/133] (442s left) i915_pm_rc6_residency (rc6-idle)
[581.136696] Starting subtest: rc6-idle
[581.163550] Starting dynamic subtest: gt0-rcs0
[605.508359] Dynamic subtest gt0-rcs0: SUCCESS (24.343s)
[605.519492] Starting dynamic subtest: gt0-bcs0
[629.771804] Dynamic subtest gt0-bcs0: SUCCESS (24.262s)
[629.783444] Starting dynamic subtest: gt0-ccs0
[654.114586] Dynamic subtest gt0-ccs0: SUCCESS (24.340s)
[654.126614] Starting dynamic subtest: gt1-vcs0
[660.288609] Dynamic subtest gt1-vcs0: SUCCESS (6.170s)
[660.300875] Starting dynamic subtest: gt1-vecs0
[666.461040] Dynamic subtest gt1-vecs0: SUCCESS (6.169s)
[666.463837] Subtest rc6-idle: SUCCESS (85.324s)
[666.568113] [115/133] (357s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[666.670068] Starting subtest: fbc-modesetfrombusy
[670.456158] Subtest fbc-modesetfrombusy: SUCCESS (3.790s)
[671.666979] [116/133] (352s left) kms_psr (psr-cursor-render)
[671.765029] Starting subtest: psr-cursor-render
[671.767161] Starting dynamic subtest: eDP-1
[673.534158] Dynamic subtest eDP-1: SUCCESS (1.769s)
[673.536319] Subtest psr-cursor-render: SUCCESS (1.770s)
[674.433188] [117/133] (349s left) gem_exec_parallel (engines)
[674.509149] Starting subtest: engines
[674.511525] Starting dynamic subtest: basic
[677.907628] Dynamic subtest basic: SUCCESS (3.400s)
[677.920700] Starting dynamic subtest: contexts
[682.358317] Dynamic subtest contexts: SUCCESS (4.448s)
[682.368077] Starting dynamic subtest: fds
[686.196246] Dynamic subtest fds: SUCCESS (3.836s)
[686.207042] Starting dynamic subtest: userptr
[687.919221] Dynamic subtest userptr: SUCCESS (1.721s)
[687.921849] Subtest engines: SUCCESS (13.412s)
[688.133790] [118/133] (336s left) prime_busy (after)
[688.196040] Starting subtest: after
[688.200815] Starting dynamic subtest: rcs0
[688.256517] Dynamic subtest rcs0: SUCCESS (0.056s)
[688.266934] Starting dynamic subtest: bcs0
[688.337665] Dynamic subtest bcs0: SUCCESS (0.080s)
[688.347586] Starting dynamic subtest: vcs0
[688.378297] Dynamic subtest vcs0: SUCCESS (0.040s)
[688.387199] Starting dynamic subtest: vcs1
[688.420189] Dynamic subtest vcs1: SUCCESS (0.041s)
[688.429822] Starting dynamic subtest: vecs0
[688.460588] Dynamic subtest vecs0: SUCCESS (0.040s)
[688.470280] Starting dynamic subtest: ccs0
[688.503288] Dynamic subtest ccs0: SUCCESS (0.042s)
[688.611596] Subtest after: SUCCESS (0.414s)
[688.710947] [119/133] (335s left) gem_partial_pwrite_pread (write-display)
[688.762486] Subtest write-display: SKIP (0.000s)
[688.843816] [120/133] (335s left) gem_tiled_blits (basic)
[688.907522] Subtest basic: SKIP (0.000s)
[688.992079] [121/133] (335s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[689.103894] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[697.811438] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.719s)
[697.950561] [122/133] (326s left) sysfs_defaults (readonly)
[698.008038] Starting subtest: readonly
[698.010322] Starting dynamic subtest: vecs0
[698.012604] Dynamic subtest vecs0: SUCCESS (0.000s)
[698.022362] Starting dynamic subtest: ccs0
[698.024663] Dynamic subtest ccs0: SUCCESS (0.000s)
[698.033970] Starting dynamic subtest: vcs0
[698.036177] Dynamic subtest vcs0: SUCCESS (0.000s)
[698.045291] Starting dynamic subtest: bcs0
[698.047501] Dynamic subtest bcs0: SUCCESS (0.000s)
[698.056737] Starting dynamic subtest: rcs0
[698.058948] Dynamic subtest rcs0: SUCCESS (0.000s)
[698.068098] Starting dynamic subtest: vcs1
[698.069995] Dynamic subtest vcs1: SUCCESS (0.000s)
[698.072315] Subtest readonly: SUCCESS (0.006s)
[698.141542] [123/133] (326s left) kms_dsc (dsc-with-formats)
[698.230491] Starting subtest: dsc-with-formats
[698.268436] Subtest dsc-with-formats: SKIP (0.001s)
[698.327365] [124/133] (326s left) prime_mmap (test_reprime)
[698.383019] Starting subtest: test_reprime
[698.384956] Starting dynamic subtest: test_reprime-smem
[698.411983] Dynamic subtest test_reprime-smem: SUCCESS (0.031s)
[698.414486] Subtest test_reprime: SUCCESS (0.032s)
[698.535714] [125/133] (325s left) gem_exec_params (rsvd2-dirt)
[698.601792] Starting subtest: rsvd2-dirt
[698.606102] Subtest rsvd2-dirt: SKIP (0.000s)
[698.739065] [126/133] (325s left) kms_lease (lessee-list)
[698.829770] Starting subtest: lessee-list
[698.831747] Starting dynamic subtest: pipe-A-eDP-1
[698.833762] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[698.843924] Starting dynamic subtest: pipe-B-eDP-1
[698.845800] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[698.854928] Starting dynamic subtest: pipe-C-eDP-1
[698.856777] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[698.866201] Starting dynamic subtest: pipe-D-eDP-1
[698.868070] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[698.869882] Subtest lessee-list: SUCCESS (0.009s)
[698.972997] [127/133] (325s left) kms_vrr (flip-dpms)
[699.063093] Starting subtest: flip-dpms
[699.068746] Subtest flip-dpms: SKIP (0.000s)
[699.174338] [128/133] (325s left) kms_frontbuffer_tracking (fbc-1p-rte)
[699.275332] Starting subtest: fbc-1p-rte
[704.786783] Subtest fbc-1p-rte: SUCCESS (5.515s)
[706.010871] [129/133] (318s left) gen9_exec_parse (batch-zero-length)
[706.075244] Subtest batch-zero-length: SKIP (0.000s)
[706.168352] [130/133] (318s left) prime_mmap (test_aperture_limit)
[706.226570] Starting subtest: test_aperture_limit
[706.228598] Starting dynamic subtest: test_aperture_limit-smem
[706.236105] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[706.240186] Subtest test_aperture_limit: SKIP (0.009s)
[706.352387] [131/133] (318s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[706.451590] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[706.456059] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[706.574390] [132/133] (318s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[706.676474] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[706.680569] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[706.804090] [133/133] (317s left) gem_exec_fence (long-history)
[707.269140] Starting subtest: long-history
[714.654636] Subtest long-history: SUCCESS (7.386s)
[715.396813] Closing watchdogs
results: parsing output: 0/ for test: gem_create
results: parsing output: 1/ for test: gem_userptr_blits
results: parsing output: 2/ for test: gem_pipe_control_store_loop
results: parsing output: 3/ for test: gem_mmap_offset
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_atomic
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_render_copy
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: gem_pxp
results: parsing output: 11/ for test: gem_exec_flush
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_cursor_edge_walk
results: parsing output: 15/ for test: kms_force_connector_basic
results: parsing output: 16/ for test: syncobj_wait
results: parsing output: 17/ for test: kms_psr2_sf
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_rotation_crc
results: parsing output: 20/ for test: kms_setmode
results: parsing output: 21/ for test: kms_addfb_basic
results: parsing output: 22/ for test: perf_pmu
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_flip_scaled_crc
results: parsing output: 27/ for test: i915_drm_fdinfo
results: parsing output: 28/ for test: core_setmaster
results: parsing output: 29/ for test: kms_chamelium_color
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: gem_mmap
results: parsing output: 33/ for test: i915_hangman
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: gem_exec_whisper
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_exec_schedule
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: gem_ctx_param
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: kms_flip
results: parsing output: 42/ for test: kms_psr2_su
results: parsing output: 43/ for test: gem_exec_balancer
results: parsing output: 44/ for test: kms_plane_lowres
results: parsing output: 45/ for test: kms_vblank
results: parsing output: 46/ for test: gem_exec_balancer
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: gem_render_copy
results: parsing output: 50/ for test: kms_cursor_legacy
results: parsing output: 51/ for test: kms_pm_rpm
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_pm_rpm
results: parsing output: 54/ for test: prime_self_import
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: gem_lmem_swapping
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_chamelium_color
results: parsing output: 60/ for test: kms_cursor_legacy
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: dumb_buffer
results: parsing output: 63/ for test: kms_flip_scaled_crc
results: parsing output: 64/ for test: perf
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_softpin
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: kms_lease
results: parsing output: 69/ for test: kms_async_flips
results: parsing output: 70/ for test: gem_exec_reloc
results: parsing output: 71/ for test: gem_readwrite
results: parsing output: 72/ for test: gem_mmap_gtt
results: parsing output: 73/ for test: kms_plane_multiple
results: parsing output: 74/ for test: kms_content_protection
results: parsing output: 75/ for test: gem_ctx_shared
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: api_intel_allocator
results: parsing output: 80/ for test: core_auth
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: kms_cursor_crc
results: parsing output: 83/ for test: gem_exec_schedule
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: core_auth
results: parsing output: 86/ for test: i915_suspend
results: parsing output: 87/ for test: kms_plane_scaling
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: gem_ctx_persistence
results: parsing output: 90/ for test: kms_prop_blob
results: parsing output: 91/ for test: gem_mmap_gtt
results: parsing output: 92/ for test: kms_cursor_legacy
results: parsing output: 93/ for test: gem_linear_blits
results: parsing output: 94/ for test: gem_exec_params
results: parsing output: 95/ for test: kms_color_pipeline
results: parsing output: 96/ for test: gem_wait
results: parsing output: 97/ for test: sriov_basic
results: parsing output: 98/ for test: kms_chamelium_frames
results: parsing output: 99/ for test: gem_eio
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_softpin
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_getfb
results: parsing output: 107/ for test: gem_ctx_exec
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: kms_cursor_crc
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: i915_pm_rc6_residency
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: gem_exec_parallel
results: parsing output: 117/ for test: prime_busy
results: parsing output: 118/ for test: gem_partial_pwrite_pread
results: parsing output: 119/ for test: gem_tiled_blits
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: sysfs_defaults
results: parsing output: 122/ for test: kms_dsc
results: parsing output: 123/ for test: prime_mmap
results: parsing output: 124/ for test: gem_exec_params
results: parsing output: 125/ for test: kms_lease
results: parsing output: 126/ for test: kms_vrr
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gen9_exec_parse
results: parsing output: 129/ for test: prime_mmap
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_exec_fence
Done.