[55.789873] Initializing watchdogs
[55.789923]   /dev/watchdog0
[55.805017] [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]
[55.809868] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.811893] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.813951] [001/131] (960s left) gem_mmap_offset (open-flood)
[55.865191] Starting subtest: open-flood
[77.354994] Subtest open-flood: SUCCESS (21.491s)
[77.482009] [002/131] (938s left) gem_exec_schedule (pi-ringfull)
[77.664966] Starting subtest: pi-ringfull
[77.666071] Starting dynamic subtest: rcs0
[77.792537] Dynamic subtest rcs0: SUCCESS (0.128s)
[77.805881] Starting dynamic subtest: bcs0
[77.868323] Dynamic subtest bcs0: SUCCESS (0.075s)
[77.882837] Starting dynamic subtest: vcs0
[77.945111] Dynamic subtest vcs0: SUCCESS (0.077s)
[77.958600] Starting dynamic subtest: vcs1
[78.020894] Dynamic subtest vcs1: SUCCESS (0.075s)
[78.034368] Starting dynamic subtest: vecs0
[78.096878] Dynamic subtest vecs0: SUCCESS (0.075s)
[78.110590] Starting dynamic subtest: ccs0
[78.171978] Dynamic subtest ccs0: SUCCESS (0.075s)
[78.173556] Subtest pi-ringfull: SUCCESS (0.508s)
[78.425307] [FACT gem_exec_schedule (pi-ringfull)] new: kernel.kmod_is_loaded.vgem: true
[78.427091] [003/131] (937s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[78.510179] Starting subtest: random-ccs-data-yf-tiled-ccs
[78.511094] Starting dynamic subtest: pipe-A-eDP-1
[78.520986] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[78.527719] Starting dynamic subtest: pipe-B-eDP-1
[78.537859] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[78.543876] Starting dynamic subtest: pipe-C-eDP-1
[78.553219] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[78.558839] Starting dynamic subtest: pipe-D-eDP-1
[78.567983] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[78.569631] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.003s)
[80.712004] [004/131] (935s left) syncobj_wait (invalid-wait-illegal-handle)
[80.768975] Starting subtest: invalid-wait-illegal-handle
[80.770054] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[80.898790] [005/131] (935s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[80.986433] Starting subtest: fbc-pr-cursor-mmap-cpu
[80.988337] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[81.075013] [006/131] (935s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[81.173499] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[81.175163] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[81.309035] [007/131] (935s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[81.393703] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[81.395397] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[81.505251] [008/131] (935s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[81.582832] Starting subtest: plane-upscale-factor-0-25-with-rotation
[81.583666] Starting dynamic subtest: pipe-A
[81.810113] Dynamic subtest pipe-A: SUCCESS (0.228s)
[81.815848] Starting dynamic subtest: pipe-B
[83.094825] Dynamic subtest pipe-B: SUCCESS (1.284s)
[83.102065] Starting dynamic subtest: pipe-C
[84.424575] Dynamic subtest pipe-C: SUCCESS (1.329s)
[84.432286] Starting dynamic subtest: pipe-D
[85.757949] Dynamic subtest pipe-D: SUCCESS (1.332s)
[85.758972] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.174s)
[86.950875] [009/131] (929s left) gem_render_copy_redux (interruptible)
[87.007055] Starting subtest: interruptible
[87.262883] Subtest interruptible: SUCCESS (0.256s)
[87.409010] [010/131] (929s left) i915_drm_fdinfo (virtual-busy-all)
[87.441632] Starting subtest: virtual-busy-all
[87.443549] Subtest virtual-busy-all: SKIP (0.000s)
[87.520021] [011/131] (929s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[87.622720] Starting subtest: x-tiled-16bpp-rotate-0
[88.777331] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.155s)
[88.963675] [012/131] (927s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[89.055402] Starting subtest: flip-primary-invalidate-overlay
[100.594567] Subtest flip-primary-invalidate-overlay: SUCCESS (11.537s)
[100.779636] [013/131] (915s left) gem_mmap_gtt (basic-small-copy-xy)
[100.832495] Subtest basic-small-copy-XY: SKIP (0.000s)
[100.892342] [014/131] (915s left) prime_vgem (basic-fence-mmap)
[100.978296] Starting subtest: basic-fence-mmap
[100.979964] Subtest basic-fence-mmap: SKIP (0.000s)
[101.100928] [015/131] (915s left) kms_setmode (invalid-clone-exclusive-crtc)
[101.157462] Starting subtest: invalid-clone-exclusive-crtc
[101.160551] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[101.259382] [016/131] (915s left) kms_color (ctm-signed)
[101.346210] Starting subtest: ctm-signed
[101.347145] Starting dynamic subtest: pipe-A-eDP-1
[103.386880] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.040s)
[103.393492] Starting dynamic subtest: pipe-B-eDP-1
[106.098601] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.711s)
[106.105384] Starting dynamic subtest: pipe-C-eDP-1
[108.731431] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.631s)
[108.737730] Starting dynamic subtest: pipe-D-eDP-1
[111.379504] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.647s)
[111.380473] Subtest ctm-signed: SUCCESS (10.031s)
[112.221878] [017/131] (904s left) syncobj_wait (wait-delayed-signal)
[112.282294] Starting subtest: wait-delayed-signal
[112.386404] Subtest wait-delayed-signal: SUCCESS (0.103s)
[112.466989] [018/131] (904s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[112.521851] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[112.577998] [019/131] (904s left) kms_legacy_colorkey (basic)
[112.666861] Starting subtest: basic
[112.667887] Starting dynamic subtest: pipe-A
[112.712325] Dynamic subtest pipe-A: SUCCESS (0.045s)
[112.722903] Starting dynamic subtest: pipe-B
[112.723895] Dynamic subtest pipe-B: SUCCESS (0.001s)
[112.729702] Starting dynamic subtest: pipe-C
[112.730613] Dynamic subtest pipe-C: SUCCESS (0.000s)
[112.736917] Starting dynamic subtest: pipe-D
[112.738430] Dynamic subtest pipe-D: SUCCESS (0.000s)
[112.739633] Subtest basic: SUCCESS (0.052s)
[112.792542] [020/131] (904s left) api_intel_bb (destroy-bb)
[112.847414] Starting subtest: destroy-bb
[112.858275] Subtest destroy-bb: SUCCESS (0.010s)
[113.009973] [021/131] (903s left) syncobj_eventfd (binary-wait-before-signal)
[113.052716] Starting subtest: binary-wait-before-signal
[113.082655] Subtest binary-wait-before-signal: SUCCESS (0.030s)
[113.176383] [022/131] (903s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[113.266178] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[113.267935] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[113.394836] [023/131] (903s left) kms_chamelium_color (ctm-negative)
[113.490850] Subtest ctm-negative: SKIP (0.000s)
[113.527362] [024/131] (903s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[113.603266] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[113.604142] Starting dynamic subtest: pipe-A-eDP-1
[113.625744] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[113.632443] Starting dynamic subtest: pipe-B-eDP-1
[113.653922] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[113.659856] Starting dynamic subtest: pipe-C-eDP-1
[113.681183] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[113.687460] Starting dynamic subtest: pipe-D-eDP-1
[113.709328] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[113.710986] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[115.784448] [025/131] (901s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[115.879604] Starting subtest: fbc-rgb101010-draw-pwrite
[121.244488] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.365s)
[122.388928] [026/131] (894s left) gem_ccs (suspend-resume)
[122.443073] Starting subtest: suspend-resume
[122.445027] Subtest suspend-resume: SKIP (0.000s)
[122.555874] [027/131] (894s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[127.548270] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[127.550670] Starting dynamic subtest: pipe-A-eDP-1
[128.343943] Dynamic subtest pipe-A-eDP-1: SKIP (0.793s)
[128.350471] Starting dynamic subtest: pipe-B-eDP-1
[129.472370] Dynamic subtest pipe-B-eDP-1: SKIP (1.127s)
[129.474056] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.924s)
[130.659503] [028/131] (886s left) kms_psr (pr-sprite-mmap-gtt)
[130.742349] Starting subtest: pr-sprite-mmap-gtt
[130.744066] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[130.834754] [029/131] (886s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[130.937623] Starting subtest: flip-vs-cursor-varying-size
[139.281576] Subtest flip-vs-cursor-varying-size: SUCCESS (8.345s)
[140.105370] [030/131] (877s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[140.195331] Starting subtest: fbc-psr2-sprite-mmap-cpu
[140.196236] Starting dynamic subtest: eDP-1
[140.197912] Dynamic subtest eDP-1: SKIP (0.000s)
[140.199665] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[140.286451] [031/131] (876s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[140.368521] Starting subtest: primary-x-tiled-reflect-x-180
[147.200424] Subtest primary-x-tiled-reflect-x-180: SUCCESS (6.833s)
[148.462702] [032/131] (868s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[148.585301] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[148.587289] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[148.758103] [033/131] (868s left) prime_self_import (reimport-vs-gem_close-race)
[148.787985] Starting subtest: reimport-vs-gem_close-race
[153.899491] Subtest reimport-vs-gem_close-race: SUCCESS (5.113s)
[153.981696] [034/131] (863s left) kms_cursor_crc (cursor-alpha-opaque)
[154.068184] Starting subtest: cursor-alpha-opaque
[154.069149] Starting dynamic subtest: pipe-A-eDP-1
[154.663751] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.595s)
[154.670200] Starting dynamic subtest: pipe-D-eDP-1
[155.932193] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.266s)
[155.933166] Subtest cursor-alpha-opaque: SUCCESS (1.863s)
[156.804370] [035/131] (860s left) kms_cursor_crc (cursor-random-64x21)
[156.979790] Starting subtest: cursor-random-64x21
[157.014579] Subtest cursor-random-64x21: SKIP (0.034s)
[157.239869] [036/131] (860s left) gem_eio (create)
[157.468899] Starting subtest: create
[157.801827] Subtest create: SUCCESS (0.332s)
[157.954025] [037/131] (859s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[158.039099] Starting subtest: basic-modeset-with-all-modifiers-formats
[158.396940] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[159.179206] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.782s)
[159.185573] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[159.201403] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[159.207847] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[159.223829] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.021s)
[159.235956] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[159.368278] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.144s)
[159.376981] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[159.390396] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.022s)
[159.397280] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[159.413159] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[159.421381] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[159.435065] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.020s)
[159.444981] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[159.457025] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.020s)
[159.464059] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[159.479240] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.022s)
[159.485495] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[159.501525] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.022s)
[159.507860] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[159.523810] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[159.530271] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[159.545991] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[159.552537] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[159.690349] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.144s)
[159.696792] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[159.712683] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.022s)
[159.718898] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[159.734924] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s)
[159.741105] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[159.757060] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[159.763201] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[159.779449] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[159.787066] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[159.801490] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.021s)
[159.807673] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[159.823816] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s)
[159.831987] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[159.846042] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[159.853251] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[159.868247] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[159.876621] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[160.024190] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s)
[160.031644] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[160.046443] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[160.052962] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[160.068711] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[160.075119] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[160.090812] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[160.097073] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[160.113031] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[160.119415] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[160.135415] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[160.141806] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[160.157570] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.021s)
[160.163838] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[160.179702] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[160.185979] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[160.201921] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[160.591933] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.554s)
[161.374424] [038/131] (856s left) kms_fbcon_fbt (fbc)
[161.445300] Starting subtest: fbc
[167.808151] Subtest fbc: SUCCESS (6.362s)
[168.889159] [039/131] (848s left) kms_flip (2x-blocking-absolute-wf_vblank)
[168.974219] Starting subtest: 2x-blocking-absolute-wf_vblank
[168.984724] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s)
[169.070400] [040/131] (848s left) kms_properties (get_properties-sanity-non-atomic)
[169.173377] Starting subtest: get_properties-sanity-non-atomic
[169.174271] Subtest get_properties-sanity-non-atomic: SUCCESS (0.002s)
[169.264957] [041/131] (848s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[169.356948] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[169.357947] Starting dynamic subtest: pipe-A
[169.586921] Dynamic subtest pipe-A: SUCCESS (0.230s)
[169.593504] Starting dynamic subtest: pipe-B
[170.891845] Dynamic subtest pipe-B: SUCCESS (1.304s)
[170.898731] Starting dynamic subtest: pipe-C
[172.221418] Dynamic subtest pipe-C: SUCCESS (1.329s)
[172.230146] Starting dynamic subtest: pipe-D
[173.551867] Dynamic subtest pipe-D: SUCCESS (1.329s)
[173.552980] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.195s)
[174.741764] [042/131] (842s left) kms_psr (fbc-psr-suspend)
[174.827347] Starting subtest: fbc-psr-suspend
[174.828258] Starting dynamic subtest: eDP-1
[174.830049] Dynamic subtest eDP-1: SKIP (0.000s)
[174.831704] Subtest fbc-psr-suspend: SKIP (0.001s)
[174.906123] [043/131] (842s left) gem_exec_schedule (smoketest)
[175.081117] Starting subtest: smoketest
[175.082341] Starting dynamic subtest: rcs0
[180.595929] Dynamic subtest rcs0: SUCCESS (5.495s)
[180.603470] Starting dynamic subtest: bcs0
[186.113996] Dynamic subtest bcs0: SUCCESS (5.513s)
[186.121926] Starting dynamic subtest: vcs0
[191.609547] Dynamic subtest vcs0: SUCCESS (5.498s)
[191.622024] Starting dynamic subtest: vcs1
[197.109877] Dynamic subtest vcs1: SUCCESS (5.497s)
[197.117343] Starting dynamic subtest: vecs0
[202.608301] Dynamic subtest vecs0: SUCCESS (5.498s)
[202.616927] Starting dynamic subtest: ccs0
[208.126412] Dynamic subtest ccs0: SUCCESS (5.520s)
[208.127284] Subtest smoketest: SUCCESS (33.025s)
[208.300322] [044/131] (809s left) vgem_basic (bad-flag)
[208.335498] Starting subtest: bad-flag
[208.336544] Subtest bad-flag: SUCCESS (0.000s)
[208.395988] [045/131] (809s left) fbdev (nullptr)
[208.424108] Starting subtest: nullptr
[208.425430] Subtest nullptr: SUCCESS (0.000s)
[208.515332] [046/131] (809s left) syncobj_timeline (reset-unsignaled)
[208.570706] Starting subtest: reset-unsignaled
[208.571791] Subtest reset-unsignaled: SUCCESS (0.000s)
[208.692583] [047/131] (809s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[208.780947] Starting subtest: y-tiled-8bpp-rotate-270
[208.782824] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[208.904269] [048/131] (808s left) kms_lease (cursor-implicit-plane)
[208.991179] Starting subtest: cursor-implicit-plane
[208.992057] Starting dynamic subtest: pipe-A-eDP-1
[209.447144] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.455s)
[209.454385] Starting dynamic subtest: pipe-B-eDP-1
[210.553416] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.105s)
[210.562459] Starting dynamic subtest: pipe-C-eDP-1
[211.687425] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.133s)
[211.695975] Starting dynamic subtest: pipe-D-eDP-1
[212.819646] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s)
[212.820628] Subtest cursor-implicit-plane: SUCCESS (3.828s)
[213.691460] [049/131] (804s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[213.773356] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[220.807068] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.035s)
[220.938444] [050/131] (796s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[221.021589] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[221.022515] Starting dynamic subtest: pipe-A-eDP-1
[221.031230] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[221.038376] Starting dynamic subtest: pipe-B-eDP-1
[221.046981] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[221.053712] Starting dynamic subtest: pipe-C-eDP-1
[221.062083] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[221.068272] Starting dynamic subtest: pipe-D-eDP-1
[221.076955] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[221.078736] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[223.285868] [051/131] (794s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[223.384806] Starting subtest: extended-modeset-hang-oldfb-with-reset
[223.385763] Starting dynamic subtest: pipe-A
[234.945272] Dynamic subtest pipe-A: SUCCESS (11.560s)
[234.953777] Starting dynamic subtest: pipe-D
[247.227345] Dynamic subtest pipe-D: SUCCESS (12.279s)
[247.228256] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.843s)
[248.028980] [052/131] (769s left) gem_exec_store (basic)
[248.089796] Starting subtest: basic
[248.217784] Subtest basic: SUCCESS (0.127s)
[248.416057] [053/131] (769s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[248.521969] Starting subtest: cursorA-vs-flipA-atomic
[259.635574] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.112s)
[260.454596] [054/131] (757s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[260.507727] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[260.508893] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[260.636123] [055/131] (757s left) kms_flip (plain-flip-ts-check-interruptible)
[260.731533] Starting subtest: plain-flip-ts-check-interruptible
[260.734885] Starting dynamic subtest: A-eDP1
[269.540942] Dynamic subtest A-eDP1: SUCCESS (8.807s)
[269.549501] Starting dynamic subtest: B-eDP1
[278.372175] Dynamic subtest B-eDP1: SUCCESS (8.830s)
[278.379646] Starting dynamic subtest: C-eDP1
[287.186087] Dynamic subtest C-eDP1: SUCCESS (8.812s)
[287.194558] Starting dynamic subtest: D-eDP1
[296.016538] Dynamic subtest D-eDP1: SUCCESS (8.829s)
[296.021080] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.288s)
[297.197857] [056/131] (720s left) kms_pm_rpm (cursor)
[299.016458] Starting subtest: cursor
[299.018865] Subtest cursor: SKIP (0.000s)
[299.449470] [057/131] (718s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[299.540063] Starting subtest: fbcpsr-stridechange
[305.638776] Subtest fbcpsr-stridechange: SUCCESS (6.098s)
[305.813533] [058/131] (712s left) gem_caching (writes)
[305.872929] Subtest writes: SKIP (0.000s)
[305.951869] [059/131] (712s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[310.924879] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[310.928361] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.002s)
[311.793905] [060/131] (706s left) gem_exec_reloc (basic-write-gtt)
[311.845271] Subtest basic-write-gtt: SKIP (0.000s)
[311.900099] [061/131] (706s left) perf (mi-rpc)
[312.014098] Starting subtest: mi-rpc
[312.015757] Subtest mi-rpc: SKIP (0.000s)
[312.047887] [062/131] (706s left) kms_chamelium_frames (hdmi-crc-fast)
[312.419246] Subtest hdmi-crc-fast: SKIP (0.000s)
[313.191976] [063/131] (705s left) gem_eio (in-flight-internal-immediate)
[313.418875] Starting subtest: in-flight-internal-immediate
[314.977556] Subtest in-flight-internal-immediate: SUCCESS (1.559s)
[315.108835] [064/131] (703s left) syncobj_timeline (single-wait-all-signaled)
[315.156678] Starting subtest: single-wait-all-signaled
[315.157531] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[315.283162] [065/131] (703s left) perf (gen12-mi-rpc)
[315.379157] Starting subtest: gen12-mi-rpc
[315.380290] Starting dynamic subtest: rcs0
[315.397374] Dynamic subtest rcs0: SUCCESS (0.017s)
[315.398205] Subtest gen12-mi-rpc: SUCCESS (0.018s)
[315.433965] [066/131] (702s left) syncobj_wait (wait-for-submit-delayed-submit)
[315.527284] Starting subtest: wait-for-submit-delayed-submit
[315.632426] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[315.711908] [067/131] (702s left) gen7_exec_parse (batch-without-end)
[315.761073] Subtest batch-without-end: SKIP (0.000s)
[315.836067] [068/131] (702s left) i915_drm_fdinfo (busy-hang)
[315.869691] Starting subtest: busy-hang
[315.870590] Starting dynamic subtest: rcs0
[315.905438] Dynamic subtest rcs0: SKIP (0.032s)
[315.914955] Starting dynamic subtest: bcs0
[315.916699] Dynamic subtest bcs0: SKIP (0.001s)
[315.924959] Starting dynamic subtest: vcs0
[315.926681] Dynamic subtest vcs0: SKIP (0.000s)
[315.933529] Starting dynamic subtest: vcs1
[315.935514] Dynamic subtest vcs1: SKIP (0.000s)
[315.942423] Starting dynamic subtest: vecs0
[315.944045] Dynamic subtest vecs0: SKIP (0.000s)
[315.950606] Starting dynamic subtest: ccs0
[315.952282] Dynamic subtest ccs0: SKIP (0.000s)
[315.953824] Subtest busy-hang: SKIP (0.039s)
[315.983269] [069/131] (702s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[316.064874] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[316.067101] Starting dynamic subtest: pipe-A-default-mode
[316.349331] Dynamic subtest pipe-A-default-mode: SKIP (0.282s)
[316.351050] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.283s)
[317.154704] [070/131] (701s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[317.246414] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[317.248168] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[317.361167] [071/131] (701s left) gem_ctx_param (invalid-ctx-set)
[317.411525] Starting subtest: invalid-ctx-set
[317.412528] Subtest invalid-ctx-set: SUCCESS (0.001s)
[317.549077] [072/131] (701s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[317.646832] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[317.648622] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[317.765604] [073/131] (700s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[317.849738] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[317.969711] [074/131] (700s left) kms_flip (flip-vs-suspend-interruptible)
[318.062400] Starting subtest: flip-vs-suspend-interruptible
[318.065427] Starting dynamic subtest: A-eDP1
[351.419380] Dynamic subtest A-eDP1: SUCCESS (4.325s)
[351.428197] Starting dynamic subtest: B-eDP1
[385.399015] Dynamic subtest B-eDP1: SUCCESS (3.975s)
[385.407632] Starting dynamic subtest: C-eDP1
[419.389436] Dynamic subtest C-eDP1: SUCCESS (4.038s)
[419.423316] Starting dynamic subtest: D-eDP1
[453.388058] Dynamic subtest D-eDP1: SUCCESS (4.013s)
[453.434546] Subtest flip-vs-suspend-interruptible: SUCCESS (16.361s)
[459.658039] [075/131] (564s left) gem_wait (invalid-flags)
[459.716660] Starting subtest: invalid-flags
[459.717663] Subtest invalid-flags: SUCCESS (0.000s)
[459.957679] [076/131] (563s left) gem_exec_endless (dispatch)
[460.026661] Starting subtest: dispatch
[460.027905] Starting dynamic subtest: rcs0
[460.032621] Dynamic subtest rcs0: SUCCESS (0.006s)
[460.041062] Starting dynamic subtest: bcs0
[460.043052] Dynamic subtest bcs0: SUCCESS (0.004s)
[460.051071] Starting dynamic subtest: vcs0
[460.053241] Dynamic subtest vcs0: SUCCESS (0.004s)
[460.061853] Starting dynamic subtest: vcs1
[460.063823] Dynamic subtest vcs1: SUCCESS (0.004s)
[460.071358] Starting dynamic subtest: vecs0
[460.072978] Dynamic subtest vecs0: SUCCESS (0.004s)
[460.080718] Starting dynamic subtest: ccs0
[460.082356] Dynamic subtest ccs0: SUCCESS (0.004s)
[460.083183] Subtest dispatch: SUCCESS (0.030s)
[461.958530] [077/131] (561s left) kms_vblank (wait-forked)
[462.052664] Starting subtest: wait-forked
[462.053693] Starting dynamic subtest: pipe-A-eDP-1
[463.868111] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.814s)
[463.878204] Starting dynamic subtest: pipe-D-eDP-1
[466.350036] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.476s)
[466.350990] Subtest wait-forked: SUCCESS (4.293s)
[467.223653] [078/131] (556s left) gem_ctx_persistence (file)
[467.275764] Starting subtest: file
[467.430583] Subtest file: SUCCESS (0.154s)
[467.562760] [079/131] (556s left) gem_eio (wait-wedge-10ms)
[467.773574] Starting subtest: wait-wedge-10ms
[468.950875] Subtest wait-wedge-10ms: SUCCESS (1.176s)
[469.104441] [080/131] (554s left) gem_exec_balancer (semaphore)
[469.149567] Starting subtest: semaphore
[470.868607] Subtest semaphore: SUCCESS (1.715s)
[471.227875] [081/131] (552s left) gem_ctx_exec (basic-invalid-context)
[471.283674] Starting subtest: basic-invalid-context
[471.289784] Subtest basic-invalid-context: SUCCESS (0.006s)
[471.431341] [082/131] (552s left) i915_module_load (resize-bar)
[471.457624] Starting subtest: resize-bar
[471.463428] Subtest resize-bar: SKIP (0.006s)
[471.504492] [083/131] (552s left) kms_addfb_basic (small-bo)
[471.591363] Starting subtest: small-bo
[471.592309] Subtest small-bo: SUCCESS (0.000s)
[471.722657] [084/131] (552s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[471.808387] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[479.113762] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.303s)
[479.269659] [085/131] (544s left) gem_exec_fence (syncobj-signal)
[479.715664] Starting subtest: syncobj-signal
[479.720330] Subtest syncobj-signal: SUCCESS (0.005s)
[480.970914] [086/131] (543s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[481.062654] Starting subtest: psr-2p-pri-indfb-multidraw
[481.064508] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[481.196555] [087/131] (542s left) gem_ctx_shared (detached-shared-gtt)
[481.250359] Starting subtest: detached-shared-gtt
[483.405402] Subtest detached-shared-gtt: SUCCESS (2.152s)
[483.743571] [088/131] (540s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[483.842996] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[483.844802] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[483.970030] [089/131] (540s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[484.065398] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[490.283634] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.217s)
[491.472298] [090/131] (532s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[491.564917] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[491.566841] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[491.710293] [091/131] (532s left) kms_plane_lowres (tiling-x)
[491.794617] Starting subtest: tiling-x
[491.795450] Starting dynamic subtest: pipe-A-eDP-1
[491.796990] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[492.086348] Starting dynamic subtest: pipe-B-eDP-1
[492.088206] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[492.096069] Starting dynamic subtest: pipe-C-eDP-1
[492.098486] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[492.106356] Starting dynamic subtest: pipe-D-eDP-1
[492.108259] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[492.109944] Subtest tiling-x: SKIP (0.288s)
[492.887414] [092/131] (531s left) gem_softpin (reverse)
[492.944670] Starting subtest: reverse
[492.949829] Subtest reverse: SUCCESS (0.005s)
[493.083571] [093/131] (531s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[493.136980] Starting subtest: etime-multi-wait-available-unsubmitted
[493.243357] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.104s)
[493.323121] [094/131] (531s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[493.408276] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[493.409115] Starting dynamic subtest: pipe-A-default-mode
[493.702409] Dynamic subtest pipe-A-default-mode: SKIP (0.292s)
[493.704096] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.293s)
[494.518778] [095/131] (529s left) kms_pm_rpm (modeset-non-lpsp)
[496.032878] Starting subtest: modeset-non-lpsp
[497.188835] Subtest modeset-non-lpsp: SKIP (1.154s)
[497.578038] [096/131] (526s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[497.669897] Starting subtest: 4-tiled-8bpp-rotate-90
[497.690250] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.020s)
[497.850002] [097/131] (526s left) syncobj_wait (single-wait-for-submit-submitted)
[497.896001] Starting subtest: single-wait-for-submit-submitted
[498.002814] Subtest single-wait-for-submit-submitted: SUCCESS (0.104s)
[498.093876] [098/131] (526s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[498.169017] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[498.169940] Starting dynamic subtest: pipe-A-eDP-1
[500.173195] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.003s)
[500.184332] Starting dynamic subtest: pipe-B-eDP-1
[502.248318] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.074s)
[502.257820] Starting dynamic subtest: pipe-C-eDP-1
[504.292980] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.043s)
[504.301259] Starting dynamic subtest: pipe-D-eDP-1
[506.342881] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.049s)
[506.343884] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.173s)
[507.585939] [099/131] (516s left) kms_psr (psr-primary-mmap-gtt)
[507.671557] Starting subtest: psr-primary-mmap-gtt
[507.672420] Starting dynamic subtest: eDP-1
[509.082852] Dynamic subtest eDP-1: SKIP (1.408s)
[509.085296] Subtest psr-primary-mmap-gtt: SKIP (1.409s)
[509.233596] [100/131] (515s left) gem_vm_create (invalid-create)
[509.290588] Starting subtest: invalid-create
[509.294437] Subtest invalid-create: SUCCESS (0.003s)
[509.436835] [101/131] (515s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[509.524235] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[509.526061] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[509.651755] [102/131] (514s left) gem_mmap_gtt (pf-nonblock)
[509.706571] Subtest pf-nonblock: SKIP (0.000s)
[509.761790] [103/131] (514s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[509.857331] Starting subtest: x-tiled-8bpp-rotate-0
[510.992423] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.135s)
[511.156802] [104/131] (513s left) kms_flip (2x-flip-vs-panning-vs-hang)
[511.251075] Starting subtest: 2x-flip-vs-panning-vs-hang
[511.261523] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.011s)
[511.402149] [105/131] (513s left) kms_debugfs (display-on-read-all)
[511.491724] Starting subtest: display-on-read-all
[511.613033] Subtest display-on-read-all: SUCCESS (0.123s)
[511.776399] [106/131] (512s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[511.878691] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[511.880405] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[511.996013] [107/131] (512s left) gem_lmem_swapping (parallel-random)
[512.030664] Subtest parallel-random: SKIP (0.000s)
[512.069167] [108/131] (512s left) kms_vblank (query-idle-hang)
[512.155446] Starting subtest: query-idle-hang
[512.156281] Starting dynamic subtest: pipe-A-eDP-1
[538.634294] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.473s)
[538.644531] Starting dynamic subtest: pipe-D-eDP-1
[553.680904] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.041s)
[553.681843] Subtest query-idle-hang: SUCCESS (41.519s)
[554.482467] [109/131] (470s left) gem_mmap_wc (set-cache-level)
[554.532147] Subtest set-cache-level: SKIP (0.000s)
[554.591357] [110/131] (470s left) gem_render_copy_redux (flink-interruptible)
[554.642673] Starting subtest: flink-interruptible
[555.423654] Subtest flink-interruptible: SUCCESS (0.781s)
[555.588991] [111/131] (469s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[555.685570] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[560.183005] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.498s)
[561.379254] [112/131] (463s left) kms_getfb (getfb-handle-closed)
[561.467472] Starting subtest: getfb-handle-closed
[561.468356] Subtest getfb-handle-closed: SUCCESS (0.000s)
[561.602928] [113/131] (463s left) i915_query (engine-info)
[561.656721] Starting subtest: engine-info
[561.659122] Subtest engine-info: SUCCESS (0.005s)
[561.794163] [114/131] (463s left) kms_invalid_mode (bad-vtotal)
[561.886089] Starting subtest: bad-vtotal
[561.887058] Starting dynamic subtest: pipe-A-eDP-1
[562.167610] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.281s)
[562.177197] Starting dynamic subtest: pipe-B-eDP-1
[562.178019] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[562.185401] Starting dynamic subtest: pipe-C-eDP-1
[562.186273] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[562.193960] Starting dynamic subtest: pipe-D-eDP-1
[562.194876] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[562.195801] Subtest bad-vtotal: SUCCESS (0.287s)
[563.017783] [115/131] (461s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[563.117419] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[564.028499] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.911s)
[564.168570] [116/131] (460s left) gem_exec_params (no-blt)
[564.229990] Starting subtest: no-blt
[564.232927] Subtest no-blt: SUCCESS (0.003s)
[564.398546] [117/131] (460s left) api_intel_bb (purge-bb)
[564.454928] Starting subtest: purge-bb
[564.458351] Subtest purge-bb: SUCCESS (0.004s)
[564.598846] [118/131] (460s left) kms_flip (dpms-vs-vblank-race)
[564.690457] Starting subtest: dpms-vs-vblank-race
[564.691390] Starting dynamic subtest: A-eDP1
[568.580676] Dynamic subtest A-eDP1: SUCCESS (3.889s)
[568.589099] Starting dynamic subtest: B-eDP1
[573.217271] Dynamic subtest B-eDP1: SUCCESS (4.636s)
[573.225454] Starting dynamic subtest: C-eDP1
[577.862635] Dynamic subtest C-eDP1: SUCCESS (4.645s)
[577.870580] Starting dynamic subtest: D-eDP1
[582.458835] Dynamic subtest D-eDP1: SUCCESS (4.595s)
[582.461090] Subtest dpms-vs-vblank-race: SUCCESS (17.772s)
[583.354017] [119/131] (441s left) kms_force_connector_basic (prune-stale-modes)
[583.431817] Starting subtest: prune-stale-modes
[583.871403] Subtest prune-stale-modes: SUCCESS (0.439s)
[584.032438] [120/131] (441s left) gem_exec_create (madvise)
[584.087980] Starting subtest: madvise
[584.089098] Starting dynamic subtest: smem
[605.963563] Dynamic subtest smem: SUCCESS (21.873s)
[605.965354] Subtest madvise: SUCCESS (21.873s)
[606.733820] [121/131] (418s left) perf_pmu (enable-race)
[606.764300] Starting subtest: enable-race
[606.765193] Starting dynamic subtest: rcs0
[619.532471] Dynamic subtest rcs0: SUCCESS (12.767s)
[619.542189] Starting dynamic subtest: bcs0
[632.274038] Dynamic subtest bcs0: SUCCESS (12.738s)
[632.283232] Starting dynamic subtest: vcs0
[647.886010] Dynamic subtest vcs0: SUCCESS (15.606s)
[647.897618] Starting dynamic subtest: vcs1
[663.886778] Dynamic subtest vcs1: SUCCESS (15.993s)
[663.897485] Starting dynamic subtest: vecs0
[679.822077] Dynamic subtest vecs0: SUCCESS (15.931s)
[679.831713] Starting dynamic subtest: ccs0
[692.573039] Dynamic subtest ccs0: SUCCESS (12.752s)
[692.574691] Subtest enable-race: SUCCESS (85.801s)
[692.708676] [122/131] (332s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[692.803040] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[692.804806] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[692.938012] [123/131] (332s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[693.026508] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[699.908257] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (6.881s)
[700.049134] [124/131] (325s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[700.099525] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[700.147951] [125/131] (325s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[700.198658] Starting subtest: y-tiled-ccs-to-yf-tiled
[700.200773] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[700.398017] [126/131] (324s left) gem_exec_whisper (basic-queues-forked-all)
[700.448319] Starting subtest: basic-queues-forked-all
[720.207005] Subtest basic-queues-forked-all: SUCCESS (19.755s)
[720.393866] [127/131] (305s left) kms_getfb (getfb2-accept-nv12)
[720.496222] Starting subtest: getfb2-accept-nv12
[720.497029] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[720.602487] [128/131] (304s left) syncobj_timeline (invalid-transfer-bad-pad)
[720.645386] Starting subtest: invalid-transfer-bad-pad
[720.646326] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[720.765694] [129/131] (304s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[720.976703] Starting subtest: cursor-rapid-movement-128x42
[721.012927] Subtest cursor-rapid-movement-128x42: SKIP (0.033s)
[721.246829] [130/131] (304s left) gem_pxp (reject-modify-context-protection-off-3)
[721.369310] Starting subtest: reject-modify-context-protection-off-3
[721.370614] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[721.480487] [131/131] (304s left) kms_frontbuffer_tracking (psr-2p-rte)
[721.573358] Starting subtest: psr-2p-rte
[721.575117] Subtest psr-2p-rte: SKIP (0.000s)
[721.680868] Closing watchdogs
results: parsing output: 0/ for test: gem_mmap_offset
results: parsing output: 1/ for test: gem_exec_schedule
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: syncobj_wait
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_plane_scaling
results: parsing output: 8/ for test: gem_render_copy_redux
results: parsing output: 9/ for test: i915_drm_fdinfo
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_psr_stress_test
results: parsing output: 12/ for test: gem_mmap_gtt
results: parsing output: 13/ for test: prime_vgem
results: parsing output: 14/ for test: kms_setmode
results: parsing output: 15/ for test: kms_color
results: parsing output: 16/ for test: syncobj_wait
results: parsing output: 17/ for test: gem_exec_reloc
results: parsing output: 18/ for test: kms_legacy_colorkey
results: parsing output: 19/ for test: api_intel_bb
results: parsing output: 20/ for test: syncobj_eventfd
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_chamelium_color
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_ccs
results: parsing output: 26/ for test: kms_psr2_sf
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: kms_rotation_crc
results: parsing output: 31/ for test: kms_cursor_legacy
results: parsing output: 32/ for test: prime_self_import
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: kms_cursor_crc
results: parsing output: 35/ for test: gem_eio
results: parsing output: 36/ for test: kms_async_flips
results: parsing output: 37/ for test: kms_fbcon_fbt
results: parsing output: 38/ for test: kms_flip
results: parsing output: 39/ for test: kms_properties
results: parsing output: 40/ for test: kms_plane_scaling
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: gem_exec_schedule
results: parsing output: 43/ for test: vgem_basic
results: parsing output: 44/ for test: fbdev
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: kms_lease
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: kms_busy
results: parsing output: 51/ for test: gem_exec_store
results: parsing output: 52/ for test: kms_cursor_legacy
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: kms_flip
results: parsing output: 55/ for test: kms_pm_rpm
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_caching
results: parsing output: 58/ for test: kms_psr2_sf
results: parsing output: 59/ for test: gem_exec_reloc
results: parsing output: 60/ for test: perf
results: parsing output: 61/ for test: kms_chamelium_frames
results: parsing output: 62/ for test: gem_eio
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: perf
results: parsing output: 65/ for test: syncobj_wait
results: parsing output: 66/ for test: gen7_exec_parse
results: parsing output: 67/ for test: i915_drm_fdinfo
results: parsing output: 68/ for test: kms_flip_scaled_crc
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_ctx_param
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_addfb_basic
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: gem_wait
results: parsing output: 75/ for test: gem_exec_endless
results: parsing output: 76/ for test: kms_vblank
results: parsing output: 77/ for test: gem_ctx_persistence
results: parsing output: 78/ for test: gem_eio
results: parsing output: 79/ for test: gem_exec_balancer
results: parsing output: 80/ for test: gem_ctx_exec
results: parsing output: 81/ for test: i915_module_load
results: parsing output: 82/ for test: kms_addfb_basic
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_exec_fence
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_ctx_shared
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_plane_lowres
results: parsing output: 91/ for test: gem_softpin
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: kms_flip_scaled_crc
results: parsing output: 94/ for test: kms_pm_rpm
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: syncobj_wait
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: gem_vm_create
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: gem_mmap_gtt
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: kms_debugfs
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: gem_lmem_swapping
results: parsing output: 107/ for test: kms_vblank
results: parsing output: 108/ for test: gem_mmap_wc
results: parsing output: 109/ for test: gem_render_copy_redux
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_getfb
results: parsing output: 112/ for test: i915_query
results: parsing output: 113/ for test: kms_invalid_mode
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: gem_exec_params
results: parsing output: 116/ for test: api_intel_bb
results: parsing output: 117/ for test: kms_flip
results: parsing output: 118/ for test: kms_force_connector_basic
results: parsing output: 119/ for test: gem_exec_create
results: parsing output: 120/ for test: perf_pmu
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_pipe_b_c_ivb
results: parsing output: 124/ for test: gem_render_copy
results: parsing output: 125/ for test: gem_exec_whisper
results: parsing output: 126/ for test: kms_getfb
results: parsing output: 127/ for test: syncobj_timeline
results: parsing output: 128/ for test: kms_cursor_crc
results: parsing output: 129/ for test: gem_pxp
results: parsing output: 130/ for test: kms_frontbuffer_tracking
Done.