[56.339285] Initializing watchdogs
[56.339330]   /dev/watchdog0
[56.353439] [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.357925] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.360120] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.363633] [001/133] (960s left) gem_partial_pwrite_pread (write-snoop)
[56.465782] Subtest write-snoop: SKIP (0.000s)
[56.559348] [002/133] (960s left) kms_content_protection (content-type-change)
[56.715442] Starting subtest: content-type-change
[56.720110] Subtest content-type-change: SKIP (0.000s)
[56.869858] [003/133] (960s left) kms_rotation_crc (multiplane-rotation)
[56.975322] Starting subtest: multiplane-rotation
[74.418150] Subtest multiplane-rotation: SUCCESS (17.471s)
[74.555127] [004/133] (942s left) kms_chamelium_color (ctm-red-to-blue)
[74.661361] Subtest ctm-red-to-blue: SKIP (0.000s)
[74.701442] [005/133] (942s left) syncobj_wait (invalid-reset-one-illegal-handle)
[74.765519] Starting subtest: invalid-reset-one-illegal-handle
[74.767603] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[74.879570] [006/133] (942s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[74.984131] Starting subtest: disable-crc-after-crtc
[74.985781] Starting dynamic subtest: pipe-A-eDP-1
[76.622476] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.638s)
[76.631196] Starting dynamic subtest: pipe-B-eDP-1
[78.970582] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.348s)
[78.979740] Starting dynamic subtest: pipe-C-eDP-1
[81.240260] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.267s)
[81.249730] Starting dynamic subtest: pipe-D-eDP-1
[83.513382] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.272s)
[83.515324] Subtest disable-crc-after-crtc: SUCCESS (8.529s)
[84.346139] [007/133] (932s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[84.428648] Subtest tiled-to-tiled: SKIP (0.000s)
[84.516532] [008/133] (932s left) syncobj_wait (wait-all-interrupted)
[84.580422] Starting subtest: wait-all-interrupted
[84.683015] Subtest wait-all-interrupted: SUCCESS (0.102s)
[84.782287] [009/133] (932s left) syncobj_wait (wait-all-complex)
[84.852400] Starting subtest: wait-all-complex
[85.065667] Subtest wait-all-complex: SUCCESS (0.212s)
[85.165257] [010/133] (932s left) gem_pxp (reject-modify-context-protection-on)
[85.307098] Starting subtest: reject-modify-context-protection-on
[85.309718] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[85.434917] [011/133] (931s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[85.550320] Starting subtest: cursorA-vs-flipB-varying-size
[85.554832] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[85.715608] [012/133] (931s left) kms_rotation_crc (primary-rotation-90)
[85.820275] Starting subtest: primary-rotation-90
[85.824742] Subtest primary-rotation-90: SKIP (0.001s)
[85.913729] [013/133] (931s left) syncobj_wait (reset-multiple-signaled)
[85.973178] Starting subtest: reset-multiple-signaled
[85.975123] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[86.109862] [014/133] (931s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[86.213263] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[86.216734] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[87.373147] [015/133] (930s left) gem_softpin (noreloc-s3)
[87.450450] Starting subtest: noreloc-S3
[107.916686] Subtest noreloc-S3: SUCCESS (5.380s)
[108.152092] [016/133] (909s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[108.272934] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[112.754677] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.522s)
[113.889318] [017/133] (903s left) gem_ctx_param (invalid-ctx-set)
[113.950335] Starting subtest: invalid-ctx-set
[113.952809] Subtest invalid-ctx-set: SUCCESS (0.001s)
[114.113918] [018/133] (903s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[114.164345] Starting subtest: single-wait-all-for-submit-unsubmitted
[114.266229] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[114.362830] [019/133] (903s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[114.481812] Starting subtest: x-tiled-64bpp-rotate-90
[114.501505] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[114.662773] [020/133] (902s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[114.729783] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[114.782274] [021/133] (902s left) kms_psr (fbc-psr-cursor-plane-move)
[114.871168] Starting subtest: fbc-psr-cursor-plane-move
[114.873409] Starting dynamic subtest: eDP-1
[114.877806] Dynamic subtest eDP-1: SKIP (0.000s)
[114.882244] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[114.963117] [022/133] (902s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[115.065218] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[116.095989] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.034s)
[116.294554] [023/133] (901s left) kms_flip (2x-flip-vs-rmfb)
[116.396098] Starting subtest: 2x-flip-vs-rmfb
[116.405287] Subtest 2x-flip-vs-rmfb: SKIP (0.011s)
[116.506655] [024/133] (901s left) kms_plane_cursor (viewport)
[116.595104] Starting subtest: viewport
[116.598909] Starting dynamic subtest: pipe-A-eDP-1-size-64
[119.138789] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.553s)
[119.199608] Starting dynamic subtest: pipe-A-eDP-1-size-128
[121.721782] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.538s)
[121.781778] Starting dynamic subtest: pipe-A-eDP-1-size-256
[124.318004] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.548s)
[124.672826] Starting dynamic subtest: pipe-B-eDP-1-size-64
[127.912728] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.256s)
[127.974801] Starting dynamic subtest: pipe-B-eDP-1-size-128
[130.499690] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.537s)
[130.570017] Starting dynamic subtest: pipe-B-eDP-1-size-256
[133.221738] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.671s)
[133.591154] Starting dynamic subtest: pipe-C-eDP-1-size-64
[136.439391] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.857s)
[136.476754] Starting dynamic subtest: pipe-C-eDP-1-size-128
[138.673449] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.202s)
[138.711039] Starting dynamic subtest: pipe-C-eDP-1-size-256
[140.895535] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.191s)
[141.229599] Starting dynamic subtest: pipe-D-eDP-1-size-64
[144.088844] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.867s)
[144.126737] Starting dynamic subtest: pipe-D-eDP-1-size-128
[146.300652] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.180s)
[146.336861] Starting dynamic subtest: pipe-D-eDP-1-size-256
[148.489562] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.158s)
[148.807927] Subtest viewport: SUCCESS (32.242s)
[149.673781] [025/133] (868s left) kms_cdclk (mode-transition)
[149.777376] Starting subtest: mode-transition
[149.779613] Starting dynamic subtest: pipe-A-eDP-1
[150.070710] Dynamic subtest pipe-A-eDP-1: SKIP (0.293s)
[150.079618] Starting dynamic subtest: pipe-B-eDP-1
[150.084252] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[150.092774] Starting dynamic subtest: pipe-C-eDP-1
[150.097480] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[150.107989] Starting dynamic subtest: pipe-D-eDP-1
[150.112170] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[150.116232] Subtest mode-transition: SKIP (0.301s)
[150.901585] [026/133] (866s left) gem_exec_balancer (fairslice)
[150.959634] Starting subtest: fairslice
[153.849620] Subtest fairslice: SUCCESS (2.888s)
[155.111496] [027/133] (862s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[155.245365] Starting subtest: basic-flip-before-cursor-varying-size
[156.171910] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.925s)
[157.022409] [028/133] (860s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[157.131943] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[157.134266] Starting dynamic subtest: pipe-A-default-mode
[157.421467] Dynamic subtest pipe-A-default-mode: SKIP (0.288s)
[157.426076] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.289s)
[158.242404] [029/133] (859s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[158.345686] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[158.347928] Starting dynamic subtest: pipe-A-default-mode
[161.079407] Dynamic subtest pipe-A-default-mode: SUCCESS (2.734s)
[161.081849] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.736s)
[161.938574] [030/133] (856s left) core_getstats (basic)
[162.002366] Starting subtest: basic
[162.004365] Subtest basic: SUCCESS (0.000s)
[162.141293] [031/133] (855s left) kms_rmfb (close-fd)
[162.250926] Starting subtest: close-fd
[162.253216] Starting dynamic subtest: pipe-A-eDP-1
[162.357178] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.108s)
[162.365774] Starting dynamic subtest: pipe-B-eDP-1
[163.584315] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.225s)
[163.593996] Starting dynamic subtest: pipe-C-eDP-1
[164.714121] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.129s)
[164.723488] Starting dynamic subtest: pipe-D-eDP-1
[165.832542] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.117s)
[165.834694] Subtest close-fd: SUCCESS (3.585s)
[167.073421] [032/133] (851s left) gem_exec_reloc (basic-gtt-wc)
[167.141601] Subtest basic-gtt-wc: SKIP (0.000s)
[167.260378] [033/133] (850s left) kms_properties (crtc-properties-legacy)
[167.376149] Starting subtest: crtc-properties-legacy
[167.378485] Starting dynamic subtest: pipe-A-eDP-1
[167.845246] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.465s)
[167.854740] Starting dynamic subtest: pipe-B-eDP-1
[169.002935] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.157s)
[169.012250] Starting dynamic subtest: pipe-C-eDP-1
[170.122235] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.120s)
[170.132680] Starting dynamic subtest: pipe-D-eDP-1
[171.257215] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s)
[171.259445] Subtest crtc-properties-legacy: SUCCESS (3.883s)
[172.093152] [034/133] (846s left) kms_invalid_mode (zero-hdisplay)
[172.198229] Starting subtest: zero-hdisplay
[172.200321] Starting dynamic subtest: pipe-A-eDP-1
[172.483051] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[172.491587] Starting dynamic subtest: pipe-B-eDP-1
[172.493713] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[172.502102] Starting dynamic subtest: pipe-C-eDP-1
[172.504227] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[172.512481] Starting dynamic subtest: pipe-D-eDP-1
[172.514372] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[172.516237] Subtest zero-hdisplay: SUCCESS (0.290s)
[173.310976] [035/133] (844s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[173.418008] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[173.420157] Starting dynamic subtest: pipe-A
[174.465541] Dynamic subtest pipe-A: SUCCESS (1.050s)
[174.482228] Starting dynamic subtest: pipe-B
[176.603206] Dynamic subtest pipe-B: SUCCESS (2.136s)
[176.611335] Starting dynamic subtest: pipe-C
[177.797138] Dynamic subtest pipe-C: SUCCESS (1.193s)
[177.805814] Starting dynamic subtest: pipe-D
[178.948925] Dynamic subtest pipe-D: SUCCESS (1.151s)
[178.951231] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.535s)
[180.177410] [036/133] (838s left) kms_pm_rpm (legacy-planes-dpms)
[182.199535] Starting subtest: legacy-planes-dpms
[182.202036] Starting dynamic subtest: plane-63
[190.775029] Dynamic subtest plane-63: SUCCESS (8.578s)
[190.788809] Starting dynamic subtest: plane-93
[199.043275] Dynamic subtest plane-93: SUCCESS (8.269s)
[199.057782] Starting dynamic subtest: plane-123
[207.356630] Dynamic subtest plane-123: SUCCESS (8.314s)
[207.367659] Starting dynamic subtest: plane-133
[215.655656] Dynamic subtest plane-133: SUCCESS (8.298s)
[215.658712] Subtest legacy-planes-dpms: SUCCESS (33.468s)
[216.053370] [037/133] (802s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[216.156972] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[216.161197] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[216.274847] [038/133] (802s left) kms_dirtyfb (default-dirtyfb-ioctl)
[216.383040] Starting subtest: default-dirtyfb-ioctl
[216.385372] Starting dynamic subtest: A-eDP-1
[218.011955] Dynamic subtest A-eDP-1: SUCCESS (1.625s)
[218.014136] Subtest default-dirtyfb-ioctl: SUCCESS (1.626s)
[218.881242] [039/133] (799s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[219.000475] Starting subtest: cursorB-vs-flipA-legacy
[219.004946] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[219.164768] [040/133] (799s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[219.226032] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[219.228326] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[219.348639] [041/133] (799s left) kms_prime (basic-crc-vgem)
[219.486417] Starting subtest: basic-crc-vgem
[219.488629] Starting dynamic subtest: second-to-first
[220.467311] Dynamic subtest second-to-first: SUCCESS (0.981s)
[220.469223] Subtest basic-crc-vgem: SUCCESS (0.982s)
[220.581194] [FACT kms_prime (basic-crc-vgem)] new: kernel.kmod_is_loaded.vgem: true
[220.584132] [042/133] (797s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[220.643015] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[220.728877] [043/133] (797s left) i915_drm_fdinfo (busy)
[220.772693] Starting subtest: busy
[220.774487] Starting dynamic subtest: rcs0
[220.810613] Dynamic subtest rcs0: SKIP (0.037s)
[220.821312] Starting dynamic subtest: bcs0
[220.824719] Dynamic subtest bcs0: SKIP (0.001s)
[220.832726] Starting dynamic subtest: vcs0
[220.835952] Dynamic subtest vcs0: SKIP (0.000s)
[220.843945] Starting dynamic subtest: vcs1
[220.847421] Dynamic subtest vcs1: SKIP (0.000s)
[220.855188] Starting dynamic subtest: vecs0
[220.858622] Dynamic subtest vecs0: SKIP (0.000s)
[220.866244] Starting dynamic subtest: ccs0
[220.869655] Dynamic subtest ccs0: SKIP (0.000s)
[220.873095] Subtest busy: SKIP (0.043s)
[220.911844] [044/133] (797s left) gem_userptr_blits (nohangcheck)
[220.985483] Starting subtest: nohangcheck
[221.262552] Subtest nohangcheck: SUCCESS (0.279s)
[221.423073] [045/133] (797s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[221.535682] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[222.174415] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.640s)
[222.351594] [046/133] (796s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[222.447882] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[222.452195] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[223.620722] [047/133] (795s left) kms_scaling_modes (scaling-mode-full)
[223.723586] Starting subtest: scaling-mode-full
[223.725492] Starting dynamic subtest: pipe-A-eDP-1
[223.815562] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[223.831571] Starting dynamic subtest: pipe-B-eDP-1
[225.026239] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.206s)
[225.034898] Starting dynamic subtest: pipe-C-eDP-1
[226.131038] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.103s)
[226.140288] Starting dynamic subtest: pipe-D-eDP-1
[227.262036] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[227.264277] Subtest scaling-mode-full: SUCCESS (3.540s)
[228.450150] [048/133] (790s left) kms_psr (fbc-pr-basic)
[228.536169] Starting subtest: fbc-pr-basic
[228.540100] Subtest fbc-pr-basic: SKIP (0.000s)
[228.634760] [049/133] (790s left) gem_ringfill (basic-all)
[234.041946] Starting subtest: basic-all
[235.192120] Subtest basic-all: SUCCESS (1.148s)
[235.369633] [050/133] (783s left) gem_exec_whisper (basic-fds-forked-all)
[235.428797] Starting subtest: basic-fds-forked-all
[257.259490] Subtest basic-fds-forked-all: SUCCESS (21.824s)
[257.463222] [051/133] (761s left) api_intel_bb (full-batch)
[257.529000] Starting subtest: full-batch
[257.537852] Subtest full-batch: SUCCESS (0.012s)
[257.709018] [052/133] (761s left) kms_cursor_crc (cursor-sliding-256x85)
[257.948856] Starting subtest: cursor-sliding-256x85
[257.998561] Subtest cursor-sliding-256x85: SKIP (0.045s)
[258.211332] [053/133] (760s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[258.312038] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[258.314320] Starting dynamic subtest: pipe-A-eDP-1
[258.372548] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[258.383836] Starting dynamic subtest: pipe-B-eDP-1
[258.431489] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[258.440757] Starting dynamic subtest: pipe-C-eDP-1
[258.485379] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[258.493709] Starting dynamic subtest: pipe-D-eDP-1
[258.537904] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[258.541306] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.009s)
[260.600195] [054/133] (758s left) gen9_exec_parse (allowed-single)
[260.675044] Subtest allowed-single: SKIP (0.000s)
[260.760647] [055/133] (758s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[260.867625] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[267.972154] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.108s)
[268.135065] [056/133] (750s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[268.245369] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[268.249392] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[268.362667] [057/133] (750s left) gem_exec_fence (expired-history)
[268.876835] Starting subtest: expired-history
[275.851297] Subtest expired-history: SUCCESS (6.975s)
[276.324617] [058/133] (742s left) kms_psr (fbc-psr-sprite-plane-move)
[276.428848] Starting subtest: fbc-psr-sprite-plane-move
[276.431141] Starting dynamic subtest: eDP-1
[276.435464] Dynamic subtest eDP-1: SKIP (0.000s)
[276.439804] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[276.525248] [059/133] (742s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[276.637058] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[283.414334] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.780s)
[283.560621] [060/133] (735s left) gem_ctx_bad_destroy (double-destroy)
[283.622504] Starting subtest: double-destroy
[283.624804] Subtest double-destroy: SUCCESS (0.000s)
[283.722454] [061/133] (735s left) syncobj_timeline (invalid-signal-illegal-handle)
[283.775533] Starting subtest: invalid-signal-illegal-handle
[283.777900] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[283.910294] [062/133] (735s left) kms_chamelium_hpd (common-hpd-after-suspend)
[284.287781] Subtest common-hpd-after-suspend: SKIP (0.000s)
[285.136838] [063/133] (734s left) kms_frontbuffer_tracking (fbc-tiling-4)
[285.234301] Starting subtest: fbc-tiling-4
[289.521851] Subtest fbc-tiling-4: SUCCESS (4.291s)
[290.679427] [064/133] (728s left) gem_cs_tlb (engines)
[290.743369] Starting subtest: engines
[290.745224] Starting dynamic subtest: rcs0
[292.897888] Dynamic subtest rcs0: SUCCESS (2.151s)
[292.908107] Starting dynamic subtest: bcs0
[295.049772] Dynamic subtest bcs0: SUCCESS (2.151s)
[295.060165] Starting dynamic subtest: vcs0
[297.202887] Dynamic subtest vcs0: SUCCESS (2.152s)
[297.212800] Starting dynamic subtest: vcs1
[299.354721] Dynamic subtest vcs1: SUCCESS (2.152s)
[299.366459] Starting dynamic subtest: vecs0
[301.506222] Dynamic subtest vecs0: SUCCESS (2.150s)
[301.516544] Starting dynamic subtest: ccs0
[303.659741] Dynamic subtest ccs0: SUCCESS (2.154s)
[303.662074] Subtest engines: SUCCESS (12.916s)
[303.831424] [065/133] (715s left) gem_mmap_gtt (hang-busy)
[303.893238] Subtest hang-busy: SKIP (0.000s)
[303.972175] [066/133] (715s left) kms_psr (psr2-sprite-plane-onoff)
[304.069794] Starting subtest: psr2-sprite-plane-onoff
[304.072027] Starting dynamic subtest: eDP-1
[305.772376] Dynamic subtest eDP-1: SUCCESS (1.704s)
[305.774706] Subtest psr2-sprite-plane-onoff: SUCCESS (1.705s)
[306.637489] [067/133] (712s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[306.741594] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[307.388716] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.649s)
[307.598839] [068/133] (712s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[307.712149] Starting subtest: y-tiled-64bpp-rotate-270
[307.716294] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[307.830375] [069/133] (711s left) gem_bad_reloc (negative-reloc-lut)
[307.893595] Subtest negative-reloc-lut: SKIP (0.000s)
[307.961412] [070/133] (711s left) gem_ctx_persistence (engines-mixed)
[308.027301] Starting subtest: engines-mixed
[308.029707] Starting dynamic subtest: rcs0
[308.128346] Dynamic subtest rcs0: SUCCESS (0.100s)
[308.141323] Starting dynamic subtest: bcs0
[308.207156] Dynamic subtest bcs0: SUCCESS (0.077s)
[308.219784] Starting dynamic subtest: vcs0
[308.288847] Dynamic subtest vcs0: SUCCESS (0.080s)
[308.301499] Starting dynamic subtest: vcs1
[308.358807] Dynamic subtest vcs1: SUCCESS (0.068s)
[308.370709] Starting dynamic subtest: vecs0
[308.438808] Dynamic subtest vecs0: SUCCESS (0.078s)
[308.451313] Starting dynamic subtest: ccs0
[308.508315] Dynamic subtest ccs0: SUCCESS (0.068s)
[308.510508] Subtest engines-mixed: SUCCESS (0.482s)
[308.615795] [071/133] (711s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[308.714716] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[308.716689] Starting dynamic subtest: pipe-A
[308.778254] Dynamic subtest pipe-A: SUCCESS (0.065s)
[308.793551] Starting dynamic subtest: pipe-B
[309.943176] Dynamic subtest pipe-B: SUCCESS (1.164s)
[309.955096] Starting dynamic subtest: pipe-C
[311.057946] Dynamic subtest pipe-C: SUCCESS (1.112s)
[311.073627] Starting dynamic subtest: pipe-D
[312.194521] Dynamic subtest pipe-D: SUCCESS (1.135s)
[312.196944] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.483s)
[313.373900] [072/133] (706s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[313.476710] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[313.481015] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[313.612818] [073/133] (706s left) gem_exec_schedule (semaphore-noskip)
[313.695161] Starting subtest: semaphore-noskip
[314.118448] Subtest semaphore-noskip: SUCCESS (0.423s)
[314.486242] [074/133] (705s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[314.588294] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[314.592633] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[314.716135] [075/133] (705s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[314.820417] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[314.824540] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[314.960617] [076/133] (704s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[315.058662] Starting subtest: 4-tiled-16bpp-rotate-0
[316.293861] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.235s)
[316.464390] [077/133] (703s left) gem_exec_basic (basic)
[316.529996] Starting subtest: basic
[316.531999] Starting dynamic subtest: rcs0-smem
[316.534039] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[316.545798] Starting dynamic subtest: bcs0-smem
[316.547410] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[316.556668] Starting dynamic subtest: vcs0-smem
[316.558219] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[316.567202] Starting dynamic subtest: vcs1-smem
[316.568736] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[316.577353] Starting dynamic subtest: vecs0-smem
[316.578901] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[316.587914] Starting dynamic subtest: ccs0-smem
[316.589534] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[316.591083] Subtest basic: SUCCESS (0.014s)
[318.130460] [078/133] (701s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[318.224037] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[318.228578] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[318.359457] [079/133] (701s left) gem_mmap (short-mmap)
[318.433485] Subtest short-mmap: SKIP (0.000s)
[318.499384] [080/133] (701s left) gem_exec_reloc (basic-gtt-wc-active)
[318.561065] Subtest basic-gtt-wc-active: SKIP (0.000s)
[318.646804] [081/133] (701s left) gem_ctx_shared (create-shared-gtt)
[318.707942] Starting subtest: create-shared-gtt
[320.861472] Subtest create-shared-gtt: SUCCESS (2.153s)
[321.264329] [082/133] (698s left) gem_exec_reloc (basic-write-wc)
[321.323868] Subtest basic-write-wc: SKIP (0.000s)
[321.395456] [083/133] (698s left) gem_eio (wait-immediate)
[321.636814] Starting subtest: wait-immediate
[322.051462] Subtest wait-immediate: SUCCESS (0.416s)
[322.236721] [084/133] (698s left) gem_ctx_persistence (legacy-engines-mixed)
[322.311503] Starting subtest: legacy-engines-mixed
[322.313505] Starting dynamic subtest: render
[322.427830] Dynamic subtest render: SUCCESS (0.115s)
[322.447519] Starting dynamic subtest: bsd1
[322.498775] Dynamic subtest bsd1: SUCCESS (0.068s)
[322.511358] Starting dynamic subtest: bsd2
[322.552317] Dynamic subtest bsd2: SUCCESS (0.051s)
[322.562866] Starting dynamic subtest: blt
[322.628624] Dynamic subtest blt: SUCCESS (0.074s)
[322.642496] Starting dynamic subtest: vebox
[322.709889] Dynamic subtest vebox: SUCCESS (0.079s)
[322.712317] Subtest legacy-engines-mixed: SUCCESS (0.399s)
[322.821891] [085/133] (697s left) perf_pmu (semaphore-busy)
[322.855445] Starting subtest: semaphore-busy
[322.857536] Starting dynamic subtest: rcs0
[324.521883] Dynamic subtest rcs0: SUCCESS (1.663s)
[324.534473] Starting dynamic subtest: bcs0
[326.153722] Dynamic subtest bcs0: SUCCESS (1.629s)
[326.166151] Starting dynamic subtest: vcs0
[330.544212] Dynamic subtest vcs0: SUCCESS (4.390s)
[330.556649] Starting dynamic subtest: vcs1
[336.560512] Dynamic subtest vcs1: SUCCESS (6.013s)
[336.572185] Starting dynamic subtest: vecs0
[342.576017] Dynamic subtest vecs0: SUCCESS (6.014s)
[342.588489] Starting dynamic subtest: ccs0
[345.651526] Dynamic subtest ccs0: SUCCESS (3.070s)
[345.654135] Subtest semaphore-busy: SUCCESS (22.798s)
[345.788122] [086/133] (674s left) gem_exec_schedule (pi-common)
[345.986748] Starting subtest: pi-common
[345.988819] Starting dynamic subtest: rcs0
[346.023407] Dynamic subtest rcs0: SUCCESS (0.039s)
[346.034047] Starting dynamic subtest: bcs0
[346.062563] Dynamic subtest bcs0: SUCCESS (0.038s)
[346.072949] Starting dynamic subtest: vcs0
[346.106720] Dynamic subtest vcs0: SUCCESS (0.042s)
[346.116666] Starting dynamic subtest: vcs1
[346.139093] Dynamic subtest vcs1: SUCCESS (0.032s)
[346.149214] Starting dynamic subtest: vecs0
[346.173997] Dynamic subtest vecs0: SUCCESS (0.033s)
[346.188121] Starting dynamic subtest: ccs0
[346.206222] Dynamic subtest ccs0: SUCCESS (0.032s)
[346.208384] Subtest pi-common: SUCCESS (0.223s)
[346.458829] [087/133] (673s left) i915_hangman (engine-error-state-capture)
[346.531375] Starting subtest: engine-error-state-capture
[346.533682] Starting dynamic subtest: rcs0
[350.035049] Dynamic subtest rcs0: SUCCESS (3.502s)
[350.048020] Starting dynamic subtest: bcs0
[355.988603] Dynamic subtest bcs0: SUCCESS (5.948s)
[356.001876] Starting dynamic subtest: vcs0
[362.004307] Dynamic subtest vcs0: SUCCESS (6.011s)
[362.017605] Starting dynamic subtest: vcs1
[368.020510] Dynamic subtest vcs1: SUCCESS (6.012s)
[368.040501] Starting dynamic subtest: vecs0
[373.971924] Dynamic subtest vecs0: SUCCESS (5.948s)
[373.985685] Starting dynamic subtest: ccs0
[379.987520] Dynamic subtest ccs0: SUCCESS (6.012s)
[379.990559] Subtest engine-error-state-capture: SUCCESS (33.449s)
[380.095346] [088/133] (640s left) syncobj_timeline (wait-for-submit-snapshot)
[380.167543] Starting subtest: wait-for-submit-snapshot
[380.247365] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[380.352501] [089/133] (640s left) kms_color (ctm-blue-to-red)
[380.452804] Starting subtest: ctm-blue-to-red
[380.454654] Starting dynamic subtest: pipe-A-eDP-1
[381.139378] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.685s)
[381.149420] Starting dynamic subtest: pipe-B-eDP-1
[382.581302] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.441s)
[382.591933] Starting dynamic subtest: pipe-C-eDP-1
[383.917412] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.337s)
[383.927616] Starting dynamic subtest: pipe-D-eDP-1
[385.238458] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.319s)
[385.240847] Subtest ctm-blue-to-red: SUCCESS (4.786s)
[386.085396] [090/133] (634s left) prime_vgem (basic-gtt)
[386.157620] Starting subtest: basic-gtt
[386.162336] Subtest basic-gtt: SKIP (0.000s)
[386.281448] [091/133] (634s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[386.375843] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[393.885019] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.511s)
[394.067305] [092/133] (626s left) api_intel_allocator (default-alignment)
[394.122756] Starting subtest: default-alignment
[394.125201] Subtest default-alignment: SUCCESS (0.003s)
[394.275846] [093/133] (626s left) i915_pm_rps (fence-order)
[394.339218] Starting subtest: fence-order
[397.200782] Subtest fence-order: SUCCESS (2.860s)
[397.362916] [094/133] (623s left) kms_vblank (query-busy)
[397.470940] Starting subtest: query-busy
[397.473325] Starting dynamic subtest: pipe-A-eDP-1
[399.348345] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.877s)
[399.363869] Starting dynamic subtest: pipe-D-eDP-1
[401.922462] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.570s)
[401.924827] Subtest query-busy: SUCCESS (4.451s)
[402.753142] [095/133] (618s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[402.851943] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[402.856513] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[402.969217] [096/133] (617s left) kms_addfb_basic (invalid-get-prop-any)
[403.032709] Starting subtest: invalid-get-prop-any
[403.034939] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[403.185193] [097/133] (617s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[403.275896] Starting subtest: fbc-psr2-cursor-mmap-gtt
[403.278140] Starting dynamic subtest: eDP-1
[403.282179] Dynamic subtest eDP-1: SKIP (0.000s)
[403.286202] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[403.374165] [098/133] (617s left) kms_flip (2x-blocking-absolute-wf_vblank)
[403.475171] Starting subtest: 2x-blocking-absolute-wf_vblank
[403.484226] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s)
[403.628129] [099/133] (617s left) kms_cursor_crc (cursor-onscreen-256x85)
[403.886551] Starting subtest: cursor-onscreen-256x85
[403.934374] Subtest cursor-onscreen-256x85: SKIP (0.043s)
[404.149742] [100/133] (616s left) kms_flip (2x-modeset-vs-vblank-race)
[404.245299] Starting subtest: 2x-modeset-vs-vblank-race
[404.254458] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[404.401679] [101/133] (616s left) kms_atomic_interruptible (atomic-setmode)
[404.490400] Starting subtest: atomic-setmode
[404.492264] Starting dynamic subtest: pipe-A-eDP-1
[411.397950] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.906s)
[411.400720] Subtest atomic-setmode: SUCCESS (6.908s)
[412.309126] [102/133] (608s left) kms_frontbuffer_tracking (psr-argb161616f-draw-render)
[412.420110] Starting subtest: psr-argb161616f-draw-render
[412.424085] Subtest psr-argb161616f-draw-render: SKIP (0.000s)
[412.551022] [103/133] (608s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[412.648591] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[412.652754] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[412.789443] [104/133] (608s left) kms_plane_scaling (invalid-num-scalers)
[412.886518] Starting subtest: invalid-num-scalers
[412.888862] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[412.906647] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.021s)
[412.920002] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[412.948327] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.040s)
[412.958595] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[412.985669] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.033s)
[412.995576] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[413.017309] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.033s)
[413.019583] Subtest invalid-num-scalers: SUCCESS (0.134s)
[413.167204] [105/133] (608s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[413.268276] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[413.271683] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[413.408821] [106/133] (607s left) sw_sync (alloc_fence_invalid_timeline)
[413.445268] Starting subtest: alloc_fence_invalid_timeline
[413.447151] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[413.528939] [107/133] (607s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[413.592803] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[413.697221] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.104s)
[413.801573] [108/133] (607s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[413.890236] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[413.892422] Starting dynamic subtest: A-eDP1
[422.830715] Dynamic subtest A-eDP1: SUCCESS (8.939s)
[422.843033] Starting dynamic subtest: B-eDP1
[431.749921] Dynamic subtest B-eDP1: SUCCESS (8.918s)
[431.764476] Starting dynamic subtest: C-eDP1
[440.674716] Dynamic subtest C-eDP1: SUCCESS (8.920s)
[440.686645] Starting dynamic subtest: D-eDP1
[449.608238] Dynamic subtest D-eDP1: SUCCESS (8.933s)
[449.614421] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.723s)
[450.861484] [109/133] (570s left) kms_addfb_basic (size-max)
[450.963953] Starting subtest: size-max
[450.966145] Subtest size-max: SUCCESS (0.000s)
[451.077373] [110/133] (570s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[451.333705] Starting subtest: cursor-rapid-movement-256x256
[451.338395] Starting dynamic subtest: pipe-A-eDP-1
[451.887766] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.547s)
[451.918275] Starting dynamic subtest: pipe-D-eDP-1
[453.066011] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.157s)
[453.068768] Subtest cursor-rapid-movement-256x256: SUCCESS (1.732s)
[453.956358] [111/133] (567s left) gem_exec_whisper (basic-queues-all)
[454.031645] Starting subtest: basic-queues-all
[462.533374] Subtest basic-queues-all: SUCCESS (8.500s)
[462.741395] [112/133] (558s left) kms_dsc (dsc-fractional-bpp)
[462.847109] Starting subtest: dsc-fractional-bpp
[462.860457] Subtest dsc-fractional-bpp: SKIP (0.001s)
[462.945981] [113/133] (558s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[463.054184] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[463.056421] Starting dynamic subtest: pipe-A-default-mode
[463.342790] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[463.349011] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.289s)
[464.180904] [114/133] (557s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[464.272979] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[464.277430] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[464.394022] [115/133] (557s left) gem_softpin (evict-prime)
[464.457576] Starting subtest: evict-prime
[464.460042] Starting dynamic subtest: rcs0
[465.628281] Dynamic subtest rcs0: SUCCESS (1.170s)
[465.642179] Starting dynamic subtest: bcs0
[466.779619] Dynamic subtest bcs0: SUCCESS (1.150s)
[466.792053] Starting dynamic subtest: vcs0
[468.050496] Dynamic subtest vcs0: SUCCESS (1.267s)
[468.062711] Starting dynamic subtest: vcs1
[470.006578] Dynamic subtest vcs1: SUCCESS (1.954s)
[470.019057] Starting dynamic subtest: vecs0
[472.078008] Dynamic subtest vecs0: SUCCESS (2.069s)
[472.091380] Starting dynamic subtest: ccs0
[473.235908] Dynamic subtest ccs0: SUCCESS (1.157s)
[473.249175] Starting dynamic subtest: all
[475.019281] Dynamic subtest all: SUCCESS (1.780s)
[475.021811] Subtest evict-prime: SUCCESS (10.563s)
[475.121303] [116/133] (546s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[475.250456] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[475.254800] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[475.395530] [117/133] (546s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[475.499238] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[475.614536] [118/133] (546s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[475.676320] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[475.776393] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.101s)
[475.881112] [119/133] (545s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[475.986859] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[475.991366] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[476.128593] [120/133] (545s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[476.226996] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[480.359338] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.135s)
[481.574327] [121/133] (540s left) gem_mmap_wc (bad-size)
[481.629853] Subtest bad-size: SKIP (0.000s)
[481.709187] [122/133] (540s left) kms_hdr (static-toggle-suspend)
[481.798083] Starting subtest: static-toggle-suspend
[481.804288] Subtest static-toggle-suspend: SKIP (0.000s)
[481.908428] [123/133] (540s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[481.997950] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[482.002042] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[482.136003] [124/133] (539s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[487.106613] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[487.109067] Starting dynamic subtest: pipe-A-eDP-1
[487.919279] Dynamic subtest pipe-A-eDP-1: SKIP (0.808s)
[487.930306] Starting dynamic subtest: pipe-B-eDP-1
[489.046231] Dynamic subtest pipe-B-eDP-1: SKIP (1.124s)
[489.051066] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.936s)
[490.254783] [125/133] (531s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[490.357580] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[490.362029] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[490.472757] [126/133] (531s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[490.577228] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[490.579529] Starting dynamic subtest: pipe-A-eDP-1
[490.599600] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[490.610166] Starting dynamic subtest: pipe-B-eDP-1
[490.629231] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[490.638812] Starting dynamic subtest: pipe-C-eDP-1
[490.657759] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[490.667175] Starting dynamic subtest: pipe-D-eDP-1
[490.686667] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[490.688621] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[492.898862] [127/133] (529s left) syncobj_timeline (single-wait-all-available-submitted)
[492.962717] Starting subtest: single-wait-all-available-submitted
[492.964694] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[493.103325] [128/133] (529s left) gem_exec_parallel (userptr)
[493.163009] Starting subtest: userptr
[493.165397] Starting dynamic subtest: rcs0
[494.621779] Dynamic subtest rcs0: SUCCESS (1.458s)
[494.634679] Starting dynamic subtest: bcs0
[496.108769] Dynamic subtest bcs0: SUCCESS (1.484s)
[496.120275] Starting dynamic subtest: vcs0
[498.037729] Dynamic subtest vcs0: SUCCESS (1.926s)
[498.048144] Starting dynamic subtest: vcs1
[500.024201] Dynamic subtest vcs1: SUCCESS (1.984s)
[500.036922] Starting dynamic subtest: vecs0
[502.070042] Dynamic subtest vecs0: SUCCESS (2.044s)
[502.082163] Starting dynamic subtest: ccs0
[503.589604] Dynamic subtest ccs0: SUCCESS (1.518s)
[503.592545] Subtest userptr: SUCCESS (10.429s)
[503.804181] [129/133] (518s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[503.909727] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[503.913880] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[504.041219] [130/133] (518s left) i915_selftest (mock)
[507.656500] Starting subtest: mock
[507.658750] Starting dynamic subtest: sanitycheck
[508.449102] Dynamic subtest sanitycheck: SUCCESS (0.793s)
[508.458726] Starting dynamic subtest: shmem
[509.219420] Dynamic subtest shmem: SUCCESS (0.769s)
[509.229251] Starting dynamic subtest: fence
[517.324260] Dynamic subtest fence: SUCCESS (8.074s)
[517.334258] Starting dynamic subtest: scatterlist
[519.040557] Dynamic subtest scatterlist: SUCCESS (1.745s)
[519.051177] Starting dynamic subtest: syncmap
[522.306985] Dynamic subtest syncmap: SUCCESS (3.265s)
[522.317591] Starting dynamic subtest: uncore
[523.041165] Dynamic subtest uncore: SUCCESS (0.733s)
[523.051043] Starting dynamic subtest: ring
[523.730134] Dynamic subtest ring: SUCCESS (0.687s)
[523.740438] Starting dynamic subtest: engine
[524.489879] Dynamic subtest engine: SUCCESS (0.758s)
[524.500006] Starting dynamic subtest: timelines
[528.698272] Dynamic subtest timelines: SUCCESS (4.206s)
[528.708112] Starting dynamic subtest: requests
[532.660364] Dynamic subtest requests: SUCCESS (3.960s)
[532.670123] Starting dynamic subtest: objects
[533.534729] Dynamic subtest objects: SUCCESS (0.873s)
[533.544682] Starting dynamic subtest: phys
[534.398689] Dynamic subtest phys: SUCCESS (0.862s)
[534.408898] Starting dynamic subtest: dmabuf
[535.299485] Dynamic subtest dmabuf: SUCCESS (0.899s)
[535.309022] Starting dynamic subtest: vma
[540.759667] Dynamic subtest vma: SUCCESS (5.458s)
[540.769443] Starting dynamic subtest: evict
[542.235230] Dynamic subtest evict: SUCCESS (1.474s)
[542.243272] Starting dynamic subtest: gtt
[545.561021] Dynamic subtest gtt: SUCCESS (3.324s)
[545.571359] Starting dynamic subtest: hugepages
[546.585342] Dynamic subtest hugepages: SUCCESS (1.022s)
[546.595840] Starting dynamic subtest: memory_region
[549.287287] Dynamic subtest memory_region: SUCCESS (2.700s)
[549.289860] Subtest mock: SUCCESS (41.639s)
[549.322014] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[549.322735] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[549.326022] [131/133] (473s left) gem_mmap_gtt (basic-write-read)
[550.879848] Subtest basic-write-read: SKIP (0.000s)
[550.946147] [FACT gem_mmap_gtt (basic-write-read)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[550.947463] [FACT gem_mmap_gtt (basic-write-read)] new: kernel.kmod_is_loaded.i915: true
[550.951845] [132/133] (471s left) perf (gen12-group-exclusive-stream-sample-oa)
[551.093587] Starting subtest: gen12-group-exclusive-stream-sample-oa
[551.113277] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.020s)
[551.155865] [133/133] (471s left) perf_pmu (busy-double-start)
[551.195879] Starting subtest: busy-double-start
[551.198222] Starting dynamic subtest: rcs0
[554.843109] Dynamic subtest rcs0: FAIL (3.596s)
[554.853020] Starting dynamic subtest: bcs0
[558.369151] Dynamic subtest bcs0: SUCCESS (3.577s)
[558.378646] Starting dynamic subtest: vcs0
[562.583013] Dynamic subtest vcs0: SUCCESS (4.212s)
[562.592647] Starting dynamic subtest: vcs1
[566.591746] Dynamic subtest vcs1: SUCCESS (4.008s)
[566.602719] Starting dynamic subtest: vecs0
[570.603006] Dynamic subtest vecs0: SUCCESS (4.009s)
[570.614823] Starting dynamic subtest: ccs0
[574.238917] Dynamic subtest ccs0: FAIL (3.567s)
[574.241112] Subtest busy-double-start: FAIL (22.980s)
[574.323399] Closing watchdogs
results: parsing output: 0/ for test: gem_partial_pwrite_pread
results: parsing output: 1/ for test: kms_content_protection
results: parsing output: 2/ for test: kms_rotation_crc
results: parsing output: 3/ for test: kms_chamelium_color
results: parsing output: 4/ for test: syncobj_wait
results: parsing output: 5/ for test: kms_pipe_crc_basic
results: parsing output: 6/ for test: gem_set_tiling_vs_blt
results: parsing output: 7/ for test: syncobj_wait
results: parsing output: 8/ for test: syncobj_wait
results: parsing output: 9/ for test: gem_pxp
results: parsing output: 10/ for test: kms_cursor_legacy
results: parsing output: 11/ for test: kms_rotation_crc
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: gem_softpin
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_ctx_param
results: parsing output: 17/ for test: syncobj_wait
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: gem_mmap_gtt
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: kms_plane_cursor
results: parsing output: 24/ for test: kms_cdclk
results: parsing output: 25/ for test: gem_exec_balancer
results: parsing output: 26/ for test: kms_cursor_legacy
results: parsing output: 27/ for test: kms_flip_scaled_crc
results: parsing output: 28/ for test: kms_flip_scaled_crc
results: parsing output: 29/ for test: core_getstats
results: parsing output: 30/ for test: kms_rmfb
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: kms_properties
results: parsing output: 33/ for test: kms_invalid_mode
results: parsing output: 34/ for test: kms_plane_scaling
results: parsing output: 35/ for test: kms_pm_rpm
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_dirtyfb
results: parsing output: 38/ for test: kms_cursor_legacy
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: kms_prime
results: parsing output: 41/ for test: kms_pipe_b_c_ivb
results: parsing output: 42/ for test: i915_drm_fdinfo
results: parsing output: 43/ for test: gem_userptr_blits
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: kms_scaling_modes
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: gem_ringfill
results: parsing output: 49/ for test: gem_exec_whisper
results: parsing output: 50/ for test: api_intel_bb
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: gen9_exec_parse
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: gem_exec_fence
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_ctx_bad_destroy
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: kms_chamelium_hpd
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_cs_tlb
results: parsing output: 64/ for test: gem_mmap_gtt
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: gem_bad_reloc
results: parsing output: 69/ for test: gem_ctx_persistence
results: parsing output: 70/ for test: kms_plane_scaling
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_exec_schedule
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: gem_exec_basic
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_mmap
results: parsing output: 79/ for test: gem_exec_reloc
results: parsing output: 80/ for test: gem_ctx_shared
results: parsing output: 81/ for test: gem_exec_reloc
results: parsing output: 82/ for test: gem_eio
results: parsing output: 83/ for test: gem_ctx_persistence
results: parsing output: 84/ for test: perf_pmu
results: parsing output: 85/ for test: gem_exec_schedule
results: parsing output: 86/ for test: i915_hangman
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: kms_color
results: parsing output: 89/ for test: prime_vgem
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: api_intel_allocator
results: parsing output: 92/ for test: i915_pm_rps
results: parsing output: 93/ for test: kms_vblank
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_addfb_basic
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: kms_flip
results: parsing output: 98/ for test: kms_cursor_crc
results: parsing output: 99/ for test: kms_flip
results: parsing output: 100/ for test: kms_atomic_interruptible
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_plane_scaling
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: sw_sync
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: kms_addfb_basic
results: parsing output: 109/ for test: kms_cursor_crc
results: parsing output: 110/ for test: gem_exec_whisper
results: parsing output: 111/ for test: kms_dsc
results: parsing output: 112/ for test: kms_flip_scaled_crc
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_softpin
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_addfb_basic
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gem_mmap_wc
results: parsing output: 121/ for test: kms_hdr
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_psr2_sf
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: gem_exec_parallel
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: i915_selftest
results: parsing output: 130/ for test: gem_mmap_gtt
results: parsing output: 131/ for test: perf
results: parsing output: 132/ for test: perf_pmu
Done.