[104.612154] Initializing watchdogs
[104.612198]   /dev/watchdog0
[104.625745] [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]
[104.629808] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[104.632109] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[104.635398] [001/133] (960s left) gem_create (create-ext-placement-all)
[104.833880] Starting subtest: create-ext-placement-all
[104.836582] Subtest create-ext-placement-all: SUCCESS (0.000s)
[104.968175] [002/133] (960s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[105.037137] Starting subtest: map-fixed-invalidate-overlap
[105.041617] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[105.199766] [003/133] (960s left) gem_pipe_control_store_loop (fresh-buffer)
[105.252903] Starting subtest: fresh-buffer
[107.406450] Subtest fresh-buffer: SUCCESS (2.154s)
[107.569557] [004/133] (957s left) gem_mmap_offset (mmap-boundaries)
[107.631917] Starting subtest: mmap-boundaries
[107.634318] Starting dynamic subtest: smem0
[107.913051] Dynamic subtest smem0: SUCCESS (0.280s)
[107.915662] Subtest mmap-boundaries: SUCCESS (0.280s)
[108.063974] [005/133] (957s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[108.170652] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[115.361882] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.194s)
[115.495192] [006/133] (949s left) kms_atomic (atomic-plane-damage)
[115.590874] Starting subtest: atomic-plane-damage
[115.663450] Starting dynamic subtest: pipe-A-eDP-1
[116.210775] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.546s)
[116.213257] Subtest atomic-plane-damage: SUCCESS (0.622s)
[117.037753] [007/133] (948s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[117.132046] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[117.134021] Starting dynamic subtest: pipe-A-eDP-1
[117.192605] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[117.201568] Starting dynamic subtest: pipe-B-eDP-1
[117.254583] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.061s)
[117.263207] Starting dynamic subtest: pipe-C-eDP-1
[117.318435] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.063s)
[117.327265] Starting dynamic subtest: pipe-D-eDP-1
[117.385532] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.066s)
[117.387918] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.256s)
[119.755380] [008/133] (945s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[119.854937] Starting subtest: psr-rgb101010-draw-mmap-wc
[126.837976] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (6.985s)
[126.982964] [009/133] (938s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[127.054501] Starting subtest: yf-tiled-to-vebox-x-tiled
[127.059311] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[127.257220] [010/133] (938s left) syncobj_timeline (wait-all-complex)
[127.311064] Starting subtest: wait-all-complex
[127.523953] Subtest wait-all-complex: SUCCESS (0.213s)
[127.617683] [011/133] (937s left) gem_pxp (create-valid-protected-context)
[127.758758] Starting subtest: create-valid-protected-context
[127.761634] Subtest create-valid-protected-context: SUCCESS (0.002s)
[127.895169] [012/133] (937s left) gem_exec_flush (basic-wb-rw-default)
[127.958796] Starting subtest: basic-wb-rw-default
[133.409592] Subtest basic-wb-rw-default: SUCCESS (5.453s)
[133.628763] [013/133] (932s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[133.730751] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[133.732989] Starting dynamic subtest: pipe-A-eDP-1
[133.753464] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[133.761346] Starting dynamic subtest: pipe-B-eDP-1
[133.781311] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[133.788718] Starting dynamic subtest: pipe-C-eDP-1
[133.808245] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[133.816056] Starting dynamic subtest: pipe-D-eDP-1
[133.835741] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[133.838042] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[135.979100] [014/133] (929s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[136.093376] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[140.272748] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.182s)
[141.476522] [015/133] (924s left) kms_cursor_edge_walk (256x256-top-bottom)
[141.583179] Starting subtest: 256x256-top-bottom
[141.585531] Starting dynamic subtest: pipe-A-eDP-1
[145.010902] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.427s)
[145.019205] Starting dynamic subtest: pipe-D-eDP-1
[148.138812] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.124s)
[148.140694] Subtest 256x256-top-bottom: SUCCESS (6.555s)
[148.966370] [016/133] (916s left) kms_force_connector_basic (force-load-detect)
[149.042287] Starting subtest: force-load-detect
[149.046942] Subtest force-load-detect: SKIP (0.000s)
[149.178774] [017/133] (916s left) syncobj_wait (invalid-signal-zero-handles)
[149.244331] Starting subtest: invalid-signal-zero-handles
[149.246560] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[149.374274] [018/133] (916s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[154.324378] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[154.326389] Starting dynamic subtest: pipe-A-eDP-1
[155.116145] Dynamic subtest pipe-A-eDP-1: SKIP (0.788s)
[155.125320] Starting dynamic subtest: pipe-B-eDP-1
[156.250827] Dynamic subtest pipe-B-eDP-1: SKIP (1.134s)
[156.255496] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.925s)
[157.465936] [019/133] (908s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[157.570767] Starting subtest: fbcpsr-rgb565-draw-render
[164.614285] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.046s)
[164.772315] [020/133] (901s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[164.861278] Starting subtest: primary-4-tiled-reflect-x-0
[171.942326] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.080s)
[173.153332] [021/133] (892s left) kms_setmode (clone-exclusive-crtc)
[173.221360] Starting subtest: clone-exclusive-crtc
[173.227940] Subtest clone-exclusive-crtc: SKIP (0.000s)
[173.342279] [022/133] (892s left) kms_addfb_basic (too-high)
[173.443610] Starting subtest: too-high
[173.445727] Subtest too-high: SUCCESS (0.001s)
[173.561107] [023/133] (892s left) perf_pmu (busy-accuracy-2)
[173.610671] Starting subtest: busy-accuracy-2
[173.612587] Starting dynamic subtest: rcs0
[176.650467] Dynamic subtest rcs0: SUCCESS (3.039s)
[176.659869] Starting dynamic subtest: bcs0
[179.711086] Dynamic subtest bcs0: SUCCESS (3.059s)
[179.720937] Starting dynamic subtest: vcs0
[182.757755] Dynamic subtest vcs0: SUCCESS (3.045s)
[182.768220] Starting dynamic subtest: vcs1
[185.802625] Dynamic subtest vcs1: SUCCESS (3.043s)
[185.812045] Starting dynamic subtest: vecs0
[188.849774] Dynamic subtest vecs0: SUCCESS (3.045s)
[188.859655] Starting dynamic subtest: ccs0
[191.907403] Dynamic subtest ccs0: SUCCESS (3.056s)
[191.909685] Subtest busy-accuracy-2: SUCCESS (18.297s)
[192.060049] [024/133] (874s left) kms_psr (pr-primary-mmap-gtt)
[192.152043] Starting subtest: pr-primary-mmap-gtt
[192.156349] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[192.245565] [025/133] (873s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[192.339846] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[192.343769] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[192.457317] [026/133] (873s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[192.556225] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[192.560197] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[192.677865] [027/133] (873s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[192.775867] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[192.778147] Starting dynamic subtest: pipe-A-default-mode
[195.482805] Dynamic subtest pipe-A-default-mode: SUCCESS (2.705s)
[195.485272] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.707s)
[196.354240] [028/133] (869s left) i915_drm_fdinfo (idle)
[196.397311] Starting subtest: idle
[196.399665] Starting dynamic subtest: rcs0
[196.988055] Dynamic subtest rcs0: SUCCESS (0.590s)
[196.999095] Starting dynamic subtest: bcs0
[197.497343] Dynamic subtest bcs0: SUCCESS (0.505s)
[197.507431] Starting dynamic subtest: vcs0
[198.003053] Dynamic subtest vcs0: SUCCESS (0.503s)
[198.011719] Starting dynamic subtest: vcs1
[198.508911] Dynamic subtest vcs1: SUCCESS (0.504s)
[198.519865] Starting dynamic subtest: vecs0
[199.014570] Dynamic subtest vecs0: SUCCESS (0.503s)
[199.025231] Starting dynamic subtest: ccs0
[199.519648] Dynamic subtest ccs0: SUCCESS (0.503s)
[199.522407] Subtest idle: SUCCESS (3.121s)
[199.636304] [029/133] (866s left) core_setmaster (master-drop-set-shared-fd)
[199.740073] Starting subtest: master-drop-set-shared-fd
[199.750882] Subtest master-drop-set-shared-fd: SUCCESS (0.011s)
[199.784178] [030/133] (866s left) kms_chamelium_color (ctm-negative)
[199.895874] Subtest ctm-negative: SKIP (0.000s)
[199.938325] [031/133] (866s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[200.001852] Starting subtest: multi-wait-for-submit-available-submitted
[200.004058] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.001s)
[200.135074] [032/133] (866s left) syncobj_timeline (invalid-signal-illegal-point)
[200.195816] Starting subtest: invalid-signal-illegal-point
[200.198239] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[200.314274] [033/133] (866s left) gem_mmap (bad-offset)
[200.375273] Subtest bad-offset: SKIP (0.000s)
[200.448169] [034/133] (866s left) i915_hangman (gt-error-state-capture)
[200.521100] Starting subtest: gt-error-state-capture
[200.523458] Starting dynamic subtest: rcs0
[211.828665] Dynamic subtest rcs0: SUCCESS (11.307s)
[211.839794] Starting dynamic subtest: bcs0
[223.860381] Dynamic subtest bcs0: SUCCESS (12.029s)
[223.873722] Starting dynamic subtest: vcs0
[235.829652] Dynamic subtest vcs0: SUCCESS (11.967s)
[235.841332] Starting dynamic subtest: vcs1
[246.836752] Dynamic subtest vcs1: SUCCESS (11.004s)
[246.847335] Starting dynamic subtest: vecs0
[257.842671] Dynamic subtest vecs0: SUCCESS (11.004s)
[257.854091] Starting dynamic subtest: ccs0
[269.877526] Dynamic subtest ccs0: SUCCESS (12.034s)
[269.880647] Subtest gt-error-state-capture: SUCCESS (69.356s)
[269.978963] [035/133] (796s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[270.087152] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[270.089462] Starting dynamic subtest: pipe-A-eDP-1
[270.098877] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[270.108636] Starting dynamic subtest: pipe-B-eDP-1
[270.117958] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[270.125798] Starting dynamic subtest: pipe-C-eDP-1
[270.134344] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[270.141497] Starting dynamic subtest: pipe-D-eDP-1
[270.150081] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[270.154145] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[272.389540] [036/133] (794s left) gem_exec_whisper (basic-fds)
[272.450728] Starting subtest: basic-fds
[279.932204] Subtest basic-fds: SUCCESS (7.480s)
[280.136115] [037/133] (786s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[280.228933] Starting subtest: psr-1p-primscrn-cur-indfb-move
[287.727628] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.500s)
[287.846264] [038/133] (778s left) gem_exec_schedule (preempt-user)
[287.926826] Starting subtest: preempt-user
[287.928784] Starting dynamic subtest: rcs0
[287.944876] Dynamic subtest rcs0: SUCCESS (0.023s)
[287.953736] Starting dynamic subtest: bcs0
[287.963454] Dynamic subtest bcs0: SUCCESS (0.018s)
[287.972134] Starting dynamic subtest: vcs0
[287.984606] Dynamic subtest vcs0: SUCCESS (0.021s)
[287.992782] Starting dynamic subtest: vcs1
[288.004059] Dynamic subtest vcs1: SUCCESS (0.019s)
[288.012149] Starting dynamic subtest: vecs0
[288.022065] Dynamic subtest vecs0: SUCCESS (0.017s)
[288.030027] Starting dynamic subtest: ccs0
[288.044678] Dynamic subtest ccs0: SUCCESS (0.022s)
[288.046970] Subtest preempt-user: SUCCESS (0.124s)
[290.073144] [039/133] (776s left) kms_psr (psr2-primary-mmap-cpu)
[290.164502] Starting subtest: psr2-primary-mmap-cpu
[290.166633] Starting dynamic subtest: eDP-1
[291.947653] Dynamic subtest eDP-1: SUCCESS (1.784s)
[291.949952] Subtest psr2-primary-mmap-cpu: SUCCESS (1.785s)
[292.839669] [040/133] (773s left) gem_ctx_param (invalid-size-set)
[292.900881] Starting subtest: invalid-size-set
[292.903302] Subtest invalid-size-set: SUCCESS (0.001s)
[293.031827] [041/133] (773s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[293.123556] Starting subtest: bad-aux-stride-y-tiled-ccs
[293.125674] Starting dynamic subtest: pipe-A-eDP-1
[293.147330] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[293.157966] Starting dynamic subtest: pipe-B-eDP-1
[293.178864] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[293.186737] Starting dynamic subtest: pipe-C-eDP-1
[293.207251] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[293.215133] Starting dynamic subtest: pipe-D-eDP-1
[293.236608] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[293.240554] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[295.315604] [042/133] (771s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[295.432083] Starting subtest: blocking-absolute-wf_vblank-interruptible
[295.434310] Starting dynamic subtest: A-eDP1
[304.163702] Dynamic subtest A-eDP1: SUCCESS (8.730s)
[304.176705] Starting dynamic subtest: B-eDP1
[312.896885] Dynamic subtest B-eDP1: SUCCESS (8.730s)
[312.906055] Starting dynamic subtest: C-eDP1
[321.616033] Dynamic subtest C-eDP1: SUCCESS (8.716s)
[321.638686] Starting dynamic subtest: D-eDP1
[330.349933] Dynamic subtest D-eDP1: SUCCESS (8.731s)
[330.355189] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.920s)
[331.594443] [043/133] (735s left) kms_psr2_su (page_flip-nv12)
[331.658581] Subtest page_flip-NV12: SKIP (0.000s)
[331.726570] [044/133] (735s left) gem_exec_balancer (sliced)
[331.789658] Starting subtest: sliced
[331.794183] Subtest sliced: SKIP (0.000s)
[332.112148] [045/133] (734s left) kms_plane_lowres (tiling-x)
[332.211065] Starting subtest: tiling-x
[332.213223] Starting dynamic subtest: pipe-A-eDP-1
[332.217522] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[332.509264] Starting dynamic subtest: pipe-B-eDP-1
[332.513635] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[332.521725] Starting dynamic subtest: pipe-C-eDP-1
[332.526299] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[332.534638] Starting dynamic subtest: pipe-D-eDP-1
[332.538936] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[332.542979] Subtest tiling-x: SKIP (0.299s)
[333.318851] [046/133] (733s left) kms_vblank (query-busy-hang)
[333.430755] Starting subtest: query-busy-hang
[333.432637] Starting dynamic subtest: pipe-A-eDP-1
[360.661209] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.229s)
[360.678677] Starting dynamic subtest: pipe-D-eDP-1
[375.627160] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.963s)
[375.629461] Subtest query-busy-hang: SUCCESS (42.197s)
[376.471967] [047/133] (690s left) gem_exec_balancer (hang)
[376.731827] Starting subtest: hang
[378.359830] Subtest hang: SUCCESS (1.630s)
[378.526127] [048/133] (688s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[378.638063] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[378.642352] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[378.784410] [049/133] (688s left) kms_flip (bo-too-big)
[378.893977] Starting subtest: bo-too-big
[378.896071] Starting dynamic subtest: A-eDP1
[380.193333] Dynamic subtest A-eDP1: SUCCESS (1.303s)
[380.203369] Starting dynamic subtest: B-eDP1
[381.526096] Dynamic subtest B-eDP1: SUCCESS (1.331s)
[381.536586] Starting dynamic subtest: C-eDP1
[382.872633] Dynamic subtest C-eDP1: SUCCESS (1.344s)
[382.883681] Starting dynamic subtest: D-eDP1
[384.196253] Dynamic subtest D-eDP1: SUCCESS (1.323s)
[384.198447] Subtest bo-too-big: SUCCESS (5.310s)
[385.431549] [050/133] (681s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[385.499600] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[385.503916] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[385.703822] [051/133] (681s left) kms_cursor_legacy (single-bo)
[385.829192] Starting subtest: single-bo
[385.830982] Starting dynamic subtest: pipe-A
[391.212074] Dynamic subtest pipe-A: SUCCESS (5.379s)
[391.223391] Starting dynamic subtest: pipe-B
[396.594508] Dynamic subtest pipe-B: SUCCESS (5.379s)
[396.605612] Starting dynamic subtest: pipe-C
[401.975863] Dynamic subtest pipe-C: SUCCESS (5.379s)
[401.987029] Starting dynamic subtest: pipe-D
[407.357049] Dynamic subtest pipe-D: SUCCESS (5.379s)
[407.367847] Starting dynamic subtest: all-pipes
[412.746657] Dynamic subtest all-pipes: SUCCESS (5.387s)
[412.749199] Subtest single-bo: SUCCESS (26.915s)
[412.912423] [052/133] (654s left) kms_pm_rpm (basic-pci-d3-state)
[415.150751] Starting subtest: basic-pci-d3-state
[416.609641] Subtest basic-pci-d3-state: SUCCESS (1.462s)
[416.706745] [053/133] (650s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[416.808117] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[421.135604] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.330s)
[422.295188] [054/133] (644s left) kms_pm_rpm (legacy-planes)
[424.014803] Starting subtest: legacy-planes
[424.016856] Starting dynamic subtest: plane-63
[432.638447] Dynamic subtest plane-63: SUCCESS (8.624s)
[432.649903] Starting dynamic subtest: plane-93
[440.988912] Dynamic subtest plane-93: SUCCESS (8.348s)
[441.000228] Starting dynamic subtest: plane-123
[449.777485] Dynamic subtest plane-123: SUCCESS (8.784s)
[449.789329] Starting dynamic subtest: plane-133
[458.468171] Dynamic subtest plane-133: SUCCESS (8.690s)
[458.470648] Subtest legacy-planes: SUCCESS (34.457s)
[458.874350] [055/133] (608s left) prime_self_import (basic-with_one_bo)
[458.914058] Starting subtest: basic-with_one_bo
[458.932198] Subtest basic-with_one_bo: SUCCESS (0.021s)
[459.074141] [056/133] (608s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[459.154991] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[459.159154] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[459.278334] [057/133] (608s left) kms_flip (modeset-vs-vblank-race)
[459.388508] Starting subtest: modeset-vs-vblank-race
[459.390745] Starting dynamic subtest: A-eDP1
[464.062587] Dynamic subtest A-eDP1: SUCCESS (4.675s)
[464.073773] Starting dynamic subtest: B-eDP1
[468.819744] Dynamic subtest B-eDP1: SUCCESS (4.755s)
[468.830197] Starting dynamic subtest: C-eDP1
[473.505115] Dynamic subtest C-eDP1: SUCCESS (4.683s)
[473.516617] Starting dynamic subtest: D-eDP1
[478.049597] Dynamic subtest D-eDP1: SUCCESS (4.543s)
[478.051922] Subtest modeset-vs-vblank-race: SUCCESS (18.666s)
[479.323575] [058/133] (588s left) gem_lmem_swapping (heavy-verify-random-ccs)
[479.372481] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[479.423995] [059/133] (588s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[479.534573] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[479.538536] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[479.672100] [060/133] (587s left) kms_chamelium_color (gamma)
[479.774291] Subtest gamma: SKIP (0.000s)
[479.818088] [061/133] (587s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[479.945973] Starting subtest: cursorB-vs-flipA-varying-size
[479.950295] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[480.111421] [062/133] (587s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[480.217130] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[484.651585] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.439s)
[485.823797] [063/133] (581s left) dumb_buffer (map-valid)
[485.889670] Starting subtest: map-valid
[485.891972] Subtest map-valid: SUCCESS (0.000s)
[486.019576] [064/133] (581s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[486.117547] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[486.119856] Starting dynamic subtest: pipe-A-default-mode
[486.431374] Dynamic subtest pipe-A-default-mode: SKIP (0.313s)
[486.435676] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.315s)
[487.267009] [065/133] (580s left) perf (i915-ref-count)
[487.365348] Starting subtest: i915-ref-count
[487.438290] Subtest i915-ref-count: SUCCESS (0.071s)
[487.497750] [066/133] (580s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[487.598320] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[487.602608] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[487.733632] [067/133] (580s left) gem_softpin (noreloc-interruptible)
[487.789921] Starting subtest: noreloc-interruptible
[493.178631] Subtest noreloc-interruptible: SUCCESS (5.387s)
[493.357304] [068/133] (574s left) kms_psr (fbc-psr2-primary-render)
[493.458744] Starting subtest: fbc-psr2-primary-render
[493.460997] Starting dynamic subtest: eDP-1
[493.465130] Dynamic subtest eDP-1: SKIP (0.000s)
[493.469203] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[493.554636] [069/133] (574s left) kms_lease (atomic-implicit-crtc)
[493.650759] Starting subtest: atomic-implicit-crtc
[493.653134] Starting dynamic subtest: pipe-A-eDP-1
[493.664584] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[493.680277] Starting dynamic subtest: pipe-B-eDP-1
[493.691222] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.013s)
[493.699738] Starting dynamic subtest: pipe-C-eDP-1
[493.710221] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[493.718470] Starting dynamic subtest: pipe-D-eDP-1
[493.729253] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[493.731443] Subtest atomic-implicit-crtc: SUCCESS (0.039s)
[493.824579] [070/133] (574s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[493.913043] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[494.285471] Starting dynamic subtest: pipe-A-eDP-1
[497.094179] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.808s)
[497.459458] Starting dynamic subtest: pipe-B-eDP-1
[500.225089] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.770s)
[500.609335] Starting dynamic subtest: pipe-C-eDP-1
[503.366507] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.764s)
[503.739826] Starting dynamic subtest: pipe-D-eDP-1
[506.503019] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.773s)
[506.506048] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.590s)
[507.701754] [071/133] (560s left) gem_exec_reloc (basic-wc-read-active)
[507.774063] Subtest basic-wc-read-active: SKIP (0.000s)
[507.873092] [072/133] (560s left) gem_readwrite (new-obj)
[507.938873] Subtest new-obj: SKIP (0.000s)
[508.008557] [073/133] (560s left) gem_mmap_gtt (basic-short)
[508.076651] Subtest basic-short: SKIP (0.000s)
[508.146973] [074/133] (559s left) kms_plane_multiple (tiling-yf)
[508.241313] Starting subtest: tiling-yf
[508.245840] Subtest tiling-yf: SKIP (0.000s)
[508.337450] [075/133] (559s left) kms_content_protection (dp-mst-type-0-hdcp14)
[508.484164] Starting subtest: dp-mst-type-0-hdcp14
[508.488860] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[508.652733] [076/133] (559s left) gem_ctx_shared (q-in-order)
[508.709810] Starting subtest: Q-in-order
[508.711909] Starting dynamic subtest: rcs0
[508.859616] Dynamic subtest rcs0: SUCCESS (0.151s)
[508.875832] Starting dynamic subtest: vcs0
[508.938753] Dynamic subtest vcs0: SUCCESS (0.079s)
[508.954814] Starting dynamic subtest: vcs1
[509.010854] Dynamic subtest vcs1: SUCCESS (0.071s)
[509.026253] Starting dynamic subtest: vecs0
[509.085330] Dynamic subtest vecs0: SUCCESS (0.073s)
[509.101754] Starting dynamic subtest: ccs0
[509.174345] Dynamic subtest ccs0: SUCCESS (0.087s)
[509.177069] Subtest Q-in-order: SUCCESS (0.466s)
[511.076662] [FACT gem_ctx_shared (q-in-order)] new: kernel.kmod_is_loaded.vgem: true
[511.079898] [077/133] (557s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[511.137983] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[511.241378] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[511.344297] [078/133] (556s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[511.450208] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[518.055421] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.607s)
[518.202327] [079/133] (550s left) kms_big_fb (linear-8bpp-rotate-270)
[518.309080] Starting subtest: linear-8bpp-rotate-270
[518.330147] Subtest linear-8bpp-rotate-270: SKIP (0.020s)
[518.479529] [080/133] (549s left) api_intel_allocator (standalone)
[518.535813] Starting subtest: standalone
[518.551078] Subtest standalone: SUCCESS (0.016s)
[518.691326] [081/133] (549s left) core_auth (getclient-master-drop)
[518.732726] Starting subtest: getclient-master-drop
[518.753246] Subtest getclient-master-drop: SUCCESS (0.025s)
[518.902568] [082/133] (549s left) kms_psr (fbc-psr2-basic)
[518.990784] Starting subtest: fbc-psr2-basic
[518.993028] Starting dynamic subtest: eDP-1
[518.997077] Dynamic subtest eDP-1: SKIP (0.000s)
[519.001114] Subtest fbc-psr2-basic: SKIP (0.001s)
[519.087295] [083/133] (549s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[519.214084] Starting subtest: cursor-rapid-movement-32x32
[519.258774] Subtest cursor-rapid-movement-32x32: SKIP (0.040s)
[519.584734] [084/133] (548s left) gem_exec_schedule (noreorder-priority)
[519.764924] Starting subtest: noreorder-priority
[519.767696] Starting dynamic subtest: rcs0
[520.898617] Dynamic subtest rcs0: SUCCESS (1.135s)
[520.910587] Starting dynamic subtest: vcs0
[522.930277] Dynamic subtest vcs0: SUCCESS (2.028s)
[522.946959] Starting dynamic subtest: vcs1
[524.868246] Dynamic subtest vcs1: SUCCESS (1.935s)
[524.882995] Starting dynamic subtest: vecs0
[526.935658] Dynamic subtest vecs0: SUCCESS (2.064s)
[526.948080] Starting dynamic subtest: ccs0
[528.104827] Dynamic subtest ccs0: SUCCESS (1.169s)
[528.107209] Subtest noreorder-priority: SUCCESS (8.342s)
[528.319602] [085/133] (540s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[528.421966] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[528.424358] Starting dynamic subtest: pipe-A-eDP-1
[528.449909] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[528.460359] Starting dynamic subtest: pipe-B-eDP-1
[528.483962] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[528.492651] Starting dynamic subtest: pipe-C-eDP-1
[528.517023] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[528.527743] Starting dynamic subtest: pipe-D-eDP-1
[528.552166] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[528.556221] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[530.681822] [086/133] (537s left) core_auth (many-magics)
[530.746683] Starting subtest: many-magics
[531.669032] Subtest many-magics: SUCCESS (0.924s)
[531.835251] [087/133] (536s left) i915_suspend (fence-restore-tiled2untiled)
[531.892322] Starting subtest: fence-restore-tiled2untiled
[531.895542] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[532.025777] [088/133] (536s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[532.122265] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[532.124110] Starting dynamic subtest: pipe-A
[532.142543] Dynamic subtest pipe-A: SKIP (0.017s)
[532.150911] Starting dynamic subtest: pipe-B
[532.173605] Dynamic subtest pipe-B: SKIP (0.030s)
[532.182192] Starting dynamic subtest: pipe-C
[532.204866] Dynamic subtest pipe-C: SKIP (0.030s)
[532.213025] Starting dynamic subtest: pipe-D
[532.234666] Dynamic subtest pipe-D: SKIP (0.030s)
[532.237719] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.110s)
[532.362092] [089/133] (536s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[532.455188] Starting subtest: y-tiled-64bpp-rotate-0
[532.458858] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[532.596685] [090/133] (536s left) gem_ctx_persistence (saturated-hostile)
[532.659064] Starting subtest: saturated-hostile
[532.661103] Starting dynamic subtest: rcs0
[533.505414] Dynamic subtest rcs0: SUCCESS (0.846s)
[533.516930] Starting dynamic subtest: bcs0
[534.291496] Dynamic subtest bcs0: SUCCESS (0.784s)
[534.302974] Starting dynamic subtest: vcs0
[535.084900] Dynamic subtest vcs0: SUCCESS (0.791s)
[535.096704] Starting dynamic subtest: vcs1
[535.895177] Dynamic subtest vcs1: SUCCESS (0.809s)
[535.907696] Starting dynamic subtest: vecs0
[536.719926] Dynamic subtest vecs0: SUCCESS (0.823s)
[536.730757] Starting dynamic subtest: ccs0
[537.588660] Dynamic subtest ccs0: SUCCESS (0.867s)
[537.591271] Subtest saturated-hostile: SUCCESS (4.930s)
[537.692867] [091/133] (531s left) kms_prop_blob (invalid-get-prop)
[537.756991] Starting subtest: invalid-get-prop
[537.759394] Subtest invalid-get-prop: SUCCESS (0.000s)
[537.892631] [092/133] (530s left) gem_mmap_gtt (basic-write)
[537.951439] Subtest basic-write: SKIP (0.000s)
[538.028953] [093/133] (530s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[538.148440] Starting subtest: cursorA-vs-flipA-varying-size
[549.264482] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.116s)
[550.105332] [094/133] (518s left) gem_linear_blits (interruptible)
[550.500303] Starting subtest: interruptible
[554.651533] Subtest interruptible: SUCCESS (4.151s)
[554.903665] [095/133] (514s left) gem_exec_params (sol-reset-invalid)
[554.997351] Starting subtest: sol-reset-invalid
[555.002878] Subtest sol-reset-invalid: SUCCESS (0.003s)
[557.001428] [096/133] (511s left) kms_color_pipeline (plane-lut1d)
[557.121206] Starting subtest: plane-lut1d
[557.133758] Starting dynamic subtest: pipe-A-eDP-1
[557.865745] Dynamic subtest pipe-A-eDP-1: FAIL (0.332s)
[558.568783] Starting dynamic subtest: pipe-B-eDP-1
[559.353427] Dynamic subtest pipe-B-eDP-1: FAIL (0.279s)
[559.901031] Starting dynamic subtest: pipe-C-eDP-1
[560.736754] Dynamic subtest pipe-C-eDP-1: FAIL (0.236s)
[561.232375] Starting dynamic subtest: pipe-D-eDP-1
[562.073434] Dynamic subtest pipe-D-eDP-1: FAIL (0.257s)
[562.075826] Subtest plane-lut1d: FAIL (4.652s)
[562.635999] [097/133] (506s left) gem_wait (busy)
[562.710340] Starting subtest: busy
[562.712723] Starting dynamic subtest: all-engines
[563.925081] Dynamic subtest all-engines: SUCCESS (1.213s)
[563.942192] Starting dynamic subtest: rcs0
[564.467299] Dynamic subtest rcs0: SUCCESS (0.541s)
[564.478500] Starting dynamic subtest: bcs0
[565.006736] Dynamic subtest bcs0: SUCCESS (0.538s)
[565.017965] Starting dynamic subtest: vcs0
[566.869081] Dynamic subtest vcs0: SUCCESS (1.859s)
[566.881749] Starting dynamic subtest: vcs1
[568.916980] Dynamic subtest vcs1: SUCCESS (2.045s)
[568.928116] Starting dynamic subtest: vecs0
[570.901582] Dynamic subtest vecs0: SUCCESS (1.981s)
[570.914098] Starting dynamic subtest: ccs0
[571.442960] Dynamic subtest ccs0: SUCCESS (0.540s)
[571.445421] Subtest busy: SUCCESS (8.732s)
[571.665277] [098/133] (497s left) sriov_basic (enable-vfs-autoprobe-on)
[571.728926] Starting subtest: enable-vfs-autoprobe-on
[571.730959] Starting dynamic subtest: numvfs-1
[571.804772] Dynamic subtest numvfs-1: FAIL (0.006s)
[571.815639] Starting dynamic subtest: numvfs-2
[571.887736] Dynamic subtest numvfs-2: FAIL (0.003s)
[571.897982] Starting dynamic subtest: numvfs-3
[571.971219] Dynamic subtest numvfs-3: FAIL (0.003s)
[571.982305] Starting dynamic subtest: numvfs-4
[572.054494] Dynamic subtest numvfs-4: FAIL (0.003s)
[572.065089] Starting dynamic subtest: numvfs-5
[572.138902] Dynamic subtest numvfs-5: FAIL (0.003s)
[572.148935] Starting dynamic subtest: numvfs-6
[572.221475] Dynamic subtest numvfs-6: FAIL (0.003s)
[572.233325] Starting dynamic subtest: numvfs-7
[572.306759] Dynamic subtest numvfs-7: FAIL (0.003s)
[572.316533] Starting dynamic subtest: numvfs-random
[572.389984] Dynamic subtest numvfs-random: FAIL (0.003s)
[572.401220] Starting dynamic subtest: numvfs-all
[572.476746] Dynamic subtest numvfs-all: FAIL (0.516s)
[572.478824] Subtest enable-vfs-autoprobe-on: FAIL (0.553s)
[572.516870] [099/133] (496s left) kms_chamelium_frames (vga-frame-dump)
[572.890281] Subtest vga-frame-dump: SKIP (0.000s)
[573.728505] [100/133] (495s left) gem_eio (throttle)
[573.923986] Starting subtest: throttle
[574.189793] Subtest throttle: SUCCESS (0.264s)
[574.326222] [101/133] (494s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-mmap-wc)
[574.425345] Starting subtest: psr-abgr161616f-draw-mmap-wc
[574.429379] Subtest psr-abgr161616f-draw-mmap-wc: SKIP (0.000s)
[574.547064] [102/133] (494s left) gem_softpin (allocator-nopin)
[574.605138] Starting subtest: allocator-nopin
[574.721403] Subtest allocator-nopin: SUCCESS (0.117s)
[574.889913] [103/133] (494s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[574.992612] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[575.683483] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.692s)
[575.891104] [104/133] (493s left) kms_flip (busy-flip)
[576.002104] Starting subtest: busy-flip
[576.004080] Starting dynamic subtest: A-eDP1
[577.657124] Dynamic subtest A-eDP1: SUCCESS (1.656s)
[577.668683] Starting dynamic subtest: B-eDP1
[579.289733] Dynamic subtest B-eDP1: SUCCESS (1.631s)
[579.306438] Starting dynamic subtest: C-eDP1
[581.008647] Dynamic subtest C-eDP1: SUCCESS (1.716s)
[581.022214] Starting dynamic subtest: D-eDP1
[582.649960] Dynamic subtest D-eDP1: SUCCESS (1.640s)
[582.652319] Subtest busy-flip: SUCCESS (6.654s)
[583.936268] [105/133] (485s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[584.044335] Starting subtest: x-tiled-16bpp-rotate-270
[584.063343] Subtest x-tiled-16bpp-rotate-270: SKIP (0.018s)
[584.211466] [106/133] (485s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-render)
[584.306040] Starting subtest: fbcpsr-abgr161616f-draw-render
[584.310159] Subtest fbcpsr-abgr161616f-draw-render: SKIP (0.000s)
[584.455532] [107/133] (484s left) kms_getfb (getfb2-accept-nv12)
[584.553720] Starting subtest: getfb2-accept-nv12
[584.555848] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[584.693157] [108/133] (484s left) gem_ctx_exec (basic-nohangcheck)
[584.748456] Starting subtest: basic-nohangcheck
[585.008769] Subtest basic-nohangcheck: SUCCESS (0.262s)
[585.150164] [109/133] (484s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[585.283533] Starting subtest: short-flip-before-cursor-atomic-transitions
[586.221530] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.937s)
[587.056988] [110/133] (482s left) kms_cursor_crc (cursor-offscreen-256x256)
[587.296558] Starting subtest: cursor-offscreen-256x256
[587.298989] Starting dynamic subtest: pipe-A-eDP-1
[589.226867] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.930s)
[589.255513] Starting dynamic subtest: pipe-D-eDP-1
[591.821813] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.573s)
[591.824119] Subtest cursor-offscreen-256x256: SUCCESS (4.528s)
[592.712223] [111/133] (476s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[592.836310] Starting subtest: 4-tiled-8bpp-rotate-0
[594.072552] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.236s)
[594.220217] [112/133] (475s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[594.289476] Subtest writes-after-reads: SKIP (0.000s)
[594.359393] [113/133] (475s left) kms_frontbuffer_tracking (psr-slowdraw)
[594.459138] Starting subtest: psr-slowdraw
[619.730051] Subtest psr-slowdraw: SUCCESS (25.272s)
[619.879751] [114/133] (449s left) i915_pm_rc6_residency (rc6-idle)
[619.934889] Starting subtest: rc6-idle
[619.977815] Starting dynamic subtest: gt0-rcs0
[644.186178] Dynamic subtest gt0-rcs0: SUCCESS (24.208s)
[644.194896] Starting dynamic subtest: gt0-bcs0
[668.446349] Dynamic subtest gt0-bcs0: SUCCESS (24.257s)
[668.455070] Starting dynamic subtest: gt0-ccs0
[692.795648] Dynamic subtest gt0-ccs0: SUCCESS (24.346s)
[692.807355] Starting dynamic subtest: gt1-vcs0
[698.969436] Dynamic subtest gt1-vcs0: SUCCESS (6.169s)
[698.979531] Starting dynamic subtest: gt1-vecs0
[705.141065] Dynamic subtest gt1-vecs0: SUCCESS (6.168s)
[705.143956] Subtest rc6-idle: SUCCESS (85.206s)
[705.253324] [115/133] (364s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[705.372042] Starting subtest: fbc-modesetfrombusy
[709.256815] Subtest fbc-modesetfrombusy: SUCCESS (3.890s)
[710.447841] [116/133] (359s left) kms_psr (psr-cursor-render)
[710.547828] Starting subtest: psr-cursor-render
[710.550205] Starting dynamic subtest: eDP-1
[712.304641] Dynamic subtest eDP-1: SUCCESS (1.756s)
[712.307023] Subtest psr-cursor-render: SUCCESS (1.757s)
[713.200210] [117/133] (356s left) gem_exec_parallel (engines)
[713.274869] Starting subtest: engines
[713.277123] Starting dynamic subtest: basic
[714.930267] Dynamic subtest basic: SUCCESS (1.654s)
[714.939540] Starting dynamic subtest: contexts
[719.426521] Dynamic subtest contexts: SUCCESS (4.494s)
[719.438731] Starting dynamic subtest: fds
[723.183084] Dynamic subtest fds: SUCCESS (3.754s)
[723.195490] Starting dynamic subtest: userptr
[724.919405] Dynamic subtest userptr: SUCCESS (1.736s)
[724.921858] Subtest engines: SUCCESS (11.644s)
[725.147738] [118/133] (344s left) prime_busy (after)
[725.218478] Starting subtest: after
[725.223250] Starting dynamic subtest: rcs0
[725.270277] Dynamic subtest rcs0: SUCCESS (0.047s)
[725.280794] Starting dynamic subtest: bcs0
[725.346112] Dynamic subtest bcs0: SUCCESS (0.075s)
[725.356303] Starting dynamic subtest: vcs0
[725.388798] Dynamic subtest vcs0: SUCCESS (0.042s)
[725.399123] Starting dynamic subtest: vcs1
[725.428765] Dynamic subtest vcs1: SUCCESS (0.039s)
[725.438042] Starting dynamic subtest: vecs0
[725.469794] Dynamic subtest vecs0: SUCCESS (0.040s)
[725.479102] Starting dynamic subtest: ccs0
[725.511794] Dynamic subtest ccs0: SUCCESS (0.041s)
[725.620431] Subtest after: SUCCESS (0.400s)
[725.723816] [119/133] (344s left) gem_partial_pwrite_pread (write-display)
[725.790406] Subtest write-display: SKIP (0.000s)
[725.853445] [120/133] (344s left) gem_tiled_blits (basic)
[725.940913] Subtest basic: SKIP (0.000s)
[726.014036] [121/133] (343s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[726.125267] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[734.474633] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.353s)
[734.641732] [122/133] (335s left) sysfs_defaults (readonly)
[734.700554] Starting subtest: readonly
[734.702935] Starting dynamic subtest: vecs0
[734.705260] Dynamic subtest vecs0: SUCCESS (0.000s)
[734.719111] Starting dynamic subtest: ccs0
[734.721189] Dynamic subtest ccs0: SUCCESS (0.000s)
[734.732160] Starting dynamic subtest: vcs0
[734.734047] Dynamic subtest vcs0: SUCCESS (0.000s)
[734.743053] Starting dynamic subtest: bcs0
[734.745340] Dynamic subtest bcs0: SUCCESS (0.000s)
[734.756771] Starting dynamic subtest: rcs0
[734.759052] Dynamic subtest rcs0: SUCCESS (0.000s)
[734.767825] Starting dynamic subtest: vcs1
[734.769800] Dynamic subtest vcs1: SUCCESS (0.000s)
[734.771684] Subtest readonly: SUCCESS (0.006s)
[734.836276] [123/133] (335s left) kms_dsc (dsc-with-formats)
[734.929640] Starting subtest: dsc-with-formats
[734.969093] Subtest dsc-with-formats: SKIP (0.001s)
[735.025483] [124/133] (335s left) prime_mmap (test_reprime)
[735.083694] Starting subtest: test_reprime
[735.085676] Starting dynamic subtest: test_reprime-smem
[735.111170] Dynamic subtest test_reprime-smem: SUCCESS (0.029s)
[735.113602] Subtest test_reprime: SUCCESS (0.030s)
[735.229606] [125/133] (334s left) gem_exec_params (rsvd2-dirt)
[735.294542] Starting subtest: rsvd2-dirt
[735.299103] Subtest rsvd2-dirt: SKIP (0.000s)
[735.441393] [126/133] (334s left) kms_lease (lessee-list)
[735.534285] Starting subtest: lessee-list
[735.536150] Starting dynamic subtest: pipe-A-eDP-1
[735.537914] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[735.547754] Starting dynamic subtest: pipe-B-eDP-1
[735.549471] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[735.557868] Starting dynamic subtest: pipe-C-eDP-1
[735.559627] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[735.568398] Starting dynamic subtest: pipe-D-eDP-1
[735.570162] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[735.571832] Subtest lessee-list: SUCCESS (0.009s)
[735.687120] [127/133] (334s left) kms_vrr (flip-dpms)
[735.783057] Starting subtest: flip-dpms
[735.788289] Subtest flip-dpms: SKIP (0.000s)
[735.877925] [128/133] (334s left) kms_frontbuffer_tracking (fbc-1p-rte)
[735.978242] Starting subtest: fbc-1p-rte
[741.472467] Subtest fbc-1p-rte: SUCCESS (5.497s)
[742.717594] [129/133] (327s left) gen9_exec_parse (batch-zero-length)
[742.772388] Subtest batch-zero-length: SKIP (0.000s)
[742.872174] [130/133] (327s left) prime_mmap (test_aperture_limit)
[742.928604] Starting subtest: test_aperture_limit
[742.930583] Starting dynamic subtest: test_aperture_limit-smem
[742.936203] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[742.940732] Subtest test_aperture_limit: SKIP (0.009s)
[743.083227] [131/133] (327s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[743.196074] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[743.200349] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[743.333419] [132/133] (327s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[743.424509] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[743.428873] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[743.547712] [133/133] (326s left) gem_exec_fence (long-history)
[744.025579] Starting subtest: long-history
[751.637739] Subtest long-history: SUCCESS (7.613s)
[752.174569] 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.