[58.687336] Initializing watchdogs
[58.687417]   /dev/watchdog0
[58.701668] [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.705815] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.708085] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.711440] [001/131] (960s left) gem_create (create-size-update)
[58.788795] Starting subtest: create-size-update
[58.791073] Subtest create-size-update: SUCCESS (0.000s)
[59.031060] [002/131] (960s left) kms_color (ctm-blue-to-red)
[59.144953] Starting subtest: ctm-blue-to-red
[59.146918] Starting dynamic subtest: pipe-A-eDP-1
[59.863705] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.719s)
[59.872652] Starting dynamic subtest: pipe-B-eDP-1
[61.287832] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.423s)
[61.296706] Starting dynamic subtest: pipe-C-eDP-1
[62.665669] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.377s)
[62.674802] Starting dynamic subtest: pipe-D-eDP-1
[64.012294] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.347s)
[64.014122] Subtest ctm-blue-to-red: SUCCESS (4.868s)
[64.849170] [003/131] (954s left) kms_draw_crc (draw-method-mmap-wc)
[64.952817] Starting subtest: draw-method-mmap-wc
[64.954679] Starting dynamic subtest: xrgb8888-untiled
[65.183117] Dynamic subtest xrgb8888-untiled: SUCCESS (0.232s)
[65.190631] Starting dynamic subtest: rgb565-untiled
[65.410089] Dynamic subtest rgb565-untiled: SUCCESS (0.222s)
[65.419185] Starting dynamic subtest: xrgb2101010-untiled
[65.627887] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[65.636434] Starting dynamic subtest: xbgr16161616f-untiled
[65.849713] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[65.858607] Starting dynamic subtest: xrgb8888-xtiled
[65.993962] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.144s)
[66.002065] Starting dynamic subtest: rgb565-xtiled
[66.127602] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[66.135382] Starting dynamic subtest: xrgb2101010-xtiled
[66.249347] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[66.256500] Starting dynamic subtest: xbgr16161616f-xtiled
[66.382887] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[66.390400] Starting dynamic subtest: xrgb8888-4tiled
[66.549708] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.167s)
[66.556635] Starting dynamic subtest: rgb565-4tiled
[66.705611] Dynamic subtest rgb565-4tiled: SUCCESS (0.155s)
[66.717333] Starting dynamic subtest: xrgb2101010-4tiled
[66.860707] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.154s)
[66.868726] Starting dynamic subtest: xbgr16161616f-4tiled
[67.040413] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.178s)
[67.042705] Subtest draw-method-mmap-wc: SUCCESS (2.089s)
[67.417179] [004/131] (951s left) kms_dp_aux_dev
[67.909980] [005/131] (951s left) gem_eio (reset-stress)
[68.114019] Starting subtest: reset-stress
[68.116423] Starting dynamic subtest: render
[72.049562] Dynamic subtest render: SUCCESS (3.934s)
[72.065667] Starting dynamic subtest: bsd1
[90.365196] Dynamic subtest bsd1: SUCCESS (18.313s)
[90.380856] Starting dynamic subtest: bsd2
[108.332687] Dynamic subtest bsd2: SUCCESS (17.966s)
[108.347458] Starting dynamic subtest: blt
[108.351724] Dynamic subtest blt: SKIP (0.000s)
[108.359527] Starting dynamic subtest: vebox
[126.378641] Dynamic subtest vebox: SUCCESS (18.044s)
[126.380770] Subtest reset-stress: SUCCESS (58.260s)
[127.953031] [FACT gem_eio (reset-stress)] new: kernel.kmod_is_loaded.vgem: true
[127.956530] [006/131] (891s left) gem_ctx_sseu (invalid-sseu)
[128.024383] Subtest invalid-sseu: SKIP (0.000s)
[128.096716] [007/131] (891s left) kms_big_fb (linear-64bpp-rotate-0)
[128.192613] Starting subtest: linear-64bpp-rotate-0
[129.904037] Subtest linear-64bpp-rotate-0: SUCCESS (1.712s)
[130.095283] [008/131] (889s left) kms_cursor_crc (cursor-random-32x32)
[130.240731] Starting subtest: cursor-random-32x32
[130.287749] Subtest cursor-random-32x32: SKIP (0.043s)
[130.585286] [009/131] (889s left) syncobj_wait (invalid-single-wait-unsubmitted)
[130.645932] Starting subtest: invalid-single-wait-unsubmitted
[130.647929] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[130.764446] [010/131] (888s left) i915_pm_freq_mult (media-freq)
[130.834171] Starting subtest: media-freq
[130.835818] Starting dynamic subtest: gt0
[130.839300] Dynamic subtest gt0: SKIP (0.000s)
[130.846919] Starting dynamic subtest: gt1
[130.850405] Dynamic subtest gt1: SKIP (0.000s)
[130.854079] Subtest media-freq: SKIP (0.001s)
[130.958816] [011/131] (888s left) kms_plane_scaling (2x-scaler-multi-pipe)
[131.050084] Starting subtest: 2x-scaler-multi-pipe
[131.053617] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[131.182794] [012/131] (888s left) gem_fence_thrash (bo-write-verify-threaded-y)
[131.217364] Starting subtest: bo-write-verify-threaded-y
[131.238075] Subtest bo-write-verify-threaded-y: SKIP (0.019s)
[131.308573] [013/131] (888s left) kms_plane (planar-pixel-format-settings)
[131.420044] Starting subtest: planar-pixel-format-settings
[131.469526] Subtest planar-pixel-format-settings: SUCCESS (0.050s)
[131.583949] [014/131] (888s left) kms_invalid_mode (bad-hsync-start)
[131.684084] Starting subtest: bad-hsync-start
[131.686039] Starting dynamic subtest: pipe-A-eDP-1
[131.973758] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[131.985675] Starting dynamic subtest: pipe-B-eDP-1
[131.987629] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[131.997933] Starting dynamic subtest: pipe-C-eDP-1
[132.000116] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[132.008071] Starting dynamic subtest: pipe-D-eDP-1
[132.010179] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[132.012279] Subtest bad-hsync-start: SUCCESS (0.295s)
[132.864124] [015/131] (886s left) gem_exec_params (invalid-fence-in-submit)
[132.923227] Starting subtest: invalid-fence-in-submit
[132.925657] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[133.084873] [016/131] (886s left) gem_ctx_param (invalid-get-ringsize)
[133.146810] Starting subtest: invalid-get-ringsize
[133.149114] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[133.290169] [017/131] (886s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[133.394595] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[133.398770] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[133.520709] [018/131] (886s left) syncobj_eventfd (timeline-wait-before-signal)
[133.587025] Starting subtest: timeline-wait-before-signal
[133.616856] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[133.714286] [019/131] (886s left) gem_exec_schedule (reorder-wide)
[133.912131] Subtest reorder-wide: SKIP (0.000s)
[134.113261] [020/131] (885s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[134.175025] Starting subtest: etime-single-wait-all-for-submit-submitted
[134.282564] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.106s)
[134.381188] [021/131] (885s left) kms_cursor_crc (cursor-size-change)
[134.474639] Starting subtest: cursor-size-change
[134.476850] Starting dynamic subtest: pipe-A-eDP-1
[135.284698] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.809s)
[135.295390] Starting dynamic subtest: pipe-D-eDP-1
[136.703094] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.419s)
[136.705222] Subtest cursor-size-change: SUCCESS (2.230s)
[137.542725] [022/131] (882s left) gem_exec_fence (long-history)
[137.986715] Starting subtest: long-history
[145.680197] Subtest long-history: SUCCESS (7.694s)
[146.162834] [023/131] (873s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[146.296096] Starting subtest: basic-flip-after-cursor-varying-size
[147.222698] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.926s)
[148.067163] [024/131] (872s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[153.030920] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[153.035587] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.003s)
[153.891883] [025/131] (866s left) kms_psr (fbc-psr2-dpms)
[153.988104] Starting subtest: fbc-psr2-dpms
[153.990253] Starting dynamic subtest: eDP-1
[153.994204] Dynamic subtest eDP-1: SKIP (0.000s)
[153.998241] Subtest fbc-psr2-dpms: SKIP (0.001s)
[154.085573] [026/131] (866s left) perf (oa-exponents)
[154.217735] Starting subtest: oa-exponents
[154.219929] Starting dynamic subtest: 0-rcs0
[155.993795] Dynamic subtest 0-rcs0: SUCCESS (1.775s)
[156.002784] Starting dynamic subtest: 1-vcs1
[157.822968] Dynamic subtest 1-vcs1: SUCCESS (1.829s)
[157.825606] Subtest oa-exponents: SUCCESS (3.605s)
[157.871490] [027/131] (862s left) gem_userptr_blits (access-control)
[157.946298] Starting subtest: access-control
[157.950726] Subtest access-control: SKIP (0.000s)
[158.110879] [028/131] (862s left) syncobj_timeline (wait-zero-handles)
[158.189710] Starting subtest: wait-zero-handles
[158.191946] Subtest wait-zero-handles: SUCCESS (0.000s)
[158.335214] [029/131] (862s left) gem_ctx_persistence (engines-queued)
[158.398192] Starting subtest: engines-queued
[158.400581] Starting dynamic subtest: rcs0
[158.467376] Dynamic subtest rcs0: SUCCESS (0.069s)
[158.477095] Starting dynamic subtest: bcs0
[158.571173] Dynamic subtest bcs0: SUCCESS (0.104s)
[158.581552] Starting dynamic subtest: vcs0
[159.862956] Dynamic subtest vcs0: SUCCESS (1.288s)
[159.873554] Starting dynamic subtest: vcs1
[161.908204] Dynamic subtest vcs1: SUCCESS (2.043s)
[161.918558] Starting dynamic subtest: vecs0
[163.892567] Dynamic subtest vecs0: SUCCESS (1.982s)
[163.903727] Starting dynamic subtest: ccs0
[164.072309] Dynamic subtest ccs0: SUCCESS (0.180s)
[164.074788] Subtest engines-queued: SUCCESS (5.674s)
[164.236222] [030/131] (856s left) i915_query (query-topology-garbage-items)
[164.290890] Starting subtest: query-topology-garbage-items
[164.292910] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[164.435471] [031/131] (856s left) gen9_exec_parse (shadow-peek)
[164.508996] Subtest shadow-peek: SKIP (0.000s)
[164.606587] [032/131] (855s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[164.714532] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[172.017492] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.305s)
[172.171675] [033/131] (848s left) gem_mmap_wc (read)
[172.241067] Subtest read: SKIP (0.000s)
[172.329062] [034/131] (848s left) gem_exec_whisper (basic-normal)
[172.408415] Starting subtest: basic-normal
[177.574778] Subtest basic-normal: SUCCESS (5.166s)
[177.784237] [035/131] (842s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[177.900982] Starting subtest: extended-modeset-hang-newfb-with-reset
[177.903407] Starting dynamic subtest: pipe-A
[191.947477] Dynamic subtest pipe-A: SUCCESS (14.045s)
[191.957663] Starting dynamic subtest: pipe-D
[207.613355] Dynamic subtest pipe-D: SUCCESS (15.662s)
[207.615687] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (29.712s)
[208.440561] [036/131] (812s left) kms_psr (fbc-psr-primary-render)
[208.547162] Starting subtest: fbc-psr-primary-render
[208.549025] Starting dynamic subtest: eDP-1
[208.553019] Dynamic subtest eDP-1: SKIP (0.000s)
[208.557112] Subtest fbc-psr-primary-render: SKIP (0.001s)
[208.646418] [037/131] (812s left) kms_psr (fbc-pr-primary-mmap-gtt)
[208.736220] Starting subtest: fbc-pr-primary-mmap-gtt
[208.740301] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[208.835215] [038/131] (811s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[208.934501] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[213.082961] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.151s)
[214.229562] [039/131] (806s left) gem_mmap (big-bo)
[214.286838] Subtest big-bo: SKIP (0.000s)
[214.364525] [040/131] (806s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[214.476211] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[214.478484] Starting dynamic subtest: pipe-A-eDP-1
[214.501671] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[214.513169] Starting dynamic subtest: pipe-B-eDP-1
[214.535115] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[214.544057] Starting dynamic subtest: pipe-C-eDP-1
[214.565567] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[214.574206] Starting dynamic subtest: pipe-D-eDP-1
[214.596374] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[214.600426] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[216.794606] [041/131] (804s left) gem_eio (unwedge-stress)
[217.026688] Starting subtest: unwedge-stress
[217.028961] Starting dynamic subtest: render
[221.878844] Dynamic subtest render: SUCCESS (4.851s)
[221.894739] Starting dynamic subtest: bsd1
[240.398512] Dynamic subtest bsd1: SUCCESS (18.519s)
[240.415887] Starting dynamic subtest: bsd2
[258.413673] Dynamic subtest bsd2: SUCCESS (18.014s)
[258.430656] Starting dynamic subtest: blt
[258.434843] Dynamic subtest blt: SKIP (0.000s)
[258.443783] Starting dynamic subtest: vebox
[276.427036] Dynamic subtest vebox: SUCCESS (18.011s)
[276.429705] Subtest unwedge-stress: SUCCESS (59.399s)
[277.972587] [042/131] (742s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[278.086919] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[278.091166] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[278.211116] [043/131] (742s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[278.278671] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[278.283388] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[278.488858] [044/131] (742s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[278.623534] Starting subtest: cursorB-vs-flipA-atomic
[278.628320] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[278.791302] [045/131] (742s left) kms_vrr (seamless-rr-switch-vrr)
[278.888250] Starting subtest: seamless-rr-switch-vrr
[278.894658] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[278.986741] [046/131] (742s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[279.097704] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[279.101854] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[279.213745] [047/131] (741s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[279.305308] Starting subtest: crc-primary-basic-y-tiled-ccs
[279.307623] Starting dynamic subtest: pipe-A-eDP-1
[279.330927] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[279.342756] Starting dynamic subtest: pipe-B-eDP-1
[279.364971] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[279.374536] Starting dynamic subtest: pipe-C-eDP-1
[279.396388] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[279.405405] Starting dynamic subtest: pipe-D-eDP-1
[279.425923] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[279.429580] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.005s)
[281.647220] [048/131] (739s left) gem_ctx_param (non-root-set)
[281.704909] Starting subtest: non-root-set
[281.726148] Subtest non-root-set: SUCCESS (0.021s)
[281.843371] [049/131] (739s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[281.944747] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[288.507065] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.564s)
[288.667081] [050/131] (732s left) fbdev (pan)
[288.703677] Starting subtest: pan
[288.725869] Subtest pan: SUCCESS (0.026s)
[288.821579] [051/131] (732s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[288.869712] Starting subtest: invalid-single-wait-unsubmitted
[288.871879] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[288.990510] [052/131] (732s left) kms_flip (bo-too-big)
[289.091364] Starting subtest: bo-too-big
[289.093599] Starting dynamic subtest: A-eDP1
[290.393988] Dynamic subtest A-eDP1: SUCCESS (1.304s)
[290.414097] Starting dynamic subtest: B-eDP1
[291.721778] Dynamic subtest B-eDP1: SUCCESS (1.326s)
[291.732174] Starting dynamic subtest: C-eDP1
[293.046697] Dynamic subtest C-eDP1: SUCCESS (1.324s)
[293.059429] Starting dynamic subtest: D-eDP1
[294.376403] Dynamic subtest D-eDP1: SUCCESS (1.329s)
[294.378856] Subtest bo-too-big: SUCCESS (5.290s)
[295.611311] [053/131] (725s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[295.716657] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[295.720699] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[295.850055] [054/131] (725s left) syncobj_timeline (reset-unsignaled)
[295.907570] Starting subtest: reset-unsignaled
[295.909818] Subtest reset-unsignaled: SUCCESS (0.000s)
[296.021595] [055/131] (725s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[296.107413] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[302.946972] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.840s)
[303.119278] [056/131] (718s left) gem_exec_schedule (preempt-queue)
[303.193935] Subtest preempt-queue: SKIP (0.000s)
[303.504393] [057/131] (718s left) gem_exec_balancer (bonded-false-hang)
[303.773412] Starting subtest: bonded-false-hang
[303.778840] Subtest bonded-false-hang: SKIP (0.000s)
[303.917069] [058/131] (717s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[304.007212] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[304.009571] Starting dynamic subtest: pipe-A
[304.233756] Dynamic subtest pipe-A: SUCCESS (0.228s)
[304.243638] Starting dynamic subtest: pipe-B
[305.498643] Dynamic subtest pipe-B: SUCCESS (1.264s)
[305.511296] Starting dynamic subtest: pipe-C
[306.866445] Dynamic subtest pipe-C: SUCCESS (1.367s)
[306.876202] Starting dynamic subtest: pipe-D
[308.166814] Dynamic subtest pipe-D: SUCCESS (1.298s)
[308.169292] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.162s)
[309.395779] [059/131] (712s left) gem_exec_create (madvise)
[309.480839] Starting subtest: madvise
[309.483291] Starting dynamic subtest: smem
[330.964309] Dynamic subtest smem: SUCCESS (21.479s)
[330.966793] Subtest madvise: SUCCESS (21.480s)
[331.891859] [060/131] (689s left) perf_pmu (init-sema)
[331.936665] Starting subtest: init-sema
[331.939054] Starting dynamic subtest: rcs0
[331.941325] Dynamic subtest rcs0: SUCCESS (0.002s)
[331.952402] Starting dynamic subtest: bcs0
[331.954565] Dynamic subtest bcs0: SUCCESS (0.000s)
[331.963663] Starting dynamic subtest: vcs0
[331.965821] Dynamic subtest vcs0: SUCCESS (0.001s)
[331.974813] Starting dynamic subtest: vcs1
[331.977075] Dynamic subtest vcs1: SUCCESS (0.001s)
[331.986026] Starting dynamic subtest: vecs0
[331.988260] Dynamic subtest vecs0: SUCCESS (0.001s)
[331.997072] Starting dynamic subtest: ccs0
[331.999039] Dynamic subtest ccs0: SUCCESS (0.000s)
[332.000931] Subtest init-sema: SUCCESS (0.008s)
[332.087599] [061/131] (689s left) kms_chamelium_color (ctm-negative)
[332.186407] Subtest ctm-negative: SKIP (0.000s)
[332.233404] [062/131] (689s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[332.296572] Subtest no-spare-fences-busy: SKIP (0.000s)
[332.356939] [063/131] (689s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[332.463164] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[332.465462] Starting dynamic subtest: pipe-A-eDP-1
[332.485394] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[332.495802] Starting dynamic subtest: pipe-B-eDP-1
[332.514747] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[332.523978] Starting dynamic subtest: pipe-C-eDP-1
[332.542521] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[332.551317] Starting dynamic subtest: pipe-D-eDP-1
[332.570746] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[332.573026] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[334.723044] [064/131] (687s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[334.827645] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[334.831786] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[334.969529] [065/131] (686s left) core_setmaster (master-drop-set-user)
[335.071919] Starting subtest: master-drop-set-user
[335.086032] Subtest master-drop-set-user: SUCCESS (0.014s)
[335.123989] [066/131] (686s left) kms_color (legacy-gamma-reset)
[335.209773] Starting subtest: legacy-gamma-reset
[335.211602] Starting dynamic subtest: pipe-A-eDP-1
[335.581646] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.373s)
[335.590851] Starting dynamic subtest: pipe-B-eDP-1
[335.595526] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s)
[335.604894] Starting dynamic subtest: pipe-C-eDP-1
[335.607079] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.012s)
[335.616039] Starting dynamic subtest: pipe-D-eDP-1
[335.620760] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[335.623035] Subtest legacy-gamma-reset: SUCCESS (0.411s)
[336.447179] [067/131] (685s left) kms_selftest (drm_plane_helper)
[336.487570] Starting subtest: drm_plane_helper
[336.526943] Starting dynamic subtest: drm_test_check_plane_state
[336.646708] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.117s)
[336.657050] Starting dynamic subtest: drm_test_check_invalid_plane_state
[336.782292] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.135s)
[336.784642] Subtest drm_plane_helper: SUCCESS (0.293s)
[337.018226] [068/131] (685s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[337.121655] Starting subtest: psr-1p-primscrn-spr-indfb-move
[344.725796] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.606s)
[344.919631] [069/131] (677s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[345.035693] Starting subtest: yf-tiled-64bpp-rotate-180
[345.040219] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[345.162347] [070/131] (676s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[345.291462] Starting subtest: short-flip-before-cursor-atomic-transitions
[346.239070] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.947s)
[347.084888] [071/131] (675s left) sw_sync (sync_busy)
[347.125186] Starting subtest: sync_busy
[347.127514] Subtest sync_busy: SUCCESS (0.002s)
[347.208304] [072/131] (675s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[347.316200] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[347.318352] Starting dynamic subtest: pipe-A-eDP-1
[349.509115] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.193s)
[349.518407] Starting dynamic subtest: pipe-B-eDP-1
[351.880103] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.370s)
[351.889156] Starting dynamic subtest: pipe-C-eDP-1
[353.963478] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.082s)
[353.976493] Starting dynamic subtest: pipe-D-eDP-1
[356.148016] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.185s)
[356.149795] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.834s)
[357.412436] [073/131] (664s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[357.524837] Starting subtest: basic-modeset-with-all-modifiers-formats
[357.896332] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[358.668608] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.772s)
[358.678278] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[358.690513] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[358.699652] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[358.712828] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.021s)
[358.722322] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[358.857398] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.144s)
[358.867509] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[358.879874] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[358.889302] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[358.902120] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.021s)
[358.911969] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[358.924213] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.021s)
[358.933516] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[358.946549] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[358.955273] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[358.968738] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[358.977611] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[358.990611] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[358.999161] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[359.013220] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.022s)
[359.021644] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[359.035361] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.021s)
[359.043984] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[359.190983] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s)
[359.200494] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[359.212826] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.022s)
[359.221629] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[359.235408] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.022s)
[359.244092] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[359.257620] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[359.266561] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[359.279887] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[359.288650] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[359.302063] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.021s)
[359.311095] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[359.324298] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.021s)
[359.333167] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[359.346558] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[359.355263] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[359.368724] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[359.377866] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[359.524761] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s)
[359.535103] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[359.546959] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[359.556148] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[359.568875] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[359.577881] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[359.591270] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.021s)
[359.600108] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[359.613372] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[359.621829] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[359.635458] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.021s)
[359.644063] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[359.657678] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.021s)
[359.666037] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[359.679946] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.021s)
[359.688406] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[359.702117] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.021s)
[360.106668] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.583s)
[360.886076] [074/131] (661s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[361.012571] Starting subtest: cursorB-vs-flipA-legacy
[361.016910] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[361.183872] [075/131] (661s left) gem_mmap_wc (pf-nonblock)
[361.241904] Subtest pf-nonblock: SKIP (0.000s)
[361.298838] [076/131] (661s left) kms_psr (psr-primary-render)
[361.394024] Starting subtest: psr-primary-render
[361.396243] Starting dynamic subtest: eDP-1
[363.153227] Dynamic subtest eDP-1: SUCCESS (1.758s)
[363.155443] Subtest psr-primary-render: SUCCESS (1.759s)
[364.054630] [077/131] (658s left) kms_flip (flip-vs-panning-interruptible)
[364.155413] Starting subtest: flip-vs-panning-interruptible
[364.159875] Starting dynamic subtest: A-eDP1
[372.829120] Dynamic subtest A-eDP1: SUCCESS (8.669s)
[372.840597] Starting dynamic subtest: B-eDP1
[381.555977] Dynamic subtest B-eDP1: SUCCESS (8.723s)
[381.570072] Starting dynamic subtest: C-eDP1
[390.269273] Dynamic subtest C-eDP1: SUCCESS (8.710s)
[390.278609] Starting dynamic subtest: D-eDP1
[399.000733] Dynamic subtest D-eDP1: SUCCESS (8.729s)
[399.004736] Subtest flip-vs-panning-interruptible: SUCCESS (34.847s)
[400.290968] [078/131] (622s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[400.393878] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[400.398608] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[400.512114] [079/131] (622s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[400.604911] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[400.607200] Starting dynamic subtest: pipe-A-default-mode
[401.738457] Dynamic subtest pipe-A-default-mode: SKIP (1.130s)
[401.742587] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.132s)
[401.942658] [080/131] (620s left) kms_psr (pr-sprite-plane-move)
[402.049170] Starting subtest: pr-sprite-plane-move
[402.053602] Subtest pr-sprite-plane-move: SKIP (0.000s)
[402.146714] [081/131] (620s left) api_intel_bb (object-reloc-keep-cache)
[402.204567] Starting subtest: object-reloc-keep-cache
[402.208718] Subtest object-reloc-keep-cache: SKIP (0.002s)
[402.369704] [082/131] (620s left) gem_spin_batch (legacy-resubmit-new)
[402.445463] Starting subtest: legacy-resubmit-new
[402.447742] Starting dynamic subtest: default
[402.450052] Dynamic subtest default: SUCCESS (0.007s)
[402.461499] Starting dynamic subtest: render
[402.463783] Dynamic subtest render: SUCCESS (0.003s)
[402.472969] Starting dynamic subtest: bsd
[402.475346] Dynamic subtest bsd: SUCCESS (0.004s)
[402.484338] Starting dynamic subtest: bsd1
[402.486213] Dynamic subtest bsd1: SUCCESS (0.003s)
[402.494641] Starting dynamic subtest: bsd2
[402.496588] Dynamic subtest bsd2: SUCCESS (0.005s)
[402.505248] Starting dynamic subtest: blt
[402.507150] Dynamic subtest blt: SUCCESS (0.006s)
[402.515763] Starting dynamic subtest: vebox
[402.517835] Dynamic subtest vebox: SUCCESS (0.005s)
[402.520109] Subtest legacy-resubmit-new: SUCCESS (0.038s)
[403.924825] [083/131] (618s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[404.030578] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[404.034758] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[404.163965] [084/131] (618s left) kms_pm_rpm (modeset-lpsp-stress)
[406.093461] Starting subtest: modeset-lpsp-stress
[422.220376] Subtest modeset-lpsp-stress: SUCCESS (16.129s)
[422.344637] [085/131] (600s left) i915_hangman (gt-error-state-capture)
[422.418225] Starting subtest: gt-error-state-capture
[422.420196] Starting dynamic subtest: rcs0
[433.845856] Dynamic subtest rcs0: SUCCESS (11.426s)
[433.859173] Starting dynamic subtest: bcs0
[445.877233] Dynamic subtest bcs0: SUCCESS (12.028s)
[445.891031] Starting dynamic subtest: vcs0
[459.828029] Dynamic subtest vcs0: SUCCESS (13.948s)
[459.840815] Starting dynamic subtest: vcs1
[471.797443] Dynamic subtest vcs1: SUCCESS (11.966s)
[471.809497] Starting dynamic subtest: vecs0
[482.805276] Dynamic subtest vecs0: SUCCESS (11.005s)
[482.818847] Starting dynamic subtest: ccs0
[494.837275] Dynamic subtest ccs0: SUCCESS (12.029s)
[494.839987] Subtest gt-error-state-capture: SUCCESS (72.418s)
[494.951043] [086/131] (527s left) kms_psr (psr-no-drrs)
[495.058964] Starting subtest: psr-no-drrs
[495.061207] Starting dynamic subtest: eDP-1
[496.646704] Dynamic subtest eDP-1: SUCCESS (1.586s)
[496.648921] Subtest psr-no-drrs: SUCCESS (1.588s)
[497.559228] [087/131] (525s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[497.672529] Starting subtest: pipe-fbc-rte
[497.679070] Starting dynamic subtest: pipe-B-eDP-1
[503.123100] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.453s)
[503.130083] Subtest pipe-fbc-rte: SUCCESS (5.456s)
[505.480415] [088/131] (517s left) kms_vrr (max-min)
[505.574851] Starting subtest: max-min
[505.581388] Subtest max-min: SKIP (0.000s)
[505.670319] [089/131] (517s left) kms_atomic (plane-primary-legacy)
[505.759477] Starting subtest: plane-primary-legacy
[505.761908] Starting dynamic subtest: pipe-A-eDP-1
[506.213872] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.454s)
[506.216298] Subtest plane-primary-legacy: SUCCESS (0.456s)
[507.119369] [090/131] (515s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[507.218669] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[508.286584] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.068s)
[508.442174] [091/131] (514s left) syncobj_wait (reset-multiple-signaled)
[508.505874] Starting subtest: reset-multiple-signaled
[508.507619] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[508.640840] [092/131] (514s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[508.739141] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[509.773696] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.034s)
[509.932745] [093/131] (513s left) kms_cursor_crc (cursor-offscreen-512x170)
[510.230683] Starting subtest: cursor-offscreen-512x170
[510.234482] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[510.406388] [094/131] (512s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[510.466902] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[510.468904] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[510.602199] [095/131] (512s left) gem_mmap_offset (bad-extensions)
[510.671984] Starting subtest: bad-extensions
[510.674050] Subtest bad-extensions: SUCCESS (0.000s)
[510.808087] [096/131] (512s left) kms_flip (flip-vs-absolute-wf_vblank)
[510.908066] Starting subtest: flip-vs-absolute-wf_vblank
[510.913905] Starting dynamic subtest: A-eDP1
[519.839183] Dynamic subtest A-eDP1: SUCCESS (8.929s)
[519.851463] Starting dynamic subtest: B-eDP1
[528.774910] Dynamic subtest B-eDP1: SUCCESS (8.934s)
[528.785910] Starting dynamic subtest: C-eDP1
[537.696644] Dynamic subtest C-eDP1: SUCCESS (8.920s)
[537.708501] Starting dynamic subtest: D-eDP1
[546.633999] Dynamic subtest D-eDP1: SUCCESS (8.935s)
[546.639053] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.729s)
[547.898537] [097/131] (475s left) gem_exec_whisper (basic-queues-priority-all)
[547.983777] Starting subtest: basic-queues-priority-all
[570.265853] Subtest basic-queues-priority-all: SUCCESS (22.278s)
[570.474277] [098/131] (452s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[570.542674] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[570.611903] [099/131] (452s left) gem_eio (in-flight-external)
[570.864079] Starting subtest: in-flight-external
[572.017865] Subtest in-flight-external: SUCCESS (1.152s)
[572.199993] [100/131] (451s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[572.298717] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[572.302963] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[572.424754] [101/131] (451s left) gem_exec_fence (basic-busy-all)
[572.489109] Starting subtest: basic-busy-all
[572.575662] Subtest basic-busy-all: SUCCESS (0.087s)
[574.983094] [102/131] (448s left) gem_render_copy (linear-to-vebox-y-tiled)
[575.040621] Starting subtest: linear-to-vebox-y-tiled
[575.045243] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[575.250032] [103/131] (448s left) kms_plane_alpha_blend (alpha-transparent-fb)
[575.347061] Starting subtest: alpha-transparent-fb
[575.635028] Starting dynamic subtest: pipe-A-eDP-1
[576.272653] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.636s)
[576.283878] Starting dynamic subtest: pipe-D-eDP-1
[577.605105] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.332s)
[577.607511] Subtest alpha-transparent-fb: SUCCESS (2.260s)
[578.424609] [104/131] (445s left) prime_vgem (shrink)
[578.509381] Starting subtest: shrink
[578.523416] Subtest shrink: SUCCESS (0.013s)
[578.640927] [105/131] (445s left) kms_cursor_crc (cursor-sliding-256x256)
[578.899469] Starting subtest: cursor-sliding-256x256
[578.904796] Starting dynamic subtest: pipe-A-eDP-1
[582.150926] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.247s)
[582.181340] Starting dynamic subtest: pipe-D-eDP-1
[586.113656] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.941s)
[586.116069] Subtest cursor-sliding-256x256: SUCCESS (7.214s)
[586.994252] [106/131] (436s left) gen9_exec_parse (bb-start-far)
[587.050156] Subtest bb-start-far: SKIP (0.000s)
[587.127678] [107/131] (436s left) kms_addfb_basic (bad-pitch-1024)
[587.181056] Starting subtest: bad-pitch-1024
[587.183235] Subtest bad-pitch-1024: SUCCESS (0.000s)
[587.340104] [108/131] (436s left) gem_ctx_create (basic)
[587.396177] Starting subtest: basic
[587.398533] Subtest basic: SUCCESS (0.000s)
[587.605675] [109/131] (436s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[587.710674] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[587.714745] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[587.845153] [110/131] (436s left) gem_exec_reloc (basic-write-wc-active)
[587.903590] Subtest basic-write-wc-active: SKIP (0.000s)
[587.982158] [111/131] (435s left) kms_pm_dc (dc6-psr)
[589.086188] Starting subtest: dc6-psr
[592.073719] Subtest dc6-psr: SUCCESS (2.986s)
[592.925375] [112/131] (431s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[593.023879] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[593.025994] Starting dynamic subtest: pipe-A
[593.045367] Dynamic subtest pipe-A: SKIP (0.018s)
[593.054914] Starting dynamic subtest: pipe-B
[593.078307] Dynamic subtest pipe-B: SKIP (0.033s)
[593.088082] Starting dynamic subtest: pipe-C
[593.113422] Dynamic subtest pipe-C: SKIP (0.033s)
[593.122906] Starting dynamic subtest: pipe-D
[593.145253] Dynamic subtest pipe-D: SKIP (0.033s)
[593.148927] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.119s)
[593.273294] [113/131] (430s left) prime_mmap (test_refcounting)
[593.336579] Starting subtest: test_refcounting
[593.338814] Starting dynamic subtest: test_refcounting-smem
[593.365939] Dynamic subtest test_refcounting-smem: SUCCESS (0.032s)
[593.368405] Subtest test_refcounting: SUCCESS (0.033s)
[593.492159] [114/131] (430s left) prime_vgem (basic-fence-flip)
[593.559306] Starting subtest: basic-fence-flip
[593.859781] Subtest basic-fence-flip: SUCCESS (0.301s)
[594.003592] [115/131] (430s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[594.098771] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[594.102922] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[594.223535] [116/131] (429s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[594.329562] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[594.334097] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[594.472261] [117/131] (429s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[594.534784] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[594.536784] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[594.652493] [118/131] (429s left) gem_userptr_blits (vma-merge)
[594.721744] Starting subtest: vma-merge
[594.761260] Subtest vma-merge: SUCCESS (0.039s)
[594.930998] [119/131] (429s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[595.031157] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[595.034689] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[595.155465] [120/131] (429s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[595.248091] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[595.251718] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[595.376384] [121/131] (428s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[595.462074] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[595.463913] Starting dynamic subtest: pipe-A-default-mode
[598.215676] Dynamic subtest pipe-A-default-mode: SUCCESS (2.751s)
[598.218065] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.754s)
[599.109649] [122/131] (425s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[599.163985] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[599.265752] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.102s)
[599.371461] [123/131] (425s left) gem_lmem_swapping (verify)
[599.412043] Subtest verify: SKIP (0.000s)
[599.453813] [124/131] (424s left) kms_chamelium_frames (dp-frame-dump)
[599.829923] Subtest dp-frame-dump: SKIP (0.000s)
[600.688934] [125/131] (423s left) syncobj_timeline (wait-all-interrupted)
[600.756189] Starting subtest: wait-all-interrupted
[600.857319] Subtest wait-all-interrupted: SUCCESS (0.103s)
[600.958282] [126/131] (423s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[601.066712] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[608.453138] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.389s)
[608.637275] [127/131] (415s left) api_intel_allocator (open-vm)
[608.694383] Starting subtest: open-vm
[608.696635] Subtest open-vm: SUCCESS (0.003s)
[608.857939] [128/131] (415s left) gem_exec_balancer (semaphore)
[608.929753] Starting subtest: semaphore
[610.884846] Subtest semaphore: SUCCESS (1.953s)
[611.238456] [129/131] (413s left) prime_vgem (basic-fence-mmap)
[611.316450] Starting subtest: basic-fence-mmap
[611.321162] Subtest basic-fence-mmap: SKIP (0.000s)
[611.461417] [130/131] (413s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[616.541386] Starting subtest: psr2-overlay-plane-move-continuous-sf
[616.543657] Starting dynamic subtest: pipe-A-eDP-1
[623.224814] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.682s)
[623.234702] Starting dynamic subtest: pipe-B-eDP-1
[629.859256] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.632s)
[629.861625] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.320s)
[630.672106] [131/131] (394s left) kms_lease (lease-again)
[630.775341] Starting subtest: lease-again
[630.777249] Starting dynamic subtest: pipe-A-eDP-1
[630.779465] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.005s)
[630.789527] Starting dynamic subtest: pipe-B-eDP-1
[630.791569] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[630.800966] Starting dynamic subtest: pipe-C-eDP-1
[630.802837] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[630.811999] Starting dynamic subtest: pipe-D-eDP-1
[630.813840] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[630.815732] Subtest lease-again: SUCCESS (0.015s)
[630.931343] Closing watchdogs
results: parsing output: 0/ for test: gem_create
results: parsing output: 1/ for test: kms_color
results: parsing output: 2/ for test: kms_draw_crc
results: parsing output: 3/ for test: kms_dp_aux_dev
results: parsing output: 4/ for test: gem_eio
results: parsing output: 5/ for test: gem_ctx_sseu
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: kms_cursor_crc
results: parsing output: 8/ for test: syncobj_wait
results: parsing output: 9/ for test: i915_pm_freq_mult
results: parsing output: 10/ for test: kms_plane_scaling
results: parsing output: 11/ for test: gem_fence_thrash
results: parsing output: 12/ for test: kms_plane
results: parsing output: 13/ for test: kms_invalid_mode
results: parsing output: 14/ for test: gem_exec_params
results: parsing output: 15/ for test: gem_ctx_param
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: syncobj_eventfd
results: parsing output: 18/ for test: gem_exec_schedule
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: kms_cursor_crc
results: parsing output: 21/ for test: gem_exec_fence
results: parsing output: 22/ for test: kms_cursor_legacy
results: parsing output: 23/ for test: kms_psr2_sf
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: perf
results: parsing output: 26/ for test: gem_userptr_blits
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: gem_ctx_persistence
results: parsing output: 29/ for test: i915_query
results: parsing output: 30/ for test: gen9_exec_parse
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_mmap_wc
results: parsing output: 33/ for test: gem_exec_whisper
results: parsing output: 34/ for test: kms_busy
results: parsing output: 35/ for test: kms_psr
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_mmap
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: gem_eio
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_render_copy
results: parsing output: 43/ for test: kms_cursor_legacy
results: parsing output: 44/ for test: kms_vrr
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: gem_ctx_param
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: fbdev
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: gem_exec_schedule
results: parsing output: 56/ for test: gem_exec_balancer
results: parsing output: 57/ for test: kms_plane_scaling
results: parsing output: 58/ for test: gem_exec_create
results: parsing output: 59/ for test: perf_pmu
results: parsing output: 60/ for test: kms_chamelium_color
results: parsing output: 61/ for test: gem_fenced_exec_thrash
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: core_setmaster
results: parsing output: 65/ for test: kms_color
results: parsing output: 66/ for test: kms_selftest
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: kms_cursor_legacy
results: parsing output: 70/ for test: sw_sync
results: parsing output: 71/ for test: kms_ccs
results: parsing output: 72/ for test: kms_async_flips
results: parsing output: 73/ for test: kms_cursor_legacy
results: parsing output: 74/ for test: gem_mmap_wc
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_flip
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_flip_scaled_crc
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: api_intel_bb
results: parsing output: 81/ for test: gem_spin_batch
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_pm_rpm
results: parsing output: 84/ for test: i915_hangman
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_vrr
results: parsing output: 88/ for test: kms_atomic
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: syncobj_wait
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: syncobj_wait
results: parsing output: 94/ for test: gem_mmap_offset
results: parsing output: 95/ for test: kms_flip
results: parsing output: 96/ for test: gem_exec_whisper
results: parsing output: 97/ for test: kms_pipe_b_c_ivb
results: parsing output: 98/ for test: gem_eio
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: gem_exec_fence
results: parsing output: 101/ for test: gem_render_copy
results: parsing output: 102/ for test: kms_plane_alpha_blend
results: parsing output: 103/ for test: prime_vgem
results: parsing output: 104/ for test: kms_cursor_crc
results: parsing output: 105/ for test: gen9_exec_parse
results: parsing output: 106/ for test: kms_addfb_basic
results: parsing output: 107/ for test: gem_ctx_create
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_exec_reloc
results: parsing output: 110/ for test: kms_pm_dc
results: parsing output: 111/ for test: kms_plane_scaling
results: parsing output: 112/ for test: prime_mmap
results: parsing output: 113/ for test: prime_vgem
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: syncobj_wait
results: parsing output: 117/ for test: gem_userptr_blits
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_flip_scaled_crc
results: parsing output: 121/ for test: syncobj_wait
results: parsing output: 122/ for test: gem_lmem_swapping
results: parsing output: 123/ for test: kms_chamelium_frames
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: api_intel_allocator
results: parsing output: 127/ for test: gem_exec_balancer
results: parsing output: 128/ for test: prime_vgem
results: parsing output: 129/ for test: kms_psr2_sf
results: parsing output: 130/ for test: kms_lease
Done.