[57.097128] Initializing watchdogs
[57.097174]   /dev/watchdog0
[57.110871] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.115208] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.117348] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.120731] [001/132] (960s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[57.243338] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[57.247728] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[57.327773] [002/132] (960s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[57.419696] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[58.106473] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.702s)
[58.277175] [003/132] (959s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[58.368865] Starting subtest: compare-crc-sanitycheck-xr24
[58.371242] Starting dynamic subtest: pipe-A-eDP-1
[58.976547] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.619s)
[58.985765] Starting dynamic subtest: pipe-B-eDP-1
[60.256310] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.295s)
[60.264749] Starting dynamic subtest: pipe-C-eDP-1
[61.425170] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.183s)
[61.434404] Starting dynamic subtest: pipe-D-eDP-1
[62.687899] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.275s)
[62.690281] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.375s)
[63.488026] [004/132] (954s left) gem_lmem_swapping (heavy-random)
[63.533360] Subtest heavy-random: SKIP (0.000s)
[63.570127] [005/132] (954s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[63.662767] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[67.389078] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.753s)
[68.560596] [006/132] (949s left) kms_color (legacy-gamma-reset)
[68.661118] Starting subtest: legacy-gamma-reset
[68.663142] Starting dynamic subtest: pipe-A-eDP-1
[69.044346] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.387s)
[69.053294] Starting dynamic subtest: pipe-B-eDP-1
[69.058151] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s)
[69.065297] Starting dynamic subtest: pipe-C-eDP-1
[69.069771] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.013s)
[69.076689] Starting dynamic subtest: pipe-D-eDP-1
[69.081525] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s)
[69.083696] Subtest legacy-gamma-reset: SUCCESS (0.424s)
[69.880372] [007/132] (947s left) gem_tiled_fence_blits (basic)
[69.930903] Subtest basic: SKIP (0.000s)
[69.996033] [008/132] (947s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[70.098951] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[70.101399] Starting dynamic subtest: pipe-A-default-mode
[72.805537] Dynamic subtest pipe-A-default-mode: SUCCESS (2.713s)
[72.807877] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.714s)
[73.662707] [009/132] (944s left) gem_mmap_gtt (basic-read-write-distinct)
[73.716378] Subtest basic-read-write-distinct: SKIP (0.000s)
[73.772234] [010/132] (944s left) gem_exec_reloc (basic-write-wc-active)
[73.837583] Subtest basic-write-wc-active: SKIP (0.000s)
[73.915172] [011/132] (944s left) kms_chamelium_edid (dp-mode-timings)
[74.299036] Subtest dp-mode-timings: SKIP (0.000s)
[75.068611] [012/132] (942s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[75.170958] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[75.175298] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[75.279676] [013/132] (942s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[75.378310] Starting subtest: fbc-modesetfrombusy
[79.151742] Subtest fbc-modesetfrombusy: SUCCESS (3.782s)
[80.319669] [014/132] (937s left) gem_exec_flush (basic-wb-rw-default)
[80.372339] Starting subtest: basic-wb-rw-default
[85.852410] Subtest basic-wb-rw-default: SUCCESS (5.448s)
[86.013845] [015/132] (932s left) i915_suspend (basic-s2idle-without-i915)
[86.053349] Starting subtest: basic-s2idle-without-i915
[106.732530] Subtest basic-s2idle-without-i915: SUCCESS (5.688s)
[106.841751] [016/132] (911s left) gen7_exec_parse (load-register-reg)
[106.910131] Subtest load-register-reg: SKIP (0.000s)
[106.972683] [017/132] (911s left) kms_getfb (getfb-addfb-different-handles)
[107.067600] Starting subtest: getfb-addfb-different-handles
[107.069674] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[107.178965] [018/132] (911s left) kms_content_protection (srm)
[107.320151] Starting subtest: srm
[107.327165] Subtest srm: SKIP (0.003s)
[107.439386] [019/132] (910s left) kms_draw_crc (draw-method-mmap-wc)
[107.533815] Starting subtest: draw-method-mmap-wc
[107.535699] Starting dynamic subtest: xrgb8888-untiled
[107.768356] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s)
[107.778094] Starting dynamic subtest: rgb565-untiled
[107.963295] Dynamic subtest rgb565-untiled: SUCCESS (0.200s)
[107.972264] Starting dynamic subtest: xrgb2101010-untiled
[108.168890] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.211s)
[108.176569] Starting dynamic subtest: xbgr16161616f-untiled
[108.363577] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.200s)
[108.371573] Starting dynamic subtest: xrgb8888-xtiled
[108.504413] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.144s)
[108.518673] Starting dynamic subtest: rgb565-xtiled
[108.623361] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[108.632050] Starting dynamic subtest: xrgb2101010-xtiled
[108.743012] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[108.755240] Starting dynamic subtest: xbgr16161616f-xtiled
[108.873302] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[108.881354] Starting dynamic subtest: xrgb8888-4tiled
[109.025321] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s)
[109.033821] Starting dynamic subtest: rgb565-4tiled
[109.166680] Dynamic subtest rgb565-4tiled: SUCCESS (0.143s)
[109.174050] Starting dynamic subtest: xrgb2101010-4tiled
[109.317884] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.155s)
[109.325773] Starting dynamic subtest: xbgr16161616f-4tiled
[109.480889] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.166s)
[109.482745] Subtest draw-method-mmap-wc: SUCCESS (2.001s)
[109.582626] [020/132] (908s left) gem_ctx_shared (exec-single-timeline)
[109.655169] Starting subtest: exec-single-timeline
[109.657062] Starting dynamic subtest: rcs0
[110.699559] Dynamic subtest rcs0: SUCCESS (1.063s)
[110.711039] Starting dynamic subtest: bcs0
[111.786128] Dynamic subtest bcs0: SUCCESS (1.104s)
[111.800704] Starting dynamic subtest: vcs0
[112.874821] Dynamic subtest vcs0: SUCCESS (1.103s)
[112.886004] Starting dynamic subtest: vcs1
[113.964110] Dynamic subtest vcs1: SUCCESS (1.101s)
[113.975299] Starting dynamic subtest: vecs0
[115.050676] Dynamic subtest vecs0: SUCCESS (1.097s)
[115.061574] Starting dynamic subtest: ccs0
[116.138506] Dynamic subtest ccs0: SUCCESS (1.097s)
[116.141381] Subtest exec-single-timeline: SUCCESS (6.578s)
[116.327443] [021/132] (902s left) kms_psr (psr2-sprite-mmap-cpu)
[116.439756] Starting subtest: psr2-sprite-mmap-cpu
[116.442095] Starting dynamic subtest: eDP-1
[118.157581] Dynamic subtest eDP-1: SUCCESS (1.730s)
[118.159668] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.731s)
[119.021601] [022/132] (899s left) kms_hdr (static-swap)
[119.115105] Starting subtest: static-swap
[119.121892] Subtest static-swap: SKIP (0.000s)
[119.185327] [023/132] (899s left) api_intel_allocator (execbuf-with-allocator)
[119.234593] Starting subtest: execbuf-with-allocator
[119.238766] Subtest execbuf-with-allocator: SUCCESS (0.006s)
[119.318994] [024/132] (899s left) gem_mmap_gtt (hang)
[119.376389] Subtest hang: SKIP (0.000s)
[119.432663] [025/132] (899s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[119.519002] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[119.521324] Starting dynamic subtest: pipe-A-eDP-1
[119.546321] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[119.557212] Starting dynamic subtest: pipe-B-eDP-1
[119.580563] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[119.588945] Starting dynamic subtest: pipe-C-eDP-1
[119.612621] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[119.620369] Starting dynamic subtest: pipe-D-eDP-1
[119.644250] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[119.648610] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[121.786410] [026/132] (896s left) gem_exec_reloc (basic-scanout)
[121.853674] Subtest basic-scanout: SKIP (0.000s)
[121.935450] [027/132] (896s left) kms_vrr (flip-basic-fastset)
[122.038108] Starting subtest: flip-basic-fastset
[122.044678] Subtest flip-basic-fastset: SKIP (0.000s)
[122.118077] [028/132] (896s left) kms_psr (fbc-pr-no-drrs)
[122.203923] Starting subtest: fbc-pr-no-drrs
[122.208375] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[122.273303] [029/132] (896s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[122.321585] Starting subtest: etime-single-wait-all-for-submit-submitted
[122.426906] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.105s)
[122.499385] [030/132] (896s left) gem_exec_create (basic)
[122.555612] Starting subtest: basic
[122.557991] Starting dynamic subtest: smem
[126.287339] Dynamic subtest smem: SUCCESS (3.743s)
[126.289904] Subtest basic: SUCCESS (3.744s)
[126.467734] [031/132] (892s left) gem_mmap_gtt (cpuset-big-copy-xy)
[126.531235] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[126.586124] [032/132] (892s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[126.687308] Starting subtest: psr-farfromfence-mmap-gtt
[126.691728] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[126.785201] [033/132] (892s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[126.877399] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[126.881851] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[126.985509] [034/132] (891s left) kms_pm_rpm (pm-caching)
[128.499144] Starting subtest: pm-caching
[128.505618] Subtest pm-caching: SKIP (0.000s)
[129.297079] [035/132] (889s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[129.399825] Starting subtest: x-tiled-16bpp-rotate-0
[130.642355] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.245s)
[130.775897] [036/132] (888s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[130.872977] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[134.928172] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.063s)
[136.064994] [037/132] (882s left) gem_create (busy-create)
[136.130871] Starting subtest: busy-create
[136.133320] Starting dynamic subtest: smem0
[169.233000] Dynamic subtest smem0: SUCCESS (33.111s)
[169.235686] Subtest busy-create: SUCCESS (33.113s)
[169.419135] [038/132] (849s left) i915_drm_fdinfo (memory-info-shared)
[169.456460] Starting subtest: memory-info-shared
[169.458976] Starting dynamic subtest: smem0
[169.504954] Dynamic subtest smem0: SUCCESS (0.049s)
[169.507864] Subtest memory-info-shared: SUCCESS (0.050s)
[169.580772] [039/132] (849s left) kms_plane_scaling (intel-max-src-size)
[169.667593] Starting subtest: intel-max-src-size
[169.674124] Subtest intel-max-src-size: SKIP (0.000s)
[169.761378] [040/132] (849s left) api_intel_bb (object-reloc-purge-cache)
[169.812306] Starting subtest: object-reloc-purge-cache
[169.819888] Subtest object-reloc-purge-cache: SKIP (0.004s)
[169.931450] [041/132] (849s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[169.991682] Starting subtest: multi-wait-all-for-submit-available-signaled
[169.994086] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[170.090681] [042/132] (849s left) kms_atomic_transition (plane-all-transition-nonblocking)
[170.186689] Starting subtest: plane-all-transition-nonblocking
[170.188989] Starting dynamic subtest: pipe-A-eDP-1
[172.679672] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[172.996094] Starting dynamic subtest: pipe-B-eDP-1
[176.197854] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.212s)
[176.508958] Subtest plane-all-transition-nonblocking: SUCCESS (6.325s)
[177.318242] [043/132] (841s left) perf (i915-ref-count)
[177.389156] Starting subtest: i915-ref-count
[177.501720] Subtest i915-ref-count: SUCCESS (0.111s)
[177.559418] [044/132] (841s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[177.655019] Starting subtest: primary-yf-tiled-reflect-x-270
[177.659461] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[177.726537] [045/132] (841s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[177.821550] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[177.823811] Starting dynamic subtest: pipe-A-eDP-1
[177.845173] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[177.854403] Starting dynamic subtest: pipe-B-eDP-1
[177.874965] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[177.883396] Starting dynamic subtest: pipe-C-eDP-1
[177.905274] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[177.914884] Starting dynamic subtest: pipe-D-eDP-1
[177.936850] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[177.940851] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[180.089972] [046/132] (839s left) gem_exec_params (sol-reset-invalid)
[180.171986] Starting subtest: sol-reset-invalid
[180.177783] Subtest sol-reset-invalid: SUCCESS (0.005s)
[182.322282] [047/132] (837s left) gem_vm_create (invalid-destroy)
[182.394203] Starting subtest: invalid-destroy
[182.396551] Subtest invalid-destroy: SUCCESS (0.002s)
[182.511444] [048/132] (836s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[184.448168] Starting subtest: gem-execbuf-stress-pc8
[184.489377] Subtest gem-execbuf-stress-pc8: SKIP (0.044s)
[184.819969] [049/132] (834s left) gem_ctx_persistence (saturated-hostile)
[184.890217] Starting subtest: saturated-hostile
[184.892611] Starting dynamic subtest: rcs0
[185.714129] Dynamic subtest rcs0: SUCCESS (0.823s)
[185.726084] Starting dynamic subtest: bcs0
[186.509634] Dynamic subtest bcs0: SUCCESS (0.794s)
[186.522233] Starting dynamic subtest: vcs0
[187.297037] Dynamic subtest vcs0: SUCCESS (0.786s)
[187.308867] Starting dynamic subtest: vcs1
[188.096540] Dynamic subtest vcs1: SUCCESS (0.798s)
[188.108322] Starting dynamic subtest: vecs0
[188.909167] Dynamic subtest vecs0: SUCCESS (0.811s)
[188.921731] Starting dynamic subtest: ccs0
[189.743551] Dynamic subtest ccs0: SUCCESS (0.833s)
[189.746613] Subtest saturated-hostile: SUCCESS (4.857s)
[189.892271] [050/132] (829s left) gem_exec_fence (concurrent)
[190.075611] Starting subtest: concurrent
[190.080232] Subtest concurrent: SKIP (0.000s)
[192.351535] [FACT gem_exec_fence (concurrent)] new: kernel.kmod_is_loaded.vgem: true
[192.355598] [051/132] (827s left) gem_fenced_exec_thrash (too-many-fences)
[192.423015] Subtest too-many-fences: SKIP (0.000s)
[192.493303] [052/132] (827s left) kms_rotation_crc (exhaust-fences)
[192.592708] Starting subtest: exhaust-fences
[192.596866] Subtest exhaust-fences: SKIP (0.000s)
[192.662482] [053/132] (826s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[192.755510] Starting subtest: y-tiled-16bpp-rotate-180
[192.759900] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[192.851990] [054/132] (826s left) gem_sync (basic-store-all)
[192.921470] Starting subtest: basic-store-all
[195.177127] Subtest basic-store-all: SUCCESS (2.267s)
[195.362095] [055/132] (824s left) prime_self_import (basic-with_one_bo_two_files)
[195.410004] Starting subtest: basic-with_one_bo_two_files
[195.439406] Subtest basic-with_one_bo_two_files: SUCCESS (0.030s)
[195.545261] [056/132] (824s left) gem_close_race (basic-process)
[195.610823] Starting subtest: basic-process
[195.661500] Subtest basic-process: SUCCESS (0.051s)
[195.861250] [057/132] (823s left) gem_softpin (allocator-basic-reserve)
[195.919009] Starting subtest: allocator-basic-reserve
[196.012627] Subtest allocator-basic-reserve: SUCCESS (0.092s)
[196.144035] [058/132] (823s left) kms_async_flips (async-flip-dpms)
[196.240810] Starting subtest: async-flip-dpms
[196.613118] Starting dynamic subtest: pipe-A-eDP-1
[200.446567] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.834s)
[200.843400] Starting dynamic subtest: pipe-B-eDP-1
[203.608466] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.770s)
[203.986071] Starting dynamic subtest: pipe-C-eDP-1
[206.783586] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.803s)
[207.161749] Starting dynamic subtest: pipe-D-eDP-1
[209.964728] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.810s)
[209.967128] Subtest async-flip-dpms: SUCCESS (13.724s)
[211.165805] [059/132] (808s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[211.263020] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[211.267397] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[211.354234] [060/132] (808s left) kms_plane_cursor (primary)
[211.450737] Starting subtest: primary
[211.455077] Starting dynamic subtest: pipe-A-eDP-1-size-64
[214.025696] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.574s)
[214.049781] Starting dynamic subtest: pipe-A-eDP-1-size-128
[216.593268] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.549s)
[216.618232] Starting dynamic subtest: pipe-A-eDP-1-size-256
[219.162947] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.549s)
[219.480023] Starting dynamic subtest: pipe-B-eDP-1-size-64
[222.762956] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.293s)
[222.787476] Starting dynamic subtest: pipe-B-eDP-1-size-128
[225.374084] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.594s)
[225.399546] Starting dynamic subtest: pipe-B-eDP-1-size-256
[227.998834] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.605s)
[228.316268] Starting dynamic subtest: pipe-C-eDP-1-size-64
[231.212073] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.906s)
[231.238884] Starting dynamic subtest: pipe-C-eDP-1-size-128
[233.433373] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.203s)
[233.460628] Starting dynamic subtest: pipe-C-eDP-1-size-256
[235.634279] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.181s)
[235.963572] Starting dynamic subtest: pipe-D-eDP-1-size-64
[238.874449] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.931s)
[238.901487] Starting dynamic subtest: pipe-D-eDP-1-size-128
[241.075095] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.180s)
[241.101833] Starting dynamic subtest: pipe-D-eDP-1-size-256
[243.241233] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.148s)
[243.556232] Subtest primary: SUCCESS (32.101s)
[244.402167] [061/132] (775s left) kms_cursor_legacy (torture-move)
[244.507030] Starting subtest: torture-move
[244.509402] Starting dynamic subtest: pipe-A
[250.871099] Dynamic subtest pipe-A: SUCCESS (6.309s)
[250.881089] Starting dynamic subtest: pipe-B
[257.377154] Dynamic subtest pipe-B: SUCCESS (6.557s)
[257.400572] Starting dynamic subtest: pipe-C
[263.924716] Dynamic subtest pipe-C: SUCCESS (6.546s)
[263.935022] Starting dynamic subtest: pipe-D
[270.744424] Dynamic subtest pipe-D: SUCCESS (6.820s)
[270.757670] Starting dynamic subtest: all-pipes
[276.861008] Dynamic subtest all-pipes: SUCCESS (6.114s)
[276.863422] Subtest torture-move: SUCCESS (32.356s)
[277.018087] [062/132] (742s left) perf (invalid-open-flags)
[277.102435] Starting subtest: invalid-open-flags
[277.104985] Subtest invalid-open-flags: SUCCESS (0.000s)
[277.147376] [063/132] (742s left) gem_exec_schedule (lateslice)
[277.221850] Starting subtest: lateslice
[277.223778] Starting dynamic subtest: rcs0
[277.232009] Dynamic subtest rcs0: SUCCESS (0.018s)
[277.243073] Starting dynamic subtest: bcs0
[277.248980] Dynamic subtest bcs0: SUCCESS (0.016s)
[277.258043] Starting dynamic subtest: vcs0
[277.266898] Dynamic subtest vcs0: SUCCESS (0.017s)
[277.275410] Starting dynamic subtest: vcs1
[277.285772] Dynamic subtest vcs1: SUCCESS (0.018s)
[277.294307] Starting dynamic subtest: vecs0
[277.305402] Dynamic subtest vecs0: SUCCESS (0.019s)
[277.313899] Starting dynamic subtest: ccs0
[277.324048] Dynamic subtest ccs0: SUCCESS (0.018s)
[277.326388] Subtest lateslice: SUCCESS (0.111s)
[279.382392] [064/132] (740s left) gem_mmap_offset (bad-extensions)
[279.436694] Starting subtest: bad-extensions
[279.439143] Subtest bad-extensions: SUCCESS (0.000s)
[279.541309] [065/132] (740s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[279.640417] Starting subtest: fbcpsr-stridechange
[285.792101] Subtest fbcpsr-stridechange: SUCCESS (6.157s)
[285.928009] [066/132] (734s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[286.027845] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[292.719965] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.701s)
[292.857893] [067/132] (727s left) kms_flip_event_leak (basic)
[292.941782] Starting subtest: basic
[292.943918] Starting dynamic subtest: pipe-A-eDP-1
[293.362241] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.419s)
[293.371785] Starting dynamic subtest: pipe-B-eDP-1
[294.458455] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.097s)
[294.467519] Starting dynamic subtest: pipe-C-eDP-1
[295.563062] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.102s)
[295.571889] Starting dynamic subtest: pipe-D-eDP-1
[296.692229] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.128s)
[296.694519] Subtest basic: SUCCESS (3.752s)
[297.561438] [068/132] (722s left) kms_big_fb (linear-16bpp-rotate-270)
[297.667885] Starting subtest: linear-16bpp-rotate-270
[297.687382] Subtest linear-16bpp-rotate-270: SKIP (0.019s)
[297.788732] [069/132] (722s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[297.904846] Starting subtest: 4-tiled-8bpp-rotate-0
[299.096650] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.194s)
[299.250247] [070/132] (721s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[299.340156] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[299.343711] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[299.448759] [071/132] (720s left) kms_sequence (get-idle)
[299.530520] Starting subtest: get-idle
[299.532308] Starting dynamic subtest: pipe-A-eDP-1
[301.331313] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.802s)
[301.341140] Starting dynamic subtest: pipe-B-eDP-1
[303.831009] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.499s)
[303.842046] Starting dynamic subtest: pipe-C-eDP-1
[306.242536] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.412s)
[306.252676] Starting dynamic subtest: pipe-D-eDP-1
[308.680219] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.438s)
[308.682574] Subtest get-idle: SUCCESS (9.155s)
[309.507575] [072/132] (710s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[309.896339] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[310.698234] [073/132] (709s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[310.797716] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[310.801883] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[310.903231] [074/132] (709s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[310.970035] Subtest tiled-to-untiled: SKIP (0.000s)
[311.041682] [075/132] (709s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[311.136468] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[311.140830] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[311.238201] [076/132] (709s left) gem_exec_schedule (submit-golden-slice)
[311.312536] Starting subtest: submit-golden-slice
[311.314789] Starting dynamic subtest: rcs0
[311.339912] Dynamic subtest rcs0: SUCCESS (0.034s)
[311.351091] Starting dynamic subtest: bcs0
[311.367694] Dynamic subtest bcs0: SUCCESS (0.027s)
[311.376496] Starting dynamic subtest: vcs0
[311.406456] Dynamic subtest vcs0: SUCCESS (0.037s)
[311.417460] Starting dynamic subtest: vcs1
[311.444169] Dynamic subtest vcs1: SUCCESS (0.037s)
[311.453358] Starting dynamic subtest: vecs0
[311.476073] Dynamic subtest vecs0: SUCCESS (0.031s)
[311.484932] Starting dynamic subtest: ccs0
[311.508764] Dynamic subtest ccs0: SUCCESS (0.032s)
[311.511099] Subtest submit-golden-slice: SUCCESS (0.204s)
[313.379930] [077/132] (707s left) syncobj_timeline (wait-for-submit-complex)
[313.448542] Starting subtest: wait-for-submit-complex
[313.509142] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[313.598700] [078/132] (707s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[313.706875] Starting subtest: yf-tiled-64bpp-rotate-180
[313.711353] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[313.786895] [079/132] (706s left) kms_rotation_crc (multiplane-rotation)
[313.873906] Starting subtest: multiplane-rotation
[331.238088] Subtest multiplane-rotation: SUCCESS (17.371s)
[331.342828] [080/132] (689s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[331.448678] Starting subtest: fbc-psr2-cursor-plane-update-sf
[331.450681] Starting dynamic subtest: pipe-A-eDP-1
[331.524082] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s)
[331.538961] Starting dynamic subtest: pipe-B-eDP-1
[332.687518] Dynamic subtest pipe-B-eDP-1: SKIP (1.159s)
[332.692179] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.241s)
[333.908814] [081/132] (686s left) gem_exec_balancer (individual)
[333.980896] Starting subtest: individual
[335.311670] Subtest individual: SUCCESS (1.328s)
[335.618621] [082/132] (685s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[335.715690] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[335.720200] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[335.817364] [083/132] (685s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[335.916963] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[335.921253] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[337.027606] [084/132] (683s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[337.138478] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[337.142682] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[337.234818] [085/132] (683s left) gem_pxp (regular-baseline-src-copy-readible)
[337.355849] Starting subtest: regular-baseline-src-copy-readible
[337.412766] Subtest regular-baseline-src-copy-readible: SUCCESS (0.060s)
[337.542240] [086/132] (683s left) gem_readwrite (read-bad-handle)
[337.597698] Subtest read-bad-handle: SKIP (0.000s)
[337.657063] [087/132] (683s left) kms_cursor_edge_walk (128x128-right-edge)
[337.751911] Starting subtest: 128x128-right-edge
[337.754167] Starting dynamic subtest: pipe-A-eDP-1
[341.191308] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.438s)
[341.201223] Starting dynamic subtest: pipe-D-eDP-1
[344.308206] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.114s)
[344.310412] Subtest 128x128-right-edge: SUCCESS (6.555s)
[345.142269] [088/132] (675s left) i915_module_load (reload-no-display)
[345.186652] Starting subtest: reload-no-display
[351.084330] Subtest reload-no-display: SUCCESS (5.899s)
[351.110695] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[351.111624] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[351.115114] [089/132] (669s left) gem_ctx_persistence (engines-hostile-preempt)
[352.655263] Starting subtest: engines-hostile-preempt
[352.657453] Starting dynamic subtest: rcs0
[352.776841] Dynamic subtest rcs0: SUCCESS (0.123s)
[352.789874] Starting dynamic subtest: bcs0
[352.822425] Dynamic subtest bcs0: SUCCESS (0.044s)
[352.832889] Starting dynamic subtest: vcs0
[354.317741] Dynamic subtest vcs0: SUCCESS (1.491s)
[354.329671] Starting dynamic subtest: vcs1
[356.276570] Dynamic subtest vcs1: SUCCESS (1.955s)
[356.291825] Starting dynamic subtest: vecs0
[358.277039] Dynamic subtest vecs0: SUCCESS (1.998s)
[358.289235] Starting dynamic subtest: ccs0
[358.342608] Dynamic subtest ccs0: SUCCESS (0.064s)
[358.345372] Subtest engines-hostile-preempt: SUCCESS (5.690s)
[358.391113] [FACT gem_ctx_persistence (engines-hostile-preempt)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[358.392283] [FACT gem_ctx_persistence (engines-hostile-preempt)] new: kernel.kmod_is_loaded.i915: true
[358.396307] [090/132] (662s left) kms_psr (fbc-psr2-sprite-blt)
[358.504720] Starting subtest: fbc-psr2-sprite-blt
[358.506896] Starting dynamic subtest: eDP-1
[358.510867] Dynamic subtest eDP-1: SKIP (0.000s)
[358.514846] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[358.575836] [091/132] (662s left) kms_cursor_crc (cursor-onscreen-512x170)
[358.885923] Starting subtest: cursor-onscreen-512x170
[358.890289] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[359.017696] [092/132] (662s left) gem_exec_schedule (u-submit-late-slice)
[359.101001] Starting subtest: u-submit-late-slice
[359.103432] Starting dynamic subtest: rcs0
[359.131480] Dynamic subtest rcs0: SUCCESS (0.037s)
[359.142602] Starting dynamic subtest: bcs0
[359.159117] Dynamic subtest bcs0: SUCCESS (0.027s)
[359.169724] Starting dynamic subtest: vcs0
[359.193177] Dynamic subtest vcs0: SUCCESS (0.033s)
[359.205882] Starting dynamic subtest: vcs1
[359.219958] Dynamic subtest vcs1: SUCCESS (0.026s)
[359.232627] Starting dynamic subtest: vecs0
[359.246583] Dynamic subtest vecs0: SUCCESS (0.026s)
[359.255698] Starting dynamic subtest: ccs0
[359.280534] Dynamic subtest ccs0: SUCCESS (0.033s)
[359.282855] Subtest u-submit-late-slice: SUCCESS (0.187s)
[360.367230] [093/132] (660s left) gem_basic (create-fd-close)
[360.426870] Starting subtest: create-fd-close
[360.431086] Subtest create-fd-close: SUCCESS (0.000s)
[360.525999] [094/132] (660s left) perf_pmu (busy-double-start)
[360.575436] Starting subtest: busy-double-start
[360.577729] Starting dynamic subtest: rcs0
[364.219210] Dynamic subtest rcs0: FAIL (3.583s)
[364.231432] Starting dynamic subtest: bcs0
[367.725679] Dynamic subtest bcs0: SUCCESS (3.566s)
[367.735900] Starting dynamic subtest: vcs0
[371.807491] Dynamic subtest vcs0: SUCCESS (4.080s)
[371.818577] Starting dynamic subtest: vcs1
[375.838517] Dynamic subtest vcs1: SUCCESS (4.029s)
[375.850042] Starting dynamic subtest: vecs0
[379.787707] Dynamic subtest vecs0: SUCCESS (3.947s)
[379.798071] Starting dynamic subtest: ccs0
[383.423366] Dynamic subtest ccs0: FAIL (3.565s)
[383.425448] Subtest busy-double-start: FAIL (22.782s)
[383.466374] [095/132] (637s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[383.584877] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[383.589152] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[383.687202] [096/132] (637s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[383.797860] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[383.801987] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[383.900098] [097/132] (637s left) kms_psr (pr-sprite-mmap-gtt)
[383.990002] Starting subtest: pr-sprite-mmap-gtt
[383.994504] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[384.062337] [098/132] (637s left) syncobj_basic (bad-fd-to-handle)
[384.123506] Starting subtest: bad-fd-to-handle
[384.125967] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[384.227168] [099/132] (637s left) drm_mm (drm_mm)
[384.261899] Starting subtest: drm_mm
[384.275741] Starting dynamic subtest: drm_test_mm_init
[384.373574] Dynamic subtest drm_test_mm_init: SUCCESS (0.099s)
[384.382305] Starting dynamic subtest: drm_test_mm_debug
[384.468156] Dynamic subtest drm_test_mm_debug: SUCCESS (0.091s)
[384.477680] Starting dynamic subtest: drm_test_mm_align32
[384.565997] Dynamic subtest drm_test_mm_align32: SUCCESS (0.098s)
[384.575655] Starting dynamic subtest: drm_test_mm_align64
[384.665318] Dynamic subtest drm_test_mm_align64: SUCCESS (0.100s)
[384.673601] Starting dynamic subtest: drm_test_mm_lowest
[384.756866] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.088s)
[384.765260] Starting dynamic subtest: drm_test_mm_highest
[384.851141] Dynamic subtest drm_test_mm_highest: SUCCESS (0.094s)
[384.853028] Subtest drm_mm: SUCCESS (0.589s)
[385.023404] [100/132] (636s left) kms_flip (blocking-wf_vblank)
[385.112931] Starting subtest: blocking-wf_vblank
[385.114817] Starting dynamic subtest: A-eDP1
[394.083032] Dynamic subtest A-eDP1: SUCCESS (8.937s)
[394.094769] Starting dynamic subtest: B-eDP1
[403.010580] Dynamic subtest B-eDP1: SUCCESS (8.927s)
[403.019700] Starting dynamic subtest: C-eDP1
[411.950493] Dynamic subtest C-eDP1: SUCCESS (8.924s)
[411.966122] Starting dynamic subtest: D-eDP1
[420.887785] Dynamic subtest D-eDP1: SUCCESS (8.933s)
[420.890580] Subtest blocking-wf_vblank: SUCCESS (35.737s)
[422.062660] [101/132] (599s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[422.153193] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[422.155394] Starting dynamic subtest: pipe-A-eDP-1
[422.922905] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.762s)
[422.932853] Starting dynamic subtest: pipe-B-eDP-1
[424.679083] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.756s)
[424.688675] Starting dynamic subtest: pipe-C-eDP-1
[426.501777] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.822s)
[426.511609] Starting dynamic subtest: pipe-D-eDP-1
[428.326727] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.823s)
[428.328665] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.169s)
[429.492521] [102/132] (592s left) gem_ccs (block-multicopy-inplace)
[429.553619] Starting subtest: block-multicopy-inplace
[429.557659] Subtest block-multicopy-inplace: SKIP (0.000s)
[429.654027] [103/132] (592s left) gem_partial_pwrite_pread (write)
[429.708370] Subtest write: SKIP (0.000s)
[429.791657] [104/132] (591s left) gen3_render_mixed_blits
[429.906502] [105/132] (591s left) gem_mmap (basic-small-bo)
[429.967304] Subtest basic-small-bo: SKIP (0.000s)
[430.025066] [106/132] (591s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[430.118471] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[430.122571] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[430.218317] [107/132] (591s left) kms_atomic_transition (plane-toggle-modeset-transition)
[430.312879] Starting subtest: plane-toggle-modeset-transition
[430.314757] Starting dynamic subtest: pipe-A-eDP-1
[442.986637] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.675s)
[442.998546] Starting dynamic subtest: pipe-B-eDP-1
[455.411353] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.422s)
[455.413712] Subtest plane-toggle-modeset-transition: SUCCESS (25.103s)
[456.231695] [108/132] (565s left) kms_psr (fbc-psr-primary-blt)
[456.327892] Starting subtest: fbc-psr-primary-blt
[456.330114] Starting dynamic subtest: eDP-1
[456.334074] Dynamic subtest eDP-1: SKIP (0.000s)
[456.338072] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[456.405286] [109/132] (565s left) syncobj_timeline (single-wait-for-submit-signaled)
[456.457619] Starting subtest: single-wait-for-submit-signaled
[456.459536] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[456.553227] [110/132] (565s left) gem_partial_pwrite_pread (writes-after-reads)
[456.597819] Subtest writes-after-reads: SKIP (0.000s)
[456.671175] [111/132] (565s left) kms_rmfb (rmfb-ioctl)
[456.752774] Starting subtest: rmfb-ioctl
[456.755152] Starting dynamic subtest: pipe-A-eDP-1
[456.856224] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.105s)
[456.867822] Starting dynamic subtest: pipe-B-eDP-1
[457.996200] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.138s)
[458.007644] Starting dynamic subtest: pipe-C-eDP-1
[459.128074] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.130s)
[459.142909] Starting dynamic subtest: pipe-D-eDP-1
[460.356923] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.226s)
[460.359131] Subtest rmfb-ioctl: SUCCESS (3.608s)
[461.488787] [112/132] (560s left) perf_pmu (semaphore-wait-idle)
[461.525586] Starting subtest: semaphore-wait-idle
[461.528070] Starting dynamic subtest: rcs0
[462.039239] Dynamic subtest rcs0: SUCCESS (0.513s)
[462.050177] Starting dynamic subtest: bcs0
[462.552414] Dynamic subtest bcs0: SUCCESS (0.510s)
[462.563841] Starting dynamic subtest: vcs0
[463.065367] Dynamic subtest vcs0: SUCCESS (0.510s)
[463.077081] Starting dynamic subtest: vcs1
[463.577522] Dynamic subtest vcs1: SUCCESS (0.510s)
[463.588113] Starting dynamic subtest: vecs0
[464.090465] Dynamic subtest vecs0: SUCCESS (0.510s)
[464.100601] Starting dynamic subtest: ccs0
[464.606409] Dynamic subtest ccs0: SUCCESS (0.512s)
[464.609604] Subtest semaphore-wait-idle: SUCCESS (3.082s)
[464.733505] [113/132] (557s left) gem_exec_fence (submit)
[464.906964] Starting subtest: submit
[464.911243] Subtest submit: SKIP (0.000s)
[466.371224] [114/132] (555s left) gem_exec_reloc (basic-write-gtt-active)
[466.436051] Subtest basic-write-gtt-active: SKIP (0.000s)
[466.503877] [115/132] (555s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[466.614191] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[473.922168] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.312s)
[474.061261] [116/132] (548s left) kms_atomic_transition (modeset-transition-nonblocking)
[474.178120] Starting subtest: modeset-transition-nonblocking
[474.180355] Starting dynamic subtest: 1x-outputs
[485.243334] Dynamic subtest 1x-outputs: SUCCESS (11.069s)
[485.245934] Subtest modeset-transition-nonblocking: SUCCESS (11.070s)
[486.144456] [117/132] (536s left) kms_pm_backlight (brightness-with-dpms)
[486.235554] Starting subtest: brightness-with-dpms
[486.285526] Starting dynamic subtest: eDP-1
[489.019438] Dynamic subtest eDP-1: SUCCESS (2.735s)
[489.021902] Subtest brightness-with-dpms: SUCCESS (2.783s)
[489.876139] [118/132] (532s left) kms_lease (lease-invalid-plane)
[489.972001] Starting subtest: lease-invalid-plane
[489.974290] Starting dynamic subtest: pipe-A-eDP-1
[489.976525] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[489.985709] Starting dynamic subtest: pipe-B-eDP-1
[489.988079] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[489.996883] Starting dynamic subtest: pipe-C-eDP-1
[489.999136] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[490.007647] Starting dynamic subtest: pipe-D-eDP-1
[490.009547] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[490.011460] Subtest lease-invalid-plane: SUCCESS (0.004s)
[490.048470] [119/132] (532s left) gem_flink_basic (double-flink)
[490.101606] Starting subtest: double-flink
[490.103921] Subtest double-flink: SUCCESS (0.000s)
[490.202681] [120/132] (532s left) perf_pmu (event-wait)
[490.244058] Starting subtest: event-wait
[490.246069] Starting dynamic subtest: rcs0
[490.250629] Dynamic subtest rcs0: SKIP (0.000s)
[490.255084] Subtest event-wait: SKIP (0.001s)
[490.333745] [121/132] (532s left) gem_pxp (display-protected-crc)
[490.449574] Starting subtest: display-protected-crc
[492.076888] Subtest display-protected-crc: SUCCESS (1.631s)
[492.199082] [122/132] (530s left) kms_plane_scaling (planes-downscale-factor-0-75)
[492.290754] Starting subtest: planes-downscale-factor-0-75
[492.293127] Starting dynamic subtest: pipe-A
[492.315445] Dynamic subtest pipe-A: SKIP (0.018s)
[492.325445] Starting dynamic subtest: pipe-B
[492.343258] Dynamic subtest pipe-B: SKIP (0.030s)
[492.353154] Starting dynamic subtest: pipe-C
[492.374413] Dynamic subtest pipe-C: SKIP (0.030s)
[492.383775] Starting dynamic subtest: pipe-D
[492.405380] Dynamic subtest pipe-D: SKIP (0.030s)
[492.409415] Subtest planes-downscale-factor-0-75: SKIP (0.110s)
[492.501005] [123/132] (530s left) kms_properties (colorop-properties-atomic)
[492.591015] Starting subtest: colorop-properties-atomic
[492.593360] Starting dynamic subtest: pipe-A-eDP-1
[492.932708] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.341s)
[492.942354] Starting dynamic subtest: pipe-B-eDP-1
[494.025908] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.093s)
[494.036197] Starting dynamic subtest: pipe-C-eDP-1
[495.058480] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.033s)
[495.069105] Starting dynamic subtest: pipe-D-eDP-1
[496.089854] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.029s)
[496.091972] Subtest colorop-properties-atomic: SUCCESS (3.500s)
[496.897630] [124/132] (525s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[497.004581] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[501.399294] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.399s)
[502.589645] [125/132] (520s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[502.696476] Starting subtest: cursorA-vs-flipA-varying-size
[513.853389] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.158s)
[514.709405] [126/132] (507s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[514.808943] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[514.811252] Starting dynamic subtest: pipe-A-eDP-1
[514.820845] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[514.834410] Starting dynamic subtest: pipe-B-eDP-1
[514.843206] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[514.853096] Starting dynamic subtest: pipe-C-eDP-1
[514.861861] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[514.870517] Starting dynamic subtest: pipe-D-eDP-1
[514.879273] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[514.883566] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[517.081006] [127/132] (505s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[517.192432] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[517.196881] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[517.294284] [128/132] (505s left) gem_ringfill (basic-all)
[523.281899] Starting subtest: basic-all
[524.436968] Subtest basic-all: SUCCESS (1.155s)
[524.594283] [129/132] (498s left) gem_exec_reloc (basic-gtt-read-active)
[524.668359] Subtest basic-gtt-read-active: SKIP (0.000s)
[524.736824] [130/132] (498s left) syncobj_timeline (device-signal-unordered)
[524.786395] Starting subtest: device-signal-unordered
[524.788575] Subtest device-signal-unordered: SUCCESS (0.000s)
[524.904295] [131/132] (498s left) syncobj_timeline (multi-wait-all-signaled)
[524.954160] Starting subtest: multi-wait-all-signaled
[524.956392] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[525.068532] [132/132] (497s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[525.339852] Starting subtest: cursor-rapid-movement-256x85
[525.385127] Subtest cursor-rapid-movement-256x85: SKIP (0.041s)
[525.560598] Closing watchdogs
results: parsing output: 0/ for test: kms_plane
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: kms_pipe_crc_basic
results: parsing output: 3/ for test: gem_lmem_swapping
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_color
results: parsing output: 6/ for test: gem_tiled_fence_blits
results: parsing output: 7/ for test: kms_flip_scaled_crc
results: parsing output: 8/ for test: gem_mmap_gtt
results: parsing output: 9/ for test: gem_exec_reloc
results: parsing output: 10/ for test: kms_chamelium_edid
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: gem_exec_flush
results: parsing output: 14/ for test: i915_suspend
results: parsing output: 15/ for test: gen7_exec_parse
results: parsing output: 16/ for test: kms_getfb
results: parsing output: 17/ for test: kms_content_protection
results: parsing output: 18/ for test: kms_draw_crc
results: parsing output: 19/ for test: gem_ctx_shared
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_hdr
results: parsing output: 22/ for test: api_intel_allocator
results: parsing output: 23/ for test: gem_mmap_gtt
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: gem_exec_reloc
results: parsing output: 26/ for test: kms_vrr
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: gem_exec_create
results: parsing output: 30/ for test: gem_mmap_gtt
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_pm_rpm
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_create
results: parsing output: 37/ for test: i915_drm_fdinfo
results: parsing output: 38/ for test: kms_plane_scaling
results: parsing output: 39/ for test: api_intel_bb
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: kms_atomic_transition
results: parsing output: 42/ for test: perf
results: parsing output: 43/ for test: kms_rotation_crc
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: gem_exec_params
results: parsing output: 46/ for test: gem_vm_create
results: parsing output: 47/ for test: i915_pm_rpm
results: parsing output: 48/ for test: gem_ctx_persistence
results: parsing output: 49/ for test: gem_exec_fence
results: parsing output: 50/ for test: gem_fenced_exec_thrash
results: parsing output: 51/ for test: kms_rotation_crc
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: gem_sync
results: parsing output: 54/ for test: prime_self_import
results: parsing output: 55/ for test: gem_close_race
results: parsing output: 56/ for test: gem_softpin
results: parsing output: 57/ for test: kms_async_flips
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_plane_cursor
results: parsing output: 60/ for test: kms_cursor_legacy
results: parsing output: 61/ for test: perf
results: parsing output: 62/ for test: gem_exec_schedule
results: parsing output: 63/ for test: gem_mmap_offset
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_flip_event_leak
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_sequence
results: parsing output: 71/ for test: kms_chamelium_hpd
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_set_tiling_vs_blt
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_exec_schedule
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_rotation_crc
results: parsing output: 79/ for test: kms_psr2_sf
results: parsing output: 80/ for test: gem_exec_balancer
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_pxp
results: parsing output: 85/ for test: gem_readwrite
results: parsing output: 86/ for test: kms_cursor_edge_walk
results: parsing output: 87/ for test: i915_module_load
results: parsing output: 88/ for test: gem_ctx_persistence
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: kms_cursor_crc
results: parsing output: 91/ for test: gem_exec_schedule
results: parsing output: 92/ for test: gem_basic
results: parsing output: 93/ for test: perf_pmu
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: syncobj_basic
results: parsing output: 98/ for test: drm_mm
results: parsing output: 99/ for test: kms_flip
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: gem_ccs
results: parsing output: 102/ for test: gem_partial_pwrite_pread
results: parsing output: 103/ for test: gen3_render_mixed_blits
results: parsing output: 104/ for test: gem_mmap
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_atomic_transition
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: gem_partial_pwrite_pread
results: parsing output: 110/ for test: kms_rmfb
results: parsing output: 111/ for test: perf_pmu
results: parsing output: 112/ for test: gem_exec_fence
results: parsing output: 113/ for test: gem_exec_reloc
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_atomic_transition
results: parsing output: 116/ for test: kms_pm_backlight
results: parsing output: 117/ for test: kms_lease
results: parsing output: 118/ for test: gem_flink_basic
results: parsing output: 119/ for test: perf_pmu
results: parsing output: 120/ for test: gem_pxp
results: parsing output: 121/ for test: kms_plane_scaling
results: parsing output: 122/ for test: kms_properties
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_ringfill
results: parsing output: 128/ for test: gem_exec_reloc
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: syncobj_timeline
results: parsing output: 131/ for test: kms_cursor_crc
Done.