[56.030969] Initializing watchdogs
[56.031034]   /dev/watchdog0
[56.045591] [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]
[56.049873] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.052090] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.055331] [001/133] (960s left) gem_create (create-ext-placement-all)
[56.252576] Starting subtest: create-ext-placement-all
[56.254844] Subtest create-ext-placement-all: SUCCESS (0.000s)
[56.397199] [002/133] (960s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[56.465841] Starting subtest: map-fixed-invalidate-overlap
[56.470153] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[56.622555] [003/133] (960s left) gem_pipe_control_store_loop (fresh-buffer)
[56.679806] Starting subtest: fresh-buffer
[58.819604] Subtest fresh-buffer: SUCCESS (2.157s)
[58.975520] [004/133] (957s left) gem_mmap_offset (mmap-boundaries)
[59.031866] Starting subtest: mmap-boundaries
[59.034196] Starting dynamic subtest: smem0
[59.312207] Dynamic subtest smem0: SUCCESS (0.285s)
[59.314593] Subtest mmap-boundaries: SUCCESS (0.285s)
[59.480838] [005/133] (957s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[59.579382] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[67.059513] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.514s)
[67.732696] [006/133] (949s left) kms_atomic (atomic-plane-damage)
[67.939708] Starting subtest: atomic-plane-damage
[68.013615] Starting dynamic subtest: pipe-A-eDP-1
[68.539816] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.526s)
[68.542286] Subtest atomic-plane-damage: SUCCESS (0.604s)
[69.352381] [007/133] (947s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[69.451132] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[69.453297] Starting dynamic subtest: pipe-A-eDP-1
[69.515857] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.066s)
[69.523932] Starting dynamic subtest: pipe-B-eDP-1
[69.578992] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.062s)
[69.587318] Starting dynamic subtest: pipe-C-eDP-1
[69.643447] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.064s)
[69.652069] Starting dynamic subtest: pipe-D-eDP-1
[69.705233] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.061s)
[69.707586] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.257s)
[72.016766] [008/133] (944s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[72.131432] Starting subtest: psr-rgb101010-draw-mmap-wc
[79.176801] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.053s)
[79.321904] [009/133] (937s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[79.389202] Starting subtest: yf-tiled-to-vebox-x-tiled
[79.393666] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[79.593316] [010/133] (937s left) syncobj_timeline (wait-all-complex)
[79.651717] Starting subtest: wait-all-complex
[79.865151] Subtest wait-all-complex: SUCCESS (0.213s)
[79.960803] [011/133] (936s left) gem_pxp (create-valid-protected-context)
[80.091030] Starting subtest: create-valid-protected-context
[80.093576] Subtest create-valid-protected-context: SUCCESS (0.002s)
[80.233639] [012/133] (936s left) gem_exec_flush (basic-wb-rw-default)
[80.304993] Starting subtest: basic-wb-rw-default
[85.756130] Subtest basic-wb-rw-default: SUCCESS (5.451s)
[85.964193] [013/133] (931s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[86.049128] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[86.051408] Starting dynamic subtest: pipe-A-eDP-1
[86.071383] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[86.081147] Starting dynamic subtest: pipe-B-eDP-1
[86.099756] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[86.107504] Starting dynamic subtest: pipe-C-eDP-1
[86.126381] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[86.134755] Starting dynamic subtest: pipe-D-eDP-1
[86.154446] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[86.156714] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[88.301885] [014/133] (928s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[88.394104] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[92.598768] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.207s)
[93.801710] [015/133] (923s left) kms_cursor_edge_walk (256x256-top-bottom)
[93.911773] Starting subtest: 256x256-top-bottom
[93.914263] Starting dynamic subtest: pipe-A-eDP-1
[97.325338] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.414s)
[97.335788] Starting dynamic subtest: pipe-D-eDP-1
[100.449508] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.120s)
[100.451783] Subtest 256x256-top-bottom: SUCCESS (6.538s)
[101.284343] [016/133] (915s left) kms_force_connector_basic (force-load-detect)
[101.365876] Starting subtest: force-load-detect
[101.370285] Subtest force-load-detect: SKIP (0.000s)
[101.508348] [017/133] (915s left) syncobj_wait (invalid-signal-zero-handles)
[101.570184] Starting subtest: invalid-signal-zero-handles
[101.572436] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[101.704844] [018/133] (915s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[106.735314] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[106.737610] Starting dynamic subtest: pipe-A-eDP-1
[107.549030] Dynamic subtest pipe-A-eDP-1: SKIP (0.811s)
[107.558438] Starting dynamic subtest: pipe-B-eDP-1
[108.679784] Dynamic subtest pipe-B-eDP-1: SKIP (1.129s)
[108.684199] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.943s)
[109.891960] [019/133] (907s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[110.003808] Starting subtest: fbcpsr-rgb565-draw-render
[117.058418] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.056s)
[117.204401] [020/133] (900s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[117.313291] Starting subtest: primary-4-tiled-reflect-x-0
[124.535668] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.222s)
[125.786738] [021/133] (891s left) kms_setmode (clone-exclusive-crtc)
[125.850078] Starting subtest: clone-exclusive-crtc
[125.856770] Subtest clone-exclusive-crtc: SKIP (0.000s)
[125.985999] [022/133] (891s left) kms_addfb_basic (too-high)
[126.082011] Starting subtest: too-high
[126.083947] Subtest too-high: SUCCESS (0.000s)
[126.218063] [023/133] (891s left) perf_pmu (busy-accuracy-2)
[126.257815] Starting subtest: busy-accuracy-2
[126.260047] Starting dynamic subtest: rcs0
[129.326079] Dynamic subtest rcs0: SUCCESS (3.041s)
[129.334322] Starting dynamic subtest: bcs0
[132.357551] Dynamic subtest bcs0: SUCCESS (3.056s)
[132.367947] Starting dynamic subtest: vcs0
[135.405050] Dynamic subtest vcs0: SUCCESS (3.046s)
[135.415567] Starting dynamic subtest: vcs1
[138.453918] Dynamic subtest vcs1: SUCCESS (3.047s)
[138.464168] Starting dynamic subtest: vecs0
[141.501346] Dynamic subtest vecs0: SUCCESS (3.045s)
[141.512439] Starting dynamic subtest: ccs0
[144.558275] Dynamic subtest ccs0: SUCCESS (3.055s)
[144.560757] Subtest busy-accuracy-2: SUCCESS (18.299s)
[144.695647] [024/133] (872s left) kms_psr (pr-primary-mmap-gtt)
[144.802982] Starting subtest: pr-primary-mmap-gtt
[144.807591] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[144.902135] [025/133] (872s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[144.995779] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[144.999761] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[145.114180] [026/133] (872s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[145.224546] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[145.228632] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[145.365718] [027/133] (872s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[145.469993] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[145.472308] Starting dynamic subtest: pipe-A-default-mode
[148.225728] Dynamic subtest pipe-A-default-mode: SUCCESS (2.755s)
[148.227983] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.756s)
[149.088534] [028/133] (868s left) i915_drm_fdinfo (idle)
[149.128886] Starting subtest: idle
[149.131281] Starting dynamic subtest: rcs0
[149.716244] Dynamic subtest rcs0: SUCCESS (0.589s)
[149.727095] Starting dynamic subtest: bcs0
[150.223623] Dynamic subtest bcs0: SUCCESS (0.504s)
[150.234398] Starting dynamic subtest: vcs0
[150.730864] Dynamic subtest vcs0: SUCCESS (0.504s)
[150.741791] Starting dynamic subtest: vcs1
[151.234498] Dynamic subtest vcs1: SUCCESS (0.503s)
[151.243802] Starting dynamic subtest: vecs0
[151.740361] Dynamic subtest vecs0: SUCCESS (0.503s)
[151.749079] Starting dynamic subtest: ccs0
[152.245605] Dynamic subtest ccs0: SUCCESS (0.503s)
[152.248252] Subtest idle: SUCCESS (3.119s)
[152.351009] [029/133] (865s left) core_setmaster (master-drop-set-shared-fd)
[152.450094] Starting subtest: master-drop-set-shared-fd
[152.460978] Subtest master-drop-set-shared-fd: SUCCESS (0.011s)
[152.497598] [030/133] (865s left) kms_chamelium_color (ctm-negative)
[152.603239] Subtest ctm-negative: SKIP (0.000s)
[152.648144] [031/133] (865s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[152.709343] Starting subtest: multi-wait-for-submit-available-submitted
[152.711670] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[152.821062] [032/133] (864s left) syncobj_timeline (invalid-signal-illegal-point)
[152.876087] Starting subtest: invalid-signal-illegal-point
[152.878064] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[152.993881] [033/133] (864s left) gem_mmap (bad-offset)
[153.067276] Subtest bad-offset: SKIP (0.000s)
[153.137467] [034/133] (864s left) i915_hangman (gt-error-state-capture)
[153.218388] Starting subtest: gt-error-state-capture
[153.220797] Starting dynamic subtest: rcs0
[164.855362] Dynamic subtest rcs0: SUCCESS (11.636s)
[164.865931] Starting dynamic subtest: bcs0
[176.886753] Dynamic subtest bcs0: SUCCESS (12.029s)
[176.898090] Starting dynamic subtest: vcs0
[188.855240] Dynamic subtest vcs0: SUCCESS (11.966s)
[188.866812] Starting dynamic subtest: vcs1
[200.886869] Dynamic subtest vcs1: SUCCESS (12.029s)
[200.898384] Starting dynamic subtest: vecs0
[212.854829] Dynamic subtest vecs0: SUCCESS (11.966s)
[212.866630] Starting dynamic subtest: ccs0
[224.888589] Dynamic subtest ccs0: SUCCESS (12.031s)
[224.891670] Subtest gt-error-state-capture: SUCCESS (71.668s)
[224.992407] [035/133] (792s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[225.096069] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[225.098409] Starting dynamic subtest: pipe-A-eDP-1
[225.107899] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[225.118654] Starting dynamic subtest: pipe-B-eDP-1
[225.128278] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[225.136784] Starting dynamic subtest: pipe-C-eDP-1
[225.145584] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[225.153567] Starting dynamic subtest: pipe-D-eDP-1
[225.162259] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[225.166432] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[227.357521] [036/133] (790s left) gem_exec_whisper (basic-fds)
[227.433790] Starting subtest: basic-fds
[234.790316] Subtest basic-fds: SUCCESS (7.354s)
[234.997276] [037/133] (782s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[235.103243] Starting subtest: psr-1p-primscrn-cur-indfb-move
[242.624218] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.523s)
[242.816684] [038/133] (775s left) gem_exec_schedule (preempt-user)
[242.897157] Starting subtest: preempt-user
[242.899489] Starting dynamic subtest: rcs0
[242.913679] Dynamic subtest rcs0: SUCCESS (0.023s)
[242.925274] Starting dynamic subtest: bcs0
[242.933406] Dynamic subtest bcs0: SUCCESS (0.019s)
[242.942467] Starting dynamic subtest: vcs0
[242.953084] Dynamic subtest vcs0: SUCCESS (0.019s)
[242.962063] Starting dynamic subtest: vcs1
[242.973457] Dynamic subtest vcs1: SUCCESS (0.020s)
[242.982396] Starting dynamic subtest: vecs0
[242.993076] Dynamic subtest vecs0: SUCCESS (0.019s)
[243.001609] Starting dynamic subtest: ccs0
[243.014056] Dynamic subtest ccs0: SUCCESS (0.020s)
[243.016451] Subtest preempt-user: SUCCESS (0.124s)
[245.016405] [039/133] (773s left) kms_psr (psr2-primary-mmap-cpu)
[245.104087] Starting subtest: psr2-primary-mmap-cpu
[245.106379] Starting dynamic subtest: eDP-1
[246.822739] Dynamic subtest eDP-1: SUCCESS (1.719s)
[246.825067] Subtest psr2-primary-mmap-cpu: SUCCESS (1.720s)
[247.725188] [040/133] (770s left) gem_ctx_param (invalid-size-set)
[247.783900] Starting subtest: invalid-size-set
[247.786350] Subtest invalid-size-set: SUCCESS (0.001s)
[247.918348] [041/133] (770s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[248.017241] Starting subtest: bad-aux-stride-y-tiled-ccs
[248.019521] Starting dynamic subtest: pipe-A-eDP-1
[248.042228] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[248.052615] Starting dynamic subtest: pipe-B-eDP-1
[248.073874] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[248.084379] Starting dynamic subtest: pipe-C-eDP-1
[248.105711] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[248.113640] Starting dynamic subtest: pipe-D-eDP-1
[248.135183] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[248.139467] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[250.289413] [042/133] (767s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[250.390885] Starting subtest: blocking-absolute-wf_vblank-interruptible
[250.393105] Starting dynamic subtest: A-eDP1
[259.124475] Dynamic subtest A-eDP1: SUCCESS (8.732s)
[259.135761] Starting dynamic subtest: B-eDP1
[267.852537] Dynamic subtest B-eDP1: SUCCESS (8.726s)
[267.863401] Starting dynamic subtest: C-eDP1
[276.568221] Dynamic subtest C-eDP1: SUCCESS (8.714s)
[276.578560] Starting dynamic subtest: D-eDP1
[285.292976] Dynamic subtest D-eDP1: SUCCESS (8.722s)
[285.295325] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.904s)
[286.527387] [043/133] (731s left) kms_psr2_su (page_flip-nv12)
[286.597042] Subtest page_flip-NV12: SKIP (0.000s)
[286.667638] [044/133] (731s left) gem_exec_balancer (sliced)
[286.747759] Starting subtest: sliced
[286.752269] Subtest sliced: SKIP (0.000s)
[287.072170] [045/133] (731s left) kms_plane_lowres (tiling-x)
[287.177091] Starting subtest: tiling-x
[287.179271] Starting dynamic subtest: pipe-A-eDP-1
[287.183661] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[287.469855] Starting dynamic subtest: pipe-B-eDP-1
[287.474279] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[287.482827] Starting dynamic subtest: pipe-C-eDP-1
[287.487314] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[287.495834] Starting dynamic subtest: pipe-D-eDP-1
[287.500139] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[287.504158] Subtest tiling-x: SKIP (0.293s)
[288.360635] [046/133] (729s left) kms_vblank (query-busy-hang)
[288.465980] Starting subtest: query-busy-hang
[288.467872] Starting dynamic subtest: pipe-A-eDP-1
[314.653066] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.185s)
[314.667213] Starting dynamic subtest: pipe-D-eDP-1
[329.680788] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.024s)
[329.682692] Subtest query-busy-hang: SUCCESS (41.213s)
[330.554043] [047/133] (687s left) gem_exec_balancer (hang)
[330.826890] Starting subtest: hang
[332.903964] Subtest hang: SUCCESS (2.081s)
[333.049920] [048/133] (685s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[333.154447] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[333.158715] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[333.269945] [049/133] (685s left) kms_flip (bo-too-big)
[333.376189] Starting subtest: bo-too-big
[333.378391] Starting dynamic subtest: A-eDP1
[334.646898] Dynamic subtest A-eDP1: SUCCESS (1.272s)
[334.656394] Starting dynamic subtest: B-eDP1
[335.970318] Dynamic subtest B-eDP1: SUCCESS (1.322s)
[335.979742] Starting dynamic subtest: C-eDP1
[337.301659] Dynamic subtest C-eDP1: SUCCESS (1.330s)
[337.313029] Starting dynamic subtest: D-eDP1
[338.635982] Dynamic subtest D-eDP1: SUCCESS (1.333s)
[338.642099] Subtest bo-too-big: SUCCESS (5.267s)
[339.863233] [050/133] (678s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[339.936824] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[339.941257] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[340.136626] [051/133] (678s left) kms_cursor_legacy (single-bo)
[340.259191] Starting subtest: single-bo
[340.261056] Starting dynamic subtest: pipe-A
[345.641078] Dynamic subtest pipe-A: SUCCESS (5.378s)
[345.651700] Starting dynamic subtest: pipe-B
[351.022851] Dynamic subtest pipe-B: SUCCESS (5.379s)
[351.032592] Starting dynamic subtest: pipe-C
[356.405050] Dynamic subtest pipe-C: SUCCESS (5.379s)
[356.414882] Starting dynamic subtest: pipe-D
[361.786969] Dynamic subtest pipe-D: SUCCESS (5.379s)
[361.796218] Starting dynamic subtest: all-pipes
[367.175725] Dynamic subtest all-pipes: SUCCESS (5.386s)
[367.178085] Subtest single-bo: SUCCESS (26.914s)
[367.345020] [052/133] (651s left) kms_pm_rpm (basic-pci-d3-state)
[368.999487] Starting subtest: basic-pci-d3-state
[370.467225] Subtest basic-pci-d3-state: SUCCESS (1.469s)
[370.576608] [053/133] (648s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[370.687570] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[375.125250] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.441s)
[376.351175] [054/133] (642s left) kms_pm_rpm (legacy-planes)
[378.075153] Starting subtest: legacy-planes
[378.077241] Starting dynamic subtest: plane-63
[386.665421] Dynamic subtest plane-63: SUCCESS (8.592s)
[386.677145] Starting dynamic subtest: plane-93
[396.168326] Dynamic subtest plane-93: SUCCESS (9.500s)
[396.180315] Starting dynamic subtest: plane-123
[404.583248] Dynamic subtest plane-123: SUCCESS (8.412s)
[404.595391] Starting dynamic subtest: plane-133
[413.171378] Dynamic subtest plane-133: SUCCESS (8.585s)
[413.174102] Subtest legacy-planes: SUCCESS (35.099s)
[413.577838] [055/133] (605s left) prime_self_import (basic-with_one_bo)
[413.620702] Starting subtest: basic-with_one_bo
[413.648781] Subtest basic-with_one_bo: SUCCESS (0.029s)
[413.794126] [056/133] (604s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[413.889449] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[413.893679] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[414.038412] [057/133] (604s left) kms_flip (modeset-vs-vblank-race)
[414.137193] Starting subtest: modeset-vs-vblank-race
[414.139668] Starting dynamic subtest: A-eDP1
[418.864417] Dynamic subtest A-eDP1: SUCCESS (4.726s)
[418.876115] Starting dynamic subtest: B-eDP1
[423.580053] Dynamic subtest B-eDP1: SUCCESS (4.713s)
[423.591784] Starting dynamic subtest: C-eDP1
[428.275588] Dynamic subtest C-eDP1: SUCCESS (4.694s)
[428.286409] Starting dynamic subtest: D-eDP1
[432.901523] Dynamic subtest D-eDP1: SUCCESS (4.625s)
[432.903798] Subtest modeset-vs-vblank-race: SUCCESS (18.767s)
[434.202825] [058/133] (584s left) gem_lmem_swapping (heavy-verify-random-ccs)
[434.245054] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[434.293040] [059/133] (584s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[434.418537] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[434.422784] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[434.542658] [060/133] (584s left) kms_chamelium_color (gamma)
[434.636267] Subtest gamma: SKIP (0.000s)
[434.682231] [061/133] (584s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[434.815699] Starting subtest: cursorB-vs-flipA-varying-size
[434.820165] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[434.984158] [062/133] (584s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[435.094514] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[439.526485] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.435s)
[440.703151] [063/133] (578s left) dumb_buffer (map-valid)
[440.766702] Starting subtest: map-valid
[440.768715] Subtest map-valid: SUCCESS (0.000s)
[440.890431] [064/133] (578s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[440.997101] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[440.999360] Starting dynamic subtest: pipe-A-default-mode
[441.302873] Dynamic subtest pipe-A-default-mode: SKIP (0.305s)
[441.307406] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.307s)
[442.125861] [065/133] (577s left) perf (i915-ref-count)
[442.219935] Starting subtest: i915-ref-count
[442.289271] Subtest i915-ref-count: SUCCESS (0.070s)
[442.342990] [066/133] (576s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[442.454277] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[442.458677] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[442.582885] [067/133] (576s left) gem_softpin (noreloc-interruptible)
[442.654106] Starting subtest: noreloc-interruptible
[448.050727] Subtest noreloc-interruptible: SUCCESS (5.397s)
[448.225622] [068/133] (571s left) kms_psr (fbc-psr2-primary-render)
[448.329968] Starting subtest: fbc-psr2-primary-render
[448.332308] Starting dynamic subtest: eDP-1
[448.336595] Dynamic subtest eDP-1: SKIP (0.000s)
[448.340974] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[448.424523] [069/133] (570s left) kms_lease (atomic-implicit-crtc)
[448.521112] Starting subtest: atomic-implicit-crtc
[448.523599] Starting dynamic subtest: pipe-A-eDP-1
[448.535270] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[448.546398] Starting dynamic subtest: pipe-B-eDP-1
[448.557496] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[448.565976] Starting dynamic subtest: pipe-C-eDP-1
[448.576698] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[448.585107] Starting dynamic subtest: pipe-D-eDP-1
[448.595588] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[448.597779] Subtest atomic-implicit-crtc: SUCCESS (0.036s)
[448.680900] [070/133] (570s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[448.762187] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[449.132829] Starting dynamic subtest: pipe-A-eDP-1
[451.870104] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.737s)
[452.246666] Starting dynamic subtest: pipe-B-eDP-1
[455.004992] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.764s)
[455.366463] Starting dynamic subtest: pipe-C-eDP-1
[458.132714] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.773s)
[458.491299] Starting dynamic subtest: pipe-D-eDP-1
[461.262053] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.777s)
[461.264462] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.501s)
[462.470424] [071/133] (556s left) gem_exec_reloc (basic-wc-read-active)
[462.545748] Subtest basic-wc-read-active: SKIP (0.000s)
[462.638470] [072/133] (556s left) gem_readwrite (new-obj)
[462.700937] Subtest new-obj: SKIP (0.000s)
[462.761186] [073/133] (556s left) gem_mmap_gtt (basic-short)
[462.813613] Subtest basic-short: SKIP (0.000s)
[462.869847] [074/133] (556s left) kms_plane_multiple (tiling-yf)
[462.970213] Starting subtest: tiling-yf
[462.974279] Subtest tiling-yf: SKIP (0.000s)
[463.062283] [075/133] (556s left) kms_content_protection (dp-mst-type-0-hdcp14)
[463.219585] Starting subtest: dp-mst-type-0-hdcp14
[463.223925] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[463.381109] [076/133] (556s left) gem_ctx_shared (q-in-order)
[463.453658] Starting subtest: Q-in-order
[463.455608] Starting dynamic subtest: rcs0
[463.630368] Dynamic subtest rcs0: SUCCESS (0.175s)
[463.644820] Starting dynamic subtest: vcs0
[463.713949] Dynamic subtest vcs0: SUCCESS (0.081s)
[463.731047] Starting dynamic subtest: vcs1
[463.790099] Dynamic subtest vcs1: SUCCESS (0.075s)
[463.807575] Starting dynamic subtest: vecs0
[463.866535] Dynamic subtest vecs0: SUCCESS (0.076s)
[463.883090] Starting dynamic subtest: ccs0
[463.959195] Dynamic subtest ccs0: SUCCESS (0.091s)
[463.961467] Subtest Q-in-order: SUCCESS (0.504s)
[465.055536] [FACT gem_ctx_shared (q-in-order)] new: kernel.kmod_is_loaded.vgem: true
[465.058879] [077/133] (554s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[465.107115] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[465.213431] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[465.313094] [078/133] (554s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[465.412830] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[472.131237] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.720s)
[472.305290] [079/133] (547s left) kms_big_fb (linear-8bpp-rotate-270)
[472.418348] Starting subtest: linear-8bpp-rotate-270
[472.440439] Subtest linear-8bpp-rotate-270: SKIP (0.021s)
[472.591117] [080/133] (547s left) api_intel_allocator (standalone)
[472.654229] Starting subtest: standalone
[472.668030] Subtest standalone: SUCCESS (0.016s)
[472.817893] [081/133] (546s left) core_auth (getclient-master-drop)
[472.854851] Starting subtest: getclient-master-drop
[472.870718] Subtest getclient-master-drop: SUCCESS (0.014s)
[473.009581] [082/133] (546s left) kms_psr (fbc-psr2-basic)
[473.108232] Starting subtest: fbc-psr2-basic
[473.110457] Starting dynamic subtest: eDP-1
[473.114375] Dynamic subtest eDP-1: SKIP (0.000s)
[473.118305] Subtest fbc-psr2-basic: SKIP (0.001s)
[473.204423] [083/133] (546s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[473.347141] Starting subtest: cursor-rapid-movement-32x32
[473.396629] Subtest cursor-rapid-movement-32x32: SKIP (0.045s)
[473.738429] [084/133] (546s left) gem_exec_schedule (noreorder-priority)
[473.926360] Starting subtest: noreorder-priority
[473.928945] Starting dynamic subtest: rcs0
[475.079999] Dynamic subtest rcs0: SUCCESS (1.154s)
[475.095663] Starting dynamic subtest: vcs0
[476.925260] Dynamic subtest vcs0: SUCCESS (1.842s)
[476.937641] Starting dynamic subtest: vcs1
[478.966405] Dynamic subtest vcs1: SUCCESS (2.040s)
[478.978416] Starting dynamic subtest: vecs0
[480.935288] Dynamic subtest vecs0: SUCCESS (1.966s)
[480.945915] Starting dynamic subtest: ccs0
[482.101956] Dynamic subtest ccs0: SUCCESS (1.165s)
[482.104944] Subtest noreorder-priority: SUCCESS (8.178s)
[482.314888] [085/133] (537s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[482.419962] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[482.422321] Starting dynamic subtest: pipe-A-eDP-1
[482.447482] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[482.459224] Starting dynamic subtest: pipe-B-eDP-1
[482.483041] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[482.492244] Starting dynamic subtest: pipe-C-eDP-1
[482.516019] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[482.524977] Starting dynamic subtest: pipe-D-eDP-1
[482.549050] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[482.553073] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[484.639452] [086/133] (535s left) core_auth (many-magics)
[484.703194] Starting subtest: many-magics
[485.659403] Subtest many-magics: SUCCESS (0.958s)
[485.860602] [087/133] (534s left) i915_suspend (fence-restore-tiled2untiled)
[485.917316] Starting subtest: fence-restore-tiled2untiled
[485.921954] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[486.061266] [088/133] (534s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[486.162146] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[486.164293] Starting dynamic subtest: pipe-A
[486.182430] Dynamic subtest pipe-A: SKIP (0.018s)
[486.196678] Starting dynamic subtest: pipe-B
[486.217074] Dynamic subtest pipe-B: SKIP (0.031s)
[486.226990] Starting dynamic subtest: pipe-C
[486.246629] Dynamic subtest pipe-C: SKIP (0.031s)
[486.255696] Starting dynamic subtest: pipe-D
[486.278325] Dynamic subtest pipe-D: SKIP (0.031s)
[486.281846] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.115s)
[486.420709] [089/133] (533s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[486.525015] Starting subtest: y-tiled-64bpp-rotate-0
[486.529254] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[486.670733] [090/133] (533s left) gem_ctx_persistence (saturated-hostile)
[486.726667] Starting subtest: saturated-hostile
[486.729158] Starting dynamic subtest: rcs0
[487.556440] Dynamic subtest rcs0: SUCCESS (0.829s)
[487.568668] Starting dynamic subtest: bcs0
[488.348092] Dynamic subtest bcs0: SUCCESS (0.790s)
[488.359714] Starting dynamic subtest: vcs0
[489.145161] Dynamic subtest vcs0: SUCCESS (0.795s)
[489.156851] Starting dynamic subtest: vcs1
[489.956223] Dynamic subtest vcs1: SUCCESS (0.810s)
[489.975898] Starting dynamic subtest: vecs0
[490.787355] Dynamic subtest vecs0: SUCCESS (0.828s)
[490.797617] Starting dynamic subtest: ccs0
[491.635443] Dynamic subtest ccs0: SUCCESS (0.845s)
[491.638345] Subtest saturated-hostile: SUCCESS (4.909s)
[491.745140] [091/133] (528s left) kms_prop_blob (invalid-get-prop)
[491.806409] Starting subtest: invalid-get-prop
[491.808692] Subtest invalid-get-prop: SUCCESS (0.000s)
[491.935400] [092/133] (528s left) gem_mmap_gtt (basic-write)
[491.991591] Subtest basic-write: SKIP (0.000s)
[492.056414] [093/133] (528s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[492.188604] Starting subtest: cursorA-vs-flipA-varying-size
[503.313575] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.123s)
[504.171070] [094/133] (516s left) gem_linear_blits (interruptible)
[504.583173] Starting subtest: interruptible
[508.996590] Subtest interruptible: SUCCESS (4.416s)
[509.172089] [095/133] (511s left) gem_exec_params (sol-reset-invalid)
[509.285046] Starting subtest: sol-reset-invalid
[509.290572] Subtest sol-reset-invalid: SUCCESS (0.004s)
[511.020111] [096/133] (509s left) kms_color_pipeline (plane-lut1d)
[511.131059] Starting subtest: plane-lut1d
[511.145669] Starting dynamic subtest: pipe-A-eDP-1
[511.864927] Dynamic subtest pipe-A-eDP-1: FAIL (0.331s)
[512.528978] Starting dynamic subtest: pipe-B-eDP-1
[513.381774] Dynamic subtest pipe-B-eDP-1: FAIL (0.351s)
[513.952183] Starting dynamic subtest: pipe-C-eDP-1
[514.794232] Dynamic subtest pipe-C-eDP-1: FAIL (0.257s)
[515.290386] Starting dynamic subtest: pipe-D-eDP-1
[516.152831] Dynamic subtest pipe-D-eDP-1: FAIL (0.278s)
[516.155156] Subtest plane-lut1d: FAIL (4.720s)
[516.703500] [097/133] (503s left) gem_wait (busy)
[516.776644] Starting subtest: busy
[516.779025] Starting dynamic subtest: all-engines
[517.913556] Dynamic subtest all-engines: SUCCESS (1.135s)
[517.927147] Starting dynamic subtest: rcs0
[518.453729] Dynamic subtest rcs0: SUCCESS (0.539s)
[518.465471] Starting dynamic subtest: bcs0
[518.992055] Dynamic subtest bcs0: SUCCESS (0.537s)
[519.003219] Starting dynamic subtest: vcs0
[520.921069] Dynamic subtest vcs0: SUCCESS (1.926s)
[520.932669] Starting dynamic subtest: vcs1
[522.903976] Dynamic subtest vcs1: SUCCESS (1.980s)
[522.915789] Starting dynamic subtest: vecs0
[524.888331] Dynamic subtest vecs0: SUCCESS (1.982s)
[524.900583] Starting dynamic subtest: ccs0
[525.429841] Dynamic subtest ccs0: SUCCESS (0.540s)
[525.432212] Subtest busy: SUCCESS (8.653s)
[525.654236] [098/133] (494s left) sriov_basic (enable-vfs-autoprobe-on)
[525.719169] Starting subtest: enable-vfs-autoprobe-on
[525.721570] Starting dynamic subtest: numvfs-1
[525.792971] Dynamic subtest numvfs-1: FAIL (0.010s)
[525.802299] Starting dynamic subtest: numvfs-2
[525.873894] Dynamic subtest numvfs-2: FAIL (0.004s)
[525.885261] Starting dynamic subtest: numvfs-3
[525.957607] Dynamic subtest numvfs-3: FAIL (0.004s)
[525.967784] Starting dynamic subtest: numvfs-4
[526.039592] Dynamic subtest numvfs-4: FAIL (0.004s)
[526.050888] Starting dynamic subtest: numvfs-5
[526.122638] Dynamic subtest numvfs-5: FAIL (0.004s)
[526.134103] Starting dynamic subtest: numvfs-6
[526.205256] Dynamic subtest numvfs-6: FAIL (0.004s)
[526.215533] Starting dynamic subtest: numvfs-7
[526.287595] Dynamic subtest numvfs-7: FAIL (0.004s)
[526.296839] Starting dynamic subtest: numvfs-random
[526.368577] Dynamic subtest numvfs-random: FAIL (0.004s)
[526.378536] Starting dynamic subtest: numvfs-all
[526.451123] Dynamic subtest numvfs-all: FAIL (0.508s)
[526.453127] Subtest enable-vfs-autoprobe-on: FAIL (0.552s)
[526.493462] [099/133] (494s left) kms_chamelium_frames (vga-frame-dump)
[526.901407] Subtest vga-frame-dump: SKIP (0.000s)
[527.696619] [100/133] (492s left) gem_eio (throttle)
[527.894868] Starting subtest: throttle
[528.161942] Subtest throttle: SUCCESS (0.265s)
[528.341856] [101/133] (492s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-mmap-wc)
[528.450343] Starting subtest: psr-abgr161616f-draw-mmap-wc
[528.454549] Subtest psr-abgr161616f-draw-mmap-wc: SKIP (0.000s)
[528.584170] [102/133] (492s left) gem_softpin (allocator-nopin)
[528.640289] Starting subtest: allocator-nopin
[528.749623] Subtest allocator-nopin: SUCCESS (0.107s)
[528.920992] [103/133] (491s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[529.025881] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[529.728447] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.704s)
[529.949771] [104/133] (490s left) kms_flip (busy-flip)
[530.055649] Starting subtest: busy-flip
[530.057624] Starting dynamic subtest: A-eDP1
[531.736689] Dynamic subtest A-eDP1: SUCCESS (1.683s)
[531.746283] Starting dynamic subtest: B-eDP1
[533.389949] Dynamic subtest B-eDP1: SUCCESS (1.652s)
[533.404625] Starting dynamic subtest: C-eDP1
[535.114613] Dynamic subtest C-eDP1: SUCCESS (1.721s)
[535.125796] Starting dynamic subtest: D-eDP1
[536.746668] Dynamic subtest D-eDP1: SUCCESS (1.630s)
[536.752021] Subtest busy-flip: SUCCESS (6.699s)
[538.037538] [105/133] (482s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[538.143945] Starting subtest: x-tiled-16bpp-rotate-270
[538.164317] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[538.328023] [106/133] (482s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-render)
[538.438185] Starting subtest: fbcpsr-abgr161616f-draw-render
[538.442693] Subtest fbcpsr-abgr161616f-draw-render: SKIP (0.000s)
[538.595167] [107/133] (482s left) kms_getfb (getfb2-accept-nv12)
[538.697897] Starting subtest: getfb2-accept-nv12
[538.700242] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[538.846403] [108/133] (482s left) gem_ctx_exec (basic-nohangcheck)
[538.910655] Starting subtest: basic-nohangcheck
[539.163405] Subtest basic-nohangcheck: SUCCESS (0.254s)
[539.333509] [109/133] (481s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[539.451312] Starting subtest: short-flip-before-cursor-atomic-transitions
[540.410870] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.961s)
[541.266752] [110/133] (479s left) kms_cursor_crc (cursor-offscreen-256x256)
[541.511196] Starting subtest: cursor-offscreen-256x256
[541.513401] Starting dynamic subtest: pipe-A-eDP-1
[543.457139] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.942s)
[543.488635] Starting dynamic subtest: pipe-D-eDP-1
[546.033106] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.553s)
[546.034978] Subtest cursor-offscreen-256x256: SUCCESS (4.522s)
[546.925138] [111/133] (474s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[547.023939] Starting subtest: 4-tiled-8bpp-rotate-0
[548.259310] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.235s)
[548.430506] [112/133] (472s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[548.503644] Subtest writes-after-reads: SKIP (0.000s)
[548.581112] [113/133] (472s left) kms_frontbuffer_tracking (psr-slowdraw)
[548.665782] Starting subtest: psr-slowdraw
[573.963151] Subtest psr-slowdraw: SUCCESS (25.296s)
[574.145910] [114/133] (447s left) i915_pm_rc6_residency (rc6-idle)
[574.203582] Starting subtest: rc6-idle
[574.245063] Starting dynamic subtest: gt0-rcs0
[598.602098] Dynamic subtest gt0-rcs0: SUCCESS (24.357s)
[598.611204] Starting dynamic subtest: gt0-bcs0
[622.878729] Dynamic subtest gt0-bcs0: SUCCESS (24.273s)
[622.888069] Starting dynamic subtest: gt0-ccs0
[647.087183] Dynamic subtest gt0-ccs0: SUCCESS (24.205s)
[647.098647] Starting dynamic subtest: gt1-vcs0
[653.261198] Dynamic subtest gt1-vcs0: SUCCESS (6.170s)
[653.273244] Starting dynamic subtest: gt1-vecs0
[659.434955] Dynamic subtest gt1-vecs0: SUCCESS (6.168s)
[659.437689] Subtest rc6-idle: SUCCESS (85.227s)
[659.536071] [115/133] (361s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[659.641804] Starting subtest: fbc-modesetfrombusy
[663.488914] Subtest fbc-modesetfrombusy: SUCCESS (3.850s)
[664.683250] [116/133] (356s left) kms_psr (psr-cursor-render)
[664.785280] Starting subtest: psr-cursor-render
[664.787694] Starting dynamic subtest: eDP-1
[666.556317] Dynamic subtest eDP-1: SUCCESS (1.771s)
[666.558680] Subtest psr-cursor-render: SUCCESS (1.772s)
[667.448284] [117/133] (353s left) gem_exec_parallel (engines)
[667.519390] Starting subtest: engines
[667.521789] Starting dynamic subtest: basic
[670.872397] Dynamic subtest basic: SUCCESS (3.350s)
[670.885073] Starting dynamic subtest: contexts
[675.417323] Dynamic subtest contexts: SUCCESS (4.543s)
[675.427339] Starting dynamic subtest: fds
[679.147970] Dynamic subtest fds: SUCCESS (3.727s)
[679.164253] Starting dynamic subtest: userptr
[680.886085] Dynamic subtest userptr: SUCCESS (1.736s)
[680.888329] Subtest engines: SUCCESS (13.366s)
[681.101162] [118/133] (340s left) prime_busy (after)
[681.175995] Starting subtest: after
[681.178261] Starting dynamic subtest: rcs0
[681.227723] Dynamic subtest rcs0: SUCCESS (0.050s)
[681.239445] Starting dynamic subtest: bcs0
[681.270275] Dynamic subtest bcs0: SUCCESS (0.041s)
[681.279681] Starting dynamic subtest: vcs0
[681.310983] Dynamic subtest vcs0: SUCCESS (0.041s)
[681.320898] Starting dynamic subtest: vcs1
[681.352703] Dynamic subtest vcs1: SUCCESS (0.041s)
[681.362585] Starting dynamic subtest: vecs0
[681.393834] Dynamic subtest vecs0: SUCCESS (0.040s)
[681.405864] Starting dynamic subtest: ccs0
[681.436644] Dynamic subtest ccs0: SUCCESS (0.042s)
[681.545709] Subtest after: SUCCESS (0.370s)
[681.646992] [119/133] (339s left) gem_partial_pwrite_pread (write-display)
[681.711295] Subtest write-display: SKIP (0.000s)
[681.808763] [120/133] (339s left) gem_tiled_blits (basic)
[681.878277] Subtest basic: SKIP (0.000s)
[681.974455] [121/133] (339s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[682.077509] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[690.782916] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.708s)
[690.910559] [122/133] (330s left) sysfs_defaults (readonly)
[690.965897] Starting subtest: readonly
[690.968210] Starting dynamic subtest: vecs0
[690.970438] Dynamic subtest vecs0: SUCCESS (0.000s)
[690.980125] Starting dynamic subtest: ccs0
[690.982121] Dynamic subtest ccs0: SUCCESS (0.000s)
[690.993395] Starting dynamic subtest: vcs0
[690.995291] Dynamic subtest vcs0: SUCCESS (0.000s)
[691.004525] Starting dynamic subtest: bcs0
[691.006453] Dynamic subtest bcs0: SUCCESS (0.000s)
[691.015864] Starting dynamic subtest: rcs0
[691.018200] Dynamic subtest rcs0: SUCCESS (0.000s)
[691.027728] Starting dynamic subtest: vcs1
[691.029660] Dynamic subtest vcs1: SUCCESS (0.000s)
[691.031589] Subtest readonly: SUCCESS (0.006s)
[691.098766] [123/133] (330s left) kms_dsc (dsc-with-formats)
[691.184377] Starting subtest: dsc-with-formats
[691.224510] Subtest dsc-with-formats: SKIP (0.001s)
[691.283407] [124/133] (330s left) prime_mmap (test_reprime)
[691.347337] Starting subtest: test_reprime
[691.349557] Starting dynamic subtest: test_reprime-smem
[691.381161] Dynamic subtest test_reprime-smem: SUCCESS (0.036s)
[691.383596] Subtest test_reprime: SUCCESS (0.037s)
[691.505127] [125/133] (330s left) gem_exec_params (rsvd2-dirt)
[691.564980] Starting subtest: rsvd2-dirt
[691.569571] Subtest rsvd2-dirt: SKIP (0.000s)
[691.685962] [126/133] (330s left) kms_lease (lessee-list)
[691.778123] Starting subtest: lessee-list
[691.780302] Starting dynamic subtest: pipe-A-eDP-1
[691.782203] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[691.794898] Starting dynamic subtest: pipe-B-eDP-1
[691.796650] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[691.806097] Starting dynamic subtest: pipe-C-eDP-1
[691.807848] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[691.816997] Starting dynamic subtest: pipe-D-eDP-1
[691.818858] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[691.820684] Subtest lessee-list: SUCCESS (0.008s)
[691.919151] [127/133] (329s left) kms_vrr (flip-dpms)
[692.010447] Starting subtest: flip-dpms
[692.015716] Subtest flip-dpms: SKIP (0.000s)
[692.109535] [128/133] (329s left) kms_frontbuffer_tracking (fbc-1p-rte)
[692.221122] Starting subtest: fbc-1p-rte
[697.730783] Subtest fbc-1p-rte: SUCCESS (5.512s)
[698.970738] [129/133] (322s left) gen9_exec_parse (batch-zero-length)
[699.034245] Subtest batch-zero-length: SKIP (0.000s)
[699.107656] [130/133] (322s left) prime_mmap (test_aperture_limit)
[699.156811] Starting subtest: test_aperture_limit
[699.158684] Starting dynamic subtest: test_aperture_limit-smem
[699.165523] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[699.169852] Subtest test_aperture_limit: SKIP (0.008s)
[699.307446] [131/133] (322s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[699.419598] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[699.423969] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[699.563567] [132/133] (322s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[699.656418] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[699.660364] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[699.783050] [133/133] (322s left) gem_exec_fence (long-history)
[700.255774] Starting subtest: long-history
[707.671097] Subtest long-history: SUCCESS (7.417s)
[708.551687] 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.