[58.614930] Initializing watchdogs
[58.614981]   /dev/watchdog0
[58.628143] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.632283] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.634487] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.637862] [001/133] (960s left) gem_partial_pwrite_pread (write-snoop)
[58.722811] Subtest write-snoop: SKIP (0.000s)
[58.802228] [002/133] (960s left) kms_content_protection (content-type-change)
[58.949982] Starting subtest: content-type-change
[58.954580] Subtest content-type-change: SKIP (0.000s)
[59.095577] [003/133] (960s left) kms_rotation_crc (multiplane-rotation)
[59.199711] Starting subtest: multiplane-rotation
[76.567978] Subtest multiplane-rotation: SUCCESS (17.381s)
[76.724600] [004/133] (942s left) kms_chamelium_color (ctm-red-to-blue)
[76.830509] Subtest ctm-red-to-blue: SKIP (0.000s)
[76.896257] [005/133] (942s left) syncobj_wait (invalid-reset-one-illegal-handle)
[76.958445] Starting subtest: invalid-reset-one-illegal-handle
[76.960123] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[77.090359] [006/133] (942s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[77.173079] Starting subtest: disable-crc-after-crtc
[77.174947] Starting dynamic subtest: pipe-A-eDP-1
[78.840263] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.666s)
[78.848858] Starting dynamic subtest: pipe-B-eDP-1
[81.133997] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.292s)
[81.141166] Starting dynamic subtest: pipe-C-eDP-1
[83.364221] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.230s)
[83.371421] Starting dynamic subtest: pipe-D-eDP-1
[85.649261] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.281s)
[85.651146] Subtest disable-crc-after-crtc: SUCCESS (8.472s)
[86.480244] [007/133] (932s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[86.550657] Subtest tiled-to-tiled: SKIP (0.000s)
[86.650271] [008/133] (932s left) syncobj_wait (wait-all-interrupted)
[86.707906] Starting subtest: wait-all-interrupted
[86.816716] Subtest wait-all-interrupted: SUCCESS (0.107s)
[86.928810] [009/133] (932s left) syncobj_wait (wait-all-complex)
[86.990831] Starting subtest: wait-all-complex
[87.202817] Subtest wait-all-complex: SUCCESS (0.212s)
[87.299377] [010/133] (932s left) gem_pxp (reject-modify-context-protection-on)
[87.433069] Starting subtest: reject-modify-context-protection-on
[87.435590] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[87.576218] [011/133] (931s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[87.702941] Starting subtest: cursorA-vs-flipB-varying-size
[87.707288] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[87.868471] [012/133] (931s left) kms_rotation_crc (primary-rotation-90)
[87.974237] Starting subtest: primary-rotation-90
[87.978290] Subtest primary-rotation-90: SKIP (0.001s)
[88.087929] [013/133] (931s left) syncobj_wait (reset-multiple-signaled)
[88.144501] Starting subtest: reset-multiple-signaled
[88.147081] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[88.253961] [014/133] (931s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[88.335660] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[88.339461] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[89.516457] [015/133] (930s left) gem_softpin (noreloc-s3)
[89.584923] Starting subtest: noreloc-S3
[109.074862] Subtest noreloc-S3: SUCCESS (5.404s)
[109.231908] [016/133] (910s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[109.350582] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[113.735633] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.414s)
[114.897999] [017/133] (904s left) gem_ctx_param (invalid-ctx-set)
[114.953516] Starting subtest: invalid-ctx-set
[114.956009] Subtest invalid-ctx-set: SUCCESS (0.001s)
[115.081417] [018/133] (904s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[115.127268] Starting subtest: single-wait-all-for-submit-unsubmitted
[115.237625] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.109s)
[115.332065] [019/133] (904s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[115.433318] Starting subtest: x-tiled-64bpp-rotate-90
[115.453783] Subtest x-tiled-64bpp-rotate-90: SKIP (0.020s)
[115.577329] [020/133] (904s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[115.643760] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[115.708871] [021/133] (904s left) kms_psr (fbc-psr-cursor-plane-move)
[115.796306] Starting subtest: fbc-psr-cursor-plane-move
[115.798433] Starting dynamic subtest: eDP-1
[115.802338] Dynamic subtest eDP-1: SKIP (0.000s)
[115.806310] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[115.896643] [022/133] (904s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[116.003177] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[117.112080] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.111s)
[117.264936] [023/133] (902s left) kms_flip (2x-flip-vs-rmfb)
[117.372295] Starting subtest: 2x-flip-vs-rmfb
[117.383692] Subtest 2x-flip-vs-rmfb: SKIP (0.011s)
[117.544126] [024/133] (902s left) kms_plane_cursor (viewport)
[117.652128] Starting subtest: viewport
[117.655912] Starting dynamic subtest: pipe-A-eDP-1-size-64
[120.200511] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.554s)
[120.260041] Starting dynamic subtest: pipe-A-eDP-1-size-128
[122.819344] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.571s)
[122.878427] Starting dynamic subtest: pipe-A-eDP-1-size-256
[125.307120] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.441s)
[125.666950] Starting dynamic subtest: pipe-B-eDP-1-size-64
[128.878662] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.223s)
[128.938932] Starting dynamic subtest: pipe-B-eDP-1-size-128
[131.432289] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.504s)
[131.491958] Starting dynamic subtest: pipe-B-eDP-1-size-256
[133.964604] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.482s)
[134.330507] Starting dynamic subtest: pipe-C-eDP-1-size-64
[137.137889] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.815s)
[137.170343] Starting dynamic subtest: pipe-C-eDP-1-size-128
[139.279095] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.113s)
[139.315763] Starting dynamic subtest: pipe-C-eDP-1-size-256
[141.491458] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.180s)
[141.823381] Starting dynamic subtest: pipe-D-eDP-1-size-64
[144.659561] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.846s)
[144.696542] Starting dynamic subtest: pipe-D-eDP-1-size-128
[146.838062] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.146s)
[146.875158] Starting dynamic subtest: pipe-D-eDP-1-size-256
[149.016190] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.146s)
[149.336870] Subtest viewport: SUCCESS (31.708s)
[150.198885] [025/133] (869s left) kms_cdclk (mode-transition)
[150.300940] Starting subtest: mode-transition
[150.303269] Starting dynamic subtest: pipe-A-eDP-1
[150.588548] Dynamic subtest pipe-A-eDP-1: SKIP (0.286s)
[150.597120] Starting dynamic subtest: pipe-B-eDP-1
[150.601485] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[150.609406] Starting dynamic subtest: pipe-C-eDP-1
[150.613848] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[150.621690] Starting dynamic subtest: pipe-D-eDP-1
[150.625639] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[150.629638] Subtest mode-transition: SKIP (0.294s)
[151.421302] [026/133] (868s left) gem_exec_balancer (fairslice)
[151.497204] Starting subtest: fairslice
[154.345368] Subtest fairslice: SUCCESS (2.847s)
[155.121567] [027/133] (865s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[155.247126] Starting subtest: basic-flip-before-cursor-varying-size
[156.170793] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.924s)
[157.060808] [028/133] (863s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[157.163242] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[157.165387] Starting dynamic subtest: pipe-A-default-mode
[157.451805] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[157.456036] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.288s)
[158.291056] [029/133] (861s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[158.381784] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[158.384182] Starting dynamic subtest: pipe-A-default-mode
[161.137204] Dynamic subtest pipe-A-default-mode: SUCCESS (2.754s)
[161.139498] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.755s)
[161.983608] [030/133] (858s left) core_getstats (basic)
[162.047003] Starting subtest: basic
[162.049011] Subtest basic: SUCCESS (0.000s)
[162.189631] [031/133] (858s left) kms_rmfb (close-fd)
[162.295406] Starting subtest: close-fd
[162.297683] Starting dynamic subtest: pipe-A-eDP-1
[162.402800] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[162.416556] Starting dynamic subtest: pipe-B-eDP-1
[163.537263] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.133s)
[163.545530] Starting dynamic subtest: pipe-C-eDP-1
[164.670826] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.134s)
[164.680071] Starting dynamic subtest: pipe-D-eDP-1
[165.795689] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.122s)
[165.797919] Subtest close-fd: SUCCESS (3.501s)
[167.025245] [032/133] (853s left) gem_exec_reloc (basic-gtt-wc)
[167.096660] Subtest basic-gtt-wc: SKIP (0.000s)
[167.172816] [033/133] (853s left) kms_properties (crtc-properties-legacy)
[167.270719] Starting subtest: crtc-properties-legacy
[167.272588] Starting dynamic subtest: pipe-A-eDP-1
[167.712812] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.442s)
[167.721243] Starting dynamic subtest: pipe-B-eDP-1
[168.872338] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.158s)
[168.880897] Starting dynamic subtest: pipe-C-eDP-1
[169.990665] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.116s)
[169.999630] Starting dynamic subtest: pipe-D-eDP-1
[171.119679] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s)
[171.122071] Subtest crtc-properties-legacy: SUCCESS (3.852s)
[171.953691] [034/133] (848s left) kms_invalid_mode (zero-hdisplay)
[172.057846] Starting subtest: zero-hdisplay
[172.060158] Starting dynamic subtest: pipe-A-eDP-1
[172.341794] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[172.352375] Starting dynamic subtest: pipe-B-eDP-1
[172.354465] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[172.361703] Starting dynamic subtest: pipe-C-eDP-1
[172.364040] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[172.371536] Starting dynamic subtest: pipe-D-eDP-1
[172.373846] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[172.376021] Subtest zero-hdisplay: SUCCESS (0.289s)
[173.172739] [035/133] (847s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[173.286234] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[173.288843] Starting dynamic subtest: pipe-A
[174.332102] Dynamic subtest pipe-A: SUCCESS (1.050s)
[174.342358] Starting dynamic subtest: pipe-B
[176.481666] Dynamic subtest pipe-B: SUCCESS (2.148s)
[176.489729] Starting dynamic subtest: pipe-C
[177.666664] Dynamic subtest pipe-C: SUCCESS (1.184s)
[177.676278] Starting dynamic subtest: pipe-D
[178.816395] Dynamic subtest pipe-D: SUCCESS (1.149s)
[178.819076] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.536s)
[180.028093] [036/133] (840s left) kms_pm_rpm (legacy-planes-dpms)
[182.168368] Starting subtest: legacy-planes-dpms
[182.171115] Starting dynamic subtest: plane-63
[190.465839] Dynamic subtest plane-63: SUCCESS (8.304s)
[190.477828] Starting dynamic subtest: plane-93
[198.809882] Dynamic subtest plane-93: SUCCESS (8.345s)
[198.821067] Starting dynamic subtest: plane-123
[207.148530] Dynamic subtest plane-123: SUCCESS (8.334s)
[207.159418] Starting dynamic subtest: plane-133
[215.443886] Dynamic subtest plane-133: SUCCESS (8.289s)
[215.446794] Subtest legacy-planes-dpms: SUCCESS (33.282s)
[215.848660] [037/133] (804s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[215.944420] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[215.948676] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[216.060931] [038/133] (804s left) kms_dirtyfb (default-dirtyfb-ioctl)
[216.154812] Starting subtest: default-dirtyfb-ioctl
[216.157072] Starting dynamic subtest: A-eDP-1
[217.728151] Dynamic subtest A-eDP-1: SUCCESS (1.572s)
[217.730374] Subtest default-dirtyfb-ioctl: SUCCESS (1.573s)
[218.580390] [039/133] (802s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[218.708588] Starting subtest: cursorB-vs-flipA-legacy
[218.713315] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[218.875449] [040/133] (801s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[218.942283] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[218.944665] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[219.061359] [041/133] (801s left) kms_prime (basic-crc-vgem)
[219.190664] Starting subtest: basic-crc-vgem
[219.192549] Starting dynamic subtest: second-to-first
[220.192949] Dynamic subtest second-to-first: SUCCESS (1.004s)
[220.194907] Subtest basic-crc-vgem: SUCCESS (1.005s)
[220.301552] [FACT kms_prime (basic-crc-vgem)] new: kernel.kmod_is_loaded.vgem: true
[220.304647] [042/133] (800s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[220.404447] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[220.470001] [043/133] (800s left) i915_drm_fdinfo (busy)
[220.504659] Starting subtest: busy
[220.506668] Starting dynamic subtest: rcs0
[220.540759] Dynamic subtest rcs0: SKIP (0.036s)
[220.549934] Starting dynamic subtest: bcs0
[220.553737] Dynamic subtest bcs0: SKIP (0.000s)
[220.567964] Starting dynamic subtest: vcs0
[220.572056] Dynamic subtest vcs0: SKIP (0.000s)
[220.585530] Starting dynamic subtest: vcs1
[220.589540] Dynamic subtest vcs1: SKIP (0.000s)
[220.598367] Starting dynamic subtest: vecs0
[220.602047] Dynamic subtest vecs0: SKIP (0.000s)
[220.609766] Starting dynamic subtest: ccs0
[220.613385] Dynamic subtest ccs0: SKIP (0.000s)
[220.617027] Subtest busy: SKIP (0.043s)
[220.651024] [044/133] (800s left) gem_userptr_blits (nohangcheck)
[220.737833] Starting subtest: nohangcheck
[221.003760] Subtest nohangcheck: SUCCESS (0.262s)
[221.170367] [045/133] (799s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[221.287758] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[221.878523] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.592s)
[222.094731] [046/133] (798s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[222.196336] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[222.200716] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[223.310173] [047/133] (797s left) kms_scaling_modes (scaling-mode-full)
[223.417120] Starting subtest: scaling-mode-full
[223.419467] Starting dynamic subtest: pipe-A-eDP-1
[223.511295] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[223.524133] Starting dynamic subtest: pipe-B-eDP-1
[224.720277] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.207s)
[224.728658] Starting dynamic subtest: pipe-C-eDP-1
[225.843234] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.122s)
[225.855534] Starting dynamic subtest: pipe-D-eDP-1
[226.983234] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.139s)
[226.985423] Subtest scaling-mode-full: SUCCESS (3.568s)
[228.163014] [048/133] (792s left) kms_psr (fbc-pr-basic)
[228.263644] Starting subtest: fbc-pr-basic
[228.267762] Subtest fbc-pr-basic: SKIP (0.000s)
[228.361643] [049/133] (792s left) gem_ringfill (basic-all)
[234.037060] Starting subtest: basic-all
[235.189674] Subtest basic-all: SUCCESS (1.152s)
[235.362530] [050/133] (785s left) gem_exec_whisper (basic-fds-forked-all)
[235.428657] Starting subtest: basic-fds-forked-all
[257.149287] Subtest basic-fds-forked-all: SUCCESS (21.717s)
[257.358318] [051/133] (763s left) api_intel_bb (full-batch)
[257.415176] Starting subtest: full-batch
[257.422587] Subtest full-batch: SUCCESS (0.011s)
[257.533455] [052/133] (763s left) kms_cursor_crc (cursor-sliding-256x85)
[257.786013] Starting subtest: cursor-sliding-256x85
[257.833714] Subtest cursor-sliding-256x85: SKIP (0.042s)
[258.040070] [053/133] (763s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[258.128403] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[258.130587] Starting dynamic subtest: pipe-A-eDP-1
[258.186317] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[258.196252] Starting dynamic subtest: pipe-B-eDP-1
[258.252169] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[258.263109] Starting dynamic subtest: pipe-C-eDP-1
[258.313699] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[258.323717] Starting dynamic subtest: pipe-D-eDP-1
[258.372748] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[258.376142] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.008s)
[260.425155] [054/133] (760s left) gen9_exec_parse (allowed-single)
[260.492074] Subtest allowed-single: SKIP (0.000s)
[260.574440] [055/133] (760s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[260.678772] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[267.790988] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.115s)
[267.938750] [056/133] (753s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[268.051657] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[268.055815] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[268.166057] [057/133] (753s left) gem_exec_fence (expired-history)
[268.658946] Starting subtest: expired-history
[275.742553] Subtest expired-history: SUCCESS (7.085s)
[276.440380] [058/133] (744s left) kms_psr (fbc-psr-sprite-plane-move)
[276.538312] Starting subtest: fbc-psr-sprite-plane-move
[276.540420] Starting dynamic subtest: eDP-1
[276.544285] Dynamic subtest eDP-1: SKIP (0.000s)
[276.548207] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[276.633513] [059/133] (744s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[276.731924] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[283.503907] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.777s)
[283.642606] [060/133] (737s left) gem_ctx_bad_destroy (double-destroy)
[283.703586] Starting subtest: double-destroy
[283.706357] Subtest double-destroy: SUCCESS (0.000s)
[283.800977] [061/133] (737s left) syncobj_timeline (invalid-signal-illegal-handle)
[283.864135] Starting subtest: invalid-signal-illegal-handle
[283.866396] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[283.983066] [062/133] (737s left) kms_chamelium_hpd (common-hpd-after-suspend)
[284.368480] Subtest common-hpd-after-suspend: SKIP (0.000s)
[285.169615] [063/133] (736s left) kms_frontbuffer_tracking (fbc-tiling-4)
[285.272567] Starting subtest: fbc-tiling-4
[289.517359] Subtest fbc-tiling-4: SUCCESS (4.249s)
[290.710328] [064/133] (730s left) gem_cs_tlb (engines)
[290.764118] Starting subtest: engines
[290.766379] Starting dynamic subtest: rcs0
[292.921098] Dynamic subtest rcs0: SUCCESS (2.153s)
[292.933218] Starting dynamic subtest: bcs0
[295.072297] Dynamic subtest bcs0: SUCCESS (2.151s)
[295.084554] Starting dynamic subtest: vcs0
[297.224712] Dynamic subtest vcs0: SUCCESS (2.151s)
[297.236779] Starting dynamic subtest: vcs1
[299.378454] Dynamic subtest vcs1: SUCCESS (2.154s)
[299.390539] Starting dynamic subtest: vecs0
[301.529233] Dynamic subtest vecs0: SUCCESS (2.150s)
[301.541425] Starting dynamic subtest: ccs0
[303.683666] Dynamic subtest ccs0: SUCCESS (2.153s)
[303.686089] Subtest engines: SUCCESS (12.919s)
[303.848161] [065/133] (717s left) gem_mmap_gtt (hang-busy)
[303.903562] Subtest hang-busy: SKIP (0.000s)
[303.971524] [066/133] (717s left) kms_psr (psr2-sprite-plane-onoff)
[304.065572] Starting subtest: psr2-sprite-plane-onoff
[304.067858] Starting dynamic subtest: eDP-1
[305.785301] Dynamic subtest eDP-1: SUCCESS (1.719s)
[305.787789] Subtest psr2-sprite-plane-onoff: SUCCESS (1.720s)
[306.667011] [067/133] (715s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[306.771747] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[307.373033] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.603s)
[307.590386] [068/133] (714s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[307.699105] Starting subtest: y-tiled-64bpp-rotate-270
[307.703326] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[307.833969] [069/133] (714s left) gem_bad_reloc (negative-reloc-lut)
[307.900202] Subtest negative-reloc-lut: SKIP (0.000s)
[307.986478] [070/133] (713s left) gem_ctx_persistence (engines-mixed)
[308.049885] Starting subtest: engines-mixed
[308.052334] Starting dynamic subtest: rcs0
[308.157418] Dynamic subtest rcs0: SUCCESS (0.107s)
[308.170261] Starting dynamic subtest: bcs0
[308.228511] Dynamic subtest bcs0: SUCCESS (0.069s)
[308.240419] Starting dynamic subtest: vcs0
[308.308206] Dynamic subtest vcs0: SUCCESS (0.078s)
[308.319478] Starting dynamic subtest: vcs1
[308.405190] Dynamic subtest vcs1: SUCCESS (0.095s)
[308.416534] Starting dynamic subtest: vecs0
[308.483254] Dynamic subtest vecs0: SUCCESS (0.076s)
[308.494667] Starting dynamic subtest: ccs0
[308.549069] Dynamic subtest ccs0: SUCCESS (0.064s)
[308.551620] Subtest engines-mixed: SUCCESS (0.500s)
[308.661803] [071/133] (713s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[308.746601] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[308.748660] Starting dynamic subtest: pipe-A
[308.813153] Dynamic subtest pipe-A: SUCCESS (0.068s)
[308.826073] Starting dynamic subtest: pipe-B
[309.966838] Dynamic subtest pipe-B: SUCCESS (1.151s)
[309.978480] Starting dynamic subtest: pipe-C
[311.084948] Dynamic subtest pipe-C: SUCCESS (1.117s)
[311.093961] Starting dynamic subtest: pipe-D
[312.221383] Dynamic subtest pipe-D: SUCCESS (1.135s)
[312.223741] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.477s)
[313.406861] [072/133] (708s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[313.518229] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[313.522422] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[313.663282] [073/133] (708s left) gem_exec_schedule (semaphore-noskip)
[313.733222] Starting subtest: semaphore-noskip
[314.139004] Subtest semaphore-noskip: SUCCESS (0.414s)
[314.520574] [074/133] (707s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[314.621848] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[314.626066] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[314.756951] [075/133] (707s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[314.857792] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[314.861860] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[314.991553] [076/133] (707s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[315.113951] Starting subtest: 4-tiled-16bpp-rotate-0
[316.356527] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.244s)
[316.514218] [077/133] (705s left) gem_exec_basic (basic)
[316.582664] Starting subtest: basic
[316.584645] Starting dynamic subtest: rcs0-smem
[316.586640] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[316.596252] Starting dynamic subtest: bcs0-smem
[316.598252] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[316.607353] Starting dynamic subtest: vcs0-smem
[316.609232] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[316.618149] Starting dynamic subtest: vcs1-smem
[316.620014] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[316.629491] Starting dynamic subtest: vecs0-smem
[316.631150] Dynamic subtest vecs0-smem: SUCCESS (0.003s)
[316.639232] Starting dynamic subtest: ccs0-smem
[316.640861] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[316.642442] Subtest basic: SUCCESS (0.017s)
[318.063917] [078/133] (704s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[318.185691] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[318.190067] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[318.322800] [079/133] (703s left) gem_mmap (short-mmap)
[318.392092] Subtest short-mmap: SKIP (0.000s)
[318.462932] [080/133] (703s left) gem_exec_reloc (basic-gtt-wc-active)
[318.524231] Subtest basic-gtt-wc-active: SKIP (0.000s)
[318.600460] [081/133] (703s left) gem_ctx_shared (create-shared-gtt)
[318.652871] Starting subtest: create-shared-gtt
[320.806089] Subtest create-shared-gtt: SUCCESS (2.153s)
[321.250101] [082/133] (701s left) gem_exec_reloc (basic-write-wc)
[321.323265] Subtest basic-write-wc: SKIP (0.000s)
[321.416524] [083/133] (701s left) gem_eio (wait-immediate)
[321.659835] Starting subtest: wait-immediate
[322.072778] Subtest wait-immediate: SUCCESS (0.412s)
[322.258782] [084/133] (700s left) gem_ctx_persistence (legacy-engines-mixed)
[322.321841] Starting subtest: legacy-engines-mixed
[322.323687] Starting dynamic subtest: render
[322.418815] Dynamic subtest render: SUCCESS (0.096s)
[322.432674] Starting dynamic subtest: bsd1
[322.503510] Dynamic subtest bsd1: SUCCESS (0.082s)
[322.516102] Starting dynamic subtest: bsd2
[322.579972] Dynamic subtest bsd2: SUCCESS (0.074s)
[322.594836] Starting dynamic subtest: blt
[322.660089] Dynamic subtest blt: SUCCESS (0.077s)
[322.674343] Starting dynamic subtest: vebox
[322.743159] Dynamic subtest vebox: SUCCESS (0.081s)
[322.745355] Subtest legacy-engines-mixed: SUCCESS (0.422s)
[322.859969] [085/133] (699s left) perf_pmu (semaphore-busy)
[322.896612] Starting subtest: semaphore-busy
[322.898320] Starting dynamic subtest: rcs0
[324.532524] Dynamic subtest rcs0: SUCCESS (1.632s)
[324.544672] Starting dynamic subtest: bcs0
[326.164244] Dynamic subtest bcs0: SUCCESS (1.630s)
[326.174220] Starting dynamic subtest: vcs0
[330.540782] Dynamic subtest vcs0: SUCCESS (4.373s)
[330.552549] Starting dynamic subtest: vcs1
[336.491634] Dynamic subtest vcs1: SUCCESS (5.945s)
[336.502782] Starting dynamic subtest: vecs0
[342.508673] Dynamic subtest vecs0: SUCCESS (6.011s)
[342.520115] Starting dynamic subtest: ccs0
[345.584307] Dynamic subtest ccs0: SUCCESS (3.072s)
[345.586778] Subtest semaphore-busy: SUCCESS (22.682s)
[345.726491] [086/133] (676s left) gem_exec_schedule (pi-common)
[345.911256] Starting subtest: pi-common
[345.913140] Starting dynamic subtest: rcs0
[345.965039] Dynamic subtest rcs0: SUCCESS (0.055s)
[345.974808] Starting dynamic subtest: bcs0
[346.014142] Dynamic subtest bcs0: SUCCESS (0.048s)
[346.024274] Starting dynamic subtest: vcs0
[346.050149] Dynamic subtest vcs0: SUCCESS (0.035s)
[346.059449] Starting dynamic subtest: vcs1
[346.085713] Dynamic subtest vcs1: SUCCESS (0.035s)
[346.094895] Starting dynamic subtest: vecs0
[346.121161] Dynamic subtest vecs0: SUCCESS (0.035s)
[346.130480] Starting dynamic subtest: ccs0
[346.155031] Dynamic subtest ccs0: SUCCESS (0.033s)
[346.157238] Subtest pi-common: SUCCESS (0.246s)
[346.418999] [087/133] (676s left) i915_hangman (engine-error-state-capture)
[346.488626] Starting subtest: engine-error-state-capture
[346.490715] Starting dynamic subtest: rcs0
[349.967270] Dynamic subtest rcs0: SUCCESS (3.478s)
[349.980280] Starting dynamic subtest: bcs0
[355.983652] Dynamic subtest bcs0: SUCCESS (6.012s)
[355.996774] Starting dynamic subtest: vcs0
[361.936278] Dynamic subtest vcs0: SUCCESS (5.948s)
[361.949289] Starting dynamic subtest: vcs1
[366.926927] Dynamic subtest vcs1: SUCCESS (4.987s)
[366.938840] Starting dynamic subtest: vecs0
[371.919979] Dynamic subtest vecs0: SUCCESS (4.989s)
[371.932483] Starting dynamic subtest: ccs0
[376.975285] Dynamic subtest ccs0: SUCCESS (5.052s)
[376.978528] Subtest engine-error-state-capture: SUCCESS (30.483s)
[377.146465] [088/133] (645s left) syncobj_timeline (wait-for-submit-snapshot)
[377.208258] Starting subtest: wait-for-submit-snapshot
[377.289372] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[377.395420] [089/133] (645s left) kms_color (ctm-blue-to-red)
[377.511582] Starting subtest: ctm-blue-to-red
[377.513888] Starting dynamic subtest: pipe-A-eDP-1
[378.251235] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.739s)
[378.263072] Starting dynamic subtest: pipe-B-eDP-1
[379.714052] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.463s)
[379.723934] Starting dynamic subtest: pipe-C-eDP-1
[381.081368] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.366s)
[381.092145] Starting dynamic subtest: pipe-D-eDP-1
[382.391399] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.307s)
[382.393453] Subtest ctm-blue-to-red: SUCCESS (4.879s)
[383.227509] [090/133] (639s left) prime_vgem (basic-gtt)
[383.316109] Starting subtest: basic-gtt
[383.320674] Subtest basic-gtt: SKIP (0.000s)
[383.465860] [091/133] (639s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[383.572213] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[391.005286] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.435s)
[391.165078] [092/133] (631s left) api_intel_allocator (default-alignment)
[391.217425] Starting subtest: default-alignment
[391.222328] Subtest default-alignment: SUCCESS (0.004s)
[391.330577] [093/133] (631s left) i915_pm_rps (fence-order)
[391.392134] Starting subtest: fence-order
[394.237546] Subtest fence-order: SUCCESS (2.843s)
[394.385958] [094/133] (628s left) kms_vblank (query-busy)
[394.490530] Starting subtest: query-busy
[394.492469] Starting dynamic subtest: pipe-A-eDP-1
[396.371714] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.881s)
[396.386571] Starting dynamic subtest: pipe-D-eDP-1
[398.907530] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.532s)
[398.909729] Subtest query-busy: SUCCESS (4.417s)
[399.728820] [095/133] (623s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[399.839771] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[399.844195] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[399.956037] [096/133] (623s left) kms_addfb_basic (invalid-get-prop-any)
[400.007953] Starting subtest: invalid-get-prop-any
[400.009950] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[400.165827] [097/133] (622s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[400.262029] Starting subtest: fbc-psr2-cursor-mmap-gtt
[400.264300] Starting dynamic subtest: eDP-1
[400.268784] Dynamic subtest eDP-1: SKIP (0.000s)
[400.273183] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[400.372790] [098/133] (622s left) kms_flip (2x-blocking-absolute-wf_vblank)
[400.475181] Starting subtest: 2x-blocking-absolute-wf_vblank
[400.484236] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.010s)
[400.627580] [099/133] (622s left) kms_cursor_crc (cursor-onscreen-256x85)
[400.888567] Starting subtest: cursor-onscreen-256x85
[400.933402] Subtest cursor-onscreen-256x85: SKIP (0.042s)
[401.138942] [100/133] (622s left) kms_flip (2x-modeset-vs-vblank-race)
[401.242664] Starting subtest: 2x-modeset-vs-vblank-race
[401.268618] Subtest 2x-modeset-vs-vblank-race: SKIP (0.025s)
[401.381956] [101/133] (621s left) kms_atomic_interruptible (atomic-setmode)
[401.491318] Starting subtest: atomic-setmode
[401.493407] Starting dynamic subtest: pipe-A-eDP-1
[408.381995] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.889s)
[408.384230] Subtest atomic-setmode: SUCCESS (6.891s)
[409.204663] [102/133] (614s left) kms_frontbuffer_tracking (psr-argb161616f-draw-render)
[409.307156] Starting subtest: psr-argb161616f-draw-render
[409.311620] Subtest psr-argb161616f-draw-render: SKIP (0.000s)
[409.440422] [103/133] (613s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[409.545926] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[409.550352] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[409.680317] [104/133] (613s left) kms_plane_scaling (invalid-num-scalers)
[409.784663] Starting subtest: invalid-num-scalers
[409.786932] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[409.802865] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.019s)
[409.812832] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[409.835977] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[409.845743] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[409.866391] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[409.876063] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[409.898256] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[409.900583] Subtest invalid-num-scalers: SUCCESS (0.116s)
[410.026797] [105/133] (613s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[410.119836] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[410.123262] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[410.229549] [106/133] (613s left) sw_sync (alloc_fence_invalid_timeline)
[410.267056] Starting subtest: alloc_fence_invalid_timeline
[410.268844] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[410.338368] [107/133] (613s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[410.393459] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[410.501306] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.106s)
[410.599869] [108/133] (612s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[410.706697] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[410.708981] Starting dynamic subtest: A-eDP1
[419.634077] Dynamic subtest A-eDP1: SUCCESS (8.927s)
[419.645653] Starting dynamic subtest: B-eDP1
[428.565940] Dynamic subtest B-eDP1: SUCCESS (8.930s)
[428.576933] Starting dynamic subtest: C-eDP1
[437.481181] Dynamic subtest C-eDP1: SUCCESS (8.914s)
[437.502152] Starting dynamic subtest: D-eDP1
[446.407435] Dynamic subtest D-eDP1: SUCCESS (8.924s)
[446.409789] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.706s)
[447.664314] [109/133] (575s left) kms_addfb_basic (size-max)
[447.776466] Starting subtest: size-max
[447.778695] Subtest size-max: SUCCESS (0.000s)
[447.896966] [110/133] (575s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[448.130930] Starting subtest: cursor-rapid-movement-256x256
[448.133269] Starting dynamic subtest: pipe-A-eDP-1
[448.662215] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.529s)
[448.692843] Starting dynamic subtest: pipe-D-eDP-1
[449.883226] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.197s)
[449.885373] Subtest cursor-rapid-movement-256x256: SUCCESS (1.751s)
[450.724750] [111/133] (572s left) gem_exec_whisper (basic-queues-all)
[450.791144] Starting subtest: basic-queues-all
[459.264812] Subtest basic-queues-all: SUCCESS (8.471s)
[459.472986] [112/133] (564s left) kms_dsc (dsc-fractional-bpp)
[459.581785] Starting subtest: dsc-fractional-bpp
[459.595161] Subtest dsc-fractional-bpp: SKIP (0.000s)
[459.681065] [113/133] (563s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[459.776332] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[459.778569] Starting dynamic subtest: pipe-A-default-mode
[460.063290] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[460.067680] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.287s)
[460.951843] [114/133] (562s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[461.054090] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[461.058777] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[461.214392] [115/133] (562s left) gem_softpin (evict-prime)
[461.281023] Starting subtest: evict-prime
[461.283304] Starting dynamic subtest: rcs0
[462.469554] Dynamic subtest rcs0: SUCCESS (1.188s)
[462.482915] Starting dynamic subtest: bcs0
[463.630959] Dynamic subtest bcs0: SUCCESS (1.159s)
[463.643626] Starting dynamic subtest: vcs0
[464.970873] Dynamic subtest vcs0: SUCCESS (1.337s)
[464.983295] Starting dynamic subtest: vcs1
[467.019677] Dynamic subtest vcs1: SUCCESS (2.046s)
[467.032153] Starting dynamic subtest: vecs0
[469.015904] Dynamic subtest vecs0: SUCCESS (1.995s)
[469.028662] Starting dynamic subtest: ccs0
[470.174520] Dynamic subtest ccs0: SUCCESS (1.158s)
[470.187747] Starting dynamic subtest: all
[472.065456] Dynamic subtest all: SUCCESS (1.887s)
[472.068589] Subtest evict-prime: SUCCESS (10.785s)
[472.171694] [116/133] (551s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[472.294191] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[472.298672] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[472.434657] [117/133] (551s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[472.542734] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[472.679666] [118/133] (551s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[472.737261] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[472.845641] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.106s)
[472.949796] [119/133] (551s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[473.054711] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[473.058750] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[473.175430] [120/133] (550s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[473.273488] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[477.340214] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.071s)
[478.556295] [121/133] (545s left) gem_mmap_wc (bad-size)
[478.617397] Subtest bad-size: SKIP (0.000s)
[478.681434] [122/133] (545s left) kms_hdr (static-toggle-suspend)
[478.783293] Starting subtest: static-toggle-suspend
[478.789812] Subtest static-toggle-suspend: SKIP (0.000s)
[478.887093] [123/133] (545s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[478.996853] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[479.001162] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[479.115909] [124/133] (545s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[484.085770] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[484.088115] Starting dynamic subtest: pipe-A-eDP-1
[484.890691] Dynamic subtest pipe-A-eDP-1: SKIP (0.803s)
[484.900865] Starting dynamic subtest: pipe-B-eDP-1
[486.027921] Dynamic subtest pipe-B-eDP-1: SKIP (1.135s)
[486.032563] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.943s)
[487.245023] [125/133] (536s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[487.336095] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[487.340162] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[487.470199] [126/133] (536s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[487.557551] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[487.559821] Starting dynamic subtest: pipe-A-eDP-1
[487.580171] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[487.595201] Starting dynamic subtest: pipe-B-eDP-1
[487.614993] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[487.625287] Starting dynamic subtest: pipe-C-eDP-1
[487.643675] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[487.653184] Starting dynamic subtest: pipe-D-eDP-1
[487.672568] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[487.674574] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[489.915464] [127/133] (534s left) syncobj_timeline (single-wait-all-available-submitted)
[489.971484] Starting subtest: single-wait-all-available-submitted
[489.973442] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[490.089198] [128/133] (534s left) gem_exec_parallel (userptr)
[490.145706] Starting subtest: userptr
[490.147969] Starting dynamic subtest: rcs0
[491.597308] Dynamic subtest rcs0: SUCCESS (1.451s)
[491.610022] Starting dynamic subtest: bcs0
[493.079266] Dynamic subtest bcs0: SUCCESS (1.481s)
[493.091507] Starting dynamic subtest: vcs0
[495.024638] Dynamic subtest vcs0: SUCCESS (1.943s)
[495.034793] Starting dynamic subtest: vcs1
[496.944243] Dynamic subtest vcs1: SUCCESS (1.917s)
[496.954398] Starting dynamic subtest: vecs0
[498.992552] Dynamic subtest vecs0: SUCCESS (2.047s)
[499.002589] Starting dynamic subtest: ccs0
[500.512415] Dynamic subtest ccs0: SUCCESS (1.520s)
[500.514890] Subtest userptr: SUCCESS (10.369s)
[500.724361] [129/133] (523s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[500.830759] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[500.834819] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[500.977641] [130/133] (523s left) i915_selftest (mock)
[502.981444] Starting subtest: mock
[502.984026] Starting dynamic subtest: sanitycheck
[503.717956] Dynamic subtest sanitycheck: SUCCESS (0.737s)
[503.727463] Starting dynamic subtest: shmem
[504.459915] Dynamic subtest shmem: SUCCESS (0.740s)
[504.469770] Starting dynamic subtest: fence
[512.246731] Dynamic subtest fence: SUCCESS (7.786s)
[512.255949] Starting dynamic subtest: scatterlist
[513.949410] Dynamic subtest scatterlist: SUCCESS (1.701s)
[513.959299] Starting dynamic subtest: syncmap
[517.748549] Dynamic subtest syncmap: SUCCESS (3.797s)
[517.758305] Starting dynamic subtest: uncore
[518.504147] Dynamic subtest uncore: SUCCESS (0.754s)
[518.514264] Starting dynamic subtest: ring
[519.259985] Dynamic subtest ring: SUCCESS (0.754s)
[519.270045] Starting dynamic subtest: engine
[519.970554] Dynamic subtest engine: SUCCESS (0.709s)
[519.980087] Starting dynamic subtest: timelines
[523.905846] Dynamic subtest timelines: SUCCESS (3.933s)
[523.915419] Starting dynamic subtest: requests
[527.578958] Dynamic subtest requests: SUCCESS (3.649s)
[527.587696] Starting dynamic subtest: objects
[528.359478] Dynamic subtest objects: SUCCESS (0.802s)
[528.368422] Starting dynamic subtest: phys
[529.217084] Dynamic subtest phys: SUCCESS (0.856s)
[529.227062] Starting dynamic subtest: dmabuf
[530.058117] Dynamic subtest dmabuf: SUCCESS (0.839s)
[530.067892] Starting dynamic subtest: vma
[535.338792] Dynamic subtest vma: SUCCESS (5.279s)
[535.348542] Starting dynamic subtest: evict
[536.679297] Dynamic subtest evict: SUCCESS (1.338s)
[536.688647] Starting dynamic subtest: gtt
[539.940461] Dynamic subtest gtt: SUCCESS (3.260s)
[539.950535] Starting dynamic subtest: hugepages
[540.933808] Dynamic subtest hugepages: SUCCESS (0.991s)
[540.943904] Starting dynamic subtest: memory_region
[543.603788] Dynamic subtest memory_region: SUCCESS (2.668s)
[543.606334] Subtest mock: SUCCESS (40.631s)
[543.636696] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[543.637360] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[543.640480] [131/133] (480s left) gem_mmap_gtt (basic-write-read)
[545.190316] Subtest basic-write-read: SKIP (0.000s)
[545.264205] [FACT gem_mmap_gtt (basic-write-read)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[545.265490] [FACT gem_mmap_gtt (basic-write-read)] new: kernel.kmod_is_loaded.i915: true
[545.269771] [132/133] (479s left) perf (gen12-group-exclusive-stream-sample-oa)
[545.414666] Starting subtest: gen12-group-exclusive-stream-sample-oa
[545.433201] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.020s)
[545.470837] [133/133] (479s left) perf_pmu (busy-double-start)
[545.512182] Starting subtest: busy-double-start
[545.514575] Starting dynamic subtest: rcs0
[549.158850] Dynamic subtest rcs0: FAIL (3.593s)
[549.169176] Starting dynamic subtest: bcs0
[552.712450] Dynamic subtest bcs0: SUCCESS (3.608s)
[552.724615] Starting dynamic subtest: vcs0
[556.563436] Dynamic subtest vcs0: SUCCESS (3.849s)
[556.575109] Starting dynamic subtest: vcs1
[560.597676] Dynamic subtest vcs1: SUCCESS (4.033s)
[560.609486] Starting dynamic subtest: vecs0
[564.580021] Dynamic subtest vecs0: SUCCESS (3.980s)
[564.591274] Starting dynamic subtest: ccs0
[568.213401] Dynamic subtest ccs0: FAIL (3.565s)
[568.215310] Subtest busy-double-start: FAIL (22.639s)
[568.295351] 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.