[57.420489] Initializing watchdogs
[57.420533]   /dev/watchdog0
[57.434363] [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.438896] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.441129] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.444352] [001/133] (960s left) gem_create (create-ext-placement-all)
[57.636657] Starting subtest: create-ext-placement-all
[57.639041] Subtest create-ext-placement-all: SUCCESS (0.000s)
[57.773692] [002/133] (960s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[57.841315] Starting subtest: map-fixed-invalidate-overlap
[57.846085] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[57.988647] [003/133] (960s left) gem_pipe_control_store_loop (fresh-buffer)
[58.044463] Starting subtest: fresh-buffer
[60.259285] Subtest fresh-buffer: SUCCESS (2.154s)
[60.366520] [004/133] (957s left) gem_mmap_offset (mmap-boundaries)
[60.439141] Starting subtest: mmap-boundaries
[60.441153] Starting dynamic subtest: smem0
[60.722546] Dynamic subtest smem0: SUCCESS (0.283s)
[60.725047] Subtest mmap-boundaries: SUCCESS (0.284s)
[60.886160] [005/133] (957s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[61.003669] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[68.604678] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.597s)
[68.784766] [006/133] (949s left) kms_atomic (atomic-plane-damage)
[68.878946] Starting subtest: atomic-plane-damage
[68.956846] Starting dynamic subtest: pipe-A-eDP-1
[69.479089] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.521s)
[69.481566] Subtest atomic-plane-damage: SUCCESS (0.601s)
[70.294104] [007/133] (947s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[70.387377] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[70.389782] Starting dynamic subtest: pipe-A-eDP-1
[70.452995] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s)
[70.462043] Starting dynamic subtest: pipe-B-eDP-1
[70.514978] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.063s)
[70.523983] Starting dynamic subtest: pipe-C-eDP-1
[70.578226] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.063s)
[70.586894] Starting dynamic subtest: pipe-D-eDP-1
[70.640181] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.061s)
[70.642528] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.253s)
[72.952611] [008/133] (945s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[73.051305] Starting subtest: psr-rgb101010-draw-mmap-wc
[80.134823] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.084s)
[80.267654] [009/133] (937s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[80.343828] Starting subtest: yf-tiled-to-vebox-x-tiled
[80.348099] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[80.542144] [010/133] (937s left) syncobj_timeline (wait-all-complex)
[80.589731] Starting subtest: wait-all-complex
[80.802789] Subtest wait-all-complex: SUCCESS (0.213s)
[80.894834] [011/133] (937s left) gem_pxp (create-valid-protected-context)
[81.034474] Starting subtest: create-valid-protected-context
[81.036710] Subtest create-valid-protected-context: SUCCESS (0.002s)
[81.175240] [012/133] (937s left) gem_exec_flush (basic-wb-rw-default)
[81.252277] Starting subtest: basic-wb-rw-default
[86.740189] Subtest basic-wb-rw-default: SUCCESS (5.450s)
[86.909879] [013/133] (931s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[87.024859] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[87.027335] Starting dynamic subtest: pipe-A-eDP-1
[87.048246] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[87.058074] Starting dynamic subtest: pipe-B-eDP-1
[87.078084] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[87.087128] Starting dynamic subtest: pipe-C-eDP-1
[87.106499] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[87.114229] Starting dynamic subtest: pipe-D-eDP-1
[87.133413] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[87.135591] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[89.351894] [014/133] (929s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[89.442822] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[93.565224] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.125s)
[94.776158] [015/133] (923s left) kms_cursor_edge_walk (256x256-top-bottom)
[94.879955] Starting subtest: 256x256-top-bottom
[94.882642] Starting dynamic subtest: pipe-A-eDP-1
[98.315995] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.436s)
[98.326148] Starting dynamic subtest: pipe-D-eDP-1
[101.429269] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.113s)
[101.431502] Subtest 256x256-top-bottom: SUCCESS (6.551s)
[102.260512] [016/133] (916s left) kms_force_connector_basic (force-load-detect)
[102.342988] Starting subtest: force-load-detect
[102.347531] Subtest force-load-detect: SKIP (0.000s)
[102.480620] [017/133] (916s left) syncobj_wait (invalid-signal-zero-handles)
[102.534691] Starting subtest: invalid-signal-zero-handles
[102.537124] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[102.651659] [018/133] (915s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[107.624925] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[107.627233] Starting dynamic subtest: pipe-A-eDP-1
[108.412650] Dynamic subtest pipe-A-eDP-1: SKIP (0.786s)
[108.423961] Starting dynamic subtest: pipe-B-eDP-1
[109.546092] Dynamic subtest pipe-B-eDP-1: SKIP (1.132s)
[109.549981] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.921s)
[110.762096] [019/133] (907s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[110.874587] Starting subtest: fbcpsr-rgb565-draw-render
[117.907478] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.035s)
[118.083253] [020/133] (900s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[118.190018] Starting subtest: primary-4-tiled-reflect-x-0
[125.300144] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.111s)
[126.534198] [021/133] (892s left) kms_setmode (clone-exclusive-crtc)
[126.603242] Starting subtest: clone-exclusive-crtc
[126.610213] Subtest clone-exclusive-crtc: SKIP (0.000s)
[126.737939] [022/133] (891s left) kms_addfb_basic (too-high)
[126.826932] Starting subtest: too-high
[126.829275] Subtest too-high: SUCCESS (0.001s)
[126.957298] [023/133] (891s left) perf_pmu (busy-accuracy-2)
[126.990595] Starting subtest: busy-accuracy-2
[126.992889] Starting dynamic subtest: rcs0
[130.032156] Dynamic subtest rcs0: SUCCESS (3.040s)
[130.042265] Starting dynamic subtest: bcs0
[133.152046] Dynamic subtest bcs0: SUCCESS (3.059s)
[133.162068] Starting dynamic subtest: vcs0
[136.192619] Dynamic subtest vcs0: SUCCESS (3.046s)
[136.203058] Starting dynamic subtest: vcs1
[139.241225] Dynamic subtest vcs1: SUCCESS (3.048s)
[139.251808] Starting dynamic subtest: vecs0
[142.291021] Dynamic subtest vecs0: SUCCESS (3.046s)
[142.301091] Starting dynamic subtest: ccs0
[145.347536] Dynamic subtest ccs0: SUCCESS (3.057s)
[145.349581] Subtest busy-accuracy-2: SUCCESS (18.307s)
[145.437852] [024/133] (873s left) kms_psr (pr-primary-mmap-gtt)
[145.544078] Starting subtest: pr-primary-mmap-gtt
[145.548553] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[145.638295] [025/133] (873s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[145.744733] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[145.748841] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[145.886294] [026/133] (873s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[145.992497] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[145.996622] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[146.112615] [027/133] (872s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[146.204899] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[146.207067] Starting dynamic subtest: pipe-A-default-mode
[148.946727] Dynamic subtest pipe-A-default-mode: SUCCESS (2.738s)
[148.948729] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.740s)
[149.830758] [028/133] (869s left) i915_drm_fdinfo (idle)
[149.869472] Starting subtest: idle
[149.871668] Starting dynamic subtest: rcs0
[150.460963] Dynamic subtest rcs0: SUCCESS (0.591s)
[150.472085] Starting dynamic subtest: bcs0
[150.968457] Dynamic subtest bcs0: SUCCESS (0.504s)
[150.979288] Starting dynamic subtest: vcs0
[151.474917] Dynamic subtest vcs0: SUCCESS (0.504s)
[151.485779] Starting dynamic subtest: vcs1
[151.981068] Dynamic subtest vcs1: SUCCESS (0.504s)
[151.990271] Starting dynamic subtest: vecs0
[152.486564] Dynamic subtest vecs0: SUCCESS (0.504s)
[152.498564] Starting dynamic subtest: ccs0
[152.992443] Dynamic subtest ccs0: SUCCESS (0.503s)
[152.995213] Subtest idle: SUCCESS (3.122s)
[153.097025] [029/133] (865s left) core_setmaster (master-drop-set-shared-fd)
[153.199478] Starting subtest: master-drop-set-shared-fd
[153.221019] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[153.256786] [030/133] (865s left) kms_chamelium_color (ctm-negative)
[153.362200] Subtest ctm-negative: SKIP (0.000s)
[153.405238] [031/133] (865s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[153.465831] Starting subtest: multi-wait-for-submit-available-submitted
[153.468064] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.001s)
[153.608636] [032/133] (865s left) syncobj_timeline (invalid-signal-illegal-point)
[153.671252] Starting subtest: invalid-signal-illegal-point
[153.673494] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[153.785901] [033/133] (865s left) gem_mmap (bad-offset)
[153.852125] Subtest bad-offset: SKIP (0.000s)
[153.919564] [034/133] (865s left) i915_hangman (gt-error-state-capture)
[153.989648] Starting subtest: gt-error-state-capture
[153.991523] Starting dynamic subtest: rcs0
[167.846276] Dynamic subtest rcs0: SUCCESS (13.804s)
[167.857849] Starting dynamic subtest: bcs0
[178.868764] Dynamic subtest bcs0: SUCCESS (11.072s)
[178.880707] Starting dynamic subtest: vcs0
[190.834960] Dynamic subtest vcs0: SUCCESS (11.964s)
[190.846534] Starting dynamic subtest: vcs1
[201.845071] Dynamic subtest vcs1: SUCCESS (11.007s)
[201.856860] Starting dynamic subtest: vecs0
[213.811074] Dynamic subtest vecs0: SUCCESS (11.963s)
[213.822918] Starting dynamic subtest: ccs0
[224.883382] Dynamic subtest ccs0: SUCCESS (11.070s)
[224.886244] Subtest gt-error-state-capture: SUCCESS (70.892s)
[224.984814] [035/133] (794s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[225.101037] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[225.103312] Starting dynamic subtest: pipe-A-eDP-1
[225.112645] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[225.123206] Starting dynamic subtest: pipe-B-eDP-1
[225.132228] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[225.140726] Starting dynamic subtest: pipe-C-eDP-1
[225.149216] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[225.157212] Starting dynamic subtest: pipe-D-eDP-1
[225.165570] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[225.169572] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[227.386280] [036/133] (791s left) gem_exec_whisper (basic-fds)
[227.457868] Starting subtest: basic-fds
[234.790361] Subtest basic-fds: SUCCESS (7.329s)
[234.998439] [037/133] (784s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[235.113427] Starting subtest: psr-1p-primscrn-cur-indfb-move
[242.589173] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.480s)
[242.783280] [038/133] (776s left) gem_exec_schedule (preempt-user)
[242.863581] Starting subtest: preempt-user
[242.865818] Starting dynamic subtest: rcs0
[242.887075] Dynamic subtest rcs0: SUCCESS (0.033s)
[242.898176] Starting dynamic subtest: bcs0
[242.906350] Dynamic subtest bcs0: SUCCESS (0.019s)
[242.915258] Starting dynamic subtest: vcs0
[242.925759] Dynamic subtest vcs0: SUCCESS (0.019s)
[242.934244] Starting dynamic subtest: vcs1
[242.948305] Dynamic subtest vcs1: SUCCESS (0.022s)
[242.956807] Starting dynamic subtest: vecs0
[242.968897] Dynamic subtest vecs0: SUCCESS (0.020s)
[242.977298] Starting dynamic subtest: ccs0
[242.991119] Dynamic subtest ccs0: SUCCESS (0.022s)
[242.993348] Subtest preempt-user: SUCCESS (0.138s)
[244.985658] [039/133] (774s left) kms_psr (psr2-primary-mmap-cpu)
[245.087081] Starting subtest: psr2-primary-mmap-cpu
[245.089177] Starting dynamic subtest: eDP-1
[246.762859] Dynamic subtest eDP-1: SUCCESS (1.676s)
[246.765166] Subtest psr2-primary-mmap-cpu: SUCCESS (1.677s)
[247.664027] [040/133] (771s left) gem_ctx_param (invalid-size-set)
[247.732716] Starting subtest: invalid-size-set
[247.735514] Subtest invalid-size-set: SUCCESS (0.001s)
[247.849980] [041/133] (771s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[247.943067] Starting subtest: bad-aux-stride-y-tiled-ccs
[247.945465] Starting dynamic subtest: pipe-A-eDP-1
[247.969066] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[247.979148] Starting dynamic subtest: pipe-B-eDP-1
[248.001063] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[248.009554] Starting dynamic subtest: pipe-C-eDP-1
[248.032608] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[248.040979] Starting dynamic subtest: pipe-D-eDP-1
[248.063255] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[248.067296] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[250.132139] [042/133] (769s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[250.230920] Starting subtest: blocking-absolute-wf_vblank-interruptible
[250.233094] Starting dynamic subtest: A-eDP1
[258.995065] Dynamic subtest A-eDP1: SUCCESS (8.727s)
[259.006210] Starting dynamic subtest: B-eDP1
[267.691058] Dynamic subtest B-eDP1: SUCCESS (8.728s)
[267.704769] Starting dynamic subtest: C-eDP1
[276.463852] Dynamic subtest C-eDP1: SUCCESS (8.723s)
[276.475582] Starting dynamic subtest: D-eDP1
[285.198101] Dynamic subtest D-eDP1: SUCCESS (8.732s)
[285.200192] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.922s)
[286.411643] [043/133] (733s left) kms_psr2_su (page_flip-nv12)
[286.475793] Subtest page_flip-NV12: SKIP (0.000s)
[286.534382] [044/133] (733s left) gem_exec_balancer (sliced)
[286.601084] Starting subtest: sliced
[286.605621] Subtest sliced: SKIP (0.000s)
[286.940817] [045/133] (732s left) kms_plane_lowres (tiling-x)
[287.034179] Starting subtest: tiling-x
[287.036495] Starting dynamic subtest: pipe-A-eDP-1
[287.041075] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[287.327474] Starting dynamic subtest: pipe-B-eDP-1
[287.332073] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[287.340811] Starting dynamic subtest: pipe-C-eDP-1
[287.345521] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[287.354175] Starting dynamic subtest: pipe-D-eDP-1
[287.358837] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[287.363243] Subtest tiling-x: SKIP (0.294s)
[288.140744] [046/133] (731s left) kms_vblank (query-busy-hang)
[288.239110] Starting subtest: query-busy-hang
[288.241216] Starting dynamic subtest: pipe-A-eDP-1
[314.642427] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.400s)
[314.655705] Starting dynamic subtest: pipe-D-eDP-1
[339.744563] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.098s)
[339.746731] Subtest query-busy-hang: SUCCESS (51.503s)
[340.606412] [047/133] (679s left) gem_exec_balancer (hang)
[340.860847] Starting subtest: hang
[342.950697] Subtest hang: SUCCESS (2.093s)
[343.114723] [048/133] (676s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[343.220074] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[343.224348] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[343.361590] [049/133] (676s left) kms_flip (bo-too-big)
[343.469778] Starting subtest: bo-too-big
[343.471582] Starting dynamic subtest: A-eDP1
[344.740087] Dynamic subtest A-eDP1: SUCCESS (1.271s)
[344.749415] Starting dynamic subtest: B-eDP1
[346.075122] Dynamic subtest B-eDP1: SUCCESS (1.333s)
[346.085559] Starting dynamic subtest: C-eDP1
[347.412455] Dynamic subtest C-eDP1: SUCCESS (1.336s)
[347.422770] Starting dynamic subtest: D-eDP1
[348.745628] Dynamic subtest D-eDP1: SUCCESS (1.332s)
[348.748119] Subtest bo-too-big: SUCCESS (5.281s)
[349.977408] [050/133] (669s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[350.043660] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[350.047758] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[350.250540] [051/133] (669s left) kms_cursor_legacy (single-bo)
[350.364814] Starting subtest: single-bo
[350.366798] Starting dynamic subtest: pipe-A
[355.799795] Dynamic subtest pipe-A: SUCCESS (5.378s)
[355.810652] Starting dynamic subtest: pipe-B
[361.128963] Dynamic subtest pipe-B: SUCCESS (5.379s)
[361.140204] Starting dynamic subtest: pipe-C
[366.562061] Dynamic subtest pipe-C: SUCCESS (5.379s)
[366.572732] Starting dynamic subtest: pipe-D
[371.944251] Dynamic subtest pipe-D: SUCCESS (5.379s)
[371.955193] Starting dynamic subtest: all-pipes
[377.333312] Dynamic subtest all-pipes: SUCCESS (5.386s)
[377.335734] Subtest single-bo: SUCCESS (26.914s)
[377.449744] [052/133] (642s left) kms_pm_rpm (basic-pci-d3-state)
[379.092989] Starting subtest: basic-pci-d3-state
[380.554123] Subtest basic-pci-d3-state: SUCCESS (1.464s)
[380.674619] [053/133] (639s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[380.797777] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[385.200943] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.407s)
[386.428370] [054/133] (633s left) kms_pm_rpm (legacy-planes)
[388.048600] Starting subtest: legacy-planes
[388.051062] Starting dynamic subtest: plane-63
[396.644448] Dynamic subtest plane-63: SUCCESS (8.595s)
[396.656261] Starting dynamic subtest: plane-93
[404.977357] Dynamic subtest plane-93: SUCCESS (8.329s)
[404.989771] Starting dynamic subtest: plane-123
[413.264484] Dynamic subtest plane-123: SUCCESS (8.285s)
[413.276075] Starting dynamic subtest: plane-133
[421.854691] Dynamic subtest plane-133: SUCCESS (8.587s)
[421.858676] Subtest legacy-planes: SUCCESS (33.807s)
[422.254428] [055/133] (597s left) prime_self_import (basic-with_one_bo)
[422.290097] Starting subtest: basic-with_one_bo
[422.304746] Subtest basic-with_one_bo: SUCCESS (0.017s)
[422.430423] [056/133] (597s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[422.523324] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[422.527628] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[422.656841] [057/133] (597s left) kms_flip (modeset-vs-vblank-race)
[422.749273] Starting subtest: modeset-vs-vblank-race
[422.751633] Starting dynamic subtest: A-eDP1
[427.452858] Dynamic subtest A-eDP1: SUCCESS (4.702s)
[427.463475] Starting dynamic subtest: B-eDP1
[432.187023] Dynamic subtest B-eDP1: SUCCESS (4.732s)
[432.198722] Starting dynamic subtest: C-eDP1
[436.807591] Dynamic subtest C-eDP1: SUCCESS (4.619s)
[436.820240] Starting dynamic subtest: D-eDP1
[441.364025] Dynamic subtest D-eDP1: SUCCESS (4.554s)
[441.369202] Subtest modeset-vs-vblank-race: SUCCESS (18.618s)
[442.554388] [058/133] (577s left) gem_lmem_swapping (heavy-verify-random-ccs)
[442.605764] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[442.650649] [059/133] (577s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[442.746167] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[442.750127] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[442.888666] [060/133] (577s left) kms_chamelium_color (gamma)
[442.990645] Subtest gamma: SKIP (0.000s)
[443.033366] [061/133] (577s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[443.159585] Starting subtest: cursorB-vs-flipA-varying-size
[443.164230] Subtest cursorB-vs-flipA-varying-size: SKIP (0.003s)
[443.347095] [062/133] (576s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[443.462783] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[447.917760] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.458s)
[449.063135] [063/133] (571s left) dumb_buffer (map-valid)
[449.120776] Starting subtest: map-valid
[449.123185] Subtest map-valid: SUCCESS (0.000s)
[449.253157] [064/133] (571s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[449.353915] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[449.356146] Starting dynamic subtest: pipe-A-default-mode
[449.668839] Dynamic subtest pipe-A-default-mode: SKIP (0.314s)
[449.673186] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.315s)
[450.484090] [065/133] (569s left) perf (i915-ref-count)
[450.574221] Starting subtest: i915-ref-count
[450.647076] Subtest i915-ref-count: SUCCESS (0.071s)
[450.703213] [066/133] (569s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[450.806788] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[450.811088] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[450.939080] [067/133] (569s left) gem_softpin (noreloc-interruptible)
[451.001171] Starting subtest: noreloc-interruptible
[456.461582] Subtest noreloc-interruptible: SUCCESS (5.397s)
[456.640488] [068/133] (563s left) kms_psr (fbc-psr2-primary-render)
[456.741142] Starting subtest: fbc-psr2-primary-render
[456.743402] Starting dynamic subtest: eDP-1
[456.747532] Dynamic subtest eDP-1: SKIP (0.000s)
[456.751623] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[456.833105] [069/133] (563s left) kms_lease (atomic-implicit-crtc)
[456.926717] Starting subtest: atomic-implicit-crtc
[456.928945] Starting dynamic subtest: pipe-A-eDP-1
[456.939758] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[456.949561] Starting dynamic subtest: pipe-B-eDP-1
[456.960307] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s)
[456.969312] Starting dynamic subtest: pipe-C-eDP-1
[456.979696] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[456.988288] Starting dynamic subtest: pipe-D-eDP-1
[456.998717] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[457.000790] Subtest atomic-implicit-crtc: SUCCESS (0.039s)
[457.106920] [070/133] (563s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[457.212096] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[457.594324] Starting dynamic subtest: pipe-A-eDP-1
[460.343294] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.748s)
[460.712492] Starting dynamic subtest: pipe-B-eDP-1
[463.461680] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.758s)
[463.831638] Starting dynamic subtest: pipe-C-eDP-1
[466.582781] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.757s)
[466.954908] Starting dynamic subtest: pipe-D-eDP-1
[469.708824] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.759s)
[469.711745] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.497s)
[470.914195] [071/133] (549s left) gem_exec_reloc (basic-wc-read-active)
[470.988959] Subtest basic-wc-read-active: SKIP (0.000s)
[471.074257] [072/133] (549s left) gem_readwrite (new-obj)
[471.145130] Subtest new-obj: SKIP (0.000s)
[471.242741] [073/133] (549s left) gem_mmap_gtt (basic-short)
[471.309278] Subtest basic-short: SKIP (0.000s)
[471.382847] [074/133] (549s left) kms_plane_multiple (tiling-yf)
[471.490023] Starting subtest: tiling-yf
[471.493940] Subtest tiling-yf: SKIP (0.000s)
[471.584314] [075/133] (549s left) kms_content_protection (dp-mst-type-0-hdcp14)
[471.739841] Starting subtest: dp-mst-type-0-hdcp14
[471.744465] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[471.915330] [076/133] (549s left) gem_ctx_shared (q-in-order)
[471.979025] Starting subtest: Q-in-order
[471.981057] Starting dynamic subtest: rcs0
[472.134737] Dynamic subtest rcs0: SUCCESS (0.158s)
[472.150403] Starting dynamic subtest: vcs0
[472.215769] Dynamic subtest vcs0: SUCCESS (0.080s)
[472.232503] Starting dynamic subtest: vcs1
[472.289722] Dynamic subtest vcs1: SUCCESS (0.073s)
[472.306990] Starting dynamic subtest: vecs0
[472.364850] Dynamic subtest vecs0: SUCCESS (0.074s)
[472.380672] Starting dynamic subtest: ccs0
[472.457185] Dynamic subtest ccs0: SUCCESS (0.091s)
[472.459777] Subtest Q-in-order: SUCCESS (0.481s)
[474.071615] [FACT gem_ctx_shared (q-in-order)] new: kernel.kmod_is_loaded.vgem: true
[474.074889] [077/133] (546s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[474.144815] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[474.247000] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.102s)
[474.356050] [078/133] (546s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[474.468241] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[481.181855] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.713s)
[481.355497] [079/133] (539s left) kms_big_fb (linear-8bpp-rotate-270)
[481.461374] Starting subtest: linear-8bpp-rotate-270
[481.482592] Subtest linear-8bpp-rotate-270: SKIP (0.021s)
[481.653330] [080/133] (539s left) api_intel_allocator (standalone)
[481.712083] Starting subtest: standalone
[481.726904] Subtest standalone: SUCCESS (0.016s)
[481.883530] [081/133] (539s left) core_auth (getclient-master-drop)
[481.920285] Starting subtest: getclient-master-drop
[481.944350] Subtest getclient-master-drop: SUCCESS (0.025s)
[482.084872] [082/133] (539s left) kms_psr (fbc-psr2-basic)
[482.174264] Starting subtest: fbc-psr2-basic
[482.176460] Starting dynamic subtest: eDP-1
[482.180828] Dynamic subtest eDP-1: SKIP (0.000s)
[482.185243] Subtest fbc-psr2-basic: SKIP (0.001s)
[482.268736] [083/133] (538s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[482.410233] Starting subtest: cursor-rapid-movement-32x32
[482.457625] Subtest cursor-rapid-movement-32x32: SKIP (0.043s)
[482.788416] [084/133] (538s left) gem_exec_schedule (noreorder-priority)
[482.975507] Starting subtest: noreorder-priority
[482.977933] Starting dynamic subtest: rcs0
[484.111247] Dynamic subtest rcs0: SUCCESS (1.135s)
[484.124061] Starting dynamic subtest: vcs0
[485.904996] Dynamic subtest vcs0: SUCCESS (1.791s)
[485.915836] Starting dynamic subtest: vcs1
[487.901831] Dynamic subtest vcs1: SUCCESS (1.993s)
[487.913882] Starting dynamic subtest: vecs0
[489.882286] Dynamic subtest vecs0: SUCCESS (1.978s)
[489.893802] Starting dynamic subtest: ccs0
[491.048261] Dynamic subtest ccs0: SUCCESS (1.164s)
[491.050886] Subtest noreorder-priority: SUCCESS (8.074s)
[491.254462] [085/133] (530s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[491.364046] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[491.366319] Starting dynamic subtest: pipe-A-eDP-1
[491.391668] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[491.403536] Starting dynamic subtest: pipe-B-eDP-1
[491.427418] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[491.437799] Starting dynamic subtest: pipe-C-eDP-1
[491.460680] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[491.468991] Starting dynamic subtest: pipe-D-eDP-1
[491.493218] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[491.497549] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[493.681283] [086/133] (527s left) core_auth (many-magics)
[493.743421] Starting subtest: many-magics
[494.647229] Subtest many-magics: SUCCESS (0.907s)
[494.744219] [087/133] (526s left) i915_suspend (fence-restore-tiled2untiled)
[494.803321] Starting subtest: fence-restore-tiled2untiled
[494.806875] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[494.934703] [088/133] (526s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[495.027136] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[495.028999] Starting dynamic subtest: pipe-A
[495.050547] Dynamic subtest pipe-A: SKIP (0.019s)
[495.059226] Starting dynamic subtest: pipe-B
[495.084779] Dynamic subtest pipe-B: SKIP (0.033s)
[495.093236] Starting dynamic subtest: pipe-C
[495.115823] Dynamic subtest pipe-C: SKIP (0.031s)
[495.124469] Starting dynamic subtest: pipe-D
[495.147372] Dynamic subtest pipe-D: SKIP (0.031s)
[495.151027] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.117s)
[495.271456] [089/133] (526s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[495.372897] Starting subtest: y-tiled-64bpp-rotate-0
[495.376558] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[495.501927] [090/133] (525s left) gem_ctx_persistence (saturated-hostile)
[495.575673] Starting subtest: saturated-hostile
[495.577718] Starting dynamic subtest: rcs0
[496.416948] Dynamic subtest rcs0: SUCCESS (0.840s)
[496.427991] Starting dynamic subtest: bcs0
[497.246707] Dynamic subtest bcs0: SUCCESS (0.828s)
[497.258639] Starting dynamic subtest: vcs0
[498.056234] Dynamic subtest vcs0: SUCCESS (0.808s)
[498.068216] Starting dynamic subtest: vcs1
[498.879914] Dynamic subtest vcs1: SUCCESS (0.822s)
[498.892174] Starting dynamic subtest: vecs0
[499.705936] Dynamic subtest vecs0: SUCCESS (0.824s)
[499.717614] Starting dynamic subtest: ccs0
[500.569260] Dynamic subtest ccs0: SUCCESS (0.861s)
[500.571697] Subtest saturated-hostile: SUCCESS (4.994s)
[500.673804] [091/133] (520s left) kms_prop_blob (invalid-get-prop)
[500.742571] Starting subtest: invalid-get-prop
[500.744494] Subtest invalid-get-prop: SUCCESS (0.000s)
[500.879185] [092/133] (520s left) gem_mmap_gtt (basic-write)
[500.939791] Subtest basic-write: SKIP (0.000s)
[501.012315] [093/133] (520s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[501.142451] Starting subtest: cursorA-vs-flipA-varying-size
[512.270053] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.125s)
[513.112205] [094/133] (508s left) gem_linear_blits (interruptible)
[513.508742] Starting subtest: interruptible
[517.800827] Subtest interruptible: SUCCESS (4.290s)
[517.941324] [095/133] (503s left) gem_exec_params (sol-reset-invalid)
[518.050783] Starting subtest: sol-reset-invalid
[518.056671] Subtest sol-reset-invalid: SUCCESS (0.003s)
[519.975970] [096/133] (501s left) kms_color_pipeline (plane-lut1d)
[520.088750] Starting subtest: plane-lut1d
[520.101619] Starting dynamic subtest: pipe-A-eDP-1
[520.846069] Dynamic subtest pipe-A-eDP-1: FAIL (0.356s)
[521.563191] Starting dynamic subtest: pipe-B-eDP-1
[522.392291] Dynamic subtest pipe-B-eDP-1: FAIL (0.313s)
[522.995437] Starting dynamic subtest: pipe-C-eDP-1
[523.818744] Dynamic subtest pipe-C-eDP-1: FAIL (0.235s)
[524.316090] Starting dynamic subtest: pipe-D-eDP-1
[525.144098] Dynamic subtest pipe-D-eDP-1: FAIL (0.246s)
[525.146449] Subtest plane-lut1d: FAIL (4.769s)
[525.722900] [097/133] (496s left) gem_wait (busy)
[525.793669] Starting subtest: busy
[525.796051] Starting dynamic subtest: all-engines
[527.892267] Dynamic subtest all-engines: SUCCESS (2.097s)
[527.904554] Starting dynamic subtest: rcs0
[528.434632] Dynamic subtest rcs0: SUCCESS (0.541s)
[528.446434] Starting dynamic subtest: bcs0
[528.975654] Dynamic subtest bcs0: SUCCESS (0.540s)
[528.987372] Starting dynamic subtest: vcs0
[530.900085] Dynamic subtest vcs0: SUCCESS (1.922s)
[530.912058] Starting dynamic subtest: vcs1
[532.884935] Dynamic subtest vcs1: SUCCESS (1.982s)
[532.896868] Starting dynamic subtest: vecs0
[534.867775] Dynamic subtest vecs0: SUCCESS (1.980s)
[534.879907] Starting dynamic subtest: ccs0
[535.410251] Dynamic subtest ccs0: SUCCESS (0.541s)
[535.412813] Subtest busy: SUCCESS (9.617s)
[535.632450] [098/133] (486s left) sriov_basic (enable-vfs-autoprobe-on)
[535.693180] Starting subtest: enable-vfs-autoprobe-on
[535.695467] Starting dynamic subtest: numvfs-1
[535.770627] Dynamic subtest numvfs-1: FAIL (0.009s)
[535.786182] Starting dynamic subtest: numvfs-2
[535.860055] Dynamic subtest numvfs-2: FAIL (0.004s)
[535.874753] Starting dynamic subtest: numvfs-3
[535.949539] Dynamic subtest numvfs-3: FAIL (0.004s)
[535.961481] Starting dynamic subtest: numvfs-4
[536.034911] Dynamic subtest numvfs-4: FAIL (0.004s)
[536.045274] Starting dynamic subtest: numvfs-5
[536.124236] Dynamic subtest numvfs-5: FAIL (0.005s)
[536.136071] Starting dynamic subtest: numvfs-6
[536.208215] Dynamic subtest numvfs-6: FAIL (0.004s)
[536.218781] Starting dynamic subtest: numvfs-7
[536.291363] Dynamic subtest numvfs-7: FAIL (0.003s)
[536.302031] Starting dynamic subtest: numvfs-random
[536.375072] Dynamic subtest numvfs-random: FAIL (0.003s)
[536.385656] Starting dynamic subtest: numvfs-all
[536.458608] Dynamic subtest numvfs-all: FAIL (0.533s)
[536.460938] Subtest enable-vfs-autoprobe-on: FAIL (0.579s)
[536.500215] [099/133] (485s left) kms_chamelium_frames (vga-frame-dump)
[536.902904] Subtest vga-frame-dump: SKIP (0.000s)
[537.701053] [100/133] (484s left) gem_eio (throttle)
[537.906069] Starting subtest: throttle
[538.172130] Subtest throttle: SUCCESS (0.267s)
[538.308712] [101/133] (483s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-mmap-wc)
[538.410649] Starting subtest: psr-abgr161616f-draw-mmap-wc
[538.414836] Subtest psr-abgr161616f-draw-mmap-wc: SKIP (0.000s)
[538.545631] [102/133] (483s left) gem_softpin (allocator-nopin)
[538.595075] Starting subtest: allocator-nopin
[538.688571] Subtest allocator-nopin: SUCCESS (0.093s)
[538.828352] [103/133] (483s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[538.937665] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[539.640218] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.703s)
[539.827198] [104/133] (482s left) kms_flip (busy-flip)
[539.930290] Starting subtest: busy-flip
[539.932504] Starting dynamic subtest: A-eDP1
[541.633795] Dynamic subtest A-eDP1: SUCCESS (1.702s)
[541.644769] Starting dynamic subtest: B-eDP1
[543.370125] Dynamic subtest B-eDP1: SUCCESS (1.735s)
[543.381088] Starting dynamic subtest: C-eDP1
[545.010467] Dynamic subtest C-eDP1: SUCCESS (1.638s)
[545.020219] Starting dynamic subtest: D-eDP1
[546.656216] Dynamic subtest D-eDP1: SUCCESS (1.644s)
[546.658722] Subtest busy-flip: SUCCESS (6.729s)
[547.856915] [105/133] (474s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[547.975492] Starting subtest: x-tiled-16bpp-rotate-270
[547.998440] Subtest x-tiled-16bpp-rotate-270: SKIP (0.020s)
[548.146260] [106/133] (473s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-render)
[548.253329] Starting subtest: fbcpsr-abgr161616f-draw-render
[548.257328] Subtest fbcpsr-abgr161616f-draw-render: SKIP (0.000s)
[548.388681] [107/133] (473s left) kms_getfb (getfb2-accept-nv12)
[548.479380] Starting subtest: getfb2-accept-nv12
[548.481734] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[548.622189] [108/133] (473s left) gem_ctx_exec (basic-nohangcheck)
[548.690842] Starting subtest: basic-nohangcheck
[548.943887] Subtest basic-nohangcheck: SUCCESS (0.255s)
[549.106479] [109/133] (473s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[549.231703] Starting subtest: short-flip-before-cursor-atomic-transitions
[550.186919] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.956s)
[551.095544] [110/133] (471s left) kms_cursor_crc (cursor-offscreen-256x256)
[551.346747] Starting subtest: cursor-offscreen-256x256
[551.352032] Starting dynamic subtest: pipe-A-eDP-1
[553.283453] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.932s)
[553.317929] Starting dynamic subtest: pipe-D-eDP-1
[555.868514] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.556s)
[555.870704] Subtest cursor-offscreen-256x256: SUCCESS (4.519s)
[556.759397] [111/133] (465s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[556.870627] Starting subtest: 4-tiled-8bpp-rotate-0
[558.106275] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.235s)
[558.253540] [112/133] (464s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[558.321656] Subtest writes-after-reads: SKIP (0.000s)
[558.386457] [113/133] (464s left) kms_frontbuffer_tracking (psr-slowdraw)
[558.495389] Starting subtest: psr-slowdraw
[583.785229] Subtest psr-slowdraw: SUCCESS (25.291s)
[583.942322] [114/133] (438s left) i915_pm_rc6_residency (rc6-idle)
[584.003167] Starting subtest: rc6-idle
[584.046627] Starting dynamic subtest: gt0-rcs0
[608.391046] Dynamic subtest gt0-rcs0: SUCCESS (24.343s)
[608.402706] Starting dynamic subtest: gt0-bcs0
[632.677245] Dynamic subtest gt0-bcs0: SUCCESS (24.283s)
[632.688567] Starting dynamic subtest: gt0-ccs0
[657.021470] Dynamic subtest gt0-ccs0: SUCCESS (24.342s)
[657.033353] Starting dynamic subtest: gt1-vcs0
[663.196433] Dynamic subtest gt1-vcs0: SUCCESS (6.170s)
[663.209179] Starting dynamic subtest: gt1-vecs0
[669.421211] Dynamic subtest gt1-vecs0: SUCCESS (6.170s)
[669.423791] Subtest rc6-idle: SUCCESS (85.366s)
[669.478764] [115/133] (353s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[669.582814] Starting subtest: fbc-modesetfrombusy
[673.400454] Subtest fbc-modesetfrombusy: SUCCESS (3.822s)
[674.598297] [116/133] (347s left) kms_psr (psr-cursor-render)
[674.695279] Starting subtest: psr-cursor-render
[674.697588] Starting dynamic subtest: eDP-1
[676.451520] Dynamic subtest eDP-1: SUCCESS (1.755s)
[676.453804] Subtest psr-cursor-render: SUCCESS (1.756s)
[677.349441] [117/133] (345s left) gem_exec_parallel (engines)
[677.422557] Starting subtest: engines
[677.424859] Starting dynamic subtest: basic
[678.999236] Dynamic subtest basic: SUCCESS (1.576s)
[679.011202] Starting dynamic subtest: contexts
[683.354446] Dynamic subtest contexts: SUCCESS (4.352s)
[683.366988] Starting dynamic subtest: fds
[687.147479] Dynamic subtest fds: SUCCESS (3.790s)
[687.160254] Starting dynamic subtest: userptr
[688.944531] Dynamic subtest userptr: SUCCESS (1.794s)
[688.946777] Subtest engines: SUCCESS (11.521s)
[689.156141] [118/133] (333s left) prime_busy (after)
[689.217249] Starting subtest: after
[689.222192] Starting dynamic subtest: rcs0
[689.251556] Dynamic subtest rcs0: SUCCESS (0.031s)
[689.262355] Starting dynamic subtest: bcs0
[689.309681] Dynamic subtest bcs0: SUCCESS (0.057s)
[689.320546] Starting dynamic subtest: vcs0
[689.351786] Dynamic subtest vcs0: SUCCESS (0.042s)
[689.362507] Starting dynamic subtest: vcs1
[689.394484] Dynamic subtest vcs1: SUCCESS (0.042s)
[689.403940] Starting dynamic subtest: vecs0
[689.435667] Dynamic subtest vecs0: SUCCESS (0.040s)
[689.445612] Starting dynamic subtest: ccs0
[689.477247] Dynamic subtest ccs0: SUCCESS (0.041s)
[689.585979] Subtest after: SUCCESS (0.367s)
[689.690312] [119/133] (332s left) gem_partial_pwrite_pread (write-display)
[689.760051] Subtest write-display: SKIP (0.000s)
[689.857124] [120/133] (332s left) gem_tiled_blits (basic)
[689.933898] Subtest basic: SKIP (0.000s)
[690.017727] [121/133] (332s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[690.124134] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[698.592057] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.470s)
[698.726542] [122/133] (324s left) sysfs_defaults (readonly)
[698.791053] Starting subtest: readonly
[698.793416] Starting dynamic subtest: vecs0
[698.795693] Dynamic subtest vecs0: SUCCESS (0.000s)
[698.805490] Starting dynamic subtest: ccs0
[698.807749] Dynamic subtest ccs0: SUCCESS (0.000s)
[698.817334] Starting dynamic subtest: vcs0
[698.819569] Dynamic subtest vcs0: SUCCESS (0.000s)
[698.829792] Starting dynamic subtest: bcs0
[698.832116] Dynamic subtest bcs0: SUCCESS (0.000s)
[698.843219] Starting dynamic subtest: rcs0
[698.845396] Dynamic subtest rcs0: SUCCESS (0.000s)
[698.854978] Starting dynamic subtest: vcs1
[698.856909] Dynamic subtest vcs1: SUCCESS (0.000s)
[698.859477] Subtest readonly: SUCCESS (0.006s)
[698.936216] [123/133] (323s left) kms_dsc (dsc-with-formats)
[699.040524] Starting subtest: dsc-with-formats
[699.078503] Subtest dsc-with-formats: SKIP (0.003s)
[699.142908] [124/133] (323s left) prime_mmap (test_reprime)
[699.200020] Starting subtest: test_reprime
[699.201901] Starting dynamic subtest: test_reprime-smem
[699.229463] Dynamic subtest test_reprime-smem: SUCCESS (0.031s)
[699.231871] Subtest test_reprime: SUCCESS (0.031s)
[699.365301] [125/133] (323s left) gem_exec_params (rsvd2-dirt)
[699.429332] Starting subtest: rsvd2-dirt
[699.433932] Subtest rsvd2-dirt: SKIP (0.000s)
[699.567653] [126/133] (323s left) kms_lease (lessee-list)
[699.658637] Starting subtest: lessee-list
[699.660482] Starting dynamic subtest: pipe-A-eDP-1
[699.662431] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[699.672334] Starting dynamic subtest: pipe-B-eDP-1
[699.673864] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[699.683069] Starting dynamic subtest: pipe-C-eDP-1
[699.684654] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[699.693558] Starting dynamic subtest: pipe-D-eDP-1
[699.695173] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[699.696697] Subtest lessee-list: SUCCESS (0.009s)
[699.815487] [127/133] (323s left) kms_vrr (flip-dpms)
[699.900017] Starting subtest: flip-dpms
[699.905237] Subtest flip-dpms: SKIP (0.000s)
[700.031618] [128/133] (323s left) kms_frontbuffer_tracking (fbc-1p-rte)
[700.138106] Starting subtest: fbc-1p-rte
[705.648030] Subtest fbc-1p-rte: SUCCESS (5.512s)
[706.796163] [129/133] (316s left) gen9_exec_parse (batch-zero-length)
[706.857459] Subtest batch-zero-length: SKIP (0.000s)
[706.937202] [130/133] (316s left) prime_mmap (test_aperture_limit)
[706.987567] Starting subtest: test_aperture_limit
[706.989860] Starting dynamic subtest: test_aperture_limit-smem
[706.996991] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[707.001113] Subtest test_aperture_limit: SKIP (0.008s)
[707.121716] [131/133] (316s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[707.234978] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[707.239412] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[707.377887] [132/133] (315s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[707.476187] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[707.480497] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[707.601388] [133/133] (315s left) gem_exec_fence (long-history)
[708.082319] Starting subtest: long-history
[715.628916] Subtest long-history: SUCCESS (7.547s)
[716.228591] 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.