[57.073231] Initializing watchdogs
[57.073282]   /dev/watchdog0
[57.087286] [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]
[57.091750] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.094109] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.097541] [001/133] (960s left) gem_create (create-ext-placement-all)
[57.290478] Starting subtest: create-ext-placement-all
[57.292774] Subtest create-ext-placement-all: SUCCESS (0.000s)
[57.414312] [002/133] (960s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[57.475508] Starting subtest: map-fixed-invalidate-overlap
[57.479627] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[57.638621] [003/133] (960s left) gem_pipe_control_store_loop (fresh-buffer)
[57.702723] Starting subtest: fresh-buffer
[59.850771] Subtest fresh-buffer: SUCCESS (2.155s)
[60.017751] [004/133] (957s left) gem_mmap_offset (mmap-boundaries)
[60.079083] Starting subtest: mmap-boundaries
[60.081444] Starting dynamic subtest: smem0
[60.367908] Dynamic subtest smem0: SUCCESS (0.290s)
[60.370498] Subtest mmap-boundaries: SUCCESS (0.291s)
[60.527803] [005/133] (957s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[60.635711] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[68.574288] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.956s)
[68.731109] [006/133] (949s left) kms_atomic (atomic-plane-damage)
[68.831084] Starting subtest: atomic-plane-damage
[68.908904] Starting dynamic subtest: pipe-A-eDP-1
[69.435658] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.529s)
[69.438043] Subtest atomic-plane-damage: SUCCESS (0.604s)
[70.340105] [007/133] (947s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[70.443061] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[70.445327] Starting dynamic subtest: pipe-A-eDP-1
[70.503484] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[70.511449] Starting dynamic subtest: pipe-B-eDP-1
[70.567264] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.061s)
[70.575732] Starting dynamic subtest: pipe-C-eDP-1
[70.628337] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.061s)
[70.637358] Starting dynamic subtest: pipe-D-eDP-1
[70.687730] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.060s)
[70.690129] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.247s)
[73.002869] [008/133] (944s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[73.117277] Starting subtest: psr-rgb101010-draw-mmap-wc
[80.162191] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.052s)
[80.308419] [009/133] (937s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[80.367487] Starting subtest: yf-tiled-to-vebox-x-tiled
[80.371978] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[80.571254] [010/133] (937s left) syncobj_timeline (wait-all-complex)
[80.622659] Starting subtest: wait-all-complex
[80.837256] Subtest wait-all-complex: SUCCESS (0.213s)
[80.930712] [011/133] (937s left) gem_pxp (create-valid-protected-context)
[81.054811] Starting subtest: create-valid-protected-context
[81.057501] Subtest create-valid-protected-context: SUCCESS (0.002s)
[81.207382] [012/133] (936s left) gem_exec_flush (basic-wb-rw-default)
[81.267041] Starting subtest: basic-wb-rw-default
[86.716295] Subtest basic-wb-rw-default: SUCCESS (5.450s)
[86.932414] [013/133] (931s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[87.041072] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[87.043490] Starting dynamic subtest: pipe-A-eDP-1
[87.065279] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[87.075407] Starting dynamic subtest: pipe-B-eDP-1
[87.094753] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[87.104907] Starting dynamic subtest: pipe-C-eDP-1
[87.128358] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[87.135982] Starting dynamic subtest: pipe-D-eDP-1
[87.155400] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[87.157626] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[89.377601] [014/133] (928s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[89.488826] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[93.608887] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.124s)
[94.774186] [015/133] (923s left) kms_cursor_edge_walk (256x256-top-bottom)
[94.882054] Starting subtest: 256x256-top-bottom
[94.884219] Starting dynamic subtest: pipe-A-eDP-1
[98.299208] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.418s)
[98.308819] Starting dynamic subtest: pipe-D-eDP-1
[101.426775] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.126s)
[101.429171] Subtest 256x256-top-bottom: SUCCESS (6.545s)
[102.257446] [016/133] (915s left) kms_force_connector_basic (force-load-detect)
[102.349486] Starting subtest: force-load-detect
[102.354180] Subtest force-load-detect: SKIP (0.000s)
[102.483348] [017/133] (915s left) syncobj_wait (invalid-signal-zero-handles)
[102.545165] Starting subtest: invalid-signal-zero-handles
[102.547449] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[102.680256] [018/133] (915s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[107.701679] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[107.703995] Starting dynamic subtest: pipe-A-eDP-1
[108.508164] Dynamic subtest pipe-A-eDP-1: SKIP (0.803s)
[108.516353] Starting dynamic subtest: pipe-B-eDP-1
[109.643554] Dynamic subtest pipe-B-eDP-1: SKIP (1.134s)
[109.647879] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.941s)
[110.947671] [019/133] (907s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[111.045690] Starting subtest: fbcpsr-rgb565-draw-render
[118.110978] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.067s)
[118.281379] [020/133] (900s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[118.375043] Starting subtest: primary-4-tiled-reflect-x-0
[125.439611] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.067s)
[126.717622] [021/133] (891s left) kms_setmode (clone-exclusive-crtc)
[126.775819] Starting subtest: clone-exclusive-crtc
[126.782697] Subtest clone-exclusive-crtc: SKIP (0.000s)
[126.901389] [022/133] (891s left) kms_addfb_basic (too-high)
[127.000432] Starting subtest: too-high
[127.002442] Subtest too-high: SUCCESS (0.001s)
[127.134066] [023/133] (891s left) perf_pmu (busy-accuracy-2)
[127.175599] Starting subtest: busy-accuracy-2
[127.177656] Starting dynamic subtest: rcs0
[130.217358] Dynamic subtest rcs0: SUCCESS (3.040s)
[130.228232] Starting dynamic subtest: bcs0
[133.274069] Dynamic subtest bcs0: SUCCESS (3.055s)
[133.282433] Starting dynamic subtest: vcs0
[136.315524] Dynamic subtest vcs0: SUCCESS (3.039s)
[136.326070] Starting dynamic subtest: vcs1
[139.365236] Dynamic subtest vcs1: SUCCESS (3.048s)
[139.373313] Starting dynamic subtest: vecs0
[142.411380] Dynamic subtest vecs0: SUCCESS (3.044s)
[142.421992] Starting dynamic subtest: ccs0
[145.470338] Dynamic subtest ccs0: SUCCESS (3.057s)
[145.472703] Subtest busy-accuracy-2: SUCCESS (18.295s)
[145.606459] [024/133] (872s left) kms_psr (pr-primary-mmap-gtt)
[145.708649] Starting subtest: pr-primary-mmap-gtt
[145.712585] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[145.804473] [025/133] (872s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[145.892210] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[145.896168] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[146.018971] [026/133] (872s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[146.119291] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[146.123270] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[146.258140] [027/133] (872s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[146.354592] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[146.356830] Starting dynamic subtest: pipe-A-default-mode
[149.153622] Dynamic subtest pipe-A-default-mode: SUCCESS (2.798s)
[149.155950] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.799s)
[150.004477] [028/133] (868s left) i915_drm_fdinfo (idle)
[150.053191] Starting subtest: idle
[150.055599] Starting dynamic subtest: rcs0
[150.656326] Dynamic subtest rcs0: SUCCESS (0.605s)
[150.667296] Starting dynamic subtest: bcs0
[151.162833] Dynamic subtest bcs0: SUCCESS (0.503s)
[151.173752] Starting dynamic subtest: vcs0
[151.667654] Dynamic subtest vcs0: SUCCESS (0.503s)
[151.678079] Starting dynamic subtest: vcs1
[152.172655] Dynamic subtest vcs1: SUCCESS (0.503s)
[152.182751] Starting dynamic subtest: vecs0
[152.677924] Dynamic subtest vecs0: SUCCESS (0.503s)
[152.688376] Starting dynamic subtest: ccs0
[153.183186] Dynamic subtest ccs0: SUCCESS (0.503s)
[153.186104] Subtest idle: SUCCESS (3.132s)
[153.281513] [029/133] (865s left) core_setmaster (master-drop-set-shared-fd)
[153.376068] Starting subtest: master-drop-set-shared-fd
[153.386758] Subtest master-drop-set-shared-fd: SUCCESS (0.011s)
[153.424688] [030/133] (865s left) kms_chamelium_color (ctm-negative)
[153.535503] Subtest ctm-negative: SKIP (0.000s)
[153.580822] [031/133] (865s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[153.645417] Starting subtest: multi-wait-for-submit-available-submitted
[153.647768] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[153.780282] [032/133] (865s left) syncobj_timeline (invalid-signal-illegal-point)
[153.839286] Starting subtest: invalid-signal-illegal-point
[153.841586] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[153.956185] [033/133] (864s left) gem_mmap (bad-offset)
[154.018469] Subtest bad-offset: SKIP (0.000s)
[154.074082] [034/133] (864s left) i915_hangman (gt-error-state-capture)
[154.142524] Starting subtest: gt-error-state-capture
[154.144947] Starting dynamic subtest: rcs0
[165.878528] Dynamic subtest rcs0: SUCCESS (11.735s)
[165.891031] Starting dynamic subtest: bcs0
[177.911403] Dynamic subtest bcs0: SUCCESS (12.030s)
[177.922491] Starting dynamic subtest: vcs0
[189.877543] Dynamic subtest vcs0: SUCCESS (11.964s)
[189.888705] Starting dynamic subtest: vcs1
[201.846481] Dynamic subtest vcs1: SUCCESS (11.966s)
[201.858298] Starting dynamic subtest: vecs0
[212.853565] Dynamic subtest vecs0: SUCCESS (11.005s)
[212.865698] Starting dynamic subtest: ccs0
[223.865233] Dynamic subtest ccs0: SUCCESS (11.009s)
[223.868048] Subtest gt-error-state-capture: SUCCESS (69.721s)
[223.966983] [035/133] (794s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[224.078878] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[224.081249] Starting dynamic subtest: pipe-A-eDP-1
[224.090075] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[224.099941] Starting dynamic subtest: pipe-B-eDP-1
[224.108788] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[224.117642] Starting dynamic subtest: pipe-C-eDP-1
[224.126135] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[224.134218] Starting dynamic subtest: pipe-D-eDP-1
[224.142891] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[224.147285] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[226.350096] [036/133] (792s left) gem_exec_whisper (basic-fds)
[226.406525] Starting subtest: basic-fds
[233.787213] Subtest basic-fds: SUCCESS (7.380s)
[233.996625] [037/133] (784s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[234.106531] Starting subtest: psr-1p-primscrn-cur-indfb-move
[241.539034] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.434s)
[241.698943] [038/133] (777s left) gem_exec_schedule (preempt-user)
[241.768877] Starting subtest: preempt-user
[241.770826] Starting dynamic subtest: rcs0
[241.782511] Dynamic subtest rcs0: SUCCESS (0.023s)
[241.792990] Starting dynamic subtest: bcs0
[241.805147] Dynamic subtest bcs0: SUCCESS (0.022s)
[241.813655] Starting dynamic subtest: vcs0
[241.825441] Dynamic subtest vcs0: SUCCESS (0.020s)
[241.835563] Starting dynamic subtest: vcs1
[241.846305] Dynamic subtest vcs1: SUCCESS (0.020s)
[241.855044] Starting dynamic subtest: vecs0
[241.868055] Dynamic subtest vecs0: SUCCESS (0.021s)
[241.876506] Starting dynamic subtest: ccs0
[241.889984] Dynamic subtest ccs0: SUCCESS (0.021s)
[241.892526] Subtest preempt-user: SUCCESS (0.131s)
[243.050445] [039/133] (776s left) kms_psr (psr2-primary-mmap-cpu)
[243.147279] Starting subtest: psr2-primary-mmap-cpu
[243.149631] Starting dynamic subtest: eDP-1
[244.838717] Dynamic subtest eDP-1: SUCCESS (1.691s)
[244.841064] Subtest psr2-primary-mmap-cpu: SUCCESS (1.692s)
[245.743302] [040/133] (773s left) gem_ctx_param (invalid-size-set)
[245.797947] Starting subtest: invalid-size-set
[245.800443] Subtest invalid-size-set: SUCCESS (0.001s)
[245.921990] [041/133] (773s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[246.015497] Starting subtest: bad-aux-stride-y-tiled-ccs
[246.017939] Starting dynamic subtest: pipe-A-eDP-1
[246.040716] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[246.051589] Starting dynamic subtest: pipe-B-eDP-1
[246.072910] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[246.081408] Starting dynamic subtest: pipe-C-eDP-1
[246.102892] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[246.111066] Starting dynamic subtest: pipe-D-eDP-1
[246.133579] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[246.138160] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[248.308882] [042/133] (770s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[248.419115] Starting subtest: blocking-absolute-wf_vblank-interruptible
[248.423958] Starting dynamic subtest: A-eDP1
[257.144082] Dynamic subtest A-eDP1: SUCCESS (8.722s)
[257.154424] Starting dynamic subtest: B-eDP1
[265.872644] Dynamic subtest B-eDP1: SUCCESS (8.728s)
[265.885764] Starting dynamic subtest: C-eDP1
[274.586999] Dynamic subtest C-eDP1: SUCCESS (8.711s)
[274.597156] Starting dynamic subtest: D-eDP1
[283.308737] Dynamic subtest D-eDP1: SUCCESS (8.720s)
[283.311809] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.891s)
[284.538031] [043/133] (734s left) kms_psr2_su (page_flip-nv12)
[284.611158] Subtest page_flip-NV12: SKIP (0.000s)
[284.685142] [044/133] (734s left) gem_exec_balancer (sliced)
[284.750751] Starting subtest: sliced
[284.755256] Subtest sliced: SKIP (0.000s)
[285.089998] [045/133] (734s left) kms_plane_lowres (tiling-x)
[285.192479] Starting subtest: tiling-x
[285.194824] Starting dynamic subtest: pipe-A-eDP-1
[285.199469] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[285.488272] Starting dynamic subtest: pipe-B-eDP-1
[285.492924] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[285.501330] Starting dynamic subtest: pipe-C-eDP-1
[285.505706] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[285.514228] Starting dynamic subtest: pipe-D-eDP-1
[285.518537] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[285.522741] Subtest tiling-x: SKIP (0.296s)
[286.362165] [046/133] (732s left) kms_vblank (query-busy-hang)
[286.459386] Starting subtest: query-busy-hang
[286.461572] Starting dynamic subtest: pipe-A-eDP-1
[312.674041] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.214s)
[312.688902] Starting dynamic subtest: pipe-D-eDP-1
[337.747300] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.068s)
[337.749678] Subtest query-busy-hang: SUCCESS (51.287s)
[338.622220] [047/133] (680s left) gem_exec_balancer (hang)
[338.897352] Starting subtest: hang
[340.909815] Subtest hang: SUCCESS (2.016s)
[341.083417] [048/133] (678s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[341.195379] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[341.199792] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[341.309286] [049/133] (678s left) kms_flip (bo-too-big)
[341.407069] Starting subtest: bo-too-big
[341.409276] Starting dynamic subtest: A-eDP1
[342.748442] Dynamic subtest A-eDP1: SUCCESS (1.340s)
[342.758943] Starting dynamic subtest: B-eDP1
[344.070056] Dynamic subtest B-eDP1: SUCCESS (1.320s)
[344.081221] Starting dynamic subtest: C-eDP1
[345.410990] Dynamic subtest C-eDP1: SUCCESS (1.340s)
[345.422057] Starting dynamic subtest: D-eDP1
[346.737727] Dynamic subtest D-eDP1: SUCCESS (1.324s)
[346.739960] Subtest bo-too-big: SUCCESS (5.334s)
[347.962443] [050/133] (671s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[348.029893] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[348.034150] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[348.237985] [051/133] (671s left) kms_cursor_legacy (single-bo)
[348.366487] Starting subtest: single-bo
[348.368633] Starting dynamic subtest: pipe-A
[353.748696] Dynamic subtest pipe-A: SUCCESS (5.380s)
[353.759798] Starting dynamic subtest: pipe-B
[359.131607] Dynamic subtest pipe-B: SUCCESS (5.380s)
[359.142376] Starting dynamic subtest: pipe-C
[364.513749] Dynamic subtest pipe-C: SUCCESS (5.379s)
[364.524650] Starting dynamic subtest: pipe-D
[369.895215] Dynamic subtest pipe-D: SUCCESS (5.378s)
[369.906268] Starting dynamic subtest: all-pipes
[375.284718] Dynamic subtest all-pipes: SUCCESS (5.387s)
[375.287038] Subtest single-bo: SUCCESS (26.917s)
[375.454443] [052/133] (644s left) kms_pm_rpm (basic-pci-d3-state)
[377.014286] Starting subtest: basic-pci-d3-state
[378.476081] Subtest basic-pci-d3-state: SUCCESS (1.464s)
[378.549650] [053/133] (641s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[378.662713] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[383.020462] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.361s)
[384.260641] [054/133] (635s left) kms_pm_rpm (legacy-planes)
[386.092237] Starting subtest: legacy-planes
[386.094731] Starting dynamic subtest: plane-63
[394.378567] Dynamic subtest plane-63: SUCCESS (8.290s)
[394.389069] Starting dynamic subtest: plane-93
[402.708631] Dynamic subtest plane-93: SUCCESS (8.328s)
[402.719503] Starting dynamic subtest: plane-123
[411.032871] Dynamic subtest plane-123: SUCCESS (8.322s)
[411.044458] Starting dynamic subtest: plane-133
[419.657343] Dynamic subtest plane-133: SUCCESS (8.621s)
[419.660021] Subtest legacy-planes: SUCCESS (33.571s)
[420.071138] [055/133] (599s left) prime_self_import (basic-with_one_bo)
[420.108679] Starting subtest: basic-with_one_bo
[420.129979] Subtest basic-with_one_bo: SUCCESS (0.023s)
[420.250520] [056/133] (599s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[420.343423] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[420.347519] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[420.452998] [057/133] (599s left) kms_flip (modeset-vs-vblank-race)
[420.554201] Starting subtest: modeset-vs-vblank-race
[420.556534] Starting dynamic subtest: A-eDP1
[425.264546] Dynamic subtest A-eDP1: SUCCESS (4.711s)
[425.276286] Starting dynamic subtest: B-eDP1
[429.991348] Dynamic subtest B-eDP1: SUCCESS (4.725s)
[430.002674] Starting dynamic subtest: C-eDP1
[434.595061] Dynamic subtest C-eDP1: SUCCESS (4.601s)
[434.605232] Starting dynamic subtest: D-eDP1
[439.233992] Dynamic subtest D-eDP1: SUCCESS (4.638s)
[439.236302] Subtest modeset-vs-vblank-race: SUCCESS (18.685s)
[440.517183] [058/133] (579s left) gem_lmem_swapping (heavy-verify-random-ccs)
[440.560812] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[440.605367] [059/133] (579s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[440.711485] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[440.715876] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[440.848425] [060/133] (579s left) kms_chamelium_color (gamma)
[440.948316] Subtest gamma: SKIP (0.000s)
[440.990036] [061/133] (578s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[441.110327] Starting subtest: cursorB-vs-flipA-varying-size
[441.114802] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[441.280406] [062/133] (578s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[441.384458] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[445.911083] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.529s)
[447.126517] [063/133] (572s left) dumb_buffer (map-valid)
[447.201499] Starting subtest: map-valid
[447.203494] Subtest map-valid: SUCCESS (0.000s)
[447.338641] [064/133] (572s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[447.435098] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[447.437392] Starting dynamic subtest: pipe-A-default-mode
[447.744796] Dynamic subtest pipe-A-default-mode: SKIP (0.308s)
[447.749310] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.310s)
[448.542658] [065/133] (571s left) perf (i915-ref-count)
[448.649375] Starting subtest: i915-ref-count
[448.721858] Subtest i915-ref-count: SUCCESS (0.071s)
[448.779015] [066/133] (571s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[448.883997] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[448.888162] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[449.023295] [067/133] (571s left) gem_softpin (noreloc-interruptible)
[449.086383] Starting subtest: noreloc-interruptible
[454.496352] Subtest noreloc-interruptible: SUCCESS (5.408s)
[454.657925] [068/133] (565s left) kms_psr (fbc-psr2-primary-render)
[454.760921] Starting subtest: fbc-psr2-primary-render
[454.763185] Starting dynamic subtest: eDP-1
[454.767173] Dynamic subtest eDP-1: SKIP (0.000s)
[454.771183] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[454.858081] [069/133] (565s left) kms_lease (atomic-implicit-crtc)
[454.968489] Starting subtest: atomic-implicit-crtc
[454.970798] Starting dynamic subtest: pipe-A-eDP-1
[454.983670] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[454.998333] Starting dynamic subtest: pipe-B-eDP-1
[455.009645] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[455.019504] Starting dynamic subtest: pipe-C-eDP-1
[455.030306] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[455.039077] Starting dynamic subtest: pipe-D-eDP-1
[455.049896] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[455.052120] Subtest atomic-implicit-crtc: SUCCESS (0.036s)
[455.151207] [070/133] (565s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[455.247238] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[455.630084] Starting dynamic subtest: pipe-A-eDP-1
[458.396897] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.766s)
[458.763689] Starting dynamic subtest: pipe-B-eDP-1
[461.528740] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.770s)
[461.890297] Starting dynamic subtest: pipe-C-eDP-1
[464.663324] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.779s)
[465.034497] Starting dynamic subtest: pipe-D-eDP-1
[467.797915] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.770s)
[467.800145] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.552s)
[468.999244] [071/133] (551s left) gem_exec_reloc (basic-wc-read-active)
[469.067770] Subtest basic-wc-read-active: SKIP (0.000s)
[469.152289] [072/133] (551s left) gem_readwrite (new-obj)
[469.212298] Subtest new-obj: SKIP (0.000s)
[469.271281] [073/133] (551s left) gem_mmap_gtt (basic-short)
[469.330552] Subtest basic-short: SKIP (0.000s)
[469.394839] [074/133] (551s left) kms_plane_multiple (tiling-yf)
[469.487937] Starting subtest: tiling-yf
[469.492064] Subtest tiling-yf: SKIP (0.000s)
[469.582216] [075/133] (550s left) kms_content_protection (dp-mst-type-0-hdcp14)
[469.735522] Starting subtest: dp-mst-type-0-hdcp14
[469.739607] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[469.881608] [076/133] (550s left) gem_ctx_shared (q-in-order)
[469.950888] Starting subtest: Q-in-order
[469.952757] Starting dynamic subtest: rcs0
[470.115856] Dynamic subtest rcs0: SUCCESS (0.166s)
[470.130887] Starting dynamic subtest: vcs0
[470.190115] Dynamic subtest vcs0: SUCCESS (0.074s)
[470.206242] Starting dynamic subtest: vcs1
[470.266244] Dynamic subtest vcs1: SUCCESS (0.075s)
[470.281869] Starting dynamic subtest: vecs0
[470.343057] Dynamic subtest vecs0: SUCCESS (0.076s)
[470.358638] Starting dynamic subtest: ccs0
[470.429165] Dynamic subtest ccs0: SUCCESS (0.085s)
[470.431110] Subtest Q-in-order: SUCCESS (0.481s)
[472.055407] [FACT gem_ctx_shared (q-in-order)] new: kernel.kmod_is_loaded.vgem: true
[472.058812] [077/133] (548s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[472.126308] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[472.225583] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[472.330912] [078/133] (548s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[472.428260] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[479.114273] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.687s)
[479.287471] [079/133] (541s left) kms_big_fb (linear-8bpp-rotate-270)
[479.387324] Starting subtest: linear-8bpp-rotate-270
[479.412206] Subtest linear-8bpp-rotate-270: SKIP (0.021s)
[479.569302] [080/133] (541s left) api_intel_allocator (standalone)
[479.620930] Starting subtest: standalone
[479.636583] Subtest standalone: SUCCESS (0.018s)
[479.809111] [081/133] (540s left) core_auth (getclient-master-drop)
[479.837726] Starting subtest: getclient-master-drop
[479.868360] Subtest getclient-master-drop: SUCCESS (0.030s)
[480.005467] [082/133] (540s left) kms_psr (fbc-psr2-basic)
[480.100255] Starting subtest: fbc-psr2-basic
[480.102440] Starting dynamic subtest: eDP-1
[480.106254] Dynamic subtest eDP-1: SKIP (0.000s)
[480.110098] Subtest fbc-psr2-basic: SKIP (0.001s)
[480.194496] [083/133] (540s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[480.334940] Starting subtest: cursor-rapid-movement-32x32
[480.389418] Subtest cursor-rapid-movement-32x32: SKIP (0.049s)
[480.723221] [084/133] (540s left) gem_exec_schedule (noreorder-priority)
[480.901030] Starting subtest: noreorder-priority
[480.903439] Starting dynamic subtest: rcs0
[482.060786] Dynamic subtest rcs0: SUCCESS (1.160s)
[482.072104] Starting dynamic subtest: vcs0
[483.953335] Dynamic subtest vcs0: SUCCESS (1.889s)
[483.965776] Starting dynamic subtest: vcs1
[485.938018] Dynamic subtest vcs1: SUCCESS (1.982s)
[485.949526] Starting dynamic subtest: vecs0
[487.810420] Dynamic subtest vecs0: SUCCESS (1.869s)
[487.822554] Starting dynamic subtest: ccs0
[488.993892] Dynamic subtest ccs0: SUCCESS (1.182s)
[488.996609] Subtest noreorder-priority: SUCCESS (8.095s)
[489.205182] [085/133] (531s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[489.302139] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[489.304451] Starting dynamic subtest: pipe-A-eDP-1
[489.331192] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[489.342582] Starting dynamic subtest: pipe-B-eDP-1
[489.366196] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[489.375215] Starting dynamic subtest: pipe-C-eDP-1
[489.398365] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[489.407080] Starting dynamic subtest: pipe-D-eDP-1
[489.430985] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[489.435060] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[491.609938] [086/133] (529s left) core_auth (many-magics)
[491.671575] Starting subtest: many-magics
[492.671188] Subtest many-magics: SUCCESS (1.002s)
[492.897441] [087/133] (528s left) i915_suspend (fence-restore-tiled2untiled)
[492.967809] Starting subtest: fence-restore-tiled2untiled
[492.971875] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[493.084553] [088/133] (527s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[493.177993] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[493.180328] Starting dynamic subtest: pipe-A
[493.199478] Dynamic subtest pipe-A: SKIP (0.018s)
[493.209573] Starting dynamic subtest: pipe-B
[493.231093] Dynamic subtest pipe-B: SKIP (0.032s)
[493.242197] Starting dynamic subtest: pipe-C
[493.264904] Dynamic subtest pipe-C: SKIP (0.032s)
[493.274121] Starting dynamic subtest: pipe-D
[493.297180] Dynamic subtest pipe-D: SKIP (0.032s)
[493.301491] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.117s)
[493.428042] [089/133] (527s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[493.528981] Starting subtest: y-tiled-64bpp-rotate-0
[493.533484] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[493.668882] [090/133] (527s left) gem_ctx_persistence (saturated-hostile)
[493.732491] Starting subtest: saturated-hostile
[493.734464] Starting dynamic subtest: rcs0
[494.591258] Dynamic subtest rcs0: SUCCESS (0.862s)
[494.603410] Starting dynamic subtest: bcs0
[495.396461] Dynamic subtest bcs0: SUCCESS (0.803s)
[495.408965] Starting dynamic subtest: vcs0
[496.206261] Dynamic subtest vcs0: SUCCESS (0.808s)
[496.217484] Starting dynamic subtest: vcs1
[497.021367] Dynamic subtest vcs1: SUCCESS (0.813s)
[497.033634] Starting dynamic subtest: vecs0
[497.793679] Dynamic subtest vecs0: SUCCESS (0.771s)
[497.803956] Starting dynamic subtest: ccs0
[498.646147] Dynamic subtest ccs0: SUCCESS (0.850s)
[498.648620] Subtest saturated-hostile: SUCCESS (4.918s)
[498.750417] [091/133] (522s left) kms_prop_blob (invalid-get-prop)
[498.803529] Starting subtest: invalid-get-prop
[498.805789] Subtest invalid-get-prop: SUCCESS (0.000s)
[498.951533] [092/133] (522s left) gem_mmap_gtt (basic-write)
[499.017477] Subtest basic-write: SKIP (0.000s)
[499.086921] [093/133] (522s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[499.207487] Starting subtest: cursorA-vs-flipA-varying-size
[510.337347] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.128s)
[511.226392] [094/133] (510s left) gem_linear_blits (interruptible)
[511.679825] Starting subtest: interruptible
[516.127732] Subtest interruptible: SUCCESS (4.447s)
[516.307655] [095/133] (505s left) gem_exec_params (sol-reset-invalid)
[516.406220] Starting subtest: sol-reset-invalid
[516.411341] Subtest sol-reset-invalid: SUCCESS (0.003s)
[517.994300] [096/133] (503s left) kms_color_pipeline (plane-lut1d)
[518.105265] Starting subtest: plane-lut1d
[518.118683] Starting dynamic subtest: pipe-A-eDP-1
[518.867325] Dynamic subtest pipe-A-eDP-1: FAIL (0.355s)
[519.581615] Starting dynamic subtest: pipe-B-eDP-1
[520.432268] Dynamic subtest pipe-B-eDP-1: FAIL (0.336s)
[521.007715] Starting dynamic subtest: pipe-C-eDP-1
[521.833506] Dynamic subtest pipe-C-eDP-1: FAIL (0.236s)
[522.344931] Starting dynamic subtest: pipe-D-eDP-1
[523.185526] Dynamic subtest pipe-D-eDP-1: FAIL (0.245s)
[523.187692] Subtest plane-lut1d: FAIL (4.769s)
[523.752062] [097/133] (497s left) gem_wait (busy)
[523.817989] Starting subtest: busy
[523.820316] Starting dynamic subtest: all-engines
[525.911179] Dynamic subtest all-engines: SUCCESS (2.091s)
[525.924045] Starting dynamic subtest: rcs0
[526.453969] Dynamic subtest rcs0: SUCCESS (0.542s)
[526.466429] Starting dynamic subtest: bcs0
[526.994062] Dynamic subtest bcs0: SUCCESS (0.539s)
[527.005585] Starting dynamic subtest: vcs0
[528.921965] Dynamic subtest vcs0: SUCCESS (1.925s)
[528.934730] Starting dynamic subtest: vcs1
[530.904110] Dynamic subtest vcs1: SUCCESS (1.979s)
[530.916310] Starting dynamic subtest: vecs0
[532.887963] Dynamic subtest vecs0: SUCCESS (1.981s)
[532.900593] Starting dynamic subtest: ccs0
[533.429494] Dynamic subtest ccs0: SUCCESS (0.540s)
[533.432066] Subtest busy: SUCCESS (9.611s)
[533.652661] [098/133] (487s left) sriov_basic (enable-vfs-autoprobe-on)
[533.719076] Starting subtest: enable-vfs-autoprobe-on
[533.721362] Starting dynamic subtest: numvfs-1
[533.792878] Dynamic subtest numvfs-1: FAIL (0.006s)
[533.804170] Starting dynamic subtest: numvfs-2
[533.876084] Dynamic subtest numvfs-2: FAIL (0.004s)
[533.887626] Starting dynamic subtest: numvfs-3
[533.959772] Dynamic subtest numvfs-3: FAIL (0.004s)
[533.970534] Starting dynamic subtest: numvfs-4
[534.043345] Dynamic subtest numvfs-4: FAIL (0.004s)
[534.053754] Starting dynamic subtest: numvfs-5
[534.125583] Dynamic subtest numvfs-5: FAIL (0.004s)
[534.137270] Starting dynamic subtest: numvfs-6
[534.209377] Dynamic subtest numvfs-6: FAIL (0.004s)
[534.220076] Starting dynamic subtest: numvfs-7
[534.292412] Dynamic subtest numvfs-7: FAIL (0.004s)
[534.303314] Starting dynamic subtest: numvfs-random
[534.373898] Dynamic subtest numvfs-random: FAIL (0.004s)
[534.385305] Starting dynamic subtest: numvfs-all
[534.458772] Dynamic subtest numvfs-all: FAIL (0.513s)
[534.460823] Subtest enable-vfs-autoprobe-on: FAIL (0.553s)
[534.501621] [099/133] (486s left) kms_chamelium_frames (vga-frame-dump)
[534.883549] Subtest vga-frame-dump: SKIP (0.000s)
[535.739278] [100/133] (485s left) gem_eio (throttle)
[535.934811] Starting subtest: throttle
[536.201510] Subtest throttle: SUCCESS (0.266s)
[536.401149] [101/133] (485s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-mmap-wc)
[536.498438] Starting subtest: psr-abgr161616f-draw-mmap-wc
[536.502620] Subtest psr-abgr161616f-draw-mmap-wc: SKIP (0.000s)
[536.622508] [102/133] (485s left) gem_softpin (allocator-nopin)
[536.681658] Starting subtest: allocator-nopin
[536.775206] Subtest allocator-nopin: SUCCESS (0.093s)
[536.925947] [103/133] (484s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[537.026051] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[537.728953] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.704s)
[537.919088] [104/133] (483s left) kms_flip (busy-flip)
[538.020342] Starting subtest: busy-flip
[538.022620] Starting dynamic subtest: A-eDP1
[539.671826] Dynamic subtest A-eDP1: SUCCESS (1.653s)
[539.684030] Starting dynamic subtest: B-eDP1
[541.326062] Dynamic subtest B-eDP1: SUCCESS (1.653s)
[541.338426] Starting dynamic subtest: C-eDP1
[542.963633] Dynamic subtest C-eDP1: SUCCESS (1.636s)
[542.976855] Starting dynamic subtest: D-eDP1
[544.592578] Dynamic subtest D-eDP1: SUCCESS (1.628s)
[544.598531] Subtest busy-flip: SUCCESS (6.580s)
[545.874860] [105/133] (475s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[545.988715] Starting subtest: x-tiled-16bpp-rotate-270
[546.008647] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[546.161748] [106/133] (475s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-render)
[546.262664] Starting subtest: fbcpsr-abgr161616f-draw-render
[546.266757] Subtest fbcpsr-abgr161616f-draw-render: SKIP (0.000s)
[546.376903] [107/133] (475s left) kms_getfb (getfb2-accept-nv12)
[546.475161] Starting subtest: getfb2-accept-nv12
[546.477338] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[546.609259] [108/133] (475s left) gem_ctx_exec (basic-nohangcheck)
[546.668674] Starting subtest: basic-nohangcheck
[546.932062] Subtest basic-nohangcheck: SUCCESS (0.264s)
[547.093692] [109/133] (474s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[547.213617] Starting subtest: short-flip-before-cursor-atomic-transitions
[548.167118] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.953s)
[549.004819] [110/133] (472s left) kms_cursor_crc (cursor-offscreen-256x256)
[549.242106] Starting subtest: cursor-offscreen-256x256
[549.246923] Starting dynamic subtest: pipe-A-eDP-1
[551.174778] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.918s)
[551.196317] Starting dynamic subtest: pipe-D-eDP-1
[553.774652] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.584s)
[553.776874] Subtest cursor-offscreen-256x256: SUCCESS (4.530s)
[554.654688] [111/133] (467s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[554.759842] Starting subtest: 4-tiled-8bpp-rotate-0
[555.984664] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.224s)
[556.133997] [112/133] (465s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[556.187257] Subtest writes-after-reads: SKIP (0.000s)
[556.263021] [113/133] (465s left) kms_frontbuffer_tracking (psr-slowdraw)
[556.368444] Starting subtest: psr-slowdraw
[581.615283] Subtest psr-slowdraw: SUCCESS (25.249s)
[581.787722] [114/133] (440s left) i915_pm_rc6_residency (rc6-idle)
[581.857728] Starting subtest: rc6-idle
[581.880545] Starting dynamic subtest: gt0-rcs0
[606.171783] Dynamic subtest gt0-rcs0: SUCCESS (24.291s)
[606.181208] Starting dynamic subtest: gt0-bcs0
[630.463580] Dynamic subtest gt0-bcs0: SUCCESS (24.289s)
[630.475417] Starting dynamic subtest: gt0-ccs0
[654.790970] Dynamic subtest gt0-ccs0: SUCCESS (24.324s)
[654.802849] Starting dynamic subtest: gt1-vcs0
[660.963969] Dynamic subtest gt1-vcs0: SUCCESS (6.169s)
[660.976304] Starting dynamic subtest: gt1-vecs0
[667.137352] Dynamic subtest gt1-vecs0: SUCCESS (6.168s)
[667.139950] Subtest rc6-idle: SUCCESS (85.280s)
[667.240682] [115/133] (354s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[667.344341] Starting subtest: fbc-modesetfrombusy
[671.121913] Subtest fbc-modesetfrombusy: SUCCESS (3.783s)
[672.321385] [116/133] (349s left) kms_psr (psr-cursor-render)
[672.422164] Starting subtest: psr-cursor-render
[672.424429] Starting dynamic subtest: eDP-1
[674.181876] Dynamic subtest eDP-1: SUCCESS (1.761s)
[674.184195] Subtest psr-cursor-render: SUCCESS (1.762s)
[675.073060] [117/133] (347s left) gem_exec_parallel (engines)
[675.155242] Starting subtest: engines
[675.157571] Starting dynamic subtest: basic
[676.888408] Dynamic subtest basic: SUCCESS (1.733s)
[676.904912] Starting dynamic subtest: contexts
[681.313082] Dynamic subtest contexts: SUCCESS (4.423s)
[681.323188] Starting dynamic subtest: fds
[685.125336] Dynamic subtest fds: SUCCESS (3.811s)
[685.137834] Starting dynamic subtest: userptr
[686.954212] Dynamic subtest userptr: SUCCESS (1.826s)
[686.956974] Subtest engines: SUCCESS (11.801s)
[687.170700] [118/133] (335s left) prime_busy (after)
[687.242883] Starting subtest: after
[687.249783] Starting dynamic subtest: rcs0
[687.301417] Dynamic subtest rcs0: SUCCESS (0.052s)
[687.313459] Starting dynamic subtest: bcs0
[687.380906] Dynamic subtest bcs0: SUCCESS (0.078s)
[687.390860] Starting dynamic subtest: vcs0
[687.423652] Dynamic subtest vcs0: SUCCESS (0.042s)
[687.434121] Starting dynamic subtest: vcs1
[687.466083] Dynamic subtest vcs1: SUCCESS (0.042s)
[687.476405] Starting dynamic subtest: vecs0
[687.507828] Dynamic subtest vecs0: SUCCESS (0.041s)
[687.518080] Starting dynamic subtest: ccs0
[687.551314] Dynamic subtest ccs0: SUCCESS (0.043s)
[687.660352] Subtest after: SUCCESS (0.415s)
[687.762156] [119/133] (334s left) gem_partial_pwrite_pread (write-display)
[687.824121] Subtest write-display: SKIP (0.000s)
[687.916522] [120/133] (334s left) gem_tiled_blits (basic)
[687.991082] Subtest basic: SKIP (0.000s)
[688.080384] [121/133] (334s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[688.184469] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[697.008200] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.826s)
[697.148082] [122/133] (325s left) sysfs_defaults (readonly)
[697.218953] Starting subtest: readonly
[697.221260] Starting dynamic subtest: vecs0
[697.223563] Dynamic subtest vecs0: SUCCESS (0.000s)
[697.234828] Starting dynamic subtest: ccs0
[697.236620] Dynamic subtest ccs0: SUCCESS (0.000s)
[697.245980] Starting dynamic subtest: vcs0
[697.247883] Dynamic subtest vcs0: SUCCESS (0.000s)
[697.257198] Starting dynamic subtest: bcs0
[697.259049] Dynamic subtest bcs0: SUCCESS (0.000s)
[697.268437] Starting dynamic subtest: rcs0
[697.270293] Dynamic subtest rcs0: SUCCESS (0.000s)
[697.280052] Starting dynamic subtest: vcs1
[697.282153] Dynamic subtest vcs1: SUCCESS (0.000s)
[697.284257] Subtest readonly: SUCCESS (0.006s)
[697.359786] [123/133] (325s left) kms_dsc (dsc-with-formats)
[697.449783] Starting subtest: dsc-with-formats
[697.487949] Subtest dsc-with-formats: SKIP (0.001s)
[697.546810] [124/133] (325s left) prime_mmap (test_reprime)
[697.601626] Starting subtest: test_reprime
[697.603602] Starting dynamic subtest: test_reprime-smem
[697.628980] Dynamic subtest test_reprime-smem: SUCCESS (0.030s)
[697.631429] Subtest test_reprime: SUCCESS (0.031s)
[697.767961] [125/133] (324s left) gem_exec_params (rsvd2-dirt)
[697.821433] Starting subtest: rsvd2-dirt
[697.825854] Subtest rsvd2-dirt: SKIP (0.000s)
[697.959447] [126/133] (324s left) kms_lease (lessee-list)
[698.077079] Starting subtest: lessee-list
[698.078620] Starting dynamic subtest: pipe-A-eDP-1
[698.080485] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[698.090574] Starting dynamic subtest: pipe-B-eDP-1
[698.092242] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[698.101501] Starting dynamic subtest: pipe-C-eDP-1
[698.103030] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[698.112086] Starting dynamic subtest: pipe-D-eDP-1
[698.113634] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[698.115141] Subtest lessee-list: SUCCESS (0.009s)
[698.221822] [127/133] (324s left) kms_vrr (flip-dpms)
[698.312614] Starting subtest: flip-dpms
[698.317955] Subtest flip-dpms: SKIP (0.000s)
[698.411863] [128/133] (324s left) kms_frontbuffer_tracking (fbc-1p-rte)
[698.500255] Starting subtest: fbc-1p-rte
[703.981028] Subtest fbc-1p-rte: SUCCESS (5.483s)
[705.212385] [129/133] (317s left) gen9_exec_parse (batch-zero-length)
[705.280346] Subtest batch-zero-length: SKIP (0.000s)
[705.353570] [130/133] (317s left) prime_mmap (test_aperture_limit)
[705.413399] Starting subtest: test_aperture_limit
[705.415575] Starting dynamic subtest: test_aperture_limit-smem
[705.423027] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[705.428041] Subtest test_aperture_limit: SKIP (0.008s)
[705.548785] [131/133] (317s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[705.660669] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[705.665247] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[705.813387] [132/133] (317s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[705.915810] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[705.919853] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[706.046648] [133/133] (316s left) gem_exec_fence (long-history)
[706.528948] Starting subtest: long-history
[713.700083] Subtest long-history: SUCCESS (7.173s)
[714.626625] 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.