[56.775980] Initializing watchdogs
[56.776039]   /dev/watchdog0
[56.791034] [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]
[56.795358] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.797619] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.800927] [001/132] (960s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[56.922420] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[56.926788] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[57.050413] [002/132] (960s left) kms_vrr (seamless-rr-switch-virtual)
[57.148653] Starting subtest: seamless-rr-switch-virtual
[57.154785] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[57.238592] [003/132] (960s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[57.301256] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[57.366728] [004/132] (960s left) kms_content_protection (dp-mst-type-1)
[57.499811] Starting subtest: dp-mst-type-1
[57.504275] Subtest dp-mst-type-1: SKIP (0.000s)
[57.654217] [005/132] (959s left) core_setmaster (master-drop-set-shared-fd)
[57.753143] Starting subtest: master-drop-set-shared-fd
[57.772875] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[57.805285] [006/132] (959s left) i915_selftest (mock)
[61.231040] Starting subtest: mock
[61.233129] Starting dynamic subtest: sanitycheck
[61.978270] Dynamic subtest sanitycheck: SUCCESS (0.754s)
[61.986793] Starting dynamic subtest: shmem
[62.707347] Dynamic subtest shmem: SUCCESS (0.732s)
[62.716091] Starting dynamic subtest: fence
[70.054314] Dynamic subtest fence: SUCCESS (7.368s)
[70.063195] Starting dynamic subtest: scatterlist
[71.778037] Dynamic subtest scatterlist: SUCCESS (1.725s)
[71.786598] Starting dynamic subtest: syncmap
[75.131498] Dynamic subtest syncmap: SUCCESS (3.356s)
[75.140649] Starting dynamic subtest: uncore
[75.896293] Dynamic subtest uncore: SUCCESS (0.766s)
[75.905179] Starting dynamic subtest: ring
[76.648338] Dynamic subtest ring: SUCCESS (0.752s)
[76.656675] Starting dynamic subtest: engine
[77.390276] Dynamic subtest engine: SUCCESS (0.741s)
[77.398976] Starting dynamic subtest: timelines
[81.285112] Dynamic subtest timelines: SUCCESS (3.893s)
[81.293795] Starting dynamic subtest: requests
[84.969396] Dynamic subtest requests: SUCCESS (3.682s)
[84.978211] Starting dynamic subtest: objects
[85.861259] Dynamic subtest objects: SUCCESS (0.891s)
[85.870247] Starting dynamic subtest: phys
[86.705412] Dynamic subtest phys: SUCCESS (0.843s)
[86.714207] Starting dynamic subtest: dmabuf
[87.518786] Dynamic subtest dmabuf: SUCCESS (0.812s)
[87.527570] Starting dynamic subtest: vma
[92.967435] Dynamic subtest vma: SUCCESS (5.446s)
[92.976083] Starting dynamic subtest: evict
[94.467033] Dynamic subtest evict: SUCCESS (1.499s)
[94.475722] Starting dynamic subtest: gtt
[97.731403] Dynamic subtest gtt: SUCCESS (3.262s)
[97.739638] Starting dynamic subtest: hugepages
[98.869557] Dynamic subtest hugepages: SUCCESS (1.137s)
[98.882590] Starting dynamic subtest: memory_region
[101.535071] Dynamic subtest memory_region: SUCCESS (2.664s)
[101.537870] Subtest mock: SUCCESS (40.340s)
[101.566770] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[101.569766] [007/132] (915s left) kms_psr (psr-sprite-plane-onoff)
[103.140118] Starting subtest: psr-sprite-plane-onoff
[103.142500] Starting dynamic subtest: eDP-1
[104.897390] Dynamic subtest eDP-1: SUCCESS (1.758s)
[104.899641] Subtest psr-sprite-plane-onoff: SUCCESS (1.759s)
[105.747332] [FACT kms_psr (psr-sprite-plane-onoff)] new: kernel.kmod_is_loaded.i915: true
[105.750782] [008/132] (911s left) kms_psr (fbc-psr2-basic)
[105.857104] Starting subtest: fbc-psr2-basic
[105.859224] Starting dynamic subtest: eDP-1
[105.863504] Dynamic subtest eDP-1: SKIP (0.000s)
[105.867645] Subtest fbc-psr2-basic: SKIP (0.001s)
[105.972728] [009/132] (911s left) kms_atomic_transition (plane-all-transition-nonblocking)
[106.070713] Starting subtest: plane-all-transition-nonblocking
[106.073061] Starting dynamic subtest: pipe-A-eDP-1
[108.564297] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[108.888708] Starting dynamic subtest: pipe-B-eDP-1
[112.149551] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.268s)
[112.458821] Subtest plane-all-transition-nonblocking: SUCCESS (6.389s)
[113.295405] [010/132] (904s left) kms_fence_pin_leak
[113.493473] [011/132] (904s left) gem_partial_pwrite_pread (writes-after-reads-display)
[113.565451] Subtest writes-after-reads-display: SKIP (0.000s)
[113.638621] [012/132] (904s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[118.652248] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[118.654670] Starting dynamic subtest: pipe-A-eDP-1
[130.073618] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.419s)
[130.082530] Starting dynamic subtest: pipe-B-eDP-1
[141.530328] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.455s)
[141.532788] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.878s)
[142.404247] [013/132] (875s left) gem_mmap_gtt (big-bo-tiledx)
[142.461985] Subtest big-bo-tiledX: SKIP (0.000s)
[142.522474] [014/132] (875s left) kms_fbcon_fbt (psr)
[142.586793] Starting subtest: psr
[149.936720] Subtest psr: SUCCESS (7.348s)
[150.008296] [015/132] (867s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[150.105813] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[150.107994] Starting dynamic subtest: pipe-A-eDP-1
[152.335664] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.230s)
[152.343399] Starting dynamic subtest: pipe-B-eDP-1
[154.708365] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.372s)
[154.715764] Starting dynamic subtest: pipe-C-eDP-1
[156.879062] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.170s)
[156.887066] Starting dynamic subtest: pipe-D-eDP-1
[159.057722] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.177s)
[159.059546] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.954s)
[160.280455] [016/132] (857s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[160.396685] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[160.400716] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[160.510478] [017/132] (857s left) gem_exec_whisper (basic-contexts-all)
[160.584019] Starting subtest: basic-contexts-all
[171.293528] Subtest basic-contexts-all: SUCCESS (10.710s)
[171.500769] [018/132] (846s left) kms_cursor_crc (cursor-size-change)
[171.612104] Starting subtest: cursor-size-change
[171.613984] Starting dynamic subtest: pipe-A-eDP-1
[172.442286] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.830s)
[172.451020] Starting dynamic subtest: pipe-D-eDP-1
[173.977716] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.535s)
[173.980111] Subtest cursor-size-change: SUCCESS (2.367s)
[174.849925] [019/132] (843s left) kms_lease (lease-revoke)
[174.957222] Starting subtest: lease-revoke
[174.959573] Starting dynamic subtest: pipe-A-eDP-1
[174.987141] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.031s)
[174.995639] Starting dynamic subtest: pipe-B-eDP-1
[175.017985] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.030s)
[175.026186] Starting dynamic subtest: pipe-C-eDP-1
[175.047193] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.028s)
[175.055477] Starting dynamic subtest: pipe-D-eDP-1
[175.078990] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.028s)
[175.081247] Subtest lease-revoke: SUCCESS (0.122s)
[175.245562] [020/132] (842s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[175.309133] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[175.313526] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[175.512660] [021/132] (842s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[175.610984] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[175.615259] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[175.746726] [022/132] (842s left) kms_flip (2x-blocking-wf_vblank)
[175.852375] Starting subtest: 2x-blocking-wf_vblank
[175.861503] Subtest 2x-blocking-wf_vblank: SKIP (0.011s)
[175.972901] [023/132] (842s left) syncobj_timeline (single-wait-available-submitted)
[176.029333] Starting subtest: single-wait-available-submitted
[176.031371] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[176.186254] [024/132] (842s left) sriov_basic (enable-vfs-bind-unbind-each)
[176.234827] Starting subtest: enable-vfs-bind-unbind-each
[176.237175] Starting dynamic subtest: numvfs-1
[176.316952] Dynamic subtest numvfs-1: FAIL (0.031s)
[176.324801] Starting dynamic subtest: numvfs-2
[176.395656] Dynamic subtest numvfs-2: FAIL (0.004s)
[176.405066] Starting dynamic subtest: numvfs-3
[176.469689] Dynamic subtest numvfs-3: FAIL (0.004s)
[176.477872] Starting dynamic subtest: numvfs-4
[176.537554] Dynamic subtest numvfs-4: FAIL (0.004s)
[176.545745] Starting dynamic subtest: numvfs-5
[176.605626] Dynamic subtest numvfs-5: FAIL (0.004s)
[176.615465] Starting dynamic subtest: numvfs-6
[176.675555] Dynamic subtest numvfs-6: FAIL (0.004s)
[176.683640] Starting dynamic subtest: numvfs-7
[176.744124] Dynamic subtest numvfs-7: FAIL (0.003s)
[176.753511] Starting dynamic subtest: numvfs-random
[176.810470] Dynamic subtest numvfs-random: FAIL (0.004s)
[176.812245] Subtest enable-vfs-bind-unbind-each: FAIL (0.061s)
[176.842941] [025/132] (841s left) api_intel_bb (object-reloc-keep-cache)
[176.909201] Starting subtest: object-reloc-keep-cache
[176.912806] Subtest object-reloc-keep-cache: SKIP (0.002s)
[177.020153] [026/132] (841s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[177.115260] Starting subtest: fbc-psr2-sprite-mmap-gtt
[177.117092] Starting dynamic subtest: eDP-1
[177.120415] Dynamic subtest eDP-1: SKIP (0.000s)
[177.123812] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[177.207514] [027/132] (841s left) gem_exec_nop (basic-parallel)
[177.290373] Starting subtest: basic-parallel
[193.875988] Subtest basic-parallel: SUCCESS (16.593s)
[194.140847] [028/132] (824s left) i915_hangman (gt-engine-error)
[194.215040] Starting subtest: gt-engine-error
[194.217307] Starting dynamic subtest: rcs0
[195.892274] Dynamic subtest rcs0: SUCCESS (1.675s)
[195.909715] Starting dynamic subtest: bcs0
[197.874464] Dynamic subtest bcs0: SUCCESS (1.980s)
[197.888731] Starting dynamic subtest: vcs0
[199.858391] Dynamic subtest vcs0: SUCCESS (1.981s)
[199.869374] Starting dynamic subtest: vcs1
[201.844460] Dynamic subtest vcs1: SUCCESS (1.984s)
[201.855836] Starting dynamic subtest: vecs0
[203.888318] Dynamic subtest vecs0: SUCCESS (2.042s)
[203.899387] Starting dynamic subtest: ccs0
[205.875669] Dynamic subtest ccs0: SUCCESS (1.984s)
[205.878394] Subtest gt-engine-error: SUCCESS (11.661s)
[205.981218] [029/132] (812s left) kms_getfb (getfb-handle-protection)
[206.095865] Starting subtest: getfb-handle-protection
[206.116108] Subtest getfb-handle-protection: SUCCESS (0.021s)
[206.271568] [030/132] (812s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[206.361210] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[206.363513] Starting dynamic subtest: pipe-A-eDP-1
[206.384670] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[206.394983] Starting dynamic subtest: pipe-B-eDP-1
[206.414135] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[206.422078] Starting dynamic subtest: pipe-C-eDP-1
[206.441358] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[206.449472] Starting dynamic subtest: pipe-D-eDP-1
[206.469048] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[206.471232] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[208.603355] [031/132] (809s left) gem_pxp (reject-modify-context-protection-off-1)
[208.740798] Starting subtest: reject-modify-context-protection-off-1
[208.742805] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[208.885384] [032/132] (809s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[208.984723] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[216.068370] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.085s)
[216.205145] [033/132] (802s left) api_intel_allocator (alloc-simple)
[216.271558] Starting subtest: alloc-simple
[216.273944] Subtest alloc-simple: SUCCESS (0.003s)
[216.424929] [034/132] (802s left) perf (blocking)
[216.560333] Starting subtest: blocking
[216.562188] Starting dynamic subtest: 0-rcs0
[226.572091] Dynamic subtest 0-rcs0: SUCCESS (10.010s)
[226.580184] Starting dynamic subtest: 1-vcs0
[236.594168] Dynamic subtest 1-vcs0: SUCCESS (10.020s)
[236.597085] Subtest blocking: SUCCESS (20.033s)
[236.639833] [035/132] (781s left) kms_frontbuffer_tracking (psr-slowdraw)
[236.745303] Starting subtest: psr-slowdraw
[261.959740] Subtest psr-slowdraw: SUCCESS (25.216s)
[262.130135] [036/132] (756s left) gem_mmap (short-mmap)
[262.200105] Subtest short-mmap: SKIP (0.000s)
[262.266299] [037/132] (756s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[262.355940] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[262.358217] Starting dynamic subtest: pipe-A-default-mode
[262.648503] Dynamic subtest pipe-A-default-mode: SKIP (0.291s)
[262.652868] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.292s)
[263.495632] [038/132] (755s left) kms_invalid_mode (bad-htotal)
[263.586628] Starting subtest: bad-htotal
[263.588864] Starting dynamic subtest: pipe-A-eDP-1
[263.890844] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.303s)
[263.903038] Starting dynamic subtest: pipe-B-eDP-1
[263.905418] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[263.915582] Starting dynamic subtest: pipe-C-eDP-1
[263.917749] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[263.925522] Starting dynamic subtest: pipe-D-eDP-1
[263.927690] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[263.929909] Subtest bad-htotal: SUCCESS (0.309s)
[264.742175] [039/132] (754s left) gem_exec_alignment (forked)
[264.803176] Starting subtest: forked
[301.945030] Subtest forked: SUCCESS (37.138s)
[302.126777] [040/132] (716s left) kms_psr (pr-cursor-mmap-gtt)
[302.266969] Starting subtest: pr-cursor-mmap-gtt
[302.271222] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[302.362883] [041/132] (716s left) gem_mmap_wc (read-write)
[302.436610] Subtest read-write: SKIP (0.000s)
[302.506289] [042/132] (716s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[302.610840] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[310.035488] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.426s)
[310.192541] [043/132] (708s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[310.289746] Starting subtest: fbc-rgb565-draw-pwrite
[314.869391] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.582s)
[316.067706] [044/132] (702s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[316.172205] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[319.749282] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.582s)
[320.958359] [045/132] (698s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[321.055750] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[321.060204] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[321.163672] [046/132] (697s left) kms_cursor_crc (cursor-offscreen-128x42)
[321.376600] Starting subtest: cursor-offscreen-128x42
[321.425230] Subtest cursor-offscreen-128x42: SKIP (0.042s)
[321.670114] [047/132] (697s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[321.840415] Starting subtest: cursor-rapid-movement-32x10
[321.884753] Subtest cursor-rapid-movement-32x10: SKIP (0.042s)
[322.170723] [048/132] (696s left) gem_ctx_persistence (legacy-engines-persistence)
[322.228238] Starting subtest: legacy-engines-persistence
[322.229810] Starting dynamic subtest: render
[323.044867] Dynamic subtest render: SUCCESS (0.817s)
[323.056680] Starting dynamic subtest: bsd1
[323.777759] Dynamic subtest bsd1: SUCCESS (0.730s)
[323.788658] Starting dynamic subtest: bsd2
[324.583996] Dynamic subtest bsd2: SUCCESS (0.803s)
[324.595703] Starting dynamic subtest: blt
[325.377901] Dynamic subtest blt: SUCCESS (0.791s)
[325.389573] Starting dynamic subtest: vebox
[326.243240] Dynamic subtest vebox: SUCCESS (0.863s)
[326.245912] Subtest legacy-engines-persistence: SUCCESS (4.017s)
[326.345363] [049/132] (692s left) syncobj_wait (wait-any-complex)
[326.416595] Starting subtest: wait-any-complex
[326.478921] Subtest wait-any-complex: SUCCESS (0.061s)
[326.585433] [050/132] (692s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[326.695098] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[326.697301] Starting dynamic subtest: pipe-A-default-mode
[327.885265] Dynamic subtest pipe-A-default-mode: SKIP (1.187s)
[327.889620] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.189s)
[328.099495] [051/132] (691s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[328.205919] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[328.208125] Starting dynamic subtest: pipe-A
[328.231662] Dynamic subtest pipe-A: SKIP (0.021s)
[328.240868] Starting dynamic subtest: pipe-B
[328.265356] Dynamic subtest pipe-B: SKIP (0.033s)
[328.275824] Starting dynamic subtest: pipe-C
[328.300327] Dynamic subtest pipe-C: SKIP (0.033s)
[328.310515] Starting dynamic subtest: pipe-D
[328.333290] Dynamic subtest pipe-D: SKIP (0.033s)
[328.337643] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.124s)
[328.480110] [052/132] (690s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[328.583197] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[328.585371] Starting dynamic subtest: pipe-A-eDP-1
[328.607686] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[328.618221] Starting dynamic subtest: pipe-B-eDP-1
[328.639207] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[328.647664] Starting dynamic subtest: pipe-C-eDP-1
[328.668887] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[328.677121] Starting dynamic subtest: pipe-D-eDP-1
[328.699221] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[328.703236] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[330.833582] [053/132] (688s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[330.938910] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[330.942983] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[331.090186] [054/132] (688s left) drm_read (empty-nonblock)
[331.270538] Starting subtest: empty-nonblock
[331.272811] Subtest empty-nonblock: SUCCESS (0.000s)
[331.430326] [055/132] (687s left) gem_partial_pwrite_pread (write-display)
[331.494462] Subtest write-display: SKIP (0.000s)
[331.574490] [056/132] (687s left) gem_ctx_param (invalid-size-set)
[331.637789] Starting subtest: invalid-size-set
[331.640217] Subtest invalid-size-set: SUCCESS (0.001s)
[331.779983] [057/132] (687s left) gem_close_race (multigpu-basic-threads)
[331.854931] Starting subtest: multigpu-basic-threads
[331.858513] Subtest multigpu-basic-threads: SKIP (0.000s)
[332.117426] [058/132] (687s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[332.211181] Starting subtest: psr-dirtyfb-ioctl
[332.213113] Starting dynamic subtest: A-eDP-1
[336.107847] Dynamic subtest A-eDP-1: SUCCESS (3.895s)
[336.110024] Subtest psr-dirtyfb-ioctl: SUCCESS (3.896s)
[336.929867] [059/132] (682s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[337.039544] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[337.652560] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.614s)
[337.879788] [060/132] (681s left) gem_mmap_gtt (zero-extend)
[337.940910] Subtest zero-extend: SKIP (0.000s)
[338.009051] [061/132] (681s left) gem_lmem_swapping (massive-random)
[338.051097] Subtest massive-random: SKIP (0.000s)
[338.099488] [062/132] (681s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[338.208423] Starting subtest: 4-tiled-32bpp-rotate-270
[338.229090] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.019s)
[338.400443] [063/132] (681s left) kms_plane_alpha_blend (alpha-basic)
[338.504260] Starting subtest: alpha-basic
[338.951677] Starting dynamic subtest: pipe-A-eDP-1
[340.886436] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.932s)
[340.913243] Starting dynamic subtest: pipe-D-eDP-1
[343.589780] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.681s)
[343.592164] Subtest alpha-basic: SUCCESS (5.085s)
[344.489926] [064/132] (675s left) kms_sequence (get-idle)
[344.599072] Starting subtest: get-idle
[344.601217] Starting dynamic subtest: pipe-A-eDP-1
[346.400571] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.800s)
[346.410776] Starting dynamic subtest: pipe-B-eDP-1
[348.837489] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.435s)
[348.846949] Starting dynamic subtest: pipe-C-eDP-1
[351.258336] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.423s)
[351.267876] Starting dynamic subtest: pipe-D-eDP-1
[353.680061] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.417s)
[353.681882] Subtest get-idle: SUCCESS (9.080s)
[354.505871] [065/132] (665s left) syncobj_wait (multi-wait-all-submitted)
[354.570675] Starting subtest: multi-wait-all-submitted
[354.670651] Subtest multi-wait-all-submitted: SUCCESS (0.101s)
[354.772102] [066/132] (665s left) gem_exec_reloc (basic-cpu-read)
[354.850615] Subtest basic-cpu-read: SKIP (0.000s)
[354.927378] [067/132] (664s left) gem_exec_suspend (basic)
[354.992850] Starting subtest: basic
[354.994718] Starting dynamic subtest: smem
[356.884587] Dynamic subtest smem: SUCCESS (1.892s)
[356.887489] Subtest basic: SUCCESS (1.894s)
[357.094367] [068/132] (662s left) gem_exec_balancer (bonded-chain)
[357.167322] Starting subtest: bonded-chain
[364.162336] Subtest bonded-chain: SUCCESS (6.993s)
[364.525445] [069/132] (655s left) gem_ppgtt (shrink-vs-evict-any)
[364.590647] Starting subtest: shrink-vs-evict-any
[369.903861] Subtest shrink-vs-evict-any: SUCCESS (5.311s)
[370.013254] [070/132] (649s left) syncobj_basic (bad-create-flags)
[370.084970] Starting subtest: bad-create-flags
[370.087292] Subtest bad-create-flags: SUCCESS (0.000s)
[370.225378] [071/132] (649s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[370.285045] Starting subtest: etime-single-wait-all-for-submit-submitted
[370.392979] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.106s)
[370.518177] [072/132] (649s left) kms_flip (2x-flip-vs-fences-interruptible)
[370.628086] Starting subtest: 2x-flip-vs-fences-interruptible
[370.632509] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[370.774095] [073/132] (649s left) gem_softpin (allocator-nopin)
[370.842150] Starting subtest: allocator-nopin
[370.939687] Subtest allocator-nopin: SUCCESS (0.099s)
[371.102617] [074/132] (649s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[371.203426] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[371.207461] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[371.322045] [075/132] (648s left) prime_busy (before)
[371.382854] Starting subtest: before
[371.385193] Starting dynamic subtest: rcs0
[371.417502] Dynamic subtest rcs0: SUCCESS (0.034s)
[371.425785] Starting dynamic subtest: bcs0
[371.475135] Dynamic subtest bcs0: SUCCESS (0.057s)
[371.483165] Starting dynamic subtest: vcs0
[371.513935] Dynamic subtest vcs0: SUCCESS (0.038s)
[371.521625] Starting dynamic subtest: vcs1
[371.553438] Dynamic subtest vcs1: SUCCESS (0.039s)
[371.561173] Starting dynamic subtest: vecs0
[371.591865] Dynamic subtest vecs0: SUCCESS (0.038s)
[371.599572] Starting dynamic subtest: ccs0
[371.630190] Dynamic subtest ccs0: SUCCESS (0.038s)
[371.739613] Subtest before: SUCCESS (0.357s)
[371.838587] [076/132] (648s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[371.944637] Starting subtest: fbc-indfb-scaledprimary
[374.950463] Subtest fbc-indfb-scaledprimary: SUCCESS (3.009s)
[376.099398] [077/132] (644s left) gem_readwrite (read-write)
[376.162898] Subtest read-write: SKIP (0.000s)
[376.227123] [078/132] (644s left) gem_exec_reloc (basic-scanout)
[376.295404] Subtest basic-scanout: SKIP (0.000s)
[376.378387] [079/132] (644s left) gem_ctx_param (invalid-ctx-set)
[376.450528] Starting subtest: invalid-ctx-set
[376.452892] Subtest invalid-ctx-set: SUCCESS (0.001s)
[376.570635] [080/132] (643s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[376.625094] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[376.627364] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[376.765227] [081/132] (643s left) gem_readwrite (beyond-eob)
[376.828795] Subtest beyond-EOB: SKIP (0.000s)
[376.891866] [082/132] (643s left) kms_big_fb (linear-32bpp-rotate-0)
[376.992307] Starting subtest: linear-32bpp-rotate-0
[378.515099] Subtest linear-32bpp-rotate-0: SUCCESS (1.522s)
[378.695466] [083/132] (641s left) gem_mmap_gtt (basic-write)
[378.763657] Subtest basic-write: SKIP (0.000s)
[378.828070] [084/132] (641s left) fbdev (nullptr)
[378.870490] Starting subtest: nullptr
[378.872382] Subtest nullptr: SUCCESS (0.000s)
[378.950762] [085/132] (641s left) syncobj_wait (wait-all-complex)
[379.010947] Starting subtest: wait-all-complex
[379.223366] Subtest wait-all-complex: SUCCESS (0.212s)
[379.320378] [086/132] (641s left) gem_tiled_partial_pwrite_pread (reads)
[379.380950] Subtest reads: SKIP (0.000s)
[379.466775] [087/132] (641s left) syncobj_wait (wait-zero-handles)
[379.530046] Starting subtest: wait-zero-handles
[379.532283] Subtest wait-zero-handles: SUCCESS (0.000s)
[379.662485] [088/132] (641s left) kms_properties (crtc-properties-atomic)
[379.774060] Starting subtest: crtc-properties-atomic
[379.776333] Starting dynamic subtest: pipe-A-eDP-1
[380.211775] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.436s)
[380.221934] Starting dynamic subtest: pipe-B-eDP-1
[381.424229] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.214s)
[381.435941] Starting dynamic subtest: pipe-C-eDP-1
[382.539818] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.113s)
[382.550231] Starting dynamic subtest: pipe-D-eDP-1
[383.670488] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.128s)
[383.672414] Subtest crtc-properties-atomic: SUCCESS (3.896s)
[384.510376] [089/132] (636s left) gem_ctx_persistence (engines-hostile-preempt)
[384.583486] Starting subtest: engines-hostile-preempt
[384.585897] Starting dynamic subtest: rcs0
[384.684055] Dynamic subtest rcs0: SUCCESS (0.100s)
[384.695692] Starting dynamic subtest: bcs0
[384.707255] Dynamic subtest bcs0: SUCCESS (0.022s)
[384.715531] Starting dynamic subtest: vcs0
[385.921908] Dynamic subtest vcs0: SUCCESS (1.212s)
[385.933181] Starting dynamic subtest: vcs1
[387.933075] Dynamic subtest vcs1: SUCCESS (2.009s)
[387.947438] Starting dynamic subtest: vecs0
[389.889882] Dynamic subtest vecs0: SUCCESS (1.954s)
[389.899987] Starting dynamic subtest: ccs0
[389.950510] Dynamic subtest ccs0: SUCCESS (0.060s)
[389.952922] Subtest engines-hostile-preempt: SUCCESS (5.367s)
[390.119746] [090/132] (630s left) syncobj_timeline (multi-wait-all-available-submitted)
[390.182177] Starting subtest: multi-wait-all-available-submitted
[390.184470] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[390.326099] [091/132] (630s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[390.421621] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[390.425812] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[390.566978] [092/132] (630s left) syncobj_wait (single-wait-submitted)
[390.632139] Starting subtest: single-wait-submitted
[390.736797] Subtest single-wait-submitted: SUCCESS (0.103s)
[390.849780] [093/132] (630s left) gem_exec_schedule (preempt-self)
[390.923880] Starting subtest: preempt-self
[390.926208] Starting dynamic subtest: rcs0
[390.935288] Dynamic subtest rcs0: SUCCESS (0.019s)
[390.946952] Starting dynamic subtest: bcs0
[390.952182] Dynamic subtest bcs0: SUCCESS (0.017s)
[390.961208] Starting dynamic subtest: vcs0
[390.973818] Dynamic subtest vcs0: SUCCESS (0.020s)
[390.988711] Starting dynamic subtest: vcs1
[390.994341] Dynamic subtest vcs1: SUCCESS (0.019s)
[391.004593] Starting dynamic subtest: vecs0
[391.012540] Dynamic subtest vecs0: SUCCESS (0.018s)
[391.021387] Starting dynamic subtest: ccs0
[391.031087] Dynamic subtest ccs0: SUCCESS (0.018s)
[391.033296] Subtest preempt-self: SUCCESS (0.116s)
[393.054264] [094/132] (627s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[393.158953] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[399.880612] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.723s)
[400.029459] [095/132] (621s left) sysfs_preempt_timeout (idempotent)
[400.102662] Starting subtest: idempotent
[400.105104] Starting dynamic subtest: vecs0
[400.107537] Dynamic subtest vecs0: SUCCESS (0.000s)
[400.119824] Starting dynamic subtest: ccs0
[400.121818] Dynamic subtest ccs0: SUCCESS (0.000s)
[400.129940] Starting dynamic subtest: vcs0
[400.131795] Dynamic subtest vcs0: SUCCESS (0.000s)
[400.139718] Starting dynamic subtest: bcs0
[400.141569] Dynamic subtest bcs0: SUCCESS (0.000s)
[400.149827] Starting dynamic subtest: rcs0
[400.151638] Dynamic subtest rcs0: SUCCESS (0.000s)
[400.159809] Starting dynamic subtest: vcs1
[400.161662] Dynamic subtest vcs1: SUCCESS (0.000s)
[400.163965] Subtest idempotent: SUCCESS (0.006s)
[400.243991] [096/132] (620s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[400.345454] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[400.349514] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[400.486103] [097/132] (620s left) kms_atomic (crtc-invalid-params-fence)
[400.583209] Starting subtest: crtc-invalid-params-fence
[400.585385] Starting dynamic subtest: pipe-A-eDP-1
[401.004699] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.422s)
[401.006932] Subtest crtc-invalid-params-fence: SUCCESS (0.423s)
[401.858400] [098/132] (619s left) gem_fence_thrash (bo-write-verify-threaded-x)
[401.896174] Starting subtest: bo-write-verify-threaded-x
[401.922579] Subtest bo-write-verify-threaded-x: SKIP (0.022s)
[401.987820] [099/132] (619s left) gem_wait (busy)
[402.048777] Starting subtest: busy
[402.051424] Starting dynamic subtest: all-engines
[403.923733] Dynamic subtest all-engines: SUCCESS (1.873s)
[403.935726] Starting dynamic subtest: rcs0
[404.463450] Dynamic subtest rcs0: SUCCESS (0.540s)
[404.474807] Starting dynamic subtest: bcs0
[405.003198] Dynamic subtest bcs0: SUCCESS (0.539s)
[405.014873] Starting dynamic subtest: vcs0
[406.931765] Dynamic subtest vcs0: SUCCESS (1.926s)
[406.944324] Starting dynamic subtest: vcs1
[408.916800] Dynamic subtest vcs1: SUCCESS (1.982s)
[408.927765] Starting dynamic subtest: vecs0
[410.899343] Dynamic subtest vecs0: SUCCESS (1.980s)
[410.912927] Starting dynamic subtest: ccs0
[411.442395] Dynamic subtest ccs0: SUCCESS (0.542s)
[411.444950] Subtest busy: SUCCESS (9.393s)
[411.657596] [100/132] (609s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[411.772016] Starting subtest: x-tiled-64bpp-rotate-180
[413.402055] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.628s)
[413.606539] [101/132] (607s left) kms_force_connector_basic (force-edid)
[413.688350] Starting subtest: force-edid
[414.054198] Subtest force-edid: SUCCESS (0.368s)
[414.215382] [102/132] (607s left) gem_ctx_param (basic-default)
[414.263027] Starting subtest: basic-default
[414.265082] Subtest basic-default: SUCCESS (0.000s)
[414.363570] [103/132] (607s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[414.445552] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[414.447354] Starting dynamic subtest: pipe-A-eDP-1
[431.292215] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.579s)
[431.302432] Starting dynamic subtest: pipe-B-eDP-1
[448.220198] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.468s)
[448.230131] Starting dynamic subtest: pipe-C-eDP-1
[465.189049] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.372s)
[465.200413] Starting dynamic subtest: pipe-D-eDP-1
[482.194425] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.403s)
[482.197257] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.827s)
[483.426028] [104/132] (537s left) kms_pm_rpm (modeset-stress-extra-wait)
[485.162615] Starting subtest: modeset-stress-extra-wait
[539.445250] Subtest modeset-stress-extra-wait: SUCCESS (54.486s)
[539.590320] [105/132] (481s left) kms_flip (2x-flip-vs-suspend)
[539.686331] Starting subtest: 2x-flip-vs-suspend
[539.695241] Subtest 2x-flip-vs-suspend: SKIP (0.011s)
[539.796875] [106/132] (481s left) kms_chamelium_frames (dp-crc-fast)
[540.200615] Subtest dp-crc-fast: SKIP (0.000s)
[541.024173] [107/132] (480s left) intel_hwmon (hwmon-write)
[541.093466] Subtest hwmon-write: SKIP (0.000s)
[541.157407] [108/132] (480s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[541.261313] Starting subtest: psr-rgb101010-draw-render
[548.595661] Subtest psr-rgb101010-draw-render: SUCCESS (7.337s)
[548.764900] [109/132] (472s left) gem_exec_flush (basic-wb-pro-default)
[548.828419] Starting subtest: basic-wb-pro-default
[554.286978] Subtest basic-wb-pro-default: SUCCESS (5.459s)
[554.493247] [110/132] (467s left) kms_prop_blob (invalid-get-prop)
[554.561409] Starting subtest: invalid-get-prop
[554.564179] Subtest invalid-get-prop: SUCCESS (0.000s)
[554.689097] [111/132] (467s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[554.788123] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[561.433493] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.650s)
[561.556727] [112/132] (460s left) kms_plane (plane-position-hole-dpms)
[561.661337] Starting subtest: plane-position-hole-dpms
[562.179934] Starting dynamic subtest: pipe-A-plane-1
[564.554540] Dynamic subtest pipe-A-plane-1: SUCCESS (2.374s)
[564.565393] Starting dynamic subtest: pipe-A-plane-2
[566.936324] Dynamic subtest pipe-A-plane-2: SUCCESS (2.382s)
[566.947615] Starting dynamic subtest: pipe-A-plane-3
[569.261207] Dynamic subtest pipe-A-plane-3: SUCCESS (2.323s)
[569.272135] Starting dynamic subtest: pipe-A-plane-4
[571.640817] Dynamic subtest pipe-A-plane-4: SUCCESS (2.380s)
[571.650586] Starting dynamic subtest: pipe-A-plane-5
[571.664608] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[572.802477] Starting dynamic subtest: pipe-B-plane-1
[575.211278] Dynamic subtest pipe-B-plane-1: SUCCESS (2.419s)
[575.223214] Starting dynamic subtest: pipe-B-plane-2
[577.579811] Dynamic subtest pipe-B-plane-2: SUCCESS (2.366s)
[577.593313] Starting dynamic subtest: pipe-B-plane-3
[579.975361] Dynamic subtest pipe-B-plane-3: SUCCESS (2.394s)
[579.985640] Starting dynamic subtest: pipe-B-plane-4
[582.349385] Dynamic subtest pipe-B-plane-4: SUCCESS (2.372s)
[582.359926] Starting dynamic subtest: pipe-B-plane-5
[582.375951] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[582.378083] Subtest plane-position-hole-dpms: SUCCESS (20.716s)
[583.251821] [113/132] (438s left) perf_pmu (busy-start)
[583.301425] Starting subtest: busy-start
[583.303954] Starting dynamic subtest: rcs0
[585.851244] Dynamic subtest rcs0: SUCCESS (2.551s)
[585.864825] Starting dynamic subtest: bcs0
[588.400379] Dynamic subtest bcs0: SUCCESS (2.546s)
[588.414171] Starting dynamic subtest: vcs0
[592.058028] Dynamic subtest vcs0: SUCCESS (3.653s)
[592.071686] Starting dynamic subtest: vcs1
[596.090222] Dynamic subtest vcs1: SUCCESS (4.029s)
[596.103631] Starting dynamic subtest: vecs0
[600.058163] Dynamic subtest vecs0: SUCCESS (3.964s)
[600.071273] Starting dynamic subtest: ccs0
[602.606508] Dynamic subtest ccs0: SUCCESS (2.546s)
[602.610054] Subtest busy-start: SUCCESS (19.304s)
[602.750849] [114/132] (419s left) kms_color_pipeline (plane-lut1d)
[602.866515] Starting subtest: plane-lut1d
[602.878900] Starting dynamic subtest: pipe-A-eDP-1
[603.664641] Dynamic subtest pipe-A-eDP-1: FAIL (0.332s)
[604.279500] Starting dynamic subtest: pipe-B-eDP-1
[605.155253] Dynamic subtest pipe-B-eDP-1: FAIL (0.301s)
[605.679672] Starting dynamic subtest: pipe-C-eDP-1
[606.625002] Dynamic subtest pipe-C-eDP-1: FAIL (0.268s)
[606.977511] Starting dynamic subtest: pipe-D-eDP-1
[607.941934] Dynamic subtest pipe-D-eDP-1: FAIL (0.280s)
[607.944349] Subtest plane-lut1d: FAIL (4.684s)
[608.455118] [115/132] (413s left) gen9_exec_parse (batch-zero-length)
[608.514516] Subtest batch-zero-length: SKIP (0.000s)
[608.593246] [116/132] (413s left) i915_drm_fdinfo (context-close-stress)
[608.646792] Starting subtest: context-close-stress
[619.388473] Subtest context-close-stress: SUCCESS (10.744s)
[619.489171] [117/132] (402s left) kms_chamelium_hpd (hdmi-hpd-storm)
[620.043320] Subtest hdmi-hpd-storm: SKIP (0.000s)
[620.818527] [118/132] (401s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[620.925485] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[620.927897] Starting dynamic subtest: pipe-A-eDP-1
[620.953708] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[620.964122] Starting dynamic subtest: pipe-B-eDP-1
[620.992232] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[621.001854] Starting dynamic subtest: pipe-C-eDP-1
[621.029563] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[621.039546] Starting dynamic subtest: pipe-D-eDP-1
[621.072472] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[621.077487] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[623.146083] [119/132] (398s left) syncobj_timeline (invalid-signal-bad-pad)
[623.208520] Starting subtest: invalid-signal-bad-pad
[623.211191] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[623.346001] [120/132] (398s left) gem_exec_fence (submit67)
[623.545389] Starting subtest: submit67
[623.550226] Subtest submit67: SKIP (0.000s)
[625.171047] [FACT gem_exec_fence (submit67)] new: kernel.kmod_is_loaded.vgem: true
[625.175063] [121/132] (396s left) gem_eio (in-flight-internal-10ms)
[625.398636] Starting subtest: in-flight-internal-10ms
[627.162503] Subtest in-flight-internal-10ms: SUCCESS (1.762s)
[627.348007] [122/132] (394s left) gem_exec_schedule (preempt-contexts)
[627.424559] Starting subtest: preempt-contexts
[627.427426] Starting dynamic subtest: rcs0
[627.483556] Dynamic subtest rcs0: SUCCESS (0.070s)
[627.494539] Starting dynamic subtest: bcs0
[627.552261] Dynamic subtest bcs0: SUCCESS (0.067s)
[627.563353] Starting dynamic subtest: vcs0
[627.603974] Dynamic subtest vcs0: SUCCESS (0.050s)
[627.614296] Starting dynamic subtest: vcs1
[627.648957] Dynamic subtest vcs1: SUCCESS (0.045s)
[627.660028] Starting dynamic subtest: vecs0
[627.691771] Dynamic subtest vecs0: SUCCESS (0.042s)
[627.702523] Starting dynamic subtest: ccs0
[627.750590] Dynamic subtest ccs0: SUCCESS (0.059s)
[627.753400] Subtest preempt-contexts: SUCCESS (0.338s)
[629.200003] [123/132] (393s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[634.214396] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[634.219662] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.002s)
[635.047949] [124/132] (387s left) kms_chamelium_audio (dp-audio)
[635.467625] Subtest dp-audio: SKIP (0.000s)
[636.306312] [125/132] (386s left) kms_psr (psr2-cursor-plane-onoff)
[636.423249] Starting subtest: psr2-cursor-plane-onoff
[636.425883] Starting dynamic subtest: eDP-1
[638.179230] Dynamic subtest eDP-1: SUCCESS (1.758s)
[638.181785] Subtest psr2-cursor-plane-onoff: SUCCESS (1.759s)
[639.064403] [126/132] (383s left) kms_plane_scaling (planes-downscale-factor-0-75)
[639.169077] Starting subtest: planes-downscale-factor-0-75
[639.171394] Starting dynamic subtest: pipe-A
[639.192822] Dynamic subtest pipe-A: SKIP (0.018s)
[639.203361] Starting dynamic subtest: pipe-B
[639.224878] Dynamic subtest pipe-B: SKIP (0.033s)
[639.235297] Starting dynamic subtest: pipe-C
[639.257369] Dynamic subtest pipe-C: SKIP (0.032s)
[639.267567] Starting dynamic subtest: pipe-D
[639.289885] Dynamic subtest pipe-D: SKIP (0.031s)
[639.294425] Subtest planes-downscale-factor-0-75: SKIP (0.117s)
[639.423321] [127/132] (383s left) kms_vblank (ts-continuation-modeset)
[639.522376] Starting subtest: ts-continuation-modeset
[639.524888] Starting dynamic subtest: pipe-A-eDP-1
[641.056643] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.534s)
[641.079617] Starting dynamic subtest: pipe-D-eDP-1
[643.264506] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.206s)
[643.267422] Subtest ts-continuation-modeset: SUCCESS (3.744s)
[644.146815] [128/132] (378s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[644.201117] Starting subtest: framebuffer-vs-set-tiling
[644.206086] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[644.395979] [129/132] (378s left) kms_cursor_crc (cursor-sliding-512x170)
[644.680096] Starting subtest: cursor-sliding-512x170
[644.684303] Subtest cursor-sliding-512x170: SKIP (0.001s)
[644.854141] [130/132] (377s left) gem_exec_capture (capture)
[644.920604] Starting subtest: capture
[644.923382] Starting dynamic subtest: rcs0-smem
[645.758864] Dynamic subtest rcs0-smem: SUCCESS (0.838s)
[645.771073] Starting dynamic subtest: bcs0-smem
[647.083133] Dynamic subtest bcs0-smem: SUCCESS (1.324s)
[647.095792] Starting dynamic subtest: vcs0-smem
[647.910237] Dynamic subtest vcs0-smem: SUCCESS (0.829s)
[647.921401] Starting dynamic subtest: vcs1-smem
[648.734485] Dynamic subtest vcs1-smem: SUCCESS (0.824s)
[648.747048] Starting dynamic subtest: vecs0-smem
[650.157768] Dynamic subtest vecs0-smem: FAIL (1.323s)
[650.170337] Starting dynamic subtest: ccs0-smem
[651.384556] Dynamic subtest ccs0-smem: SUCCESS (1.322s)
[651.387720] Subtest capture: FAIL (6.463s)
[651.553997] [131/132] (371s left) i915_pm_rps (min-max-config-idle)
[651.626856] Starting subtest: min-max-config-idle
[651.632619] Subtest min-max-config-idle: SKIP (0.001s)
[651.776199] [132/132] (370s left) kms_flip (2x-plain-flip)
[651.887091] Starting subtest: 2x-plain-flip
[651.899366] Subtest 2x-plain-flip: SKIP (0.011s)
[651.999988] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_vrr
results: parsing output: 2/ for test: gem_mmap_gtt
results: parsing output: 3/ for test: kms_content_protection
results: parsing output: 4/ for test: core_setmaster
results: parsing output: 5/ for test: i915_selftest
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: kms_atomic_transition
results: parsing output: 9/ for test: kms_fence_pin_leak
results: parsing output: 10/ for test: gem_partial_pwrite_pread
results: parsing output: 11/ for test: kms_psr2_sf
results: parsing output: 12/ for test: gem_mmap_gtt
results: parsing output: 13/ for test: kms_fbcon_fbt
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: gem_exec_whisper
results: parsing output: 17/ for test: kms_cursor_crc
results: parsing output: 18/ for test: kms_lease
results: parsing output: 19/ for test: gem_render_copy
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: sriov_basic
results: parsing output: 24/ for test: api_intel_bb
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: gem_exec_nop
results: parsing output: 27/ for test: i915_hangman
results: parsing output: 28/ for test: kms_getfb
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: gem_pxp
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: api_intel_allocator
results: parsing output: 33/ for test: perf
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_mmap
results: parsing output: 36/ for test: kms_flip_scaled_crc
results: parsing output: 37/ for test: kms_invalid_mode
results: parsing output: 38/ for test: gem_exec_alignment
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: gem_mmap_wc
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_cursor_crc
results: parsing output: 46/ for test: kms_cursor_crc
results: parsing output: 47/ for test: gem_ctx_persistence
results: parsing output: 48/ for test: syncobj_wait
results: parsing output: 49/ for test: kms_flip_scaled_crc
results: parsing output: 50/ for test: kms_plane_scaling
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: drm_read
results: parsing output: 54/ for test: gem_partial_pwrite_pread
results: parsing output: 55/ for test: gem_ctx_param
results: parsing output: 56/ for test: gem_close_race
results: parsing output: 57/ for test: kms_dirtyfb
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: gem_mmap_gtt
results: parsing output: 60/ for test: gem_lmem_swapping
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_plane_alpha_blend
results: parsing output: 63/ for test: kms_sequence
results: parsing output: 64/ for test: syncobj_wait
results: parsing output: 65/ for test: gem_exec_reloc
results: parsing output: 66/ for test: gem_exec_suspend
results: parsing output: 67/ for test: gem_exec_balancer
results: parsing output: 68/ for test: gem_ppgtt
results: parsing output: 69/ for test: syncobj_basic
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: gem_softpin
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: prime_busy
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_readwrite
results: parsing output: 77/ for test: gem_exec_reloc
results: parsing output: 78/ for test: gem_ctx_param
results: parsing output: 79/ for test: syncobj_wait
results: parsing output: 80/ for test: gem_readwrite
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: gem_mmap_gtt
results: parsing output: 83/ for test: fbdev
results: parsing output: 84/ for test: syncobj_wait
results: parsing output: 85/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 86/ for test: syncobj_wait
results: parsing output: 87/ for test: kms_properties
results: parsing output: 88/ for test: gem_ctx_persistence
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: gem_exec_schedule
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: sysfs_preempt_timeout
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_atomic
results: parsing output: 97/ for test: gem_fence_thrash
results: parsing output: 98/ for test: gem_wait
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_force_connector_basic
results: parsing output: 101/ for test: gem_ctx_param
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: kms_pm_rpm
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: kms_chamelium_frames
results: parsing output: 106/ for test: intel_hwmon
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_exec_flush
results: parsing output: 109/ for test: kms_prop_blob
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_plane
results: parsing output: 112/ for test: perf_pmu
results: parsing output: 113/ for test: kms_color_pipeline
results: parsing output: 114/ for test: gen9_exec_parse
results: parsing output: 115/ for test: i915_drm_fdinfo
results: parsing output: 116/ for test: kms_chamelium_hpd
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: gem_exec_fence
results: parsing output: 120/ for test: gem_eio
results: parsing output: 121/ for test: gem_exec_schedule
results: parsing output: 122/ for test: kms_psr2_sf
results: parsing output: 123/ for test: kms_chamelium_audio
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: kms_plane_scaling
results: parsing output: 126/ for test: kms_vblank
results: parsing output: 127/ for test: kms_addfb_basic
results: parsing output: 128/ for test: kms_cursor_crc
results: parsing output: 129/ for test: gem_exec_capture
results: parsing output: 130/ for test: i915_pm_rps
results: parsing output: 131/ for test: kms_flip
Done.