[58.842416] Initializing watchdogs
[58.842465]   /dev/watchdog0
[58.857661] [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]
[58.862726] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.865336] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.868564] [001/132] (960s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[59.010947] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[59.015127] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[59.139873] [002/132] (960s left) kms_vrr (seamless-rr-switch-virtual)
[59.239950] Starting subtest: seamless-rr-switch-virtual
[59.246227] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[59.332048] [003/132] (960s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[59.400226] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[59.463148] [004/132] (960s left) kms_content_protection (dp-mst-type-1)
[59.613904] Starting subtest: dp-mst-type-1
[59.618437] Subtest dp-mst-type-1: SKIP (0.000s)
[59.767022] [005/132] (959s left) core_setmaster (master-drop-set-shared-fd)
[59.867278] Starting subtest: master-drop-set-shared-fd
[59.886557] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[59.920480] [006/132] (959s left) i915_selftest (mock)
[63.319157] Starting subtest: mock
[63.321852] Starting dynamic subtest: sanitycheck
[64.096310] Dynamic subtest sanitycheck: SUCCESS (0.780s)
[64.104913] Starting dynamic subtest: shmem
[64.813176] Dynamic subtest shmem: SUCCESS (0.716s)
[64.821874] Starting dynamic subtest: fence
[73.083950] Dynamic subtest fence: SUCCESS (8.269s)
[73.092111] Starting dynamic subtest: scatterlist
[74.807077] Dynamic subtest scatterlist: SUCCESS (1.722s)
[74.815640] Starting dynamic subtest: syncmap
[78.036485] Dynamic subtest syncmap: SUCCESS (3.228s)
[78.045869] Starting dynamic subtest: uncore
[78.761216] Dynamic subtest uncore: SUCCESS (0.725s)
[78.770582] Starting dynamic subtest: ring
[79.525068] Dynamic subtest ring: SUCCESS (0.762s)
[79.533236] Starting dynamic subtest: engine
[80.248121] Dynamic subtest engine: SUCCESS (0.723s)
[80.255880] Starting dynamic subtest: timelines
[84.129059] Dynamic subtest timelines: SUCCESS (3.880s)
[84.138353] Starting dynamic subtest: requests
[88.144879] Dynamic subtest requests: SUCCESS (4.016s)
[88.153225] Starting dynamic subtest: objects
[88.953234] Dynamic subtest objects: SUCCESS (0.808s)
[88.961806] Starting dynamic subtest: phys
[89.815425] Dynamic subtest phys: SUCCESS (0.862s)
[89.823923] Starting dynamic subtest: dmabuf
[90.626287] Dynamic subtest dmabuf: SUCCESS (0.810s)
[90.634817] Starting dynamic subtest: vma
[96.104034] Dynamic subtest vma: SUCCESS (5.477s)
[96.111192] Starting dynamic subtest: evict
[97.575042] Dynamic subtest evict: SUCCESS (1.470s)
[97.583450] Starting dynamic subtest: gtt
[100.776221] Dynamic subtest gtt: SUCCESS (3.200s)
[100.784595] Starting dynamic subtest: hugepages
[101.738705] Dynamic subtest hugepages: SUCCESS (0.962s)
[101.746869] Starting dynamic subtest: memory_region
[104.491925] Dynamic subtest memory_region: SUCCESS (2.752s)
[104.494840] Subtest mock: SUCCESS (41.181s)
[104.521306] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[104.524196] [007/132] (915s left) kms_psr (psr-sprite-plane-onoff)
[106.109887] Starting subtest: psr-sprite-plane-onoff
[106.112141] Starting dynamic subtest: eDP-1
[107.852227] Dynamic subtest eDP-1: SUCCESS (1.743s)
[107.854675] Subtest psr-sprite-plane-onoff: SUCCESS (1.743s)
[108.725468] [FACT kms_psr (psr-sprite-plane-onoff)] new: kernel.kmod_is_loaded.i915: true
[108.728990] [008/132] (910s left) kms_psr (fbc-psr2-basic)
[108.833450] Starting subtest: fbc-psr2-basic
[108.835835] Starting dynamic subtest: eDP-1
[108.840233] Dynamic subtest eDP-1: SKIP (0.000s)
[108.844566] Subtest fbc-psr2-basic: SKIP (0.001s)
[108.928548] [009/132] (910s left) kms_atomic_transition (plane-all-transition-nonblocking)
[109.021341] Starting subtest: plane-all-transition-nonblocking
[109.023762] Starting dynamic subtest: pipe-A-eDP-1
[111.516904] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[111.834219] Starting dynamic subtest: pipe-B-eDP-1
[115.020483] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.195s)
[115.319823] Subtest plane-all-transition-nonblocking: SUCCESS (6.296s)
[116.164566] [010/132] (903s left) kms_fence_pin_leak
[116.357254] [011/132] (903s left) gem_partial_pwrite_pread (writes-after-reads-display)
[116.427072] Subtest writes-after-reads-display: SKIP (0.000s)
[116.513582] [012/132] (903s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[121.518771] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[121.521157] Starting dynamic subtest: pipe-A-eDP-1
[132.920108] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.401s)
[132.927738] Starting dynamic subtest: pipe-B-eDP-1
[144.362110] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.439s)
[144.364548] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.844s)
[145.228884] [013/132] (874s left) gem_mmap_gtt (big-bo-tiledx)
[145.294983] Subtest big-bo-tiledX: SKIP (0.000s)
[145.356809] [014/132] (874s left) kms_fbcon_fbt (psr)
[145.415703] Starting subtest: psr
[152.773506] Subtest psr: SUCCESS (7.353s)
[152.846590] [015/132] (867s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[152.940877] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[152.943068] Starting dynamic subtest: pipe-A-eDP-1
[155.193262] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.253s)
[155.200358] Starting dynamic subtest: pipe-B-eDP-1
[157.606756] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.411s)
[157.614934] Starting dynamic subtest: pipe-C-eDP-1
[159.769072] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.162s)
[159.776824] Starting dynamic subtest: pipe-D-eDP-1
[161.817331] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.046s)
[161.819269] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.877s)
[163.034014] [016/132] (856s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[163.142651] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[163.147100] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[163.263645] [017/132] (856s left) gem_exec_whisper (basic-contexts-all)
[163.328574] Starting subtest: basic-contexts-all
[174.837960] Subtest basic-contexts-all: SUCCESS (11.502s)
[175.045649] [018/132] (844s left) kms_cursor_crc (cursor-size-change)
[175.157057] Starting subtest: cursor-size-change
[175.159290] Starting dynamic subtest: pipe-A-eDP-1
[175.963869] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.806s)
[175.972565] Starting dynamic subtest: pipe-D-eDP-1
[177.387764] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.422s)
[177.389791] Subtest cursor-size-change: SUCCESS (2.230s)
[178.225335] [019/132] (841s left) kms_lease (lease-revoke)
[178.333054] Starting subtest: lease-revoke
[178.335156] Starting dynamic subtest: pipe-A-eDP-1
[178.367142] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.034s)
[178.376565] Starting dynamic subtest: pipe-B-eDP-1
[178.399208] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.031s)
[178.407673] Starting dynamic subtest: pipe-C-eDP-1
[178.431820] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.029s)
[178.441208] Starting dynamic subtest: pipe-D-eDP-1
[178.460670] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.028s)
[178.462990] Subtest lease-revoke: SUCCESS (0.130s)
[178.612061] [020/132] (841s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[178.686242] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[178.690390] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[178.890773] [021/132] (841s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[178.996508] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[179.000869] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[179.130443] [022/132] (841s left) kms_flip (2x-blocking-wf_vblank)
[179.233020] Starting subtest: 2x-blocking-wf_vblank
[179.244105] Subtest 2x-blocking-wf_vblank: SKIP (0.010s)
[179.386463] [023/132] (840s left) syncobj_timeline (single-wait-available-submitted)
[179.437903] Starting subtest: single-wait-available-submitted
[179.440218] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[179.577208] [024/132] (840s left) sriov_basic (enable-vfs-bind-unbind-each)
[179.637390] Starting subtest: enable-vfs-bind-unbind-each
[179.639688] Starting dynamic subtest: numvfs-1
[179.717368] Dynamic subtest numvfs-1: FAIL (0.029s)
[179.726492] Starting dynamic subtest: numvfs-2
[179.797084] Dynamic subtest numvfs-2: FAIL (0.004s)
[179.806806] Starting dynamic subtest: numvfs-3
[179.867234] Dynamic subtest numvfs-3: FAIL (0.003s)
[179.877219] Starting dynamic subtest: numvfs-4
[179.938299] Dynamic subtest numvfs-4: FAIL (0.003s)
[179.947888] Starting dynamic subtest: numvfs-5
[180.007997] Dynamic subtest numvfs-5: FAIL (0.005s)
[180.016072] Starting dynamic subtest: numvfs-6
[180.075639] Dynamic subtest numvfs-6: FAIL (0.004s)
[180.084618] Starting dynamic subtest: numvfs-7
[180.144379] Dynamic subtest numvfs-7: FAIL (0.004s)
[180.153176] Starting dynamic subtest: numvfs-random
[180.212110] Dynamic subtest numvfs-random: FAIL (0.004s)
[180.214072] Subtest enable-vfs-bind-unbind-each: FAIL (0.061s)
[180.247936] [025/132] (840s left) api_intel_bb (object-reloc-keep-cache)
[180.302691] Starting subtest: object-reloc-keep-cache
[180.306136] Subtest object-reloc-keep-cache: SKIP (0.002s)
[180.439693] [026/132] (839s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[180.528380] Starting subtest: fbc-psr2-sprite-mmap-gtt
[180.530163] Starting dynamic subtest: eDP-1
[180.533451] Dynamic subtest eDP-1: SKIP (0.000s)
[180.536708] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[180.620623] [027/132] (839s left) gem_exec_nop (basic-parallel)
[180.702119] Starting subtest: basic-parallel
[196.885291] Subtest basic-parallel: SUCCESS (16.189s)
[197.155150] [028/132] (823s left) i915_hangman (gt-engine-error)
[197.228331] Starting subtest: gt-engine-error
[197.230490] Starting dynamic subtest: rcs0
[198.899468] Dynamic subtest rcs0: SUCCESS (1.670s)
[198.912568] Starting dynamic subtest: bcs0
[200.883061] Dynamic subtest bcs0: SUCCESS (1.980s)
[200.894366] Starting dynamic subtest: vcs0
[202.866425] Dynamic subtest vcs0: SUCCESS (1.981s)
[202.876781] Starting dynamic subtest: vcs1
[204.851754] Dynamic subtest vcs1: SUCCESS (1.983s)
[204.862341] Starting dynamic subtest: vecs0
[206.898694] Dynamic subtest vecs0: SUCCESS (2.044s)
[206.910672] Starting dynamic subtest: ccs0
[208.884672] Dynamic subtest ccs0: SUCCESS (1.983s)
[208.887391] Subtest gt-engine-error: SUCCESS (11.657s)
[208.996774] [029/132] (811s left) kms_getfb (getfb-handle-protection)
[209.102047] Starting subtest: getfb-handle-protection
[209.128597] Subtest getfb-handle-protection: SUCCESS (0.027s)
[209.301037] [030/132] (811s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[209.400254] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[209.402405] Starting dynamic subtest: pipe-A-eDP-1
[209.423873] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[209.433250] Starting dynamic subtest: pipe-B-eDP-1
[209.453208] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[209.461322] Starting dynamic subtest: pipe-C-eDP-1
[209.480996] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[209.489436] Starting dynamic subtest: pipe-D-eDP-1
[209.509236] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[209.511484] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[211.593830] [031/132] (808s left) gem_pxp (reject-modify-context-protection-off-1)
[211.730012] Starting subtest: reject-modify-context-protection-off-1
[211.732333] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[211.870386] [032/132] (808s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[211.977717] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[219.024897] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.056s)
[219.182833] [033/132] (801s left) api_intel_allocator (alloc-simple)
[219.248624] Starting subtest: alloc-simple
[219.251051] Subtest alloc-simple: SUCCESS (0.003s)
[219.406292] [034/132] (801s left) perf (blocking)
[219.548136] Starting subtest: blocking
[219.550471] Starting dynamic subtest: 0-rcs0
[229.566507] Dynamic subtest 0-rcs0: SUCCESS (10.016s)
[229.579496] Starting dynamic subtest: 1-vecs0
[239.588789] Dynamic subtest 1-vecs0: SUCCESS (10.020s)
[239.591378] Subtest blocking: SUCCESS (20.039s)
[239.635388] [035/132] (781s left) kms_frontbuffer_tracking (psr-slowdraw)
[239.741163] Starting subtest: psr-slowdraw
[264.943277] Subtest psr-slowdraw: SUCCESS (25.204s)
[265.099251] [036/132] (755s left) gem_mmap (short-mmap)
[265.159520] Subtest short-mmap: SKIP (0.000s)
[265.234681] [037/132] (755s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[265.336989] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[265.339264] Starting dynamic subtest: pipe-A-default-mode
[265.631899] Dynamic subtest pipe-A-default-mode: SKIP (0.293s)
[265.636543] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.295s)
[266.459539] [038/132] (754s left) kms_invalid_mode (bad-htotal)
[266.563575] Starting subtest: bad-htotal
[266.565955] Starting dynamic subtest: pipe-A-eDP-1
[266.845875] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[266.857246] Starting dynamic subtest: pipe-B-eDP-1
[266.859720] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[266.867999] Starting dynamic subtest: pipe-C-eDP-1
[266.870364] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[266.878340] Starting dynamic subtest: pipe-D-eDP-1
[266.880698] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[266.882856] Subtest bad-htotal: SUCCESS (0.292s)
[267.690987] [039/132] (753s left) gem_exec_alignment (forked)
[267.758382] Starting subtest: forked
[306.347757] Subtest forked: SUCCESS (38.587s)
[306.452647] [040/132] (714s left) kms_psr (pr-cursor-mmap-gtt)
[306.590894] Starting subtest: pr-cursor-mmap-gtt
[306.595171] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[306.690433] [041/132] (714s left) gem_mmap_wc (read-write)
[306.750170] Subtest read-write: SKIP (0.000s)
[306.816084] [042/132] (714s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[306.912092] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[314.354469] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.445s)
[314.520809] [043/132] (706s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[314.624634] Starting subtest: fbc-rgb565-draw-pwrite
[319.179491] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.557s)
[320.328478] [044/132] (700s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[320.444696] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[324.039565] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.598s)
[325.232089] [045/132] (695s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[325.343353] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[325.347687] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[325.481876] [046/132] (695s left) kms_cursor_crc (cursor-offscreen-128x42)
[325.726108] Starting subtest: cursor-offscreen-128x42
[325.774942] Subtest cursor-offscreen-128x42: SKIP (0.045s)
[326.006117] [047/132] (695s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[326.155043] Starting subtest: cursor-rapid-movement-32x10
[326.201410] Subtest cursor-rapid-movement-32x10: SKIP (0.042s)
[326.479227] [048/132] (694s left) gem_ctx_persistence (legacy-engines-persistence)
[326.536461] Starting subtest: legacy-engines-persistence
[326.538484] Starting dynamic subtest: render
[327.336757] Dynamic subtest render: SUCCESS (0.799s)
[327.351814] Starting dynamic subtest: bsd1
[328.105061] Dynamic subtest bsd1: SUCCESS (0.765s)
[328.119317] Starting dynamic subtest: bsd2
[328.827226] Dynamic subtest bsd2: SUCCESS (0.719s)
[328.838251] Starting dynamic subtest: blt
[329.616863] Dynamic subtest blt: SUCCESS (0.787s)
[329.631814] Starting dynamic subtest: vebox
[330.400517] Dynamic subtest vebox: SUCCESS (0.780s)
[330.403176] Subtest legacy-engines-persistence: SUCCESS (3.865s)
[330.507361] [049/132] (690s left) syncobj_wait (wait-any-complex)
[330.568531] Starting subtest: wait-any-complex
[330.630268] Subtest wait-any-complex: SUCCESS (0.061s)
[330.733849] [050/132] (690s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[330.834720] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[330.836803] Starting dynamic subtest: pipe-A-default-mode
[331.971083] Dynamic subtest pipe-A-default-mode: SKIP (1.133s)
[331.975387] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.135s)
[332.167554] [051/132] (689s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[332.272874] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[332.275070] Starting dynamic subtest: pipe-A
[332.297103] Dynamic subtest pipe-A: SKIP (0.019s)
[332.306337] Starting dynamic subtest: pipe-B
[332.328218] Dynamic subtest pipe-B: SKIP (0.032s)
[332.337143] Starting dynamic subtest: pipe-C
[332.361585] Dynamic subtest pipe-C: SKIP (0.033s)
[332.370286] Starting dynamic subtest: pipe-D
[332.395156] Dynamic subtest pipe-D: SKIP (0.033s)
[332.398775] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.120s)
[332.538402] [052/132] (688s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[332.632077] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[332.634413] Starting dynamic subtest: pipe-A-eDP-1
[332.657515] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[332.668728] Starting dynamic subtest: pipe-B-eDP-1
[332.690219] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[332.698455] Starting dynamic subtest: pipe-C-eDP-1
[332.719795] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[332.728137] Starting dynamic subtest: pipe-D-eDP-1
[332.749569] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[332.753875] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[334.833593] [053/132] (686s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[334.935448] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[334.939509] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[335.066365] [054/132] (686s left) drm_read (empty-nonblock)
[335.235688] Starting subtest: empty-nonblock
[335.238384] Subtest empty-nonblock: SUCCESS (0.000s)
[335.421288] [055/132] (686s left) gem_partial_pwrite_pread (write-display)
[335.493568] Subtest write-display: SKIP (0.000s)
[335.582450] [056/132] (685s left) gem_ctx_param (invalid-size-set)
[335.646883] Starting subtest: invalid-size-set
[335.649395] Subtest invalid-size-set: SUCCESS (0.001s)
[335.783447] [057/132] (685s left) gem_close_race (multigpu-basic-threads)
[335.847564] Starting subtest: multigpu-basic-threads
[335.851219] Subtest multigpu-basic-threads: SKIP (0.000s)
[336.123121] [058/132] (685s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[336.225665] Starting subtest: psr-dirtyfb-ioctl
[336.227781] Starting dynamic subtest: A-eDP-1
[340.115921] Dynamic subtest A-eDP-1: SUCCESS (3.887s)
[340.117812] Subtest psr-dirtyfb-ioctl: SUCCESS (3.889s)
[340.935085] [059/132] (680s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[341.051032] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[341.653121] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.603s)
[341.863371] [060/132] (679s left) gem_mmap_gtt (zero-extend)
[341.941263] Subtest zero-extend: SKIP (0.000s)
[342.011333] [061/132] (679s left) gem_lmem_swapping (massive-random)
[342.055091] Subtest massive-random: SKIP (0.000s)
[342.107706] [062/132] (679s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[342.212049] Starting subtest: 4-tiled-32bpp-rotate-270
[342.231759] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.019s)
[342.390817] [063/132] (679s left) kms_plane_alpha_blend (alpha-basic)
[342.489315] Starting subtest: alpha-basic
[342.784857] Starting dynamic subtest: pipe-A-eDP-1
[344.684753] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.898s)
[344.711893] Starting dynamic subtest: pipe-D-eDP-1
[347.379438] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.674s)
[347.381865] Subtest alpha-basic: SUCCESS (4.890s)
[348.212137] [064/132] (673s left) kms_sequence (get-idle)
[348.316255] Starting subtest: get-idle
[348.318527] Starting dynamic subtest: pipe-A-eDP-1
[350.148549] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.828s)
[350.157724] Starting dynamic subtest: pipe-B-eDP-1
[352.654296] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.505s)
[352.666373] Starting dynamic subtest: pipe-C-eDP-1
[355.085331] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.428s)
[355.094861] Starting dynamic subtest: pipe-D-eDP-1
[357.512648] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.425s)
[357.514493] Subtest get-idle: SUCCESS (9.194s)
[358.339705] [065/132] (663s left) syncobj_wait (multi-wait-all-submitted)
[358.394236] Starting subtest: multi-wait-all-submitted
[358.495772] Subtest multi-wait-all-submitted: SUCCESS (0.102s)
[358.595784] [066/132] (663s left) gem_exec_reloc (basic-cpu-read)
[358.653730] Subtest basic-cpu-read: SKIP (0.000s)
[358.740454] [067/132] (663s left) gem_exec_suspend (basic)
[358.806788] Starting subtest: basic
[358.808879] Starting dynamic subtest: smem
[360.915944] Dynamic subtest smem: SUCCESS (2.110s)
[360.918923] Subtest basic: SUCCESS (2.113s)
[361.126246] [068/132] (660s left) gem_exec_balancer (bonded-chain)
[361.190922] Starting subtest: bonded-chain
[368.178987] Subtest bonded-chain: SUCCESS (6.986s)
[368.534760] [069/132] (653s left) gem_ppgtt (shrink-vs-evict-any)
[368.593565] Starting subtest: shrink-vs-evict-any
[373.879823] Subtest shrink-vs-evict-any: SUCCESS (5.284s)
[373.995971] [070/132] (648s left) syncobj_basic (bad-create-flags)
[374.072583] Starting subtest: bad-create-flags
[374.074993] Subtest bad-create-flags: SUCCESS (0.000s)
[374.213712] [071/132] (647s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[374.275523] Starting subtest: etime-single-wait-all-for-submit-submitted
[374.376226] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.101s)
[374.478757] [072/132] (647s left) kms_flip (2x-flip-vs-fences-interruptible)
[374.587362] Starting subtest: 2x-flip-vs-fences-interruptible
[374.591445] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[374.732945] [073/132] (647s left) gem_softpin (allocator-nopin)
[374.792629] Starting subtest: allocator-nopin
[374.869630] Subtest allocator-nopin: SUCCESS (0.076s)
[375.023097] [074/132] (647s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[375.134410] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[375.138422] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[375.263042] [075/132] (647s left) prime_busy (before)
[375.326299] Starting subtest: before
[375.331357] Starting dynamic subtest: rcs0
[375.360791] Dynamic subtest rcs0: SUCCESS (0.031s)
[375.371257] Starting dynamic subtest: bcs0
[375.424993] Dynamic subtest bcs0: SUCCESS (0.063s)
[375.435141] Starting dynamic subtest: vcs0
[375.464532] Dynamic subtest vcs0: SUCCESS (0.039s)
[375.473032] Starting dynamic subtest: vcs1
[375.504699] Dynamic subtest vcs1: SUCCESS (0.039s)
[375.513522] Starting dynamic subtest: vecs0
[375.544453] Dynamic subtest vecs0: SUCCESS (0.039s)
[375.553092] Starting dynamic subtest: ccs0
[375.583203] Dynamic subtest ccs0: SUCCESS (0.038s)
[375.692285] Subtest before: SUCCESS (0.364s)
[375.794495] [076/132] (646s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[375.899914] Starting subtest: fbc-indfb-scaledprimary
[378.884506] Subtest fbc-indfb-scaledprimary: SUCCESS (2.988s)
[380.040085] [077/132] (642s left) gem_readwrite (read-write)
[380.101305] Subtest read-write: SKIP (0.000s)
[380.165775] [078/132] (642s left) gem_exec_reloc (basic-scanout)
[380.225763] Subtest basic-scanout: SKIP (0.000s)
[380.290058] [079/132] (642s left) gem_ctx_param (invalid-ctx-set)
[380.351952] Starting subtest: invalid-ctx-set
[380.354218] Subtest invalid-ctx-set: SUCCESS (0.001s)
[380.482758] [080/132] (641s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[380.549288] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[380.551821] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[380.678371] [081/132] (641s left) gem_readwrite (beyond-eob)
[380.737574] Subtest beyond-EOB: SKIP (0.000s)
[380.807050] [082/132] (641s left) kms_big_fb (linear-32bpp-rotate-0)
[380.904069] Starting subtest: linear-32bpp-rotate-0
[382.469068] Subtest linear-32bpp-rotate-0: SUCCESS (1.566s)
[382.637060] [083/132] (639s left) gem_mmap_gtt (basic-write)
[382.703667] Subtest basic-write: SKIP (0.000s)
[382.769250] [084/132] (639s left) fbdev (nullptr)
[382.814578] Starting subtest: nullptr
[382.816838] Subtest nullptr: SUCCESS (0.000s)
[382.897680] [085/132] (639s left) syncobj_wait (wait-all-complex)
[382.960860] Starting subtest: wait-all-complex
[383.175681] Subtest wait-all-complex: SUCCESS (0.213s)
[383.271055] [086/132] (639s left) gem_tiled_partial_pwrite_pread (reads)
[383.333582] Subtest reads: SKIP (0.000s)
[383.408544] [087/132] (639s left) syncobj_wait (wait-zero-handles)
[383.465575] Starting subtest: wait-zero-handles
[383.467776] Subtest wait-zero-handles: SUCCESS (0.000s)
[383.584729] [088/132] (639s left) kms_properties (crtc-properties-atomic)
[383.678957] Starting subtest: crtc-properties-atomic
[383.681226] Starting dynamic subtest: pipe-A-eDP-1
[384.132895] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.452s)
[384.144874] Starting dynamic subtest: pipe-B-eDP-1
[385.267287] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.135s)
[385.277285] Starting dynamic subtest: pipe-C-eDP-1
[386.393917] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.122s)
[386.403799] Starting dynamic subtest: pipe-D-eDP-1
[387.537445] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.143s)
[387.539629] Subtest crtc-properties-atomic: SUCCESS (3.859s)
[388.368920] [089/132] (634s left) gem_ctx_persistence (engines-hostile-preempt)
[388.433238] Starting subtest: engines-hostile-preempt
[388.435180] Starting dynamic subtest: rcs0
[388.522766] Dynamic subtest rcs0: SUCCESS (0.092s)
[388.532913] Starting dynamic subtest: bcs0
[388.596738] Dynamic subtest bcs0: SUCCESS (0.072s)
[388.607781] Starting dynamic subtest: vcs0
[389.929071] Dynamic subtest vcs0: SUCCESS (1.329s)
[389.941739] Starting dynamic subtest: vcs1
[391.870320] Dynamic subtest vcs1: SUCCESS (1.938s)
[391.881872] Starting dynamic subtest: vecs0
[393.982021] Dynamic subtest vecs0: SUCCESS (2.109s)
[393.993249] Starting dynamic subtest: ccs0
[394.061751] Dynamic subtest ccs0: SUCCESS (0.078s)
[394.064823] Subtest engines-hostile-preempt: SUCCESS (5.632s)
[394.166471] [090/132] (628s left) syncobj_timeline (multi-wait-all-available-submitted)
[394.224141] Starting subtest: multi-wait-all-available-submitted
[394.226510] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[394.365226] [091/132] (628s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[394.480388] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[394.484707] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[394.595071] [092/132] (628s left) syncobj_wait (single-wait-submitted)
[394.658782] Starting subtest: single-wait-submitted
[394.760123] Subtest single-wait-submitted: SUCCESS (0.102s)
[394.859299] [093/132] (628s left) gem_exec_schedule (preempt-self)
[394.943718] Starting subtest: preempt-self
[394.946019] Starting dynamic subtest: rcs0
[394.959708] Dynamic subtest rcs0: SUCCESS (0.023s)
[394.971213] Starting dynamic subtest: bcs0
[394.978962] Dynamic subtest bcs0: SUCCESS (0.019s)
[394.987941] Starting dynamic subtest: vcs0
[394.999316] Dynamic subtest vcs0: SUCCESS (0.020s)
[395.008083] Starting dynamic subtest: vcs1
[395.017468] Dynamic subtest vcs1: SUCCESS (0.017s)
[395.026310] Starting dynamic subtest: vecs0
[395.033122] Dynamic subtest vecs0: SUCCESS (0.015s)
[395.041899] Starting dynamic subtest: ccs0
[395.052083] Dynamic subtest ccs0: SUCCESS (0.018s)
[395.054386] Subtest preempt-self: SUCCESS (0.116s)
[397.003839] [094/132] (626s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[397.104159] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[403.671664] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.569s)
[403.844176] [095/132] (619s left) sysfs_preempt_timeout (idempotent)
[403.903488] Starting subtest: idempotent
[403.905960] Starting dynamic subtest: vecs0
[403.908405] Dynamic subtest vecs0: SUCCESS (0.000s)
[403.919123] Starting dynamic subtest: ccs0
[403.921353] Dynamic subtest ccs0: SUCCESS (0.000s)
[403.929734] Starting dynamic subtest: vcs0
[403.931961] Dynamic subtest vcs0: SUCCESS (0.000s)
[403.940522] Starting dynamic subtest: bcs0
[403.942789] Dynamic subtest bcs0: SUCCESS (0.000s)
[403.952301] Starting dynamic subtest: rcs0
[403.954519] Dynamic subtest rcs0: SUCCESS (0.000s)
[403.962884] Starting dynamic subtest: vcs1
[403.964781] Dynamic subtest vcs1: SUCCESS (0.000s)
[403.966688] Subtest idempotent: SUCCESS (0.006s)
[404.040127] [096/132] (619s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[404.142357] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[404.146228] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[404.254487] [097/132] (618s left) kms_atomic (crtc-invalid-params-fence)
[404.345351] Starting subtest: crtc-invalid-params-fence
[404.347479] Starting dynamic subtest: pipe-A-eDP-1
[404.755141] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.408s)
[404.757389] Subtest crtc-invalid-params-fence: SUCCESS (0.410s)
[405.644111] [098/132] (617s left) gem_fence_thrash (bo-write-verify-threaded-x)
[405.681955] Starting subtest: bo-write-verify-threaded-x
[405.705627] Subtest bo-write-verify-threaded-x: SKIP (0.020s)
[405.761909] [099/132] (617s left) gem_wait (busy)
[405.825590] Starting subtest: busy
[405.827982] Starting dynamic subtest: all-engines
[407.892933] Dynamic subtest all-engines: SUCCESS (2.065s)
[407.905037] Starting dynamic subtest: rcs0
[408.434928] Dynamic subtest rcs0: SUCCESS (0.541s)
[408.444614] Starting dynamic subtest: bcs0
[408.976653] Dynamic subtest bcs0: SUCCESS (0.540s)
[408.986602] Starting dynamic subtest: vcs0
[410.901377] Dynamic subtest vcs0: SUCCESS (1.921s)
[410.911961] Starting dynamic subtest: vcs1
[412.885020] Dynamic subtest vcs1: SUCCESS (1.981s)
[412.896843] Starting dynamic subtest: vecs0
[414.932455] Dynamic subtest vecs0: SUCCESS (2.045s)
[414.945388] Starting dynamic subtest: ccs0
[415.474475] Dynamic subtest ccs0: SUCCESS (0.541s)
[415.476909] Subtest busy: SUCCESS (9.648s)
[415.695154] [100/132] (607s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[415.798829] Starting subtest: x-tiled-64bpp-rotate-180
[417.365424] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.568s)
[417.547039] [101/132] (605s left) kms_force_connector_basic (force-edid)
[417.635336] Starting subtest: force-edid
[418.000506] Subtest force-edid: SUCCESS (0.366s)
[418.167435] [102/132] (605s left) gem_ctx_param (basic-default)
[418.227298] Starting subtest: basic-default
[418.229376] Subtest basic-default: SUCCESS (0.000s)
[418.324126] [103/132] (605s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[418.404870] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[418.406601] Starting dynamic subtest: pipe-A-eDP-1
[435.430009] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.951s)
[435.442102] Starting dynamic subtest: pipe-B-eDP-1
[453.408135] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.744s)
[453.418661] Starting dynamic subtest: pipe-C-eDP-1
[471.384834] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.745s)
[471.404569] Starting dynamic subtest: pipe-D-eDP-1
[489.363748] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.736s)
[489.366427] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (10.181s)
[496.581670] [104/132] (532s left) kms_pm_rpm (modeset-stress-extra-wait)
[498.853729] Starting subtest: modeset-stress-extra-wait
[553.116419] Subtest modeset-stress-extra-wait: SUCCESS (54.254s)
[553.230131] [105/132] (476s left) kms_flip (2x-flip-vs-suspend)
[553.327665] Starting subtest: 2x-flip-vs-suspend
[553.338765] Subtest 2x-flip-vs-suspend: SKIP (0.010s)
[553.489609] [106/132] (476s left) kms_chamelium_frames (dp-crc-fast)
[553.883770] Subtest dp-crc-fast: SKIP (0.000s)
[554.712416] [107/132] (474s left) intel_hwmon (hwmon-write)
[554.778549] Subtest hwmon-write: SKIP (0.000s)
[554.862533] [108/132] (474s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[554.966468] Starting subtest: psr-rgb101010-draw-render
[562.431589] Subtest psr-rgb101010-draw-render: SUCCESS (7.470s)
[562.578107] [109/132] (467s left) gem_exec_flush (basic-wb-pro-default)
[562.639288] Starting subtest: basic-wb-pro-default
[568.103751] Subtest basic-wb-pro-default: SUCCESS (5.464s)
[568.314190] [110/132] (461s left) kms_prop_blob (invalid-get-prop)
[568.379341] Starting subtest: invalid-get-prop
[568.382023] Subtest invalid-get-prop: SUCCESS (0.000s)
[568.503046] [111/132] (461s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[568.612381] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[575.240424] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.631s)
[575.354115] [112/132] (454s left) kms_plane (plane-position-hole-dpms)
[575.447756] Starting subtest: plane-position-hole-dpms
[575.971276] Starting dynamic subtest: pipe-A-plane-1
[578.348454] Dynamic subtest pipe-A-plane-1: SUCCESS (2.379s)
[578.359102] Starting dynamic subtest: pipe-A-plane-2
[580.654035] Dynamic subtest pipe-A-plane-2: SUCCESS (2.305s)
[580.665836] Starting dynamic subtest: pipe-A-plane-3
[583.040327] Dynamic subtest pipe-A-plane-3: SUCCESS (2.386s)
[583.052146] Starting dynamic subtest: pipe-A-plane-4
[585.399738] Dynamic subtest pipe-A-plane-4: SUCCESS (2.358s)
[585.410605] Starting dynamic subtest: pipe-A-plane-5
[585.428586] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[586.596452] Starting dynamic subtest: pipe-B-plane-1
[588.946853] Dynamic subtest pipe-B-plane-1: SUCCESS (2.356s)
[588.957688] Starting dynamic subtest: pipe-B-plane-2
[591.257355] Dynamic subtest pipe-B-plane-2: SUCCESS (2.312s)
[591.268295] Starting dynamic subtest: pipe-B-plane-3
[593.643915] Dynamic subtest pipe-B-plane-3: SUCCESS (2.386s)
[593.655554] Starting dynamic subtest: pipe-B-plane-4
[595.949370] Dynamic subtest pipe-B-plane-4: SUCCESS (2.303s)
[595.960747] Starting dynamic subtest: pipe-B-plane-5
[595.974240] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[595.976672] Subtest plane-position-hole-dpms: SUCCESS (20.526s)
[596.773610] [113/132] (433s left) perf_pmu (busy-start)
[596.823713] Starting subtest: busy-start
[596.826626] Starting dynamic subtest: rcs0
[599.373006] Dynamic subtest rcs0: SUCCESS (2.550s)
[599.384298] Starting dynamic subtest: bcs0
[601.922596] Dynamic subtest bcs0: SUCCESS (2.548s)
[601.933763] Starting dynamic subtest: vcs0
[605.694684] Dynamic subtest vcs0: SUCCESS (3.768s)
[605.712065] Starting dynamic subtest: vcs1
[609.662328] Dynamic subtest vcs1: SUCCESS (3.965s)
[609.674152] Starting dynamic subtest: vecs0
[613.693035] Dynamic subtest vecs0: SUCCESS (4.027s)
[613.705718] Starting dynamic subtest: ccs0
[616.240765] Dynamic subtest ccs0: SUCCESS (2.546s)
[616.243653] Subtest busy-start: SUCCESS (19.420s)
[616.354420] [114/132] (413s left) kms_color_pipeline (plane-lut1d)
[616.457286] Starting subtest: plane-lut1d
[616.470271] Starting dynamic subtest: pipe-A-eDP-1
[617.281285] Dynamic subtest pipe-A-eDP-1: FAIL (0.365s)
[617.879675] Starting dynamic subtest: pipe-B-eDP-1
[618.803293] Dynamic subtest pipe-B-eDP-1: FAIL (0.313s)
[619.279757] Starting dynamic subtest: pipe-C-eDP-1
[620.272220] Dynamic subtest pipe-C-eDP-1: FAIL (0.246s)
[620.573911] Starting dynamic subtest: pipe-D-eDP-1
[621.487617] Dynamic subtest pipe-D-eDP-1: FAIL (0.246s)
[621.490148] Subtest plane-lut1d: FAIL (4.657s)
[621.950292] [115/132] (407s left) gen9_exec_parse (batch-zero-length)
[622.014770] Subtest batch-zero-length: SKIP (0.000s)
[622.109674] [116/132] (407s left) i915_drm_fdinfo (context-close-stress)
[622.155879] Starting subtest: context-close-stress
[632.899958] Subtest context-close-stress: SUCCESS (10.745s)
[633.008026] [117/132] (397s left) kms_chamelium_hpd (hdmi-hpd-storm)
[633.541676] Subtest hdmi-hpd-storm: SKIP (0.000s)
[634.405770] [118/132] (395s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[634.493458] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[634.496010] Starting dynamic subtest: pipe-A-eDP-1
[634.524313] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[634.535506] Starting dynamic subtest: pipe-B-eDP-1
[634.562755] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[634.572728] Starting dynamic subtest: pipe-C-eDP-1
[634.601491] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[634.611514] Starting dynamic subtest: pipe-D-eDP-1
[634.639988] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[634.644586] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[636.742135] [119/132] (393s left) syncobj_timeline (invalid-signal-bad-pad)
[636.807760] Starting subtest: invalid-signal-bad-pad
[636.810205] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[636.947317] [120/132] (393s left) gem_exec_fence (submit67)
[637.130538] Starting subtest: submit67
[637.136237] Subtest submit67: SKIP (0.000s)
[638.761565] [FACT gem_exec_fence (submit67)] new: kernel.kmod_is_loaded.vgem: true
[638.765292] [121/132] (391s left) gem_eio (in-flight-internal-10ms)
[638.994620] Starting subtest: in-flight-internal-10ms
[640.799637] Subtest in-flight-internal-10ms: SUCCESS (1.804s)
[640.947485] [122/132] (389s left) gem_exec_schedule (preempt-contexts)
[641.014724] Starting subtest: preempt-contexts
[641.017335] Starting dynamic subtest: rcs0
[641.064558] Dynamic subtest rcs0: SUCCESS (0.061s)
[641.075030] Starting dynamic subtest: bcs0
[641.123124] Dynamic subtest bcs0: SUCCESS (0.058s)
[641.134456] Starting dynamic subtest: vcs0
[641.169380] Dynamic subtest vcs0: SUCCESS (0.046s)
[641.180344] Starting dynamic subtest: vcs1
[641.211723] Dynamic subtest vcs1: SUCCESS (0.040s)
[641.222537] Starting dynamic subtest: vecs0
[641.258543] Dynamic subtest vecs0: SUCCESS (0.046s)
[641.268739] Starting dynamic subtest: ccs0
[641.317115] Dynamic subtest ccs0: SUCCESS (0.059s)
[641.319535] Subtest preempt-contexts: SUCCESS (0.315s)
[642.825287] [123/132] (387s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[647.904279] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[647.910348] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.002s)
[648.740612] [124/132] (381s left) kms_chamelium_audio (dp-audio)
[649.129219] Subtest dp-audio: SKIP (0.000s)
[649.915537] [125/132] (380s left) kms_psr (psr2-cursor-plane-onoff)
[650.011938] Starting subtest: psr2-cursor-plane-onoff
[650.014631] Starting dynamic subtest: eDP-1
[651.669519] Dynamic subtest eDP-1: SUCCESS (1.659s)
[651.672375] Subtest psr2-cursor-plane-onoff: SUCCESS (1.660s)
[652.549622] [126/132] (377s left) kms_plane_scaling (planes-downscale-factor-0-75)
[652.649663] Starting subtest: planes-downscale-factor-0-75
[652.652463] Starting dynamic subtest: pipe-A
[652.675554] Dynamic subtest pipe-A: SKIP (0.020s)
[652.688504] Starting dynamic subtest: pipe-B
[652.723749] Dynamic subtest pipe-B: SKIP (0.046s)
[652.734225] Starting dynamic subtest: pipe-C
[652.764875] Dynamic subtest pipe-C: SKIP (0.040s)
[652.777627] Starting dynamic subtest: pipe-D
[652.802204] Dynamic subtest pipe-D: SKIP (0.037s)
[652.807552] Subtest planes-downscale-factor-0-75: SKIP (0.148s)
[652.918205] [127/132] (377s left) kms_vblank (ts-continuation-modeset)
[653.017334] Starting subtest: ts-continuation-modeset
[653.019588] Starting dynamic subtest: pipe-A-eDP-1
[654.464108] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.447s)
[654.481505] Starting dynamic subtest: pipe-D-eDP-1
[656.665054] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.198s)
[656.667664] Subtest ts-continuation-modeset: SUCCESS (3.649s)
[657.548343] [128/132] (372s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[657.607047] Starting subtest: framebuffer-vs-set-tiling
[657.611902] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[657.775529] [129/132] (372s left) kms_cursor_crc (cursor-sliding-512x170)
[658.082252] Starting subtest: cursor-sliding-512x170
[658.086738] Subtest cursor-sliding-512x170: SKIP (0.001s)
[658.258736] [130/132] (372s left) gem_exec_capture (capture)
[658.333368] Starting subtest: capture
[658.335733] Starting dynamic subtest: rcs0-smem
[659.172646] Dynamic subtest rcs0-smem: SUCCESS (0.836s)
[659.197252] Starting dynamic subtest: bcs0-smem
[660.502394] Dynamic subtest bcs0-smem: SUCCESS (1.331s)
[660.513716] Starting dynamic subtest: vcs0-smem
[661.330743] Dynamic subtest vcs0-smem: SUCCESS (0.828s)
[661.341333] Starting dynamic subtest: vcs1-smem
[662.657221] Dynamic subtest vcs1-smem: SUCCESS (1.326s)
[662.667726] Starting dynamic subtest: vecs0-smem
[663.546469] Dynamic subtest vecs0-smem: FAIL (0.812s)
[663.558136] Starting dynamic subtest: ccs0-smem
[664.793394] Dynamic subtest ccs0-smem: SUCCESS (1.322s)
[664.796118] Subtest capture: FAIL (6.459s)
[664.954155] [131/132] (365s left) i915_pm_rps (min-max-config-idle)
[665.016535] Starting subtest: min-max-config-idle
[665.021973] Subtest min-max-config-idle: SKIP (0.002s)
[665.145161] [132/132] (365s left) kms_flip (2x-plain-flip)
[665.247759] Starting subtest: 2x-plain-flip
[665.256351] Subtest 2x-plain-flip: SKIP (0.010s)
[665.393877] 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.