[57.534428] Initializing watchdogs
[57.534476]   /dev/watchdog0
[57.549205] [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]
[57.553629] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.555850] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.559308] [001/133] (960s left) gem_partial_pwrite_pread (write-snoop)
[57.649128] Subtest write-snoop: SKIP (0.000s)
[57.738229] [002/133] (960s left) kms_content_protection (content-type-change)
[57.899333] Starting subtest: content-type-change
[57.903983] Subtest content-type-change: SKIP (0.000s)
[58.061383] [003/133] (960s left) kms_rotation_crc (multiplane-rotation)
[58.143224] Starting subtest: multiplane-rotation
[75.586601] Subtest multiplane-rotation: SUCCESS (17.381s)
[75.736255] [004/133] (942s left) kms_chamelium_color (ctm-red-to-blue)
[75.835209] Subtest ctm-red-to-blue: SKIP (0.000s)
[75.878921] [005/133] (942s left) syncobj_wait (invalid-reset-one-illegal-handle)
[75.927411] Starting subtest: invalid-reset-one-illegal-handle
[75.929461] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[76.045529] [006/133] (942s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[76.134077] Starting subtest: disable-crc-after-crtc
[76.135962] Starting dynamic subtest: pipe-A-eDP-1
[77.768721] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.630s)
[77.778178] Starting dynamic subtest: pipe-B-eDP-1
[80.146257] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.374s)
[80.155576] Starting dynamic subtest: pipe-C-eDP-1
[82.408294] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.260s)
[82.416910] Starting dynamic subtest: pipe-D-eDP-1
[84.653523] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.241s)
[84.655799] Subtest disable-crc-after-crtc: SUCCESS (8.510s)
[85.509458] [007/133] (932s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[85.587527] Subtest tiled-to-tiled: SKIP (0.000s)
[85.668679] [008/133] (932s left) syncobj_wait (wait-all-interrupted)
[85.729303] Starting subtest: wait-all-interrupted
[85.831300] Subtest wait-all-interrupted: SUCCESS (0.102s)
[85.928233] [009/133] (932s left) syncobj_wait (wait-all-complex)
[85.984381] Starting subtest: wait-all-complex
[86.197661] Subtest wait-all-complex: SUCCESS (0.212s)
[86.295262] [010/133] (932s left) gem_pxp (reject-modify-context-protection-on)
[86.418943] Starting subtest: reject-modify-context-protection-on
[86.421688] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[86.563087] [011/133] (931s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[86.680826] Starting subtest: cursorA-vs-flipB-varying-size
[86.686062] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[86.861030] [012/133] (931s left) kms_rotation_crc (primary-rotation-90)
[86.961034] Starting subtest: primary-rotation-90
[86.965278] Subtest primary-rotation-90: SKIP (0.001s)
[87.055814] [013/133] (931s left) syncobj_wait (reset-multiple-signaled)
[87.113689] Starting subtest: reset-multiple-signaled
[87.116023] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[87.252266] [014/133] (931s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[87.354248] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[87.358096] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[88.541095] [015/133] (930s left) gem_softpin (noreloc-s3)
[88.606776] Starting subtest: noreloc-S3
[108.161412] Subtest noreloc-S3: SUCCESS (5.396s)
[108.328805] [016/133] (910s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[108.451255] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[113.087616] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.543s)
[114.305197] [017/133] (904s left) gem_ctx_param (invalid-ctx-set)
[114.375221] Starting subtest: invalid-ctx-set
[114.377574] Subtest invalid-ctx-set: SUCCESS (0.001s)
[114.517563] [018/133] (904s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[114.582820] Starting subtest: single-wait-all-for-submit-unsubmitted
[114.690068] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[114.787355] [019/133] (903s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[114.884872] Starting subtest: x-tiled-64bpp-rotate-90
[114.904989] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[115.056158] [020/133] (903s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[115.122358] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[115.188113] [021/133] (903s left) kms_psr (fbc-psr-cursor-plane-move)
[115.284692] Starting subtest: fbc-psr-cursor-plane-move
[115.286999] Starting dynamic subtest: eDP-1
[115.291183] Dynamic subtest eDP-1: SKIP (0.000s)
[115.295408] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[115.387315] [022/133] (903s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[115.490200] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[116.523400] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.022s)
[116.685702] [023/133] (902s left) kms_flip (2x-flip-vs-rmfb)
[116.789678] Starting subtest: 2x-flip-vs-rmfb
[116.809330] Subtest 2x-flip-vs-rmfb: SKIP (0.020s)
[116.914479] [024/133] (902s left) kms_plane_cursor (viewport)
[117.014262] Starting subtest: viewport
[117.018172] Starting dynamic subtest: pipe-A-eDP-1-size-64
[119.600566] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.565s)
[119.659342] Starting dynamic subtest: pipe-A-eDP-1-size-128
[122.216959] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.549s)
[122.281128] Starting dynamic subtest: pipe-A-eDP-1-size-256
[124.861467] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.581s)
[125.218212] Starting dynamic subtest: pipe-B-eDP-1-size-64
[128.566344] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.350s)
[128.625643] Starting dynamic subtest: pipe-B-eDP-1-size-128
[131.162562] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.538s)
[131.221751] Starting dynamic subtest: pipe-B-eDP-1-size-256
[133.798929] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.582s)
[134.147269] Starting dynamic subtest: pipe-C-eDP-1-size-64
[136.955100] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.815s)
[136.994611] Starting dynamic subtest: pipe-C-eDP-1-size-128
[139.167846] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.180s)
[139.205072] Starting dynamic subtest: pipe-C-eDP-1-size-256
[141.390562] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.191s)
[141.715087] Starting dynamic subtest: pipe-D-eDP-1-size-64
[144.636873] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.930s)
[144.674573] Starting dynamic subtest: pipe-D-eDP-1-size-128
[146.871829] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.202s)
[146.910095] Starting dynamic subtest: pipe-D-eDP-1-size-256
[149.095104] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.191s)
[149.426824] Subtest viewport: SUCCESS (32.336s)
[150.339100] [025/133] (868s left) kms_cdclk (mode-transition)
[150.444391] Starting subtest: mode-transition
[150.446742] Starting dynamic subtest: pipe-A-eDP-1
[150.742843] Dynamic subtest pipe-A-eDP-1: SKIP (0.297s)
[150.751588] Starting dynamic subtest: pipe-B-eDP-1
[150.756210] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[150.764434] Starting dynamic subtest: pipe-C-eDP-1
[150.769095] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[150.777692] Starting dynamic subtest: pipe-D-eDP-1
[150.782261] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[150.786794] Subtest mode-transition: SKIP (0.305s)
[151.548750] [026/133] (867s left) gem_exec_balancer (fairslice)
[151.616027] Starting subtest: fairslice
[154.506129] Subtest fairslice: SUCCESS (2.889s)
[155.024972] [027/133] (864s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[155.160876] Starting subtest: basic-flip-before-cursor-varying-size
[156.095177] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.933s)
[156.982282] [028/133] (862s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[157.087320] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[157.089578] Starting dynamic subtest: pipe-A-default-mode
[157.376274] Dynamic subtest pipe-A-default-mode: SKIP (0.288s)
[157.380660] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.290s)
[158.221934] [029/133] (860s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[158.327698] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[158.329915] Starting dynamic subtest: pipe-A-default-mode
[161.067748] Dynamic subtest pipe-A-default-mode: SUCCESS (2.738s)
[161.070137] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.740s)
[161.924342] [030/133] (857s left) core_getstats (basic)
[161.989554] Starting subtest: basic
[161.991846] Subtest basic: SUCCESS (0.000s)
[162.130472] [031/133] (857s left) kms_rmfb (close-fd)
[162.225819] Starting subtest: close-fd
[162.228139] Starting dynamic subtest: pipe-A-eDP-1
[162.336047] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.108s)
[162.345708] Starting dynamic subtest: pipe-B-eDP-1
[163.557314] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.219s)
[163.565708] Starting dynamic subtest: pipe-C-eDP-1
[164.766332] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.207s)
[164.776634] Starting dynamic subtest: pipe-D-eDP-1
[165.908146] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.142s)
[165.910369] Subtest close-fd: SUCCESS (3.682s)
[167.142007] [032/133] (852s left) gem_exec_reloc (basic-gtt-wc)
[167.205639] Subtest basic-gtt-wc: SKIP (0.000s)
[167.271286] [033/133] (852s left) kms_properties (crtc-properties-legacy)
[167.352673] Starting subtest: crtc-properties-legacy
[167.354985] Starting dynamic subtest: pipe-A-eDP-1
[167.787970] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.433s)
[167.797090] Starting dynamic subtest: pipe-B-eDP-1
[168.989633] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.199s)
[168.998602] Starting dynamic subtest: pipe-C-eDP-1
[170.109577] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.119s)
[170.119287] Starting dynamic subtest: pipe-D-eDP-1
[171.242799] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.132s)
[171.245184] Subtest crtc-properties-legacy: SUCCESS (3.889s)
[172.073015] [034/133] (847s left) kms_invalid_mode (zero-hdisplay)
[172.171746] Starting subtest: zero-hdisplay
[172.173860] Starting dynamic subtest: pipe-A-eDP-1
[172.473436] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.300s)
[172.482253] Starting dynamic subtest: pipe-B-eDP-1
[172.484127] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[172.491689] Starting dynamic subtest: pipe-C-eDP-1
[172.493832] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[172.502133] Starting dynamic subtest: pipe-D-eDP-1
[172.504290] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[172.506388] Subtest zero-hdisplay: SUCCESS (0.306s)
[173.310953] [035/133] (846s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[173.419244] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[173.421551] Starting dynamic subtest: pipe-A
[174.482640] Dynamic subtest pipe-A: SUCCESS (1.066s)
[174.492573] Starting dynamic subtest: pipe-B
[176.597569] Dynamic subtest pipe-B: SUCCESS (2.113s)
[176.610055] Starting dynamic subtest: pipe-C
[177.777671] Dynamic subtest pipe-C: SUCCESS (1.177s)
[177.786960] Starting dynamic subtest: pipe-D
[178.924868] Dynamic subtest pipe-D: SUCCESS (1.146s)
[178.927089] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.506s)
[180.130771] [036/133] (839s left) kms_pm_rpm (legacy-planes-dpms)
[182.057976] Starting subtest: legacy-planes-dpms
[182.060835] Starting dynamic subtest: plane-63
[190.671031] Dynamic subtest plane-63: SUCCESS (8.607s)
[190.682772] Starting dynamic subtest: plane-93
[199.281296] Dynamic subtest plane-93: SUCCESS (8.604s)
[199.292827] Starting dynamic subtest: plane-123
[207.577050] Dynamic subtest plane-123: SUCCESS (8.297s)
[207.588498] Starting dynamic subtest: plane-133
[216.178833] Dynamic subtest plane-133: SUCCESS (8.602s)
[216.181560] Subtest legacy-planes-dpms: SUCCESS (34.120s)
[216.570873] [037/133] (802s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[216.672373] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[216.676443] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[216.809581] [038/133] (802s left) kms_dirtyfb (default-dirtyfb-ioctl)
[216.912728] Starting subtest: default-dirtyfb-ioctl
[216.915032] Starting dynamic subtest: A-eDP-1
[218.555136] Dynamic subtest A-eDP-1: SUCCESS (1.643s)
[218.557423] Subtest default-dirtyfb-ioctl: SUCCESS (1.644s)
[219.400816] [039/133] (800s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[219.539466] Starting subtest: cursorB-vs-flipA-legacy
[219.544097] Subtest cursorB-vs-flipA-legacy: SKIP (0.002s)
[219.718457] [040/133] (799s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[219.787137] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[219.789454] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.001s)
[219.937437] [041/133] (799s left) kms_prime (basic-crc-vgem)
[220.075847] Starting subtest: basic-crc-vgem
[220.078103] Starting dynamic subtest: second-to-first
[221.044602] Dynamic subtest second-to-first: SUCCESS (0.971s)
[221.046545] Subtest basic-crc-vgem: SUCCESS (0.972s)
[221.148309] [FACT kms_prime (basic-crc-vgem)] new: kernel.kmod_is_loaded.vgem: true
[221.151162] [042/133] (798s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[221.249695] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[221.318721] [043/133] (798s left) i915_drm_fdinfo (busy)
[221.356525] Starting subtest: busy
[221.358049] Starting dynamic subtest: rcs0
[221.401884] Dynamic subtest rcs0: SKIP (0.044s)
[221.413156] Starting dynamic subtest: bcs0
[221.416792] Dynamic subtest bcs0: SKIP (0.001s)
[221.425243] Starting dynamic subtest: vcs0
[221.429056] Dynamic subtest vcs0: SKIP (0.000s)
[221.439365] Starting dynamic subtest: vcs1
[221.442728] Dynamic subtest vcs1: SKIP (0.000s)
[221.450329] Starting dynamic subtest: vecs0
[221.453642] Dynamic subtest vecs0: SKIP (0.000s)
[221.461461] Starting dynamic subtest: ccs0
[221.464834] Dynamic subtest ccs0: SKIP (0.000s)
[221.468293] Subtest busy: SKIP (0.051s)
[221.502275] [044/133] (798s left) gem_userptr_blits (nohangcheck)
[221.580716] Starting subtest: nohangcheck
[221.840373] Subtest nohangcheck: SUCCESS (0.256s)
[222.000862] [045/133] (797s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[222.104496] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[222.706106] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.603s)
[222.926675] [046/133] (796s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[223.026325] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[223.030926] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[224.144440] [047/133] (795s left) kms_scaling_modes (scaling-mode-full)
[224.245786] Starting subtest: scaling-mode-full
[224.247691] Starting dynamic subtest: pipe-A-eDP-1
[224.338640] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.095s)
[224.348257] Starting dynamic subtest: pipe-B-eDP-1
[225.547930] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.207s)
[225.557432] Starting dynamic subtest: pipe-C-eDP-1
[226.764594] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.215s)
[226.774797] Starting dynamic subtest: pipe-D-eDP-1
[227.905797] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.140s)
[227.907932] Subtest scaling-mode-full: SUCCESS (3.664s)
[229.104747] [048/133] (790s left) kms_psr (fbc-pr-basic)
[229.204606] Starting subtest: fbc-pr-basic
[229.209138] Subtest fbc-pr-basic: SKIP (0.000s)
[229.301121] [049/133] (790s left) gem_ringfill (basic-all)
[234.911458] Starting subtest: basic-all
[236.083422] Subtest basic-all: SUCCESS (1.171s)
[236.254244] [050/133] (783s left) gem_exec_whisper (basic-fds-forked-all)
[236.319152] Starting subtest: basic-fds-forked-all
[257.976960] Subtest basic-fds-forked-all: SUCCESS (21.652s)
[258.189865] [051/133] (761s left) api_intel_bb (full-batch)
[258.249211] Starting subtest: full-batch
[258.256608] Subtest full-batch: SUCCESS (0.010s)
[258.415099] [052/133] (761s left) kms_cursor_crc (cursor-sliding-256x85)
[258.675342] Starting subtest: cursor-sliding-256x85
[258.723060] Subtest cursor-sliding-256x85: SKIP (0.044s)
[258.914646] [053/133] (761s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[258.999639] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[259.001906] Starting dynamic subtest: pipe-A-eDP-1
[259.060226] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[259.071251] Starting dynamic subtest: pipe-B-eDP-1
[259.125777] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[259.135601] Starting dynamic subtest: pipe-C-eDP-1
[259.187021] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[259.197579] Starting dynamic subtest: pipe-D-eDP-1
[259.244716] Dynamic subtest pipe-D-eDP-1: SKIP (0.002s)
[259.249021] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.009s)
[261.287454] [054/133] (758s left) gen9_exec_parse (allowed-single)
[261.358838] Subtest allowed-single: SKIP (0.000s)
[261.457125] [055/133] (758s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[261.558613] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[268.760785] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.201s)
[268.896640] [056/133] (751s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[269.000581] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[269.005176] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[269.126602] [057/133] (751s left) gem_exec_fence (expired-history)
[269.651194] Starting subtest: expired-history
[276.655390] Subtest expired-history: SUCCESS (7.004s)
[277.342318] [058/133] (743s left) kms_psr (fbc-psr-sprite-plane-move)
[277.440453] Starting subtest: fbc-psr-sprite-plane-move
[277.442817] Starting dynamic subtest: eDP-1
[277.447209] Dynamic subtest eDP-1: SKIP (0.000s)
[277.451609] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[277.544631] [059/133] (742s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[277.668175] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[284.473932] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.807s)
[284.640356] [060/133] (735s left) gem_ctx_bad_destroy (double-destroy)
[284.700753] Starting subtest: double-destroy
[284.702989] Subtest double-destroy: SUCCESS (0.000s)
[284.799721] [061/133] (735s left) syncobj_timeline (invalid-signal-illegal-handle)
[284.851466] Starting subtest: invalid-signal-illegal-handle
[284.853829] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[284.990452] [062/133] (735s left) kms_chamelium_hpd (common-hpd-after-suspend)
[285.375361] Subtest common-hpd-after-suspend: SKIP (0.000s)
[286.209545] [063/133] (734s left) kms_frontbuffer_tracking (fbc-tiling-4)
[286.314285] Starting subtest: fbc-tiling-4
[290.565378] Subtest fbc-tiling-4: SUCCESS (4.252s)
[291.734360] [064/133] (728s left) gem_cs_tlb (engines)
[291.803829] Starting subtest: engines
[291.805818] Starting dynamic subtest: rcs0
[293.957998] Dynamic subtest rcs0: SUCCESS (2.151s)
[293.970250] Starting dynamic subtest: bcs0
[296.111178] Dynamic subtest bcs0: SUCCESS (2.151s)
[296.120963] Starting dynamic subtest: vcs0
[298.265120] Dynamic subtest vcs0: SUCCESS (2.152s)
[298.273892] Starting dynamic subtest: vcs1
[300.420070] Dynamic subtest vcs1: SUCCESS (2.153s)
[300.428870] Starting dynamic subtest: vecs0
[302.577273] Dynamic subtest vecs0: SUCCESS (2.155s)
[302.589002] Starting dynamic subtest: ccs0
[304.730894] Dynamic subtest ccs0: SUCCESS (2.152s)
[304.733194] Subtest engines: SUCCESS (12.921s)
[304.887846] [065/133] (715s left) gem_mmap_gtt (hang-busy)
[304.944861] Subtest hang-busy: SKIP (0.000s)
[305.015700] [066/133] (715s left) kms_psr (psr2-sprite-plane-onoff)
[305.112501] Starting subtest: psr2-sprite-plane-onoff
[305.114825] Starting dynamic subtest: eDP-1
[306.832154] Dynamic subtest eDP-1: SUCCESS (1.717s)
[306.834611] Subtest psr2-sprite-plane-onoff: SUCCESS (1.718s)
[307.684447] [067/133] (713s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[307.791921] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[308.416508] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.626s)
[308.626947] [068/133] (712s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[308.734365] Starting subtest: y-tiled-64bpp-rotate-270
[308.738840] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[308.869161] [069/133] (712s left) gem_bad_reloc (negative-reloc-lut)
[308.931165] Subtest negative-reloc-lut: SKIP (0.000s)
[309.023865] [070/133] (711s left) gem_ctx_persistence (engines-mixed)
[309.093138] Starting subtest: engines-mixed
[309.095352] Starting dynamic subtest: rcs0
[309.217533] Dynamic subtest rcs0: SUCCESS (0.124s)
[309.229885] Starting dynamic subtest: bcs0
[309.302317] Dynamic subtest bcs0: SUCCESS (0.082s)
[309.314469] Starting dynamic subtest: vcs0
[309.368173] Dynamic subtest vcs0: SUCCESS (0.064s)
[309.379807] Starting dynamic subtest: vcs1
[309.439077] Dynamic subtest vcs1: SUCCESS (0.068s)
[309.450026] Starting dynamic subtest: vecs0
[309.501054] Dynamic subtest vecs0: SUCCESS (0.060s)
[309.512297] Starting dynamic subtest: ccs0
[309.573176] Dynamic subtest ccs0: SUCCESS (0.070s)
[309.575881] Subtest engines-mixed: SUCCESS (0.481s)
[309.675539] [071/133] (711s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[309.770628] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[309.772569] Starting dynamic subtest: pipe-A
[309.836280] Dynamic subtest pipe-A: SUCCESS (0.067s)
[309.846343] Starting dynamic subtest: pipe-B
[310.992333] Dynamic subtest pipe-B: SUCCESS (1.154s)
[311.003634] Starting dynamic subtest: pipe-C
[312.091229] Dynamic subtest pipe-C: SUCCESS (1.097s)
[312.106009] Starting dynamic subtest: pipe-D
[313.223758] Dynamic subtest pipe-D: SUCCESS (1.130s)
[313.226079] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.455s)
[314.409678] [072/133] (706s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[314.509277] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[314.513584] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[314.645258] [073/133] (706s left) gem_exec_schedule (semaphore-noskip)
[314.721401] Starting subtest: semaphore-noskip
[315.122190] Subtest semaphore-noskip: SUCCESS (0.409s)
[315.502836] [074/133] (705s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[315.606788] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[315.610779] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[315.729854] [075/133] (705s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[315.821756] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[315.826130] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[315.942097] [076/133] (705s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[316.038422] Starting subtest: 4-tiled-16bpp-rotate-0
[317.341920] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.303s)
[317.486053] [077/133] (703s left) gem_exec_basic (basic)
[317.562285] Starting subtest: basic
[317.564297] Starting dynamic subtest: rcs0-smem
[317.566361] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[317.576320] Starting dynamic subtest: bcs0-smem
[317.577989] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[317.586301] Starting dynamic subtest: vcs0-smem
[317.587999] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[317.596325] Starting dynamic subtest: vcs1-smem
[317.598020] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[317.606182] Starting dynamic subtest: vecs0-smem
[317.607824] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[317.616202] Starting dynamic subtest: ccs0-smem
[317.617832] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[317.619439] Subtest basic: SUCCESS (0.014s)
[319.005398] [078/133] (702s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[319.114300] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[319.118721] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[319.261648] [079/133] (702s left) gem_mmap (short-mmap)
[319.335549] Subtest short-mmap: SKIP (0.000s)
[319.398937] [080/133] (701s left) gem_exec_reloc (basic-gtt-wc-active)
[319.459030] Subtest basic-gtt-wc-active: SKIP (0.000s)
[319.542496] [081/133] (701s left) gem_ctx_shared (create-shared-gtt)
[319.600119] Starting subtest: create-shared-gtt
[321.754401] Subtest create-shared-gtt: SUCCESS (2.153s)
[322.159176] [082/133] (699s left) gem_exec_reloc (basic-write-wc)
[322.224092] Subtest basic-write-wc: SKIP (0.000s)
[322.304232] [083/133] (699s left) gem_eio (wait-immediate)
[322.549717] Starting subtest: wait-immediate
[322.943697] Subtest wait-immediate: SUCCESS (0.394s)
[323.145380] [084/133] (698s left) gem_ctx_persistence (legacy-engines-mixed)
[323.212573] Starting subtest: legacy-engines-mixed
[323.214441] Starting dynamic subtest: render
[323.305608] Dynamic subtest render: SUCCESS (0.093s)
[323.319442] Starting dynamic subtest: bsd1
[323.358015] Dynamic subtest bsd1: SUCCESS (0.049s)
[323.369247] Starting dynamic subtest: bsd2
[323.431794] Dynamic subtest bsd2: SUCCESS (0.071s)
[323.445737] Starting dynamic subtest: blt
[323.505025] Dynamic subtest blt: SUCCESS (0.070s)
[323.519411] Starting dynamic subtest: vebox
[323.577809] Dynamic subtest vebox: SUCCESS (0.070s)
[323.579825] Subtest legacy-engines-mixed: SUCCESS (0.366s)
[323.682411] [085/133] (697s left) perf_pmu (semaphore-busy)
[323.728097] Starting subtest: semaphore-busy
[323.729746] Starting dynamic subtest: rcs0
[325.358671] Dynamic subtest rcs0: SUCCESS (1.628s)
[325.369420] Starting dynamic subtest: bcs0
[326.991741] Dynamic subtest bcs0: SUCCESS (1.629s)
[327.004102] Starting dynamic subtest: vcs0
[331.416326] Dynamic subtest vcs0: SUCCESS (4.423s)
[331.428610] Starting dynamic subtest: vcs1
[337.431981] Dynamic subtest vcs1: SUCCESS (6.015s)
[337.443437] Starting dynamic subtest: vecs0
[343.450103] Dynamic subtest vecs0: SUCCESS (6.017s)
[343.462157] Starting dynamic subtest: ccs0
[346.521110] Dynamic subtest ccs0: SUCCESS (3.068s)
[346.524103] Subtest semaphore-busy: SUCCESS (22.798s)
[346.661306] [086/133] (674s left) gem_exec_schedule (pi-common)
[346.844492] Starting subtest: pi-common
[346.846769] Starting dynamic subtest: rcs0
[346.884498] Dynamic subtest rcs0: SUCCESS (0.042s)
[346.895551] Starting dynamic subtest: bcs0
[346.926686] Dynamic subtest bcs0: SUCCESS (0.041s)
[346.944408] Starting dynamic subtest: vcs0
[346.970162] Dynamic subtest vcs0: SUCCESS (0.043s)
[346.980508] Starting dynamic subtest: vcs1
[347.012221] Dynamic subtest vcs1: SUCCESS (0.040s)
[347.022451] Starting dynamic subtest: vecs0
[347.044422] Dynamic subtest vecs0: SUCCESS (0.031s)
[347.054594] Starting dynamic subtest: ccs0
[347.077763] Dynamic subtest ccs0: SUCCESS (0.032s)
[347.079965] Subtest pi-common: SUCCESS (0.236s)
[347.338392] [087/133] (674s left) i915_hangman (engine-error-state-capture)
[347.416507] Starting subtest: engine-error-state-capture
[347.418464] Starting dynamic subtest: rcs0
[350.906794] Dynamic subtest rcs0: SUCCESS (3.490s)
[350.920141] Starting dynamic subtest: bcs0
[356.924029] Dynamic subtest bcs0: SUCCESS (6.015s)
[356.937089] Starting dynamic subtest: vcs0
[362.875619] Dynamic subtest vcs0: SUCCESS (5.950s)
[362.888426] Starting dynamic subtest: vcs1
[368.891732] Dynamic subtest vcs1: SUCCESS (6.013s)
[368.904647] Starting dynamic subtest: vecs0
[374.843838] Dynamic subtest vecs0: SUCCESS (5.950s)
[374.856361] Starting dynamic subtest: ccs0
[379.898621] Dynamic subtest ccs0: SUCCESS (5.052s)
[379.901542] Subtest engine-error-state-capture: SUCCESS (32.487s)
[380.010232] [088/133] (641s left) syncobj_timeline (wait-for-submit-snapshot)
[380.077088] Starting subtest: wait-for-submit-snapshot
[380.158568] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[380.266668] [089/133] (641s left) kms_color (ctm-blue-to-red)
[380.366489] Starting subtest: ctm-blue-to-red
[380.368731] Starting dynamic subtest: pipe-A-eDP-1
[381.061997] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.695s)
[381.072734] Starting dynamic subtest: pipe-B-eDP-1
[382.468602] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.407s)
[382.479253] Starting dynamic subtest: pipe-C-eDP-1
[383.856359] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.384s)
[383.866498] Starting dynamic subtest: pipe-D-eDP-1
[385.189502] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.334s)
[385.192287] Subtest ctm-blue-to-red: SUCCESS (4.824s)
[386.019164] [090/133] (635s left) prime_vgem (basic-gtt)
[386.111198] Starting subtest: basic-gtt
[386.115856] Subtest basic-gtt: SKIP (0.000s)
[386.252118] [091/133] (635s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[386.353772] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[393.823942] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.471s)
[393.960875] [092/133] (627s left) api_intel_allocator (default-alignment)
[394.025081] Starting subtest: default-alignment
[394.027420] Subtest default-alignment: SUCCESS (0.004s)
[394.195459] [093/133] (627s left) i915_pm_rps (fence-order)
[394.258856] Starting subtest: fence-order
[397.114002] Subtest fence-order: SUCCESS (2.853s)
[397.278936] [094/133] (624s left) kms_vblank (query-busy)
[397.384431] Starting subtest: query-busy
[397.386356] Starting dynamic subtest: pipe-A-eDP-1
[399.261233] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.875s)
[399.276780] Starting dynamic subtest: pipe-D-eDP-1
[401.778147] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.516s)
[401.780745] Subtest query-busy: SUCCESS (4.396s)
[402.613139] [095/133] (619s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[402.721101] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[402.725588] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[402.858823] [096/133] (619s left) kms_addfb_basic (invalid-get-prop-any)
[402.916643] Starting subtest: invalid-get-prop-any
[402.918555] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[403.089895] [097/133] (618s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[403.193696] Starting subtest: fbc-psr2-cursor-mmap-gtt
[403.195992] Starting dynamic subtest: eDP-1
[403.200391] Dynamic subtest eDP-1: SKIP (0.000s)
[403.204784] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[403.292044] [098/133] (618s left) kms_flip (2x-blocking-absolute-wf_vblank)
[403.396846] Starting subtest: 2x-blocking-absolute-wf_vblank
[403.408256] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s)
[403.513753] [099/133] (618s left) kms_cursor_crc (cursor-onscreen-256x85)
[403.771842] Starting subtest: cursor-onscreen-256x85
[403.818665] Subtest cursor-onscreen-256x85: SKIP (0.043s)
[404.052054] [100/133] (618s left) kms_flip (2x-modeset-vs-vblank-race)
[404.149288] Starting subtest: 2x-modeset-vs-vblank-race
[404.159194] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[404.355638] [101/133] (617s left) kms_atomic_interruptible (atomic-setmode)
[404.451014] Starting subtest: atomic-setmode
[404.452955] Starting dynamic subtest: pipe-A-eDP-1
[411.372925] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.919s)
[411.375255] Subtest atomic-setmode: SUCCESS (6.921s)
[412.260011] [102/133] (610s left) kms_frontbuffer_tracking (psr-argb161616f-draw-render)
[412.368441] Starting subtest: psr-argb161616f-draw-render
[412.372998] Subtest psr-argb161616f-draw-render: SKIP (0.000s)
[412.505708] [103/133] (609s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[412.600019] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[412.604129] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[412.727354] [104/133] (609s left) kms_plane_scaling (invalid-num-scalers)
[412.830752] Starting subtest: invalid-num-scalers
[412.833063] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[412.849300] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.019s)
[412.859708] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[412.884550] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.033s)
[412.894652] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[412.918979] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.033s)
[412.928999] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[412.952676] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.033s)
[412.954949] Subtest invalid-num-scalers: SUCCESS (0.124s)
[413.091276] [105/133] (609s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[413.191955] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[413.195477] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[413.337203] [106/133] (609s left) sw_sync (alloc_fence_invalid_timeline)
[413.376324] Starting subtest: alloc_fence_invalid_timeline
[413.378546] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[413.457342] [107/133] (609s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[413.521618] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[413.623131] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.102s)
[413.722660] [108/133] (608s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[413.829612] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[413.834168] Starting dynamic subtest: A-eDP1
[422.786144] Dynamic subtest A-eDP1: SUCCESS (8.953s)
[422.799958] Starting dynamic subtest: B-eDP1
[431.713379] Dynamic subtest B-eDP1: SUCCESS (8.923s)
[431.724966] Starting dynamic subtest: C-eDP1
[440.629412] Dynamic subtest C-eDP1: SUCCESS (8.913s)
[440.643012] Starting dynamic subtest: D-eDP1
[449.558028] Dynamic subtest D-eDP1: SUCCESS (8.924s)
[449.560763] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.725s)
[450.808132] [109/133] (571s left) kms_addfb_basic (size-max)
[450.907661] Starting subtest: size-max
[450.909592] Subtest size-max: SUCCESS (0.000s)
[451.023557] [110/133] (571s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[451.264278] Starting subtest: cursor-rapid-movement-256x256
[451.269434] Starting dynamic subtest: pipe-A-eDP-1
[451.835115] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s)
[451.866910] Starting dynamic subtest: pipe-D-eDP-1
[453.079577] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.220s)
[453.081818] Subtest cursor-rapid-movement-256x256: SUCCESS (1.812s)
[453.960538] [111/133] (568s left) gem_exec_whisper (basic-queues-all)
[454.033505] Starting subtest: basic-queues-all
[462.563851] Subtest basic-queues-all: SUCCESS (8.528s)
[462.778631] [112/133] (559s left) kms_dsc (dsc-fractional-bpp)
[462.874001] Starting subtest: dsc-fractional-bpp
[462.887371] Subtest dsc-fractional-bpp: SKIP (0.001s)
[462.978006] [113/133] (559s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[463.086620] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[463.088787] Starting dynamic subtest: pipe-A-default-mode
[463.376753] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[463.381318] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.288s)
[464.179647] [114/133] (558s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[464.297507] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[464.301717] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[464.425980] [115/133] (558s left) gem_softpin (evict-prime)
[464.491889] Starting subtest: evict-prime
[464.494092] Starting dynamic subtest: rcs0
[465.695582] Dynamic subtest rcs0: SUCCESS (1.203s)
[465.708944] Starting dynamic subtest: bcs0
[466.850001] Dynamic subtest bcs0: SUCCESS (1.153s)
[466.863493] Starting dynamic subtest: vcs0
[468.933350] Dynamic subtest vcs0: SUCCESS (2.078s)
[468.946841] Starting dynamic subtest: vcs1
[470.982303] Dynamic subtest vcs1: SUCCESS (2.046s)
[470.995993] Starting dynamic subtest: vecs0
[472.890561] Dynamic subtest vecs0: SUCCESS (1.905s)
[472.903466] Starting dynamic subtest: ccs0
[474.044669] Dynamic subtest ccs0: SUCCESS (1.153s)
[474.057544] Starting dynamic subtest: all
[475.901937] Dynamic subtest all: SUCCESS (1.853s)
[475.904588] Subtest evict-prime: SUCCESS (11.408s)
[476.013973] [116/133] (546s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[476.121027] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[476.125506] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[476.255658] [117/133] (546s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[476.360740] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[476.493455] [118/133] (546s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[476.556528] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[476.665776] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.107s)
[476.769294] [119/133] (546s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[476.879616] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[476.884091] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[476.998994] [120/133] (546s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[477.102171] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[481.194037] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.094s)
[482.385887] [121/133] (540s left) gem_mmap_wc (bad-size)
[482.446701] Subtest bad-size: SKIP (0.000s)
[482.509032] [122/133] (540s left) kms_hdr (static-toggle-suspend)
[482.608848] Starting subtest: static-toggle-suspend
[482.615411] Subtest static-toggle-suspend: SKIP (0.000s)
[482.708945] [123/133] (540s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[482.800116] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[482.804330] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[482.939688] [124/133] (540s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[487.924264] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[487.926694] Starting dynamic subtest: pipe-A-eDP-1
[488.723077] Dynamic subtest pipe-A-eDP-1: SKIP (0.795s)
[488.734578] Starting dynamic subtest: pipe-B-eDP-1
[489.856484] Dynamic subtest pipe-B-eDP-1: SKIP (1.132s)
[489.860825] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.932s)
[491.066009] [125/133] (532s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[491.164213] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[491.168617] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[491.271672] [126/133] (532s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[491.372361] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[491.374621] Starting dynamic subtest: pipe-A-eDP-1
[491.395552] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[491.408223] Starting dynamic subtest: pipe-B-eDP-1
[491.427980] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[491.438157] Starting dynamic subtest: pipe-C-eDP-1
[491.457743] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[491.467589] Starting dynamic subtest: pipe-D-eDP-1
[491.487297] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[491.489556] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[493.627114] [127/133] (529s left) syncobj_timeline (single-wait-all-available-submitted)
[493.683021] Starting subtest: single-wait-all-available-submitted
[493.685245] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[493.818777] [128/133] (529s left) gem_exec_parallel (userptr)
[493.884130] Starting subtest: userptr
[493.886500] Starting dynamic subtest: rcs0
[495.317227] Dynamic subtest rcs0: SUCCESS (1.432s)
[495.330444] Starting dynamic subtest: bcs0
[496.796662] Dynamic subtest bcs0: SUCCESS (1.477s)
[496.811072] Starting dynamic subtest: vcs0
[498.910165] Dynamic subtest vcs0: SUCCESS (2.108s)
[498.923869] Starting dynamic subtest: vcs1
[500.956488] Dynamic subtest vcs1: SUCCESS (2.043s)
[500.968823] Starting dynamic subtest: vecs0
[502.902168] Dynamic subtest vecs0: SUCCESS (1.943s)
[502.913968] Starting dynamic subtest: ccs0
[504.394369] Dynamic subtest ccs0: SUCCESS (1.490s)
[504.396915] Subtest userptr: SUCCESS (10.509s)
[504.606125] [129/133] (518s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[504.716909] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[504.720838] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[504.867962] [130/133] (518s left) i915_selftest (mock)
[508.583294] Starting subtest: mock
[508.585620] Starting dynamic subtest: sanitycheck
[509.358022] Dynamic subtest sanitycheck: SUCCESS (0.774s)
[509.367431] Starting dynamic subtest: shmem
[510.124670] Dynamic subtest shmem: SUCCESS (0.766s)
[510.134673] Starting dynamic subtest: fence
[518.116946] Dynamic subtest fence: SUCCESS (7.987s)
[518.127171] Starting dynamic subtest: scatterlist
[519.886918] Dynamic subtest scatterlist: SUCCESS (1.767s)
[519.897758] Starting dynamic subtest: syncmap
[523.216899] Dynamic subtest syncmap: SUCCESS (3.326s)
[523.228126] Starting dynamic subtest: uncore
[523.967035] Dynamic subtest uncore: SUCCESS (0.748s)
[523.977096] Starting dynamic subtest: ring
[524.747817] Dynamic subtest ring: SUCCESS (0.778s)
[524.757595] Starting dynamic subtest: engine
[525.527477] Dynamic subtest engine: SUCCESS (0.778s)
[525.537816] Starting dynamic subtest: timelines
[529.553160] Dynamic subtest timelines: SUCCESS (4.021s)
[529.563230] Starting dynamic subtest: requests
[533.105856] Dynamic subtest requests: SUCCESS (3.550s)
[533.116198] Starting dynamic subtest: objects
[534.002192] Dynamic subtest objects: SUCCESS (0.895s)
[534.012424] Starting dynamic subtest: phys
[534.883194] Dynamic subtest phys: SUCCESS (0.878s)
[534.893605] Starting dynamic subtest: dmabuf
[535.790189] Dynamic subtest dmabuf: SUCCESS (0.905s)
[535.806218] Starting dynamic subtest: vma
[541.286356] Dynamic subtest vma: SUCCESS (5.492s)
[541.296473] Starting dynamic subtest: evict
[542.822034] Dynamic subtest evict: SUCCESS (1.533s)
[542.832380] Starting dynamic subtest: gtt
[546.136133] Dynamic subtest gtt: SUCCESS (3.311s)
[546.146393] Starting dynamic subtest: hugepages
[547.179754] Dynamic subtest hugepages: SUCCESS (1.041s)
[547.190264] Starting dynamic subtest: memory_region
[549.887880] Dynamic subtest memory_region: SUCCESS (2.705s)
[549.890445] Subtest mock: SUCCESS (41.295s)
[549.929782] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[549.930492] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[549.933879] [131/133] (473s left) gem_mmap_gtt (basic-write-read)
[551.465959] Subtest basic-write-read: SKIP (0.000s)
[551.560737] [FACT gem_mmap_gtt (basic-write-read)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[551.562014] [FACT gem_mmap_gtt (basic-write-read)] new: kernel.kmod_is_loaded.i915: true
[551.565872] [132/133] (472s left) perf (gen12-group-exclusive-stream-sample-oa)
[551.719440] Starting subtest: gen12-group-exclusive-stream-sample-oa
[551.740219] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.021s)
[551.776013] [133/133] (471s left) perf_pmu (busy-double-start)
[551.818234] Starting subtest: busy-double-start
[551.820394] Starting dynamic subtest: rcs0
[555.440509] Dynamic subtest rcs0: SUCCESS (3.623s)
[555.452584] Starting dynamic subtest: bcs0
[559.059458] Dynamic subtest bcs0: SUCCESS (3.615s)
[559.071559] Starting dynamic subtest: vcs0
[563.419336] Dynamic subtest vcs0: SUCCESS (4.356s)
[563.430724] Starting dynamic subtest: vcs1
[567.458279] Dynamic subtest vcs1: SUCCESS (4.036s)
[567.470116] Starting dynamic subtest: vecs0
[571.419404] Dynamic subtest vecs0: SUCCESS (3.958s)
[571.430856] Starting dynamic subtest: ccs0
[575.060489] Dynamic subtest ccs0: FAIL (3.586s)
[575.062700] Subtest busy-double-start: FAIL (23.186s)
[575.165465] 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.