[56.931893] Initializing watchdogs
[56.932027]   /dev/watchdog0
[56.950593] [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.955365] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.957868] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.961201] [001/132] (960s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[57.092295] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[57.096596] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[57.228809] [002/132] (960s left) kms_vrr (seamless-rr-switch-virtual)
[57.318527] Starting subtest: seamless-rr-switch-virtual
[57.324745] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[57.412901] [003/132] (960s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[57.466337] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[57.534303] [004/132] (960s left) kms_content_protection (dp-mst-type-1)
[57.676427] Starting subtest: dp-mst-type-1
[57.681111] Subtest dp-mst-type-1: SKIP (0.000s)
[57.839195] [005/132] (959s left) core_setmaster (master-drop-set-shared-fd)
[57.933807] Starting subtest: master-drop-set-shared-fd
[57.955624] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[57.989748] [006/132] (959s left) i915_selftest (mock)
[59.843770] Starting subtest: mock
[59.846648] Starting dynamic subtest: sanitycheck
[60.629540] Dynamic subtest sanitycheck: SUCCESS (0.786s)
[60.637946] Starting dynamic subtest: shmem
[61.375249] Dynamic subtest shmem: SUCCESS (0.745s)
[61.384147] Starting dynamic subtest: fence
[69.088361] Dynamic subtest fence: SUCCESS (7.711s)
[69.096969] Starting dynamic subtest: scatterlist
[70.839071] Dynamic subtest scatterlist: SUCCESS (1.750s)
[70.848303] Starting dynamic subtest: syncmap
[74.114612] Dynamic subtest syncmap: SUCCESS (3.274s)
[74.123681] Starting dynamic subtest: uncore
[74.833226] Dynamic subtest uncore: SUCCESS (0.719s)
[74.842087] Starting dynamic subtest: ring
[75.595146] Dynamic subtest ring: SUCCESS (0.761s)
[75.604082] Starting dynamic subtest: engine
[76.374133] Dynamic subtest engine: SUCCESS (0.778s)
[76.383040] Starting dynamic subtest: timelines
[80.278404] Dynamic subtest timelines: SUCCESS (3.902s)
[80.287021] Starting dynamic subtest: requests
[83.675082] Dynamic subtest requests: SUCCESS (3.397s)
[83.683076] Starting dynamic subtest: objects
[84.568504] Dynamic subtest objects: SUCCESS (0.892s)
[84.582954] Starting dynamic subtest: phys
[85.439527] Dynamic subtest phys: SUCCESS (0.870s)
[85.448143] Starting dynamic subtest: dmabuf
[86.287554] Dynamic subtest dmabuf: SUCCESS (0.847s)
[86.296080] Starting dynamic subtest: vma
[91.781579] Dynamic subtest vma: SUCCESS (5.492s)
[91.790063] Starting dynamic subtest: evict
[93.274084] Dynamic subtest evict: SUCCESS (1.492s)
[93.283433] Starting dynamic subtest: gtt
[96.579189] Dynamic subtest gtt: SUCCESS (3.304s)
[96.587761] Starting dynamic subtest: hugepages
[97.562653] Dynamic subtest hugepages: SUCCESS (0.983s)
[97.571623] Starting dynamic subtest: memory_region
[100.282089] Dynamic subtest memory_region: SUCCESS (2.718s)
[100.284849] Subtest mock: SUCCESS (40.439s)
[100.308873] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[100.312182] [007/132] (917s left) kms_psr (psr-sprite-plane-onoff)
[101.902096] Starting subtest: psr-sprite-plane-onoff
[101.904443] Starting dynamic subtest: eDP-1
[103.646638] Dynamic subtest eDP-1: SUCCESS (1.745s)
[103.649013] Subtest psr-sprite-plane-onoff: SUCCESS (1.745s)
[104.517642] [FACT kms_psr (psr-sprite-plane-onoff)] new: kernel.kmod_is_loaded.i915: true
[104.521191] [008/132] (913s left) kms_psr (fbc-psr2-basic)
[104.619738] Starting subtest: fbc-psr2-basic
[104.621631] Starting dynamic subtest: eDP-1
[104.625702] Dynamic subtest eDP-1: SKIP (0.000s)
[104.629719] Subtest fbc-psr2-basic: SKIP (0.000s)
[104.716215] [009/132] (913s left) kms_atomic_transition (plane-all-transition-nonblocking)
[104.806971] Starting subtest: plane-all-transition-nonblocking
[104.809369] Starting dynamic subtest: pipe-A-eDP-1
[107.299955] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[107.615327] Starting dynamic subtest: pipe-B-eDP-1
[110.824733] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.218s)
[111.122640] Subtest plane-all-transition-nonblocking: SUCCESS (6.316s)
[111.969523] [010/132] (905s left) kms_fence_pin_leak
[112.137403] [011/132] (905s left) gem_partial_pwrite_pread (writes-after-reads-display)
[112.199043] Subtest writes-after-reads-display: SKIP (0.000s)
[112.268548] [012/132] (905s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[117.344419] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[117.346331] Starting dynamic subtest: pipe-A-eDP-1
[128.756660] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.411s)
[128.767960] Starting dynamic subtest: pipe-B-eDP-1
[140.176285] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.416s)
[140.178577] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.831s)
[141.066080] [013/132] (876s left) gem_mmap_gtt (big-bo-tiledx)
[141.143385] Subtest big-bo-tiledX: SKIP (0.000s)
[141.208704] [014/132] (876s left) kms_fbcon_fbt (psr)
[141.267925] Starting subtest: psr
[148.598148] Subtest psr: SUCCESS (7.326s)
[148.669547] [015/132] (869s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[148.777059] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[148.779400] Starting dynamic subtest: pipe-A-eDP-1
[151.021016] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.242s)
[151.028935] Starting dynamic subtest: pipe-B-eDP-1
[153.380577] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.359s)
[153.387995] Starting dynamic subtest: pipe-C-eDP-1
[155.519241] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.137s)
[155.527536] Starting dynamic subtest: pipe-D-eDP-1
[157.657097] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.138s)
[157.658886] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.882s)
[158.936380] [016/132] (859s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[159.041655] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[159.046087] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[159.169244] [017/132] (858s left) gem_exec_whisper (basic-contexts-all)
[159.236829] Starting subtest: basic-contexts-all
[170.870957] Subtest basic-contexts-all: SUCCESS (11.630s)
[171.075624] [018/132] (847s left) kms_cursor_crc (cursor-size-change)
[171.172043] Starting subtest: cursor-size-change
[171.174273] Starting dynamic subtest: pipe-A-eDP-1
[171.970572] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.797s)
[171.978519] Starting dynamic subtest: pipe-D-eDP-1
[173.484899] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.513s)
[173.487151] Subtest cursor-size-change: SUCCESS (2.313s)
[174.297566] [019/132] (843s left) kms_lease (lease-revoke)
[174.402342] Starting subtest: lease-revoke
[174.404655] Starting dynamic subtest: pipe-A-eDP-1
[174.435419] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.032s)
[174.443734] Starting dynamic subtest: pipe-B-eDP-1
[174.461106] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.027s)
[174.470393] Starting dynamic subtest: pipe-C-eDP-1
[174.487716] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.025s)
[174.496456] Starting dynamic subtest: pipe-D-eDP-1
[174.516917] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.026s)
[174.518873] Subtest lease-revoke: SUCCESS (0.115s)
[174.678980] [020/132] (843s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[174.752746] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[174.757445] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[174.956288] [021/132] (843s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[175.047629] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[175.051734] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[175.178188] [022/132] (843s left) kms_flip (2x-blocking-wf_vblank)
[175.274957] Starting subtest: 2x-blocking-wf_vblank
[175.286121] Subtest 2x-blocking-wf_vblank: SKIP (0.010s)
[175.382750] [023/132] (842s left) syncobj_timeline (single-wait-available-submitted)
[175.444833] Starting subtest: single-wait-available-submitted
[175.447422] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[175.578469] [024/132] (842s left) sriov_basic (enable-vfs-bind-unbind-each)
[175.642163] Starting subtest: enable-vfs-bind-unbind-each
[175.644498] Starting dynamic subtest: numvfs-1
[175.722846] Dynamic subtest numvfs-1: FAIL (0.029s)
[175.732853] Starting dynamic subtest: numvfs-2
[175.805616] Dynamic subtest numvfs-2: FAIL (0.004s)
[175.815581] Starting dynamic subtest: numvfs-3
[175.886773] Dynamic subtest numvfs-3: FAIL (0.004s)
[175.895877] Starting dynamic subtest: numvfs-4
[175.955118] Dynamic subtest numvfs-4: FAIL (0.004s)
[175.964160] Starting dynamic subtest: numvfs-5
[176.024066] Dynamic subtest numvfs-5: FAIL (0.004s)
[176.032554] Starting dynamic subtest: numvfs-6
[176.092769] Dynamic subtest numvfs-6: FAIL (0.003s)
[176.102794] Starting dynamic subtest: numvfs-7
[176.162543] Dynamic subtest numvfs-7: FAIL (0.004s)
[176.171086] Starting dynamic subtest: numvfs-random
[176.230793] Dynamic subtest numvfs-random: FAIL (0.003s)
[176.232488] Subtest enable-vfs-bind-unbind-each: FAIL (0.059s)
[176.266640] [025/132] (842s left) api_intel_bb (object-reloc-keep-cache)
[176.333968] Starting subtest: object-reloc-keep-cache
[176.339775] Subtest object-reloc-keep-cache: SKIP (0.006s)
[176.497871] [026/132] (841s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[176.589430] Starting subtest: fbc-psr2-sprite-mmap-gtt
[176.591355] Starting dynamic subtest: eDP-1
[176.594788] Dynamic subtest eDP-1: SKIP (0.000s)
[176.598250] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[176.682952] [027/132] (841s left) gem_exec_nop (basic-parallel)
[176.743766] Starting subtest: basic-parallel
[193.842356] Subtest basic-parallel: SUCCESS (17.106s)
[194.108705] [028/132] (824s left) i915_hangman (gt-engine-error)
[194.190179] Starting subtest: gt-engine-error
[194.192968] Starting dynamic subtest: rcs0
[195.892225] Dynamic subtest rcs0: SUCCESS (1.702s)
[195.904960] Starting dynamic subtest: bcs0
[197.875410] Dynamic subtest bcs0: SUCCESS (1.981s)
[197.890194] Starting dynamic subtest: vcs0
[199.860834] Dynamic subtest vcs0: SUCCESS (1.983s)
[199.871739] Starting dynamic subtest: vcs1
[201.844481] Dynamic subtest vcs1: SUCCESS (1.981s)
[201.856036] Starting dynamic subtest: vecs0
[203.892469] Dynamic subtest vecs0: SUCCESS (2.045s)
[203.903934] Starting dynamic subtest: ccs0
[205.876473] Dynamic subtest ccs0: SUCCESS (1.981s)
[205.879470] Subtest gt-engine-error: SUCCESS (11.688s)
[205.983410] [029/132] (812s left) kms_getfb (getfb-handle-protection)
[206.082269] Starting subtest: getfb-handle-protection
[206.109132] Subtest getfb-handle-protection: SUCCESS (0.028s)
[206.235334] [030/132] (812s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[206.333276] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[206.335561] Starting dynamic subtest: pipe-A-eDP-1
[206.356058] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[206.366222] Starting dynamic subtest: pipe-B-eDP-1
[206.385670] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[206.393517] Starting dynamic subtest: pipe-C-eDP-1
[206.413611] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[206.421146] Starting dynamic subtest: pipe-D-eDP-1
[206.441252] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[206.443238] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[208.574087] [031/132] (810s left) gem_pxp (reject-modify-context-protection-off-1)
[208.712632] Starting subtest: reject-modify-context-protection-off-1
[208.715085] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[208.837265] [032/132] (809s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[208.942532] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[215.952427] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.012s)
[216.087762] [033/132] (802s left) api_intel_allocator (alloc-simple)
[216.147383] Starting subtest: alloc-simple
[216.149287] Subtest alloc-simple: SUCCESS (0.004s)
[216.313988] [034/132] (802s left) perf (blocking)
[216.461733] Starting subtest: blocking
[216.463960] Starting dynamic subtest: 0-rcs0
[226.498670] Dynamic subtest 0-rcs0: SUCCESS (10.035s)
[226.507183] Starting dynamic subtest: 1-vcs1
[236.519131] Dynamic subtest 1-vcs1: SUCCESS (10.019s)
[236.521761] Subtest blocking: SUCCESS (20.057s)
[236.565712] [035/132] (782s left) kms_frontbuffer_tracking (psr-slowdraw)
[236.670101] Starting subtest: psr-slowdraw
[261.948177] Subtest psr-slowdraw: SUCCESS (25.280s)
[262.127321] [036/132] (756s left) gem_mmap (short-mmap)
[262.180275] Subtest short-mmap: SKIP (0.000s)
[262.239074] [037/132] (756s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[262.335232] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[262.337522] Starting dynamic subtest: pipe-A-default-mode
[262.623819] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[262.628504] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.286s)
[263.437490] [038/132] (755s left) kms_invalid_mode (bad-htotal)
[263.537241] Starting subtest: bad-htotal
[263.539541] Starting dynamic subtest: pipe-A-eDP-1
[263.830995] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s)
[263.839684] Starting dynamic subtest: pipe-B-eDP-1
[263.841622] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[263.849553] Starting dynamic subtest: pipe-C-eDP-1
[263.851857] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[263.860073] Starting dynamic subtest: pipe-D-eDP-1
[263.862579] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[263.864943] Subtest bad-htotal: SUCCESS (0.298s)
[264.662507] [039/132] (754s left) gem_exec_alignment (forked)
[264.728977] Starting subtest: forked
[303.226468] Subtest forked: SUCCESS (38.493s)
[303.325726] [040/132] (715s left) kms_psr (pr-cursor-mmap-gtt)
[303.473898] Starting subtest: pr-cursor-mmap-gtt
[303.478645] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[303.588140] [041/132] (715s left) gem_mmap_wc (read-write)
[303.635870] Subtest read-write: SKIP (0.000s)
[303.696794] [042/132] (715s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[303.804945] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[311.184084] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.389s)
[311.362565] [043/132] (707s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[311.460053] Starting subtest: fbc-rgb565-draw-pwrite
[316.004155] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.547s)
[317.194787] [044/132] (701s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[317.297126] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[320.873876] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.581s)
[322.095223] [045/132] (697s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[322.204409] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[322.208466] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[322.342079] [046/132] (696s left) kms_cursor_crc (cursor-offscreen-128x42)
[322.558287] Starting subtest: cursor-offscreen-128x42
[322.609577] Subtest cursor-offscreen-128x42: SKIP (0.045s)
[322.845407] [047/132] (696s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[323.001476] Starting subtest: cursor-rapid-movement-32x10
[323.053572] Subtest cursor-rapid-movement-32x10: SKIP (0.050s)
[323.347127] [048/132] (695s left) gem_ctx_persistence (legacy-engines-persistence)
[323.421843] Starting subtest: legacy-engines-persistence
[323.423705] Starting dynamic subtest: render
[324.266989] Dynamic subtest render: SUCCESS (0.846s)
[324.285124] Starting dynamic subtest: bsd1
[325.092854] Dynamic subtest bsd1: SUCCESS (0.823s)
[325.107196] Starting dynamic subtest: bsd2
[325.875431] Dynamic subtest bsd2: SUCCESS (0.779s)
[325.887009] Starting dynamic subtest: blt
[326.699920] Dynamic subtest blt: SUCCESS (0.822s)
[326.711819] Starting dynamic subtest: vebox
[327.527270] Dynamic subtest vebox: SUCCESS (0.824s)
[327.529792] Subtest legacy-engines-persistence: SUCCESS (4.108s)
[327.629385] [049/132] (691s left) syncobj_wait (wait-any-complex)
[327.711795] Starting subtest: wait-any-complex
[327.773244] Subtest wait-any-complex: SUCCESS (0.061s)
[327.900573] [050/132] (691s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[328.007937] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[328.010150] Starting dynamic subtest: pipe-A-default-mode
[329.130488] Dynamic subtest pipe-A-default-mode: SKIP (1.117s)
[329.134613] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.119s)
[329.330312] [051/132] (690s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[329.425208] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[329.427522] Starting dynamic subtest: pipe-A
[329.448732] Dynamic subtest pipe-A: SKIP (0.019s)
[329.462051] Starting dynamic subtest: pipe-B
[329.481340] Dynamic subtest pipe-B: SKIP (0.034s)
[329.490852] Starting dynamic subtest: pipe-C
[329.516233] Dynamic subtest pipe-C: SKIP (0.033s)
[329.524684] Starting dynamic subtest: pipe-D
[329.549937] Dynamic subtest pipe-D: SKIP (0.033s)
[329.554134] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.122s)
[329.685987] [052/132] (689s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[329.787226] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[329.789431] Starting dynamic subtest: pipe-A-eDP-1
[329.812260] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[329.823250] Starting dynamic subtest: pipe-B-eDP-1
[329.844662] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[329.853248] Starting dynamic subtest: pipe-C-eDP-1
[329.874952] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[329.883498] Starting dynamic subtest: pipe-D-eDP-1
[329.905897] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[329.910037] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[332.077512] [053/132] (687s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[332.185388] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[332.189272] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[332.325941] [054/132] (687s left) drm_read (empty-nonblock)
[332.503267] Starting subtest: empty-nonblock
[332.505632] Subtest empty-nonblock: SUCCESS (0.000s)
[332.698945] [055/132] (686s left) gem_partial_pwrite_pread (write-display)
[332.755499] Subtest write-display: SKIP (0.000s)
[332.826403] [056/132] (686s left) gem_ctx_param (invalid-size-set)
[332.881760] Starting subtest: invalid-size-set
[332.884036] Subtest invalid-size-set: SUCCESS (0.001s)
[333.008395] [057/132] (686s left) gem_close_race (multigpu-basic-threads)
[333.069557] Starting subtest: multigpu-basic-threads
[333.073281] Subtest multigpu-basic-threads: SKIP (0.000s)
[333.305746] [058/132] (686s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[333.406015] Starting subtest: psr-dirtyfb-ioctl
[333.410367] Starting dynamic subtest: A-eDP-1
[337.361557] Dynamic subtest A-eDP-1: SUCCESS (3.956s)
[337.363910] Subtest psr-dirtyfb-ioctl: SUCCESS (3.958s)
[338.189794] [059/132] (681s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[338.287918] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[338.878550] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.592s)
[339.095548] [060/132] (680s left) gem_mmap_gtt (zero-extend)
[339.158556] Subtest zero-extend: SKIP (0.000s)
[339.213546] [061/132] (680s left) gem_lmem_swapping (massive-random)
[339.255408] Subtest massive-random: SKIP (0.000s)
[339.307834] [062/132] (680s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[339.413462] Starting subtest: 4-tiled-32bpp-rotate-270
[339.433939] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.020s)
[339.581199] [063/132] (680s left) kms_plane_alpha_blend (alpha-basic)
[339.679204] Starting subtest: alpha-basic
[339.973697] Starting dynamic subtest: pipe-A-eDP-1
[341.909891] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.934s)
[341.948479] Starting dynamic subtest: pipe-D-eDP-1
[344.542494] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.602s)
[344.544895] Subtest alpha-basic: SUCCESS (4.865s)
[345.367978] [064/132] (674s left) kms_sequence (get-idle)
[345.479153] Starting subtest: get-idle
[345.481352] Starting dynamic subtest: pipe-A-eDP-1
[347.292961] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.813s)
[347.302533] Starting dynamic subtest: pipe-B-eDP-1
[349.714856] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.420s)
[349.724463] Starting dynamic subtest: pipe-C-eDP-1
[352.135655] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.419s)
[352.145064] Starting dynamic subtest: pipe-D-eDP-1
[354.557910] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.422s)
[354.560289] Subtest get-idle: SUCCESS (9.079s)
[355.386941] [065/132] (664s left) syncobj_wait (multi-wait-all-submitted)
[355.454419] Starting subtest: multi-wait-all-submitted
[355.561778] Subtest multi-wait-all-submitted: SUCCESS (0.106s)
[355.662620] [066/132] (664s left) gem_exec_reloc (basic-cpu-read)
[355.733017] Subtest basic-cpu-read: SKIP (0.000s)
[355.829092] [067/132] (664s left) gem_exec_suspend (basic)
[355.903492] Starting subtest: basic
[355.905969] Starting dynamic subtest: smem
[357.908087] Dynamic subtest smem: SUCCESS (2.004s)
[357.911050] Subtest basic: SUCCESS (2.006s)
[358.122050] [068/132] (662s left) gem_exec_balancer (bonded-chain)
[358.189019] Starting subtest: bonded-chain
[365.174819] Subtest bonded-chain: SUCCESS (6.984s)
[365.524832] [069/132] (654s left) gem_ppgtt (shrink-vs-evict-any)
[365.592664] Starting subtest: shrink-vs-evict-any
[370.865864] Subtest shrink-vs-evict-any: SUCCESS (5.271s)
[370.967635] [070/132] (649s left) syncobj_basic (bad-create-flags)
[371.027601] Starting subtest: bad-create-flags
[371.030028] Subtest bad-create-flags: SUCCESS (0.000s)
[371.148906] [071/132] (649s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[371.210041] Starting subtest: etime-single-wait-all-for-submit-submitted
[371.314438] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.103s)
[371.415436] [072/132] (648s left) kms_flip (2x-flip-vs-fences-interruptible)
[371.516384] Starting subtest: 2x-flip-vs-fences-interruptible
[371.521109] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[371.641041] [073/132] (648s left) gem_softpin (allocator-nopin)
[371.708634] Starting subtest: allocator-nopin
[371.815207] Subtest allocator-nopin: SUCCESS (0.105s)
[371.958827] [074/132] (648s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[372.067575] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[372.072040] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[372.202291] [075/132] (648s left) prime_busy (before)
[372.261681] Starting subtest: before
[372.266533] Starting dynamic subtest: rcs0
[372.297269] Dynamic subtest rcs0: SUCCESS (0.032s)
[372.308398] Starting dynamic subtest: bcs0
[372.364906] Dynamic subtest bcs0: SUCCESS (0.066s)
[372.375610] Starting dynamic subtest: vcs0
[372.403807] Dynamic subtest vcs0: SUCCESS (0.039s)
[372.412802] Starting dynamic subtest: vcs1
[372.444218] Dynamic subtest vcs1: SUCCESS (0.040s)
[372.453884] Starting dynamic subtest: vecs0
[372.485425] Dynamic subtest vecs0: SUCCESS (0.039s)
[372.494171] Starting dynamic subtest: ccs0
[372.525211] Dynamic subtest ccs0: SUCCESS (0.040s)
[372.633515] Subtest before: SUCCESS (0.370s)
[372.728100] [076/132] (647s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[372.825990] Starting subtest: fbc-indfb-scaledprimary
[375.854295] Subtest fbc-indfb-scaledprimary: SUCCESS (3.031s)
[377.088823] [077/132] (643s left) gem_readwrite (read-write)
[377.151178] Subtest read-write: SKIP (0.000s)
[377.248155] [078/132] (643s left) gem_exec_reloc (basic-scanout)
[377.314595] Subtest basic-scanout: SKIP (0.000s)
[377.399399] [079/132] (643s left) gem_ctx_param (invalid-ctx-set)
[377.458737] Starting subtest: invalid-ctx-set
[377.461113] Subtest invalid-ctx-set: SUCCESS (0.001s)
[377.595410] [080/132] (643s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[377.654600] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[377.656588] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[377.802827] [081/132] (642s left) gem_readwrite (beyond-eob)
[377.866713] Subtest beyond-EOB: SKIP (0.000s)
[377.945964] [082/132] (642s left) kms_big_fb (linear-32bpp-rotate-0)
[378.056173] Starting subtest: linear-32bpp-rotate-0
[379.601437] Subtest linear-32bpp-rotate-0: SUCCESS (1.545s)
[379.787025] [083/132] (641s left) gem_mmap_gtt (basic-write)
[379.854455] Subtest basic-write: SKIP (0.000s)
[379.917483] [084/132] (640s left) fbdev (nullptr)
[379.961121] Starting subtest: nullptr
[379.963057] Subtest nullptr: SUCCESS (0.000s)
[380.044069] [085/132] (640s left) syncobj_wait (wait-all-complex)
[380.107946] Starting subtest: wait-all-complex
[380.322474] Subtest wait-all-complex: SUCCESS (0.213s)
[380.416338] [086/132] (640s left) gem_tiled_partial_pwrite_pread (reads)
[380.479115] Subtest reads: SKIP (0.000s)
[380.569791] [087/132] (640s left) syncobj_wait (wait-zero-handles)
[380.633626] Starting subtest: wait-zero-handles
[380.636019] Subtest wait-zero-handles: SUCCESS (0.000s)
[380.781559] [088/132] (640s left) kms_properties (crtc-properties-atomic)
[380.877261] Starting subtest: crtc-properties-atomic
[380.879568] Starting dynamic subtest: pipe-A-eDP-1
[381.328097] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.448s)
[381.337134] Starting dynamic subtest: pipe-B-eDP-1
[382.503633] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.174s)
[382.514082] Starting dynamic subtest: pipe-C-eDP-1
[383.635949] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.133s)
[383.646467] Starting dynamic subtest: pipe-D-eDP-1
[384.781312] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.142s)
[384.783535] Subtest crtc-properties-atomic: SUCCESS (3.902s)
[385.604299] [089/132] (635s left) gem_ctx_persistence (engines-hostile-preempt)
[385.669378] Starting subtest: engines-hostile-preempt
[385.671689] Starting dynamic subtest: rcs0
[385.745680] Dynamic subtest rcs0: SUCCESS (0.076s)
[385.754849] Starting dynamic subtest: bcs0
[385.788582] Dynamic subtest bcs0: SUCCESS (0.041s)
[385.798664] Starting dynamic subtest: vcs0
[386.916585] Dynamic subtest vcs0: SUCCESS (1.124s)
[386.929050] Starting dynamic subtest: vcs1
[388.900310] Dynamic subtest vcs1: SUCCESS (1.981s)
[388.912402] Starting dynamic subtest: vecs0
[390.957231] Dynamic subtest vecs0: SUCCESS (2.054s)
[390.968031] Starting dynamic subtest: ccs0
[390.986497] Dynamic subtest ccs0: SUCCESS (0.028s)
[390.988907] Subtest engines-hostile-preempt: SUCCESS (5.317s)
[391.131067] [090/132] (629s left) syncobj_timeline (multi-wait-all-available-submitted)
[391.186665] Starting subtest: multi-wait-all-available-submitted
[391.189112] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[391.327124] [091/132] (629s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[391.465835] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[391.470638] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[391.607051] [092/132] (629s left) syncobj_wait (single-wait-submitted)
[391.668074] Starting subtest: single-wait-submitted
[391.769296] Subtest single-wait-submitted: SUCCESS (0.101s)
[391.867040] [093/132] (629s left) gem_exec_schedule (preempt-self)
[391.945922] Starting subtest: preempt-self
[391.948079] Starting dynamic subtest: rcs0
[391.959316] Dynamic subtest rcs0: SUCCESS (0.020s)
[391.969055] Starting dynamic subtest: bcs0
[391.978856] Dynamic subtest bcs0: SUCCESS (0.019s)
[391.993491] Starting dynamic subtest: vcs0
[392.001216] Dynamic subtest vcs0: SUCCESS (0.021s)
[392.011684] Starting dynamic subtest: vcs1
[392.021160] Dynamic subtest vcs1: SUCCESS (0.019s)
[392.029842] Starting dynamic subtest: vecs0
[392.039549] Dynamic subtest vecs0: SUCCESS (0.018s)
[392.050879] Starting dynamic subtest: ccs0
[392.057793] Dynamic subtest ccs0: SUCCESS (0.017s)
[392.059712] Subtest preempt-self: SUCCESS (0.120s)
[393.997852] [094/132] (627s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[394.106134] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[400.796247] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.691s)
[400.977424] [095/132] (620s left) sysfs_preempt_timeout (idempotent)
[401.049534] Starting subtest: idempotent
[401.051731] Starting dynamic subtest: vecs0
[401.053962] Dynamic subtest vecs0: SUCCESS (0.000s)
[401.063725] Starting dynamic subtest: ccs0
[401.065713] Dynamic subtest ccs0: SUCCESS (0.000s)
[401.074719] Starting dynamic subtest: vcs0
[401.076957] Dynamic subtest vcs0: SUCCESS (0.000s)
[401.085774] Starting dynamic subtest: bcs0
[401.087754] Dynamic subtest bcs0: SUCCESS (0.000s)
[401.096663] Starting dynamic subtest: rcs0
[401.098693] Dynamic subtest rcs0: SUCCESS (0.000s)
[401.107284] Starting dynamic subtest: vcs1
[401.109252] Dynamic subtest vcs1: SUCCESS (0.000s)
[401.111113] Subtest idempotent: SUCCESS (0.007s)
[401.147523] [096/132] (620s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[401.251598] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[401.256083] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[401.422012] [097/132] (619s left) kms_atomic (crtc-invalid-params-fence)
[401.534429] Starting subtest: crtc-invalid-params-fence
[401.536578] Starting dynamic subtest: pipe-A-eDP-1
[401.957837] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.423s)
[401.960174] Subtest crtc-invalid-params-fence: SUCCESS (0.424s)
[402.852515] [098/132] (618s left) gem_fence_thrash (bo-write-verify-threaded-x)
[402.890586] Starting subtest: bo-write-verify-threaded-x
[402.923824] Subtest bo-write-verify-threaded-x: SKIP (0.028s)
[402.993580] [099/132] (618s left) gem_wait (busy)
[403.065680] Starting subtest: busy
[403.068081] Starting dynamic subtest: all-engines
[404.886521] Dynamic subtest all-engines: SUCCESS (1.818s)
[404.898660] Starting dynamic subtest: rcs0
[405.427822] Dynamic subtest rcs0: SUCCESS (0.541s)
[405.439406] Starting dynamic subtest: bcs0
[405.968913] Dynamic subtest bcs0: SUCCESS (0.539s)
[405.979660] Starting dynamic subtest: vcs0
[407.892969] Dynamic subtest vcs0: SUCCESS (1.922s)
[407.904591] Starting dynamic subtest: vcs1
[409.877100] Dynamic subtest vcs1: SUCCESS (1.981s)
[409.888985] Starting dynamic subtest: vecs0
[411.925622] Dynamic subtest vecs0: SUCCESS (2.045s)
[411.937541] Starting dynamic subtest: ccs0
[412.467385] Dynamic subtest ccs0: SUCCESS (0.541s)
[412.470068] Subtest busy: SUCCESS (9.402s)
[412.690553] [100/132] (608s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[412.797454] Starting subtest: x-tiled-64bpp-rotate-180
[414.398798] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.601s)
[414.600698] [101/132] (606s left) kms_force_connector_basic (force-edid)
[414.679641] Starting subtest: force-edid
[415.042602] Subtest force-edid: SUCCESS (0.362s)
[415.204834] [102/132] (606s left) gem_ctx_param (basic-default)
[415.267513] Starting subtest: basic-default
[415.269490] Subtest basic-default: SUCCESS (0.000s)
[415.364250] [103/132] (606s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[415.449450] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[415.451661] Starting dynamic subtest: pipe-A-eDP-1
[431.711582] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.550s)
[431.723963] Starting dynamic subtest: pipe-B-eDP-1
[448.709796] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.417s)
[448.720486] Starting dynamic subtest: pipe-C-eDP-1
[465.669353] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.383s)
[465.679944] Starting dynamic subtest: pipe-D-eDP-1
[482.628313] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.348s)
[482.630856] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.704s)
[483.864256] [104/132] (537s left) kms_pm_rpm (modeset-stress-extra-wait)
[485.511346] Starting subtest: modeset-stress-extra-wait
[539.841983] Subtest modeset-stress-extra-wait: SUCCESS (54.299s)
[539.958897] [105/132] (481s left) kms_flip (2x-flip-vs-suspend)
[540.074722] Starting subtest: 2x-flip-vs-suspend
[540.082775] Subtest 2x-flip-vs-suspend: SKIP (0.011s)
[540.230109] [106/132] (481s left) kms_chamelium_frames (dp-crc-fast)
[540.626335] Subtest dp-crc-fast: SKIP (0.000s)
[541.464913] [107/132] (480s left) intel_hwmon (hwmon-write)
[541.525589] Subtest hwmon-write: SKIP (0.000s)
[541.583353] [108/132] (480s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[541.677352] Starting subtest: psr-rgb101010-draw-render
[548.927244] Subtest psr-rgb101010-draw-render: SUCCESS (7.247s)
[549.087496] [109/132] (472s left) gem_exec_flush (basic-wb-pro-default)
[549.169517] Starting subtest: basic-wb-pro-default
[554.623901] Subtest basic-wb-pro-default: SUCCESS (5.453s)
[554.835793] [110/132] (467s left) kms_prop_blob (invalid-get-prop)
[554.895251] Starting subtest: invalid-get-prop
[554.898067] Subtest invalid-get-prop: SUCCESS (0.000s)
[555.035239] [111/132] (466s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[555.136974] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[561.773255] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.634s)
[561.918339] [112/132] (460s left) kms_plane (plane-position-hole-dpms)
[562.013583] Starting subtest: plane-position-hole-dpms
[562.548940] Starting dynamic subtest: pipe-A-plane-1
[564.900667] Dynamic subtest pipe-A-plane-1: SUCCESS (2.349s)
[564.912033] Starting dynamic subtest: pipe-A-plane-2
[567.307063] Dynamic subtest pipe-A-plane-2: SUCCESS (2.405s)
[567.318012] Starting dynamic subtest: pipe-A-plane-3
[569.705456] Dynamic subtest pipe-A-plane-3: SUCCESS (2.397s)
[569.716545] Starting dynamic subtest: pipe-A-plane-4
[572.100708] Dynamic subtest pipe-A-plane-4: SUCCESS (2.393s)
[572.112077] Starting dynamic subtest: pipe-A-plane-5
[572.128148] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[573.360365] Starting dynamic subtest: pipe-B-plane-1
[575.734680] Dynamic subtest pipe-B-plane-1: SUCCESS (2.383s)
[575.745440] Starting dynamic subtest: pipe-B-plane-2
[578.110059] Dynamic subtest pipe-B-plane-2: SUCCESS (2.376s)
[578.120589] Starting dynamic subtest: pipe-B-plane-3
[580.512575] Dynamic subtest pipe-B-plane-3: SUCCESS (2.400s)
[580.525076] Starting dynamic subtest: pipe-B-plane-4
[582.900767] Dynamic subtest pipe-B-plane-4: SUCCESS (2.386s)
[582.912593] Starting dynamic subtest: pipe-B-plane-5
[582.927817] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[582.930582] Subtest plane-position-hole-dpms: SUCCESS (20.903s)
[583.809692] [113/132] (438s left) perf_pmu (busy-start)
[583.858054] Starting subtest: busy-start
[583.860844] Starting dynamic subtest: rcs0
[586.408026] Dynamic subtest rcs0: SUCCESS (2.550s)
[586.421208] Starting dynamic subtest: bcs0
[588.959902] Dynamic subtest bcs0: SUCCESS (2.548s)
[588.971751] Starting dynamic subtest: vcs0
[592.374792] Dynamic subtest vcs0: SUCCESS (3.409s)
[592.387975] Starting dynamic subtest: vcs1
[596.343199] Dynamic subtest vcs1: SUCCESS (3.964s)
[596.355229] Starting dynamic subtest: vecs0
[600.374553] Dynamic subtest vecs0: SUCCESS (4.027s)
[600.386451] Starting dynamic subtest: ccs0
[602.925884] Dynamic subtest ccs0: SUCCESS (2.548s)
[602.929022] Subtest busy-start: SUCCESS (19.062s)
[603.078387] [114/132] (419s left) kms_color_pipeline (plane-lut1d)
[603.181936] Starting subtest: plane-lut1d
[603.198927] Starting dynamic subtest: pipe-A-eDP-1
[603.987853] Dynamic subtest pipe-A-eDP-1: FAIL (0.333s)
[604.647831] Starting dynamic subtest: pipe-B-eDP-1
[605.502059] Dynamic subtest pipe-B-eDP-1: FAIL (0.312s)
[606.041030] Starting dynamic subtest: pipe-C-eDP-1
[606.969476] Dynamic subtest pipe-C-eDP-1: FAIL (0.246s)
[607.339853] Starting dynamic subtest: pipe-D-eDP-1
[608.208892] Dynamic subtest pipe-D-eDP-1: FAIL (0.235s)
[608.210878] Subtest plane-lut1d: FAIL (4.671s)
[608.715250] [115/132] (413s left) gen9_exec_parse (batch-zero-length)
[608.787055] Subtest batch-zero-length: SKIP (0.000s)
[608.859671] [116/132] (413s left) i915_drm_fdinfo (context-close-stress)
[608.899099] Starting subtest: context-close-stress
[619.650800] Subtest context-close-stress: SUCCESS (10.747s)
[619.750324] [117/132] (402s left) kms_chamelium_hpd (hdmi-hpd-storm)
[620.316039] Subtest hdmi-hpd-storm: SKIP (0.000s)
[621.093435] [118/132] (401s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[621.197996] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[621.200746] Starting dynamic subtest: pipe-A-eDP-1
[621.228862] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[621.244893] Starting dynamic subtest: pipe-B-eDP-1
[621.273695] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[621.283786] Starting dynamic subtest: pipe-C-eDP-1
[621.313017] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[621.325820] Starting dynamic subtest: pipe-D-eDP-1
[621.354038] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[621.358799] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[623.424826] [119/132] (398s left) syncobj_timeline (invalid-signal-bad-pad)
[623.504339] Starting subtest: invalid-signal-bad-pad
[623.507024] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[623.678930] [120/132] (398s left) gem_exec_fence (submit67)
[623.863639] Starting subtest: submit67
[623.869031] Subtest submit67: SKIP (0.000s)
[625.490552] [FACT gem_exec_fence (submit67)] new: kernel.kmod_is_loaded.vgem: true
[625.494502] [121/132] (396s left) gem_eio (in-flight-internal-10ms)
[625.727908] Starting subtest: in-flight-internal-10ms
[627.476802] Subtest in-flight-internal-10ms: SUCCESS (1.748s)
[627.670643] [122/132] (394s left) gem_exec_schedule (preempt-contexts)
[627.746798] Starting subtest: preempt-contexts
[627.749726] Starting dynamic subtest: rcs0
[627.801960] Dynamic subtest rcs0: SUCCESS (0.065s)
[627.813150] Starting dynamic subtest: bcs0
[627.857940] Dynamic subtest bcs0: SUCCESS (0.056s)
[627.868345] Starting dynamic subtest: vcs0
[627.906305] Dynamic subtest vcs0: SUCCESS (0.047s)
[627.916574] Starting dynamic subtest: vcs1
[627.950822] Dynamic subtest vcs1: SUCCESS (0.044s)
[627.962589] Starting dynamic subtest: vecs0
[627.997104] Dynamic subtest vecs0: SUCCESS (0.045s)
[628.008664] Starting dynamic subtest: ccs0
[628.061678] Dynamic subtest ccs0: SUCCESS (0.064s)
[628.064226] Subtest preempt-contexts: SUCCESS (0.326s)
[629.504506] [123/132] (393s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[634.595546] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[634.600902] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.002s)
[635.437254] [124/132] (387s left) kms_chamelium_audio (dp-audio)
[635.825052] Subtest dp-audio: SKIP (0.000s)
[636.598856] [125/132] (386s left) kms_psr (psr2-cursor-plane-onoff)
[636.696822] Starting subtest: psr2-cursor-plane-onoff
[636.699541] Starting dynamic subtest: eDP-1
[638.374704] Dynamic subtest eDP-1: SUCCESS (1.675s)
[638.377448] Subtest psr2-cursor-plane-onoff: SUCCESS (1.676s)
[639.231331] [126/132] (383s left) kms_plane_scaling (planes-downscale-factor-0-75)
[639.322409] Starting subtest: planes-downscale-factor-0-75
[639.324629] Starting dynamic subtest: pipe-A
[639.345202] Dynamic subtest pipe-A: SKIP (0.019s)
[639.358562] Starting dynamic subtest: pipe-B
[639.384966] Dynamic subtest pipe-B: SKIP (0.038s)
[639.394718] Starting dynamic subtest: pipe-C
[639.418201] Dynamic subtest pipe-C: SKIP (0.032s)
[639.427978] Starting dynamic subtest: pipe-D
[639.448971] Dynamic subtest pipe-D: SKIP (0.031s)
[639.452913] Subtest planes-downscale-factor-0-75: SKIP (0.124s)
[639.589271] [127/132] (383s left) kms_vblank (ts-continuation-modeset)
[639.690877] Starting subtest: ts-continuation-modeset
[639.693587] Starting dynamic subtest: pipe-A-eDP-1
[641.149050] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.457s)
[641.164735] Starting dynamic subtest: pipe-D-eDP-1
[643.340044] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.187s)
[643.342964] Subtest ts-continuation-modeset: SUCCESS (3.648s)
[644.225744] [128/132] (378s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[644.288847] Starting subtest: framebuffer-vs-set-tiling
[644.294451] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[644.453387] [129/132] (378s left) kms_cursor_crc (cursor-sliding-512x170)
[644.738801] Starting subtest: cursor-sliding-512x170
[644.743674] Subtest cursor-sliding-512x170: SKIP (0.001s)
[644.910696] [130/132] (377s left) gem_exec_capture (capture)
[644.976956] Starting subtest: capture
[644.979822] Starting dynamic subtest: rcs0-smem
[645.820345] Dynamic subtest rcs0-smem: SUCCESS (0.840s)
[645.832479] Starting dynamic subtest: bcs0-smem
[646.672530] Dynamic subtest bcs0-smem: SUCCESS (0.853s)
[646.682199] Starting dynamic subtest: vcs0-smem
[647.505389] Dynamic subtest vcs0-smem: SUCCESS (0.831s)
[647.515451] Starting dynamic subtest: vcs1-smem
[648.327465] Dynamic subtest vcs1-smem: SUCCESS (0.821s)
[648.337546] Starting dynamic subtest: vecs0-smem
[649.716336] Dynamic subtest vecs0-smem: FAIL (1.320s)
[649.727876] Starting dynamic subtest: ccs0-smem
[650.973213] Dynamic subtest ccs0-smem: SUCCESS (1.324s)
[650.976042] Subtest capture: FAIL (5.993s)
[651.110518] [131/132] (371s left) i915_pm_rps (min-max-config-idle)
[651.179124] Starting subtest: min-max-config-idle
[651.184458] Subtest min-max-config-idle: SKIP (0.001s)
[651.337391] [132/132] (371s left) kms_flip (2x-plain-flip)
[651.438781] Starting subtest: 2x-plain-flip
[651.449686] Subtest 2x-plain-flip: SKIP (0.010s)
[651.588383] 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.