[57.854582] Initializing watchdogs
[57.854626]   /dev/watchdog0
[57.868451] [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.872651] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.874805] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.878093] [001/133] (960s left) gem_create (create-ext-placement-all)
[58.073955] Starting subtest: create-ext-placement-all
[58.076671] Subtest create-ext-placement-all: SUCCESS (0.000s)
[58.215100] [002/133] (960s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[58.280263] Starting subtest: map-fixed-invalidate-overlap
[58.284867] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[58.443598] [003/133] (960s left) gem_pipe_control_store_loop (fresh-buffer)
[58.503069] Starting subtest: fresh-buffer
[60.668220] Subtest fresh-buffer: SUCCESS (2.155s)
[60.822846] [004/133] (957s left) gem_mmap_offset (mmap-boundaries)
[60.873929] Starting subtest: mmap-boundaries
[60.875937] Starting dynamic subtest: smem0
[61.174322] Dynamic subtest smem0: SUCCESS (0.300s)
[61.177298] Subtest mmap-boundaries: SUCCESS (0.301s)
[61.326468] [005/133] (957s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[61.447474] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[69.008849] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.550s)
[69.164678] [006/133] (949s left) kms_atomic (atomic-plane-damage)
[69.266669] Starting subtest: atomic-plane-damage
[69.343196] Starting dynamic subtest: pipe-A-eDP-1
[69.864071] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.523s)
[69.866525] Subtest atomic-plane-damage: SUCCESS (0.599s)
[70.713199] [007/133] (947s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[70.813053] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[70.815521] Starting dynamic subtest: pipe-A-eDP-1
[70.876954] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.066s)
[70.888122] Starting dynamic subtest: pipe-B-eDP-1
[70.938467] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.061s)
[70.947536] Starting dynamic subtest: pipe-C-eDP-1
[71.001653] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.062s)
[71.010292] Starting dynamic subtest: pipe-D-eDP-1
[71.060849] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.059s)
[71.063196] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.252s)
[73.280936] [008/133] (945s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[73.382777] Starting subtest: psr-rgb101010-draw-mmap-wc
[80.337967] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (6.955s)
[80.456289] [009/133] (938s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[80.511290] Starting subtest: yf-tiled-to-vebox-x-tiled
[80.515796] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[80.709462] [010/133] (938s left) syncobj_timeline (wait-all-complex)
[80.772132] Starting subtest: wait-all-complex
[80.985922] Subtest wait-all-complex: SUCCESS (0.213s)
[81.081057] [011/133] (937s left) gem_pxp (create-valid-protected-context)
[81.210940] Starting subtest: create-valid-protected-context
[81.213551] Subtest create-valid-protected-context: SUCCESS (0.002s)
[81.357313] [012/133] (937s left) gem_exec_flush (basic-wb-rw-default)
[81.426831] Starting subtest: basic-wb-rw-default
[86.873042] Subtest basic-wb-rw-default: SUCCESS (5.445s)
[87.077849] [013/133] (931s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[87.173025] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[87.175365] Starting dynamic subtest: pipe-A-eDP-1
[87.196095] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[87.205074] Starting dynamic subtest: pipe-B-eDP-1
[87.224249] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[87.230988] Starting dynamic subtest: pipe-C-eDP-1
[87.249379] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[87.256941] Starting dynamic subtest: pipe-D-eDP-1
[87.276978] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[87.279043] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[89.407632] [014/133] (929s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[89.502630] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[93.569744] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.071s)
[94.710809] [015/133] (924s left) kms_cursor_edge_walk (256x256-top-bottom)
[94.808894] Starting subtest: 256x256-top-bottom
[94.811205] Starting dynamic subtest: pipe-A-eDP-1
[98.241319] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.433s)
[98.250444] Starting dynamic subtest: pipe-D-eDP-1
[101.362772] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.118s)
[101.365164] Subtest 256x256-top-bottom: SUCCESS (6.552s)
[102.189613] [016/133] (916s left) kms_force_connector_basic (force-load-detect)
[102.271967] Starting subtest: force-load-detect
[102.276509] Subtest force-load-detect: SKIP (0.000s)
[102.411129] [017/133] (916s left) syncobj_wait (invalid-signal-zero-handles)
[102.478688] Starting subtest: invalid-signal-zero-handles
[102.480570] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[102.599118] [018/133] (916s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[107.553071] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[107.555375] Starting dynamic subtest: pipe-A-eDP-1
[108.349702] Dynamic subtest pipe-A-eDP-1: SKIP (0.794s)
[108.360828] Starting dynamic subtest: pipe-B-eDP-1
[109.492719] Dynamic subtest pipe-B-eDP-1: SKIP (1.140s)
[109.497371] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.938s)
[110.710800] [019/133] (908s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[110.820334] Starting subtest: fbcpsr-rgb565-draw-render
[117.821380] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.004s)
[117.990891] [020/133] (901s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[118.086279] Starting subtest: primary-4-tiled-reflect-x-0
[125.269188] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.183s)
[126.484968] [021/133] (892s left) kms_setmode (clone-exclusive-crtc)
[126.557227] Starting subtest: clone-exclusive-crtc
[126.564096] Subtest clone-exclusive-crtc: SKIP (0.000s)
[126.699381] [022/133] (892s left) kms_addfb_basic (too-high)
[126.796634] Starting subtest: too-high
[126.798747] Subtest too-high: SUCCESS (0.000s)
[126.932705] [023/133] (892s left) perf_pmu (busy-accuracy-2)
[126.976645] Starting subtest: busy-accuracy-2
[126.978472] Starting dynamic subtest: rcs0
[130.022229] Dynamic subtest rcs0: SUCCESS (3.039s)
[130.034194] Starting dynamic subtest: bcs0
[133.080018] Dynamic subtest bcs0: SUCCESS (3.060s)
[133.090071] Starting dynamic subtest: vcs0
[136.133153] Dynamic subtest vcs0: SUCCESS (3.051s)
[136.143042] Starting dynamic subtest: vcs1
[139.184919] Dynamic subtest vcs1: SUCCESS (3.049s)
[139.194883] Starting dynamic subtest: vecs0
[142.233067] Dynamic subtest vecs0: SUCCESS (3.046s)
[142.244078] Starting dynamic subtest: ccs0
[145.295493] Dynamic subtest ccs0: SUCCESS (3.061s)
[145.297828] Subtest busy-accuracy-2: SUCCESS (18.317s)
[145.430598] [024/133] (873s left) kms_psr (pr-primary-mmap-gtt)
[145.522810] Starting subtest: pr-primary-mmap-gtt
[145.526830] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[145.613017] [025/133] (873s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[145.712180] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[145.716319] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[145.821972] [026/133] (873s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[145.917188] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[145.921221] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[146.043315] [027/133] (873s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[146.145737] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[146.148250] Starting dynamic subtest: pipe-A-default-mode
[148.882581] Dynamic subtest pipe-A-default-mode: SUCCESS (2.737s)
[148.884934] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.738s)
[149.772314] [028/133] (869s left) i915_drm_fdinfo (idle)
[149.811845] Starting subtest: idle
[149.813943] Starting dynamic subtest: rcs0
[150.416843] Dynamic subtest rcs0: SUCCESS (0.607s)
[150.427950] Starting dynamic subtest: bcs0
[150.924232] Dynamic subtest bcs0: SUCCESS (0.504s)
[150.935867] Starting dynamic subtest: vcs0
[151.429759] Dynamic subtest vcs0: SUCCESS (0.504s)
[151.441214] Starting dynamic subtest: vcs1
[151.935602] Dynamic subtest vcs1: SUCCESS (0.504s)
[151.946293] Starting dynamic subtest: vecs0
[152.441114] Dynamic subtest vecs0: SUCCESS (0.504s)
[152.452365] Starting dynamic subtest: ccs0
[152.946225] Dynamic subtest ccs0: SUCCESS (0.503s)
[152.949035] Subtest idle: SUCCESS (3.136s)
[153.047250] [029/133] (866s left) core_setmaster (master-drop-set-shared-fd)
[153.153920] Starting subtest: master-drop-set-shared-fd
[153.172500] Subtest master-drop-set-shared-fd: SUCCESS (0.021s)
[153.211764] [030/133] (866s left) kms_chamelium_color (ctm-negative)
[153.314204] Subtest ctm-negative: SKIP (0.000s)
[153.357780] [031/133] (866s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[153.416985] Starting subtest: multi-wait-for-submit-available-submitted
[153.419368] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[153.531672] [032/133] (866s left) syncobj_timeline (invalid-signal-illegal-point)
[153.593343] Starting subtest: invalid-signal-illegal-point
[153.595381] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[153.710566] [033/133] (865s left) gem_mmap (bad-offset)
[153.772435] Subtest bad-offset: SKIP (0.000s)
[153.836772] [034/133] (865s left) i915_hangman (gt-error-state-capture)
[153.901853] Starting subtest: gt-error-state-capture
[153.903763] Starting dynamic subtest: rcs0
[165.875892] Dynamic subtest rcs0: SUCCESS (11.972s)
[165.886910] Starting dynamic subtest: bcs0
[177.843747] Dynamic subtest bcs0: SUCCESS (11.965s)
[177.855247] Starting dynamic subtest: vcs0
[189.811902] Dynamic subtest vcs0: SUCCESS (11.965s)
[189.823179] Starting dynamic subtest: vcs1
[200.819596] Dynamic subtest vcs1: SUCCESS (11.006s)
[200.832740] Starting dynamic subtest: vecs0
[211.826873] Dynamic subtest vecs0: SUCCESS (11.005s)
[211.839256] Starting dynamic subtest: ccs0
[223.794983] Dynamic subtest ccs0: SUCCESS (11.966s)
[223.797676] Subtest gt-error-state-capture: SUCCESS (69.891s)
[223.897937] [035/133] (795s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[224.002334] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[224.004716] Starting dynamic subtest: pipe-A-eDP-1
[224.013919] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[224.024019] Starting dynamic subtest: pipe-B-eDP-1
[224.032986] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[224.041656] Starting dynamic subtest: pipe-C-eDP-1
[224.050238] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[224.058396] Starting dynamic subtest: pipe-D-eDP-1
[224.067281] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[224.071966] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[226.324501] [036/133] (793s left) gem_exec_whisper (basic-fds)
[226.394820] Starting subtest: basic-fds
[233.540249] Subtest basic-fds: SUCCESS (7.141s)
[233.743481] [037/133] (786s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[233.859304] Starting subtest: psr-1p-primscrn-cur-indfb-move
[241.268296] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.411s)
[241.445117] [038/133] (778s left) gem_exec_schedule (preempt-user)
[241.521217] Starting subtest: preempt-user
[241.523366] Starting dynamic subtest: rcs0
[241.533796] Dynamic subtest rcs0: SUCCESS (0.022s)
[241.542694] Starting dynamic subtest: bcs0
[241.551744] Dynamic subtest bcs0: SUCCESS (0.017s)
[241.560026] Starting dynamic subtest: vcs0
[241.573873] Dynamic subtest vcs0: SUCCESS (0.022s)
[241.581763] Starting dynamic subtest: vcs1
[241.594125] Dynamic subtest vcs1: SUCCESS (0.020s)
[241.602044] Starting dynamic subtest: vecs0
[241.616263] Dynamic subtest vecs0: SUCCESS (0.022s)
[241.624991] Starting dynamic subtest: ccs0
[241.637228] Dynamic subtest ccs0: SUCCESS (0.020s)
[241.639600] Subtest preempt-user: SUCCESS (0.126s)
[242.997889] [039/133] (776s left) kms_psr (psr2-primary-mmap-cpu)
[243.098301] Starting subtest: psr2-primary-mmap-cpu
[243.100636] Starting dynamic subtest: eDP-1
[244.895745] Dynamic subtest eDP-1: SUCCESS (1.796s)
[244.897915] Subtest psr2-primary-mmap-cpu: SUCCESS (1.797s)
[245.804739] [040/133] (774s left) gem_ctx_param (invalid-size-set)
[245.861834] Starting subtest: invalid-size-set
[245.864162] Subtest invalid-size-set: SUCCESS (0.001s)
[245.993265] [041/133] (773s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[246.080707] Starting subtest: bad-aux-stride-y-tiled-ccs
[246.082986] Starting dynamic subtest: pipe-A-eDP-1
[246.105714] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[246.116682] Starting dynamic subtest: pipe-B-eDP-1
[246.138224] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[246.146367] Starting dynamic subtest: pipe-C-eDP-1
[246.168045] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[246.176494] Starting dynamic subtest: pipe-D-eDP-1
[246.198837] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[246.203507] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[248.274385] [042/133] (771s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[248.377356] Starting subtest: blocking-absolute-wf_vblank-interruptible
[248.379572] Starting dynamic subtest: A-eDP1
[257.106360] Dynamic subtest A-eDP1: SUCCESS (8.726s)
[257.117872] Starting dynamic subtest: B-eDP1
[265.835702] Dynamic subtest B-eDP1: SUCCESS (8.729s)
[265.846933] Starting dynamic subtest: C-eDP1
[274.558610] Dynamic subtest C-eDP1: SUCCESS (8.720s)
[274.568660] Starting dynamic subtest: D-eDP1
[283.282517] Dynamic subtest D-eDP1: SUCCESS (8.723s)
[283.288395] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.908s)
[284.514927] [043/133] (735s left) kms_psr2_su (page_flip-nv12)
[284.582251] Subtest page_flip-NV12: SKIP (0.000s)
[284.645438] [044/133] (735s left) gem_exec_balancer (sliced)
[284.704374] Starting subtest: sliced
[284.708776] Subtest sliced: SKIP (0.000s)
[285.028942] [045/133] (735s left) kms_plane_lowres (tiling-x)
[285.133279] Starting subtest: tiling-x
[285.135461] Starting dynamic subtest: pipe-A-eDP-1
[285.139855] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[285.436881] Starting dynamic subtest: pipe-B-eDP-1
[285.441274] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[285.449506] Starting dynamic subtest: pipe-C-eDP-1
[285.454084] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[285.462772] Starting dynamic subtest: pipe-D-eDP-1
[285.467342] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[285.471416] Subtest tiling-x: SKIP (0.302s)
[286.244267] [046/133] (733s left) kms_vblank (query-busy-hang)
[286.348205] Starting subtest: query-busy-hang
[286.350575] Starting dynamic subtest: pipe-A-eDP-1
[312.719559] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.368s)
[312.735841] Starting dynamic subtest: pipe-D-eDP-1
[337.699599] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.979s)
[337.702074] Subtest query-busy-hang: SUCCESS (51.352s)
[338.514374] [047/133] (681s left) gem_exec_balancer (hang)
[338.773351] Starting subtest: hang
[340.401473] Subtest hang: SUCCESS (1.632s)
[340.560099] [048/133] (679s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[340.674579] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[340.678728] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[340.784877] [049/133] (679s left) kms_flip (bo-too-big)
[340.883370] Starting subtest: bo-too-big
[340.885306] Starting dynamic subtest: A-eDP1
[342.145120] Dynamic subtest A-eDP1: SUCCESS (1.264s)
[342.156459] Starting dynamic subtest: B-eDP1
[343.475125] Dynamic subtest B-eDP1: SUCCESS (1.328s)
[343.497603] Starting dynamic subtest: C-eDP1
[344.818804] Dynamic subtest C-eDP1: SUCCESS (1.341s)
[344.827983] Starting dynamic subtest: D-eDP1
[346.145658] Dynamic subtest D-eDP1: SUCCESS (1.326s)
[346.148097] Subtest bo-too-big: SUCCESS (5.268s)
[347.369704] [050/133] (672s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[347.437799] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[347.442717] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[347.645463] [051/133] (672s left) kms_cursor_legacy (single-bo)
[347.759629] Starting subtest: single-bo
[347.761699] Starting dynamic subtest: pipe-A
[353.141395] Dynamic subtest pipe-A: SUCCESS (5.378s)
[353.152108] Starting dynamic subtest: pipe-B
[358.522665] Dynamic subtest pipe-B: SUCCESS (5.379s)
[358.531170] Starting dynamic subtest: pipe-C
[363.905053] Dynamic subtest pipe-C: SUCCESS (5.379s)
[363.913312] Starting dynamic subtest: pipe-D
[369.286904] Dynamic subtest pipe-D: SUCCESS (5.379s)
[369.296851] Starting dynamic subtest: all-pipes
[374.675834] Dynamic subtest all-pipes: SUCCESS (5.386s)
[374.678225] Subtest single-bo: SUCCESS (26.914s)
[374.839424] [052/133] (645s left) kms_pm_rpm (basic-pci-d3-state)
[377.091194] Starting subtest: basic-pci-d3-state
[378.562856] Subtest basic-pci-d3-state: SUCCESS (1.471s)
[378.661495] [053/133] (641s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[378.757515] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[383.102203] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.347s)
[384.335896] [054/133] (636s left) kms_pm_rpm (legacy-planes)
[386.071882] Starting subtest: legacy-planes
[386.074707] Starting dynamic subtest: plane-63
[395.525038] Dynamic subtest plane-63: SUCCESS (9.457s)
[395.539739] Starting dynamic subtest: plane-93
[403.814244] Dynamic subtest plane-93: SUCCESS (8.286s)
[403.826178] Starting dynamic subtest: plane-123
[412.442122] Dynamic subtest plane-123: SUCCESS (8.625s)
[412.452896] Starting dynamic subtest: plane-133
[420.759071] Dynamic subtest plane-133: SUCCESS (8.314s)
[420.762260] Subtest legacy-planes: SUCCESS (34.693s)
[421.133347] [055/133] (599s left) prime_self_import (basic-with_one_bo)
[421.166557] Starting subtest: basic-with_one_bo
[421.191755] Subtest basic-with_one_bo: SUCCESS (0.025s)
[421.337325] [056/133] (599s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[421.431615] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[421.435778] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[421.563506] [057/133] (598s left) kms_flip (modeset-vs-vblank-race)
[421.656826] Starting subtest: modeset-vs-vblank-race
[421.659173] Starting dynamic subtest: A-eDP1
[426.344210] Dynamic subtest A-eDP1: SUCCESS (4.688s)
[426.358672] Starting dynamic subtest: B-eDP1
[431.063048] Dynamic subtest B-eDP1: SUCCESS (4.715s)
[431.075439] Starting dynamic subtest: C-eDP1
[435.665099] Dynamic subtest C-eDP1: SUCCESS (4.599s)
[435.674399] Starting dynamic subtest: D-eDP1
[440.289160] Dynamic subtest D-eDP1: SUCCESS (4.623s)
[440.291370] Subtest modeset-vs-vblank-race: SUCCESS (18.637s)
[441.491322] [058/133] (579s left) gem_lmem_swapping (heavy-verify-random-ccs)
[441.537022] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[441.572615] [059/133] (579s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[441.679804] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[441.684168] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[441.805017] [060/133] (578s left) kms_chamelium_color (gamma)
[441.911334] Subtest gamma: SKIP (0.000s)
[441.955052] [061/133] (578s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[442.067101] Starting subtest: cursorB-vs-flipA-varying-size
[442.071383] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[442.233787] [062/133] (578s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[442.330930] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[446.700843] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.373s)
[447.902443] [063/133] (572s left) dumb_buffer (map-valid)
[447.960069] Starting subtest: map-valid
[447.962221] Subtest map-valid: SUCCESS (0.000s)
[448.097321] [064/133] (572s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[448.192568] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[448.194832] Starting dynamic subtest: pipe-A-default-mode
[448.499693] Dynamic subtest pipe-A-default-mode: SKIP (0.305s)
[448.503856] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.307s)
[449.315332] [065/133] (571s left) perf (i915-ref-count)
[449.408303] Starting subtest: i915-ref-count
[449.481591] Subtest i915-ref-count: SUCCESS (0.071s)
[449.534698] [066/133] (571s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[449.621211] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[449.625148] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[449.740597] [067/133] (571s left) gem_softpin (noreloc-interruptible)
[449.801628] Starting subtest: noreloc-interruptible
[455.197265] Subtest noreloc-interruptible: SUCCESS (5.393s)
[455.348864] [068/133] (565s left) kms_psr (fbc-psr2-primary-render)
[455.446914] Starting subtest: fbc-psr2-primary-render
[455.449285] Starting dynamic subtest: eDP-1
[455.453666] Dynamic subtest eDP-1: SKIP (0.000s)
[455.458157] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[455.540799] [069/133] (565s left) kms_lease (atomic-implicit-crtc)
[455.636934] Starting subtest: atomic-implicit-crtc
[455.639217] Starting dynamic subtest: pipe-A-eDP-1
[455.651253] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[455.661908] Starting dynamic subtest: pipe-B-eDP-1
[455.673223] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[455.681332] Starting dynamic subtest: pipe-C-eDP-1
[455.691716] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[455.699447] Starting dynamic subtest: pipe-D-eDP-1
[455.709847] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[455.711735] Subtest atomic-implicit-crtc: SUCCESS (0.035s)
[455.808141] [070/133] (565s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[455.908185] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[456.292939] Starting dynamic subtest: pipe-A-eDP-1
[459.084781] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.791s)
[459.460043] Starting dynamic subtest: pipe-B-eDP-1
[462.217489] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.764s)
[462.581775] Starting dynamic subtest: pipe-C-eDP-1
[465.349517] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.776s)
[465.707363] Starting dynamic subtest: pipe-D-eDP-1
[468.479587] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.777s)
[468.483104] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.571s)
[469.686504] [071/133] (551s left) gem_exec_reloc (basic-wc-read-active)
[469.742670] Subtest basic-wc-read-active: SKIP (0.000s)
[469.818795] [072/133] (551s left) gem_readwrite (new-obj)
[469.883115] Subtest new-obj: SKIP (0.000s)
[469.951424] [073/133] (551s left) gem_mmap_gtt (basic-short)
[470.009871] Subtest basic-short: SKIP (0.000s)
[470.080591] [074/133] (551s left) kms_plane_multiple (tiling-yf)
[470.176625] Starting subtest: tiling-yf
[470.180969] Subtest tiling-yf: SKIP (0.000s)
[470.282086] [075/133] (550s left) kms_content_protection (dp-mst-type-0-hdcp14)
[470.418479] Starting subtest: dp-mst-type-0-hdcp14
[470.423071] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[470.586940] [076/133] (550s left) gem_ctx_shared (q-in-order)
[470.647555] Starting subtest: Q-in-order
[470.649506] Starting dynamic subtest: rcs0
[470.798523] Dynamic subtest rcs0: SUCCESS (0.150s)
[470.819264] Starting dynamic subtest: vcs0
[470.882041] Dynamic subtest vcs0: SUCCESS (0.081s)
[470.897343] Starting dynamic subtest: vcs1
[470.955608] Dynamic subtest vcs1: SUCCESS (0.073s)
[470.970825] Starting dynamic subtest: vecs0
[471.032257] Dynamic subtest vecs0: SUCCESS (0.074s)
[471.047885] Starting dynamic subtest: ccs0
[471.124333] Dynamic subtest ccs0: SUCCESS (0.091s)
[471.126394] Subtest Q-in-order: SUCCESS (0.477s)
[472.027999] [FACT gem_ctx_shared (q-in-order)] new: kernel.kmod_is_loaded.vgem: true
[472.031298] [077/133] (549s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[472.097590] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[472.200064] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.102s)
[472.299692] [078/133] (549s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[472.409475] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[478.954559] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.546s)
[479.151156] [079/133] (542s left) kms_big_fb (linear-8bpp-rotate-270)
[479.271533] Starting subtest: linear-8bpp-rotate-270
[479.295547] Subtest linear-8bpp-rotate-270: SKIP (0.023s)
[479.457535] [080/133] (541s left) api_intel_allocator (standalone)
[479.521985] Starting subtest: standalone
[479.537929] Subtest standalone: SUCCESS (0.017s)
[479.684084] [081/133] (541s left) core_auth (getclient-master-drop)
[479.717039] Starting subtest: getclient-master-drop
[479.743305] Subtest getclient-master-drop: SUCCESS (0.026s)
[479.902321] [082/133] (541s left) kms_psr (fbc-psr2-basic)
[479.999464] Starting subtest: fbc-psr2-basic
[480.001439] Starting dynamic subtest: eDP-1
[480.004942] Dynamic subtest eDP-1: SKIP (0.000s)
[480.008592] Subtest fbc-psr2-basic: SKIP (0.001s)
[480.096580] [083/133] (541s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[480.236480] Starting subtest: cursor-rapid-movement-32x32
[480.283249] Subtest cursor-rapid-movement-32x32: SKIP (0.042s)
[480.593382] [084/133] (541s left) gem_exec_schedule (noreorder-priority)
[480.763106] Starting subtest: noreorder-priority
[480.765438] Starting dynamic subtest: rcs0
[481.903883] Dynamic subtest rcs0: SUCCESS (1.141s)
[481.916098] Starting dynamic subtest: vcs0
[483.949049] Dynamic subtest vcs0: SUCCESS (2.042s)
[483.960591] Starting dynamic subtest: vcs1
[485.935265] Dynamic subtest vcs1: SUCCESS (1.983s)
[485.947457] Starting dynamic subtest: vecs0
[487.913220] Dynamic subtest vecs0: SUCCESS (1.975s)
[487.925175] Starting dynamic subtest: ccs0
[489.076692] Dynamic subtest ccs0: SUCCESS (1.162s)
[489.079574] Subtest noreorder-priority: SUCCESS (8.314s)
[489.292897] [085/133] (532s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[489.383916] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[489.386258] Starting dynamic subtest: pipe-A-eDP-1
[489.411861] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[489.420870] Starting dynamic subtest: pipe-B-eDP-1
[489.445462] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[489.453738] Starting dynamic subtest: pipe-C-eDP-1
[489.477666] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[489.486528] Starting dynamic subtest: pipe-D-eDP-1
[489.510041] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[489.513918] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[491.681645] [086/133] (530s left) core_auth (many-magics)
[491.746786] Starting subtest: many-magics
[492.622124] Subtest many-magics: SUCCESS (0.878s)
[492.856765] [087/133] (528s left) i915_suspend (fence-restore-tiled2untiled)
[492.924779] Starting subtest: fence-restore-tiled2untiled
[492.929258] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[493.054569] [088/133] (528s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[493.146978] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[493.149115] Starting dynamic subtest: pipe-A
[493.168774] Dynamic subtest pipe-A: SKIP (0.017s)
[493.179329] Starting dynamic subtest: pipe-B
[493.199416] Dynamic subtest pipe-B: SKIP (0.030s)
[493.208859] Starting dynamic subtest: pipe-C
[493.231347] Dynamic subtest pipe-C: SKIP (0.031s)
[493.239966] Starting dynamic subtest: pipe-D
[493.261092] Dynamic subtest pipe-D: SKIP (0.030s)
[493.264922] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.110s)
[493.373453] [089/133] (528s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[493.479598] Starting subtest: y-tiled-64bpp-rotate-0
[493.484050] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[493.624908] [090/133] (528s left) gem_ctx_persistence (saturated-hostile)
[493.694825] Starting subtest: saturated-hostile
[493.697366] Starting dynamic subtest: rcs0
[494.558476] Dynamic subtest rcs0: SUCCESS (0.863s)
[494.570457] Starting dynamic subtest: bcs0
[495.353720] Dynamic subtest bcs0: SUCCESS (0.793s)
[495.365352] Starting dynamic subtest: vcs0
[496.165810] Dynamic subtest vcs0: SUCCESS (0.810s)
[496.177666] Starting dynamic subtest: vcs1
[496.980932] Dynamic subtest vcs1: SUCCESS (0.813s)
[496.992916] Starting dynamic subtest: vecs0
[497.799916] Dynamic subtest vecs0: SUCCESS (0.817s)
[497.811489] Starting dynamic subtest: ccs0
[498.654872] Dynamic subtest ccs0: SUCCESS (0.853s)
[498.657693] Subtest saturated-hostile: SUCCESS (4.961s)
[498.759228] [091/133] (523s left) kms_prop_blob (invalid-get-prop)
[498.818513] Starting subtest: invalid-get-prop
[498.820812] Subtest invalid-get-prop: SUCCESS (0.000s)
[498.950365] [092/133] (523s left) gem_mmap_gtt (basic-write)
[499.007877] Subtest basic-write: SKIP (0.000s)
[499.078660] [093/133] (522s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[499.210181] Starting subtest: cursorA-vs-flipA-varying-size
[510.347839] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.123s)
[511.229765] [094/133] (510s left) gem_linear_blits (interruptible)
[511.626216] Starting subtest: interruptible
[515.826546] Subtest interruptible: SUCCESS (4.200s)
[516.004552] [095/133] (506s left) gem_exec_params (sol-reset-invalid)
[516.107301] Starting subtest: sol-reset-invalid
[516.112830] Subtest sol-reset-invalid: SUCCESS (0.003s)
[518.029322] [096/133] (504s left) kms_color_pipeline (plane-lut1d)
[518.149688] Starting subtest: plane-lut1d
[518.163068] Starting dynamic subtest: pipe-A-eDP-1
[518.858043] Dynamic subtest pipe-A-eDP-1: FAIL (0.310s)
[519.565860] Starting dynamic subtest: pipe-B-eDP-1
[520.359229] Dynamic subtest pipe-B-eDP-1: FAIL (0.291s)
[520.900346] Starting dynamic subtest: pipe-C-eDP-1
[521.722953] Dynamic subtest pipe-C-eDP-1: FAIL (0.246s)
[522.235592] Starting dynamic subtest: pipe-D-eDP-1
[523.048299] Dynamic subtest pipe-D-eDP-1: FAIL (0.235s)
[523.050344] Subtest plane-lut1d: FAIL (4.615s)
[523.631783] [097/133] (498s left) gem_wait (busy)
[523.706434] Starting subtest: busy
[523.708618] Starting dynamic subtest: all-engines
[524.884390] Dynamic subtest all-engines: SUCCESS (1.175s)
[524.896026] Starting dynamic subtest: rcs0
[525.424639] Dynamic subtest rcs0: SUCCESS (0.539s)
[525.435456] Starting dynamic subtest: bcs0
[525.963471] Dynamic subtest bcs0: SUCCESS (0.538s)
[525.974368] Starting dynamic subtest: vcs0
[527.892250] Dynamic subtest vcs0: SUCCESS (1.926s)
[527.904050] Starting dynamic subtest: vcs1
[529.876886] Dynamic subtest vcs1: SUCCESS (1.982s)
[529.888751] Starting dynamic subtest: vecs0
[531.924539] Dynamic subtest vecs0: SUCCESS (2.045s)
[531.936514] Starting dynamic subtest: ccs0
[532.465894] Dynamic subtest ccs0: SUCCESS (0.540s)
[532.468443] Subtest busy: SUCCESS (8.759s)
[532.690182] [098/133] (489s left) sriov_basic (enable-vfs-autoprobe-on)
[532.751919] Starting subtest: enable-vfs-autoprobe-on
[532.754146] Starting dynamic subtest: numvfs-1
[532.828778] Dynamic subtest numvfs-1: FAIL (0.005s)
[532.839998] Starting dynamic subtest: numvfs-2
[532.915372] Dynamic subtest numvfs-2: FAIL (0.003s)
[532.926941] Starting dynamic subtest: numvfs-3
[532.999034] Dynamic subtest numvfs-3: FAIL (0.003s)
[533.009540] Starting dynamic subtest: numvfs-4
[533.081392] Dynamic subtest numvfs-4: FAIL (0.003s)
[533.091294] Starting dynamic subtest: numvfs-5
[533.162550] Dynamic subtest numvfs-5: FAIL (0.003s)
[533.174079] Starting dynamic subtest: numvfs-6
[533.246436] Dynamic subtest numvfs-6: FAIL (0.004s)
[533.256307] Starting dynamic subtest: numvfs-7
[533.329712] Dynamic subtest numvfs-7: FAIL (0.003s)
[533.340709] Starting dynamic subtest: numvfs-random
[533.411084] Dynamic subtest numvfs-random: FAIL (0.004s)
[533.420534] Starting dynamic subtest: numvfs-all
[533.490119] Dynamic subtest numvfs-all: FAIL (0.514s)
[533.492008] Subtest enable-vfs-autoprobe-on: FAIL (0.551s)
[533.528541] [099/133] (488s left) kms_chamelium_frames (vga-frame-dump)
[533.912331] Subtest vga-frame-dump: SKIP (0.000s)
[534.711286] [100/133] (487s left) gem_eio (throttle)
[534.906117] Starting subtest: throttle
[535.171792] Subtest throttle: SUCCESS (0.265s)
[535.357791] [101/133] (486s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-mmap-wc)
[535.463126] Starting subtest: psr-abgr161616f-draw-mmap-wc
[535.467175] Subtest psr-abgr161616f-draw-mmap-wc: SKIP (0.000s)
[535.609863] [102/133] (486s left) gem_softpin (allocator-nopin)
[535.682659] Starting subtest: allocator-nopin
[535.787614] Subtest allocator-nopin: SUCCESS (0.103s)
[535.939867] [103/133] (486s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[536.034024] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[536.736451] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.704s)
[536.934776] [104/133] (485s left) kms_flip (busy-flip)
[537.041216] Starting subtest: busy-flip
[537.043144] Starting dynamic subtest: A-eDP1
[538.750391] Dynamic subtest A-eDP1: SUCCESS (1.710s)
[538.761602] Starting dynamic subtest: B-eDP1
[540.476828] Dynamic subtest B-eDP1: SUCCESS (1.725s)
[540.488726] Starting dynamic subtest: C-eDP1
[542.107786] Dynamic subtest C-eDP1: SUCCESS (1.629s)
[542.119095] Starting dynamic subtest: D-eDP1
[543.742456] Dynamic subtest D-eDP1: SUCCESS (1.634s)
[543.744864] Subtest busy-flip: SUCCESS (6.706s)
[545.030118] [105/133] (477s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[545.144616] Starting subtest: x-tiled-16bpp-rotate-270
[545.164248] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[545.333796] [106/133] (477s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-render)
[545.436434] Starting subtest: fbcpsr-abgr161616f-draw-render
[545.440956] Subtest fbcpsr-abgr161616f-draw-render: SKIP (0.000s)
[545.564525] [107/133] (477s left) kms_getfb (getfb2-accept-nv12)
[545.656996] Starting subtest: getfb2-accept-nv12
[545.659263] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[545.798593] [108/133] (476s left) gem_ctx_exec (basic-nohangcheck)
[545.865754] Starting subtest: basic-nohangcheck
[546.156727] Subtest basic-nohangcheck: SUCCESS (0.290s)
[546.305976] [109/133] (476s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[546.436644] Starting subtest: short-flip-before-cursor-atomic-transitions
[547.396110] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.958s)
[548.264152] [110/133] (474s left) kms_cursor_crc (cursor-offscreen-256x256)
[548.535265] Starting subtest: cursor-offscreen-256x256
[548.537443] Starting dynamic subtest: pipe-A-eDP-1
[550.466951] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.931s)
[550.497480] Starting dynamic subtest: pipe-D-eDP-1
[553.039591] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.548s)
[553.041903] Subtest cursor-offscreen-256x256: SUCCESS (4.503s)
[553.942143] [111/133] (468s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[554.047588] Starting subtest: 4-tiled-8bpp-rotate-0
[555.294221] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.247s)
[555.473113] [112/133] (467s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[555.543419] Subtest writes-after-reads: SKIP (0.000s)
[555.627833] [113/133] (467s left) kms_frontbuffer_tracking (psr-slowdraw)
[555.719050] Starting subtest: psr-slowdraw
[580.871144] Subtest psr-slowdraw: SUCCESS (25.152s)
[581.022383] [114/133] (441s left) i915_pm_rc6_residency (rc6-idle)
[581.079989] Starting subtest: rc6-idle
[581.106441] Starting dynamic subtest: gt0-rcs0
[605.496852] Dynamic subtest gt0-rcs0: SUCCESS (24.389s)
[605.508099] Starting dynamic subtest: gt0-bcs0
[629.709811] Dynamic subtest gt0-bcs0: SUCCESS (24.210s)
[629.719059] Starting dynamic subtest: gt0-ccs0
[654.085294] Dynamic subtest gt0-ccs0: SUCCESS (24.373s)
[654.096249] Starting dynamic subtest: gt1-vcs0
[660.262054] Dynamic subtest gt1-vcs0: SUCCESS (6.170s)
[660.273683] Starting dynamic subtest: gt1-vecs0
[666.432546] Dynamic subtest gt1-vecs0: SUCCESS (6.169s)
[666.435202] Subtest rc6-idle: SUCCESS (85.353s)
[666.538349] [115/133] (356s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[666.651344] Starting subtest: fbc-modesetfrombusy
[670.381624] Subtest fbc-modesetfrombusy: SUCCESS (3.735s)
[671.576634] [116/133] (351s left) kms_psr (psr-cursor-render)
[671.687157] Starting subtest: psr-cursor-render
[671.689480] Starting dynamic subtest: eDP-1
[673.437775] Dynamic subtest eDP-1: SUCCESS (1.751s)
[673.440078] Subtest psr-cursor-render: SUCCESS (1.752s)
[674.316803] [117/133] (348s left) gem_exec_parallel (engines)
[674.385186] Starting subtest: engines
[674.387539] Starting dynamic subtest: basic
[675.968832] Dynamic subtest basic: SUCCESS (1.583s)
[675.981815] Starting dynamic subtest: contexts
[680.401980] Dynamic subtest contexts: SUCCESS (4.429s)
[680.414408] Starting dynamic subtest: fds
[684.178416] Dynamic subtest fds: SUCCESS (3.773s)
[684.190998] Starting dynamic subtest: userptr
[685.890334] Dynamic subtest userptr: SUCCESS (1.710s)
[685.892925] Subtest engines: SUCCESS (11.505s)
[686.111425] [118/133] (336s left) prime_busy (after)
[686.179089] Starting subtest: after
[686.181548] Starting dynamic subtest: rcs0
[686.216988] Dynamic subtest rcs0: SUCCESS (0.036s)
[686.228460] Starting dynamic subtest: bcs0
[686.258574] Dynamic subtest bcs0: SUCCESS (0.041s)
[686.268413] Starting dynamic subtest: vcs0
[686.301502] Dynamic subtest vcs0: SUCCESS (0.042s)
[686.311293] Starting dynamic subtest: vcs1
[686.342625] Dynamic subtest vcs1: SUCCESS (0.040s)
[686.351779] Starting dynamic subtest: vecs0
[686.384855] Dynamic subtest vecs0: SUCCESS (0.041s)
[686.396045] Starting dynamic subtest: ccs0
[686.426799] Dynamic subtest ccs0: SUCCESS (0.042s)
[686.535439] Subtest after: SUCCESS (0.356s)
[686.634927] [119/133] (336s left) gem_partial_pwrite_pread (write-display)
[686.699790] Subtest write-display: SKIP (0.000s)
[686.802757] [120/133] (336s left) gem_tiled_blits (basic)
[686.860831] Subtest basic: SKIP (0.000s)
[686.940597] [121/133] (336s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[687.050577] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[695.562641] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.514s)
[695.702034] [122/133] (327s left) sysfs_defaults (readonly)
[695.772869] Starting subtest: readonly
[695.775198] Starting dynamic subtest: vecs0
[695.777388] Dynamic subtest vecs0: SUCCESS (0.000s)
[695.786741] Starting dynamic subtest: ccs0
[695.788963] Dynamic subtest ccs0: SUCCESS (0.000s)
[695.797669] Starting dynamic subtest: vcs0
[695.800046] Dynamic subtest vcs0: SUCCESS (0.000s)
[695.811506] Starting dynamic subtest: bcs0
[695.813709] Dynamic subtest bcs0: SUCCESS (0.000s)
[695.822158] Starting dynamic subtest: rcs0
[695.824409] Dynamic subtest rcs0: SUCCESS (0.000s)
[695.832972] Starting dynamic subtest: vcs1
[695.835114] Dynamic subtest vcs1: SUCCESS (0.000s)
[695.837245] Subtest readonly: SUCCESS (0.005s)
[695.893228] [123/133] (327s left) kms_dsc (dsc-with-formats)
[695.990271] Starting subtest: dsc-with-formats
[696.029825] Subtest dsc-with-formats: SKIP (0.001s)
[696.087570] [124/133] (327s left) prime_mmap (test_reprime)
[696.144477] Starting subtest: test_reprime
[696.146678] Starting dynamic subtest: test_reprime-smem
[696.172081] Dynamic subtest test_reprime-smem: SUCCESS (0.030s)
[696.174344] Subtest test_reprime: SUCCESS (0.030s)
[696.298207] [125/133] (327s left) gem_exec_params (rsvd2-dirt)
[696.360149] Starting subtest: rsvd2-dirt
[696.364537] Subtest rsvd2-dirt: SKIP (0.000s)
[696.489375] [126/133] (326s left) kms_lease (lessee-list)
[696.600243] Starting subtest: lessee-list
[696.602212] Starting dynamic subtest: pipe-A-eDP-1
[696.603931] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s)
[696.616509] Starting dynamic subtest: pipe-B-eDP-1
[696.618229] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[696.626626] Starting dynamic subtest: pipe-C-eDP-1
[696.628373] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[696.636768] Starting dynamic subtest: pipe-D-eDP-1
[696.638495] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[696.640188] Subtest lessee-list: SUCCESS (0.013s)
[696.740200] [127/133] (326s left) kms_vrr (flip-dpms)
[696.844167] Starting subtest: flip-dpms
[696.849115] Subtest flip-dpms: SKIP (0.000s)
[696.944452] [128/133] (326s left) kms_frontbuffer_tracking (fbc-1p-rte)
[697.045031] Starting subtest: fbc-1p-rte
[702.538204] Subtest fbc-1p-rte: SUCCESS (5.495s)
[703.744930] [129/133] (319s left) gen9_exec_parse (batch-zero-length)
[703.804413] Subtest batch-zero-length: SKIP (0.000s)
[703.890572] [130/133] (319s left) prime_mmap (test_aperture_limit)
[703.957690] Starting subtest: test_aperture_limit
[703.960053] Starting dynamic subtest: test_aperture_limit-smem
[703.967882] Dynamic subtest test_aperture_limit-smem: SKIP (0.007s)
[703.972239] Subtest test_aperture_limit: SKIP (0.008s)
[704.109655] [131/133] (319s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[704.223960] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[704.228242] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[704.352187] [132/133] (319s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[704.450445] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[704.454497] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[704.594259] [133/133] (319s left) gem_exec_fence (long-history)
[705.063035] Starting subtest: long-history
[712.659934] Subtest long-history: SUCCESS (7.596s)
[713.480712] 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.