[56.668715] Initializing watchdogs
[56.668761]   /dev/watchdog0
[56.682849] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.687075] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.689189] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.692543] [001/133] (960s left) gem_partial_pwrite_pread (write-snoop)
[56.783867] Subtest write-snoop: SKIP (0.000s)
[56.858678] [002/133] (960s left) kms_content_protection (content-type-change)
[57.016763] Starting subtest: content-type-change
[57.021270] Subtest content-type-change: SKIP (0.000s)
[57.178216] [003/133] (960s left) kms_rotation_crc (multiplane-rotation)
[57.273683] Starting subtest: multiplane-rotation
[74.720233] Subtest multiplane-rotation: SUCCESS (17.449s)
[74.878283] [004/133] (942s left) kms_chamelium_color (ctm-red-to-blue)
[74.981499] Subtest ctm-red-to-blue: SKIP (0.000s)
[75.024795] [005/133] (942s left) syncobj_wait (invalid-reset-one-illegal-handle)
[75.081945] Starting subtest: invalid-reset-one-illegal-handle
[75.083967] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[75.208855] [006/133] (942s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[75.300532] Starting subtest: disable-crc-after-crtc
[75.302435] Starting dynamic subtest: pipe-A-eDP-1
[76.954557] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.654s)
[76.962983] Starting dynamic subtest: pipe-B-eDP-1
[79.253065] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.297s)
[79.265135] Starting dynamic subtest: pipe-C-eDP-1
[81.501861] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.245s)
[81.512771] Starting dynamic subtest: pipe-D-eDP-1
[83.758506] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.258s)
[83.760757] Subtest disable-crc-after-crtc: SUCCESS (8.459s)
[84.600271] [007/133] (932s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[84.664384] Subtest tiled-to-tiled: SKIP (0.000s)
[84.741839] [008/133] (932s left) syncobj_wait (wait-all-interrupted)
[84.798126] Starting subtest: wait-all-interrupted
[84.899099] Subtest wait-all-interrupted: SUCCESS (0.102s)
[84.996391] [009/133] (932s left) syncobj_wait (wait-all-complex)
[85.056941] Starting subtest: wait-all-complex
[85.270030] Subtest wait-all-complex: SUCCESS (0.212s)
[85.366236] [010/133] (932s left) gem_pxp (reject-modify-context-protection-on)
[85.500780] Starting subtest: reject-modify-context-protection-on
[85.503520] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[85.639309] [011/133] (931s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[85.764128] Starting subtest: cursorA-vs-flipB-varying-size
[85.768768] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[85.935164] [012/133] (931s left) kms_rotation_crc (primary-rotation-90)
[86.029885] Starting subtest: primary-rotation-90
[86.034398] Subtest primary-rotation-90: SKIP (0.001s)
[86.123784] [013/133] (931s left) syncobj_wait (reset-multiple-signaled)
[86.186064] Starting subtest: reset-multiple-signaled
[86.188421] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[86.327298] [014/133] (931s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[86.427068] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[86.430869] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[87.550270] [015/133] (930s left) gem_softpin (noreloc-s3)
[87.624271] Starting subtest: noreloc-S3
[107.646757] Subtest noreloc-S3: SUCCESS (5.396s)
[110.831581] [016/133] (909s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[110.946119] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[115.420747] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.474s)
[116.655319] [017/133] (904s left) gem_ctx_param (invalid-ctx-set)
[116.704156] Starting subtest: invalid-ctx-set
[116.706595] Subtest invalid-ctx-set: SUCCESS (0.001s)
[116.836646] [018/133] (904s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[116.898589] Starting subtest: single-wait-all-for-submit-unsubmitted
[117.002669] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[117.099288] [019/133] (903s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[117.209516] Starting subtest: x-tiled-64bpp-rotate-90
[117.229414] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[117.388005] [020/133] (903s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[117.446974] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[117.508225] [021/133] (903s left) kms_psr (fbc-psr-cursor-plane-move)
[117.606545] Starting subtest: fbc-psr-cursor-plane-move
[117.608470] Starting dynamic subtest: eDP-1
[117.612592] Dynamic subtest eDP-1: SKIP (0.000s)
[117.616704] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[117.706460] [022/133] (903s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[117.801215] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[118.802994] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.002s)
[118.988710] [023/133] (902s left) kms_flip (2x-flip-vs-rmfb)
[119.089241] Starting subtest: 2x-flip-vs-rmfb
[119.102640] Subtest 2x-flip-vs-rmfb: SKIP (0.015s)
[119.202143] [024/133] (901s left) kms_plane_cursor (viewport)
[119.299545] Starting subtest: viewport
[119.303380] Starting dynamic subtest: pipe-A-eDP-1-size-64
[121.920939] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.619s)
[121.979863] Starting dynamic subtest: pipe-A-eDP-1-size-128
[124.534069] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.560s)
[124.593482] Starting dynamic subtest: pipe-A-eDP-1-size-256
[127.136273] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.551s)
[127.489970] Starting dynamic subtest: pipe-B-eDP-1-size-64
[130.791575] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.310s)
[130.851308] Starting dynamic subtest: pipe-B-eDP-1-size-128
[133.448435] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.604s)
[133.508772] Starting dynamic subtest: pipe-B-eDP-1-size-256
[136.116950] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.615s)
[136.465824] Starting dynamic subtest: pipe-C-eDP-1-size-64
[139.394488] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.938s)
[139.431405] Starting dynamic subtest: pipe-C-eDP-1-size-128
[141.638190] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.213s)
[141.678301] Starting dynamic subtest: pipe-C-eDP-1-size-256
[143.827837] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.158s)
[144.157038] Starting dynamic subtest: pipe-D-eDP-1-size-64
[147.014683] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.869s)
[147.059540] Starting dynamic subtest: pipe-D-eDP-1-size-128
[149.261218] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.214s)
[149.296842] Starting dynamic subtest: pipe-D-eDP-1-size-256
[151.459854] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.169s)
[151.782628] Subtest viewport: SUCCESS (32.475s)
[152.591693] [025/133] (868s left) kms_cdclk (mode-transition)
[152.686548] Starting subtest: mode-transition
[152.688800] Starting dynamic subtest: pipe-A-eDP-1
[152.974460] Dynamic subtest pipe-A-eDP-1: SKIP (0.286s)
[152.983614] Starting dynamic subtest: pipe-B-eDP-1
[152.988231] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[152.996463] Starting dynamic subtest: pipe-C-eDP-1
[153.001061] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[153.009018] Starting dynamic subtest: pipe-D-eDP-1
[153.013461] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[153.017665] Subtest mode-transition: SKIP (0.293s)
[153.819591] [026/133] (867s left) gem_exec_balancer (fairslice)
[153.893665] Starting subtest: fairslice
[156.762652] Subtest fairslice: SUCCESS (2.870s)
[157.622514] [027/133] (863s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[157.753055] Starting subtest: basic-flip-before-cursor-varying-size
[158.668369] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.913s)
[159.556767] [028/133] (861s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[159.649454] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[159.651711] Starting dynamic subtest: pipe-A-default-mode
[159.939053] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[159.943730] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.287s)
[160.780726] [029/133] (860s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[160.876272] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[160.878555] Starting dynamic subtest: pipe-A-default-mode
[163.605273] Dynamic subtest pipe-A-default-mode: SUCCESS (2.727s)
[163.607627] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.729s)
[164.468086] [030/133] (856s left) core_getstats (basic)
[164.523791] Starting subtest: basic
[164.525682] Subtest basic: SUCCESS (0.000s)
[164.641821] [031/133] (856s left) kms_rmfb (close-fd)
[164.733768] Starting subtest: close-fd
[164.735621] Starting dynamic subtest: pipe-A-eDP-1
[164.841886] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[164.851296] Starting dynamic subtest: pipe-B-eDP-1
[165.993289] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.150s)
[166.004699] Starting dynamic subtest: pipe-C-eDP-1
[167.113599] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.120s)
[167.123513] Starting dynamic subtest: pipe-D-eDP-1
[168.252504] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.138s)
[168.254744] Subtest close-fd: SUCCESS (3.519s)
[169.489863] [032/133] (851s left) gem_exec_reloc (basic-gtt-wc)
[169.572033] Subtest basic-gtt-wc: SKIP (0.000s)
[169.652589] [033/133] (851s left) kms_properties (crtc-properties-legacy)
[169.752187] Starting subtest: crtc-properties-legacy
[169.754034] Starting dynamic subtest: pipe-A-eDP-1
[170.200403] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.447s)
[170.212441] Starting dynamic subtest: pipe-B-eDP-1
[171.343573] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.143s)
[171.352170] Starting dynamic subtest: pipe-C-eDP-1
[172.469198] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.121s)
[172.478750] Starting dynamic subtest: pipe-D-eDP-1
[173.605389] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.135s)
[173.607790] Subtest crtc-properties-legacy: SUCCESS (3.853s)
[174.434298] [034/133] (847s left) kms_invalid_mode (zero-hdisplay)
[174.541770] Starting subtest: zero-hdisplay
[174.544051] Starting dynamic subtest: pipe-A-eDP-1
[174.833596] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s)
[174.844920] Starting dynamic subtest: pipe-B-eDP-1
[174.846995] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[174.855256] Starting dynamic subtest: pipe-C-eDP-1
[174.857555] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[174.865242] Starting dynamic subtest: pipe-D-eDP-1
[174.867183] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[174.869142] Subtest zero-hdisplay: SUCCESS (0.299s)
[175.676267] [035/133] (845s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[175.780609] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[175.782990] Starting dynamic subtest: pipe-A
[176.828632] Dynamic subtest pipe-A: SUCCESS (1.050s)
[176.842326] Starting dynamic subtest: pipe-B
[178.952516] Dynamic subtest pipe-B: SUCCESS (2.122s)
[178.965749] Starting dynamic subtest: pipe-C
[180.128732] Dynamic subtest pipe-C: SUCCESS (1.174s)
[180.152758] Starting dynamic subtest: pipe-D
[181.354935] Dynamic subtest pipe-D: SUCCESS (1.223s)
[181.357566] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.577s)
[182.567929] [036/133] (839s left) kms_pm_rpm (legacy-planes-dpms)
[184.697561] Starting subtest: legacy-planes-dpms
[184.700388] Starting dynamic subtest: plane-63
[193.326872] Dynamic subtest plane-63: SUCCESS (8.629s)
[193.337766] Starting dynamic subtest: plane-93
[201.645173] Dynamic subtest plane-93: SUCCESS (8.315s)
[201.656235] Starting dynamic subtest: plane-123
[209.946333] Dynamic subtest plane-123: SUCCESS (8.299s)
[209.957813] Starting dynamic subtest: plane-133
[218.665157] Dynamic subtest plane-133: SUCCESS (8.717s)
[218.667781] Subtest legacy-planes-dpms: SUCCESS (33.971s)
[219.064658] [037/133] (802s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[219.172958] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[219.177303] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[219.304884] [038/133] (802s left) kms_dirtyfb (default-dirtyfb-ioctl)
[219.406272] Starting subtest: default-dirtyfb-ioctl
[219.408561] Starting dynamic subtest: A-eDP-1
[221.011153] Dynamic subtest A-eDP-1: SUCCESS (1.605s)
[221.013533] Subtest default-dirtyfb-ioctl: SUCCESS (1.607s)
[221.885356] [039/133] (799s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[222.016830] Starting subtest: cursorB-vs-flipA-legacy
[222.021442] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[222.183768] [040/133] (799s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[222.237376] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[222.239648] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[222.366825] [041/133] (799s left) kms_prime (basic-crc-vgem)
[222.494765] Starting subtest: basic-crc-vgem
[222.497107] Starting dynamic subtest: second-to-first
[223.439830] Dynamic subtest second-to-first: SUCCESS (0.948s)
[223.441585] Subtest basic-crc-vgem: SUCCESS (0.949s)
[223.547283] [FACT kms_prime (basic-crc-vgem)] new: kernel.kmod_is_loaded.vgem: true
[223.550244] [042/133] (798s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[223.667682] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[223.737603] [043/133] (798s left) i915_drm_fdinfo (busy)
[223.780965] Starting subtest: busy
[223.782852] Starting dynamic subtest: rcs0
[223.806627] Dynamic subtest rcs0: SKIP (0.024s)
[223.814585] Starting dynamic subtest: bcs0
[223.832515] Dynamic subtest bcs0: SKIP (0.025s)
[223.842899] Starting dynamic subtest: vcs0
[223.846270] Dynamic subtest vcs0: SKIP (0.000s)
[223.854365] Starting dynamic subtest: vcs1
[223.857674] Dynamic subtest vcs1: SKIP (0.000s)
[223.865915] Starting dynamic subtest: vecs0
[223.869384] Dynamic subtest vecs0: SKIP (0.000s)
[223.877385] Starting dynamic subtest: ccs0
[223.880792] Dynamic subtest ccs0: SKIP (0.000s)
[223.884226] Subtest busy: SKIP (0.054s)
[223.930768] [044/133] (797s left) gem_userptr_blits (nohangcheck)
[224.019578] Starting subtest: nohangcheck
[224.281622] Subtest nohangcheck: SUCCESS (0.258s)
[224.440014] [045/133] (797s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[224.547625] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[225.171902] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.626s)
[225.334172] [046/133] (796s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[225.424263] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[225.428596] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[226.616379] [047/133] (795s left) kms_scaling_modes (scaling-mode-full)
[226.711392] Starting subtest: scaling-mode-full
[226.713515] Starting dynamic subtest: pipe-A-eDP-1
[226.803776] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[226.813415] Starting dynamic subtest: pipe-B-eDP-1
[228.009220] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.203s)
[228.020635] Starting dynamic subtest: pipe-C-eDP-1
[229.221875] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.212s)
[229.231038] Starting dynamic subtest: pipe-D-eDP-1
[230.353762] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s)
[230.356049] Subtest scaling-mode-full: SUCCESS (3.645s)
[231.638671] [048/133] (790s left) kms_psr (fbc-pr-basic)
[231.750589] Starting subtest: fbc-pr-basic
[231.754952] Subtest fbc-pr-basic: SKIP (0.000s)
[231.849057] [049/133] (790s left) gem_ringfill (basic-all)
[237.561107] Starting subtest: basic-all
[238.720140] Subtest basic-all: SUCCESS (1.158s)
[238.897444] [050/133] (783s left) gem_exec_whisper (basic-fds-forked-all)
[238.976647] Starting subtest: basic-fds-forked-all
[260.531249] Subtest basic-fds-forked-all: SUCCESS (21.553s)
[260.748452] [051/133] (761s left) api_intel_bb (full-batch)
[260.809785] Starting subtest: full-batch
[260.815155] Subtest full-batch: SUCCESS (0.008s)
[260.943047] [052/133] (761s left) kms_cursor_crc (cursor-sliding-256x85)
[261.199060] Starting subtest: cursor-sliding-256x85
[261.248615] Subtest cursor-sliding-256x85: SKIP (0.043s)
[261.450644] [053/133] (760s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[261.560743] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[261.562939] Starting dynamic subtest: pipe-A-eDP-1
[261.621026] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[261.630157] Starting dynamic subtest: pipe-B-eDP-1
[261.680097] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[261.690192] Starting dynamic subtest: pipe-C-eDP-1
[261.736430] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[261.745386] Starting dynamic subtest: pipe-D-eDP-1
[261.791703] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[261.795433] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.009s)
[263.807436] [054/133] (758s left) gen9_exec_parse (allowed-single)
[263.882065] Subtest allowed-single: SKIP (0.000s)
[263.978958] [055/133] (758s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[264.088768] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[271.164449] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.078s)
[271.304295] [056/133] (751s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[271.407054] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[271.411376] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[271.544041] [057/133] (750s left) gem_exec_fence (expired-history)
[272.043581] Starting subtest: expired-history
[279.281464] Subtest expired-history: SUCCESS (7.238s)
[279.892638] [058/133] (742s left) kms_psr (fbc-psr-sprite-plane-move)
[279.998240] Starting subtest: fbc-psr-sprite-plane-move
[280.000540] Starting dynamic subtest: eDP-1
[280.004768] Dynamic subtest eDP-1: SKIP (0.000s)
[280.009097] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[280.097252] [059/133] (742s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[280.208333] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[286.972769] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.768s)
[287.154484] [060/133] (735s left) gem_ctx_bad_destroy (double-destroy)
[287.213542] Starting subtest: double-destroy
[287.215841] Subtest double-destroy: SUCCESS (0.000s)
[287.334533] [061/133] (735s left) syncobj_timeline (invalid-signal-illegal-handle)
[287.398082] Starting subtest: invalid-signal-illegal-handle
[287.399970] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[287.531616] [062/133] (735s left) kms_chamelium_hpd (common-hpd-after-suspend)
[287.910652] Subtest common-hpd-after-suspend: SKIP (0.000s)
[288.716940] [063/133] (734s left) kms_frontbuffer_tracking (fbc-tiling-4)
[288.825582] Starting subtest: fbc-tiling-4
[293.024414] Subtest fbc-tiling-4: SUCCESS (4.201s)
[294.262405] [064/133] (728s left) gem_cs_tlb (engines)
[294.326980] Starting subtest: engines
[294.329375] Starting dynamic subtest: rcs0
[296.482166] Dynamic subtest rcs0: SUCCESS (2.152s)
[296.491393] Starting dynamic subtest: bcs0
[298.635999] Dynamic subtest bcs0: SUCCESS (2.152s)
[298.647777] Starting dynamic subtest: vcs0
[300.787812] Dynamic subtest vcs0: SUCCESS (2.151s)
[300.799652] Starting dynamic subtest: vcs1
[302.940932] Dynamic subtest vcs1: SUCCESS (2.152s)
[302.952399] Starting dynamic subtest: vecs0
[305.094589] Dynamic subtest vecs0: SUCCESS (2.152s)
[305.104057] Starting dynamic subtest: ccs0
[307.248239] Dynamic subtest ccs0: SUCCESS (2.153s)
[307.250446] Subtest engines: SUCCESS (12.917s)
[307.397585] [065/133] (715s left) gem_mmap_gtt (hang-busy)
[307.469447] Subtest hang-busy: SKIP (0.000s)
[307.541910] [066/133] (715s left) kms_psr (psr2-sprite-plane-onoff)
[307.645398] Starting subtest: psr2-sprite-plane-onoff
[307.647692] Starting dynamic subtest: eDP-1
[309.444632] Dynamic subtest eDP-1: SUCCESS (1.798s)
[309.446892] Subtest psr2-sprite-plane-onoff: SUCCESS (1.799s)
[310.302010] [067/133] (712s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[310.407614] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[311.009453] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.603s)
[311.225218] [068/133] (711s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[311.320837] Starting subtest: y-tiled-64bpp-rotate-270
[311.324952] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[311.457051] [069/133] (711s left) gem_bad_reloc (negative-reloc-lut)
[311.515179] Subtest negative-reloc-lut: SKIP (0.000s)
[311.604697] [070/133] (711s left) gem_ctx_persistence (engines-mixed)
[311.685700] Starting subtest: engines-mixed
[311.688165] Starting dynamic subtest: rcs0
[311.817248] Dynamic subtest rcs0: SUCCESS (0.131s)
[311.829158] Starting dynamic subtest: bcs0
[311.904551] Dynamic subtest bcs0: SUCCESS (0.085s)
[311.917573] Starting dynamic subtest: vcs0
[311.971008] Dynamic subtest vcs0: SUCCESS (0.065s)
[311.982119] Starting dynamic subtest: vcs1
[312.047167] Dynamic subtest vcs1: SUCCESS (0.074s)
[312.058889] Starting dynamic subtest: vecs0
[312.116032] Dynamic subtest vecs0: SUCCESS (0.067s)
[312.128427] Starting dynamic subtest: ccs0
[312.201198] Dynamic subtest ccs0: SUCCESS (0.083s)
[312.203545] Subtest engines-mixed: SUCCESS (0.517s)
[312.306966] [071/133] (710s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[312.405920] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[312.407943] Starting dynamic subtest: pipe-A
[312.471175] Dynamic subtest pipe-A: SUCCESS (0.066s)
[312.480653] Starting dynamic subtest: pipe-B
[313.599193] Dynamic subtest pipe-B: SUCCESS (1.125s)
[313.615182] Starting dynamic subtest: pipe-C
[314.707627] Dynamic subtest pipe-C: SUCCESS (1.106s)
[314.723709] Starting dynamic subtest: pipe-D
[315.857197] Dynamic subtest pipe-D: SUCCESS (1.147s)
[315.859876] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.453s)
[317.034563] [072/133] (706s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[317.148036] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[317.152214] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[317.281792] [073/133] (705s left) gem_exec_schedule (semaphore-noskip)
[317.360575] Starting subtest: semaphore-noskip
[317.767285] Subtest semaphore-noskip: SUCCESS (0.414s)
[318.154075] [074/133] (705s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[318.244451] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[318.248597] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[318.377506] [075/133] (704s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[318.487543] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[318.491977] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[318.623114] [076/133] (704s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[318.727586] Starting subtest: 4-tiled-16bpp-rotate-0
[320.086933] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.358s)
[320.246452] [077/133] (703s left) gem_exec_basic (basic)
[320.314003] Starting subtest: basic
[320.315667] Starting dynamic subtest: rcs0-smem
[320.317657] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[320.328432] Starting dynamic subtest: bcs0-smem
[320.330143] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[320.341095] Starting dynamic subtest: vcs0-smem
[320.342948] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[320.351505] Starting dynamic subtest: vcs1-smem
[320.353317] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[320.361834] Starting dynamic subtest: vecs0-smem
[320.363675] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[320.372152] Starting dynamic subtest: ccs0-smem
[320.374028] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[320.375846] Subtest basic: SUCCESS (0.019s)
[321.597757] [078/133] (701s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[321.708706] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[321.712670] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[321.847118] [079/133] (701s left) gem_mmap (short-mmap)
[321.905421] Subtest short-mmap: SKIP (0.000s)
[321.976424] [080/133] (701s left) gem_exec_reloc (basic-gtt-wc-active)
[322.049231] Subtest basic-gtt-wc-active: SKIP (0.000s)
[322.146478] [081/133] (701s left) gem_ctx_shared (create-shared-gtt)
[322.209784] Starting subtest: create-shared-gtt
[324.363634] Subtest create-shared-gtt: SUCCESS (2.153s)
[324.759071] [082/133] (698s left) gem_exec_reloc (basic-write-wc)
[324.825489] Subtest basic-write-wc: SKIP (0.000s)
[324.904706] [083/133] (698s left) gem_eio (wait-immediate)
[325.160469] Starting subtest: wait-immediate
[325.577381] Subtest wait-immediate: SUCCESS (0.417s)
[325.764159] [084/133] (697s left) gem_ctx_persistence (legacy-engines-mixed)
[325.828275] Starting subtest: legacy-engines-mixed
[325.830396] Starting dynamic subtest: render
[325.958433] Dynamic subtest render: SUCCESS (0.129s)
[325.973745] Starting dynamic subtest: bsd1
[326.003596] Dynamic subtest bsd1: SUCCESS (0.043s)
[326.016597] Starting dynamic subtest: bsd2
[326.079169] Dynamic subtest bsd2: SUCCESS (0.073s)
[326.091308] Starting dynamic subtest: blt
[326.150580] Dynamic subtest blt: SUCCESS (0.069s)
[326.164940] Starting dynamic subtest: vebox
[326.231066] Dynamic subtest vebox: SUCCESS (0.077s)
[326.233725] Subtest legacy-engines-mixed: SUCCESS (0.404s)
[326.334796] [085/133] (697s left) perf_pmu (semaphore-busy)
[326.373134] Starting subtest: semaphore-busy
[326.375169] Starting dynamic subtest: rcs0
[328.025692] Dynamic subtest rcs0: SUCCESS (1.648s)
[328.038027] Starting dynamic subtest: bcs0
[329.656547] Dynamic subtest bcs0: SUCCESS (1.629s)
[329.668065] Starting dynamic subtest: vcs0
[334.064532] Dynamic subtest vcs0: SUCCESS (4.406s)
[334.075953] Starting dynamic subtest: vcs1
[340.016252] Dynamic subtest vcs1: SUCCESS (5.949s)
[340.028024] Starting dynamic subtest: vecs0
[346.032606] Dynamic subtest vecs0: SUCCESS (6.013s)
[346.044757] Starting dynamic subtest: ccs0
[349.108340] Dynamic subtest ccs0: SUCCESS (3.073s)
[349.110703] Subtest semaphore-busy: SUCCESS (22.734s)
[349.252012] [086/133] (674s left) gem_exec_schedule (pi-common)
[349.460064] Starting subtest: pi-common
[349.462173] Starting dynamic subtest: rcs0
[349.501902] Dynamic subtest rcs0: SUCCESS (0.044s)
[349.516309] Starting dynamic subtest: bcs0
[349.547079] Dynamic subtest bcs0: SUCCESS (0.044s)
[349.562743] Starting dynamic subtest: vcs0
[349.589546] Dynamic subtest vcs0: SUCCESS (0.041s)
[349.609241] Starting dynamic subtest: vcs1
[349.627379] Dynamic subtest vcs1: SUCCESS (0.037s)
[349.643047] Starting dynamic subtest: vecs0
[349.661238] Dynamic subtest vecs0: SUCCESS (0.033s)
[349.671024] Starting dynamic subtest: ccs0
[349.695171] Dynamic subtest ccs0: SUCCESS (0.033s)
[349.697393] Subtest pi-common: SUCCESS (0.238s)
[349.964214] [087/133] (673s left) i915_hangman (engine-error-state-capture)
[350.028927] Starting subtest: engine-error-state-capture
[350.031546] Starting dynamic subtest: rcs0
[353.492190] Dynamic subtest rcs0: SUCCESS (3.463s)
[353.507267] Starting dynamic subtest: bcs0
[359.507027] Dynamic subtest bcs0: SUCCESS (6.013s)
[359.519397] Starting dynamic subtest: vcs0
[365.460074] Dynamic subtest vcs0: SUCCESS (5.950s)
[365.474377] Starting dynamic subtest: vcs1
[370.515881] Dynamic subtest vcs1: SUCCESS (5.053s)
[370.528774] Starting dynamic subtest: vecs0
[376.468932] Dynamic subtest vecs0: SUCCESS (5.950s)
[376.488568] Starting dynamic subtest: ccs0
[382.421360] Dynamic subtest ccs0: SUCCESS (5.950s)
[382.424368] Subtest engine-error-state-capture: SUCCESS (32.394s)
[382.538119] [088/133] (641s left) syncobj_timeline (wait-for-submit-snapshot)
[382.605885] Starting subtest: wait-for-submit-snapshot
[382.687472] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[382.802510] [089/133] (641s left) kms_color (ctm-blue-to-red)
[382.901365] Starting subtest: ctm-blue-to-red
[382.903785] Starting dynamic subtest: pipe-A-eDP-1
[383.590251] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.688s)
[383.600851] Starting dynamic subtest: pipe-B-eDP-1
[385.013140] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.424s)
[385.028017] Starting dynamic subtest: pipe-C-eDP-1
[386.388701] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.374s)
[386.405027] Starting dynamic subtest: pipe-D-eDP-1
[387.671930] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.283s)
[387.674392] Subtest ctm-blue-to-red: SUCCESS (4.773s)
[388.544763] [090/133] (635s left) prime_vgem (basic-gtt)
[388.625396] Starting subtest: basic-gtt
[388.629713] Subtest basic-gtt: SKIP (0.000s)
[388.757535] [091/133] (635s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[388.847264] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[396.393986] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.550s)
[396.582225] [092/133] (627s left) api_intel_allocator (default-alignment)
[396.641381] Starting subtest: default-alignment
[396.643627] Subtest default-alignment: SUCCESS (0.003s)
[396.796812] [093/133] (627s left) i915_pm_rps (fence-order)
[396.860168] Starting subtest: fence-order
[400.329378] Subtest fence-order: SUCCESS (3.469s)
[400.471666] [094/133] (623s left) kms_vblank (query-busy)
[400.569329] Starting subtest: query-busy
[400.571615] Starting dynamic subtest: pipe-A-eDP-1
[402.446666] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.878s)
[402.462736] Starting dynamic subtest: pipe-D-eDP-1
[405.021498] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.572s)
[405.023856] Subtest query-busy: SUCCESS (4.454s)
[405.850626] [095/133] (618s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[405.963909] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[405.968374] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[406.092955] [096/133] (618s left) kms_addfb_basic (invalid-get-prop-any)
[406.150622] Starting subtest: invalid-get-prop-any
[406.152742] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[406.323157] [097/133] (617s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[406.413248] Starting subtest: fbc-psr2-cursor-mmap-gtt
[406.415553] Starting dynamic subtest: eDP-1
[406.419953] Dynamic subtest eDP-1: SKIP (0.000s)
[406.424420] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[406.514234] [098/133] (617s left) kms_flip (2x-blocking-absolute-wf_vblank)
[406.610804] Starting subtest: 2x-blocking-absolute-wf_vblank
[406.622373] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.011s)
[406.724188] [099/133] (617s left) kms_cursor_crc (cursor-onscreen-256x85)
[406.985602] Starting subtest: cursor-onscreen-256x85
[407.033434] Subtest cursor-onscreen-256x85: SKIP (0.043s)
[407.250774] [100/133] (617s left) kms_flip (2x-modeset-vs-vblank-race)
[407.337807] Starting subtest: 2x-modeset-vs-vblank-race
[407.349204] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[407.455691] [101/133] (616s left) kms_atomic_interruptible (atomic-setmode)
[407.558296] Starting subtest: atomic-setmode
[407.560276] Starting dynamic subtest: pipe-A-eDP-1
[414.469201] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.909s)
[414.471496] Subtest atomic-setmode: SUCCESS (6.910s)
[415.356634] [102/133] (609s left) kms_frontbuffer_tracking (psr-argb161616f-draw-render)
[415.464169] Starting subtest: psr-argb161616f-draw-render
[415.468107] Subtest psr-argb161616f-draw-render: SKIP (0.000s)
[415.604192] [103/133] (608s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[415.699886] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[415.703963] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[415.832814] [104/133] (608s left) kms_plane_scaling (invalid-num-scalers)
[415.918466] Starting subtest: invalid-num-scalers
[415.920732] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[415.937236] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.019s)
[415.947371] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[415.971514] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.033s)
[415.981565] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[416.005884] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.033s)
[416.015543] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[416.039144] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.033s)
[416.041829] Subtest invalid-num-scalers: SUCCESS (0.123s)
[416.181422] [105/133] (608s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[416.285789] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[416.289261] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[416.405746] [106/133] (608s left) sw_sync (alloc_fence_invalid_timeline)
[416.440704] Starting subtest: alloc_fence_invalid_timeline
[416.442536] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[416.518723] [107/133] (608s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[416.585095] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[416.690326] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.103s)
[416.790589] [108/133] (607s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[416.888196] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[416.890610] Starting dynamic subtest: A-eDP1
[425.776869] Dynamic subtest A-eDP1: SUCCESS (8.888s)
[425.788055] Starting dynamic subtest: B-eDP1
[434.709100] Dynamic subtest B-eDP1: SUCCESS (8.930s)
[434.722478] Starting dynamic subtest: C-eDP1
[443.629643] Dynamic subtest C-eDP1: SUCCESS (8.916s)
[443.639607] Starting dynamic subtest: D-eDP1
[452.550583] Dynamic subtest D-eDP1: SUCCESS (8.919s)
[452.552941] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.664s)
[453.803155] [109/133] (570s left) kms_addfb_basic (size-max)
[453.906284] Starting subtest: size-max
[453.908554] Subtest size-max: SUCCESS (0.000s)
[454.045377] [110/133] (570s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[454.297583] Starting subtest: cursor-rapid-movement-256x256
[454.299845] Starting dynamic subtest: pipe-A-eDP-1
[454.828576] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.529s)
[454.859547] Starting dynamic subtest: pipe-D-eDP-1
[456.097396] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.247s)
[456.099534] Subtest cursor-rapid-movement-256x256: SUCCESS (1.803s)
[456.969253] [111/133] (567s left) gem_exec_whisper (basic-queues-all)
[457.044081] Starting subtest: basic-queues-all
[465.472027] Subtest basic-queues-all: SUCCESS (8.424s)
[465.680742] [112/133] (559s left) kms_dsc (dsc-fractional-bpp)
[465.784243] Starting subtest: dsc-fractional-bpp
[465.797183] Subtest dsc-fractional-bpp: SKIP (0.000s)
[465.872002] [113/133] (559s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[465.968211] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[465.970446] Starting dynamic subtest: pipe-A-default-mode
[466.258748] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[466.263549] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.288s)
[467.096551] [114/133] (557s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[467.195141] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[467.199529] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[467.344584] [115/133] (557s left) gem_softpin (evict-prime)
[467.418740] Starting subtest: evict-prime
[467.421000] Starting dynamic subtest: rcs0
[468.618505] Dynamic subtest rcs0: SUCCESS (1.200s)
[468.636585] Starting dynamic subtest: bcs0
[469.757519] Dynamic subtest bcs0: SUCCESS (1.136s)
[469.769499] Starting dynamic subtest: vcs0
[471.508783] Dynamic subtest vcs0: SUCCESS (1.747s)
[471.519224] Starting dynamic subtest: vcs1
[473.490186] Dynamic subtest vcs1: SUCCESS (1.977s)
[473.502946] Starting dynamic subtest: vecs0
[475.543931] Dynamic subtest vecs0: SUCCESS (2.052s)
[475.555838] Starting dynamic subtest: ccs0
[476.676588] Dynamic subtest ccs0: SUCCESS (1.131s)
[476.692915] Starting dynamic subtest: all
[478.500932] Dynamic subtest all: SUCCESS (1.820s)
[478.503920] Subtest evict-prime: SUCCESS (11.081s)
[478.669602] [116/133] (546s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[478.789696] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[478.794093] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[478.895087] [117/133] (546s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[478.992428] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[479.111919] [118/133] (545s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[479.177338] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[479.282609] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.105s)
[479.383730] [119/133] (545s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[479.485223] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[479.489634] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[479.619585] [120/133] (545s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[479.730695] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[483.884287] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.157s)
[485.085195] [121/133] (540s left) gem_mmap_wc (bad-size)
[485.146698] Subtest bad-size: SKIP (0.000s)
[485.213095] [122/133] (540s left) kms_hdr (static-toggle-suspend)
[485.306553] Starting subtest: static-toggle-suspend
[485.312794] Subtest static-toggle-suspend: SKIP (0.000s)
[485.405211] [123/133] (539s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[485.511836] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[485.515905] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[485.636058] [124/133] (539s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[490.631504] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[490.633872] Starting dynamic subtest: pipe-A-eDP-1
[491.423599] Dynamic subtest pipe-A-eDP-1: SKIP (0.788s)
[491.435023] Starting dynamic subtest: pipe-B-eDP-1
[492.557879] Dynamic subtest pipe-B-eDP-1: SKIP (1.133s)
[492.562418] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.925s)
[493.759330] [125/133] (531s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[493.862362] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[493.866825] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[494.013039] [126/133] (531s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[494.102306] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[494.104458] Starting dynamic subtest: pipe-A-eDP-1
[494.123955] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[494.135751] Starting dynamic subtest: pipe-B-eDP-1
[494.154472] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[494.164366] Starting dynamic subtest: pipe-C-eDP-1
[494.182919] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[494.192781] Starting dynamic subtest: pipe-D-eDP-1
[494.211276] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[494.213419] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[496.326529] [127/133] (529s left) syncobj_timeline (single-wait-all-available-submitted)
[496.385655] Starting subtest: single-wait-all-available-submitted
[496.387899] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[496.502716] [128/133] (529s left) gem_exec_parallel (userptr)
[496.560048] Starting subtest: userptr
[496.562333] Starting dynamic subtest: rcs0
[498.022148] Dynamic subtest rcs0: SUCCESS (1.461s)
[498.034400] Starting dynamic subtest: bcs0
[499.506675] Dynamic subtest bcs0: SUCCESS (1.483s)
[499.516737] Starting dynamic subtest: vcs0
[501.495227] Dynamic subtest vcs0: SUCCESS (1.986s)
[501.507702] Starting dynamic subtest: vcs1
[503.541898] Dynamic subtest vcs1: SUCCESS (2.044s)
[503.552791] Starting dynamic subtest: vecs0
[505.461614] Dynamic subtest vecs0: SUCCESS (1.917s)
[505.472000] Starting dynamic subtest: ccs0
[506.949902] Dynamic subtest ccs0: SUCCESS (1.487s)
[506.952541] Subtest userptr: SUCCESS (10.391s)
[507.160483] [129/133] (518s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[507.269182] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[507.273415] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[507.381565] [130/133] (518s left) i915_selftest (mock)
[509.471310] Starting subtest: mock
[509.473964] Starting dynamic subtest: sanitycheck
[510.234543] Dynamic subtest sanitycheck: SUCCESS (0.764s)
[510.250110] Starting dynamic subtest: shmem
[510.990672] Dynamic subtest shmem: SUCCESS (0.754s)
[511.007373] Starting dynamic subtest: fence
[518.746155] Dynamic subtest fence: SUCCESS (7.744s)
[518.756962] Starting dynamic subtest: scatterlist
[520.499718] Dynamic subtest scatterlist: SUCCESS (1.760s)
[520.510008] Starting dynamic subtest: syncmap
[523.762361] Dynamic subtest syncmap: SUCCESS (3.260s)
[523.778227] Starting dynamic subtest: uncore
[524.491985] Dynamic subtest uncore: SUCCESS (0.727s)
[524.501367] Starting dynamic subtest: ring
[525.234530] Dynamic subtest ring: SUCCESS (0.741s)
[525.244069] Starting dynamic subtest: engine
[525.976563] Dynamic subtest engine: SUCCESS (0.740s)
[525.986393] Starting dynamic subtest: timelines
[529.849225] Dynamic subtest timelines: SUCCESS (3.866s)
[529.859273] Starting dynamic subtest: requests
[533.332398] Dynamic subtest requests: SUCCESS (3.484s)
[533.342054] Starting dynamic subtest: objects
[534.164890] Dynamic subtest objects: SUCCESS (0.831s)
[534.174552] Starting dynamic subtest: phys
[535.003932] Dynamic subtest phys: SUCCESS (0.837s)
[535.014121] Starting dynamic subtest: dmabuf
[535.843771] Dynamic subtest dmabuf: SUCCESS (0.837s)
[535.853691] Starting dynamic subtest: vma
[541.303066] Dynamic subtest vma: SUCCESS (5.457s)
[541.318710] Starting dynamic subtest: evict
[542.772297] Dynamic subtest evict: SUCCESS (1.467s)
[542.781727] Starting dynamic subtest: gtt
[546.133234] Dynamic subtest gtt: SUCCESS (3.359s)
[546.143164] Starting dynamic subtest: hugepages
[547.146953] Dynamic subtest hugepages: SUCCESS (1.012s)
[547.156642] Starting dynamic subtest: memory_region
[549.921339] Dynamic subtest memory_region: SUCCESS (2.771s)
[549.924052] Subtest mock: SUCCESS (40.449s)
[549.953905] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[549.954585] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[549.957765] [131/133] (475s left) gem_mmap_gtt (basic-write-read)
[551.536376] Subtest basic-write-read: SKIP (0.000s)
[551.604656] [FACT gem_mmap_gtt (basic-write-read)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[551.605981] [FACT gem_mmap_gtt (basic-write-read)] new: kernel.kmod_is_loaded.i915: true
[551.610567] [132/133] (474s left) perf (gen12-group-exclusive-stream-sample-oa)
[551.760543] Starting subtest: gen12-group-exclusive-stream-sample-oa
[551.780963] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.020s)
[551.822944] [133/133] (473s left) perf_pmu (busy-double-start)
[551.865803] Starting subtest: busy-double-start
[551.868113] Starting dynamic subtest: rcs0
[555.511091] Dynamic subtest rcs0: FAIL (3.592s)
[555.522009] Starting dynamic subtest: bcs0
[559.063005] Dynamic subtest bcs0: SUCCESS (3.604s)
[559.074218] Starting dynamic subtest: vcs0
[563.071066] Dynamic subtest vcs0: SUCCESS (4.006s)
[563.080972] Starting dynamic subtest: vcs1
[567.077441] Dynamic subtest vcs1: SUCCESS (4.003s)
[567.088943] Starting dynamic subtest: vecs0
[571.103226] Dynamic subtest vecs0: SUCCESS (4.023s)
[571.113693] Starting dynamic subtest: ccs0
[574.736264] Dynamic subtest ccs0: FAIL (3.565s)
[574.738142] Subtest busy-double-start: FAIL (22.805s)
[574.814902] 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.