[58.311535] Initializing watchdogs
[58.311580]   /dev/watchdog0
[58.325779] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.330116] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.332352] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.335735] [001/133] (960s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[58.450044] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[58.454532] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[58.518143] [002/133] (960s left) gem_render_copy (x-tiled)
[58.580113] Starting subtest: x-tiled
[58.582552] Starting dynamic subtest: smem
[58.625560] Dynamic subtest smem: SUCCESS (0.045s)
[58.627932] Subtest x-tiled: SUCCESS (0.045s)
[58.843930] [003/133] (960s left) syncobj_wait (wait-for-submit-complex)
[58.896703] Starting subtest: wait-for-submit-complex
[58.958548] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[59.029457] [004/133] (959s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[59.123955] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[81.455677] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.338s)
[81.587633] [005/133] (937s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[81.695306] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[81.698763] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[81.757255] [006/133] (937s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[81.819444] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[81.821414] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[81.921343] [007/133] (937s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[82.026705] Starting subtest: y-tiled-64bpp-rotate-270
[82.030479] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[82.139679] [008/133] (936s left) gem_exec_whisper (basic-contexts-forked)
[82.209110] Starting subtest: basic-contexts-forked
[105.618966] Subtest basic-contexts-forked: SUCCESS (23.405s)
[105.819304] [009/133] (913s left) gem_readwrite (read-bad-handle)
[105.877585] Subtest read-bad-handle: SKIP (0.000s)
[105.929888] [010/133] (913s left) kms_psr (psr-dpms)
[106.026853] Starting subtest: psr-dpms
[106.029171] Starting dynamic subtest: eDP-1
[109.036310] Dynamic subtest eDP-1: SUCCESS (3.009s)
[109.038515] Subtest psr-dpms: SUCCESS (3.010s)
[109.902473] [011/133] (909s left) prime_vgem (basic-gtt)
[110.070102] Starting subtest: basic-gtt
[110.074356] Subtest basic-gtt: SKIP (0.000s)
[110.163669] [FACT prime_vgem (basic-gtt)] new: kernel.kmod_is_loaded.vgem: true
[110.166899] [012/133] (909s left) gem_exec_fence (syncobj-import)
[110.580945] Starting subtest: syncobj-import
[110.589164] Subtest syncobj-import: SUCCESS (0.008s)
[111.986633] [013/133] (907s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[112.085252] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[112.089421] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s)
[112.169214] [014/133] (907s left) kms_rotation_crc (cursor-rotation-180)
[112.261886] Starting subtest: cursor-rotation-180
[113.764380] Subtest cursor-rotation-180: SUCCESS (1.503s)
[114.972437] [015/133] (904s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[115.023172] Starting subtest: etime-single-wait-all-for-submit-submitted
[115.131066] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.107s)
[115.204313] [016/133] (904s left) gem_mmap_wc (write-gtt-read-wc)
[115.258739] Subtest write-gtt-read-wc: SKIP (0.000s)
[115.340113] [017/133] (904s left) gem_spin_batch (legacy)
[115.407786] Starting subtest: legacy
[115.410211] Starting dynamic subtest: default
[118.650716] Dynamic subtest default: SUCCESS (3.235s)
[118.667431] Starting dynamic subtest: render
[121.882996] Dynamic subtest render: SUCCESS (3.229s)
[121.892903] Starting dynamic subtest: bsd
[125.118997] Dynamic subtest bsd: SUCCESS (3.233s)
[125.129432] Starting dynamic subtest: bsd1
[128.355906] Dynamic subtest bsd1: SUCCESS (3.234s)
[128.365920] Starting dynamic subtest: bsd2
[131.590120] Dynamic subtest bsd2: SUCCESS (3.231s)
[131.598581] Starting dynamic subtest: blt
[134.823696] Dynamic subtest blt: SUCCESS (3.230s)
[134.834079] Starting dynamic subtest: vebox
[138.058870] Dynamic subtest vebox: SUCCESS (3.232s)
[138.061281] Subtest legacy: SUCCESS (22.642s)
[139.929676] [018/133] (879s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[139.987517] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[139.989633] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[140.080711] [019/133] (879s left) kms_psr (psr-cursor-plane-onoff)
[140.173016] Starting subtest: psr-cursor-plane-onoff
[140.175284] Starting dynamic subtest: eDP-1
[141.877073] Dynamic subtest eDP-1: SUCCESS (1.704s)
[141.879407] Subtest psr-cursor-plane-onoff: SUCCESS (1.704s)
[142.744322] [020/133] (876s left) i915_pm_freq_api (freq-suspend)
[142.800832] Starting subtest: freq-suspend
[142.803148] Starting dynamic subtest: gt0
[159.345626] Dynamic subtest gt0: SUCCESS (1.356s)
[159.359943] Starting dynamic subtest: gt1
[175.343074] Dynamic subtest gt1: SUCCESS (1.227s)
[175.345261] Subtest freq-suspend: SUCCESS (2.587s)
[175.445210] [021/133] (844s left) i915_query (hwconfig_table)
[175.501020] Starting subtest: hwconfig_table
[175.799539] Subtest hwconfig_table: SUCCESS (0.001s)
[175.836855] [022/133] (843s left) gem_exec_reloc (basic-gtt-read-noreloc)
[175.897793] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[175.973758] [023/133] (843s left) kms_big_fb (linear-8bpp-rotate-90)
[176.070695] Starting subtest: linear-8bpp-rotate-90
[176.095646] Subtest linear-8bpp-rotate-90: SKIP (0.025s)
[176.220772] [024/133] (843s left) kms_content_protection (suspend-resume)
[176.354830] Starting subtest: suspend-resume
[176.358796] Subtest suspend-resume: SKIP (0.000s)
[176.480634] [025/133] (843s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[176.569145] Starting subtest: basic-modeset-with-all-modifiers-formats
[176.942836] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[177.685913] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.743s)
[177.695649] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[177.707774] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[177.716309] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[177.730075] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[177.739229] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[177.875033] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.144s)
[177.884755] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[177.897104] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.022s)
[177.906064] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[177.919142] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[177.927556] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[177.941886] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[177.950382] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[177.963825] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[177.972573] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[177.986172] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[177.995058] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[178.008409] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[178.017171] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[178.030628] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.022s)
[178.039160] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[178.052969] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[178.061384] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[178.197854] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.144s)
[178.207061] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[178.219564] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[178.228075] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[178.242181] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s)
[178.250544] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[178.264569] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[178.275195] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[178.286658] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[178.296001] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[178.308551] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s)
[178.316777] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[178.331060] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s)
[178.339274] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[178.353045] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[178.361470] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[178.375549] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[178.383802] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[178.531796] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s)
[178.540443] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[178.554238] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.022s)
[178.564907] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[178.576395] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.021s)
[178.584528] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[178.598258] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[178.606838] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[178.620464] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[178.628391] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[178.642765] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[178.650743] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[178.665045] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[178.673133] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[178.687321] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[178.695424] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[178.709672] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.021s)
[179.107011] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.535s)
[179.866633] [026/133] (839s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[179.967776] Starting subtest: bad-pixel-format-y-tiled-ccs
[179.970149] Starting dynamic subtest: pipe-A-eDP-1
[179.993429] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[180.004069] Starting dynamic subtest: pipe-B-eDP-1
[180.026688] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[180.035224] Starting dynamic subtest: pipe-C-eDP-1
[180.057092] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[180.065769] Starting dynamic subtest: pipe-D-eDP-1
[180.087587] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[180.091648] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s)
[182.169384] [027/133] (837s left) gem_mmap (bad-size)
[182.234931] Subtest bad-size: SKIP (0.000s)
[182.316490] [028/133] (837s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[182.414064] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[182.417952] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[182.496703] [029/133] (837s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[182.591696] Starting subtest: disable-crc-after-crtc
[182.593525] Starting dynamic subtest: pipe-A-eDP-1
[184.255963] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.662s)
[184.265601] Starting dynamic subtest: pipe-B-eDP-1
[186.583512] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.323s)
[186.593504] Starting dynamic subtest: pipe-C-eDP-1
[188.821974] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.237s)
[188.832026] Starting dynamic subtest: pipe-D-eDP-1
[191.089795] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.266s)
[191.092178] Subtest disable-crc-after-crtc: SUCCESS (8.494s)
[191.927246] [030/133] (828s left) kms_invalid_mode (clock-too-high)
[192.030261] Starting subtest: clock-too-high
[192.033129] Starting dynamic subtest: pipe-A-eDP-1
[192.037901] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[192.049318] Starting dynamic subtest: pipe-B-eDP-1
[192.053732] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[192.062547] Starting dynamic subtest: pipe-C-eDP-1
[192.066725] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[192.074845] Starting dynamic subtest: pipe-D-eDP-1
[192.079018] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[192.082971] Subtest clock-too-high: SKIP (0.004s)
[192.118172] [031/133] (827s left) syncobj_timeline (signal)
[192.177086] Starting subtest: signal
[192.178945] Subtest signal: SUCCESS (0.000s)
[192.284944] [032/133] (827s left) kms_hdr (bpc-switch)
[192.370379] Starting subtest: bpc-switch
[193.413136] Starting dynamic subtest: pipe-A-eDP-1
[196.811810] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.400s)
[196.814203] Subtest bpc-switch: SUCCESS (4.443s)
[196.937211] [033/133] (823s left) perf (gen12-group-concurrent-oa-buffer-read)
[197.076480] Starting subtest: gen12-group-concurrent-oa-buffer-read
[207.112968] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.033s)
[207.160440] [034/133] (813s left) gem_exec_reloc (basic-cpu-wc-active)
[207.221906] Subtest basic-cpu-wc-active: SKIP (0.000s)
[207.296286] [035/133] (812s left) kms_cursor_edge_walk (256x256-top-bottom)
[207.404133] Starting subtest: 256x256-top-bottom
[207.406512] Starting dynamic subtest: pipe-A-eDP-1
[210.848032] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.444s)
[210.857923] Starting dynamic subtest: pipe-D-eDP-1
[213.976904] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.128s)
[213.979162] Subtest 256x256-top-bottom: SUCCESS (6.575s)
[214.792622] [036/133] (805s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[214.918998] Starting subtest: cursorA-vs-flipB-varying-size
[214.923617] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[215.072933] [037/133] (805s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[215.121668] Starting subtest: etime-multi-wait-all-available-unsubmitted
[215.225780] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.103s)
[215.306881] [038/133] (805s left) gem_workarounds (basic-read-context)
[215.375252] Starting subtest: basic-read-context
[215.383459] Subtest basic-read-context: SUCCESS (0.010s)
[215.507946] [039/133] (804s left) kms_flip (flip-vs-rmfb)
[215.604494] Starting subtest: flip-vs-rmfb
[215.606768] Starting dynamic subtest: A-eDP1
[224.277149] Dynamic subtest A-eDP1: SUCCESS (8.672s)
[224.287630] Starting dynamic subtest: B-eDP1
[232.911227] Dynamic subtest B-eDP1: SUCCESS (8.632s)
[232.921235] Starting dynamic subtest: C-eDP1
[241.553130] Dynamic subtest C-eDP1: SUCCESS (8.640s)
[241.562298] Starting dynamic subtest: D-eDP1
[250.178847] Dynamic subtest D-eDP1: SUCCESS (8.622s)
[250.183513] Subtest flip-vs-rmfb: SUCCESS (34.576s)
[251.361291] [040/133] (769s left) gem_exec_suspend (basic-s3)
[251.432041] Starting subtest: basic-S3
[251.434384] Starting dynamic subtest: smem
[271.291042] Dynamic subtest smem: SUCCESS (6.431s)
[271.293692] Subtest basic-S3: SUCCESS (6.434s)
[271.490196] [041/133] (748s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[271.583561] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[271.585759] Starting dynamic subtest: pipe-A-eDP-1
[271.608108] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[271.620266] Starting dynamic subtest: pipe-B-eDP-1
[271.641644] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[271.650284] Starting dynamic subtest: pipe-C-eDP-1
[271.671726] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[271.680431] Starting dynamic subtest: pipe-D-eDP-1
[271.702105] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[271.706124] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[273.817349] [042/133] (746s left) gem_lmem_swapping (heavy-verify-multi)
[273.864114] Subtest heavy-verify-multi: SKIP (0.000s)
[273.913314] [043/133] (746s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[274.011538] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[274.015940] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[275.135677] [044/133] (745s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[275.231212] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[275.235686] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[275.329783] [045/133] (745s left) api_intel_bb (destroy-bb)
[275.388205] Starting subtest: destroy-bb
[275.396551] Subtest destroy-bb: SUCCESS (0.008s)
[275.514609] [046/133] (745s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[275.612704] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[275.616656] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[275.716660] [047/133] (745s left) kms_atomic_transition (modeset-transition)
[275.805828] Starting subtest: modeset-transition
[275.807746] Starting dynamic subtest: 1x-outputs
[286.586544] Dynamic subtest 1x-outputs: SUCCESS (10.771s)
[286.589414] Subtest modeset-transition: SUCCESS (10.773s)
[287.457476] [048/133] (733s left) gem_ctx_shared (q-smoketest-all)
[287.519817] Starting subtest: Q-smoketest-all
[319.906915] Subtest Q-smoketest-all: SUCCESS (32.334s)
[321.315603] [049/133] (699s left) gem_fence_thrash (bo-write-verify-none)
[321.356723] Starting subtest: bo-write-verify-none
[321.380104] Subtest bo-write-verify-none: SKIP (0.022s)
[321.439878] [050/133] (699s left) kms_cursor_crc (cursor-offscreen-128x128)
[321.665837] Starting subtest: cursor-offscreen-128x128
[321.670793] Starting dynamic subtest: pipe-A-eDP-1
[323.603916] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.934s)
[323.636372] Starting dynamic subtest: pipe-D-eDP-1
[326.252553] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.624s)
[326.254805] Subtest cursor-offscreen-128x128: SUCCESS (4.584s)
[327.117855] [051/133] (693s left) gem_exec_balancer (bonded-false-hang)
[327.392012] Starting subtest: bonded-false-hang
[327.396809] Subtest bonded-false-hang: SKIP (0.000s)
[327.495159] [052/133] (693s left) kms_big_fb (4-tiled-addfb-size-overflow)
[327.584221] Starting subtest: 4-tiled-addfb-size-overflow
[327.586594] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[327.679425] [053/133] (693s left) kms_psr (fbc-psr-primary-render)
[327.780740] Starting subtest: fbc-psr-primary-render
[327.782578] Starting dynamic subtest: eDP-1
[327.786370] Dynamic subtest eDP-1: SKIP (0.000s)
[327.790311] Subtest fbc-psr-primary-render: SKIP (0.001s)
[327.852234] [054/133] (693s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[327.952840] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[327.955121] Starting dynamic subtest: pipe-A-default-mode
[329.090857] Dynamic subtest pipe-A-default-mode: SKIP (1.136s)
[329.095399] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.137s)
[329.247421] [055/133] (691s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip)
[329.357345] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip
[329.361895] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[329.450935] [056/133] (691s left) gem_fence_thrash (bo-write-verify-y)
[329.488594] Starting subtest: bo-write-verify-y
[329.521515] Subtest bo-write-verify-y: SKIP (0.030s)
[329.588391] [057/133] (691s left) perf_pmu (all-busy-check-all)
[329.623029] Starting subtest: all-busy-check-all
[331.259302] Subtest all-busy-check-all: SUCCESS (1.635s)
[331.366519] [058/133] (689s left) gem_exec_schedule (manyslice)
[331.450283] Starting subtest: manyslice
[331.452346] Starting dynamic subtest: rcs0
[336.578829] Dynamic subtest rcs0: SUCCESS (5.134s)
[336.588675] Starting dynamic subtest: bcs0
[343.198981] Dynamic subtest bcs0: SUCCESS (6.615s)
[343.216684] Starting dynamic subtest: vcs0
[349.788558] Dynamic subtest vcs0: SUCCESS (6.587s)
[349.802528] Starting dynamic subtest: vcs1
[355.873577] Dynamic subtest vcs1: SUCCESS (6.080s)
[355.886472] Starting dynamic subtest: vecs0
[361.943614] Dynamic subtest vecs0: SUCCESS (6.066s)
[361.956402] Starting dynamic subtest: ccs0
[369.696510] Dynamic subtest ccs0: SUCCESS (7.749s)
[369.699228] Subtest manyslice: SUCCESS (38.244s)
[370.002680] [059/133] (651s left) core_sysfs (read-all-entries)
[370.055415] Starting subtest: read-all-entries
[370.066606] Subtest read-all-entries: SUCCESS (0.011s)
[370.184481] [060/133] (651s left) kms_draw_crc (draw-method-mmap-cpu)
[370.311706] Starting subtest: draw-method-mmap-cpu
[370.313901] Starting dynamic subtest: xrgb8888-untiled
[370.531479] Dynamic subtest xrgb8888-untiled: SUCCESS (0.222s)
[370.541407] Starting dynamic subtest: rgb565-untiled
[370.731756] Dynamic subtest rgb565-untiled: SUCCESS (0.199s)
[370.742161] Starting dynamic subtest: xrgb2101010-untiled
[370.931415] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.199s)
[370.940798] Starting dynamic subtest: xbgr16161616f-untiled
[371.141952] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.210s)
[371.150709] Starting dynamic subtest: xrgb8888-xtiled
[371.264316] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[371.273376] Starting dynamic subtest: rgb565-xtiled
[371.386392] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[371.395448] Starting dynamic subtest: xrgb2101010-xtiled
[371.497455] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[371.506127] Starting dynamic subtest: xbgr16161616f-xtiled
[371.620068] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s)
[371.631203] Starting dynamic subtest: xrgb8888-4tiled
[371.819656] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.197s)
[371.832717] Starting dynamic subtest: rgb565-4tiled
[372.041565] Dynamic subtest rgb565-4tiled: SUCCESS (0.220s)
[372.050114] Starting dynamic subtest: xrgb2101010-4tiled
[372.164826] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s)
[372.173591] Starting dynamic subtest: xbgr16161616f-4tiled
[372.297300] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[372.299241] Subtest draw-method-mmap-cpu: SUCCESS (1.990s)
[372.428038] [061/133] (648s left) kms_sequence (queue-idle)
[372.523300] Starting subtest: queue-idle
[372.525358] Starting dynamic subtest: pipe-A-eDP-1
[374.341418] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.816s)
[374.350910] Starting dynamic subtest: pipe-B-eDP-1
[376.831024] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.488s)
[376.841206] Starting dynamic subtest: pipe-C-eDP-1
[379.317860] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.489s)
[379.327989] Starting dynamic subtest: pipe-D-eDP-1
[381.748720] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.430s)
[381.751089] Subtest queue-idle: SUCCESS (9.228s)
[382.581009] [062/133] (638s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[382.688750] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[382.690691] Starting dynamic subtest: pipe-A
[383.036747] Dynamic subtest pipe-A: SUCCESS (0.350s)
[383.050758] Starting dynamic subtest: pipe-B
[384.443459] Dynamic subtest pipe-B: SUCCESS (1.405s)
[384.453809] Starting dynamic subtest: pipe-C
[385.866471] Dynamic subtest pipe-C: SUCCESS (1.422s)
[385.875898] Starting dynamic subtest: pipe-D
[387.309112] Dynamic subtest pipe-D: SUCCESS (1.441s)
[387.311675] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.625s)
[388.459875] [063/133] (632s left) i915_drm_fdinfo (basics)
[388.499036] Starting subtest: basics
[388.500994] Subtest basics: SUCCESS (0.000s)
[388.567711] [064/133] (632s left) gem_ringfill (legacy-basic)
[394.302305] Starting subtest: legacy-basic
[394.305120] Starting dynamic subtest: default
[394.366376] Dynamic subtest default: SUCCESS (0.063s)
[394.379199] Starting dynamic subtest: render
[394.409742] Dynamic subtest render: SUCCESS (0.041s)
[394.422875] Starting dynamic subtest: bsd
[394.453535] Dynamic subtest bsd: SUCCESS (0.041s)
[394.466000] Starting dynamic subtest: bsd1
[394.493754] Dynamic subtest bsd1: SUCCESS (0.037s)
[394.503711] Starting dynamic subtest: bsd2
[394.536357] Dynamic subtest bsd2: SUCCESS (0.040s)
[394.546576] Starting dynamic subtest: blt
[394.581219] Dynamic subtest blt: SUCCESS (0.043s)
[394.591821] Starting dynamic subtest: vebox
[394.624469] Dynamic subtest vebox: SUCCESS (0.041s)
[394.626776] Subtest legacy-basic: SUCCESS (0.324s)
[394.703222] [065/133] (626s left) sysfs_timeslice_duration (invalid)
[394.765944] Starting subtest: invalid
[394.768266] Starting dynamic subtest: vecs0
[394.770653] Dynamic subtest vecs0: SUCCESS (0.000s)
[394.780929] Starting dynamic subtest: ccs0
[394.782870] Dynamic subtest ccs0: SUCCESS (0.000s)
[394.791122] Starting dynamic subtest: vcs0
[394.793003] Dynamic subtest vcs0: SUCCESS (0.000s)
[394.801280] Starting dynamic subtest: bcs0
[394.803161] Dynamic subtest bcs0: SUCCESS (0.000s)
[394.811856] Starting dynamic subtest: rcs0
[394.814043] Dynamic subtest rcs0: SUCCESS (0.000s)
[394.822636] Starting dynamic subtest: vcs1
[394.824515] Dynamic subtest vcs1: SUCCESS (0.000s)
[394.826410] Subtest invalid: SUCCESS (0.006s)
[394.879840] [066/133] (626s left) gem_exec_params (larger-than-life-batch)
[394.930862] Starting subtest: larger-than-life-batch
[397.351044] Subtest larger-than-life-batch: SUCCESS (2.420s)
[398.321609] [067/133] (623s left) gem_exec_reloc (basic-write-cpu)
[398.419383] Subtest basic-write-cpu: SKIP (0.000s)
[398.488366] [068/133] (623s left) sriov_basic (enable-vfs-autoprobe-on)
[398.547708] Starting subtest: enable-vfs-autoprobe-on
[398.550047] Starting dynamic subtest: numvfs-1
[398.630963] Dynamic subtest numvfs-1: FAIL (0.030s)
[398.640754] Starting dynamic subtest: numvfs-2
[398.715020] Dynamic subtest numvfs-2: FAIL (0.004s)
[398.725642] Starting dynamic subtest: numvfs-3
[398.798855] Dynamic subtest numvfs-3: FAIL (0.004s)
[398.809361] Starting dynamic subtest: numvfs-4
[398.882553] Dynamic subtest numvfs-4: FAIL (0.006s)
[398.892866] Starting dynamic subtest: numvfs-5
[398.965457] Dynamic subtest numvfs-5: FAIL (0.004s)
[398.976460] Starting dynamic subtest: numvfs-6
[399.049608] Dynamic subtest numvfs-6: FAIL (0.004s)
[399.059907] Starting dynamic subtest: numvfs-7
[399.132891] Dynamic subtest numvfs-7: FAIL (0.003s)
[399.142290] Starting dynamic subtest: numvfs-random
[399.211191] Dynamic subtest numvfs-random: FAIL (0.004s)
[399.220951] Starting dynamic subtest: numvfs-all
[399.283309] Dynamic subtest numvfs-all: FAIL (0.514s)
[399.284908] Subtest enable-vfs-autoprobe-on: FAIL (0.579s)
[399.320767] [069/133] (622s left) gem_eio (banned)
[399.572869] Starting subtest: banned
[400.205285] Subtest banned: SUCCESS (0.634s)
[400.370580] [070/133] (621s left) kms_pm_rpm (basic-pci-d3-state)
[402.417150] Starting subtest: basic-pci-d3-state
[403.882187] Subtest basic-pci-d3-state: SUCCESS (1.466s)
[403.970715] [071/133] (617s left) gem_ccs (ctrl-surf-copy)
[404.044018] Starting subtest: ctrl-surf-copy
[404.048707] Subtest ctrl-surf-copy: SKIP (0.000s)
[404.146922] [072/133] (617s left) prime_mmap (test_reprime)
[404.206177] Starting subtest: test_reprime
[404.207969] Starting dynamic subtest: test_reprime-smem
[404.234121] Dynamic subtest test_reprime-smem: SUCCESS (0.031s)
[404.236563] Subtest test_reprime: SUCCESS (0.032s)
[404.338371] [073/133] (617s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[404.434422] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[405.281055] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.848s)
[405.444395] [074/133] (616s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[405.544036] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[405.548126] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[405.636237] [075/133] (616s left) gem_tiled_wc
[405.756937] [076/133] (616s left) gem_wait (wait)
[405.825802] Starting subtest: wait
[405.828172] Starting dynamic subtest: all-engines
[407.225463] Dynamic subtest all-engines: SUCCESS (1.398s)
[407.236912] Starting dynamic subtest: rcs0
[408.272830] Dynamic subtest rcs0: SUCCESS (1.046s)
[408.285376] Starting dynamic subtest: bcs0
[409.321334] Dynamic subtest bcs0: SUCCESS (1.046s)
[409.336319] Starting dynamic subtest: vcs0
[410.366924] Dynamic subtest vcs0: SUCCESS (1.043s)
[410.379554] Starting dynamic subtest: vcs1
[411.413462] Dynamic subtest vcs1: SUCCESS (1.044s)
[411.426415] Starting dynamic subtest: vecs0
[412.458722] Dynamic subtest vecs0: SUCCESS (1.043s)
[412.471011] Starting dynamic subtest: ccs0
[413.506156] Dynamic subtest ccs0: SUCCESS (1.045s)
[413.508701] Subtest wait: SUCCESS (7.681s)
[413.706669] [077/133] (608s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[413.839549] Starting subtest: flip-vs-cursor-varying-size
[422.573972] Subtest flip-vs-cursor-varying-size: SUCCESS (8.735s)
[423.373761] [078/133] (598s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[423.491298] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[423.495642] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[423.601091] [079/133] (598s left) perf_pmu (multi-client)
[423.640177] Starting subtest: multi-client
[423.642569] Starting dynamic subtest: rcs0
[424.699893] Dynamic subtest rcs0: SUCCESS (1.059s)
[424.712971] Starting dynamic subtest: bcs0
[425.752875] Dynamic subtest bcs0: SUCCESS (1.049s)
[425.766163] Starting dynamic subtest: vcs0
[426.804750] Dynamic subtest vcs0: SUCCESS (1.048s)
[426.816346] Starting dynamic subtest: vcs1
[428.276601] Dynamic subtest vcs1: SUCCESS (1.470s)
[428.292444] Starting dynamic subtest: vecs0
[430.320872] Dynamic subtest vecs0: SUCCESS (2.042s)
[430.333376] Starting dynamic subtest: ccs0
[432.305886] Dynamic subtest ccs0: SUCCESS (1.982s)
[432.308838] Subtest multi-client: SUCCESS (8.666s)
[432.431604] [080/133] (589s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[432.542922] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[432.547420] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[432.645127] [081/133] (589s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[432.751512] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[440.185475] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.434s)
[440.334673] [082/133] (581s left) kms_psr (pr-sprite-blt)
[440.431517] Starting subtest: pr-sprite-blt
[440.435860] Subtest pr-sprite-blt: SKIP (0.000s)
[440.503929] [083/133] (581s left) kms_prime (basic-modeset-hybrid)
[440.589949] Subtest basic-modeset-hybrid: SKIP (0.000s)
[440.689148] [084/133] (581s left) gem_eio (in-flight-internal-1us)
[440.873122] Starting subtest: in-flight-internal-1us
[442.351939] Subtest in-flight-internal-1us: SUCCESS (1.478s)
[442.493957] [085/133] (579s left) gem_exec_create (legacy)
[442.553320] Starting subtest: legacy
[442.555752] Starting dynamic subtest: smem
[446.266715] Dynamic subtest smem: SUCCESS (3.710s)
[446.269491] Subtest legacy: SUCCESS (3.712s)
[446.454075] [086/133] (575s left) syncobj_basic (bad-create-flags)
[446.500466] Starting subtest: bad-create-flags
[446.502758] Subtest bad-create-flags: SUCCESS (0.000s)
[446.593515] [087/133] (575s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[446.689211] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[446.693540] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[446.763470] [088/133] (575s left) kms_psr (fbc-psr2-primary-page-flip)
[446.861789] Starting subtest: fbc-psr2-primary-page-flip
[446.864111] Starting dynamic subtest: eDP-1
[446.868534] Dynamic subtest eDP-1: SKIP (0.000s)
[446.872903] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[446.938792] [089/133] (575s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[447.042000] Starting subtest: psr-rgb565-draw-mmap-wc
[453.677075] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.636s)
[453.777181] [090/133] (568s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[453.881370] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[453.883826] Starting dynamic subtest: pipe-A
[454.216428] Dynamic subtest pipe-A: SUCCESS (0.338s)
[454.227302] Starting dynamic subtest: pipe-B
[455.595399] Dynamic subtest pipe-B: SUCCESS (1.378s)
[455.607940] Starting dynamic subtest: pipe-C
[457.021663] Dynamic subtest pipe-C: SUCCESS (1.424s)
[457.038142] Starting dynamic subtest: pipe-D
[458.459307] Dynamic subtest pipe-D: SUCCESS (1.435s)
[458.461983] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.581s)
[459.633899] [091/133] (563s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[459.746092] Starting subtest: fbcpsr-2p-rte
[459.750312] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[459.853670] [092/133] (562s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[459.938445] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[459.940763] Starting dynamic subtest: pipe-A-eDP-1
[460.762651] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.817s)
[460.774760] Starting dynamic subtest: pipe-B-eDP-1
[462.258371] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.494s)
[462.269339] Starting dynamic subtest: pipe-C-eDP-1
[463.763310] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.502s)
[463.773564] Starting dynamic subtest: pipe-D-eDP-1
[465.295116] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.531s)
[465.297235] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.349s)
[466.488570] [093/133] (556s left) gem_exec_reloc (basic-write-read-noreloc)
[466.565341] Subtest basic-write-read-noreloc: SKIP (0.000s)
[466.631259] [094/133] (556s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[466.729044] Starting subtest: psr-2p-primscrn-spr-indfb-move
[466.733173] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[466.834217] [095/133] (555s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[466.902548] Starting subtest: multi-wait-all-for-submit-signaled
[466.904895] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[467.006782] [096/133] (555s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[467.095204] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[473.764968] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.671s)
[473.904248] [097/133] (548s left) kms_flip (flip-vs-fences-interruptible)
[474.008132] Starting subtest: flip-vs-fences-interruptible
[474.012561] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[474.108048] [098/133] (548s left) gem_pwrite (basic-self)
[474.179945] Subtest basic-self: SKIP (0.000s)
[474.252571] [099/133] (548s left) api_intel_bb (blit-noreloc-keep-cache)
[474.317401] Starting subtest: blit-noreloc-keep-cache
[474.325825] Subtest blit-noreloc-keep-cache: SUCCESS (0.010s)
[474.446447] [100/133] (548s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[474.535312] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[474.539685] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[474.606577] [101/133] (548s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[474.709247] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[479.125334] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.418s)
[480.308019] [102/133] (542s left) kms_chamelium_color (ctm-0-25)
[480.406967] Subtest ctm-0-25: SKIP (0.000s)
[480.453548] [103/133] (542s left) gem_create (create-ext-placement-sanity-check)
[480.623548] Starting subtest: create-ext-placement-sanity-check
[480.626210] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[480.725348] [104/133] (542s left) kms_vblank (ts-continuation-idle-hang)
[480.830548] Starting subtest: ts-continuation-idle-hang
[480.832456] Starting dynamic subtest: pipe-A-eDP-1
[507.001625] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.169s)
[507.017551] Starting dynamic subtest: pipe-D-eDP-1
[522.045036] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.045s)
[522.047304] Subtest ts-continuation-idle-hang: SUCCESS (41.219s)
[522.858515] [105/133] (500s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[522.987799] Starting subtest: short-busy-flip-before-cursor-toggle
[522.992287] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[523.133126] [106/133] (500s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[523.240155] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[523.242490] Starting dynamic subtest: pipe-A-eDP-1
[529.153293] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.917s)
[529.164153] Starting dynamic subtest: pipe-B-eDP-1
[535.811746] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.659s)
[535.814194] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.578s)
[536.695948] [107/133] (486s left) syncobj_wait (wait-delayed-signal)
[536.752420] Starting subtest: wait-delayed-signal
[536.854925] Subtest wait-delayed-signal: SUCCESS (0.103s)
[536.947691] [108/133] (486s left) kms_cursor_crc (cursor-random-256x256)
[537.180402] Starting subtest: cursor-random-256x256
[537.185555] Starting dynamic subtest: pipe-A-eDP-1
[540.502877] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.318s)
[540.532171] Starting dynamic subtest: pipe-D-eDP-1
[544.479074] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.955s)
[544.481506] Subtest cursor-random-256x256: SUCCESS (7.297s)
[545.356966] [109/133] (478s left) kms_flip (2x-modeset-vs-vblank-race)
[545.461827] Starting subtest: 2x-modeset-vs-vblank-race
[545.470043] Subtest 2x-modeset-vs-vblank-race: SKIP (0.010s)
[545.550731] [110/133] (477s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[545.665201] Starting subtest: basic-flip-before-cursor-varying-size
[546.600205] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.935s)
[547.483847] [111/133] (475s left) kms_flip (2x-flip-vs-dpms)
[547.579062] Starting subtest: 2x-flip-vs-dpms
[547.588541] Subtest 2x-flip-vs-dpms: SKIP (0.010s)
[547.670448] [112/133] (475s left) gem_render_copy_redux (interruptible)
[547.735535] Starting subtest: interruptible
[548.026096] Subtest interruptible: SUCCESS (0.291s)
[548.147711] [113/133] (475s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[548.253130] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[548.257678] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[548.346337] [114/133] (475s left) kms_color (ctm-negative)
[548.431013] Starting subtest: ctm-negative
[548.432605] Starting dynamic subtest: pipe-A-eDP-1
[549.140069] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[549.151589] Starting dynamic subtest: pipe-B-eDP-1
[550.601479] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.460s)
[550.612244] Starting dynamic subtest: pipe-C-eDP-1
[551.966748] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.366s)
[551.977490] Starting dynamic subtest: pipe-D-eDP-1
[553.294153] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.327s)
[553.296484] Subtest ctm-negative: SUCCESS (4.865s)
[554.105595] [115/133] (469s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[554.201146] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[561.019652] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.821s)
[561.146787] [116/133] (462s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[561.242188] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[561.246611] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[561.342583] [117/133] (462s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[561.405758] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[561.472272] [118/133] (462s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[561.569706] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[561.574173] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[561.674252] [119/133] (462s left) gem_ctx_persistence (engines-hostile-preempt)
[561.731435] Starting subtest: engines-hostile-preempt
[561.733714] Starting dynamic subtest: rcs0
[561.794912] Dynamic subtest rcs0: SUCCESS (0.063s)
[561.805756] Starting dynamic subtest: bcs0
[561.877043] Dynamic subtest bcs0: SUCCESS (0.081s)
[561.889124] Starting dynamic subtest: vcs0
[563.232585] Dynamic subtest vcs0: SUCCESS (1.351s)
[563.244818] Starting dynamic subtest: vcs1
[565.236056] Dynamic subtest vcs1: SUCCESS (2.001s)
[565.248633] Starting dynamic subtest: vecs0
[567.288773] Dynamic subtest vecs0: SUCCESS (2.050s)
[567.301216] Starting dynamic subtest: ccs0
[567.311734] Dynamic subtest ccs0: SUCCESS (0.022s)
[567.313823] Subtest engines-hostile-preempt: SUCCESS (5.581s)
[567.434632] [120/133] (456s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[567.533186] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[567.537182] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[567.604293] [121/133] (456s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[567.981814] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[568.774994] [122/133] (455s left) gem_render_copy (yf-tiled-ccs-to-linear)
[568.833880] Starting subtest: yf-tiled-ccs-to-linear
[568.838620] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[569.022949] [123/133] (454s left) kms_lease (simple-lease)
[569.109849] Starting subtest: simple-lease
[569.112189] Starting dynamic subtest: pipe-A-eDP-1
[569.606602] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.496s)
[569.617062] Starting dynamic subtest: pipe-B-eDP-1
[571.034720] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.428s)
[571.044817] Starting dynamic subtest: pipe-C-eDP-1
[572.436267] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.398s)
[572.446167] Starting dynamic subtest: pipe-D-eDP-1
[573.836064] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.398s)
[573.838174] Subtest simple-lease: SUCCESS (4.726s)
[574.663655] [124/133] (449s left) gem_mmap_gtt (basic-read-write)
[574.714546] Subtest basic-read-write: SKIP (0.000s)
[574.771284] [125/133] (449s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[574.860290] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[579.315080] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.457s)
[580.453357] [126/133] (443s left) gem_ctx_persistence (heartbeat-close)
[580.503983] Starting subtest: heartbeat-close
[580.508634] Subtest heartbeat-close: SKIP (0.000s)
[580.603085] [127/133] (443s left) i915_pm_rpm (sysfs-read)
[582.426570] Starting subtest: sysfs-read
[583.582840] Subtest sysfs-read: SUCCESS (1.156s)
[583.960257] [128/133] (440s left) gem_mmap_gtt (fault-concurrent-y)
[584.019378] Subtest fault-concurrent-Y: SKIP (0.000s)
[584.075714] [129/133] (440s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[584.469789] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[585.295380] [130/133] (438s left) kms_flip (nonexisting-fb)
[585.403881] Starting subtest: nonexisting-fb
[585.408766] Starting dynamic subtest: A-eDP1
[586.575180] Dynamic subtest A-eDP1: SUCCESS (1.167s)
[586.590686] Starting dynamic subtest: B-eDP1
[587.710932] Dynamic subtest B-eDP1: SUCCESS (1.133s)
[587.721944] Starting dynamic subtest: C-eDP1
[588.848147] Dynamic subtest C-eDP1: SUCCESS (1.135s)
[588.860212] Starting dynamic subtest: D-eDP1
[589.980917] Dynamic subtest D-eDP1: SUCCESS (1.131s)
[589.985903] Subtest nonexisting-fb: SUCCESS (4.581s)
[591.147741] [131/133] (433s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[591.257170] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[597.775777] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.521s)
[597.883107] [132/133] (426s left) gen7_exec_parse (chained-batch)
[597.949682] Subtest chained-batch: SKIP (0.000s)
[598.029639] [133/133] (426s left) gem_exec_schedule (thriceslice)
[598.095830] Starting subtest: thriceslice
[598.098087] Starting dynamic subtest: rcs0
[598.115312] Dynamic subtest rcs0: SUCCESS (0.029s)
[598.127701] Starting dynamic subtest: bcs0
[598.146122] Dynamic subtest bcs0: SUCCESS (0.029s)
[598.156357] Starting dynamic subtest: vcs0
[598.196354] Dynamic subtest vcs0: SUCCESS (0.049s)
[598.208422] Starting dynamic subtest: vcs1
[598.225327] Dynamic subtest vcs1: SUCCESS (0.028s)
[598.235375] Starting dynamic subtest: vecs0
[598.254427] Dynamic subtest vecs0: SUCCESS (0.028s)
[598.264343] Starting dynamic subtest: ccs0
[598.285423] Dynamic subtest ccs0: SUCCESS (0.030s)
[598.287765] Subtest thriceslice: SUCCESS (0.199s)
[598.581634] Closing watchdogs
results: parsing output: 0/ for test: kms_flip_scaled_crc
results: parsing output: 1/ for test: gem_render_copy
results: parsing output: 2/ for test: syncobj_wait
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_psr2_sf
results: parsing output: 5/ for test: syncobj_wait
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: gem_exec_whisper
results: parsing output: 8/ for test: gem_readwrite
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: prime_vgem
results: parsing output: 11/ for test: gem_exec_fence
results: parsing output: 12/ for test: kms_plane
results: parsing output: 13/ for test: kms_rotation_crc
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: gem_mmap_wc
results: parsing output: 16/ for test: gem_spin_batch
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: i915_pm_freq_api
results: parsing output: 20/ for test: i915_query
results: parsing output: 21/ for test: gem_exec_reloc
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_content_protection
results: parsing output: 24/ for test: kms_async_flips
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: gem_mmap
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_pipe_crc_basic
results: parsing output: 29/ for test: kms_invalid_mode
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: kms_hdr
results: parsing output: 32/ for test: perf
results: parsing output: 33/ for test: gem_exec_reloc
results: parsing output: 34/ for test: kms_cursor_edge_walk
results: parsing output: 35/ for test: kms_cursor_legacy
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: gem_workarounds
results: parsing output: 38/ for test: kms_flip
results: parsing output: 39/ for test: gem_exec_suspend
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: gem_lmem_swapping
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: api_intel_bb
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_atomic_transition
results: parsing output: 47/ for test: gem_ctx_shared
results: parsing output: 48/ for test: gem_fence_thrash
results: parsing output: 49/ for test: kms_cursor_crc
results: parsing output: 50/ for test: gem_exec_balancer
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: kms_flip_scaled_crc
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: gem_fence_thrash
results: parsing output: 56/ for test: perf_pmu
results: parsing output: 57/ for test: gem_exec_schedule
results: parsing output: 58/ for test: core_sysfs
results: parsing output: 59/ for test: kms_draw_crc
results: parsing output: 60/ for test: kms_sequence
results: parsing output: 61/ for test: kms_plane_scaling
results: parsing output: 62/ for test: i915_drm_fdinfo
results: parsing output: 63/ for test: gem_ringfill
results: parsing output: 64/ for test: sysfs_timeslice_duration
results: parsing output: 65/ for test: gem_exec_params
results: parsing output: 66/ for test: gem_exec_reloc
results: parsing output: 67/ for test: sriov_basic
results: parsing output: 68/ for test: gem_eio
results: parsing output: 69/ for test: kms_pm_rpm
results: parsing output: 70/ for test: gem_ccs
results: parsing output: 71/ for test: prime_mmap
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_tiled_wc
results: parsing output: 75/ for test: gem_wait
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: perf_pmu
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: kms_prime
results: parsing output: 83/ for test: gem_eio
results: parsing output: 84/ for test: gem_exec_create
results: parsing output: 85/ for test: syncobj_basic
results: parsing output: 86/ for test: kms_flip_scaled_crc
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_plane_scaling
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: gem_exec_reloc
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: gem_pwrite
results: parsing output: 98/ for test: api_intel_bb
results: parsing output: 99/ for test: kms_plane
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_chamelium_color
results: parsing output: 102/ for test: gem_create
results: parsing output: 103/ for test: kms_vblank
results: parsing output: 104/ for test: kms_cursor_legacy
results: parsing output: 105/ for test: kms_psr2_sf
results: parsing output: 106/ for test: syncobj_wait
results: parsing output: 107/ for test: kms_cursor_crc
results: parsing output: 108/ for test: kms_flip
results: parsing output: 109/ for test: kms_cursor_legacy
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: gem_render_copy_redux
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_color
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_pipe_b_c_ivb
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_ctx_persistence
results: parsing output: 119/ for test: kms_psr2_sf
results: parsing output: 120/ for test: kms_chamelium_edid
results: parsing output: 121/ for test: gem_render_copy
results: parsing output: 122/ for test: kms_lease
results: parsing output: 123/ for test: gem_mmap_gtt
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_ctx_persistence
results: parsing output: 126/ for test: i915_pm_rpm
results: parsing output: 127/ for test: gem_mmap_gtt
results: parsing output: 128/ for test: kms_chamelium_hpd
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gen7_exec_parse
results: parsing output: 132/ for test: gem_exec_schedule
Done.