[58.159970] Initializing watchdogs
[58.160033]   /dev/watchdog0
[58.173122] [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]
[58.177405] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.179501] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.182572] [001/133] (960s left) gem_create (create-ext-placement-all)
[58.378439] Starting subtest: create-ext-placement-all
[58.380931] Subtest create-ext-placement-all: SUCCESS (0.000s)
[58.517280] [002/133] (960s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[58.576871] Starting subtest: map-fixed-invalidate-overlap
[58.581366] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[58.748114] [003/133] (960s left) gem_pipe_control_store_loop (fresh-buffer)
[58.802764] Starting subtest: fresh-buffer
[60.958419] Subtest fresh-buffer: SUCCESS (2.154s)
[61.100684] [004/133] (957s left) gem_mmap_offset (mmap-boundaries)
[61.148742] Starting subtest: mmap-boundaries
[61.150687] Starting dynamic subtest: smem0
[61.424516] Dynamic subtest smem0: SUCCESS (0.278s)
[61.426935] Subtest mmap-boundaries: SUCCESS (0.278s)
[61.576540] [005/133] (957s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[61.685568] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[69.156229] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.474s)
[69.324010] [006/133] (949s left) kms_atomic (atomic-plane-damage)
[69.423106] Starting subtest: atomic-plane-damage
[69.498326] Starting dynamic subtest: pipe-A-eDP-1
[70.036253] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.537s)
[70.038777] Subtest atomic-plane-damage: SUCCESS (0.612s)
[70.929944] [007/133] (947s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[71.022049] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[71.024290] Starting dynamic subtest: pipe-A-eDP-1
[71.082093] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[71.089185] Starting dynamic subtest: pipe-B-eDP-1
[71.140728] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.058s)
[71.148541] Starting dynamic subtest: pipe-C-eDP-1
[71.199855] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.058s)
[71.207455] Starting dynamic subtest: pipe-D-eDP-1
[71.258624] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.058s)
[71.260941] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.239s)
[73.496130] [008/133] (945s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[73.597234] Starting subtest: psr-rgb101010-draw-mmap-wc
[80.505625] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (6.911s)
[80.663155] [009/133] (938s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[80.727252] Starting subtest: yf-tiled-to-vebox-x-tiled
[80.731323] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[80.931204] [010/133] (938s left) syncobj_timeline (wait-all-complex)
[80.987962] Starting subtest: wait-all-complex
[81.200584] Subtest wait-all-complex: SUCCESS (0.212s)
[81.294366] [011/133] (937s left) gem_pxp (create-valid-protected-context)
[81.438836] Starting subtest: create-valid-protected-context
[81.441773] Subtest create-valid-protected-context: SUCCESS (0.002s)
[81.582128] [012/133] (937s left) gem_exec_flush (basic-wb-rw-default)
[81.656055] Starting subtest: basic-wb-rw-default
[87.100788] Subtest basic-wb-rw-default: SUCCESS (5.445s)
[87.306963] [013/133] (931s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[87.407587] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[87.410010] Starting dynamic subtest: pipe-A-eDP-1
[87.430672] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[87.440143] Starting dynamic subtest: pipe-B-eDP-1
[87.458874] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[87.466355] Starting dynamic subtest: pipe-C-eDP-1
[87.485959] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[87.493984] Starting dynamic subtest: pipe-D-eDP-1
[87.512381] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[87.514180] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[89.586479] [014/133] (929s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[89.699812] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[93.823341] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.128s)
[95.000279] [015/133] (924s left) kms_cursor_edge_walk (256x256-top-bottom)
[95.106500] Starting subtest: 256x256-top-bottom
[95.109039] Starting dynamic subtest: pipe-A-eDP-1
[98.542314] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.436s)
[98.551314] Starting dynamic subtest: pipe-D-eDP-1
[101.646399] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.105s)
[101.648710] Subtest 256x256-top-bottom: SUCCESS (6.542s)
[102.492221] [016/133] (916s left) kms_force_connector_basic (force-load-detect)
[102.577758] Starting subtest: force-load-detect
[102.581973] Subtest force-load-detect: SKIP (0.000s)
[102.712180] [017/133] (916s left) syncobj_wait (invalid-signal-zero-handles)
[102.769124] Starting subtest: invalid-signal-zero-handles
[102.771307] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[102.875236] [018/133] (916s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[107.843825] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[107.846190] Starting dynamic subtest: pipe-A-eDP-1
[108.635063] Dynamic subtest pipe-A-eDP-1: SKIP (0.786s)
[108.644403] Starting dynamic subtest: pipe-B-eDP-1
[109.768736] Dynamic subtest pipe-B-eDP-1: SKIP (1.132s)
[109.773325] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.921s)
[111.058250] [019/133] (908s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[111.166521] Starting subtest: fbcpsr-rgb565-draw-render
[118.170406] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.008s)
[118.324542] [020/133] (901s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[118.430631] Starting subtest: primary-4-tiled-reflect-x-0
[125.510086] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.082s)
[126.745275] [021/133] (892s left) kms_setmode (clone-exclusive-crtc)
[126.808860] Starting subtest: clone-exclusive-crtc
[126.815184] Subtest clone-exclusive-crtc: SKIP (0.000s)
[126.953583] [022/133] (892s left) kms_addfb_basic (too-high)
[127.044844] Starting subtest: too-high
[127.047105] Subtest too-high: SUCCESS (0.001s)
[127.154024] [023/133] (892s left) perf_pmu (busy-accuracy-2)
[127.200632] Starting subtest: busy-accuracy-2
[127.202752] Starting dynamic subtest: rcs0
[130.240784] Dynamic subtest rcs0: SUCCESS (3.040s)
[130.248066] Starting dynamic subtest: bcs0
[133.305589] Dynamic subtest bcs0: SUCCESS (3.063s)
[133.315445] Starting dynamic subtest: vcs0
[136.349292] Dynamic subtest vcs0: SUCCESS (3.042s)
[136.359630] Starting dynamic subtest: vcs1
[139.397087] Dynamic subtest vcs1: SUCCESS (3.046s)
[139.407179] Starting dynamic subtest: vecs0
[142.443059] Dynamic subtest vecs0: SUCCESS (3.044s)
[142.454525] Starting dynamic subtest: ccs0
[145.502073] Dynamic subtest ccs0: SUCCESS (3.057s)
[145.504556] Subtest busy-accuracy-2: SUCCESS (18.301s)
[145.661699] [024/133] (873s left) kms_psr (pr-primary-mmap-gtt)
[145.769935] Starting subtest: pr-primary-mmap-gtt
[145.774221] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[145.864093] [025/133] (873s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[145.968060] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[145.972052] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[146.079303] [026/133] (873s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[146.184454] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[146.188734] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[146.310913] [027/133] (873s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[146.408540] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[146.410694] Starting dynamic subtest: pipe-A-default-mode
[149.145249] Dynamic subtest pipe-A-default-mode: SUCCESS (2.736s)
[149.147432] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.737s)
[150.037644] [028/133] (869s left) i915_drm_fdinfo (idle)
[150.091442] Starting subtest: idle
[150.093948] Starting dynamic subtest: rcs0
[150.702878] Dynamic subtest rcs0: SUCCESS (0.611s)
[150.712879] Starting dynamic subtest: bcs0
[151.209998] Dynamic subtest bcs0: SUCCESS (0.504s)
[151.220668] Starting dynamic subtest: vcs0
[151.717498] Dynamic subtest vcs0: SUCCESS (0.505s)
[151.728457] Starting dynamic subtest: vcs1
[152.222816] Dynamic subtest vcs1: SUCCESS (0.503s)
[152.233678] Starting dynamic subtest: vecs0
[152.728783] Dynamic subtest vecs0: SUCCESS (0.503s)
[152.739711] Starting dynamic subtest: ccs0
[153.235557] Dynamic subtest ccs0: SUCCESS (0.504s)
[153.238086] Subtest idle: SUCCESS (3.144s)
[153.333559] [029/133] (866s left) core_setmaster (master-drop-set-shared-fd)
[153.443140] Starting subtest: master-drop-set-shared-fd
[153.465479] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[153.502886] [030/133] (866s left) kms_chamelium_color (ctm-negative)
[153.594275] Subtest ctm-negative: SKIP (0.000s)
[153.638929] [031/133] (866s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[153.706368] Starting subtest: multi-wait-for-submit-available-submitted
[153.708791] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[153.829924] [032/133] (866s left) syncobj_timeline (invalid-signal-illegal-point)
[153.889295] Starting subtest: invalid-signal-illegal-point
[153.891300] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[154.003315] [033/133] (865s left) gem_mmap (bad-offset)
[154.060612] Subtest bad-offset: SKIP (0.000s)
[154.122791] [034/133] (865s left) i915_hangman (gt-error-state-capture)
[154.200426] Starting subtest: gt-error-state-capture
[154.202789] Starting dynamic subtest: rcs0
[165.876625] Dynamic subtest rcs0: SUCCESS (11.675s)
[165.887901] Starting dynamic subtest: bcs0
[177.843901] Dynamic subtest bcs0: SUCCESS (11.965s)
[177.855596] Starting dynamic subtest: vcs0
[189.876228] Dynamic subtest vcs0: SUCCESS (12.030s)
[189.887940] Starting dynamic subtest: vcs1
[201.846448] Dynamic subtest vcs1: SUCCESS (11.967s)
[201.857335] Starting dynamic subtest: vecs0
[213.811638] Dynamic subtest vecs0: SUCCESS (11.964s)
[213.822892] Starting dynamic subtest: ccs0
[224.884671] Dynamic subtest ccs0: SUCCESS (11.070s)
[224.887606] Subtest gt-error-state-capture: SUCCESS (70.684s)
[225.028371] [035/133] (794s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[225.147414] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[225.149622] Starting dynamic subtest: pipe-A-eDP-1
[225.158688] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[225.167779] Starting dynamic subtest: pipe-B-eDP-1
[225.176899] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[225.184769] Starting dynamic subtest: pipe-C-eDP-1
[225.193627] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[225.201718] Starting dynamic subtest: pipe-D-eDP-1
[225.210537] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[225.214958] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[227.410558] [036/133] (792s left) gem_exec_whisper (basic-fds)
[227.494553] Starting subtest: basic-fds
[234.721658] Subtest basic-fds: SUCCESS (7.225s)
[234.935289] [037/133] (785s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[235.039417] Starting subtest: psr-1p-primscrn-cur-indfb-move
[242.350708] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.313s)
[242.517096] [038/133] (777s left) gem_exec_schedule (preempt-user)
[242.592688] Starting subtest: preempt-user
[242.594682] Starting dynamic subtest: rcs0
[242.607549] Dynamic subtest rcs0: SUCCESS (0.024s)
[242.616227] Starting dynamic subtest: bcs0
[242.625339] Dynamic subtest bcs0: SUCCESS (0.017s)
[242.633661] Starting dynamic subtest: vcs0
[242.644688] Dynamic subtest vcs0: SUCCESS (0.019s)
[242.652872] Starting dynamic subtest: vcs1
[242.663345] Dynamic subtest vcs1: SUCCESS (0.018s)
[242.671420] Starting dynamic subtest: vecs0
[242.682518] Dynamic subtest vecs0: SUCCESS (0.019s)
[242.690725] Starting dynamic subtest: ccs0
[242.703319] Dynamic subtest ccs0: SUCCESS (0.020s)
[242.705557] Subtest preempt-user: SUCCESS (0.120s)
[244.023699] [039/133] (776s left) kms_psr (psr2-primary-mmap-cpu)
[244.115051] Starting subtest: psr2-primary-mmap-cpu
[244.117184] Starting dynamic subtest: eDP-1
[245.811070] Dynamic subtest eDP-1: SUCCESS (1.696s)
[245.813378] Subtest psr2-primary-mmap-cpu: SUCCESS (1.697s)
[246.706135] [040/133] (773s left) gem_ctx_param (invalid-size-set)
[246.762959] Starting subtest: invalid-size-set
[246.765419] Subtest invalid-size-set: SUCCESS (0.001s)
[246.909928] [041/133] (773s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[247.011376] Starting subtest: bad-aux-stride-y-tiled-ccs
[247.013599] Starting dynamic subtest: pipe-A-eDP-1
[247.036100] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[247.045587] Starting dynamic subtest: pipe-B-eDP-1
[247.067213] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[247.075082] Starting dynamic subtest: pipe-C-eDP-1
[247.096605] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[247.104722] Starting dynamic subtest: pipe-D-eDP-1
[247.126789] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[247.130893] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[249.284474] [042/133] (770s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[249.387357] Starting subtest: blocking-absolute-wf_vblank-interruptible
[249.389721] Starting dynamic subtest: A-eDP1
[258.131655] Dynamic subtest A-eDP1: SUCCESS (8.743s)
[258.142175] Starting dynamic subtest: B-eDP1
[266.865412] Dynamic subtest B-eDP1: SUCCESS (8.733s)
[266.875654] Starting dynamic subtest: C-eDP1
[275.583381] Dynamic subtest C-eDP1: SUCCESS (8.716s)
[275.593600] Starting dynamic subtest: D-eDP1
[284.312775] Dynamic subtest D-eDP1: SUCCESS (8.727s)
[284.319065] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.930s)
[285.556728] [043/133] (734s left) kms_psr2_su (page_flip-nv12)
[285.616238] Subtest page_flip-NV12: SKIP (0.000s)
[285.679868] [044/133] (734s left) gem_exec_balancer (sliced)
[285.759399] Starting subtest: sliced
[285.763668] Subtest sliced: SKIP (0.000s)
[286.071917] [045/133] (734s left) kms_plane_lowres (tiling-x)
[286.174308] Starting subtest: tiling-x
[286.176567] Starting dynamic subtest: pipe-A-eDP-1
[286.181081] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[286.471085] Starting dynamic subtest: pipe-B-eDP-1
[286.475800] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[286.484461] Starting dynamic subtest: pipe-C-eDP-1
[286.489293] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[286.498225] Starting dynamic subtest: pipe-D-eDP-1
[286.502107] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[286.506110] Subtest tiling-x: SKIP (0.295s)
[287.288297] [046/133] (733s left) kms_vblank (query-busy-hang)
[287.384356] Starting subtest: query-busy-hang
[287.386306] Starting dynamic subtest: pipe-A-eDP-1
[313.676687] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.291s)
[313.691494] Starting dynamic subtest: pipe-D-eDP-1
[338.654805] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.973s)
[338.657682] Subtest query-busy-hang: SUCCESS (51.270s)
[339.554618] [047/133] (680s left) gem_exec_balancer (hang)
[339.812012] Starting subtest: hang
[341.947539] Subtest hang: SUCCESS (2.139s)
[342.119150] [048/133] (678s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[342.227443] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[342.231419] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[342.365285] [049/133] (678s left) kms_flip (bo-too-big)
[342.464993] Starting subtest: bo-too-big
[342.467298] Starting dynamic subtest: A-eDP1
[343.786586] Dynamic subtest A-eDP1: SUCCESS (1.324s)
[343.796909] Starting dynamic subtest: B-eDP1
[345.110245] Dynamic subtest B-eDP1: SUCCESS (1.322s)
[345.121418] Starting dynamic subtest: C-eDP1
[346.361328] Dynamic subtest C-eDP1: SUCCESS (1.250s)
[346.369760] Starting dynamic subtest: D-eDP1
[347.685856] Dynamic subtest D-eDP1: SUCCESS (1.324s)
[347.690898] Subtest bo-too-big: SUCCESS (5.230s)
[348.908542] [050/133] (671s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[348.980645] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[348.984971] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[349.185776] [051/133] (671s left) kms_cursor_legacy (single-bo)
[349.311838] Starting subtest: single-bo
[349.314402] Starting dynamic subtest: pipe-A
[354.693899] Dynamic subtest pipe-A: SUCCESS (5.379s)
[354.705621] Starting dynamic subtest: pipe-B
[360.075912] Dynamic subtest pipe-B: SUCCESS (5.380s)
[360.086298] Starting dynamic subtest: pipe-C
[365.457585] Dynamic subtest pipe-C: SUCCESS (5.379s)
[365.468253] Starting dynamic subtest: pipe-D
[370.839666] Dynamic subtest pipe-D: SUCCESS (5.379s)
[370.850113] Starting dynamic subtest: all-pipes
[376.227836] Dynamic subtest all-pipes: SUCCESS (5.386s)
[376.230161] Subtest single-bo: SUCCESS (26.914s)
[376.395664] [052/133] (644s left) kms_pm_rpm (basic-pci-d3-state)
[377.933070] Starting subtest: basic-pci-d3-state
[379.417875] Subtest basic-pci-d3-state: SUCCESS (1.483s)
[379.519378] [053/133] (641s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[379.623768] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[383.935566] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.314s)
[385.099478] [054/133] (635s left) kms_pm_rpm (legacy-planes)
[387.026769] Starting subtest: legacy-planes
[387.028762] Starting dynamic subtest: plane-63
[395.353319] Dynamic subtest plane-63: SUCCESS (8.328s)
[395.363914] Starting dynamic subtest: plane-93
[404.054826] Dynamic subtest plane-93: SUCCESS (8.699s)
[404.066548] Starting dynamic subtest: plane-123
[412.348722] Dynamic subtest plane-123: SUCCESS (8.291s)
[412.359663] Starting dynamic subtest: plane-133
[420.630083] Dynamic subtest plane-133: SUCCESS (8.280s)
[420.632528] Subtest legacy-planes: SUCCESS (33.607s)
[421.019247] [055/133] (599s left) prime_self_import (basic-with_one_bo)
[421.058087] Starting subtest: basic-with_one_bo
[421.087256] Subtest basic-with_one_bo: SUCCESS (0.031s)
[421.233251] [056/133] (599s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[421.329275] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[421.333167] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[421.459152] [057/133] (599s left) kms_flip (modeset-vs-vblank-race)
[421.564107] Starting subtest: modeset-vs-vblank-race
[421.566238] Starting dynamic subtest: A-eDP1
[426.229730] Dynamic subtest A-eDP1: SUCCESS (4.667s)
[426.240524] Starting dynamic subtest: B-eDP1
[430.958152] Dynamic subtest B-eDP1: SUCCESS (4.726s)
[430.979035] Starting dynamic subtest: C-eDP1
[435.560660] Dynamic subtest C-eDP1: SUCCESS (4.600s)
[435.574029] Starting dynamic subtest: D-eDP1
[440.122939] Dynamic subtest D-eDP1: SUCCESS (4.558s)
[440.129085] Subtest modeset-vs-vblank-race: SUCCESS (18.565s)
[441.335436] [058/133] (579s left) gem_lmem_swapping (heavy-verify-random-ccs)
[441.393073] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[441.452302] [059/133] (579s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[441.560427] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[441.564741] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[441.697074] [060/133] (579s left) kms_chamelium_color (gamma)
[441.796571] Subtest gamma: SKIP (0.000s)
[441.863072] [061/133] (579s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[441.983478] Starting subtest: cursorB-vs-flipA-varying-size
[441.988074] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[442.166152] [062/133] (578s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[442.271194] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[446.741404] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.472s)
[447.937990] [063/133] (573s left) dumb_buffer (map-valid)
[448.003209] Starting subtest: map-valid
[448.005153] Subtest map-valid: SUCCESS (0.000s)
[448.143111] [064/133] (573s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[448.244854] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[448.247153] Starting dynamic subtest: pipe-A-default-mode
[448.557235] Dynamic subtest pipe-A-default-mode: SKIP (0.311s)
[448.561689] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.313s)
[449.363827] [065/133] (571s left) perf (i915-ref-count)
[449.455828] Starting subtest: i915-ref-count
[449.514547] Subtest i915-ref-count: SUCCESS (0.057s)
[449.568424] [066/133] (571s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[449.664461] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[449.668757] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[449.784619] [067/133] (571s left) gem_softpin (noreloc-interruptible)
[449.852285] Starting subtest: noreloc-interruptible
[455.258832] Subtest noreloc-interruptible: SUCCESS (5.404s)
[455.406713] [068/133] (565s left) kms_psr (fbc-psr2-primary-render)
[455.507058] Starting subtest: fbc-psr2-primary-render
[455.509381] Starting dynamic subtest: eDP-1
[455.513795] Dynamic subtest eDP-1: SKIP (0.000s)
[455.518326] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[455.602484] [069/133] (565s left) kms_lease (atomic-implicit-crtc)
[455.695284] Starting subtest: atomic-implicit-crtc
[455.697728] Starting dynamic subtest: pipe-A-eDP-1
[455.708762] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[455.717930] Starting dynamic subtest: pipe-B-eDP-1
[455.728684] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[455.737107] Starting dynamic subtest: pipe-C-eDP-1
[455.747487] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[455.755620] Starting dynamic subtest: pipe-D-eDP-1
[455.765913] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[455.767795] Subtest atomic-implicit-crtc: SUCCESS (0.034s)
[455.869195] [070/133] (565s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[455.963724] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[456.339797] Starting dynamic subtest: pipe-A-eDP-1
[459.105416] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.764s)
[459.465799] Starting dynamic subtest: pipe-B-eDP-1
[462.237106] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.777s)
[462.607810] Starting dynamic subtest: pipe-C-eDP-1
[465.365021] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.769s)
[465.728477] Starting dynamic subtest: pipe-D-eDP-1
[468.496888] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.774s)
[468.499340] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.535s)
[469.700089] [071/133] (551s left) gem_exec_reloc (basic-wc-read-active)
[469.775094] Subtest basic-wc-read-active: SKIP (0.000s)
[469.839395] [072/133] (551s left) gem_readwrite (new-obj)
[469.890193] Subtest new-obj: SKIP (0.000s)
[469.952172] [073/133] (551s left) gem_mmap_gtt (basic-short)
[469.998867] Subtest basic-short: SKIP (0.000s)
[470.063476] [074/133] (551s left) kms_plane_multiple (tiling-yf)
[470.171133] Starting subtest: tiling-yf
[470.175599] Subtest tiling-yf: SKIP (0.000s)
[470.265334] [075/133] (551s left) kms_content_protection (dp-mst-type-0-hdcp14)
[470.413139] Starting subtest: dp-mst-type-0-hdcp14
[470.417619] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[470.587997] [076/133] (551s left) gem_ctx_shared (q-in-order)
[470.663097] Starting subtest: Q-in-order
[470.664978] Starting dynamic subtest: rcs0
[470.802475] Dynamic subtest rcs0: SUCCESS (0.141s)
[470.817610] Starting dynamic subtest: vcs0
[470.876542] Dynamic subtest vcs0: SUCCESS (0.073s)
[470.891953] Starting dynamic subtest: vcs1
[470.950609] Dynamic subtest vcs1: SUCCESS (0.074s)
[470.965787] Starting dynamic subtest: vecs0
[471.026341] Dynamic subtest vecs0: SUCCESS (0.075s)
[471.041974] Starting dynamic subtest: ccs0
[471.113322] Dynamic subtest ccs0: SUCCESS (0.086s)
[471.115842] Subtest Q-in-order: SUCCESS (0.452s)
[472.021140] [FACT gem_ctx_shared (q-in-order)] new: kernel.kmod_is_loaded.vgem: true
[472.024606] [077/133] (549s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[472.084039] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[472.185057] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[472.284730] [078/133] (549s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[472.393477] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[478.961024] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.577s)
[479.135011] [079/133] (542s left) kms_big_fb (linear-8bpp-rotate-270)
[479.232054] Starting subtest: linear-8bpp-rotate-270
[479.252682] Subtest linear-8bpp-rotate-270: SKIP (0.020s)
[479.402936] [080/133] (542s left) api_intel_allocator (standalone)
[479.461507] Starting subtest: standalone
[479.473801] Subtest standalone: SUCCESS (0.015s)
[479.628705] [081/133] (542s left) core_auth (getclient-master-drop)
[479.663599] Starting subtest: getclient-master-drop
[479.685874] Subtest getclient-master-drop: SUCCESS (0.025s)
[479.858218] [082/133] (542s left) kms_psr (fbc-psr2-basic)
[479.959416] Starting subtest: fbc-psr2-basic
[479.961612] Starting dynamic subtest: eDP-1
[479.966016] Dynamic subtest eDP-1: SKIP (0.000s)
[479.970377] Subtest fbc-psr2-basic: SKIP (0.001s)
[480.053993] [083/133] (541s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[480.195252] Starting subtest: cursor-rapid-movement-32x32
[480.239475] Subtest cursor-rapid-movement-32x32: SKIP (0.040s)
[480.564698] [084/133] (541s left) gem_exec_schedule (noreorder-priority)
[480.750035] Starting subtest: noreorder-priority
[480.752740] Starting dynamic subtest: rcs0
[481.912899] Dynamic subtest rcs0: SUCCESS (1.163s)
[481.923198] Starting dynamic subtest: vcs0
[483.952274] Dynamic subtest vcs0: SUCCESS (2.035s)
[483.963068] Starting dynamic subtest: vcs1
[485.936406] Dynamic subtest vcs1: SUCCESS (1.981s)
[485.948591] Starting dynamic subtest: vecs0
[487.913737] Dynamic subtest vecs0: SUCCESS (1.974s)
[487.926322] Starting dynamic subtest: ccs0
[489.089238] Dynamic subtest ccs0: SUCCESS (1.174s)
[489.091879] Subtest noreorder-priority: SUCCESS (8.340s)
[489.302434] [085/133] (532s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[489.410912] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[489.413230] Starting dynamic subtest: pipe-A-eDP-1
[489.438056] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[489.449479] Starting dynamic subtest: pipe-B-eDP-1
[489.473933] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[489.484651] Starting dynamic subtest: pipe-C-eDP-1
[489.507867] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[489.517474] Starting dynamic subtest: pipe-D-eDP-1
[489.543288] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[489.547537] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.008s)
[491.598925] [086/133] (530s left) core_auth (many-magics)
[491.656037] Starting subtest: many-magics
[492.521630] Subtest many-magics: SUCCESS (0.868s)
[492.621418] [087/133] (529s left) i915_suspend (fence-restore-tiled2untiled)
[492.687214] Starting subtest: fence-restore-tiled2untiled
[492.690615] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[492.812554] [088/133] (529s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[492.911467] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[492.913346] Starting dynamic subtest: pipe-A
[492.932434] Dynamic subtest pipe-A: SKIP (0.018s)
[492.941067] Starting dynamic subtest: pipe-B
[492.967380] Dynamic subtest pipe-B: SKIP (0.033s)
[492.975896] Starting dynamic subtest: pipe-C
[492.997347] Dynamic subtest pipe-C: SKIP (0.031s)
[493.005526] Starting dynamic subtest: pipe-D
[493.029323] Dynamic subtest pipe-D: SKIP (0.030s)
[493.032397] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.116s)
[493.164809] [089/133] (529s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[493.268293] Starting subtest: y-tiled-64bpp-rotate-0
[493.271758] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[493.408406] [090/133] (528s left) gem_ctx_persistence (saturated-hostile)
[493.474074] Starting subtest: saturated-hostile
[493.475942] Starting dynamic subtest: rcs0
[494.350864] Dynamic subtest rcs0: SUCCESS (0.876s)
[494.362293] Starting dynamic subtest: bcs0
[495.168328] Dynamic subtest bcs0: SUCCESS (0.816s)
[495.179064] Starting dynamic subtest: vcs0
[495.965930] Dynamic subtest vcs0: SUCCESS (0.796s)
[495.976704] Starting dynamic subtest: vcs1
[496.785466] Dynamic subtest vcs1: SUCCESS (0.817s)
[496.796223] Starting dynamic subtest: vecs0
[497.606182] Dynamic subtest vecs0: SUCCESS (0.819s)
[497.617480] Starting dynamic subtest: ccs0
[498.471221] Dynamic subtest ccs0: SUCCESS (0.863s)
[498.473688] Subtest saturated-hostile: SUCCESS (4.998s)
[498.585318] [091/133] (523s left) kms_prop_blob (invalid-get-prop)
[498.646676] Starting subtest: invalid-get-prop
[498.649071] Subtest invalid-get-prop: SUCCESS (0.000s)
[498.808930] [092/133] (523s left) gem_mmap_gtt (basic-write)
[498.871682] Subtest basic-write: SKIP (0.000s)
[498.950634] [093/133] (523s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[499.077671] Starting subtest: cursorA-vs-flipA-varying-size
[510.194289] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.115s)
[511.054644] [094/133] (511s left) gem_linear_blits (interruptible)
[511.419605] Starting subtest: interruptible
[515.660032] Subtest interruptible: SUCCESS (4.239s)
[515.847948] [095/133] (506s left) gem_exec_params (sol-reset-invalid)
[515.967975] Starting subtest: sol-reset-invalid
[515.972539] Subtest sol-reset-invalid: SUCCESS (0.004s)
[517.988712] [096/133] (504s left) kms_color_pipeline (plane-lut1d)
[518.100740] Starting subtest: plane-lut1d
[518.114353] Starting dynamic subtest: pipe-A-eDP-1
[518.824752] Dynamic subtest pipe-A-eDP-1: FAIL (0.320s)
[519.482963] Starting dynamic subtest: pipe-B-eDP-1
[520.266349] Dynamic subtest pipe-B-eDP-1: FAIL (0.280s)
[520.826725] Starting dynamic subtest: pipe-C-eDP-1
[521.653772] Dynamic subtest pipe-C-eDP-1: FAIL (0.235s)
[522.162448] Starting dynamic subtest: pipe-D-eDP-1
[523.018067] Dynamic subtest pipe-D-eDP-1: FAIL (0.267s)
[523.020112] Subtest plane-lut1d: FAIL (4.612s)
[523.562886] [097/133] (499s left) gem_wait (busy)
[523.625407] Starting subtest: busy
[523.627817] Starting dynamic subtest: all-engines
[524.950023] Dynamic subtest all-engines: SUCCESS (1.323s)
[524.961935] Starting dynamic subtest: rcs0
[525.493494] Dynamic subtest rcs0: SUCCESS (0.541s)
[525.504592] Starting dynamic subtest: bcs0
[526.033532] Dynamic subtest bcs0: SUCCESS (0.539s)
[526.043835] Starting dynamic subtest: vcs0
[527.895361] Dynamic subtest vcs0: SUCCESS (1.859s)
[527.911289] Starting dynamic subtest: vcs1
[529.877349] Dynamic subtest vcs1: SUCCESS (1.979s)
[529.889366] Starting dynamic subtest: vecs0
[531.925083] Dynamic subtest vecs0: SUCCESS (2.045s)
[531.937786] Starting dynamic subtest: ccs0
[532.467495] Dynamic subtest ccs0: SUCCESS (0.541s)
[532.469893] Subtest busy: SUCCESS (8.842s)
[532.690536] [098/133] (489s left) sriov_basic (enable-vfs-autoprobe-on)
[532.752815] Starting subtest: enable-vfs-autoprobe-on
[532.755151] Starting dynamic subtest: numvfs-1
[532.828646] Dynamic subtest numvfs-1: FAIL (0.005s)
[532.839344] Starting dynamic subtest: numvfs-2
[532.911434] Dynamic subtest numvfs-2: FAIL (0.004s)
[532.922071] Starting dynamic subtest: numvfs-3
[532.994869] Dynamic subtest numvfs-3: FAIL (0.003s)
[533.005478] Starting dynamic subtest: numvfs-4
[533.077894] Dynamic subtest numvfs-4: FAIL (0.003s)
[533.088071] Starting dynamic subtest: numvfs-5
[533.159454] Dynamic subtest numvfs-5: FAIL (0.003s)
[533.169354] Starting dynamic subtest: numvfs-6
[533.242176] Dynamic subtest numvfs-6: FAIL (0.004s)
[533.252801] Starting dynamic subtest: numvfs-7
[533.326493] Dynamic subtest numvfs-7: FAIL (0.003s)
[533.337506] Starting dynamic subtest: numvfs-random
[533.409596] Dynamic subtest numvfs-random: FAIL (0.004s)
[533.419984] Starting dynamic subtest: numvfs-all
[533.493502] Dynamic subtest numvfs-all: FAIL (0.510s)
[533.495542] Subtest enable-vfs-autoprobe-on: FAIL (0.549s)
[533.534981] [099/133] (489s left) kms_chamelium_frames (vga-frame-dump)
[533.941779] Subtest vga-frame-dump: SKIP (0.000s)
[534.748139] [100/133] (487s left) gem_eio (throttle)
[534.946526] Starting subtest: throttle
[535.201257] Subtest throttle: SUCCESS (0.256s)
[535.376026] [101/133] (487s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-mmap-wc)
[535.461607] Starting subtest: psr-abgr161616f-draw-mmap-wc
[535.465684] Subtest psr-abgr161616f-draw-mmap-wc: SKIP (0.000s)
[535.588206] [102/133] (487s left) gem_softpin (allocator-nopin)
[535.645654] Starting subtest: allocator-nopin
[535.755100] Subtest allocator-nopin: SUCCESS (0.109s)
[535.916682] [103/133] (486s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[536.021304] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[536.711922] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.692s)
[536.886233] [104/133] (485s left) kms_flip (busy-flip)
[536.985074] Starting subtest: busy-flip
[536.987335] Starting dynamic subtest: A-eDP1
[538.686311] Dynamic subtest A-eDP1: SUCCESS (1.702s)
[538.697085] Starting dynamic subtest: B-eDP1
[540.318110] Dynamic subtest B-eDP1: SUCCESS (1.630s)
[540.330290] Starting dynamic subtest: C-eDP1
[541.950679] Dynamic subtest C-eDP1: SUCCESS (1.631s)
[541.960077] Starting dynamic subtest: D-eDP1
[543.580084] Dynamic subtest D-eDP1: SUCCESS (1.628s)
[543.582301] Subtest busy-flip: SUCCESS (6.601s)
[544.775368] [105/133] (478s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[544.872408] Starting subtest: x-tiled-16bpp-rotate-270
[544.893615] Subtest x-tiled-16bpp-rotate-270: SKIP (0.021s)
[545.042378] [106/133] (477s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-render)
[545.138610] Starting subtest: fbcpsr-abgr161616f-draw-render
[545.143025] Subtest fbcpsr-abgr161616f-draw-render: SKIP (0.000s)
[545.268452] [107/133] (477s left) kms_getfb (getfb2-accept-nv12)
[545.361326] Starting subtest: getfb2-accept-nv12
[545.363552] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[545.491565] [108/133] (477s left) gem_ctx_exec (basic-nohangcheck)
[545.558615] Starting subtest: basic-nohangcheck
[545.816772] Subtest basic-nohangcheck: SUCCESS (0.260s)
[545.978615] [109/133] (477s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[546.093599] Starting subtest: short-flip-before-cursor-atomic-transitions
[547.032913] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.940s)
[547.910277] [110/133] (475s left) kms_cursor_crc (cursor-offscreen-256x256)
[548.155837] Starting subtest: cursor-offscreen-256x256
[548.161798] Starting dynamic subtest: pipe-A-eDP-1
[550.088380] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.929s)
[550.116427] Starting dynamic subtest: pipe-D-eDP-1
[552.701279] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.590s)
[552.703589] Subtest cursor-offscreen-256x256: SUCCESS (4.544s)
[553.582020] [111/133] (469s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[553.689335] Starting subtest: 4-tiled-8bpp-rotate-0
[554.858471] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.169s)
[555.004163] [112/133] (468s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[555.053738] Subtest writes-after-reads: SKIP (0.000s)
[555.126164] [113/133] (468s left) kms_frontbuffer_tracking (psr-slowdraw)
[555.217098] Starting subtest: psr-slowdraw
[580.304427] Subtest psr-slowdraw: SUCCESS (25.086s)
[580.460334] [114/133] (442s left) i915_pm_rc6_residency (rc6-idle)
[580.521977] Starting subtest: rc6-idle
[580.546979] Starting dynamic subtest: gt0-rcs0
[604.759896] Dynamic subtest gt0-rcs0: SUCCESS (24.212s)
[604.771403] Starting dynamic subtest: gt0-bcs0
[629.041340] Dynamic subtest gt0-bcs0: SUCCESS (24.279s)
[629.052908] Starting dynamic subtest: gt0-ccs0
[653.384685] Dynamic subtest gt0-ccs0: SUCCESS (24.341s)
[653.398348] Starting dynamic subtest: gt1-vcs0
[659.557968] Dynamic subtest gt1-vcs0: SUCCESS (6.169s)
[659.569533] Starting dynamic subtest: gt1-vecs0
[665.729823] Dynamic subtest gt1-vecs0: SUCCESS (6.169s)
[665.733069] Subtest rc6-idle: SUCCESS (85.208s)
[665.833898] [115/133] (357s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[665.939702] Starting subtest: fbc-modesetfrombusy
[669.758020] Subtest fbc-modesetfrombusy: SUCCESS (3.823s)
[670.953440] [116/133] (352s left) kms_psr (psr-cursor-render)
[671.048149] Starting subtest: psr-cursor-render
[671.050502] Starting dynamic subtest: eDP-1
[672.819547] Dynamic subtest eDP-1: SUCCESS (1.772s)
[672.821902] Subtest psr-cursor-render: SUCCESS (1.773s)
[673.708798] [117/133] (349s left) gem_exec_parallel (engines)
[673.769129] Starting subtest: engines
[673.771456] Starting dynamic subtest: basic
[675.926049] Dynamic subtest basic: SUCCESS (2.155s)
[675.938342] Starting dynamic subtest: contexts
[680.371498] Dynamic subtest contexts: SUCCESS (4.443s)
[680.383953] Starting dynamic subtest: fds
[684.172318] Dynamic subtest fds: SUCCESS (3.798s)
[684.184907] Starting dynamic subtest: userptr
[685.939246] Dynamic subtest userptr: SUCCESS (1.765s)
[685.942041] Subtest engines: SUCCESS (12.169s)
[686.168023] [118/133] (337s left) prime_busy (after)
[686.232966] Starting subtest: after
[686.235282] Starting dynamic subtest: rcs0
[686.284306] Dynamic subtest rcs0: SUCCESS (0.050s)
[686.295676] Starting dynamic subtest: bcs0
[686.351668] Dynamic subtest bcs0: SUCCESS (0.066s)
[686.363094] Starting dynamic subtest: vcs0
[686.392450] Dynamic subtest vcs0: SUCCESS (0.041s)
[686.402558] Starting dynamic subtest: vcs1
[686.432587] Dynamic subtest vcs1: SUCCESS (0.039s)
[686.441812] Starting dynamic subtest: vecs0
[686.472751] Dynamic subtest vecs0: SUCCESS (0.040s)
[686.482066] Starting dynamic subtest: ccs0
[686.515324] Dynamic subtest ccs0: SUCCESS (0.042s)
[686.624888] Subtest after: SUCCESS (0.392s)
[686.724605] [119/133] (336s left) gem_partial_pwrite_pread (write-display)
[686.794790] Subtest write-display: SKIP (0.000s)
[686.855702] [120/133] (336s left) gem_tiled_blits (basic)
[686.910242] Subtest basic: SKIP (0.000s)
[686.986031] [121/133] (336s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[687.094713] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[695.615365] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.522s)
[695.752514] [122/133] (327s left) sysfs_defaults (readonly)
[695.813747] Starting subtest: readonly
[695.816153] Starting dynamic subtest: vecs0
[695.818474] Dynamic subtest vecs0: SUCCESS (0.000s)
[695.829642] Starting dynamic subtest: ccs0
[695.831938] Dynamic subtest ccs0: SUCCESS (0.000s)
[695.842196] Starting dynamic subtest: vcs0
[695.844383] Dynamic subtest vcs0: SUCCESS (0.000s)
[695.853069] Starting dynamic subtest: bcs0
[695.855440] Dynamic subtest bcs0: SUCCESS (0.001s)
[695.865635] Starting dynamic subtest: rcs0
[695.867579] Dynamic subtest rcs0: SUCCESS (0.000s)
[695.876491] Starting dynamic subtest: vcs1
[695.878735] Dynamic subtest vcs1: SUCCESS (0.000s)
[695.880969] Subtest readonly: SUCCESS (0.008s)
[695.936616] [123/133] (327s left) kms_dsc (dsc-with-formats)
[696.041180] Starting subtest: dsc-with-formats
[696.079196] Subtest dsc-with-formats: SKIP (0.001s)
[696.138308] [124/133] (327s left) prime_mmap (test_reprime)
[696.205643] Starting subtest: test_reprime
[696.207605] Starting dynamic subtest: test_reprime-smem
[696.249290] Dynamic subtest test_reprime-smem: SUCCESS (0.046s)
[696.251795] Subtest test_reprime: SUCCESS (0.046s)
[696.378487] [125/133] (327s left) gem_exec_params (rsvd2-dirt)
[696.443253] Starting subtest: rsvd2-dirt
[696.447652] Subtest rsvd2-dirt: SKIP (0.000s)
[696.582513] [126/133] (327s left) kms_lease (lessee-list)
[696.674610] Starting subtest: lessee-list
[696.676448] Starting dynamic subtest: pipe-A-eDP-1
[696.678409] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[696.688596] Starting dynamic subtest: pipe-B-eDP-1
[696.690166] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[696.698760] Starting dynamic subtest: pipe-C-eDP-1
[696.700303] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[696.708885] Starting dynamic subtest: pipe-D-eDP-1
[696.710515] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[696.712154] Subtest lessee-list: SUCCESS (0.008s)
[696.814930] [127/133] (326s left) kms_vrr (flip-dpms)
[696.919210] Starting subtest: flip-dpms
[696.924499] Subtest flip-dpms: SKIP (0.000s)
[697.015183] [128/133] (326s left) kms_frontbuffer_tracking (fbc-1p-rte)
[697.112308] Starting subtest: fbc-1p-rte
[702.551042] Subtest fbc-1p-rte: SUCCESS (5.442s)
[703.785847] [129/133] (320s left) gen9_exec_parse (batch-zero-length)
[703.861368] Subtest batch-zero-length: SKIP (0.000s)
[703.944642] [130/133] (319s left) prime_mmap (test_aperture_limit)
[704.013315] Starting subtest: test_aperture_limit
[704.015530] Starting dynamic subtest: test_aperture_limit-smem
[704.022154] Dynamic subtest test_aperture_limit-smem: SKIP (0.007s)
[704.026215] Subtest test_aperture_limit: SKIP (0.008s)
[704.158328] [131/133] (319s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[704.269062] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[704.273476] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[704.398183] [132/133] (319s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[704.505144] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[704.509449] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[704.618136] [133/133] (319s left) gem_exec_fence (long-history)
[705.075231] Starting subtest: long-history
[712.672549] Subtest long-history: SUCCESS (7.597s)
[713.196580] 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.