[55.979213] Initializing watchdogs
[55.979258]   /dev/watchdog0
[55.992946] [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]
[55.997163] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.999479] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.002859] [001/133] (960s left) gem_create (create-ext-placement-all)
[56.209417] Starting subtest: create-ext-placement-all
[56.211364] Subtest create-ext-placement-all: SUCCESS (0.000s)
[56.338339] [002/133] (960s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[56.419357] Starting subtest: map-fixed-invalidate-overlap
[56.423751] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[56.587392] [003/133] (959s left) gem_pipe_control_store_loop (fresh-buffer)
[56.646920] Starting subtest: fresh-buffer
[58.802595] Subtest fresh-buffer: SUCCESS (2.154s)
[58.962531] [004/133] (957s left) gem_mmap_offset (mmap-boundaries)
[59.018486] Starting subtest: mmap-boundaries
[59.020535] Starting dynamic subtest: smem0
[59.302200] Dynamic subtest smem0: SUCCESS (0.286s)
[59.305036] Subtest mmap-boundaries: SUCCESS (0.286s)
[59.439704] [005/133] (957s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[59.553588] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[66.912924] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.362s)
[67.463315] [006/133] (949s left) kms_atomic (atomic-plane-damage)
[67.618672] Starting subtest: atomic-plane-damage
[67.702999] Starting dynamic subtest: pipe-A-eDP-1
[68.257924] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.556s)
[68.262406] Subtest atomic-plane-damage: SUCCESS (0.641s)
[69.153047] [007/133] (947s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[69.260064] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[69.262363] Starting dynamic subtest: pipe-A-eDP-1
[69.326808] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.067s)
[69.335818] Starting dynamic subtest: pipe-B-eDP-1
[69.385275] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.060s)
[69.392334] Starting dynamic subtest: pipe-C-eDP-1
[69.446195] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.059s)
[69.453638] Starting dynamic subtest: pipe-D-eDP-1
[69.505082] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.058s)
[69.507384] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.247s)
[71.813068] [008/133] (944s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[71.923330] Starting subtest: psr-rgb101010-draw-mmap-wc
[78.955064] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.037s)
[79.079589] [009/133] (937s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[79.153565] Starting subtest: yf-tiled-to-vebox-x-tiled
[79.157903] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[79.357108] [010/133] (937s left) syncobj_timeline (wait-all-complex)
[79.422605] Starting subtest: wait-all-complex
[79.634876] Subtest wait-all-complex: SUCCESS (0.213s)
[79.728861] [011/133] (937s left) gem_pxp (create-valid-protected-context)
[79.869600] Starting subtest: create-valid-protected-context
[79.872254] Subtest create-valid-protected-context: SUCCESS (0.002s)
[80.008989] [012/133] (936s left) gem_exec_flush (basic-wb-rw-default)
[80.076678] Starting subtest: basic-wb-rw-default
[85.528271] Subtest basic-wb-rw-default: SUCCESS (5.453s)
[85.735823] [013/133] (931s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[85.841451] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[85.843878] Starting dynamic subtest: pipe-A-eDP-1
[85.865625] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[85.874591] Starting dynamic subtest: pipe-B-eDP-1
[85.893828] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[85.901277] Starting dynamic subtest: pipe-C-eDP-1
[85.920063] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[85.927520] Starting dynamic subtest: pipe-D-eDP-1
[85.946705] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[85.948902] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[88.096399] [014/133] (928s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[88.190190] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[92.268739] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.081s)
[93.477371] [015/133] (923s left) kms_cursor_edge_walk (256x256-top-bottom)
[93.573392] Starting subtest: 256x256-top-bottom
[93.575759] Starting dynamic subtest: pipe-A-eDP-1
[96.995274] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.420s)
[97.004709] Starting dynamic subtest: pipe-D-eDP-1
[100.116460] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.121s)
[100.118851] Subtest 256x256-top-bottom: SUCCESS (6.542s)
[100.948552] [016/133] (916s left) kms_force_connector_basic (force-load-detect)
[101.033226] Starting subtest: force-load-detect
[101.037956] Subtest force-load-detect: SKIP (0.000s)
[101.168617] [017/133] (915s left) syncobj_wait (invalid-signal-zero-handles)
[101.226120] Starting subtest: invalid-signal-zero-handles
[101.228416] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[101.367052] [018/133] (915s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[106.389507] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[106.391607] Starting dynamic subtest: pipe-A-eDP-1
[107.202429] Dynamic subtest pipe-A-eDP-1: SKIP (0.810s)
[107.209710] Starting dynamic subtest: pipe-B-eDP-1
[108.328053] Dynamic subtest pipe-B-eDP-1: SKIP (1.125s)
[108.332054] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.938s)
[109.530999] [019/133] (907s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[109.632856] Starting subtest: fbcpsr-rgb565-draw-render
[116.645379] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.016s)
[116.800160] [020/133] (900s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[116.890907] Starting subtest: primary-4-tiled-reflect-x-0
[123.861420] Subtest primary-4-tiled-reflect-x-0: SUCCESS (6.972s)
[125.109927] [021/133] (892s left) kms_setmode (clone-exclusive-crtc)
[125.175593] Starting subtest: clone-exclusive-crtc
[125.182494] Subtest clone-exclusive-crtc: SKIP (0.000s)
[125.287731] [022/133] (892s left) kms_addfb_basic (too-high)
[125.384982] Starting subtest: too-high
[125.387262] Subtest too-high: SUCCESS (0.001s)
[125.504219] [023/133] (891s left) perf_pmu (busy-accuracy-2)
[125.544156] Starting subtest: busy-accuracy-2
[125.546383] Starting dynamic subtest: rcs0
[128.584762] Dynamic subtest rcs0: SUCCESS (3.039s)
[128.594871] Starting dynamic subtest: bcs0
[131.640018] Dynamic subtest bcs0: SUCCESS (3.054s)
[131.649580] Starting dynamic subtest: vcs0
[134.686559] Dynamic subtest vcs0: SUCCESS (3.045s)
[134.696303] Starting dynamic subtest: vcs1
[137.731599] Dynamic subtest vcs1: SUCCESS (3.043s)
[137.741425] Starting dynamic subtest: vecs0
[140.780682] Dynamic subtest vecs0: SUCCESS (3.047s)
[140.791441] Starting dynamic subtest: ccs0
[143.836241] Dynamic subtest ccs0: SUCCESS (3.054s)
[143.838706] Subtest busy-accuracy-2: SUCCESS (18.292s)
[143.995616] [024/133] (873s left) kms_psr (pr-primary-mmap-gtt)
[144.100165] Starting subtest: pr-primary-mmap-gtt
[144.104487] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[144.195195] [025/133] (873s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[144.292077] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[144.296150] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[144.424177] [026/133] (873s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[144.555030] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[144.559805] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[144.697407] [027/133] (872s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[144.788032] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[144.790562] Starting dynamic subtest: pipe-A-default-mode
[147.547940] Dynamic subtest pipe-A-default-mode: SUCCESS (2.761s)
[147.550268] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.763s)
[148.399847] [028/133] (869s left) i915_drm_fdinfo (idle)
[148.463283] Starting subtest: idle
[148.465466] Starting dynamic subtest: rcs0
[149.072921] Dynamic subtest rcs0: SUCCESS (0.610s)
[149.083529] Starting dynamic subtest: bcs0
[149.577683] Dynamic subtest bcs0: SUCCESS (0.503s)
[149.588612] Starting dynamic subtest: vcs0
[150.081543] Dynamic subtest vcs0: SUCCESS (0.503s)
[150.092231] Starting dynamic subtest: vcs1
[150.586089] Dynamic subtest vcs1: SUCCESS (0.503s)
[150.596469] Starting dynamic subtest: vecs0
[151.090283] Dynamic subtest vecs0: SUCCESS (0.503s)
[151.101133] Starting dynamic subtest: ccs0
[151.593977] Dynamic subtest ccs0: SUCCESS (0.503s)
[151.596848] Subtest idle: SUCCESS (3.132s)
[151.696113] [029/133] (865s left) core_setmaster (master-drop-set-shared-fd)
[151.821232] Starting subtest: master-drop-set-shared-fd
[151.840522] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[151.877881] [030/133] (865s left) kms_chamelium_color (ctm-negative)
[151.974270] Subtest ctm-negative: SKIP (0.000s)
[152.020217] [031/133] (865s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[152.072369] Starting subtest: multi-wait-for-submit-available-submitted
[152.074605] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[152.192798] [032/133] (865s left) syncobj_timeline (invalid-signal-illegal-point)
[152.259650] Starting subtest: invalid-signal-illegal-point
[152.261898] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[152.409295] [033/133] (865s left) gem_mmap (bad-offset)
[152.466829] Subtest bad-offset: SKIP (0.000s)
[152.525395] [034/133] (865s left) i915_hangman (gt-error-state-capture)
[152.591913] Starting subtest: gt-error-state-capture
[152.593682] Starting dynamic subtest: rcs0
[163.894832] Dynamic subtest rcs0: SUCCESS (11.301s)
[163.908410] Starting dynamic subtest: bcs0
[175.861460] Dynamic subtest bcs0: SUCCESS (11.964s)
[175.873289] Starting dynamic subtest: vcs0
[187.830332] Dynamic subtest vcs0: SUCCESS (11.967s)
[187.841763] Starting dynamic subtest: vcs1
[199.797365] Dynamic subtest vcs1: SUCCESS (11.964s)
[199.808922] Starting dynamic subtest: vecs0
[210.805491] Dynamic subtest vecs0: SUCCESS (11.006s)
[210.817146] Starting dynamic subtest: ccs0
[221.877619] Dynamic subtest ccs0: SUCCESS (11.069s)
[221.880548] Subtest gt-error-state-capture: SUCCESS (69.283s)
[222.042547] [035/133] (795s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[222.152247] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[222.154397] Starting dynamic subtest: pipe-A-eDP-1
[222.163240] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[222.172708] Starting dynamic subtest: pipe-B-eDP-1
[222.181215] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[222.189339] Starting dynamic subtest: pipe-C-eDP-1
[222.197290] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[222.204743] Starting dynamic subtest: pipe-D-eDP-1
[222.212794] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[222.216682] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[224.446130] [036/133] (793s left) gem_exec_whisper (basic-fds)
[224.509100] Starting subtest: basic-fds
[232.010884] Subtest basic-fds: SUCCESS (7.498s)
[232.216061] [037/133] (785s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[232.316156] Starting subtest: psr-1p-primscrn-cur-indfb-move
[239.903381] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.588s)
[240.084152] [038/133] (777s left) gem_exec_schedule (preempt-user)
[240.164999] Starting subtest: preempt-user
[240.167268] Starting dynamic subtest: rcs0
[240.180299] Dynamic subtest rcs0: SUCCESS (0.023s)
[240.189397] Starting dynamic subtest: bcs0
[240.199236] Dynamic subtest bcs0: SUCCESS (0.018s)
[240.207309] Starting dynamic subtest: vcs0
[240.220857] Dynamic subtest vcs0: SUCCESS (0.021s)
[240.228816] Starting dynamic subtest: vcs1
[240.240877] Dynamic subtest vcs1: SUCCESS (0.019s)
[240.249272] Starting dynamic subtest: vecs0
[240.261078] Dynamic subtest vecs0: SUCCESS (0.019s)
[240.269344] Starting dynamic subtest: ccs0
[240.283316] Dynamic subtest ccs0: SUCCESS (0.022s)
[240.285631] Subtest preempt-user: SUCCESS (0.127s)
[241.997109] [039/133] (775s left) kms_psr (psr2-primary-mmap-cpu)
[242.100068] Starting subtest: psr2-primary-mmap-cpu
[242.102323] Starting dynamic subtest: eDP-1
[243.852449] Dynamic subtest eDP-1: SUCCESS (1.753s)
[243.854876] Subtest psr2-primary-mmap-cpu: SUCCESS (1.755s)
[244.741400] [040/133] (773s left) gem_ctx_param (invalid-size-set)
[244.803035] Starting subtest: invalid-size-set
[244.805483] Subtest invalid-size-set: SUCCESS (0.001s)
[244.952398] [041/133] (773s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[245.045202] Starting subtest: bad-aux-stride-y-tiled-ccs
[245.047452] Starting dynamic subtest: pipe-A-eDP-1
[245.070344] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[245.081188] Starting dynamic subtest: pipe-B-eDP-1
[245.102827] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[245.111739] Starting dynamic subtest: pipe-C-eDP-1
[245.133536] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[245.143091] Starting dynamic subtest: pipe-D-eDP-1
[245.164876] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[245.169197] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[247.214455] [042/133] (770s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[247.323643] Starting subtest: blocking-absolute-wf_vblank-interruptible
[247.326014] Starting dynamic subtest: A-eDP1
[256.047777] Dynamic subtest A-eDP1: SUCCESS (8.723s)
[256.059802] Starting dynamic subtest: B-eDP1
[264.778572] Dynamic subtest B-eDP1: SUCCESS (8.728s)
[264.788513] Starting dynamic subtest: C-eDP1
[273.495113] Dynamic subtest C-eDP1: SUCCESS (8.715s)
[273.506864] Starting dynamic subtest: D-eDP1
[282.226049] Dynamic subtest D-eDP1: SUCCESS (8.728s)
[282.231145] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.905s)
[283.461942] [043/133] (734s left) kms_psr2_su (page_flip-nv12)
[283.520782] Subtest page_flip-NV12: SKIP (0.000s)
[283.577801] [044/133] (734s left) gem_exec_balancer (sliced)
[283.646483] Starting subtest: sliced
[283.650646] Subtest sliced: SKIP (0.000s)
[283.978833] [045/133] (734s left) kms_plane_lowres (tiling-x)
[284.073671] Starting subtest: tiling-x
[284.076080] Starting dynamic subtest: pipe-A-eDP-1
[284.080854] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[284.366069] Starting dynamic subtest: pipe-B-eDP-1
[284.370701] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[284.379075] Starting dynamic subtest: pipe-C-eDP-1
[284.383746] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[284.392211] Starting dynamic subtest: pipe-D-eDP-1
[284.396471] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[284.400683] Subtest tiling-x: SKIP (0.292s)
[285.186134] [046/133] (733s left) kms_vblank (query-busy-hang)
[285.285435] Starting subtest: query-busy-hang
[285.287392] Starting dynamic subtest: pipe-A-eDP-1
[311.638065] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.350s)
[311.652279] Starting dynamic subtest: pipe-D-eDP-1
[326.675044] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.035s)
[326.677690] Subtest query-busy-hang: SUCCESS (41.389s)
[327.548622] [047/133] (690s left) gem_exec_balancer (hang)
[327.824484] Starting subtest: hang
[329.896172] Subtest hang: SUCCESS (2.076s)
[330.052246] [048/133] (688s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[330.159582] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[330.163985] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[330.265842] [049/133] (688s left) kms_flip (bo-too-big)
[330.358556] Starting subtest: bo-too-big
[330.360491] Starting dynamic subtest: A-eDP1
[331.681775] Dynamic subtest A-eDP1: SUCCESS (1.325s)
[331.690146] Starting dynamic subtest: B-eDP1
[333.006302] Dynamic subtest B-eDP1: SUCCESS (1.324s)
[333.017917] Starting dynamic subtest: C-eDP1
[334.342879] Dynamic subtest C-eDP1: SUCCESS (1.335s)
[334.351780] Starting dynamic subtest: D-eDP1
[335.680169] Dynamic subtest D-eDP1: SUCCESS (1.337s)
[335.685037] Subtest bo-too-big: SUCCESS (5.331s)
[336.897842] [050/133] (681s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[336.956283] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[336.960714] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[337.156607] [051/133] (681s left) kms_cursor_legacy (single-bo)
[337.270595] Starting subtest: single-bo
[337.272567] Starting dynamic subtest: pipe-A
[342.651899] Dynamic subtest pipe-A: SUCCESS (5.379s)
[342.663130] Starting dynamic subtest: pipe-B
[348.033984] Dynamic subtest pipe-B: SUCCESS (5.379s)
[348.044888] Starting dynamic subtest: pipe-C
[353.414101] Dynamic subtest pipe-C: SUCCESS (5.378s)
[353.422157] Starting dynamic subtest: pipe-D
[358.796555] Dynamic subtest pipe-D: SUCCESS (5.378s)
[358.806057] Starting dynamic subtest: all-pipes
[364.184104] Dynamic subtest all-pipes: SUCCESS (5.386s)
[364.186529] Subtest single-bo: SUCCESS (26.912s)
[364.347285] [052/133] (654s left) kms_pm_rpm (basic-pci-d3-state)
[366.074181] Starting subtest: basic-pci-d3-state
[367.560594] Subtest basic-pci-d3-state: SUCCESS (1.490s)
[367.670078] [053/133] (650s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[367.759201] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[372.058433] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.302s)
[373.245380] [054/133] (645s left) kms_pm_rpm (legacy-planes)
[375.060462] Starting subtest: legacy-planes
[375.062928] Starting dynamic subtest: plane-63
[383.361459] Dynamic subtest plane-63: SUCCESS (8.299s)
[383.372026] Starting dynamic subtest: plane-93
[391.654130] Dynamic subtest plane-93: SUCCESS (8.290s)
[391.666731] Starting dynamic subtest: plane-123
[399.956904] Dynamic subtest plane-123: SUCCESS (8.298s)
[399.969091] Starting dynamic subtest: plane-133
[408.560407] Dynamic subtest plane-133: SUCCESS (8.603s)
[408.563163] Subtest legacy-planes: SUCCESS (33.500s)
[408.945380] [055/133] (609s left) prime_self_import (basic-with_one_bo)
[408.983883] Starting subtest: basic-with_one_bo
[409.010493] Subtest basic-with_one_bo: SUCCESS (0.028s)
[409.159992] [056/133] (609s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[409.256711] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[409.260962] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[409.387648] [057/133] (609s left) kms_flip (modeset-vs-vblank-race)
[409.478121] Starting subtest: modeset-vs-vblank-race
[409.480302] Starting dynamic subtest: A-eDP1
[414.127604] Dynamic subtest A-eDP1: SUCCESS (4.651s)
[414.140443] Starting dynamic subtest: B-eDP1
[418.849023] Dynamic subtest B-eDP1: SUCCESS (4.719s)
[418.859008] Starting dynamic subtest: C-eDP1
[423.483538] Dynamic subtest C-eDP1: SUCCESS (4.633s)
[423.493670] Starting dynamic subtest: D-eDP1
[428.005278] Dynamic subtest D-eDP1: SUCCESS (4.521s)
[428.007564] Subtest modeset-vs-vblank-race: SUCCESS (18.533s)
[429.287302] [058/133] (589s left) gem_lmem_swapping (heavy-verify-random-ccs)
[429.335344] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[429.369367] [059/133] (589s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[429.475421] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[429.479376] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[429.624906] [060/133] (589s left) kms_chamelium_color (gamma)
[429.719282] Subtest gamma: SKIP (0.000s)
[429.766037] [061/133] (589s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[429.897958] Starting subtest: cursorB-vs-flipA-varying-size
[429.902608] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[430.060628] [062/133] (588s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[430.170418] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[434.623438] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.456s)
[435.787098] [063/133] (583s left) dumb_buffer (map-valid)
[435.852411] Starting subtest: map-valid
[435.854301] Subtest map-valid: SUCCESS (0.000s)
[435.972786] [064/133] (582s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[436.074333] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[436.076461] Starting dynamic subtest: pipe-A-default-mode
[436.374711] Dynamic subtest pipe-A-default-mode: SKIP (0.300s)
[436.379240] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.301s)
[437.219084] [065/133] (581s left) perf (i915-ref-count)
[437.297612] Starting subtest: i915-ref-count
[437.371856] Subtest i915-ref-count: SUCCESS (0.072s)
[437.424982] [066/133] (581s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[437.516385] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[437.520705] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[437.626973] [067/133] (581s left) gem_softpin (noreloc-interruptible)
[437.688790] Starting subtest: noreloc-interruptible
[443.103970] Subtest noreloc-interruptible: SUCCESS (5.416s)
[443.269095] [068/133] (575s left) kms_psr (fbc-psr2-primary-render)
[443.369738] Starting subtest: fbc-psr2-primary-render
[443.372066] Starting dynamic subtest: eDP-1
[443.376376] Dynamic subtest eDP-1: SKIP (0.000s)
[443.380368] Subtest fbc-psr2-primary-render: SKIP (0.002s)
[443.471376] [069/133] (575s left) kms_lease (atomic-implicit-crtc)
[443.568296] Starting subtest: atomic-implicit-crtc
[443.570616] Starting dynamic subtest: pipe-A-eDP-1
[443.582524] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[443.596345] Starting dynamic subtest: pipe-B-eDP-1
[443.607493] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[443.617693] Starting dynamic subtest: pipe-C-eDP-1
[443.628024] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[443.636108] Starting dynamic subtest: pipe-D-eDP-1
[443.646427] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[443.648548] Subtest atomic-implicit-crtc: SUCCESS (0.034s)
[443.743352] [070/133] (575s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[443.835662] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[444.207932] Starting dynamic subtest: pipe-A-eDP-1
[446.963750] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.755s)
[447.336444] Starting dynamic subtest: pipe-B-eDP-1
[450.087790] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.756s)
[450.447163] Starting dynamic subtest: pipe-C-eDP-1
[453.213243] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.772s)
[453.591630] Starting dynamic subtest: pipe-D-eDP-1
[456.348274] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.762s)
[456.350845] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.513s)
[457.559437] [071/133] (561s left) gem_exec_reloc (basic-wc-read-active)
[457.617753] Subtest basic-wc-read-active: SKIP (0.000s)
[457.704275] [072/133] (561s left) gem_readwrite (new-obj)
[457.761298] Subtest new-obj: SKIP (0.000s)
[457.825206] [073/133] (561s left) gem_mmap_gtt (basic-short)
[457.884748] Subtest basic-short: SKIP (0.000s)
[457.938192] [074/133] (561s left) kms_plane_multiple (tiling-yf)
[458.035428] Starting subtest: tiling-yf
[458.039438] Subtest tiling-yf: SKIP (0.000s)
[458.127630] [075/133] (561s left) kms_content_protection (dp-mst-type-0-hdcp14)
[458.274732] Starting subtest: dp-mst-type-0-hdcp14
[458.279292] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[458.431668] [076/133] (560s left) gem_ctx_shared (q-in-order)
[458.492202] Starting subtest: Q-in-order
[458.494205] Starting dynamic subtest: rcs0
[458.642158] Dynamic subtest rcs0: SUCCESS (0.149s)
[458.658139] Starting dynamic subtest: vcs0
[458.721331] Dynamic subtest vcs0: SUCCESS (0.078s)
[458.738494] Starting dynamic subtest: vcs1
[458.801970] Dynamic subtest vcs1: SUCCESS (0.079s)
[458.818857] Starting dynamic subtest: vecs0
[458.881980] Dynamic subtest vecs0: SUCCESS (0.080s)
[458.898934] Starting dynamic subtest: ccs0
[458.972203] Dynamic subtest ccs0: SUCCESS (0.088s)
[458.974596] Subtest Q-in-order: SUCCESS (0.480s)
[460.052561] [FACT gem_ctx_shared (q-in-order)] new: kernel.kmod_is_loaded.vgem: true
[460.056173] [077/133] (559s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[460.113506] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[460.219081] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[460.317332] [078/133] (559s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[460.415243] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[467.035407] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.622s)
[467.210905] [079/133] (552s left) kms_big_fb (linear-8bpp-rotate-270)
[467.316285] Starting subtest: linear-8bpp-rotate-270
[467.336886] Subtest linear-8bpp-rotate-270: SKIP (0.020s)
[467.488233] [080/133] (552s left) api_intel_allocator (standalone)
[467.540786] Starting subtest: standalone
[467.556476] Subtest standalone: SUCCESS (0.018s)
[467.721021] [081/133] (551s left) core_auth (getclient-master-drop)
[467.759271] Starting subtest: getclient-master-drop
[467.784444] Subtest getclient-master-drop: SUCCESS (0.024s)
[467.918232] [082/133] (551s left) kms_psr (fbc-psr2-basic)
[468.015651] Starting subtest: fbc-psr2-basic
[468.017923] Starting dynamic subtest: eDP-1
[468.022148] Dynamic subtest eDP-1: SKIP (0.000s)
[468.026275] Subtest fbc-psr2-basic: SKIP (0.001s)
[468.111121] [083/133] (551s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[468.257304] Starting subtest: cursor-rapid-movement-32x32
[468.302290] Subtest cursor-rapid-movement-32x32: SKIP (0.042s)
[468.636245] [084/133] (551s left) gem_exec_schedule (noreorder-priority)
[468.818394] Starting subtest: noreorder-priority
[468.820768] Starting dynamic subtest: rcs0
[469.983061] Dynamic subtest rcs0: SUCCESS (1.164s)
[469.995574] Starting dynamic subtest: vcs0
[471.917761] Dynamic subtest vcs0: SUCCESS (1.931s)
[471.935012] Starting dynamic subtest: vcs1
[473.900296] Dynamic subtest vcs1: SUCCESS (1.979s)
[473.915622] Starting dynamic subtest: vecs0
[475.910597] Dynamic subtest vecs0: SUCCESS (2.007s)
[475.922555] Starting dynamic subtest: ccs0
[477.076345] Dynamic subtest ccs0: SUCCESS (1.165s)
[477.079217] Subtest noreorder-priority: SUCCESS (8.259s)
[477.291242] [085/133] (542s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[477.414858] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[477.417064] Starting dynamic subtest: pipe-A-eDP-1
[477.440885] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[477.450246] Starting dynamic subtest: pipe-B-eDP-1
[477.472114] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[477.480097] Starting dynamic subtest: pipe-C-eDP-1
[477.502869] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[477.511044] Starting dynamic subtest: pipe-D-eDP-1
[477.534617] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[477.539030] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[479.659829] [086/133] (540s left) core_auth (many-magics)
[479.726686] Starting subtest: many-magics
[480.620830] Subtest many-magics: SUCCESS (0.897s)
[480.861775] [087/133] (539s left) i915_suspend (fence-restore-tiled2untiled)
[480.934250] Starting subtest: fence-restore-tiled2untiled
[480.938684] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[481.067538] [088/133] (538s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[481.167857] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[481.170012] Starting dynamic subtest: pipe-A
[481.189585] Dynamic subtest pipe-A: SKIP (0.018s)
[481.198431] Starting dynamic subtest: pipe-B
[481.223520] Dynamic subtest pipe-B: SKIP (0.033s)
[481.232224] Starting dynamic subtest: pipe-C
[481.254829] Dynamic subtest pipe-C: SKIP (0.030s)
[481.265217] Starting dynamic subtest: pipe-D
[481.282541] Dynamic subtest pipe-D: SKIP (0.030s)
[481.286327] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.113s)
[481.415068] [089/133] (538s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[481.525699] Starting subtest: y-tiled-64bpp-rotate-0
[481.531065] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[481.652265] [090/133] (538s left) gem_ctx_persistence (saturated-hostile)
[481.711263] Starting subtest: saturated-hostile
[481.713599] Starting dynamic subtest: rcs0
[482.558664] Dynamic subtest rcs0: SUCCESS (0.847s)
[482.570695] Starting dynamic subtest: bcs0
[483.360118] Dynamic subtest bcs0: SUCCESS (0.801s)
[483.374917] Starting dynamic subtest: vcs0
[484.165495] Dynamic subtest vcs0: SUCCESS (0.801s)
[484.177305] Starting dynamic subtest: vcs1
[484.987461] Dynamic subtest vcs1: SUCCESS (0.821s)
[484.999413] Starting dynamic subtest: vecs0
[485.788683] Dynamic subtest vecs0: SUCCESS (0.799s)
[485.798115] Starting dynamic subtest: ccs0
[486.642542] Dynamic subtest ccs0: SUCCESS (0.852s)
[486.645147] Subtest saturated-hostile: SUCCESS (4.932s)
[486.746944] [091/133] (533s left) kms_prop_blob (invalid-get-prop)
[486.817660] Starting subtest: invalid-get-prop
[486.820061] Subtest invalid-get-prop: SUCCESS (0.000s)
[486.951537] [092/133] (533s left) gem_mmap_gtt (basic-write)
[487.014940] Subtest basic-write: SKIP (0.000s)
[487.075112] [093/133] (533s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[487.207294] Starting subtest: cursorA-vs-flipA-varying-size
[498.346664] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.141s)
[499.183850] [094/133] (520s left) gem_linear_blits (interruptible)
[499.656205] Starting subtest: interruptible
[504.264449] Subtest interruptible: SUCCESS (4.607s)
[504.438581] [095/133] (515s left) gem_exec_params (sol-reset-invalid)
[504.539701] Starting subtest: sol-reset-invalid
[504.544786] Subtest sol-reset-invalid: SUCCESS (0.004s)
[505.958059] [096/133] (514s left) kms_color_pipeline (plane-lut1d)
[506.063097] Starting subtest: plane-lut1d
[506.085190] Starting dynamic subtest: pipe-A-eDP-1
[506.797249] Dynamic subtest pipe-A-eDP-1: FAIL (0.331s)
[507.544604] Starting dynamic subtest: pipe-B-eDP-1
[508.374852] Dynamic subtest pipe-B-eDP-1: FAIL (0.325s)
[508.968783] Starting dynamic subtest: pipe-C-eDP-1
[509.834433] Dynamic subtest pipe-C-eDP-1: FAIL (0.280s)
[510.307593] Starting dynamic subtest: pipe-D-eDP-1
[511.131649] Dynamic subtest pipe-D-eDP-1: FAIL (0.258s)
[511.134121] Subtest plane-lut1d: FAIL (4.775s)
[511.705090] [097/133] (508s left) gem_wait (busy)
[511.789896] Starting subtest: busy
[511.792464] Starting dynamic subtest: all-engines
[512.918058] Dynamic subtest all-engines: SUCCESS (1.126s)
[512.929333] Starting dynamic subtest: rcs0
[513.458599] Dynamic subtest rcs0: SUCCESS (0.539s)
[513.469652] Starting dynamic subtest: bcs0
[513.998223] Dynamic subtest bcs0: SUCCESS (0.539s)
[514.007084] Starting dynamic subtest: vcs0
[515.863400] Dynamic subtest vcs0: SUCCESS (1.861s)
[515.876268] Starting dynamic subtest: vcs1
[517.910019] Dynamic subtest vcs1: SUCCESS (2.044s)
[517.920050] Starting dynamic subtest: vecs0
[519.893765] Dynamic subtest vecs0: SUCCESS (1.981s)
[519.903912] Starting dynamic subtest: ccs0
[520.438453] Dynamic subtest ccs0: SUCCESS (0.543s)
[520.440774] Subtest busy: SUCCESS (8.649s)
[520.656601] [098/133] (499s left) sriov_basic (enable-vfs-autoprobe-on)
[520.714494] Starting subtest: enable-vfs-autoprobe-on
[520.716417] Starting dynamic subtest: numvfs-1
[520.790894] Dynamic subtest numvfs-1: FAIL (0.005s)
[520.801753] Starting dynamic subtest: numvfs-2
[520.873709] Dynamic subtest numvfs-2: FAIL (0.003s)
[520.883465] Starting dynamic subtest: numvfs-3
[520.955437] Dynamic subtest numvfs-3: FAIL (0.003s)
[520.964525] Starting dynamic subtest: numvfs-4
[521.036476] Dynamic subtest numvfs-4: FAIL (0.003s)
[521.046890] Starting dynamic subtest: numvfs-5
[521.119308] Dynamic subtest numvfs-5: FAIL (0.003s)
[521.129628] Starting dynamic subtest: numvfs-6
[521.205101] Dynamic subtest numvfs-6: FAIL (0.004s)
[521.215049] Starting dynamic subtest: numvfs-7
[521.289161] Dynamic subtest numvfs-7: FAIL (0.003s)
[521.299677] Starting dynamic subtest: numvfs-random
[521.374231] Dynamic subtest numvfs-random: FAIL (0.003s)
[521.385437] Starting dynamic subtest: numvfs-all
[521.458739] Dynamic subtest numvfs-all: FAIL (0.508s)
[521.460807] Subtest enable-vfs-autoprobe-on: FAIL (0.545s)
[521.499493] [099/133] (498s left) kms_chamelium_frames (vga-frame-dump)
[521.876985] Subtest vga-frame-dump: SKIP (0.000s)
[522.686228] [100/133] (497s left) gem_eio (throttle)
[522.875708] Starting subtest: throttle
[523.137383] Subtest throttle: SUCCESS (0.260s)
[523.313332] [101/133] (497s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-mmap-wc)
[523.411084] Starting subtest: psr-abgr161616f-draw-mmap-wc
[523.415419] Subtest psr-abgr161616f-draw-mmap-wc: SKIP (0.000s)
[523.544366] [102/133] (496s left) gem_softpin (allocator-nopin)
[523.616496] Starting subtest: allocator-nopin
[523.720360] Subtest allocator-nopin: SUCCESS (0.104s)
[523.866639] [103/133] (496s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[523.956652] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[524.658781] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.703s)
[524.879287] [104/133] (495s left) kms_flip (busy-flip)
[524.975343] Starting subtest: busy-flip
[524.977590] Starting dynamic subtest: A-eDP1
[526.619767] Dynamic subtest A-eDP1: SUCCESS (1.644s)
[526.631443] Starting dynamic subtest: B-eDP1
[528.346697] Dynamic subtest B-eDP1: SUCCESS (1.725s)
[528.358059] Starting dynamic subtest: C-eDP1
[529.971859] Dynamic subtest C-eDP1: SUCCESS (1.624s)
[529.982716] Starting dynamic subtest: D-eDP1
[531.607554] Dynamic subtest D-eDP1: SUCCESS (1.634s)
[531.613079] Subtest busy-flip: SUCCESS (6.637s)
[532.886808] [105/133] (487s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[532.991649] Starting subtest: x-tiled-16bpp-rotate-270
[533.011540] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[533.171456] [106/133] (487s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-render)
[533.270549] Starting subtest: fbcpsr-abgr161616f-draw-render
[533.274529] Subtest fbcpsr-abgr161616f-draw-render: SKIP (0.000s)
[533.413628] [107/133] (487s left) kms_getfb (getfb2-accept-nv12)
[533.510267] Starting subtest: getfb2-accept-nv12
[533.512548] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[533.633673] [108/133] (487s left) gem_ctx_exec (basic-nohangcheck)
[533.702593] Starting subtest: basic-nohangcheck
[533.946942] Subtest basic-nohangcheck: SUCCESS (0.245s)
[534.113240] [109/133] (486s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[534.235557] Starting subtest: short-flip-before-cursor-atomic-transitions
[535.189059] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.954s)
[536.017429] [110/133] (484s left) kms_cursor_crc (cursor-offscreen-256x256)
[536.270722] Starting subtest: cursor-offscreen-256x256
[536.275882] Starting dynamic subtest: pipe-A-eDP-1
[538.202848] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.929s)
[538.232596] Starting dynamic subtest: pipe-D-eDP-1
[540.800528] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.576s)
[540.802677] Subtest cursor-offscreen-256x256: SUCCESS (4.530s)
[541.681114] [111/133] (479s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[541.783037] Starting subtest: 4-tiled-8bpp-rotate-0
[542.984663] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.201s)
[543.176450] [112/133] (477s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[543.239409] Subtest writes-after-reads: SKIP (0.000s)
[543.320348] [113/133] (477s left) kms_frontbuffer_tracking (psr-slowdraw)
[543.427950] Starting subtest: psr-slowdraw
[568.637647] Subtest psr-slowdraw: SUCCESS (25.209s)
[568.792118] [114/133] (452s left) i915_pm_rc6_residency (rc6-idle)
[568.855763] Starting subtest: rc6-idle
[568.908260] Starting dynamic subtest: gt0-rcs0
[593.172516] Dynamic subtest gt0-rcs0: SUCCESS (24.263s)
[593.181968] Starting dynamic subtest: gt0-bcs0
[617.435556] Dynamic subtest gt0-bcs0: SUCCESS (24.260s)
[617.447626] Starting dynamic subtest: gt0-ccs0
[641.764837] Dynamic subtest gt0-ccs0: SUCCESS (24.326s)
[641.773701] Starting dynamic subtest: gt1-vcs0
[647.939755] Dynamic subtest gt1-vcs0: SUCCESS (6.170s)
[647.951776] Starting dynamic subtest: gt1-vecs0
[654.111723] Dynamic subtest gt1-vecs0: SUCCESS (6.169s)
[654.114730] Subtest rc6-idle: SUCCESS (85.254s)
[654.218699] [115/133] (366s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[654.319314] Starting subtest: fbc-modesetfrombusy
[658.135913] Subtest fbc-modesetfrombusy: SUCCESS (3.820s)
[659.377936] [116/133] (361s left) kms_psr (psr-cursor-render)
[659.486550] Starting subtest: psr-cursor-render
[659.488685] Starting dynamic subtest: eDP-1
[661.196432] Dynamic subtest eDP-1: SUCCESS (1.709s)
[661.198726] Subtest psr-cursor-render: SUCCESS (1.710s)
[662.084533] [117/133] (359s left) gem_exec_parallel (engines)
[662.152429] Starting subtest: engines
[662.154810] Starting dynamic subtest: basic
[663.894933] Dynamic subtest basic: SUCCESS (1.740s)
[663.906252] Starting dynamic subtest: contexts
[668.369353] Dynamic subtest contexts: SUCCESS (4.447s)
[668.379665] Starting dynamic subtest: fds
[672.196477] Dynamic subtest fds: SUCCESS (3.851s)
[672.215058] Starting dynamic subtest: userptr
[673.912329] Dynamic subtest userptr: SUCCESS (1.713s)
[673.915048] Subtest engines: SUCCESS (11.759s)
[674.126273] [118/133] (347s left) prime_busy (after)
[674.192893] Starting subtest: after
[674.198327] Starting dynamic subtest: rcs0
[674.249269] Dynamic subtest rcs0: SUCCESS (0.052s)
[674.261294] Starting dynamic subtest: bcs0
[674.329058] Dynamic subtest bcs0: SUCCESS (0.079s)
[674.340503] Starting dynamic subtest: vcs0
[674.370648] Dynamic subtest vcs0: SUCCESS (0.041s)
[674.380579] Starting dynamic subtest: vcs1
[674.410785] Dynamic subtest vcs1: SUCCESS (0.039s)
[674.422375] Starting dynamic subtest: vecs0
[674.451705] Dynamic subtest vecs0: SUCCESS (0.040s)
[674.461041] Starting dynamic subtest: ccs0
[674.493730] Dynamic subtest ccs0: SUCCESS (0.041s)
[674.602744] Subtest after: SUCCESS (0.408s)
[674.700380] [119/133] (346s left) gem_partial_pwrite_pread (write-display)
[674.771892] Subtest write-display: SKIP (0.000s)
[674.864522] [120/133] (346s left) gem_tiled_blits (basic)
[674.917343] Subtest basic: SKIP (0.000s)
[674.991345] [121/133] (346s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[675.093521] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[683.549548] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.459s)
[683.700878] [122/133] (337s left) sysfs_defaults (readonly)
[683.764707] Starting subtest: readonly
[683.767052] Starting dynamic subtest: vecs0
[683.769407] Dynamic subtest vecs0: SUCCESS (0.000s)
[683.779726] Starting dynamic subtest: ccs0
[683.781686] Dynamic subtest ccs0: SUCCESS (0.000s)
[683.790943] Starting dynamic subtest: vcs0
[683.792799] Dynamic subtest vcs0: SUCCESS (0.000s)
[683.801584] Starting dynamic subtest: bcs0
[683.803460] Dynamic subtest bcs0: SUCCESS (0.000s)
[683.812450] Starting dynamic subtest: rcs0
[683.814353] Dynamic subtest rcs0: SUCCESS (0.000s)
[683.823219] Starting dynamic subtest: vcs1
[683.825222] Dynamic subtest vcs1: SUCCESS (0.000s)
[683.827162] Subtest readonly: SUCCESS (0.005s)
[683.912271] [123/133] (337s left) kms_dsc (dsc-with-formats)
[684.012039] Starting subtest: dsc-with-formats
[684.051985] Subtest dsc-with-formats: SKIP (0.001s)
[684.111249] [124/133] (337s left) prime_mmap (test_reprime)
[684.182702] Starting subtest: test_reprime
[684.185039] Starting dynamic subtest: test_reprime-smem
[684.213189] Dynamic subtest test_reprime-smem: SUCCESS (0.032s)
[684.215604] Subtest test_reprime: SUCCESS (0.033s)
[684.360403] [125/133] (337s left) gem_exec_params (rsvd2-dirt)
[684.424389] Starting subtest: rsvd2-dirt
[684.429022] Subtest rsvd2-dirt: SKIP (0.000s)
[684.577895] [126/133] (336s left) kms_lease (lessee-list)
[684.677564] Starting subtest: lessee-list
[684.679490] Starting dynamic subtest: pipe-A-eDP-1
[684.681485] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[684.691447] Starting dynamic subtest: pipe-B-eDP-1
[684.693080] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[684.701137] Starting dynamic subtest: pipe-C-eDP-1
[684.702768] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[684.711333] Starting dynamic subtest: pipe-D-eDP-1
[684.712934] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[684.714664] Subtest lessee-list: SUCCESS (0.008s)
[684.818529] [127/133] (336s left) kms_vrr (flip-dpms)
[684.913242] Starting subtest: flip-dpms
[684.918309] Subtest flip-dpms: SKIP (0.000s)
[685.004904] [128/133] (336s left) kms_frontbuffer_tracking (fbc-1p-rte)
[685.114079] Starting subtest: fbc-1p-rte
[690.642508] Subtest fbc-1p-rte: SUCCESS (5.530s)
[691.890258] [129/133] (329s left) gen9_exec_parse (batch-zero-length)
[691.949379] Subtest batch-zero-length: SKIP (0.000s)
[692.031342] [130/133] (329s left) prime_mmap (test_aperture_limit)
[692.090519] Starting subtest: test_aperture_limit
[692.092501] Starting dynamic subtest: test_aperture_limit-smem
[692.100257] Dynamic subtest test_aperture_limit-smem: SKIP (0.007s)
[692.104650] Subtest test_aperture_limit: SKIP (0.008s)
[692.230640] [131/133] (329s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[692.335540] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[692.339776] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[692.468354] [132/133] (329s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[692.566264] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[692.570508] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[692.696252] [133/133] (329s left) gem_exec_fence (long-history)
[693.159771] Starting subtest: long-history
[700.688420] Subtest long-history: SUCCESS (7.529s)
[702.799655] 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.