[60.071758] Initializing watchdogs
[60.071803]   /dev/watchdog0
[60.090252] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[60.094713] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.096813] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.098609] [001/132] (960s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[60.204765] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[60.206459] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[60.331825] [002/132] (960s left) kms_vrr (seamless-rr-switch-virtual)
[60.415901] Starting subtest: seamless-rr-switch-virtual
[60.418981] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[60.504593] [003/132] (960s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[60.562288] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[60.617597] [004/132] (960s left) kms_content_protection (dp-mst-type-1)
[60.761812] Starting subtest: dp-mst-type-1
[60.764060] Subtest dp-mst-type-1: SKIP (0.000s)
[60.920989] [005/132] (959s left) core_setmaster (master-drop-set-shared-fd)
[61.013830] Starting subtest: master-drop-set-shared-fd
[61.035138] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[61.063398] [006/132] (959s left) i915_selftest (mock)
[64.433996] Starting subtest: mock
[64.435766] Starting dynamic subtest: sanitycheck
[65.178857] Dynamic subtest sanitycheck: SUCCESS (0.745s)
[65.185908] Starting dynamic subtest: shmem
[65.930764] Dynamic subtest shmem: SUCCESS (0.750s)
[65.937925] Starting dynamic subtest: fence
[74.010873] Dynamic subtest fence: SUCCESS (8.074s)
[74.018587] Starting dynamic subtest: scatterlist
[75.757354] Dynamic subtest scatterlist: SUCCESS (1.746s)
[75.764586] Starting dynamic subtest: syncmap
[79.381794] Dynamic subtest syncmap: SUCCESS (3.622s)
[79.390081] Starting dynamic subtest: uncore
[80.119648] Dynamic subtest uncore: SUCCESS (0.738s)
[80.126688] Starting dynamic subtest: ring
[80.899898] Dynamic subtest ring: SUCCESS (0.779s)
[80.907510] Starting dynamic subtest: engine
[81.666924] Dynamic subtest engine: SUCCESS (0.766s)
[81.674385] Starting dynamic subtest: timelines
[85.577989] Dynamic subtest timelines: SUCCESS (3.910s)
[85.585271] Starting dynamic subtest: requests
[89.034788] Dynamic subtest requests: SUCCESS (3.454s)
[89.042719] Starting dynamic subtest: objects
[89.902371] Dynamic subtest objects: SUCCESS (0.869s)
[89.909541] Starting dynamic subtest: phys
[90.756076] Dynamic subtest phys: SUCCESS (0.851s)
[90.763263] Starting dynamic subtest: dmabuf
[91.596181] Dynamic subtest dmabuf: SUCCESS (0.839s)
[91.603046] Starting dynamic subtest: vma
[97.042905] Dynamic subtest vma: SUCCESS (5.444s)
[97.050302] Starting dynamic subtest: evict
[98.547710] Dynamic subtest evict: SUCCESS (1.504s)
[98.553667] Starting dynamic subtest: gtt
[101.821487] Dynamic subtest gtt: SUCCESS (3.273s)
[101.828705] Starting dynamic subtest: hugepages
[102.865601] Dynamic subtest hugepages: SUCCESS (1.045s)
[102.872061] Starting dynamic subtest: memory_region
[105.508846] Dynamic subtest memory_region: SUCCESS (2.642s)
[105.510201] Subtest mock: SUCCESS (41.066s)
[105.528710] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[105.530116] [007/132] (915s left) kms_psr (psr-sprite-plane-onoff)
[107.092427] Starting subtest: psr-sprite-plane-onoff
[107.093288] Starting dynamic subtest: eDP-1
[108.851431] Dynamic subtest eDP-1: SUCCESS (1.759s)
[108.852452] Subtest psr-sprite-plane-onoff: SUCCESS (1.759s)
[109.710403] [FACT kms_psr (psr-sprite-plane-onoff)] new: kernel.kmod_is_loaded.i915: true
[109.712465] [008/132] (911s left) kms_psr (fbc-psr2-basic)
[109.808438] Starting subtest: fbc-psr2-basic
[109.809482] Starting dynamic subtest: eDP-1
[109.811272] Dynamic subtest eDP-1: SKIP (0.000s)
[109.813119] Subtest fbc-psr2-basic: SKIP (0.000s)
[109.894644] [009/132] (910s left) kms_atomic_transition (plane-all-transition-nonblocking)
[109.981794] Starting subtest: plane-all-transition-nonblocking
[109.982816] Starting dynamic subtest: pipe-A-eDP-1
[112.477957] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.497s)
[112.779692] Starting dynamic subtest: pipe-B-eDP-1
[116.013038] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.240s)
[116.310273] Subtest plane-all-transition-nonblocking: SUCCESS (6.329s)
[117.145712] [010/132] (903s left) kms_fence_pin_leak
[117.339170] [011/132] (903s left) gem_partial_pwrite_pread (writes-after-reads-display)
[117.399823] Subtest writes-after-reads-display: SKIP (0.000s)
[117.475211] [012/132] (903s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[122.501079] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[122.503421] Starting dynamic subtest: pipe-A-eDP-1
[133.932186] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.429s)
[133.939901] Starting dynamic subtest: pipe-B-eDP-1
[145.367363] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.432s)
[145.368257] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.866s)
[146.244871] [013/132] (874s left) gem_mmap_gtt (big-bo-tiledx)
[146.306414] Subtest big-bo-tiledX: SKIP (0.000s)
[146.365365] [014/132] (874s left) kms_fbcon_fbt (psr)
[146.426902] Starting subtest: psr
[153.782604] Subtest psr: SUCCESS (7.352s)
[153.847718] [015/132] (867s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[153.947407] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[153.948398] Starting dynamic subtest: pipe-A-eDP-1
[156.168097] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.221s)
[156.175084] Starting dynamic subtest: pipe-B-eDP-1
[158.623438] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.454s)
[158.630742] Starting dynamic subtest: pipe-C-eDP-1
[160.779495] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.155s)
[160.786755] Starting dynamic subtest: pipe-D-eDP-1
[162.955405] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.175s)
[162.956422] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (9.009s)
[164.227833] [016/132] (856s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[164.331052] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[164.332932] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[164.458604] [017/132] (856s left) gem_exec_whisper (basic-contexts-all)
[164.513503] Starting subtest: basic-contexts-all
[174.795955] Subtest basic-contexts-all: SUCCESS (10.280s)
[174.994508] [018/132] (846s left) kms_cursor_crc (cursor-size-change)
[175.091114] Starting subtest: cursor-size-change
[175.091991] Starting dynamic subtest: pipe-A-eDP-1
[175.891214] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.799s)
[175.898302] Starting dynamic subtest: pipe-D-eDP-1
[177.372799] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.481s)
[177.373630] Subtest cursor-size-change: SUCCESS (2.283s)
[178.200738] [019/132] (842s left) kms_lease (lease-revoke)
[178.301267] Starting subtest: lease-revoke
[178.302158] Starting dynamic subtest: pipe-A-eDP-1
[178.334044] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.032s)
[178.347940] Starting dynamic subtest: pipe-B-eDP-1
[178.360230] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.025s)
[178.370395] Starting dynamic subtest: pipe-C-eDP-1
[178.387370] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.026s)
[178.396133] Starting dynamic subtest: pipe-D-eDP-1
[178.414768] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.026s)
[178.415742] Subtest lease-revoke: SUCCESS (0.114s)
[178.575608] [020/132] (842s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[178.629709] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[178.631670] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[178.829386] [021/132] (842s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[178.918053] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[178.919738] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[179.064809] [022/132] (842s left) kms_flip (2x-blocking-wf_vblank)
[179.153994] Starting subtest: 2x-blocking-wf_vblank
[179.164954] Subtest 2x-blocking-wf_vblank: SKIP (0.011s)
[179.292489] [023/132] (841s left) syncobj_timeline (single-wait-available-submitted)
[179.350920] Starting subtest: single-wait-available-submitted
[179.351992] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[179.449614] [024/132] (841s left) sriov_basic (enable-vfs-bind-unbind-each)
[179.504706] Starting subtest: enable-vfs-bind-unbind-each
[179.505772] Starting dynamic subtest: numvfs-1
[179.538736] Dynamic subtest numvfs-1: FAIL (0.015s)
[179.546200] Starting dynamic subtest: numvfs-2
[179.578503] Dynamic subtest numvfs-2: FAIL (0.004s)
[179.585142] Starting dynamic subtest: numvfs-3
[179.610975] Dynamic subtest numvfs-3: FAIL (0.003s)
[179.617293] Starting dynamic subtest: numvfs-4
[179.642375] Dynamic subtest numvfs-4: FAIL (0.003s)
[179.648640] Starting dynamic subtest: numvfs-5
[179.674404] Dynamic subtest numvfs-5: FAIL (0.003s)
[179.680443] Starting dynamic subtest: numvfs-6
[179.705784] Dynamic subtest numvfs-6: FAIL (0.004s)
[179.711891] Starting dynamic subtest: numvfs-7
[179.737290] Dynamic subtest numvfs-7: FAIL (0.003s)
[179.743378] Starting dynamic subtest: numvfs-random
[179.769946] Dynamic subtest numvfs-random: FAIL (0.004s)
[179.771191] Subtest enable-vfs-bind-unbind-each: FAIL (0.045s)
[179.796330] [025/132] (841s left) api_intel_bb (object-reloc-keep-cache)
[179.851778] Starting subtest: object-reloc-keep-cache
[179.854430] Subtest object-reloc-keep-cache: SKIP (0.003s)
[180.006678] [026/132] (841s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[180.089378] Starting subtest: fbc-psr2-sprite-mmap-gtt
[180.090278] Starting dynamic subtest: eDP-1
[180.091991] Dynamic subtest eDP-1: SKIP (0.000s)
[180.093972] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[180.177954] [027/132] (841s left) gem_exec_nop (basic-parallel)
[180.233473] Starting subtest: basic-parallel
[195.927809] Subtest basic-parallel: SUCCESS (15.693s)
[196.153774] [028/132] (825s left) i915_hangman (gt-engine-error)
[196.206775] Starting subtest: gt-engine-error
[196.207577] Starting dynamic subtest: rcs0
[197.879354] Dynamic subtest rcs0: SUCCESS (1.670s)
[197.888828] Starting dynamic subtest: bcs0
[199.861957] Dynamic subtest bcs0: SUCCESS (1.980s)
[199.872128] Starting dynamic subtest: vcs0
[201.909856] Dynamic subtest vcs0: SUCCESS (2.045s)
[201.919724] Starting dynamic subtest: vcs1
[203.892303] Dynamic subtest vcs1: SUCCESS (1.980s)
[203.901120] Starting dynamic subtest: vecs0
[205.878088] Dynamic subtest vecs0: SUCCESS (1.983s)
[205.888052] Starting dynamic subtest: ccs0
[207.860416] Dynamic subtest ccs0: SUCCESS (1.981s)
[207.862053] Subtest gt-engine-error: SUCCESS (11.654s)
[207.957777] [029/132] (813s left) kms_getfb (getfb-handle-protection)
[208.053429] Starting subtest: getfb-handle-protection
[208.079699] Subtest getfb-handle-protection: SUCCESS (0.026s)
[208.242520] [030/132] (813s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[208.338353] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[208.339276] Starting dynamic subtest: pipe-A-eDP-1
[208.347106] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[208.354427] Starting dynamic subtest: pipe-B-eDP-1
[208.362289] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[208.368980] Starting dynamic subtest: pipe-C-eDP-1
[208.376801] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[208.383182] Starting dynamic subtest: pipe-D-eDP-1
[208.390713] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[208.391571] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[210.669370] [031/132] (810s left) gem_pxp (reject-modify-context-protection-off-1)
[210.794766] Starting subtest: reject-modify-context-protection-off-1
[210.796032] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[210.937240] [032/132] (810s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[211.032231] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[218.031525] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.000s)
[218.163220] [033/132] (803s left) api_intel_allocator (alloc-simple)
[218.219506] Starting subtest: alloc-simple
[218.222514] Subtest alloc-simple: SUCCESS (0.004s)
[218.381258] [034/132] (803s left) perf (blocking)
[218.507673] Starting subtest: blocking
[218.508568] Starting dynamic subtest: 0-rcs0
[228.542084] Dynamic subtest 0-rcs0: SUCCESS (10.031s)
[228.549447] Starting dynamic subtest: 1-vcs0
[238.561027] Dynamic subtest 1-vcs0: SUCCESS (10.019s)
[238.562492] Subtest blocking: SUCCESS (20.053s)
[238.600893] [035/132] (782s left) kms_frontbuffer_tracking (psr-slowdraw)
[238.710147] Starting subtest: psr-slowdraw
[263.815541] Subtest psr-slowdraw: SUCCESS (25.105s)
[263.992181] [036/132] (757s left) gem_mmap (short-mmap)
[264.051851] Subtest short-mmap: SKIP (0.000s)
[264.113115] [037/132] (757s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[264.207103] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[264.207937] Starting dynamic subtest: pipe-A-default-mode
[264.495952] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[264.497805] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.288s)
[265.333997] [038/132] (756s left) kms_invalid_mode (bad-htotal)
[265.426239] Starting subtest: bad-htotal
[265.427052] Starting dynamic subtest: pipe-A-eDP-1
[265.716509] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[265.723606] Starting dynamic subtest: pipe-B-eDP-1
[265.724428] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[265.730972] Starting dynamic subtest: pipe-C-eDP-1
[265.731942] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[265.740271] Starting dynamic subtest: pipe-D-eDP-1
[265.741059] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[265.741872] Subtest bad-htotal: SUCCESS (0.295s)
[266.561651] [039/132] (755s left) gem_exec_alignment (forked)
[266.625080] Starting subtest: forked
[305.539853] Subtest forked: SUCCESS (38.911s)
[305.630899] [040/132] (716s left) kms_psr (pr-cursor-mmap-gtt)
[305.758378] Starting subtest: pr-cursor-mmap-gtt
[305.760283] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[305.846470] [041/132] (715s left) gem_mmap_wc (read-write)
[305.907293] Subtest read-write: SKIP (0.000s)
[305.960967] [042/132] (715s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[306.051839] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[313.487722] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.436s)
[313.651122] [043/132] (708s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[313.750687] Starting subtest: fbc-rgb565-draw-pwrite
[318.381942] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.631s)
[319.591018] [044/132] (702s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[319.683413] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[323.330653] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.647s)
[324.499803] [045/132] (697s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[324.592339] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[324.594046] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[324.714943] [046/132] (697s left) kms_cursor_crc (cursor-offscreen-128x42)
[324.920172] Starting subtest: cursor-offscreen-128x42
[324.964541] Subtest cursor-offscreen-128x42: SKIP (0.043s)
[325.199842] [047/132] (696s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[325.344769] Starting subtest: cursor-rapid-movement-32x10
[325.389829] Subtest cursor-rapid-movement-32x10: SKIP (0.043s)
[325.687013] [048/132] (696s left) gem_ctx_persistence (legacy-engines-persistence)
[325.755506] Starting subtest: legacy-engines-persistence
[325.756412] Starting dynamic subtest: render
[326.592849] Dynamic subtest render: SUCCESS (0.836s)
[326.605615] Starting dynamic subtest: bsd1
[327.363572] Dynamic subtest bsd1: SUCCESS (0.767s)
[327.374263] Starting dynamic subtest: bsd2
[328.162851] Dynamic subtest bsd2: SUCCESS (0.796s)
[328.174783] Starting dynamic subtest: blt
[328.942960] Dynamic subtest blt: SUCCESS (0.777s)
[328.955271] Starting dynamic subtest: vebox
[329.731701] Dynamic subtest vebox: SUCCESS (0.786s)
[329.732896] Subtest legacy-engines-persistence: SUCCESS (3.977s)
[329.861389] [049/132] (692s left) syncobj_wait (wait-any-complex)
[329.924740] Starting subtest: wait-any-complex
[329.988382] Subtest wait-any-complex: SUCCESS (0.064s)
[330.086415] [050/132] (691s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[330.183907] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[330.184755] Starting dynamic subtest: pipe-A-default-mode
[331.329419] Dynamic subtest pipe-A-default-mode: SKIP (1.144s)
[331.331159] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.145s)
[331.513056] [051/132] (690s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[331.614357] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[331.615149] Starting dynamic subtest: pipe-A
[331.634359] Dynamic subtest pipe-A: SKIP (0.019s)
[331.641889] Starting dynamic subtest: pipe-B
[331.668735] Dynamic subtest pipe-B: SKIP (0.033s)
[331.676316] Starting dynamic subtest: pipe-C
[331.702076] Dynamic subtest pipe-C: SKIP (0.033s)
[331.709505] Starting dynamic subtest: pipe-D
[331.734483] Dynamic subtest pipe-D: SKIP (0.032s)
[331.736204] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.119s)
[331.840745] [052/132] (690s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[331.944526] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[331.945484] Starting dynamic subtest: pipe-A-eDP-1
[331.953841] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[331.961508] Starting dynamic subtest: pipe-B-eDP-1
[331.969660] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[331.977055] Starting dynamic subtest: pipe-C-eDP-1
[331.985298] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[331.992630] Starting dynamic subtest: pipe-D-eDP-1
[332.001040] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[332.002690] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[334.197121] [053/132] (687s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[334.291586] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[334.293345] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[334.420790] [054/132] (687s left) drm_read (empty-nonblock)
[334.573213] Starting subtest: empty-nonblock
[334.574277] Subtest empty-nonblock: SUCCESS (0.000s)
[334.725423] [055/132] (687s left) gem_partial_pwrite_pread (write-display)
[334.786669] Subtest write-display: SKIP (0.000s)
[334.870093] [056/132] (687s left) gem_ctx_param (invalid-size-set)
[334.940020] Starting subtest: invalid-size-set
[334.941435] Subtest invalid-size-set: SUCCESS (0.001s)
[335.065663] [057/132] (687s left) gem_close_race (multigpu-basic-threads)
[335.129666] Starting subtest: multigpu-basic-threads
[335.131417] Subtest multigpu-basic-threads: SKIP (0.000s)
[335.374494] [058/132] (686s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[335.461310] Starting subtest: psr-dirtyfb-ioctl
[335.462252] Starting dynamic subtest: A-eDP-1
[339.370018] Dynamic subtest A-eDP-1: SUCCESS (3.908s)
[339.371055] Subtest psr-dirtyfb-ioctl: SUCCESS (3.910s)
[340.172733] [059/132] (682s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[340.269597] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[340.872849] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.603s)
[341.076156] [060/132] (681s left) gem_mmap_gtt (zero-extend)
[341.138028] Subtest zero-extend: SKIP (0.000s)
[341.203684] [061/132] (681s left) gem_lmem_swapping (massive-random)
[341.244978] Subtest massive-random: SKIP (0.000s)
[341.283602] [062/132] (681s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[341.400548] Starting subtest: 4-tiled-32bpp-rotate-270
[341.423332] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.022s)
[341.611039] [063/132] (680s left) kms_plane_alpha_blend (alpha-basic)
[341.698860] Starting subtest: alpha-basic
[341.989122] Starting dynamic subtest: pipe-A-eDP-1
[343.896289] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.907s)
[343.923552] Starting dynamic subtest: pipe-D-eDP-1
[346.540353] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.623s)
[346.541322] Subtest alpha-basic: SUCCESS (4.841s)
[347.354579] [064/132] (675s left) kms_sequence (get-idle)
[347.439725] Starting subtest: get-idle
[347.440785] Starting dynamic subtest: pipe-A-eDP-1
[349.249759] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.810s)
[349.257120] Starting dynamic subtest: pipe-B-eDP-1
[351.735532] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.484s)
[351.758054] Starting dynamic subtest: pipe-C-eDP-1
[354.236728] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.497s)
[354.247450] Starting dynamic subtest: pipe-D-eDP-1
[356.644396] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.406s)
[356.645413] Subtest get-idle: SUCCESS (9.207s)
[357.469433] [065/132] (665s left) syncobj_wait (multi-wait-all-submitted)
[357.536774] Starting subtest: multi-wait-all-submitted
[357.642700] Subtest multi-wait-all-submitted: SUCCESS (0.103s)
[357.730787] [066/132] (664s left) gem_exec_reloc (basic-cpu-read)
[357.796698] Subtest basic-cpu-read: SKIP (0.000s)
[357.862887] [067/132] (664s left) gem_exec_suspend (basic)
[357.928123] Starting subtest: basic
[357.929267] Starting dynamic subtest: smem
[359.895778] Dynamic subtest smem: SUCCESS (1.964s)
[359.897344] Subtest basic: SUCCESS (1.966s)
[360.096831] [068/132] (662s left) gem_exec_balancer (bonded-chain)
[360.158786] Starting subtest: bonded-chain
[367.148641] Subtest bonded-chain: SUCCESS (6.987s)
[367.882937] [069/132] (654s left) gem_ppgtt (shrink-vs-evict-any)
[367.943817] Starting subtest: shrink-vs-evict-any
[374.905466] Subtest shrink-vs-evict-any: SUCCESS (6.960s)
[374.996252] [070/132] (647s left) syncobj_basic (bad-create-flags)
[375.045339] Starting subtest: bad-create-flags
[375.046301] Subtest bad-create-flags: SUCCESS (0.000s)
[375.153430] [071/132] (647s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[375.198044] Starting subtest: etime-single-wait-all-for-submit-submitted
[375.307337] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.107s)
[375.404182] [072/132] (647s left) kms_flip (2x-flip-vs-fences-interruptible)
[375.496566] Starting subtest: 2x-flip-vs-fences-interruptible
[375.498255] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[375.602211] [073/132] (647s left) gem_softpin (allocator-nopin)
[375.660615] Starting subtest: allocator-nopin
[375.744336] Subtest allocator-nopin: SUCCESS (0.083s)
[375.888817] [074/132] (646s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[375.973157] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[375.974835] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[376.104781] [075/132] (646s left) prime_busy (before)
[376.164685] Starting subtest: before
[376.166304] Starting dynamic subtest: rcs0
[376.200960] Dynamic subtest rcs0: SUCCESS (0.035s)
[376.210781] Starting dynamic subtest: bcs0
[376.252810] Dynamic subtest bcs0: SUCCESS (0.051s)
[376.261858] Starting dynamic subtest: vcs0
[376.293103] Dynamic subtest vcs0: SUCCESS (0.039s)
[376.300064] Starting dynamic subtest: vcs1
[376.333157] Dynamic subtest vcs1: SUCCESS (0.040s)
[376.340494] Starting dynamic subtest: vecs0
[376.374684] Dynamic subtest vecs0: SUCCESS (0.041s)
[376.383908] Starting dynamic subtest: ccs0
[376.416535] Dynamic subtest ccs0: SUCCESS (0.041s)
[376.525264] Subtest before: SUCCESS (0.360s)
[376.615509] [076/132] (646s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[376.712942] Starting subtest: fbc-indfb-scaledprimary
[379.665564] Subtest fbc-indfb-scaledprimary: SUCCESS (2.952s)
[380.794131] [077/132] (642s left) gem_readwrite (read-write)
[380.845724] Subtest read-write: SKIP (0.000s)
[380.902342] [078/132] (642s left) gem_exec_reloc (basic-scanout)
[380.956062] Subtest basic-scanout: SKIP (0.000s)
[381.025711] [079/132] (641s left) gem_ctx_param (invalid-ctx-set)
[381.083446] Starting subtest: invalid-ctx-set
[381.084356] Subtest invalid-ctx-set: SUCCESS (0.001s)
[381.193641] [080/132] (641s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[381.250365] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[381.251315] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[381.385126] [081/132] (641s left) gem_readwrite (beyond-eob)
[381.452601] Subtest beyond-EOB: SKIP (0.000s)
[381.504872] [082/132] (641s left) kms_big_fb (linear-32bpp-rotate-0)
[381.604721] Starting subtest: linear-32bpp-rotate-0
[383.027033] Subtest linear-32bpp-rotate-0: SUCCESS (1.422s)
[383.181229] [083/132] (639s left) gem_mmap_gtt (basic-write)
[383.237631] Subtest basic-write: SKIP (0.000s)
[383.298218] [084/132] (639s left) fbdev (nullptr)
[383.339103] Starting subtest: nullptr
[383.340094] Subtest nullptr: SUCCESS (0.000s)
[383.412384] [085/132] (639s left) syncobj_wait (wait-all-complex)
[383.475812] Starting subtest: wait-all-complex
[383.691436] Subtest wait-all-complex: SUCCESS (0.213s)
[383.781778] [086/132] (639s left) gem_tiled_partial_pwrite_pread (reads)
[383.841354] Subtest reads: SKIP (0.000s)
[383.915265] [087/132] (639s left) syncobj_wait (wait-zero-handles)
[383.975794] Starting subtest: wait-zero-handles
[383.976861] Subtest wait-zero-handles: SUCCESS (0.000s)
[384.102037] [088/132] (639s left) kms_properties (crtc-properties-atomic)
[384.200071] Starting subtest: crtc-properties-atomic
[384.200944] Starting dynamic subtest: pipe-A-eDP-1
[384.636584] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.434s)
[384.648402] Starting dynamic subtest: pipe-B-eDP-1
[385.816348] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.179s)
[385.824346] Starting dynamic subtest: pipe-C-eDP-1
[386.936302] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.120s)
[386.944857] Starting dynamic subtest: pipe-D-eDP-1
[388.082833] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.145s)
[388.083879] Subtest crtc-properties-atomic: SUCCESS (3.883s)
[388.912514] [089/132] (634s left) gem_ctx_persistence (engines-hostile-preempt)
[388.975877] Starting subtest: engines-hostile-preempt
[388.976799] Starting dynamic subtest: rcs0
[389.118837] Dynamic subtest rcs0: SUCCESS (0.142s)
[389.130265] Starting dynamic subtest: bcs0
[389.212907] Dynamic subtest bcs0: SUCCESS (0.092s)
[389.224844] Starting dynamic subtest: vcs0
[390.920043] Dynamic subtest vcs0: SUCCESS (1.703s)
[390.930602] Starting dynamic subtest: vcs1
[392.903567] Dynamic subtest vcs1: SUCCESS (1.982s)
[392.915319] Starting dynamic subtest: vecs0
[394.936890] Dynamic subtest vecs0: SUCCESS (2.029s)
[394.947360] Starting dynamic subtest: ccs0
[395.028559] Dynamic subtest ccs0: SUCCESS (0.091s)
[395.032421] Subtest engines-hostile-preempt: SUCCESS (6.054s)
[395.124407] [090/132] (628s left) syncobj_timeline (multi-wait-all-available-submitted)
[395.185595] Starting subtest: multi-wait-all-available-submitted
[395.186589] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[395.317917] [091/132] (628s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[395.418307] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[395.419920] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[395.550983] [092/132] (627s left) syncobj_wait (single-wait-submitted)
[395.604116] Starting subtest: single-wait-submitted
[395.706084] Subtest single-wait-submitted: SUCCESS (0.102s)
[395.800565] [093/132] (627s left) gem_exec_schedule (preempt-self)
[395.866825] Starting subtest: preempt-self
[395.867846] Starting dynamic subtest: rcs0
[395.889414] Dynamic subtest rcs0: SUCCESS (0.022s)
[395.898048] Starting dynamic subtest: bcs0
[395.907408] Dynamic subtest bcs0: SUCCESS (0.017s)
[395.915738] Starting dynamic subtest: vcs0
[395.929061] Dynamic subtest vcs0: SUCCESS (0.021s)
[395.936871] Starting dynamic subtest: vcs1
[395.944620] Dynamic subtest vcs1: SUCCESS (0.015s)
[395.952398] Starting dynamic subtest: vecs0
[395.960699] Dynamic subtest vecs0: SUCCESS (0.015s)
[395.968323] Starting dynamic subtest: ccs0
[395.977878] Dynamic subtest ccs0: SUCCESS (0.016s)
[395.978804] Subtest preempt-self: SUCCESS (0.112s)
[398.052446] [094/132] (625s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[398.155440] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[404.891294] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.733s)
[405.033211] [095/132] (618s left) sysfs_preempt_timeout (idempotent)
[405.092297] Starting subtest: idempotent
[405.093313] Starting dynamic subtest: vecs0
[405.094294] Dynamic subtest vecs0: SUCCESS (0.000s)
[405.102933] Starting dynamic subtest: ccs0
[405.103748] Dynamic subtest ccs0: SUCCESS (0.000s)
[405.111167] Starting dynamic subtest: vcs0
[405.111975] Dynamic subtest vcs0: SUCCESS (0.000s)
[405.119399] Starting dynamic subtest: bcs0
[405.120232] Dynamic subtest bcs0: SUCCESS (0.000s)
[405.127460] Starting dynamic subtest: rcs0
[405.128290] Dynamic subtest rcs0: SUCCESS (0.000s)
[405.135416] Starting dynamic subtest: vcs1
[405.136279] Dynamic subtest vcs1: SUCCESS (0.000s)
[405.137090] Subtest idempotent: SUCCESS (0.006s)
[405.238655] [096/132] (618s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[405.338716] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[405.340606] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[405.455406] [097/132] (618s left) kms_atomic (crtc-invalid-params-fence)
[405.550126] Starting subtest: crtc-invalid-params-fence
[405.550917] Starting dynamic subtest: pipe-A-eDP-1
[405.998285] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.447s)
[405.999091] Subtest crtc-invalid-params-fence: SUCCESS (0.449s)
[406.864798] [098/132] (616s left) gem_fence_thrash (bo-write-verify-threaded-x)
[406.901084] Starting subtest: bo-write-verify-threaded-x
[406.923197] Subtest bo-write-verify-threaded-x: SKIP (0.023s)
[406.990096] [099/132] (616s left) gem_wait (busy)
[407.053680] Starting subtest: busy
[407.054797] Starting dynamic subtest: all-engines
[408.918784] Dynamic subtest all-engines: SUCCESS (1.862s)
[408.929268] Starting dynamic subtest: rcs0
[409.459397] Dynamic subtest rcs0: SUCCESS (0.540s)
[409.469507] Starting dynamic subtest: bcs0
[409.999734] Dynamic subtest bcs0: SUCCESS (0.539s)
[410.009438] Starting dynamic subtest: vcs0
[411.927988] Dynamic subtest vcs0: SUCCESS (1.925s)
[411.938055] Starting dynamic subtest: vcs1
[413.911330] Dynamic subtest vcs1: SUCCESS (1.981s)
[413.921625] Starting dynamic subtest: vecs0
[415.893429] Dynamic subtest vecs0: SUCCESS (1.981s)
[415.905090] Starting dynamic subtest: ccs0
[416.435788] Dynamic subtest ccs0: SUCCESS (0.541s)
[416.436773] Subtest busy: SUCCESS (9.383s)
[416.654042] [100/132] (606s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[416.771470] Starting subtest: x-tiled-64bpp-rotate-180
[418.351097] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.580s)
[418.569506] [101/132] (605s left) kms_force_connector_basic (force-edid)
[418.647515] Starting subtest: force-edid
[419.013428] Subtest force-edid: SUCCESS (0.366s)
[419.171187] [102/132] (604s left) gem_ctx_param (basic-default)
[419.212548] Starting subtest: basic-default
[419.213608] Subtest basic-default: SUCCESS (0.000s)
[419.296387] [103/132] (604s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[419.385140] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[419.385989] Starting dynamic subtest: pipe-A-eDP-1
[435.729643] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.005s)
[435.738289] Starting dynamic subtest: pipe-B-eDP-1
[453.696867] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.788s)
[453.705547] Starting dynamic subtest: pipe-C-eDP-1
[471.653061] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.793s)
[471.662189] Starting dynamic subtest: pipe-D-eDP-1
[489.693723] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.772s)
[489.694553] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (10.363s)
[496.928380] [104/132] (532s left) kms_pm_rpm (modeset-stress-extra-wait)
[499.078618] Starting subtest: modeset-stress-extra-wait
[553.374127] Subtest modeset-stress-extra-wait: SUCCESS (54.187s)
[553.480710] [105/132] (476s left) kms_flip (2x-flip-vs-suspend)
[553.573380] Starting subtest: 2x-flip-vs-suspend
[553.584656] Subtest 2x-flip-vs-suspend: SKIP (0.011s)
[553.699933] [106/132] (476s left) kms_chamelium_frames (dp-crc-fast)
[554.071343] Subtest dp-crc-fast: SKIP (0.000s)
[554.856285] [107/132] (475s left) intel_hwmon (hwmon-write)
[554.920199] Subtest hwmon-write: SKIP (0.000s)
[554.979830] [108/132] (474s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[555.075213] Starting subtest: psr-rgb101010-draw-render
[562.756347] Subtest psr-rgb101010-draw-render: SUCCESS (7.678s)
[562.893863] [109/132] (467s left) gem_exec_flush (basic-wb-pro-default)
[562.955202] Starting subtest: basic-wb-pro-default
[568.416490] Subtest basic-wb-pro-default: SUCCESS (5.459s)
[568.620467] [110/132] (461s left) kms_prop_blob (invalid-get-prop)
[568.677271] Starting subtest: invalid-get-prop
[568.678223] Subtest invalid-get-prop: SUCCESS (0.000s)
[568.812193] [111/132] (461s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[568.914012] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[575.488456] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.572s)
[575.614343] [112/132] (454s left) kms_plane (plane-position-hole-dpms)
[575.706597] Starting subtest: plane-position-hole-dpms
[576.249387] Starting dynamic subtest: pipe-A-plane-1
[578.630589] Dynamic subtest pipe-A-plane-1: SUCCESS (2.380s)
[578.639305] Starting dynamic subtest: pipe-A-plane-2
[581.054911] Dynamic subtest pipe-A-plane-2: SUCCESS (2.423s)
[581.063479] Starting dynamic subtest: pipe-A-plane-3
[583.421225] Dynamic subtest pipe-A-plane-3: SUCCESS (2.363s)
[583.430196] Starting dynamic subtest: pipe-A-plane-4
[585.826782] Dynamic subtest pipe-A-plane-4: SUCCESS (2.405s)
[585.835312] Starting dynamic subtest: pipe-A-plane-5
[585.852985] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[587.061284] Starting dynamic subtest: pipe-B-plane-1
[589.453946] Dynamic subtest pipe-B-plane-1: SUCCESS (2.399s)
[589.462563] Starting dynamic subtest: pipe-B-plane-2
[591.842398] Dynamic subtest pipe-B-plane-2: SUCCESS (2.387s)
[591.852249] Starting dynamic subtest: pipe-B-plane-3
[594.267611] Dynamic subtest pipe-B-plane-3: SUCCESS (2.425s)
[594.277339] Starting dynamic subtest: pipe-B-plane-4
[596.616506] Dynamic subtest pipe-B-plane-4: SUCCESS (2.349s)
[596.627347] Starting dynamic subtest: pipe-B-plane-5
[596.641106] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[596.641963] Subtest plane-position-hole-dpms: SUCCESS (20.931s)
[597.520803] [113/132] (432s left) perf_pmu (busy-start)
[597.565958] Starting subtest: busy-start
[597.567064] Starting dynamic subtest: rcs0
[600.118503] Dynamic subtest rcs0: SUCCESS (2.554s)
[600.130476] Starting dynamic subtest: bcs0
[602.670375] Dynamic subtest bcs0: SUCCESS (2.551s)
[602.683057] Starting dynamic subtest: vcs0
[605.822865] Dynamic subtest vcs0: SUCCESS (3.151s)
[605.835836] Starting dynamic subtest: vcs1
[609.857320] Dynamic subtest vcs1: SUCCESS (4.032s)
[609.868876] Starting dynamic subtest: vecs0
[613.822806] Dynamic subtest vecs0: SUCCESS (3.966s)
[613.834646] Starting dynamic subtest: ccs0
[616.373555] Dynamic subtest ccs0: SUCCESS (2.550s)
[616.377999] Subtest busy-start: SUCCESS (18.821s)
[616.529440] [114/132] (413s left) kms_color_pipeline (plane-lut1d)
[616.623741] Starting subtest: plane-lut1d
[616.638325] Starting dynamic subtest: pipe-A-eDP-1
[617.102833] Dynamic subtest pipe-A-eDP-1: FAIL (0.323s)
[618.019963] Starting dynamic subtest: pipe-B-eDP-1
[618.500942] Dynamic subtest pipe-B-eDP-1: FAIL (0.303s)
[619.418679] Starting dynamic subtest: pipe-C-eDP-1
[619.888231] Dynamic subtest pipe-C-eDP-1: FAIL (0.269s)
[620.727436] Starting dynamic subtest: pipe-D-eDP-1
[621.168322] Dynamic subtest pipe-D-eDP-1: FAIL (0.235s)
[621.244563] Subtest plane-lut1d: FAIL (4.623s)
[622.094760] [115/132] (408s left) gen9_exec_parse (batch-zero-length)
[622.161759] Subtest batch-zero-length: SKIP (0.000s)
[622.234058] [116/132] (407s left) i915_drm_fdinfo (context-close-stress)
[622.272573] Starting subtest: context-close-stress
[633.016247] Subtest context-close-stress: SUCCESS (10.743s)
[633.129145] [117/132] (397s left) kms_chamelium_hpd (hdmi-hpd-storm)
[633.688334] Subtest hdmi-hpd-storm: SKIP (0.000s)
[634.444935] [118/132] (395s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[634.530697] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[634.531557] Starting dynamic subtest: pipe-A-eDP-1
[634.542189] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[634.556087] Starting dynamic subtest: pipe-B-eDP-1
[634.566534] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[634.576652] Starting dynamic subtest: pipe-C-eDP-1
[634.587031] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[634.597083] Starting dynamic subtest: pipe-D-eDP-1
[634.606469] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[634.608150] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[636.792955] [119/132] (393s left) syncobj_timeline (invalid-signal-bad-pad)
[636.840559] Starting subtest: invalid-signal-bad-pad
[636.841499] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[636.966056] [120/132] (393s left) gem_exec_fence (submit67)
[637.146492] Starting subtest: submit67
[637.148604] Subtest submit67: SKIP (0.000s)
[638.868414] [FACT gem_exec_fence (submit67)] new: kernel.kmod_is_loaded.vgem: true
[638.870775] [121/132] (391s left) gem_eio (in-flight-internal-10ms)
[639.094273] Starting subtest: in-flight-internal-10ms
[640.925499] Subtest in-flight-internal-10ms: SUCCESS (1.831s)
[641.097380] [122/132] (389s left) gem_exec_schedule (preempt-contexts)
[641.176898] Starting subtest: preempt-contexts
[641.177846] Starting dynamic subtest: rcs0
[641.234180] Dynamic subtest rcs0: SUCCESS (0.058s)
[641.243641] Starting dynamic subtest: bcs0
[641.288724] Dynamic subtest bcs0: SUCCESS (0.054s)
[641.298842] Starting dynamic subtest: vcs0
[641.337490] Dynamic subtest vcs0: SUCCESS (0.048s)
[641.347411] Starting dynamic subtest: vcs1
[641.382932] Dynamic subtest vcs1: SUCCESS (0.045s)
[641.392419] Starting dynamic subtest: vecs0
[641.428832] Dynamic subtest vecs0: SUCCESS (0.045s)
[641.438346] Starting dynamic subtest: ccs0
[641.481357] Dynamic subtest ccs0: SUCCESS (0.052s)
[641.482306] Subtest preempt-contexts: SUCCESS (0.306s)
[642.949281] [123/132] (387s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[647.967361] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[647.970225] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.003s)
[648.789984] [124/132] (381s left) kms_chamelium_audio (dp-audio)
[649.175353] Subtest dp-audio: SKIP (0.000s)
[649.940214] [125/132] (380s left) kms_psr (psr2-cursor-plane-onoff)
[650.026532] Starting subtest: psr2-cursor-plane-onoff
[650.027483] Starting dynamic subtest: eDP-1
[651.716921] Dynamic subtest eDP-1: SUCCESS (1.689s)
[651.717754] Subtest psr2-cursor-plane-onoff: SUCCESS (1.690s)
[652.589129] [126/132] (377s left) kms_plane_scaling (planes-downscale-factor-0-75)
[652.683933] Starting subtest: planes-downscale-factor-0-75
[652.684889] Starting dynamic subtest: pipe-A
[652.705228] Dynamic subtest pipe-A: SKIP (0.020s)
[652.714823] Starting dynamic subtest: pipe-B
[652.737988] Dynamic subtest pipe-B: SKIP (0.032s)
[652.747670] Starting dynamic subtest: pipe-C
[652.771693] Dynamic subtest pipe-C: SKIP (0.032s)
[652.781392] Starting dynamic subtest: pipe-D
[652.803787] Dynamic subtest pipe-D: SKIP (0.033s)
[652.805449] Subtest planes-downscale-factor-0-75: SKIP (0.119s)
[652.939437] [127/132] (377s left) kms_vblank (ts-continuation-modeset)
[653.043260] Starting subtest: ts-continuation-modeset
[653.044305] Starting dynamic subtest: pipe-A-eDP-1
[654.505216] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.463s)
[654.517711] Starting dynamic subtest: pipe-D-eDP-1
[656.709616] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.202s)
[656.710555] Subtest ts-continuation-modeset: SUCCESS (3.669s)
[657.594083] [128/132] (373s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[657.649544] Starting subtest: framebuffer-vs-set-tiling
[657.651239] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[657.836871] [129/132] (372s left) kms_cursor_crc (cursor-sliding-512x170)
[658.109016] Starting subtest: cursor-sliding-512x170
[658.112292] Subtest cursor-sliding-512x170: SKIP (0.001s)
[658.291312] [130/132] (372s left) gem_exec_capture (capture)
[658.357963] Starting subtest: capture
[658.358950] Starting dynamic subtest: rcs0-smem
[659.235535] Dynamic subtest rcs0-smem: SUCCESS (0.876s)
[659.246317] Starting dynamic subtest: bcs0-smem
[660.121911] Dynamic subtest bcs0-smem: SUCCESS (0.886s)
[660.130636] Starting dynamic subtest: vcs0-smem
[660.949718] Dynamic subtest vcs0-smem: SUCCESS (0.827s)
[660.959547] Starting dynamic subtest: vcs1-smem
[661.793241] Dynamic subtest vcs1-smem: SUCCESS (0.843s)
[661.805600] Starting dynamic subtest: vecs0-smem
[663.148604] Dynamic subtest vecs0-smem: FAIL (1.332s)
[663.157663] Starting dynamic subtest: ccs0-smem
[664.458909] Dynamic subtest ccs0-smem: SUCCESS (1.332s)
[664.460035] Subtest capture: FAIL (6.100s)
[664.608060] [131/132] (366s left) i915_pm_rps (min-max-config-idle)
[664.666031] Starting subtest: min-max-config-idle
[664.669293] Subtest min-max-config-idle: SKIP (0.001s)
[664.797575] [132/132] (365s left) kms_flip (2x-plain-flip)
[664.901965] Starting subtest: 2x-plain-flip
[664.913889] Subtest 2x-plain-flip: SKIP (0.011s)
[665.010963] 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.