[57.665536] Initializing watchdogs
[57.665589]   /dev/watchdog0
[57.678093] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.681778] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.683843] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.687091] [001/129] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[57.851129] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[57.855319] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[57.929703] [002/129] (960s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[62.880100] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[62.882542] Starting dynamic subtest: pipe-A-eDP-1
[69.447486] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.601s)
[69.455159] Starting dynamic subtest: pipe-B-eDP-1
[76.036390] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.607s)
[76.039049] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (13.212s)
[76.901895] [003/129] (941s left) gem_mmap_gtt (medium-copy)
[76.965330] Subtest medium-copy: SKIP (0.000s)
[77.018092] [004/129] (941s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[77.115882] Starting subtest: nonblocking-crc-frame-sequence
[77.118154] Starting dynamic subtest: pipe-A-eDP-1
[77.859356] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.743s)
[77.867469] Starting dynamic subtest: pipe-B-eDP-1
[79.297324] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.439s)
[79.305374] Starting dynamic subtest: pipe-C-eDP-1
[80.688458] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.392s)
[80.696038] Starting dynamic subtest: pipe-D-eDP-1
[82.027083] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.340s)
[82.029661] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.917s)
[82.805101] [005/129] (935s left) kms_flip (2x-plain-flip-interruptible)
[82.910634] Starting subtest: 2x-plain-flip-interruptible
[82.922311] Subtest 2x-plain-flip-interruptible: SKIP (0.010s)
[82.989679] [006/129] (935s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[83.047936] Starting subtest: etime-single-wait-for-submit-submitted
[83.151960] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.102s)
[83.216156] [007/129] (935s left) gem_eio (in-flight-external)
[83.428268] Starting subtest: in-flight-external
[84.962097] Subtest in-flight-external: SUCCESS (1.533s)
[85.085576] [008/129] (933s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[85.148973] Starting subtest: invalid-multi-wait-unsubmitted
[85.151122] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[85.258988] [009/129] (933s left) perf (i915-ref-count)
[85.314447] Starting subtest: i915-ref-count
[85.378240] Subtest i915-ref-count: SUCCESS (0.061s)
[85.425453] [010/129] (932s left) gem_eio (wait-wedge-immediate)
[85.647807] Starting subtest: wait-wedge-immediate
[87.006359] Subtest wait-wedge-immediate: SUCCESS (1.360s)
[87.131414] [011/129] (931s left) gem_exec_schedule (fifo)
[87.199120] Starting subtest: fifo
[87.201338] Starting dynamic subtest: rcs0
[87.280858] Dynamic subtest rcs0: SUCCESS (0.092s)
[87.289425] Starting dynamic subtest: vcs0
[87.352937] Dynamic subtest vcs0: SUCCESS (0.072s)
[87.362563] Starting dynamic subtest: vcs1
[87.423473] Dynamic subtest vcs1: SUCCESS (0.071s)
[87.433150] Starting dynamic subtest: vecs0
[87.493141] Dynamic subtest vecs0: SUCCESS (0.070s)
[87.499767] Starting dynamic subtest: ccs0
[87.582078] Dynamic subtest ccs0: SUCCESS (0.089s)
[87.584411] Subtest fifo: SUCCESS (0.393s)
[89.058332] [012/129] (929s left) gem_mmap_wc (bad-object)
[89.111655] Subtest bad-object: SKIP (0.000s)
[89.167572] [013/129] (929s left) gem_exec_schedule (out-order)
[89.230291] Starting subtest: out-order
[89.232456] Starting dynamic subtest: rcs0
[89.331402] Dynamic subtest rcs0: SUCCESS (0.105s)
[89.340954] Starting dynamic subtest: vcs0
[89.408456] Dynamic subtest vcs0: SUCCESS (0.077s)
[89.416106] Starting dynamic subtest: vcs1
[89.483399] Dynamic subtest vcs1: SUCCESS (0.075s)
[89.493561] Starting dynamic subtest: vecs0
[89.555882] Dynamic subtest vecs0: SUCCESS (0.073s)
[89.565145] Starting dynamic subtest: ccs0
[89.688246] Dynamic subtest ccs0: SUCCESS (0.131s)
[89.691061] Subtest out-order: SUCCESS (0.462s)
[91.023678] [014/129] (927s left) gem_softpin (allocator-basic-reserve)
[91.098851] Starting subtest: allocator-basic-reserve
[91.164733] Subtest allocator-basic-reserve: SUCCESS (0.065s)
[91.281933] [015/129] (927s left) core_auth (basic-auth)
[91.339989] Starting subtest: basic-auth
[91.342304] Subtest basic-auth: SUCCESS (0.001s)
[91.433917] [016/129] (927s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[91.555488] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[91.559720] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[91.644090] [017/129] (926s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[91.742051] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[91.744462] Starting dynamic subtest: pipe-A-eDP-1
[91.765406] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[91.774540] Starting dynamic subtest: pipe-B-eDP-1
[91.794392] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[91.801564] Starting dynamic subtest: pipe-C-eDP-1
[91.821718] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[91.829690] Starting dynamic subtest: pipe-D-eDP-1
[91.849643] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[91.851912] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[93.854508] [018/129] (924s left) kms_busy (basic)
[93.950912] Starting subtest: basic
[93.953258] Starting dynamic subtest: flip
[94.579545] Dynamic subtest flip: SUCCESS (0.627s)
[94.586660] Starting dynamic subtest: modeset
[97.965202] Dynamic subtest modeset: SUCCESS (3.385s)
[97.967939] Subtest basic: SUCCESS (4.013s)
[98.752340] [019/129] (919s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[98.805064] Starting subtest: y-tiled-ccs-to-y-tiled
[98.809758] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[98.978103] [020/129] (919s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[99.089930] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[102.490580] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (3.405s)
[102.610865] [021/129] (916s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[102.706612] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[102.710554] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[103.838497] [022/129] (914s left) kms_universal_plane (cursor-fb-leak)
[103.939263] Starting subtest: cursor-fb-leak
[103.941614] Starting dynamic subtest: pipe-A-eDP-1
[104.250319] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.310s)
[104.259644] Starting dynamic subtest: pipe-B-eDP-1
[105.592684] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.342s)
[105.601912] Starting dynamic subtest: pipe-C-eDP-1
[106.907528] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.313s)
[106.914293] Starting dynamic subtest: pipe-D-eDP-1
[108.856499] Dynamic subtest pipe-D-eDP-1: FAIL (1.343s)
[108.858624] Subtest cursor-fb-leak: FAIL (4.312s)
[109.413313] [023/129] (909s left) gem_userptr_blits (sync-unmap-after-close)
[109.474568] Starting subtest: sync-unmap-after-close
[109.487029] Subtest sync-unmap-after-close: SUCCESS (0.010s)
[109.622601] [024/129] (909s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[109.736609] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[114.274681] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (4.541s)
[114.410474] [025/129] (904s left) perf_pmu (semaphore-busy)
[114.455329] Starting subtest: semaphore-busy
[114.457736] Starting dynamic subtest: rcs0
[116.085457] Dynamic subtest rcs0: SUCCESS (1.626s)
[116.095343] Starting dynamic subtest: bcs0
[117.714269] Dynamic subtest bcs0: SUCCESS (1.628s)
[117.722662] Starting dynamic subtest: vcs0
[121.444189] Dynamic subtest vcs0: SUCCESS (3.729s)
[121.453101] Starting dynamic subtest: vcs1
[127.462037] Dynamic subtest vcs1: SUCCESS (6.016s)
[127.472252] Starting dynamic subtest: vecs0
[133.413609] Dynamic subtest vecs0: SUCCESS (5.950s)
[133.423080] Starting dynamic subtest: ccs0
[136.550239] Dynamic subtest ccs0: SUCCESS (3.136s)
[136.552956] Subtest semaphore-busy: SUCCESS (22.092s)
[136.656730] [026/129] (882s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[136.775328] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[136.779437] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[136.883817] [027/129] (882s left) kms_cursor_edge_walk (64x64-left-edge)
[136.985951] Starting subtest: 64x64-left-edge
[136.988296] Starting dynamic subtest: pipe-A-eDP-1
[140.414422] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.427s)
[140.422846] Starting dynamic subtest: pipe-D-eDP-1
[143.547734] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.130s)
[143.549740] Subtest 64x64-left-edge: SUCCESS (6.559s)
[144.340848] [028/129] (874s left) i915_getparams_basic (basic-subslice-total)
[144.396976] Starting subtest: basic-subslice-total
[144.401259] Subtest basic-subslice-total: SUCCESS (0.000s)
[144.480457] [029/129] (874s left) kms_cursor_crc (cursor-suspend)
[144.602634] Starting subtest: cursor-suspend
[144.604851] Starting dynamic subtest: pipe-A-eDP-1
[177.918197] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.065s)
[177.927263] Starting dynamic subtest: pipe-D-eDP-1
[210.852278] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.586s)
[210.854439] Subtest cursor-suspend: SUCCESS (6.653s)
[211.619006] [030/129] (866s left) i915_pm_rps (thresholds-idle-park)
[211.687446] Starting subtest: thresholds-idle-park
[211.691742] Subtest thresholds-idle-park: SKIP (0.000s)
[211.754499] [031/129] (866s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[211.859159] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[211.862975] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[211.931140] [032/129] (866s left) kms_chamelium_edid (vga-edid-read)
[212.309901] Subtest vga-edid-read: SKIP (0.000s)
[213.083502] [033/129] (865s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[213.185823] Starting subtest: fbc-pr-sprite-mmap-cpu
[213.190238] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[213.248966] [034/129] (865s left) fbdev (pan)
[213.282126] Starting subtest: pan
[213.306549] Subtest pan: SUCCESS (0.027s)
[213.368213] [035/129] (865s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[213.472484] Starting subtest: y-tiled-16bpp-rotate-270
[213.476803] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[213.559686] [036/129] (865s left) gem_ctx_engines (invalid-engines)
[213.613210] Starting subtest: invalid-engines
[213.624751] Subtest invalid-engines: SUCCESS (0.010s)
[213.855361] [037/129] (864s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[213.910082] Starting subtest: wait-all-for-submit-delayed-submit
[214.012630] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.105s)
[214.079350] [038/129] (864s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[214.167659] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[214.169848] Starting dynamic subtest: pipe-A-eDP-1
[214.191330] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[214.199806] Starting dynamic subtest: pipe-B-eDP-1
[214.220535] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[214.228207] Starting dynamic subtest: pipe-C-eDP-1
[214.249539] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[214.256846] Starting dynamic subtest: pipe-D-eDP-1
[214.278152] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[214.282339] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[216.287934] [039/129] (862s left) gem_lmem_swapping (parallel-multi)
[216.328639] Subtest parallel-multi: SKIP (0.000s)
[216.365548] [040/129] (862s left) kms_psr (fbc-psr-primary-blt)
[216.459973] Starting subtest: fbc-psr-primary-blt
[216.462214] Starting dynamic subtest: eDP-1
[216.466287] Dynamic subtest eDP-1: SKIP (0.000s)
[216.470395] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[216.525237] [041/129] (862s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[216.626043] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[216.630289] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[216.733977] [042/129] (862s left) kms_psr (fbc-psr-cursor-render)
[216.841536] Starting subtest: fbc-psr-cursor-render
[216.844169] Starting dynamic subtest: eDP-1
[216.848580] Dynamic subtest eDP-1: SKIP (0.000s)
[216.852895] Subtest fbc-psr-cursor-render: SKIP (0.001s)
[216.919165] [043/129] (861s left) gem_eio (reset-stress)
[217.109120] Starting subtest: reset-stress
[260.093752] Subtest reset-stress: SUCCESS (43.103s)
[261.642128] [FACT gem_eio (reset-stress)] new: kernel.kmod_is_loaded.vgem: true
[261.645397] [044/129] (817s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[261.755015] Starting subtest: x-tiled-8bpp-rotate-180
[262.923075] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.167s)
[263.059701] [045/129] (815s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[263.165978] Starting subtest: yf-tiled-32bpp-rotate-0
[263.170145] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[263.269453] [046/129] (815s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[263.336116] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[263.337934] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[263.442713] [047/129] (815s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[263.553752] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[263.557233] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[263.672310] [048/129] (815s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[263.725854] Starting subtest: invalid-bsd2-flag-on-vebox
[263.727808] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[263.821314] [049/129] (815s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[263.923840] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[263.927189] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[264.022857] [050/129] (814s left) kms_pm_rpm (cursor-dpms)
[265.859035] Starting subtest: cursor-dpms
[265.864478] Subtest cursor-dpms: SKIP (0.000s)
[266.281496] [051/129] (812s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[266.375732] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[266.377959] Starting dynamic subtest: pipe-A-eDP-1
[298.645351] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.794s)
[298.654229] Starting dynamic subtest: pipe-B-eDP-1
[331.546606] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.509s)
[331.555150] Starting dynamic subtest: pipe-C-eDP-1
[364.545944] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.447s)
[364.555489] Starting dynamic subtest: pipe-D-eDP-1
[397.542244] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.413s)
[397.544744] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (13.167s)
[398.710513] [052/129] (798s left) gem_pxp (display-protected-crc)
[398.829390] Starting subtest: display-protected-crc
[400.403860] Subtest display-protected-crc: SUCCESS (1.624s)
[400.503422] [053/129] (796s left) perf (invalid-oa-exponent)
[400.585873] Starting subtest: invalid-oa-exponent
[400.611362] Subtest invalid-oa-exponent: SUCCESS (0.025s)
[400.652676] [054/129] (796s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[400.749324] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[400.759642] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.010s)
[400.828732] [055/129] (796s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[400.930578] Starting subtest: addfb25-yf-tiled-legacy
[400.933260] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[401.012172] [056/129] (796s left) kms_force_connector_basic (force-edid)
[401.088329] Starting subtest: force-edid
[401.416502] Subtest force-edid: SUCCESS (0.337s)
[401.558611] [057/129] (795s left) kms_psr (pr-suspend)
[401.656374] Starting subtest: pr-suspend
[401.660791] Subtest pr-suspend: SKIP (0.000s)
[401.723238] [058/129] (795s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[401.826791] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[401.831134] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[401.914166] [059/129] (795s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[402.019872] Starting subtest: psr-rgb101010-draw-pwrite
[407.448780] Subtest psr-rgb101010-draw-pwrite: SUCCESS (5.515s)
[407.565553] [060/129] (789s left) gem_exec_schedule (wide)
[407.761653] Starting subtest: wide
[407.764248] Starting dynamic subtest: rcs0
[417.207892] Dynamic subtest rcs0: SUCCESS (9.502s)
[417.223193] Starting dynamic subtest: vcs0
[427.635703] Dynamic subtest vcs0: SUCCESS (10.448s)
[427.645103] Starting dynamic subtest: vcs1
[436.904355] Dynamic subtest vcs1: SUCCESS (9.261s)
[436.916224] Starting dynamic subtest: vecs0
[448.441834] Dynamic subtest vecs0: SUCCESS (11.534s)
[448.453067] Starting dynamic subtest: ccs0
[461.807876] Dynamic subtest ccs0: SUCCESS (13.366s)
[461.810701] Subtest wide: SUCCESS (54.116s)
[462.950814] [061/129] (734s left) kms_vrr (flipline)
[463.054213] Starting subtest: flipline
[463.062340] Subtest flipline: SKIP (0.000s)
[463.122444] [062/129] (734s left) kms_pm_backlight (fade-with-suspend)
[463.222152] Starting subtest: fade-with-suspend
[479.486214] Starting dynamic subtest: eDP-1
[482.148039] Dynamic subtest eDP-1: SUCCESS (2.746s)
[482.150790] Subtest fade-with-suspend: SUCCESS (3.998s)
[482.975922] [063/129] (729s left) gem_spin_batch (engines)
[483.046870] Starting subtest: engines
[483.049623] Starting dynamic subtest: rcs0
[486.278812] Dynamic subtest rcs0: SUCCESS (3.297s)
[486.290673] Starting dynamic subtest: bcs0
[489.506774] Dynamic subtest bcs0: SUCCESS (3.272s)
[489.518661] Starting dynamic subtest: vcs0
[492.734683] Dynamic subtest vcs0: SUCCESS (3.256s)
[492.744476] Starting dynamic subtest: vcs1
[495.962624] Dynamic subtest vcs1: SUCCESS (3.247s)
[495.972646] Starting dynamic subtest: vecs0
[499.193442] Dynamic subtest vecs0: SUCCESS (3.242s)
[499.205200] Starting dynamic subtest: ccs0
[502.429368] Dynamic subtest ccs0: SUCCESS (3.243s)
[502.431899] Subtest engines: SUCCESS (19.569s)
[502.668215] [064/129] (709s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[502.778563] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[502.783924] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[502.869240] [065/129] (709s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[502.967666] Starting subtest: fb-8bpc-vs-panel-8bpc
[502.970301] Starting dynamic subtest: pipe-A-eDP-1
[504.310037] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.343s)
[504.312820] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.344s)
[505.170441] [066/129] (706s left) kms_content_protection (dp-mst-type-0)
[505.351762] Starting subtest: dp-mst-type-0
[505.357433] Subtest dp-mst-type-0: SKIP (0.000s)
[505.496028] [067/129] (706s left) gem_set_tiling_vs_pwrite
[505.616465] [068/129] (706s left) kms_addfb_basic (bo-too-small)
[505.719122] Starting subtest: bo-too-small
[505.721573] Subtest bo-too-small: SUCCESS (0.000s)
[505.832070] [069/129] (706s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[505.961914] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[514.187306] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (8.226s)
[515.063919] [070/129] (697s left) syncobj_wait (wait-all-snapshot)
[515.119695] Starting subtest: wait-all-snapshot
[515.199619] Subtest wait-all-snapshot: SUCCESS (0.082s)
[515.273405] [071/129] (696s left) prime_vgem (coherency-gtt)
[515.347264] Starting subtest: coherency-gtt
[515.352136] Subtest coherency-gtt: SKIP (0.000s)
[515.436645] [072/129] (696s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[515.530301] Starting subtest: primary-yf-tiled-reflect-x-0
[515.592976] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.059s)
[515.690665] [073/129] (696s left) kms_flip (nonexisting-fb)
[515.785520] Starting subtest: nonexisting-fb
[515.788357] Starting dynamic subtest: A-eDP1
[516.927973] Dynamic subtest A-eDP1: SUCCESS (1.142s)
[516.937671] Starting dynamic subtest: B-eDP1
[518.129109] Dynamic subtest B-eDP1: SUCCESS (1.201s)
[518.138695] Starting dynamic subtest: C-eDP1
[519.328481] Dynamic subtest C-eDP1: SUCCESS (1.198s)
[519.337403] Starting dynamic subtest: D-eDP1
[520.532633] Dynamic subtest D-eDP1: SUCCESS (1.202s)
[520.538660] Subtest nonexisting-fb: SUCCESS (4.751s)
[521.764414] [074/129] (690s left) vgem_basic (create)
[521.812794] Starting subtest: create
[521.814800] Subtest create: SUCCESS (0.000s)
[521.862816] [075/129] (690s left) kms_atomic (plane-overlay-legacy)
[521.958680] Starting subtest: plane-overlay-legacy
[521.961366] Starting dynamic subtest: pipe-A-eDP-1
[522.376454] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.413s)
[522.379054] Subtest plane-overlay-legacy: SUCCESS (0.414s)
[523.160842] [076/129] (689s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[528.261283] Starting subtest: fbc-pr-cursor-plane-update-sf
[528.266410] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.002s)
[529.063469] [077/129] (683s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[529.128831] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[529.134482] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[529.307246] [078/129] (683s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[529.423942] Starting subtest: x-tiled-16bpp-rotate-90
[529.443184] Subtest x-tiled-16bpp-rotate-90: SKIP (0.018s)
[529.584022] [079/129] (682s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[529.686879] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[529.691231] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[529.745917] [080/129] (682s left) gem_exec_fence (long-history)
[530.190691] Starting subtest: long-history
[537.709303] Subtest long-history: SUCCESS (7.521s)
[538.175507] [081/129] (674s left) gem_eio (throttle)
[538.410376] Starting subtest: throttle
[538.771885] Subtest throttle: SUCCESS (0.362s)
[538.929741] [082/129] (673s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[539.044177] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[539.049170] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[539.150955] [083/129] (673s left) gem_exec_whisper (basic-queues-priority)
[539.213069] Starting subtest: basic-queues-priority
[561.734022] Subtest basic-queues-priority: SUCCESS (22.523s)
[561.911469] [084/129] (650s left) gem_partial_pwrite_pread (reads-display)
[561.965431] Subtest reads-display: SKIP (0.000s)
[562.035908] [085/129] (650s left) api_intel_bb (intel-bb-blit-x)
[562.091365] Starting subtest: intel-bb-blit-x
[565.673933] Subtest intel-bb-blit-x: SUCCESS (3.585s)
[565.792089] [086/129] (646s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[565.894431] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[565.897048] Starting dynamic subtest: pipe-A-eDP-1
[565.922422] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[565.932821] Starting dynamic subtest: pipe-B-eDP-1
[565.958550] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[565.968652] Starting dynamic subtest: pipe-C-eDP-1
[565.996116] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[566.006191] Starting dynamic subtest: pipe-D-eDP-1
[566.032667] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[566.037414] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s)
[568.144988] [087/129] (644s left) gem_softpin (invalid)
[568.202557] Starting subtest: invalid
[568.211317] Subtest invalid: SUCCESS (0.006s)
[568.318724] [088/129] (644s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[568.878679] Starting subtest: syncobj-timeline-invalid-wait
[568.885905] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.005s)
[570.073831] [089/129] (642s left) kms_selftest (drm_cmdline_parser)
[570.112564] Starting subtest: drm_cmdline_parser
[570.125848] Starting dynamic subtest: drm_test_cmdline_force_d_only
[570.258905] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.133s)
[570.269357] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[570.391437] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.130s)
[570.401963] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[570.518672] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.127s)
[570.527266] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[570.650348] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.130s)
[570.659640] Starting dynamic subtest: drm_test_cmdline_force_e_only
[570.763078] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.113s)
[570.771650] Starting dynamic subtest: drm_test_cmdline_res
[570.873573] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.109s)
[570.883643] Starting dynamic subtest: drm_test_cmdline_res_vesa
[570.991524] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.116s)
[571.001823] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[571.107303] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.114s)
[571.116916] Starting dynamic subtest: drm_test_cmdline_res_rblank
[571.235962] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.129s)
[571.245558] Starting dynamic subtest: drm_test_cmdline_res_bpp
[571.351869] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.116s)
[571.361322] Starting dynamic subtest: drm_test_cmdline_res_refresh
[571.464805] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.112s)
[571.473772] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[571.553640] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.087s)
[571.562815] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[571.646182] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.092s)
[571.655827] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[571.766139] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.118s)
[571.775374] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[571.890342] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.124s)
[571.899395] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[572.019461] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.128s)
[572.028780] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[572.104628] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.083s)
[572.113264] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[572.227575] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.123s)
[572.236835] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[572.353551] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.125s)
[572.362694] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[572.434125] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.079s)
[572.442686] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[572.579254] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.145s)
[572.588703] Starting dynamic subtest: drm_test_cmdline_name
[572.719680] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.140s)
[572.729358] Starting dynamic subtest: drm_test_cmdline_name_bpp
[572.855866] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.136s)
[572.865303] Starting dynamic subtest: drm_test_cmdline_name_option
[572.983918] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.125s)
[572.993632] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[573.101726] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.117s)
[573.110938] Starting dynamic subtest: drm_test_cmdline_rotate_0
[573.242505] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.139s)
[573.251300] Starting dynamic subtest: drm_test_cmdline_rotate_90
[573.382654] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.140s)
[573.392915] Starting dynamic subtest: drm_test_cmdline_rotate_180
[573.517397] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.133s)
[573.527663] Starting dynamic subtest: drm_test_cmdline_rotate_270
[573.670968] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.154s)
[573.686885] Starting dynamic subtest: drm_test_cmdline_hmirror
[573.782656] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.113s)
[573.793247] Starting dynamic subtest: drm_test_cmdline_vmirror
[573.910649] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.125s)
[573.920847] Starting dynamic subtest: drm_test_cmdline_margin_options
[574.038454] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.127s)
[574.049023] Starting dynamic subtest: drm_test_cmdline_multiple_options
[574.182558] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.143s)
[574.192941] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[574.321515] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.139s)
[574.330937] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[574.458491] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.136s)
[574.469659] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[574.584608] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.125s)
[574.595476] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[574.725300] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.140s)
[574.734343] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[574.861950] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.136s)
[574.872579] Starting dynamic subtest: drm_test_cmdline_invalid
[575.009430] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.148s)
[575.018818] Starting dynamic subtest: drm_test_cmdline_tv_options
[575.153960] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.140s)
[575.156501] Subtest drm_cmdline_parser: SUCCESS (5.042s)
[575.333287] [090/129] (637s left) gem_exec_balancer (hog)
[575.402501] Starting subtest: hog
[575.407763] Subtest hog: SKIP (0.000s)
[575.697201] [091/129] (637s left) drm_fdinfo (busy-idle)
[575.735504] Starting subtest: busy-idle
[575.738076] Starting dynamic subtest: rcs0
[575.779945] Dynamic subtest rcs0: SKIP (0.042s)
[575.790181] Starting dynamic subtest: bcs0
[575.795107] Dynamic subtest bcs0: SKIP (0.000s)
[575.803950] Starting dynamic subtest: vcs0
[575.808858] Dynamic subtest vcs0: SKIP (0.000s)
[575.818152] Starting dynamic subtest: vcs1
[575.822424] Dynamic subtest vcs1: SKIP (0.000s)
[575.830860] Starting dynamic subtest: vecs0
[575.834823] Dynamic subtest vecs0: SKIP (0.000s)
[575.843337] Starting dynamic subtest: ccs0
[575.847786] Dynamic subtest ccs0: SKIP (0.000s)
[575.851911] Subtest busy-idle: SKIP (0.047s)
[575.882749] [092/129] (637s left) core_setmaster (master-drop-set-root)
[578.132466] Starting subtest: master-drop-set-root
[578.146938] Subtest master-drop-set-root: SUCCESS (0.015s)
[578.184762] [FACT core_setmaster (master-drop-set-root)] new: kernel.kmod_is_loaded.amdgpu: true
[578.185387] [FACT core_setmaster (master-drop-set-root)] new: kernel.kmod_is_loaded.xe: true
[578.188789] [093/129] (634s left) kms_chamelium_frames (hdmi-aspect-ratio)
[578.568149] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[579.324103] [094/129] (633s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[584.419560] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[584.425571] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.002s)
[585.250384] [095/129] (627s left) gem_lmem_swapping (verify-random-ccs)
[585.298220] Subtest verify-random-ccs: SKIP (0.000s)
[585.345132] [096/129] (627s left) kms_fbcon_fbt (psr)
[585.405195] Starting subtest: psr
[590.832029] Subtest psr: SUCCESS (5.427s)
[590.913206] [097/129] (622s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[591.034094] Starting subtest: cursorB-vs-flipB-legacy
[591.039203] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[591.126956] [098/129] (621s left) gem_ctx_param (invalid-set-no-zeromap)
[591.183469] Starting subtest: invalid-set-no-zeromap
[591.186255] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[591.253970] [099/129] (621s left) i915_pm_freq_api (freq-reset)
[591.316802] Starting subtest: freq-reset
[591.319552] Starting dynamic subtest: gt0
[591.509491] Dynamic subtest gt0: SUCCESS (0.192s)
[591.520250] Starting dynamic subtest: gt1
[591.683095] Dynamic subtest gt1: SUCCESS (0.171s)
[591.685819] Subtest freq-reset: SUCCESS (0.365s)
[591.752178] [100/129] (621s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[591.869890] Starting subtest: flip-vs-cursor-busy-crc-atomic
[592.623350] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.752s)
[593.445398] [101/129] (619s left) kms_plane (pixel-format)
[593.547301] Starting subtest: pixel-format
[593.589634] Starting dynamic subtest: pipe-A-plane-0
[598.689062] Dynamic subtest pipe-A-plane-0: SUCCESS (5.099s)
[598.697836] Starting dynamic subtest: pipe-A-plane-3
[601.022549] Dynamic subtest pipe-A-plane-3: SUCCESS (2.333s)
[601.034001] Starting dynamic subtest: pipe-A-plane-5
[601.211620] Dynamic subtest pipe-A-plane-5: SUCCESS (0.188s)
[602.309420] Starting dynamic subtest: pipe-B-plane-0
[607.413078] Dynamic subtest pipe-B-plane-0: SUCCESS (5.111s)
[607.422900] Starting dynamic subtest: pipe-B-plane-3
[609.946227] Dynamic subtest pipe-B-plane-3: SUCCESS (2.533s)
[609.955480] Starting dynamic subtest: pipe-B-plane-5
[610.157762] Dynamic subtest pipe-B-plane-5: SUCCESS (0.210s)
[610.465811] Subtest pixel-format: SUCCESS (16.916s)
[611.247026] [102/129] (602s left) prime_vgem (busy)
[611.326503] Starting subtest: busy
[611.328959] Starting dynamic subtest: rcs0
[611.378695] Dynamic subtest rcs0: SUCCESS (0.053s)
[611.388827] Starting dynamic subtest: bcs0
[611.459983] Dynamic subtest bcs0: SUCCESS (0.081s)
[611.469375] Starting dynamic subtest: vcs0
[611.502721] Dynamic subtest vcs0: SUCCESS (0.042s)
[611.512020] Starting dynamic subtest: vcs1
[611.548577] Dynamic subtest vcs1: SUCCESS (0.045s)
[611.557716] Starting dynamic subtest: vecs0
[611.594646] Dynamic subtest vecs0: SUCCESS (0.045s)
[611.603785] Starting dynamic subtest: ccs0
[611.641006] Dynamic subtest ccs0: SUCCESS (0.045s)
[611.643704] Subtest busy: SUCCESS (0.316s)
[611.763463] [103/129] (601s left) gem_wait (await)
[611.828624] Starting subtest: await
[611.831496] Starting dynamic subtest: all-engines
[612.947921] Dynamic subtest all-engines: SUCCESS (1.119s)
[612.963045] Starting dynamic subtest: rcs0
[614.007414] Dynamic subtest rcs0: SUCCESS (1.057s)
[614.023624] Starting dynamic subtest: bcs0
[615.065569] Dynamic subtest bcs0: SUCCESS (1.057s)
[615.081486] Starting dynamic subtest: vcs0
[616.123648] Dynamic subtest vcs0: SUCCESS (1.056s)
[616.140189] Starting dynamic subtest: vcs1
[617.183787] Dynamic subtest vcs1: SUCCESS (1.057s)
[617.205320] Starting dynamic subtest: vecs0
[618.239631] Dynamic subtest vecs0: SUCCESS (1.054s)
[618.255853] Starting dynamic subtest: ccs0
[619.301959] Dynamic subtest ccs0: SUCCESS (1.060s)
[619.304554] Subtest await: SUCCESS (7.475s)
[619.498687] [104/129] (593s left) gem_ctx_persistence (legacy-engines-persistence)
[619.562961] Starting subtest: legacy-engines-persistence
[619.565674] Starting dynamic subtest: render
[620.408187] Dynamic subtest render: SUCCESS (0.845s)
[620.420536] Starting dynamic subtest: bsd1
[621.196223] Dynamic subtest bsd1: SUCCESS (0.785s)
[621.208358] Starting dynamic subtest: bsd2
[622.003116] Dynamic subtest bsd2: SUCCESS (0.804s)
[622.016343] Starting dynamic subtest: blt
[622.792968] Dynamic subtest blt: SUCCESS (0.788s)
[622.805924] Starting dynamic subtest: vebox
[623.615060] Dynamic subtest vebox: SUCCESS (0.820s)
[623.618373] Subtest legacy-engines-persistence: SUCCESS (4.053s)
[623.691933] [105/129] (589s left) gem_userptr_blits (map-fixed-invalidate)
[623.765566] Starting subtest: map-fixed-invalidate
[623.770627] Subtest map-fixed-invalidate: SKIP (0.000s)
[623.906135] [106/129] (589s left) kms_flip (plain-flip-ts-check)
[624.016318] Starting subtest: plain-flip-ts-check
[624.018702] Starting dynamic subtest: A-eDP1
[632.916170] Dynamic subtest A-eDP1: SUCCESS (8.901s)
[632.925621] Starting dynamic subtest: B-eDP1
[641.815109] Dynamic subtest B-eDP1: SUCCESS (8.898s)
[641.824092] Starting dynamic subtest: C-eDP1
[650.700772] Dynamic subtest C-eDP1: SUCCESS (8.887s)
[650.709962] Starting dynamic subtest: D-eDP1
[659.599123] Dynamic subtest D-eDP1: SUCCESS (8.899s)
[659.604627] Subtest plain-flip-ts-check: SUCCESS (35.596s)
[660.731099] [107/129] (552s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[660.829536] Starting subtest: basic-max-pipe-crc-check
[660.834383] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[660.874483] [108/129] (552s left) syncobj_timeline (single-wait-for-submit-signaled)
[660.933239] Starting subtest: single-wait-for-submit-signaled
[660.935667] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[661.031187] [109/129] (552s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[661.161158] Starting subtest: cursor-vs-flip-varying-size
[691.531327] Subtest cursor-vs-flip-varying-size: SUCCESS (30.379s)
[692.326269] [110/129] (521s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[692.392054] Starting subtest: multi-wait-all-for-submit-signaled
[692.395401] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[692.499011] [111/129] (521s left) perf (global-sseu-config-invalid)
[692.587803] Starting subtest: global-sseu-config-invalid
[692.593328] Subtest global-sseu-config-invalid: SKIP (0.000s)
[692.631790] [112/129] (520s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[692.731533] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[692.736284] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[692.825529] [113/129] (520s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[692.884208] Starting subtest: etime-multi-wait-all-available-unsubmitted
[692.982878] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.101s)
[693.054191] [114/129] (520s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[693.152810] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[696.461472] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (3.314s)
[696.597808] [115/129] (517s left) gem_busy (parallel)
[696.796100] Starting subtest: parallel
[696.798794] Starting dynamic subtest: rcs0
[697.972289] Dynamic subtest rcs0: SUCCESS (1.174s)
[697.985005] Starting dynamic subtest: bcs0
[699.956117] Dynamic subtest bcs0: SUCCESS (1.982s)
[699.973065] Starting dynamic subtest: vcs0
[701.940667] Dynamic subtest vcs0: SUCCESS (1.982s)
[701.951641] Starting dynamic subtest: vcs1
[703.987615] Dynamic subtest vcs1: SUCCESS (2.044s)
[703.999678] Starting dynamic subtest: vecs0
[705.972553] Dynamic subtest vecs0: SUCCESS (1.982s)
[705.985438] Starting dynamic subtest: ccs0
[707.956712] Dynamic subtest ccs0: SUCCESS (1.981s)
[707.959690] Subtest parallel: SUCCESS (11.160s)
[708.183295] [116/129] (505s left) gem_userptr_blits (sync-overlap)
[708.245429] Starting subtest: sync-overlap
[708.248184] Subtest sync-overlap: SUCCESS (0.000s)
[708.379089] [117/129] (505s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[708.478159] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[713.047885] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (4.571s)
[713.177082] [118/129] (500s left) kms_frontbuffer_tracking (fbc-tiling-y)
[713.289379] Starting subtest: fbc-tiling-y
[713.294305] Subtest fbc-tiling-y: SKIP (0.000s)
[713.394242] [119/129] (500s left) kms_cursor_crc (cursor-random-32x10)
[713.538254] Starting subtest: cursor-random-32x10
[713.577579] Subtest cursor-random-32x10: SKIP (0.033s)
[713.871564] [120/129] (500s left) vgem_basic (busy-fence)
[713.917069] Starting subtest: busy-fence
[713.919257] Subtest busy-fence: SUCCESS (0.000s)
[713.968176] [121/129] (499s left) kms_plane_scaling (planes-downscale-factor-0-25)
[714.061638] Starting subtest: planes-downscale-factor-0-25
[714.064241] Starting dynamic subtest: pipe-A
[714.078417] Dynamic subtest pipe-A: SKIP (0.011s)
[714.087901] Starting dynamic subtest: pipe-B
[714.099359] Dynamic subtest pipe-B: SKIP (0.020s)
[714.108669] Starting dynamic subtest: pipe-C
[714.120771] Dynamic subtest pipe-C: SKIP (0.020s)
[714.129763] Starting dynamic subtest: pipe-D
[714.141792] Dynamic subtest pipe-D: SKIP (0.020s)
[714.145646] Subtest planes-downscale-factor-0-25: SKIP (0.073s)
[714.235003] [122/129] (499s left) kms_async_flips (test-time-stamp-atomic)
[714.324007] Starting subtest: test-time-stamp-atomic
[714.696624] Starting dynamic subtest: pipe-A-eDP-1
[715.498695] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.800s)
[715.863454] Starting dynamic subtest: pipe-B-eDP-1
[716.698441] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.841s)
[717.061933] Starting dynamic subtest: pipe-C-eDP-1
[717.898180] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.841s)
[718.262382] Starting dynamic subtest: pipe-D-eDP-1
[719.098796] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.842s)
[719.101626] Subtest test-time-stamp-atomic: SUCCESS (4.770s)
[720.318331] [123/129] (493s left) kms_psr (psr-cursor-plane-move)
[720.418976] Starting subtest: psr-cursor-plane-move
[720.421321] Starting dynamic subtest: eDP-1
[722.181002] Dynamic subtest eDP-1: SUCCESS (1.760s)
[722.183399] Subtest psr-cursor-plane-move: SUCCESS (1.761s)
[723.023185] [124/129] (491s left) kms_flip (2x-nonexisting-fb)
[723.127667] Starting subtest: 2x-nonexisting-fb
[723.138157] Subtest 2x-nonexisting-fb: SKIP (0.010s)
[723.251800] [125/129] (490s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[723.349385] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[724.438615] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.089s)
[724.578094] [126/129] (489s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[724.687227] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[724.692467] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[724.761694] [127/129] (489s left) kms_color (ctm-green-to-red)
[724.866040] Starting subtest: ctm-green-to-red
[724.868290] Starting dynamic subtest: pipe-A-eDP-1
[725.553192] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.684s)
[725.563323] Starting dynamic subtest: pipe-B-eDP-1
[726.967816] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.415s)
[726.978282] Starting dynamic subtest: pipe-C-eDP-1
[728.327464] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.358s)
[728.337630] Starting dynamic subtest: pipe-D-eDP-1
[729.628576] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.298s)
[729.631230] Subtest ctm-green-to-red: SUCCESS (4.757s)
[730.420403] [128/129] (483s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[730.532548] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[730.535419] Starting dynamic subtest: pipe-A-default-mode
[730.821341] Dynamic subtest pipe-A-default-mode: SKIP (0.281s)
[730.826482] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.283s)
[731.620218] [129/129] (482s left) kms_feature_discovery (psr1)
[731.727514] Starting subtest: psr1
[731.729924] Subtest psr1: SUCCESS (0.000s)
[731.792128] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_psr2_sf
results: parsing output: 2/ for test: gem_mmap_gtt
results: parsing output: 3/ for test: kms_pipe_crc_basic
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: gem_eio
results: parsing output: 7/ for test: syncobj_wait
results: parsing output: 8/ for test: perf
results: parsing output: 9/ for test: gem_eio
results: parsing output: 10/ for test: gem_exec_schedule
results: parsing output: 11/ for test: gem_mmap_wc
results: parsing output: 12/ for test: gem_exec_schedule
results: parsing output: 13/ for test: gem_softpin
results: parsing output: 14/ for test: core_auth
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: kms_busy
results: parsing output: 18/ for test: gem_render_copy
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: kms_universal_plane
results: parsing output: 22/ for test: gem_userptr_blits
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: perf_pmu
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_cursor_edge_walk
results: parsing output: 27/ for test: i915_getparams_basic
results: parsing output: 28/ for test: kms_cursor_crc
results: parsing output: 29/ for test: i915_pm_rps
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_chamelium_edid
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: fbdev
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: gem_ctx_engines
results: parsing output: 36/ for test: syncobj_wait
results: parsing output: 37/ for test: kms_ccs
results: parsing output: 38/ for test: gem_lmem_swapping
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: gem_eio
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_exec_params
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_pm_rpm
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: gem_pxp
results: parsing output: 52/ for test: perf
results: parsing output: 53/ for test: kms_flip
results: parsing output: 54/ for test: kms_addfb_basic
results: parsing output: 55/ for test: kms_force_connector_basic
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_exec_schedule
results: parsing output: 60/ for test: kms_vrr
results: parsing output: 61/ for test: kms_pm_backlight
results: parsing output: 62/ for test: gem_spin_batch
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_dither
results: parsing output: 65/ for test: kms_content_protection
results: parsing output: 66/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 67/ for test: kms_addfb_basic
results: parsing output: 68/ for test: kms_cursor_legacy
results: parsing output: 69/ for test: syncobj_wait
results: parsing output: 70/ for test: prime_vgem
results: parsing output: 71/ for test: kms_rotation_crc
results: parsing output: 72/ for test: kms_flip
results: parsing output: 73/ for test: vgem_basic
results: parsing output: 74/ for test: kms_atomic
results: parsing output: 75/ for test: kms_psr2_sf
results: parsing output: 76/ for test: gem_render_copy
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_joiner
results: parsing output: 79/ for test: gem_exec_fence
results: parsing output: 80/ for test: gem_eio
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_exec_whisper
results: parsing output: 83/ for test: gem_partial_pwrite_pread
results: parsing output: 84/ for test: api_intel_bb
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: gem_softpin
results: parsing output: 87/ for test: gem_exec_fence
results: parsing output: 88/ for test: kms_selftest
results: parsing output: 89/ for test: gem_exec_balancer
results: parsing output: 90/ for test: drm_fdinfo
results: parsing output: 91/ for test: core_setmaster
results: parsing output: 92/ for test: kms_chamelium_frames
results: parsing output: 93/ for test: kms_psr2_sf
results: parsing output: 94/ for test: gem_lmem_swapping
results: parsing output: 95/ for test: kms_fbcon_fbt
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: gem_ctx_param
results: parsing output: 98/ for test: i915_pm_freq_api
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: kms_plane
results: parsing output: 101/ for test: prime_vgem
results: parsing output: 102/ for test: gem_wait
results: parsing output: 103/ for test: gem_ctx_persistence
results: parsing output: 104/ for test: gem_userptr_blits
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: kms_multipipe_modeset
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: perf
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_busy
results: parsing output: 115/ for test: gem_userptr_blits
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_cursor_crc
results: parsing output: 119/ for test: vgem_basic
results: parsing output: 120/ for test: kms_plane_scaling
results: parsing output: 121/ for test: kms_async_flips
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: kms_flip
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_color
results: parsing output: 127/ for test: kms_flip_scaled_crc
results: parsing output: 128/ for test: kms_feature_discovery
Done.