[60.349789] Initializing watchdogs
[60.349837]   /dev/watchdog0
[60.364074] [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]
[60.368523] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.370876] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.374224] [001/131] (960s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[60.503260] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[60.507666] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.002s)
[60.649401] [002/131] (960s left) gem_exec_fence (submit3)
[60.835332] Starting subtest: submit3
[60.839860] Subtest submit3: SKIP (0.000s)
[63.062591] [FACT gem_exec_fence (submit3)] new: kernel.kmod_is_loaded.vgem: true
[63.065754] [003/131] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[63.181998] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[63.186195] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[63.313804] [004/131] (957s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[63.407520] Starting subtest: fbc-rgb101010-draw-mmap-wc
[67.969619] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.571s)
[69.108480] [005/131] (951s left) gem_exec_balancer (noheartbeat)
[69.368665] Starting subtest: noheartbeat
[69.373439] Subtest noheartbeat: SKIP (0.000s)
[69.506977] [006/131] (951s left) kms_chamelium_color (ctm-blue-to-red)
[69.607236] Subtest ctm-blue-to-red: SKIP (0.000s)
[69.654683] [007/131] (951s left) gem_workarounds (suspend-resume)
[69.720754] Starting subtest: suspend-resume
[86.020205] Subtest suspend-resume: SUCCESS (4.928s)
[86.177049] [008/131] (934s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[86.290230] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[86.292554] Starting dynamic subtest: pipe-A
[86.355032] Dynamic subtest pipe-A: SUCCESS (0.066s)
[86.365125] Starting dynamic subtest: pipe-B
[87.478990] Dynamic subtest pipe-B: SUCCESS (1.140s)
[87.489060] Starting dynamic subtest: pipe-C
[88.571740] Dynamic subtest pipe-C: SUCCESS (1.106s)
[88.581443] Starting dynamic subtest: pipe-D
[89.692996] Dynamic subtest pipe-D: SUCCESS (1.134s)
[89.695372] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.448s)
[90.860607] [009/131] (930s left) gem_pxp (create-regular-buffer)
[90.987886] Starting subtest: create-regular-buffer
[90.990327] Subtest create-regular-buffer: SUCCESS (0.000s)
[91.112213] [010/131] (930s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[91.178804] Starting subtest: rel-constants-invalid-rel-gen5
[91.181236] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[91.308877] [011/131] (929s left) gem_exec_nop (basic-series)
[91.385171] Starting subtest: basic-series
[107.271901] Subtest basic-series: SUCCESS (15.956s)
[107.528715] [012/131] (913s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[107.653419] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[107.657952] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[107.777416] [013/131] (913s left) kms_psr (fbc-psr-primary-page-flip)
[107.877816] Starting subtest: fbc-psr-primary-page-flip
[107.880198] Starting dynamic subtest: eDP-1
[107.884358] Dynamic subtest eDP-1: SKIP (0.000s)
[107.888619] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[107.974514] [014/131] (913s left) i915_pm_rps (engine-order)
[108.042414] Starting subtest: engine-order
[112.975164] Subtest engine-order: SUCCESS (4.939s)
[113.142586] [015/131] (908s left) gem_softpin (evict-active)
[113.205903] Starting subtest: evict-active
[113.216224] Subtest evict-active: SUCCESS (0.010s)
[113.371537] [016/131] (908s left) syncobj_timeline (wait-delayed-signal)
[113.426910] Starting subtest: wait-delayed-signal
[113.528953] Subtest wait-delayed-signal: SUCCESS (0.102s)
[113.638542] [017/131] (907s left) kms_panel_fitting (atomic-fastset)
[113.734740] Starting subtest: atomic-fastset
[113.737277] Starting dynamic subtest: pipe-A-eDP-1
[113.879974] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.147s)
[113.889092] Starting dynamic subtest: pipe-B-eDP-1
[115.121683] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.242s)
[115.130693] Starting dynamic subtest: pipe-C-eDP-1
[116.302773] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.180s)
[116.315674] Starting dynamic subtest: pipe-D-eDP-1
[117.437716] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s)
[117.440127] Subtest atomic-fastset: SUCCESS (3.706s)
[118.711485] [018/131] (902s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[118.823398] Starting subtest: x-tiled-16bpp-rotate-270
[118.843214] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[118.991915] [019/131] (902s left) api_intel_bb (render-ccs)
[119.063703] Starting subtest: render-ccs
[119.569954] Subtest render-ccs: SUCCESS (0.505s)
[119.685939] [020/131] (901s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[119.790621] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[119.792970] Starting dynamic subtest: pipe-A-eDP-1
[119.816079] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[119.827105] Starting dynamic subtest: pipe-B-eDP-1
[119.850690] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[119.861145] Starting dynamic subtest: pipe-C-eDP-1
[119.883070] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[119.892681] Starting dynamic subtest: pipe-D-eDP-1
[119.914680] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[119.918862] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[121.982467] [021/131] (899s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[122.044314] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[122.152286] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.107s)
[122.255291] [022/131] (899s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[122.357304] Starting subtest: psr-2p-primscrn-cur-indfb-move
[122.361625] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[122.522113] [023/131] (899s left) gem_lmem_swapping (heavy-multi)
[122.573335] Subtest heavy-multi: SKIP (0.000s)
[122.625163] [024/131] (899s left) kms_async_flips (test-cursor)
[122.739543] Starting subtest: test-cursor
[122.743935] Subtest test-cursor: SKIP (0.000s)
[123.911980] [025/131] (897s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[128.970372] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[128.972763] Starting dynamic subtest: pipe-A-eDP-1
[129.773667] Dynamic subtest pipe-A-eDP-1: SKIP (0.799s)
[129.784077] Starting dynamic subtest: pipe-B-eDP-1
[130.905809] Dynamic subtest pipe-B-eDP-1: SKIP (1.132s)
[130.910562] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.934s)
[132.115790] [026/131] (889s left) kms_plane_multiple (2x-tiling-4)
[132.223472] Starting subtest: 2x-tiling-4
[132.227899] Subtest 2x-tiling-4: SKIP (0.000s)
[132.318886] [027/131] (889s left) gem_ctx_param (invalid-param-set)
[132.372818] Starting subtest: invalid-param-set
[132.375179] Subtest invalid-param-set: SUCCESS (0.000s)
[132.470084] [028/131] (889s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[132.566109] Starting subtest: bad-pixel-format-y-tiled-ccs
[132.568462] Starting dynamic subtest: pipe-A-eDP-1
[132.590705] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[132.600254] Starting dynamic subtest: pipe-B-eDP-1
[132.621396] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[132.629920] Starting dynamic subtest: pipe-C-eDP-1
[132.651326] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[132.659390] Starting dynamic subtest: pipe-D-eDP-1
[132.681071] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[132.685369] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.003s)
[134.808603] [029/131] (887s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[134.917589] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[134.919775] Starting dynamic subtest: pipe-A
[134.938666] Dynamic subtest pipe-A: SKIP (0.017s)
[134.948013] Starting dynamic subtest: pipe-B
[134.969172] Dynamic subtest pipe-B: SKIP (0.031s)
[134.977934] Starting dynamic subtest: pipe-C
[135.000665] Dynamic subtest pipe-C: SKIP (0.031s)
[135.009310] Starting dynamic subtest: pipe-D
[135.032798] Dynamic subtest pipe-D: SKIP (0.031s)
[135.036899] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.111s)
[135.158207] [030/131] (886s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[135.210633] Starting subtest: multi-wait-all-available-submitted-signaled
[135.212841] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[135.344990] [031/131] (886s left) perf (missing-sample-flags)
[135.483144] Starting subtest: missing-sample-flags
[135.485313] Subtest missing-sample-flags: SUCCESS (0.000s)
[135.530058] [032/131] (886s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[135.629632] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[141.968797] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.345s)
[143.132517] [033/131] (879s left) kms_pm_rpm (system-suspend-idle)
[145.399592] Starting subtest: system-suspend-idle
[165.515410] Subtest system-suspend-idle: SUCCESS (4.642s)
[165.922853] [034/131] (856s left) kms_vblank (wait-forked)
[166.032990] Starting subtest: wait-forked
[166.035281] Starting dynamic subtest: pipe-A-eDP-1
[167.837630] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.824s)
[167.852199] Starting dynamic subtest: pipe-D-eDP-1
[170.351470] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.532s)
[170.353395] Subtest wait-forked: SUCCESS (4.359s)
[171.230020] [035/131] (851s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[171.342483] Starting subtest: y-tiled-32bpp-rotate-0
[171.346771] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[171.475787] [036/131] (850s left) kms_pipe_crc_basic (read-crc)
[171.591306] Starting subtest: read-crc
[171.593614] Starting dynamic subtest: pipe-A-eDP-1
[172.301335] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.713s)
[172.318767] Starting dynamic subtest: pipe-B-eDP-1
[173.663355] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.369s)
[173.672541] Starting dynamic subtest: pipe-C-eDP-1
[174.952456] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.295s)
[174.962026] Starting dynamic subtest: pipe-D-eDP-1
[176.275144] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.323s)
[176.277164] Subtest read-crc: SUCCESS (4.705s)
[177.131081] [037/131] (845s left) kms_cursor_legacy (single-move)
[177.261447] Starting subtest: single-move
[177.263760] Starting dynamic subtest: pipe-A
[182.629306] Dynamic subtest pipe-A: SUCCESS (5.379s)
[182.640079] Starting dynamic subtest: pipe-B
[188.007001] Dynamic subtest pipe-B: SUCCESS (5.382s)
[188.017863] Starting dynamic subtest: pipe-C
[193.385835] Dynamic subtest pipe-C: SUCCESS (5.382s)
[193.396551] Starting dynamic subtest: pipe-D
[198.767029] Dynamic subtest pipe-D: SUCCESS (5.380s)
[198.778041] Starting dynamic subtest: all-pipes
[204.158472] Dynamic subtest all-pipes: SUCCESS (5.388s)
[204.160883] Subtest single-move: SUCCESS (26.920s)
[204.326333] [038/131] (818s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[209.353273] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[209.357935] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.003s)
[210.222016] [039/131] (812s left) gem_unref_active_buffers
[210.462334] [040/131] (812s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[210.557396] Starting subtest: fbc-psr2-primary-mmap-gtt
[210.559269] Starting dynamic subtest: eDP-1
[210.563275] Dynamic subtest eDP-1: SKIP (0.000s)
[210.567355] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[210.655259] [041/131] (811s left) syncobj_wait (invalid-signal-zero-handles)
[210.712364] Starting subtest: invalid-signal-zero-handles
[210.714723] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[210.854890] [042/131] (811s left) gen9_exec_parse (bb-oversize)
[210.917325] Subtest bb-oversize: SKIP (0.000s)
[210.985102] [043/131] (811s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[211.043282] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[211.143667] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.101s)
[211.247426] [044/131] (811s left) gem_exec_reloc (basic-write-cpu-noreloc)
[211.316573] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[211.398120] [045/131] (811s left) gem_mmap_offset (bad-flags)
[211.452819] Starting subtest: bad-flags
[211.454774] Subtest bad-flags: SUCCESS (0.000s)
[211.590301] [046/131] (811s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[211.712331] Starting subtest: cursor-vs-flip-legacy
[241.011363] Subtest cursor-vs-flip-legacy: SUCCESS (29.303s)
[241.833898] [047/131] (780s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[241.934986] Starting subtest: sprite-rotation-90-pos-100-0
[241.939584] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[242.031387] [048/131] (780s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[242.140660] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[243.141058] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.000s)
[243.312134] [049/131] (779s left) gem_create (busy-create)
[243.372751] Starting subtest: busy-create
[243.375023] Starting dynamic subtest: smem0
[275.823877] Dynamic subtest smem0: SUCCESS (32.447s)
[275.826775] Subtest busy-create: SUCCESS (32.449s)
[276.035006] [050/131] (746s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[276.142582] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[280.315450] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.174s)
[281.533064] [051/131] (741s left) perf (invalid-open-flags)
[281.642979] Starting subtest: invalid-open-flags
[281.645420] Subtest invalid-open-flags: SUCCESS (0.000s)
[281.684690] [052/131] (741s left) perf (oa-formats)
[281.782341] Starting subtest: oa-formats
[281.784635] Starting dynamic subtest: 0-rcs0
[281.798467] Dynamic subtest 0-rcs0: SUCCESS (0.016s)
[281.809454] Starting dynamic subtest: 1-vecs0
[281.821251] Dynamic subtest 1-vecs0: SUCCESS (0.022s)
[281.823544] Subtest oa-formats: SUCCESS (0.039s)
[281.863698] [053/131] (741s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[281.974786] Starting subtest: 4-tiled-8bpp-rotate-270
[281.998837] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.022s)
[282.155522] [054/131] (740s left) kms_cursor_crc (cursor-onscreen-64x21)
[282.331795] Starting subtest: cursor-onscreen-64x21
[282.380058] Subtest cursor-onscreen-64x21: SKIP (0.042s)
[282.630015] [055/131] (740s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[282.727053] Starting subtest: primary-4-tiled-reflect-x-180
[289.774067] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.046s)
[291.013060] [056/131] (732s left) kms_cursor_crc (cursor-onscreen-256x256)
[291.282866] Starting subtest: cursor-onscreen-256x256
[291.288041] Starting dynamic subtest: pipe-A-eDP-1
[293.405008] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.118s)
[293.434328] Starting dynamic subtest: pipe-D-eDP-1
[296.142492] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.715s)
[296.144922] Subtest cursor-onscreen-256x256: SUCCESS (4.859s)
[296.963894] [057/131] (726s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[297.077598] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[304.446384] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.372s)
[304.582799] [058/131] (718s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[304.694371] Starting subtest: async-flip-with-page-flip-events-tiled
[305.066079] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[307.836919] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.770s)
[307.846633] Starting dynamic subtest: pipe-A-eDP-1-4
[310.022299] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.183s)
[310.034339] Starting dynamic subtest: pipe-A-eDP-1-4
[312.031144] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[312.042991] Starting dynamic subtest: pipe-A-eDP-1-x
[314.254404] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.222s)
[314.620394] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[317.363380] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.751s)
[317.372892] Starting dynamic subtest: pipe-B-eDP-1-4
[319.548765] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[319.564199] Starting dynamic subtest: pipe-B-eDP-1-4
[321.558093] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.008s)
[321.567926] Starting dynamic subtest: pipe-B-eDP-1-x
[323.748579] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[324.129261] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[326.878201] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.756s)
[326.887433] Starting dynamic subtest: pipe-C-eDP-1-4
[329.064139] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.186s)
[329.073535] Starting dynamic subtest: pipe-C-eDP-1-4
[331.074012] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[331.086152] Starting dynamic subtest: pipe-C-eDP-1-x
[333.252438] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[333.616390] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[336.401049] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.791s)
[336.410586] Starting dynamic subtest: pipe-D-eDP-1-4
[338.585270] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.183s)
[338.594881] Starting dynamic subtest: pipe-D-eDP-1-4
[340.594475] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[340.603714] Starting dynamic subtest: pipe-D-eDP-1-x
[342.773072] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[342.775620] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.085s)
[344.003281] [059/131] (679s left) perf (polling)
[344.108055] Starting subtest: polling
[344.110537] Starting dynamic subtest: 0-rcs0
[354.143055] Dynamic subtest 0-rcs0: SUCCESS (10.035s)
[354.152677] Starting dynamic subtest: 1-vecs0
[364.158971] Dynamic subtest 1-vecs0: SUCCESS (10.017s)
[364.161401] Subtest polling: SUCCESS (20.055s)
[364.209606] [060/131] (659s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[364.307713] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[364.312052] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[364.431715] [061/131] (658s left) syncobj_timeline (reset-signaled)
[364.492298] Starting subtest: reset-signaled
[364.494599] Subtest reset-signaled: SUCCESS (0.000s)
[364.604764] [062/131] (658s left) kms_rmfb (rmfb-ioctl)
[364.694441] Starting subtest: rmfb-ioctl
[364.696302] Starting dynamic subtest: pipe-A-eDP-1
[364.798005] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.105s)
[364.807363] Starting dynamic subtest: pipe-B-eDP-1
[365.925319] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.126s)
[365.937130] Starting dynamic subtest: pipe-C-eDP-1
[367.036381] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.110s)
[367.045988] Starting dynamic subtest: pipe-D-eDP-1
[368.171179] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s)
[368.173563] Subtest rmfb-ioctl: SUCCESS (3.482s)
[369.405632] [063/131] (654s left) gem_userptr_blits (create-destroy-sync)
[369.491054] Starting subtest: create-destroy-sync
[374.496593] Subtest create-destroy-sync: SUCCESS (5.009s)
[374.665386] [064/131] (648s left) gem_exec_reloc (basic-gtt-cpu-active)
[374.737965] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[374.823608] [065/131] (648s left) api_intel_allocator (execbuf-with-allocator)
[374.887494] Starting subtest: execbuf-with-allocator
[374.894668] Subtest execbuf-with-allocator: SUCCESS (0.010s)
[375.061057] [066/131] (648s left) kms_lease (cursor-implicit-plane)
[375.162230] Starting subtest: cursor-implicit-plane
[375.164573] Starting dynamic subtest: pipe-A-eDP-1
[375.621259] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.457s)
[375.633550] Starting dynamic subtest: pipe-B-eDP-1
[376.697030] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.077s)
[376.706828] Starting dynamic subtest: pipe-C-eDP-1
[377.811530] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.113s)
[377.820409] Starting dynamic subtest: pipe-D-eDP-1
[378.940434] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s)
[378.942722] Subtest cursor-implicit-plane: SUCCESS (3.780s)
[379.826848] [067/131] (643s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[379.949773] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[379.954109] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[380.129851] [068/131] (643s left) syncobj_wait (invalid-signal-illegal-handle)
[380.184065] Starting subtest: invalid-signal-illegal-handle
[380.186330] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[380.307151] [069/131] (643s left) kms_psr (psr-primary-blt)
[380.401571] Starting subtest: psr-primary-blt
[380.403676] Starting dynamic subtest: eDP-1
[382.109798] Dynamic subtest eDP-1: SUCCESS (1.706s)
[382.111936] Subtest psr-primary-blt: SUCCESS (1.707s)
[382.989491] [070/131] (640s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[383.086958] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[383.089239] Starting dynamic subtest: pipe-A-eDP-1
[383.145127] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[383.155702] Starting dynamic subtest: pipe-B-eDP-1
[383.210745] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[383.221471] Starting dynamic subtest: pipe-C-eDP-1
[383.277869] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[383.287589] Starting dynamic subtest: pipe-D-eDP-1
[383.343488] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[383.347760] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[385.351827] [071/131] (638s left) kms_psr (pr-primary-blt)
[385.455280] Starting subtest: pr-primary-blt
[385.459655] Subtest pr-primary-blt: SKIP (0.000s)
[385.553918] [072/131] (638s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[385.657238] Starting subtest: psr-2p-primscrn-spr-indfb-move
[385.661449] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[385.784975] [073/131] (638s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[385.876810] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[385.878883] Starting dynamic subtest: pipe-A-default-mode
[386.998448] Dynamic subtest pipe-A-default-mode: SKIP (1.118s)
[387.002611] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.119s)
[387.169232] [074/131] (636s left) gem_exec_schedule (u-semaphore-noskip)
[387.252469] Starting subtest: u-semaphore-noskip
[387.642818] Subtest u-semaphore-noskip: SUCCESS (0.397s)
[388.017651] [075/131] (635s left) i915_drm_fdinfo (memory-info-idle)
[388.058862] Starting subtest: memory-info-idle
[388.061257] Starting dynamic subtest: smem0
[388.123717] Dynamic subtest smem0: SUCCESS (0.067s)
[388.126247] Subtest memory-info-idle: SUCCESS (0.068s)
[388.222064] [076/131] (635s left) i915_selftest (live)
[391.812558] Starting subtest: live
[391.815408] Starting dynamic subtest: sanitycheck
[394.644590] Dynamic subtest sanitycheck: SUCCESS (2.831s)
[394.654873] Starting dynamic subtest: uncore
[399.123440] Dynamic subtest uncore: SUCCESS (4.475s)
[399.133281] Starting dynamic subtest: workarounds
[416.918084] Dynamic subtest workarounds: FAIL (17.206s)
[416.926564] Starting dynamic subtest: gt_engines
[421.051264] Dynamic subtest gt_engines: SUCCESS (4.714s)
[421.061685] Starting dynamic subtest: gt_timelines
[439.190260] Dynamic subtest gt_timelines: SUCCESS (18.134s)
[439.200392] Starting dynamic subtest: gt_contexts
[443.630535] Dynamic subtest gt_contexts: SUCCESS (4.437s)
[443.640939] Starting dynamic subtest: gt_lrc
[449.981405] Dynamic subtest gt_lrc: SUCCESS (6.349s)
[449.991512] Starting dynamic subtest: gt_mocs
[453.151196] Dynamic subtest gt_mocs: SUCCESS (3.167s)
[453.161780] Starting dynamic subtest: gt_pm
[460.063403] Dynamic subtest gt_pm: SUCCESS (6.910s)
[460.073229] Starting dynamic subtest: gt_heartbeat
[464.478304] Dynamic subtest gt_heartbeat: SUCCESS (4.413s)
[464.488022] Starting dynamic subtest: gt_tlb
[473.868662] Dynamic subtest gt_tlb: SUCCESS (9.388s)
[473.878966] Starting dynamic subtest: requests
[485.449448] Dynamic subtest requests: SUCCESS (11.579s)
[485.463503] Starting dynamic subtest: migrate
[493.496050] Dynamic subtest migrate: SUCCESS (8.045s)
[493.505873] Starting dynamic subtest: active
[497.948255] Dynamic subtest active: SUCCESS (4.451s)
[497.958436] Starting dynamic subtest: objects
[502.790100] Dynamic subtest objects: SUCCESS (4.840s)
[502.805944] Starting dynamic subtest: mman
[507.829282] Dynamic subtest mman: SUCCESS (5.037s)
[507.844685] Starting dynamic subtest: dmabuf
[510.731281] Dynamic subtest dmabuf: SUCCESS (2.900s)
[510.741396] Starting dynamic subtest: vma
[515.226785] Dynamic subtest vma: SUCCESS (4.493s)
[515.236510] Starting dynamic subtest: coherency
[520.396527] Dynamic subtest coherency: SUCCESS (5.168s)
[520.406001] Starting dynamic subtest: gtt
[532.491962] Dynamic subtest gtt: SUCCESS (12.096s)
[532.502027] Starting dynamic subtest: gem
[540.621283] Dynamic subtest gem: SUCCESS (8.129s)
[540.631135] Starting dynamic subtest: evict
[544.770120] Dynamic subtest evict: SUCCESS (4.147s)
[544.779911] Starting dynamic subtest: hugepages
[555.992850] Dynamic subtest hugepages: SUCCESS (11.221s)
[556.002881] Starting dynamic subtest: gem_contexts
[584.897324] Dynamic subtest gem_contexts: SUCCESS (28.908s)
[584.912650] Starting dynamic subtest: client
[589.386041] Dynamic subtest client: SUCCESS (4.488s)
[589.396168] Starting dynamic subtest: gem_migrate
[593.873605] Dynamic subtest gem_migrate: SUCCESS (4.486s)
[593.883727] Starting dynamic subtest: reset
[598.371664] Dynamic subtest reset: SUCCESS (4.496s)
[598.382513] Starting dynamic subtest: memory_region
[602.835525] Dynamic subtest memory_region: SUCCESS (4.462s)
[602.845120] Starting dynamic subtest: hangcheck
[616.236978] Dynamic subtest hangcheck: SUCCESS (13.401s)
[616.247188] Starting dynamic subtest: execlists
[620.775066] Dynamic subtest execlists: SUCCESS (4.536s)
[620.786356] Starting dynamic subtest: ring_submission
[625.261702] Dynamic subtest ring_submission: SUCCESS (4.485s)
[625.271190] Starting dynamic subtest: perf
[629.732800] Dynamic subtest perf: SUCCESS (4.470s)
[629.742835] Starting dynamic subtest: slpc
[641.976596] Dynamic subtest slpc: SUCCESS (12.244s)
[641.987076] Starting dynamic subtest: guc
[646.003554] Dynamic subtest guc: SUCCESS (4.024s)
[646.013598] Starting dynamic subtest: guc_multi_lrc
[650.412260] Dynamic subtest guc_multi_lrc: SUCCESS (4.403s)
[650.422594] Starting dynamic subtest: guc_hang
[655.534751] Dynamic subtest guc_hang: SUCCESS (5.116s)
[655.544763] Starting dynamic subtest: late_gt_pm
[660.050464] Dynamic subtest late_gt_pm: SUCCESS (4.511s)
[660.053620] Subtest live: FAIL (268.239s)
[660.082794] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[660.083505] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[660.086586] [077/131] (363s left) gem_userptr_blits (nohangcheck)
[661.651290] Starting subtest: nohangcheck
[661.942503] Subtest nohangcheck: SUCCESS (0.290s)
[662.053850] [FACT gem_userptr_blits (nohangcheck)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[662.055047] [FACT gem_userptr_blits (nohangcheck)] new: kernel.kmod_is_loaded.i915: true
[662.058790] [078/131] (362s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[662.154804] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[662.157002] Starting dynamic subtest: pipe-A-eDP-1
[662.991276] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.828s)
[663.000057] Starting dynamic subtest: pipe-B-eDP-1
[664.509359] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.516s)
[664.519290] Starting dynamic subtest: pipe-C-eDP-1
[666.036483] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.523s)
[666.046949] Starting dynamic subtest: pipe-D-eDP-1
[667.532089] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.492s)
[667.534309] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.365s)
[668.717359] [079/131] (355s left) gem_softpin (allocator-nopin)
[668.781683] Starting subtest: allocator-nopin
[668.892586] Subtest allocator-nopin: SUCCESS (0.109s)
[669.048177] [080/131] (355s left) kms_draw_crc (draw-method-pwrite)
[669.144313] Starting subtest: draw-method-pwrite
[669.146268] Starting dynamic subtest: xrgb8888-untiled
[669.721742] Dynamic subtest xrgb8888-untiled: SUCCESS (0.579s)
[669.730676] Starting dynamic subtest: rgb565-untiled
[670.166263] Dynamic subtest rgb565-untiled: SUCCESS (0.442s)
[670.175265] Starting dynamic subtest: xrgb2101010-untiled
[670.722198] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.555s)
[670.731237] Starting dynamic subtest: xbgr16161616f-untiled
[671.467296] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.744s)
[671.476405] Starting dynamic subtest: xrgb8888-xtiled
[673.234709] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.766s)
[673.243709] Starting dynamic subtest: rgb565-xtiled
[674.312797] Dynamic subtest rgb565-xtiled: SUCCESS (1.077s)
[674.321900] Starting dynamic subtest: xrgb2101010-xtiled
[676.080808] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.766s)
[676.090126] Starting dynamic subtest: xbgr16161616f-xtiled
[679.326792] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.243s)
[679.336266] Starting dynamic subtest: xrgb8888-4tiled
[680.404735] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.077s)
[680.414123] Starting dynamic subtest: rgb565-4tiled
[680.971725] Dynamic subtest rgb565-4tiled: SUCCESS (0.566s)
[680.981337] Starting dynamic subtest: xrgb2101010-4tiled
[682.050162] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.077s)
[682.059710] Starting dynamic subtest: xbgr16161616f-4tiled
[685.006906] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.955s)
[685.009259] Subtest draw-method-pwrite: SUCCESS (15.857s)
[685.155015] [081/131] (339s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[685.267573] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[685.271653] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[685.407101] [082/131] (338s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[685.519365] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[685.523410] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[685.654696] [083/131] (338s left) syncobj_timeline (host-signal-points)
[685.720268] Starting subtest: host-signal-points
[685.724921] Subtest host-signal-points: SUCCESS (0.004s)
[685.873460] [084/131] (338s left) gem_mmap_gtt (basic-small-bo)
[685.935364] Subtest basic-small-bo: SKIP (0.000s)
[685.996895] [085/131] (338s left) perf_pmu (semaphore-wait-idle)
[686.040377] Starting subtest: semaphore-wait-idle
[686.041930] Starting dynamic subtest: rcs0
[686.553640] Dynamic subtest rcs0: SUCCESS (0.513s)
[686.565257] Starting dynamic subtest: bcs0
[687.065738] Dynamic subtest bcs0: SUCCESS (0.509s)
[687.078159] Starting dynamic subtest: vcs0
[687.579026] Dynamic subtest vcs0: SUCCESS (0.510s)
[687.591342] Starting dynamic subtest: vcs1
[688.091075] Dynamic subtest vcs1: SUCCESS (0.510s)
[688.103177] Starting dynamic subtest: vecs0
[688.609775] Dynamic subtest vecs0: SUCCESS (0.514s)
[688.622872] Starting dynamic subtest: ccs0
[689.126336] Dynamic subtest ccs0: SUCCESS (0.514s)
[689.129047] Subtest semaphore-wait-idle: SUCCESS (3.086s)
[689.291380] [086/131] (335s left) kms_addfb_basic (no-handle)
[689.351867] Starting subtest: no-handle
[689.353757] Subtest no-handle: SUCCESS (0.000s)
[689.526659] [087/131] (334s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[689.634228] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[696.835977] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.201s)
[696.982882] [088/131] (327s left) gem_render_copy (yf-tiled-ccs-to-linear)
[697.040469] Starting subtest: yf-tiled-ccs-to-linear
[697.044787] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[697.245596] [089/131] (327s left) kms_flip (wf_vblank-ts-check)
[697.343754] Starting subtest: wf_vblank-ts-check
[697.346004] Starting dynamic subtest: A-eDP1
[706.275464] Dynamic subtest A-eDP1: SUCCESS (8.929s)
[706.285741] Starting dynamic subtest: B-eDP1
[715.205537] Dynamic subtest B-eDP1: SUCCESS (8.927s)
[715.218629] Starting dynamic subtest: C-eDP1
[724.124197] Dynamic subtest C-eDP1: SUCCESS (8.912s)
[724.134104] Starting dynamic subtest: D-eDP1
[733.047306] Dynamic subtest D-eDP1: SUCCESS (8.922s)
[733.049807] Subtest wf_vblank-ts-check: SUCCESS (35.701s)
[734.294541] [090/131] (290s left) gem_exec_schedule (deep)
[734.483151] Starting subtest: deep
[734.485732] Starting dynamic subtest: rcs0
[739.318054] Dynamic subtest rcs0: SKIP (4.831s)
[739.330446] Starting dynamic subtest: vcs0
[749.505513] Dynamic subtest vcs0: SUCCESS (10.187s)
[749.518823] Starting dynamic subtest: vcs1
[760.315798] Dynamic subtest vcs1: SUCCESS (10.808s)
[760.328926] Starting dynamic subtest: vecs0
[772.048665] Dynamic subtest vecs0: SUCCESS (11.731s)
[772.061064] Starting dynamic subtest: ccs0
[784.571874] Dynamic subtest ccs0: SUCCESS (12.521s)
[784.574972] Subtest deep: SUCCESS (50.083s)
[785.656524] [091/131] (238s left) kms_sequence (queue-idle)
[785.764062] Starting subtest: queue-idle
[785.765970] Starting dynamic subtest: pipe-A-eDP-1
[787.571980] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.808s)
[787.582230] Starting dynamic subtest: pipe-B-eDP-1
[790.037548] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.464s)
[790.048455] Starting dynamic subtest: pipe-C-eDP-1
[792.452110] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.414s)
[792.462131] Starting dynamic subtest: pipe-D-eDP-1
[794.919357] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.465s)
[794.921636] Subtest queue-idle: SUCCESS (9.156s)
[795.757271] [092/131] (228s left) gem_gtt_cpu_tlb
[795.875870] [093/131] (228s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[795.968358] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[802.512587] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.546s)
[802.692051] [094/131] (222s left) gem_eio (create-ext)
[802.930873] Starting subtest: create-ext
[803.267057] Subtest create-ext: SUCCESS (0.336s)
[803.447533] [095/131] (221s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[803.506554] Subtest writes-after-reads-uncached: SKIP (0.000s)
[803.605146] [096/131] (221s left) sysfs_preempt_timeout (idempotent)
[803.659643] Starting subtest: idempotent
[803.661579] Starting dynamic subtest: vecs0
[803.665871] Dynamic subtest vecs0: SUCCESS (0.000s)
[803.676557] Starting dynamic subtest: ccs0
[803.678276] Dynamic subtest ccs0: SUCCESS (0.000s)
[803.687369] Starting dynamic subtest: vcs0
[803.689121] Dynamic subtest vcs0: SUCCESS (0.000s)
[803.698418] Starting dynamic subtest: bcs0
[803.699943] Dynamic subtest bcs0: SUCCESS (0.001s)
[803.708567] Starting dynamic subtest: rcs0
[803.710160] Dynamic subtest rcs0: SUCCESS (0.001s)
[803.718847] Starting dynamic subtest: vcs1
[803.720468] Dynamic subtest vcs1: SUCCESS (0.000s)
[803.722027] Subtest idempotent: SUCCESS (0.010s)
[803.764395] [097/131] (221s left) gem_busy (semaphore)
[803.955517] Subtest semaphore: SKIP (0.000s)
[804.208128] [098/131] (220s left) sriov_basic (enable-vfs-bind-unbind-each)
[804.271774] Starting subtest: enable-vfs-bind-unbind-each
[804.274093] Starting dynamic subtest: numvfs-1
[804.348201] Dynamic subtest numvfs-1: FAIL (0.005s)
[804.359606] Starting dynamic subtest: numvfs-2
[804.431036] Dynamic subtest numvfs-2: FAIL (0.004s)
[804.442176] Starting dynamic subtest: numvfs-3
[804.515255] Dynamic subtest numvfs-3: FAIL (0.003s)
[804.527898] Starting dynamic subtest: numvfs-4
[804.599437] Dynamic subtest numvfs-4: FAIL (0.004s)
[804.610255] Starting dynamic subtest: numvfs-5
[804.682903] Dynamic subtest numvfs-5: FAIL (0.004s)
[804.694013] Starting dynamic subtest: numvfs-6
[804.767030] Dynamic subtest numvfs-6: FAIL (0.004s)
[804.777812] Starting dynamic subtest: numvfs-7
[804.850084] Dynamic subtest numvfs-7: FAIL (0.003s)
[804.861483] Starting dynamic subtest: numvfs-random
[804.933453] Dynamic subtest numvfs-random: FAIL (0.004s)
[804.935529] Subtest enable-vfs-bind-unbind-each: FAIL (0.036s)
[804.974650] [099/131] (220s left) kms_pm_lpsp (screens-disabled)
[806.078301] Starting subtest: screens-disabled
[806.082274] Subtest screens-disabled: SKIP (0.000s)
[806.173634] [100/131] (218s left) gem_exec_capture (capture-invisible)
[806.227089] Starting subtest: capture-invisible
[806.229545] Starting dynamic subtest: smem0
[806.234090] Dynamic subtest smem0: SKIP (0.000s)
[806.238572] Subtest capture-invisible: SKIP (0.001s)
[806.355629] [101/131] (218s left) gem_lmem_swapping (verify-ccs)
[806.404984] Subtest verify-ccs: SKIP (0.000s)
[806.451363] [102/131] (218s left) kms_joiner (basic-force-ultra-joiner)
[806.548868] Starting subtest: basic-force-ultra-joiner
[806.552867] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[806.643912] [103/131] (218s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[806.742060] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[813.317723] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.575s)
[813.476173] [104/131] (211s left) kms_color (legacy-gamma)
[813.577185] Starting subtest: legacy-gamma
[813.579405] Starting dynamic subtest: pipe-A-eDP-1
[814.364729] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.786s)
[814.375438] Starting dynamic subtest: pipe-B-eDP-1
[815.795561] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.430s)
[815.805751] Starting dynamic subtest: pipe-C-eDP-1
[817.132185] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.338s)
[817.142745] Starting dynamic subtest: pipe-D-eDP-1
[818.462690] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.327s)
[818.464963] Subtest legacy-gamma: SUCCESS (4.885s)
[819.308551] [105/131] (205s left) gem_exec_schedule (wide)
[819.496029] Starting subtest: wide
[819.498525] Starting dynamic subtest: rcs0
[829.997032] Dynamic subtest rcs0: SUCCESS (10.500s)
[830.011361] Starting dynamic subtest: vcs0
[840.483368] Dynamic subtest vcs0: SUCCESS (10.486s)
[840.497139] Starting dynamic subtest: vcs1
[850.514226] Dynamic subtest vcs1: SUCCESS (10.029s)
[850.526718] Starting dynamic subtest: vecs0
[860.847183] Dynamic subtest vecs0: SUCCESS (10.333s)
[860.860239] Starting dynamic subtest: ccs0
[874.799414] Dynamic subtest ccs0: SUCCESS (13.951s)
[874.802016] Subtest wide: SUCCESS (55.305s)
[876.644374] [106/131] (148s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[876.768171] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[876.770491] Starting dynamic subtest: pipe-A-default-mode
[877.057345] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[877.061860] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.288s)
[877.920789] [107/131] (147s left) kms_big_fb (linear-64bpp-rotate-180)
[878.026992] Starting subtest: linear-64bpp-rotate-180
[879.549655] Subtest linear-64bpp-rotate-180: SUCCESS (1.523s)
[879.773559] [108/131] (145s left) gem_ppgtt (blt-vs-render-ctxn)
[879.848259] Starting subtest: blt-vs-render-ctxN
[912.973286] Subtest blt-vs-render-ctxN: SUCCESS (33.122s)
[913.155237] [109/131] (112s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[913.290674] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[913.295040] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[913.437590] [110/131] (112s left) kms_chamelium_frames (dp-frame-dump)
[913.825687] Subtest dp-frame-dump: SKIP (0.000s)
[914.602959] [111/131] (110s left) kms_psr2_su (page_flip-nv12)
[914.663075] Subtest page_flip-NV12: SKIP (0.000s)
[914.725823] [112/131] (110s left) gem_tiling_max_stride
[914.842310] [113/131] (110s left) perf_pmu (busy-idle)
[914.879324] Starting subtest: busy-idle
[914.881440] Starting dynamic subtest: rcs0
[915.566159] Dynamic subtest rcs0: SUCCESS (0.686s)
[915.580090] Starting dynamic subtest: bcs0
[916.244273] Dynamic subtest bcs0: SUCCESS (0.676s)
[916.257798] Starting dynamic subtest: vcs0
[917.780120] Dynamic subtest vcs0: SUCCESS (1.532s)
[917.793419] Starting dynamic subtest: vcs1
[919.765170] Dynamic subtest vcs1: SUCCESS (1.982s)
[919.778287] Starting dynamic subtest: vecs0
[921.813430] Dynamic subtest vecs0: SUCCESS (2.045s)
[921.826836] Starting dynamic subtest: ccs0
[922.477678] Dynamic subtest ccs0: SUCCESS (0.663s)
[922.480151] Subtest busy-idle: SUCCESS (7.598s)
[922.618151] [114/131] (103s left) dmabuf_sync_file (export-before-signal)
[922.668385] Starting subtest: export-before-signal
[922.670655] Subtest export-before-signal: SUCCESS (0.001s)
[922.748722] [115/131] (102s left) gem_exec_reloc (basic-cpu-read)
[922.810871] Subtest basic-cpu-read: SKIP (0.000s)
[922.900795] [116/131] (102s left) kms_hdr (bpc-switch)
[923.003135] Starting subtest: bpc-switch
[924.097455] Starting dynamic subtest: pipe-A-eDP-1
[927.496261] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.402s)
[927.498747] Subtest bpc-switch: SUCCESS (4.495s)
[927.657628] [117/131] ( 98s left) perf (i915-ref-count)
[927.772833] Starting subtest: i915-ref-count
[927.842081] Subtest i915-ref-count: SUCCESS (0.067s)
[927.900727] [118/131] ( 97s left) gem_ctx_isolation (nonpriv)
[927.973839] Starting subtest: nonpriv
[927.976170] Starting dynamic subtest: rcs0
[928.228912] Dynamic subtest rcs0: SUCCESS (0.255s)
[928.240002] Starting dynamic subtest: bcs0
[928.510100] Dynamic subtest bcs0: SUCCESS (0.280s)
[928.519987] Starting dynamic subtest: vcs0
[928.773544] Dynamic subtest vcs0: SUCCESS (0.263s)
[928.784270] Starting dynamic subtest: vcs1
[930.046812] Dynamic subtest vcs1: SUCCESS (1.272s)
[930.059467] Starting dynamic subtest: vecs0
[932.053867] Dynamic subtest vecs0: SUCCESS (2.006s)
[932.064498] Starting dynamic subtest: ccs0
[934.059576] Dynamic subtest ccs0: SUCCESS (2.004s)
[934.061900] Subtest nonpriv: SUCCESS (6.085s)
[934.331446] [119/131] ( 91s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[934.406932] Starting subtest: y-tiled-to-vebox-x-tiled
[934.411691] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[934.616256] [120/131] ( 91s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[934.711535] Starting subtest: plane-use-after-nonblocking-unbind
[934.713862] Starting dynamic subtest: pipe-A-eDP-1
[934.771366] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.061s)
[935.073298] Starting dynamic subtest: pipe-B-eDP-1
[935.847199] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.789s)
[936.163241] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.452s)
[937.035775] [121/131] ( 88s left) i915_hangman (engine-error-state-capture)
[937.115843] Starting subtest: engine-error-state-capture
[937.118304] Starting dynamic subtest: rcs0
[940.787380] Dynamic subtest rcs0: SUCCESS (3.672s)
[940.800854] Starting dynamic subtest: bcs0
[946.738654] Dynamic subtest bcs0: SUCCESS (5.948s)
[946.752460] Starting dynamic subtest: vcs0
[952.754747] Dynamic subtest vcs0: SUCCESS (6.013s)
[952.768895] Starting dynamic subtest: vcs1
[958.771545] Dynamic subtest vcs1: SUCCESS (6.013s)
[958.787903] Starting dynamic subtest: vecs0
[964.723664] Dynamic subtest vecs0: SUCCESS (5.949s)
[964.739284] Starting dynamic subtest: ccs0
[970.739010] Dynamic subtest ccs0: SUCCESS (6.012s)
[970.743466] Subtest engine-error-state-capture: SUCCESS (33.623s)
[970.847424] [122/131] ( 55s left) gem_exec_schedule (pi-shared-iova)
[971.034966] Starting subtest: pi-shared-iova
[971.037583] Starting dynamic subtest: rcs0
[971.174795] Dynamic subtest rcs0: SUCCESS (0.142s)
[971.188412] Starting dynamic subtest: vcs0
[971.267644] Dynamic subtest vcs0: SUCCESS (0.092s)
[971.281347] Starting dynamic subtest: vcs1
[971.348883] Dynamic subtest vcs1: SUCCESS (0.081s)
[971.362136] Starting dynamic subtest: vecs0
[971.442258] Dynamic subtest vecs0: SUCCESS (0.091s)
[971.454776] Starting dynamic subtest: ccs0
[971.567089] Dynamic subtest ccs0: SUCCESS (0.123s)
[971.569508] Subtest pi-shared-iova: SUCCESS (0.535s)
[972.894978] [123/131] ( 53s left) syncobj_wait (invalid-reset-illegal-handle)
[972.957809] Starting subtest: invalid-reset-illegal-handle
[972.960658] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[973.095821] [124/131] ( 52s left) syncobj_wait (single-wait-all-for-submit-signaled)
[973.157843] Starting subtest: single-wait-all-for-submit-signaled
[973.160257] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[973.280534] [125/131] ( 52s left) kms_cursor_crc (cursor-sliding-512x170)
[973.565910] Starting subtest: cursor-sliding-512x170
[973.570370] Subtest cursor-sliding-512x170: SKIP (0.001s)
[973.743570] [126/131] ( 52s left) kms_chamelium_hpd (hdmi-hpd-fast)
[974.124739] Subtest hdmi-hpd-fast: SKIP (0.000s)
[974.918504] [127/131] ( 51s left) gem_ctx_persistence (hostile)
[974.975692] Starting subtest: hostile
[984.505487] Subtest hostile: SUCCESS (9.523s)
[984.672948] [128/131] ( 41s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[984.785890] Starting subtest: fbc-rgb565-draw-blt
[988.921750] Subtest fbc-rgb565-draw-blt: SUCCESS (4.139s)
[990.069905] [129/131] ( 36s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[990.162519] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[999.478186] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.318s)
[999.668013] [130/131] ( 26s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[999.769505] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[999.773492] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[999.878317] [131/131] ( 26s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[999.980446] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[999.984800] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[1000.114739] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: gem_exec_fence
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_exec_balancer
results: parsing output: 5/ for test: kms_chamelium_color
results: parsing output: 6/ for test: gem_workarounds
results: parsing output: 7/ for test: kms_plane_scaling
results: parsing output: 8/ for test: gem_pxp
results: parsing output: 9/ for test: gem_exec_params
results: parsing output: 10/ for test: gem_exec_nop
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: i915_pm_rps
results: parsing output: 14/ for test: gem_softpin
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: kms_panel_fitting
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: api_intel_bb
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: syncobj_wait
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_lmem_swapping
results: parsing output: 23/ for test: kms_async_flips
results: parsing output: 24/ for test: kms_psr2_sf
results: parsing output: 25/ for test: kms_plane_multiple
results: parsing output: 26/ for test: gem_ctx_param
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: kms_plane_scaling
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: perf
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_pm_rpm
results: parsing output: 33/ for test: kms_vblank
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_pipe_crc_basic
results: parsing output: 36/ for test: kms_cursor_legacy
results: parsing output: 37/ for test: kms_psr2_sf
results: parsing output: 38/ for test: gem_unref_active_buffers
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: syncobj_wait
results: parsing output: 41/ for test: gen9_exec_parse
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: gem_exec_reloc
results: parsing output: 44/ for test: gem_mmap_offset
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: kms_rotation_crc
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: gem_create
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: perf
results: parsing output: 51/ for test: perf
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_cursor_crc
results: parsing output: 54/ for test: kms_rotation_crc
results: parsing output: 55/ for test: kms_cursor_crc
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_async_flips
results: parsing output: 58/ for test: perf
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: kms_rmfb
results: parsing output: 62/ for test: gem_userptr_blits
results: parsing output: 63/ for test: gem_exec_reloc
results: parsing output: 64/ for test: api_intel_allocator
results: parsing output: 65/ for test: kms_lease
results: parsing output: 66/ for test: kms_cursor_legacy
results: parsing output: 67/ for test: syncobj_wait
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_flip_scaled_crc
results: parsing output: 73/ for test: gem_exec_schedule
results: parsing output: 74/ for test: i915_drm_fdinfo
results: parsing output: 75/ for test: i915_selftest
results: parsing output: 76/ for test: gem_userptr_blits
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: gem_softpin
results: parsing output: 79/ for test: kms_draw_crc
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: gem_mmap_gtt
results: parsing output: 84/ for test: perf_pmu
results: parsing output: 85/ for test: kms_addfb_basic
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_render_copy
results: parsing output: 88/ for test: kms_flip
results: parsing output: 89/ for test: gem_exec_schedule
results: parsing output: 90/ for test: kms_sequence
results: parsing output: 91/ for test: gem_gtt_cpu_tlb
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_eio
results: parsing output: 94/ for test: gem_partial_pwrite_pread
results: parsing output: 95/ for test: sysfs_preempt_timeout
results: parsing output: 96/ for test: gem_busy
results: parsing output: 97/ for test: sriov_basic
results: parsing output: 98/ for test: kms_pm_lpsp
results: parsing output: 99/ for test: gem_exec_capture
results: parsing output: 100/ for test: gem_lmem_swapping
results: parsing output: 101/ for test: kms_joiner
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_color
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: kms_flip_scaled_crc
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: gem_ppgtt
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_chamelium_frames
results: parsing output: 110/ for test: kms_psr2_su
results: parsing output: 111/ for test: gem_tiling_max_stride
results: parsing output: 112/ for test: perf_pmu
results: parsing output: 113/ for test: dmabuf_sync_file
results: parsing output: 114/ for test: gem_exec_reloc
results: parsing output: 115/ for test: kms_hdr
results: parsing output: 116/ for test: perf
results: parsing output: 117/ for test: gem_ctx_isolation
results: parsing output: 118/ for test: gem_render_copy
results: parsing output: 119/ for test: kms_atomic_transition
results: parsing output: 120/ for test: i915_hangman
results: parsing output: 121/ for test: gem_exec_schedule
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: kms_cursor_crc
results: parsing output: 125/ for test: kms_chamelium_hpd
results: parsing output: 126/ for test: gem_ctx_persistence
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
Done.