[58.922232] Initializing watchdogs
[58.922275]   /dev/watchdog0
[58.936444] [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.940830] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.943092] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.946396] [001/133] (960s left) gem_pxp (verify-pxp-stale-ctx-execution)
[59.087827] Starting subtest: verify-pxp-stale-ctx-execution
[60.154024] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.063s)
[60.280167] [002/133] (959s left) kms_psr (fbc-psr-sprite-blt)
[60.376888] Starting subtest: fbc-psr-sprite-blt
[60.378855] Starting dynamic subtest: eDP-1
[60.383040] Dynamic subtest eDP-1: SKIP (0.000s)
[60.387198] Subtest fbc-psr-sprite-blt: SKIP (0.000s)
[60.445215] [003/133] (959s left) syncobj_wait (invalid-signal-illegal-handle)
[60.502693] Starting subtest: invalid-signal-illegal-handle
[60.505081] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[60.607975] [004/133] (958s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[60.705950] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[61.842868] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.135s)
[61.952542] [005/133] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[62.056411] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[62.059784] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[62.164036] [006/133] (957s left) gem_wait (busy)
[62.234416] Starting subtest: busy
[62.236518] Starting dynamic subtest: all-engines
[63.895881] Dynamic subtest all-engines: SUCCESS (1.656s)
[63.906795] Starting dynamic subtest: rcs0
[64.438615] Dynamic subtest rcs0: SUCCESS (0.542s)
[64.448859] Starting dynamic subtest: bcs0
[64.979062] Dynamic subtest bcs0: SUCCESS (0.539s)
[64.989033] Starting dynamic subtest: vcs0
[66.902473] Dynamic subtest vcs0: SUCCESS (1.919s)
[66.912655] Starting dynamic subtest: vcs1
[68.884853] Dynamic subtest vcs1: SUCCESS (1.980s)
[68.897064] Starting dynamic subtest: vecs0
[70.932610] Dynamic subtest vecs0: SUCCESS (2.046s)
[70.943141] Starting dynamic subtest: ccs0
[71.473289] Dynamic subtest ccs0: SUCCESS (0.540s)
[71.475950] Subtest busy: SUCCESS (9.228s)
[71.669870] [007/133] (947s left) gem_eio (wait-10ms)
[71.887862] Starting subtest: wait-10ms
[72.200060] Subtest wait-10ms: SUCCESS (0.314s)
[72.351955] [008/133] (947s left) kms_cdclk (mode-transition)
[72.454204] Starting subtest: mode-transition
[72.456553] Starting dynamic subtest: pipe-A-eDP-1
[72.755472] Dynamic subtest pipe-A-eDP-1: SKIP (0.299s)
[72.764150] Starting dynamic subtest: pipe-B-eDP-1
[72.768866] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[72.777285] Starting dynamic subtest: pipe-C-eDP-1
[72.781987] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[72.789406] Starting dynamic subtest: pipe-D-eDP-1
[72.793602] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[72.797783] Subtest mode-transition: SKIP (0.304s)
[73.546636] [009/133] (946s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[73.640329] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[73.645048] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[73.736451] [010/133] (946s left) kms_async_flips (alternate-sync-async-flip)
[73.833028] Starting subtest: alternate-sync-async-flip
[74.208779] Starting dynamic subtest: pipe-A-eDP-1
[77.044472] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.836s)
[77.427072] Starting dynamic subtest: pipe-B-eDP-1
[80.178182] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.757s)
[80.544071] Starting dynamic subtest: pipe-C-eDP-1
[83.303738] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.767s)
[83.668360] Starting dynamic subtest: pipe-D-eDP-1
[86.440026] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.778s)
[86.442071] Subtest alternate-sync-async-flip: SUCCESS (12.604s)
[87.612718] [011/133] (932s left) gem_exec_schedule (timeslicing)
[87.689340] Starting subtest: timeslicing
[87.691441] Starting dynamic subtest: rcs0
[87.698715] Dynamic subtest rcs0: SUCCESS (0.021s)
[87.708737] Starting dynamic subtest: bcs0
[87.718695] Dynamic subtest bcs0: SUCCESS (0.020s)
[87.726421] Starting dynamic subtest: vcs0
[87.738595] Dynamic subtest vcs0: SUCCESS (0.019s)
[87.746503] Starting dynamic subtest: vcs1
[87.757797] Dynamic subtest vcs1: SUCCESS (0.019s)
[87.765614] Starting dynamic subtest: vecs0
[87.778059] Dynamic subtest vecs0: SUCCESS (0.020s)
[87.787245] Starting dynamic subtest: ccs0
[87.799574] Dynamic subtest ccs0: SUCCESS (0.020s)
[87.801741] Subtest timeslicing: SUCCESS (0.122s)
[88.950865] [012/133] (930s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[89.004771] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[89.114334] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.109s)
[89.199256] [013/133] (930s left) perf (polling-small-buf)
[89.327695] Starting subtest: polling-small-buf
[89.418107] Subtest polling-small-buf: SUCCESS (0.089s)
[89.461903] [014/133] (930s left) kms_hdr (invalid-hdr)
[89.555059] Starting subtest: invalid-hdr
[91.623075] Starting dynamic subtest: pipe-A-eDP-1
[94.503818] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.880s)
[94.505941] Subtest invalid-hdr: SUCCESS (4.949s)
[94.606203] [015/133] (925s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[94.713492] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[94.717641] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[94.804539] [016/133] (925s left) gem_exec_params (rel-constants-invalid-ring)
[94.862561] Starting subtest: rel-constants-invalid-ring
[94.864407] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[94.954160] [017/133] (925s left) kms_plane_multiple (tiling-y)
[95.039024] Starting subtest: tiling-y
[95.043271] Subtest tiling-y: SKIP (0.000s)
[95.112546] [018/133] (924s left) kms_flip (flip-vs-rmfb)
[95.210990] Starting subtest: flip-vs-rmfb
[95.213407] Starting dynamic subtest: A-eDP1
[103.833363] Dynamic subtest A-eDP1: SUCCESS (8.623s)
[103.842789] Starting dynamic subtest: B-eDP1
[112.469660] Dynamic subtest B-eDP1: SUCCESS (8.634s)
[112.484323] Starting dynamic subtest: C-eDP1
[121.097882] Dynamic subtest C-eDP1: SUCCESS (8.625s)
[121.105661] Starting dynamic subtest: D-eDP1
[129.728165] Dynamic subtest D-eDP1: SUCCESS (8.628s)
[129.732779] Subtest flip-vs-rmfb: SUCCESS (34.523s)
[130.922541] [019/133] (889s left) kms_addfb_basic (addfb25-bad-modifier)
[131.024196] Starting subtest: addfb25-bad-modifier
[131.026524] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[131.117838] [020/133] (889s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[131.223694] Starting subtest: yf-tiled-16bpp-rotate-0
[131.227843] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[131.308925] [021/133] (888s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[131.422293] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[133.611055] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (2.188s)
[133.729361] [022/133] (886s left) syncobj_timeline (invalid-transfer-illegal-handle)
[133.791782] Starting subtest: invalid-transfer-illegal-handle
[133.793837] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[133.902609] [023/133] (886s left) kms_cursor_crc (cursor-onscreen-64x21)
[134.088177] Starting subtest: cursor-onscreen-64x21
[134.132080] Subtest cursor-onscreen-64x21: SKIP (0.039s)
[134.355593] [024/133] (885s left) gem_ctx_persistence (engines-hostile)
[134.417479] Starting subtest: engines-hostile
[134.419458] Starting dynamic subtest: rcs0
[134.498151] Dynamic subtest rcs0: SUCCESS (0.080s)
[134.510336] Starting dynamic subtest: bcs0
[134.616171] Dynamic subtest bcs0: SUCCESS (0.116s)
[134.627039] Starting dynamic subtest: vcs0
[134.699051] Dynamic subtest vcs0: SUCCESS (0.081s)
[134.710361] Starting dynamic subtest: vcs1
[134.830619] Dynamic subtest vcs1: SUCCESS (0.129s)
[134.841043] Starting dynamic subtest: vecs0
[134.934483] Dynamic subtest vecs0: SUCCESS (0.102s)
[134.944583] Starting dynamic subtest: ccs0
[135.062021] Dynamic subtest ccs0: SUCCESS (0.126s)
[135.064165] Subtest engines-hostile: SUCCESS (0.646s)
[135.142340] [025/133] (885s left) dmabuf_sync_file (export-basic)
[135.216035] Starting subtest: export-basic
[135.220180] Subtest export-basic: SUCCESS (0.005s)
[135.286261] [FACT dmabuf_sync_file (export-basic)] new: kernel.kmod_is_loaded.vgem: true
[135.289627] [026/133] (885s left) kms_psr (fbc-pr-primary-page-flip)
[135.385089] Starting subtest: fbc-pr-primary-page-flip
[135.388838] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[135.468010] [027/133] (884s left) gem_mmap_offset (partial-mmap)
[135.521313] Starting subtest: partial-mmap
[135.523110] Starting dynamic subtest: smem0
[135.525076] Dynamic subtest smem0: SUCCESS (0.003s)
[135.526709] Subtest partial-mmap: SUCCESS (0.004s)
[135.647489] [028/133] (884s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[135.739345] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[135.741235] Starting dynamic subtest: pipe-A
[135.760844] Dynamic subtest pipe-A: SKIP (0.017s)
[135.769107] Starting dynamic subtest: pipe-B
[135.792859] Dynamic subtest pipe-B: SKIP (0.033s)
[135.800910] Starting dynamic subtest: pipe-C
[135.822172] Dynamic subtest pipe-C: SKIP (0.029s)
[135.829475] Starting dynamic subtest: pipe-D
[135.851484] Dynamic subtest pipe-D: SKIP (0.028s)
[135.854851] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.109s)
[135.959681] [029/133] (884s left) syncobj_timeline (wait-any-snapshot)
[136.029014] Starting subtest: wait-any-snapshot
[136.109483] Subtest wait-any-snapshot: SUCCESS (0.081s)
[136.182347] [030/133] (884s left) perf_pmu (busy-accuracy-50)
[136.219713] Starting subtest: busy-accuracy-50
[136.221538] Starting dynamic subtest: rcs0
[137.760393] Dynamic subtest rcs0: SUCCESS (1.537s)
[137.771757] Starting dynamic subtest: bcs0
[139.304065] Dynamic subtest bcs0: SUCCESS (1.541s)
[139.314786] Starting dynamic subtest: vcs0
[140.848198] Dynamic subtest vcs0: SUCCESS (1.541s)
[140.858915] Starting dynamic subtest: vcs1
[142.383846] Dynamic subtest vcs1: SUCCESS (1.535s)
[142.393862] Starting dynamic subtest: vecs0
[143.924272] Dynamic subtest vecs0: SUCCESS (1.537s)
[143.932603] Starting dynamic subtest: ccs0
[145.472170] Dynamic subtest ccs0: SUCCESS (1.544s)
[145.474629] Subtest busy-accuracy-50: SUCCESS (9.249s)
[146.017217] [031/133] (874s left) syncobj_wait (reset-during-wait-for-submit)
[146.074173] Starting subtest: reset-during-wait-for-submit
[146.177071] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[146.255996] [032/133] (874s left) gem_exec_whisper (basic-normal-all)
[146.324853] Starting subtest: basic-normal-all
[149.752885] Subtest basic-normal-all: SUCCESS (3.425s)
[149.937287] [033/133] (870s left) kms_chamelium_hpd (hdmi-hpd)
[150.316940] Subtest hdmi-hpd: SKIP (0.000s)
[151.164445] [034/133] (869s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[151.267904] Starting subtest: psr2-overlay-plane-move-continuous-sf
[151.270064] Starting dynamic subtest: pipe-A-eDP-1
[157.244550] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.980s)
[157.254763] Starting dynamic subtest: pipe-B-eDP-1
[163.949140] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.702s)
[163.951309] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (12.685s)
[164.822884] [035/133] (855s left) gem_exec_fence (basic-busy)
[165.008967] Starting subtest: basic-busy
[165.011640] Starting dynamic subtest: rcs0
[165.094359] Dynamic subtest rcs0: SUCCESS (0.086s)
[165.105371] Starting dynamic subtest: bcs0
[165.147695] Dynamic subtest bcs0: SUCCESS (0.051s)
[165.158942] Starting dynamic subtest: vcs0
[165.199322] Dynamic subtest vcs0: SUCCESS (0.050s)
[165.209943] Starting dynamic subtest: vcs1
[165.252281] Dynamic subtest vcs1: SUCCESS (0.051s)
[165.262935] Starting dynamic subtest: vecs0
[165.306327] Dynamic subtest vecs0: SUCCESS (0.052s)
[165.316831] Starting dynamic subtest: ccs0
[165.355286] Dynamic subtest ccs0: SUCCESS (0.047s)
[165.357718] Subtest basic-busy: SUCCESS (0.348s)
[167.005212] [036/133] (853s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[167.113198] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[167.117574] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[167.215461] [037/133] (853s left) gem_ctx_shared (detached-shared-gtt)
[167.281890] Starting subtest: detached-shared-gtt
[169.434695] Subtest detached-shared-gtt: SUCCESS (2.152s)
[169.828383] [038/133] (851s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[169.934116] Starting subtest: psr2-cursor-plane-move-continuous-sf
[169.936448] Starting dynamic subtest: pipe-A-eDP-1
[180.303923] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.370s)
[180.312495] Starting dynamic subtest: pipe-B-eDP-1
[191.405626] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.103s)
[191.408087] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.475s)
[192.203451] [039/133] (828s left) gem_partial_pwrite_pread (reads)
[192.278733] Subtest reads: SKIP (0.000s)
[192.343914] [040/133] (828s left) perf_pmu (idle-no-semaphores)
[192.384469] Starting subtest: idle-no-semaphores
[192.386742] Starting dynamic subtest: rcs0
[192.919309] Dynamic subtest rcs0: SUCCESS (0.535s)
[192.931648] Starting dynamic subtest: bcs0
[193.436120] Dynamic subtest bcs0: SUCCESS (0.514s)
[193.447661] Starting dynamic subtest: vcs0
[193.970386] Dynamic subtest vcs0: SUCCESS (0.531s)
[193.981206] Starting dynamic subtest: vcs1
[194.488365] Dynamic subtest vcs1: SUCCESS (0.514s)
[194.500046] Starting dynamic subtest: vecs0
[195.015784] Dynamic subtest vecs0: SUCCESS (0.525s)
[195.027313] Starting dynamic subtest: ccs0
[195.536081] Dynamic subtest ccs0: SUCCESS (0.517s)
[195.539067] Subtest idle-no-semaphores: SUCCESS (3.155s)
[195.643988] [041/133] (825s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[195.739472] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[195.743909] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[195.836741] [042/133] (825s left) kms_addfb_basic (bo-too-small)
[195.921263] Starting subtest: bo-too-small
[195.923156] Subtest bo-too-small: SUCCESS (0.000s)
[196.003344] [043/133] (825s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[196.184140] Starting subtest: cursor-rapid-movement-32x10
[196.240789] Subtest cursor-rapid-movement-32x10: SKIP (0.051s)
[196.518876] [044/133] (824s left) kms_color (ctm-signed)
[196.608418] Starting subtest: ctm-signed
[196.610049] Starting dynamic subtest: pipe-A-eDP-1
[198.682702] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.075s)
[198.692063] Starting dynamic subtest: pipe-B-eDP-1
[201.531210] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.848s)
[201.540716] Starting dynamic subtest: pipe-C-eDP-1
[204.163176] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.631s)
[204.171775] Starting dynamic subtest: pipe-D-eDP-1
[206.829682] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.666s)
[206.832082] Subtest ctm-signed: SUCCESS (10.223s)
[207.688363] [045/133] (813s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[207.787088] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[207.791597] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[207.890113] [046/133] (813s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[207.963424] Starting subtest: y-tiled-to-vebox-x-tiled
[207.967586] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[208.146551] [047/133] (813s left) i915_pm_rps (min-max-config-idle)
[208.215446] Starting subtest: min-max-config-idle
[208.220035] Subtest min-max-config-idle: SKIP (0.001s)
[208.286296] [048/133] (813s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[208.382455] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[208.386703] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[208.463868] [049/133] (812s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[208.553726] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[208.555857] Starting dynamic subtest: pipe-A-eDP-1
[208.615369] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[208.625979] Starting dynamic subtest: pipe-B-eDP-1
[208.681331] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[208.691188] Starting dynamic subtest: pipe-C-eDP-1
[208.748413] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[208.758240] Starting dynamic subtest: pipe-D-eDP-1
[208.816350] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[208.820868] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[210.748450] [050/133] (810s left) kms_chamelium_edid (vga-edid-read)
[211.138795] Subtest vga-edid-read: SKIP (0.000s)
[211.959889] [051/133] (809s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[212.051742] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[212.055779] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[212.162432] [052/133] (809s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[212.260027] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[212.262237] Starting dynamic subtest: pipe-A-eDP-1
[212.333126] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[212.344911] Starting dynamic subtest: pipe-B-eDP-1
[213.449686] Dynamic subtest pipe-B-eDP-1: SKIP (1.114s)
[213.454282] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.194s)
[214.629498] [053/133] (806s left) kms_flip (2x-flip-vs-suspend-interruptible)
[214.723525] Starting subtest: 2x-flip-vs-suspend-interruptible
[214.735337] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.010s)
[214.836784] [054/133] (806s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[214.931088] Starting subtest: bad-rotation-90-yf-tiled-ccs
[214.933360] Starting dynamic subtest: pipe-A-eDP-1
[214.956514] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[214.965693] Starting dynamic subtest: pipe-B-eDP-1
[214.987613] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[214.995836] Starting dynamic subtest: pipe-C-eDP-1
[215.017497] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[215.028084] Starting dynamic subtest: pipe-D-eDP-1
[215.050235] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[215.054666] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.004s)
[217.188506] [055/133] (804s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[217.291343] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[217.295772] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[217.402916] [056/133] (804s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[217.494260] Starting subtest: plane-upscale-20x20-with-rotation
[217.496638] Starting dynamic subtest: pipe-A
[217.732086] Dynamic subtest pipe-A: SUCCESS (0.238s)
[217.742188] Starting dynamic subtest: pipe-B
[219.062926] Dynamic subtest pipe-B: SUCCESS (1.330s)
[219.071462] Starting dynamic subtest: pipe-C
[220.390169] Dynamic subtest pipe-C: SUCCESS (1.326s)
[220.399349] Starting dynamic subtest: pipe-D
[221.715059] Dynamic subtest pipe-D: SUCCESS (1.324s)
[221.717273] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.222s)
[222.889265] [057/133] (798s left) gem_ppgtt (shrink-vs-evict-pinned)
[222.947066] Starting subtest: shrink-vs-evict-pinned
[228.911696] Subtest shrink-vs-evict-pinned: SUCCESS (5.963s)
[229.015975] [058/133] (792s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[229.115327] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[236.558336] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.445s)
[236.695814] [059/133] (785s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[236.780273] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[236.784759] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[236.854977] [060/133] (784s left) kms_pm_rpm (basic-pci-d3-state)
[239.001594] Starting subtest: basic-pci-d3-state
[240.495089] Subtest basic-pci-d3-state: SUCCESS (1.497s)
[240.622602] [061/133] (781s left) i915_pm_rps (waitboost)
[240.688657] Starting subtest: waitboost
[246.786594] Subtest waitboost: SUCCESS (6.098s)
[246.912245] [062/133] (774s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[247.003034] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[247.005335] Starting dynamic subtest: pipe-A-eDP-1
[247.027929] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[247.037691] Starting dynamic subtest: pipe-B-eDP-1
[247.060460] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[247.070561] Starting dynamic subtest: pipe-C-eDP-1
[247.091839] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[247.102137] Starting dynamic subtest: pipe-D-eDP-1
[247.123990] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[247.128257] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s)
[249.325129] [063/133] (772s left) gem_ctx_shared (create-shared-gtt)
[249.388016] Starting subtest: create-shared-gtt
[251.542791] Subtest create-shared-gtt: SUCCESS (2.153s)
[251.857060] [064/133] (770s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[251.980265] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[252.939253] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.959s)
[253.748608] [065/133] (768s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[253.856781] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[253.861160] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[253.973167] [066/133] (768s left) gem_userptr_blits (coherency-unsync)
[254.045329] Subtest coherency-unsync: SKIP (0.000s)
[254.171145] [067/133] (767s left) kms_flip (plain-flip-fb-recreate-interruptible)
[254.269149] Starting subtest: plain-flip-fb-recreate-interruptible
[254.271454] Starting dynamic subtest: A-eDP1
[263.128849] Dynamic subtest A-eDP1: SUCCESS (8.859s)
[263.138688] Starting dynamic subtest: B-eDP1
[271.959611] Dynamic subtest B-eDP1: SUCCESS (8.829s)
[271.977067] Starting dynamic subtest: C-eDP1
[280.775727] Dynamic subtest C-eDP1: SUCCESS (8.813s)
[280.786758] Starting dynamic subtest: D-eDP1
[289.606287] Dynamic subtest D-eDP1: SUCCESS (8.827s)
[289.610964] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.342s)
[290.780483] [068/133] (731s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[290.902309] Starting subtest: cursorA-vs-flipB-atomic-transitions
[290.906646] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[291.045638] [069/133] (731s left) kms_selftest (drm_format)
[291.090833] Starting subtest: drm_format
[291.125727] Starting dynamic subtest: drm_test_format_block_width_invalid
[291.254389] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.128s)
[291.269043] Starting dynamic subtest: drm_test_format_block_width_one_plane
[291.362184] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.108s)
[291.372672] Starting dynamic subtest: drm_test_format_block_width_two_plane
[291.455206] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.092s)
[291.465214] Starting dynamic subtest: drm_test_format_block_width_three_plane
[291.548339] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.092s)
[291.557459] Starting dynamic subtest: drm_test_format_block_width_tiled
[291.670453] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.121s)
[291.679035] Starting dynamic subtest: drm_test_format_block_height_invalid
[291.765682] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.095s)
[291.774073] Starting dynamic subtest: drm_test_format_block_height_one_plane
[291.869314] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.103s)
[291.878879] Starting dynamic subtest: drm_test_format_block_height_two_plane
[291.950320] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.080s)
[291.959489] Starting dynamic subtest: drm_test_format_block_height_three_plane
[292.056535] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.106s)
[292.064483] Starting dynamic subtest: drm_test_format_block_height_tiled
[292.165347] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.107s)
[292.174963] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[292.255399] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.090s)
[292.263638] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[292.345106] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.089s)
[292.354613] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[292.458165] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.111s)
[292.467875] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[292.565327] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.107s)
[292.574880] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[292.666345] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.099s)
[292.676262] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[292.760843] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.095s)
[292.769283] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[292.844327] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.082s)
[292.852529] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[292.935233] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.089s)
[292.937235] Subtest drm_format: SUCCESS (1.845s)
[293.096351] [070/133] (729s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[293.161580] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[293.233393] [071/133] (729s left) gem_pread (snoop)
[293.289613] Subtest snoop: SKIP (0.000s)
[293.346861] [072/133] (728s left) kms_async_flips (test-time-stamp)
[293.438431] Starting subtest: test-time-stamp
[293.809842] Starting dynamic subtest: pipe-A-eDP-1
[294.583211] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.771s)
[294.972053] Starting dynamic subtest: pipe-B-eDP-1
[295.714937] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.747s)
[296.089932] Starting dynamic subtest: pipe-C-eDP-1
[296.853150] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.768s)
[297.215563] Starting dynamic subtest: pipe-D-eDP-1
[297.973528] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.764s)
[297.975961] Subtest test-time-stamp: SUCCESS (4.534s)
[299.135631] [073/133] (723s left) gem_tiled_fence_blits (basic)
[299.183178] Subtest basic: SKIP (0.000s)
[299.250212] [074/133] (723s left) gem_exec_schedule (fairslice-all)
[299.312779] Starting subtest: fairslice-all
[301.374406] Subtest fairslice-all: SUCCESS (2.068s)
[301.676071] [075/133] (720s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[301.776052] Starting subtest: primary-y-tiled-reflect-x-270
[301.780655] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[301.847118] [076/133] (720s left) drm_read (fault-buffer)
[301.988589] Starting subtest: fault-buffer
[301.990951] Subtest fault-buffer: SUCCESS (0.001s)
[302.104377] [077/133] (720s left) kms_frontbuffer_tracking (fbc-tiling-4)
[302.200905] Starting subtest: fbc-tiling-4
[306.405059] Subtest fbc-tiling-4: SUCCESS (4.208s)
[307.540207] [078/133] (715s left) kms_lease (lease-invalid-connector)
[307.623834] Starting subtest: lease-invalid-connector
[307.626108] Starting dynamic subtest: pipe-A-eDP-1
[307.628245] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[307.636371] Starting dynamic subtest: pipe-B-eDP-1
[307.638241] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[307.646549] Starting dynamic subtest: pipe-C-eDP-1
[307.648694] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[307.656712] Starting dynamic subtest: pipe-D-eDP-1
[307.658616] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[307.660488] Subtest lease-invalid-connector: SUCCESS (0.004s)
[307.707714] [079/133] (714s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[307.834464] Starting subtest: short-flip-after-cursor-toggle
[308.754397] Subtest short-flip-after-cursor-toggle: SUCCESS (0.920s)
[309.548854] [080/133] (713s left) gem_userptr_blits (create-destroy-sync)
[309.612474] Starting subtest: create-destroy-sync
[314.629726] Subtest create-destroy-sync: SUCCESS (5.016s)
[314.781464] [081/133] (707s left) kms_invalid_mode (bad-vtotal)
[314.871396] Starting subtest: bad-vtotal
[314.873649] Starting dynamic subtest: pipe-A-eDP-1
[315.172640] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.303s)
[315.181818] Starting dynamic subtest: pipe-B-eDP-1
[315.184033] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[315.192119] Starting dynamic subtest: pipe-C-eDP-1
[315.194228] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[315.202214] Starting dynamic subtest: pipe-D-eDP-1
[315.204496] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[315.206716] Subtest bad-vtotal: SUCCESS (0.309s)
[315.998313] [082/133] (706s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[316.093036] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[316.095213] Starting dynamic subtest: pipe-A-eDP-1
[316.945090] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.845s)
[316.957477] Starting dynamic subtest: pipe-B-eDP-1
[318.486174] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.540s)
[318.495582] Starting dynamic subtest: pipe-C-eDP-1
[319.994708] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.507s)
[320.004128] Starting dynamic subtest: pipe-D-eDP-1
[321.521419] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.523s)
[321.523699] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.420s)
[322.736225] [083/133] (700s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[323.273494] Starting subtest: syncobj-stationary-timeline-chain-engines
[323.396604] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.127s)
[324.981241] [084/133] (697s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[325.076759] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[325.081232] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[325.189652] [085/133] (697s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[325.283418] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[325.287510] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[325.363454] [086/133] (697s left) kms_flip (2x-nonexisting-fb-interruptible)
[325.453831] Starting subtest: 2x-nonexisting-fb-interruptible
[325.465641] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.010s)
[325.552122] [087/133] (697s left) i915_hangman (error-state-basic)
[325.615860] Starting subtest: error-state-basic
[325.760926] Subtest error-state-basic: SUCCESS (0.145s)
[325.835715] [088/133] (697s left) gen9_exec_parse (batch-invalid-length)
[325.898558] Subtest batch-invalid-length: SKIP (0.000s)
[325.965070] [089/133] (697s left) gem_flink_basic (bad-open)
[326.014428] Starting subtest: bad-open
[326.016082] Subtest bad-open: SUCCESS (0.000s)
[326.138345] [090/133] (696s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[326.238993] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[326.242653] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[326.334889] [091/133] (696s left) gem_exec_balancer (invalid-bonds)
[326.395294] Starting subtest: invalid-bonds
[326.399187] Subtest invalid-bonds: SKIP (0.000s)
[326.700378] [092/133] (696s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[328.233424] Starting subtest: modeset-lpsp-stress-no-wait
[338.312422] Subtest modeset-lpsp-stress-no-wait: SUCCESS (10.083s)
[338.437495] [093/133] (684s left) syncobj_basic (test-valid-cycle)
[338.499496] Starting subtest: test-valid-cycle
[338.501400] Subtest test-valid-cycle: SUCCESS (0.000s)
[338.598427] [094/133] (684s left) gem_huc_copy (huc-copy)
[338.659505] Starting subtest: huc-copy
[338.664753] Subtest huc-copy: SUCCESS (0.004s)
[338.778701] [095/133] (684s left) kms_frontbuffer_tracking (fbc-stridechange)
[338.874473] Starting subtest: fbc-stridechange
[342.162422] Subtest fbc-stridechange: SUCCESS (3.291s)
[343.299939] [096/133] (679s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[343.388853] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[343.391146] Starting dynamic subtest: pipe-A-default-mode
[344.555881] Dynamic subtest pipe-A-default-mode: SKIP (1.165s)
[344.560222] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.167s)
[344.715683] [097/133] (678s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[344.772902] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[344.833682] [098/133] (678s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[344.916066] Starting subtest: basic-max-pipe-crc-check
[344.920453] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[344.966362] [099/133] (678s left) kms_psr (pr-primary-mmap-cpu)
[345.044897] Starting subtest: pr-primary-mmap-cpu
[345.049247] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[345.117916] [100/133] (678s left) kms_vblank (query-forked-hang)
[345.207648] Starting subtest: query-forked-hang
[345.209727] Starting dynamic subtest: pipe-A-eDP-1
[371.684957] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.477s)
[371.700697] Starting dynamic subtest: pipe-D-eDP-1
[386.656099] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.964s)
[386.658433] Subtest query-forked-hang: SUCCESS (41.448s)
[387.492933] [101/133] (636s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[387.609849] Starting subtest: 2x-long-flip-vs-cursor-legacy
[387.615749] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[387.754585] [102/133] (635s left) gem_ctx_bad_destroy (double-destroy)
[387.807815] Starting subtest: double-destroy
[387.810074] Subtest double-destroy: SUCCESS (0.000s)
[387.880883] [103/133] (635s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[387.971820] Starting subtest: fbc-indfb-scaledprimary
[390.956880] Subtest fbc-indfb-scaledprimary: SUCCESS (2.989s)
[392.095442] [104/133] (631s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[392.188087] Starting subtest: 2x-flip-vs-rmfb-interruptible
[392.198746] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.011s)
[392.275091] [105/133] (631s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[392.337435] Starting subtest: multi-wait-available-submitted-signaled
[392.339638] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s)
[392.457710] [106/133] (631s left) gem_shrink (reclaim)
[392.523070] Starting subtest: reclaim
[394.905422] Subtest reclaim: SUCCESS (2.382s)
[395.025398] [107/133] (628s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[395.131534] Starting subtest: yf-tiled-64bpp-rotate-0
[395.136031] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[395.216802] [108/133] (628s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[395.311438] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[395.315821] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[395.416990] [109/133] (628s left) kms_cursor_edge_walk (128x128-top-bottom)
[395.518064] Starting subtest: 128x128-top-bottom
[395.520354] Starting dynamic subtest: pipe-A-eDP-1
[398.953744] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.436s)
[398.963748] Starting dynamic subtest: pipe-D-eDP-1
[402.079408] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.123s)
[402.081798] Subtest 128x128-top-bottom: SUCCESS (6.562s)
[402.882161] [110/133] (621s left) kms_addfb_basic (unused-modifier)
[402.942907] Starting subtest: unused-modifier
[402.945099] Subtest unused-modifier: SUCCESS (0.000s)
[403.078934] [111/133] (620s left) gem_workarounds (basic-read-fd)
[403.145146] Starting subtest: basic-read-fd
[403.162496] Subtest basic-read-fd: SUCCESS (0.016s)
[403.288662] [112/133] (620s left) kms_atomic_transition (plane-all-modeset-transition)
[403.391088] Starting subtest: plane-all-modeset-transition
[403.395305] Subtest plane-all-modeset-transition: SKIP (0.000s)
[403.465861] [113/133] (620s left) kms_psr (psr2-suspend)
[403.561160] Starting subtest: psr2-suspend
[403.563337] Starting dynamic subtest: eDP-1
[421.703010] Dynamic subtest eDP-1: SUCCESS (3.709s)
[421.705362] Subtest psr2-suspend: SUCCESS (3.710s)
[422.599247] [114/133] (601s left) gem_busy (semaphore)
[422.792546] Subtest semaphore: SKIP (0.000s)
[423.003547] [115/133] (601s left) sysfs_timeslice_duration (timeout)
[423.054596] Starting subtest: timeout
[423.056882] Starting dynamic subtest: vecs0
[432.303589] Dynamic subtest vecs0: SUCCESS (9.153s)
[432.315863] Starting dynamic subtest: ccs0
[433.527845] Dynamic subtest ccs0: SUCCESS (1.219s)
[433.543674] Starting dynamic subtest: vcs0
[443.311877] Dynamic subtest vcs0: SUCCESS (9.752s)
[443.325070] Starting dynamic subtest: bcs0
[443.915880] Dynamic subtest bcs0: SUCCESS (0.603s)
[443.925945] Starting dynamic subtest: rcs0
[445.145600] Dynamic subtest rcs0: SUCCESS (1.225s)
[445.157894] Starting dynamic subtest: vcs1
[454.324998] Dynamic subtest vcs1: SUCCESS (9.168s)
[454.327879] Subtest timeout: SUCCESS (31.133s)
[454.402311] [116/133] (569s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[454.500355] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[454.504312] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[454.600006] [117/133] (569s left) kms_dp_aux_dev
[454.944456] [118/133] (569s left) gem_exec_schedule (implicit-read-write)
[455.014199] Starting subtest: implicit-read-write
[455.016127] Starting dynamic subtest: rcs0
[455.143816] Dynamic subtest rcs0: SUCCESS (0.131s)
[455.157147] Starting dynamic subtest: vcs0
[455.221460] Dynamic subtest vcs0: SUCCESS (0.077s)
[455.235725] Starting dynamic subtest: vcs1
[455.307499] Dynamic subtest vcs1: SUCCESS (0.085s)
[455.320707] Starting dynamic subtest: vecs0
[455.389872] Dynamic subtest vecs0: SUCCESS (0.081s)
[455.402326] Starting dynamic subtest: ccs0
[455.476493] Dynamic subtest ccs0: SUCCESS (0.086s)
[455.478872] Subtest implicit-read-write: SUCCESS (0.466s)
[456.413562] [119/133] (567s left) kms_content_protection (dp-mst-type-1)
[456.550940] Starting subtest: dp-mst-type-1
[456.555501] Subtest dp-mst-type-1: SKIP (0.000s)
[456.668565] [120/133] (567s left) gem_softpin (allocator-nopin)
[456.717037] Starting subtest: allocator-nopin
[456.798429] Subtest allocator-nopin: SUCCESS (0.081s)
[456.913462] [121/133] (567s left) gem_ctx_engines (none)
[456.976551] Starting subtest: none
[456.978790] Subtest none: SUCCESS (0.001s)
[457.159195] [122/133] (567s left) kms_feature_discovery (display-2x)
[457.261180] Starting subtest: display-2x
[457.265638] Subtest display-2x: SKIP (0.000s)
[457.352264] [123/133] (567s left) gem_exec_reloc (basic-wc)
[457.407640] Subtest basic-wc: SKIP (0.000s)
[457.477353] [124/133] (567s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[457.531404] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[457.634210] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[457.718396] [125/133] (566s left) kms_busy (basic)
[457.818130] Starting subtest: basic
[457.820533] Starting dynamic subtest: flip
[458.412924] Dynamic subtest flip: SUCCESS (0.596s)
[458.423042] Starting dynamic subtest: modeset
[462.114346] Dynamic subtest modeset: SUCCESS (3.701s)
[462.116723] Subtest basic: SUCCESS (4.300s)
[462.922069] [126/133] (561s left) core_getclient (basic)
[462.974919] Starting subtest: basic
[462.976852] Subtest basic: SUCCESS (0.000s)
[463.063252] [127/133] (561s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[463.166432] Starting subtest: 4-tiled-64bpp-rotate-270
[463.185755] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.019s)
[463.323787] [128/133] (561s left) i915_drm_fdinfo (context-close-stress)
[463.362850] Starting subtest: context-close-stress
[474.107680] Subtest context-close-stress: SUCCESS (10.743s)
[474.196114] [129/133] (550s left) api_intel_bb (bb-with-allocator)
[474.379417] Starting subtest: bb-with-allocator
[474.386428] Subtest bb-with-allocator: SUCCESS (0.010s)
[474.520921] [130/133] (550s left) kms_scaling_modes (scaling-mode-center)
[474.632351] Starting subtest: scaling-mode-center
[474.634249] Starting dynamic subtest: pipe-A-eDP-1
[474.732987] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.102s)
[474.743476] Starting dynamic subtest: pipe-B-eDP-1
[475.934210] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.199s)
[475.947331] Starting dynamic subtest: pipe-C-eDP-1
[477.048653] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.111s)
[477.058458] Starting dynamic subtest: pipe-D-eDP-1
[478.183808] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s)
[478.186167] Subtest scaling-mode-center: SUCCESS (3.553s)
[479.341787] [131/133] (545s left) gen3_render_tiledx_blits
[479.455226] [132/133] (545s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[479.588440] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[479.592871] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[479.735827] [133/133] (545s left) kms_addfb_basic (unused-pitches)
[479.795025] Starting subtest: unused-pitches
[479.797253] Subtest unused-pitches: SUCCESS (0.000s)
[479.941588] Closing watchdogs
results: parsing output: 0/ for test: gem_pxp
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: syncobj_wait
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_wait
results: parsing output: 6/ for test: gem_eio
results: parsing output: 7/ for test: kms_cdclk
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_async_flips
results: parsing output: 10/ for test: gem_exec_schedule
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: perf
results: parsing output: 13/ for test: kms_hdr
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_exec_params
results: parsing output: 16/ for test: kms_plane_multiple
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: kms_addfb_basic
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_cursor_crc
results: parsing output: 23/ for test: gem_ctx_persistence
results: parsing output: 24/ for test: dmabuf_sync_file
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: gem_mmap_offset
results: parsing output: 27/ for test: kms_plane_scaling
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: perf_pmu
results: parsing output: 30/ for test: syncobj_wait
results: parsing output: 31/ for test: gem_exec_whisper
results: parsing output: 32/ for test: kms_chamelium_hpd
results: parsing output: 33/ for test: kms_psr2_sf
results: parsing output: 34/ for test: gem_exec_fence
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_ctx_shared
results: parsing output: 37/ for test: kms_psr2_sf
results: parsing output: 38/ for test: gem_partial_pwrite_pread
results: parsing output: 39/ for test: perf_pmu
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_addfb_basic
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_color
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: gem_render_copy
results: parsing output: 46/ for test: i915_pm_rps
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: kms_chamelium_edid
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_psr2_sf
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_plane_scaling
results: parsing output: 56/ for test: gem_ppgtt
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_plane
results: parsing output: 59/ for test: kms_pm_rpm
results: parsing output: 60/ for test: i915_pm_rps
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: gem_ctx_shared
results: parsing output: 63/ for test: kms_cursor_legacy
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_userptr_blits
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: kms_selftest
results: parsing output: 69/ for test: gem_exec_reloc
results: parsing output: 70/ for test: gem_pread
results: parsing output: 71/ for test: kms_async_flips
results: parsing output: 72/ for test: gem_tiled_fence_blits
results: parsing output: 73/ for test: gem_exec_schedule
results: parsing output: 74/ for test: kms_rotation_crc
results: parsing output: 75/ for test: drm_read
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_lease
results: parsing output: 78/ for test: kms_cursor_legacy
results: parsing output: 79/ for test: gem_userptr_blits
results: parsing output: 80/ for test: kms_invalid_mode
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: gem_exec_fence
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_flip
results: parsing output: 86/ for test: i915_hangman
results: parsing output: 87/ for test: gen9_exec_parse
results: parsing output: 88/ for test: gem_flink_basic
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gem_exec_balancer
results: parsing output: 91/ for test: kms_pm_rpm
results: parsing output: 92/ for test: syncobj_basic
results: parsing output: 93/ for test: gem_huc_copy
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_flip_scaled_crc
results: parsing output: 96/ for test: gem_mmap_gtt
results: parsing output: 97/ for test: kms_multipipe_modeset
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: kms_vblank
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: gem_ctx_bad_destroy
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: gem_shrink
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_cursor_edge_walk
results: parsing output: 109/ for test: kms_addfb_basic
results: parsing output: 110/ for test: gem_workarounds
results: parsing output: 111/ for test: kms_atomic_transition
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: gem_busy
results: parsing output: 114/ for test: sysfs_timeslice_duration
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_dp_aux_dev
results: parsing output: 117/ for test: gem_exec_schedule
results: parsing output: 118/ for test: kms_content_protection
results: parsing output: 119/ for test: gem_softpin
results: parsing output: 120/ for test: gem_ctx_engines
results: parsing output: 121/ for test: kms_feature_discovery
results: parsing output: 122/ for test: gem_exec_reloc
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_busy
results: parsing output: 125/ for test: core_getclient
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: i915_drm_fdinfo
results: parsing output: 128/ for test: api_intel_bb
results: parsing output: 129/ for test: kms_scaling_modes
results: parsing output: 130/ for test: gen3_render_tiledx_blits
results: parsing output: 131/ for test: kms_cursor_legacy
results: parsing output: 132/ for test: kms_addfb_basic
Done.