[60.251276] Initializing watchdogs
[60.251409]   /dev/watchdog0
[60.267115] [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]
[60.271536] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.274788] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.278230] [001/133] (960s left) gem_partial_pwrite_pread (write-snoop)
[60.366219] Subtest write-snoop: SKIP (0.000s)
[60.434516] [002/133] (960s left) kms_content_protection (content-type-change)
[60.566037] Starting subtest: content-type-change
[60.571154] Subtest content-type-change: SKIP (0.000s)
[60.709997] [003/133] (960s left) kms_rotation_crc (multiplane-rotation)
[60.801322] Starting subtest: multiplane-rotation
[78.203383] Subtest multiplane-rotation: SUCCESS (17.403s)
[78.341722] [004/133] (942s left) kms_chamelium_color (ctm-red-to-blue)
[78.447621] Subtest ctm-red-to-blue: SKIP (0.000s)
[78.505768] [005/133] (942s left) syncobj_wait (invalid-reset-one-illegal-handle)
[78.560083] Starting subtest: invalid-reset-one-illegal-handle
[78.562070] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[78.703313] [006/133] (942s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[78.795766] Starting subtest: disable-crc-after-crtc
[78.797580] Starting dynamic subtest: pipe-A-eDP-1
[80.408201] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.612s)
[80.417405] Starting dynamic subtest: pipe-B-eDP-1
[82.697189] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.287s)
[82.704585] Starting dynamic subtest: pipe-C-eDP-1
[84.932285] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.234s)
[84.940849] Starting dynamic subtest: pipe-D-eDP-1
[87.194994] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.261s)
[87.197303] Subtest disable-crc-after-crtc: SUCCESS (8.398s)
[88.049225] [007/133] (932s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[88.119612] Subtest tiled-to-tiled: SKIP (0.000s)
[88.201416] [008/133] (932s left) syncobj_wait (wait-all-interrupted)
[88.262052] Starting subtest: wait-all-interrupted
[88.365134] Subtest wait-all-interrupted: SUCCESS (0.103s)
[88.460188] [009/133] (932s left) syncobj_wait (wait-all-complex)
[88.530866] Starting subtest: wait-all-complex
[88.744811] Subtest wait-all-complex: SUCCESS (0.214s)
[88.841038] [010/133] (932s left) gem_pxp (reject-modify-context-protection-on)
[88.976849] Starting subtest: reject-modify-context-protection-on
[88.979453] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[89.101922] [011/133] (932s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[89.226637] Starting subtest: cursorA-vs-flipB-varying-size
[89.231427] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[89.393107] [012/133] (931s left) kms_rotation_crc (primary-rotation-90)
[89.492952] Starting subtest: primary-rotation-90
[89.497388] Subtest primary-rotation-90: SKIP (0.001s)
[89.588269] [013/133] (931s left) syncobj_wait (reset-multiple-signaled)
[89.647465] Starting subtest: reset-multiple-signaled
[89.649719] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[89.784543] [014/133] (931s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[89.891465] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[89.895443] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[91.086329] [015/133] (930s left) gem_softpin (noreloc-s3)
[91.163632] Starting subtest: noreloc-S3
[111.407228] Subtest noreloc-S3: SUCCESS (5.383s)
[111.571766] [016/133] (909s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[111.702878] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[116.149014] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.449s)
[117.298544] [017/133] (904s left) gem_ctx_param (invalid-ctx-set)
[117.350971] Starting subtest: invalid-ctx-set
[117.353598] Subtest invalid-ctx-set: SUCCESS (0.001s)
[117.474373] [018/133] (903s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[117.531525] Starting subtest: single-wait-all-for-submit-unsubmitted
[117.636699] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[117.730736] [019/133] (903s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[117.838554] Starting subtest: x-tiled-64bpp-rotate-90
[117.858663] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[118.014747] [020/133] (903s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[118.068486] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[118.129570] [021/133] (903s left) kms_psr (fbc-psr-cursor-plane-move)
[118.222470] Starting subtest: fbc-psr-cursor-plane-move
[118.224325] Starting dynamic subtest: eDP-1
[118.228209] Dynamic subtest eDP-1: SKIP (0.000s)
[118.232209] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[118.315032] [022/133] (903s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[118.417743] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[119.384731] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.967s)
[119.542496] [023/133] (902s left) kms_flip (2x-flip-vs-rmfb)
[119.646520] Starting subtest: 2x-flip-vs-rmfb
[119.654507] Subtest 2x-flip-vs-rmfb: SKIP (0.010s)
[119.794712] [024/133] (901s left) kms_plane_cursor (viewport)
[119.885215] Starting subtest: viewport
[119.889033] Starting dynamic subtest: pipe-A-eDP-1-size-64
[122.440782] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.553s)
[122.500827] Starting dynamic subtest: pipe-A-eDP-1-size-128
[124.965355] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.471s)
[125.024816] Starting dynamic subtest: pipe-A-eDP-1-size-256
[127.522534] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.504s)
[127.869498] Starting dynamic subtest: pipe-B-eDP-1-size-64
[131.039198] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.178s)
[131.098385] Starting dynamic subtest: pipe-B-eDP-1-size-128
[133.564055] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.471s)
[133.622122] Starting dynamic subtest: pipe-B-eDP-1-size-256
[136.124541] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.504s)
[136.472027] Starting dynamic subtest: pipe-C-eDP-1-size-64
[139.357774] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.895s)
[139.392782] Starting dynamic subtest: pipe-C-eDP-1-size-128
[141.590393] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.204s)
[141.626252] Starting dynamic subtest: pipe-C-eDP-1-size-256
[143.788213] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.169s)
[144.116802] Starting dynamic subtest: pipe-D-eDP-1-size-64
[146.997977] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.892s)
[147.034392] Starting dynamic subtest: pipe-D-eDP-1-size-128
[149.174958] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.146s)
[149.212183] Starting dynamic subtest: pipe-D-eDP-1-size-256
[151.475752] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.269s)
[151.792427] Subtest viewport: SUCCESS (31.906s)
[152.614902] [025/133] (869s left) kms_cdclk (mode-transition)
[152.712641] Starting subtest: mode-transition
[152.714898] Starting dynamic subtest: pipe-A-eDP-1
[153.008954] Dynamic subtest pipe-A-eDP-1: SKIP (0.292s)
[153.018533] Starting dynamic subtest: pipe-B-eDP-1
[153.023165] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[153.031070] Starting dynamic subtest: pipe-C-eDP-1
[153.035701] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[153.043452] Starting dynamic subtest: pipe-D-eDP-1
[153.047505] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[153.051463] Subtest mode-transition: SKIP (0.299s)
[153.835856] [026/133] (867s left) gem_exec_balancer (fairslice)
[153.891880] Starting subtest: fairslice
[156.764116] Subtest fairslice: SUCCESS (2.871s)
[157.854858] [027/133] (863s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[157.995071] Starting subtest: basic-flip-before-cursor-varying-size
[158.939537] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.946s)
[159.787218] [028/133] (862s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[159.880486] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[159.882827] Starting dynamic subtest: pipe-A-default-mode
[160.181431] Dynamic subtest pipe-A-default-mode: SKIP (0.297s)
[160.186065] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.299s)
[161.008874] [029/133] (860s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[161.104496] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[161.106757] Starting dynamic subtest: pipe-A-default-mode
[163.841279] Dynamic subtest pipe-A-default-mode: SUCCESS (2.736s)
[163.843796] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.738s)
[164.698481] [030/133] (857s left) core_getstats (basic)
[164.769656] Starting subtest: basic
[164.771966] Subtest basic: SUCCESS (0.000s)
[164.901127] [031/133] (857s left) kms_rmfb (close-fd)
[164.996720] Starting subtest: close-fd
[164.998999] Starting dynamic subtest: pipe-A-eDP-1
[165.105182] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[165.118048] Starting dynamic subtest: pipe-B-eDP-1
[166.250724] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.145s)
[166.259929] Starting dynamic subtest: pipe-C-eDP-1
[167.377151] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.127s)
[167.385775] Starting dynamic subtest: pipe-D-eDP-1
[168.509486] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[168.511882] Subtest close-fd: SUCCESS (3.513s)
[169.745654] [032/133] (852s left) gem_exec_reloc (basic-gtt-wc)
[169.811467] Subtest basic-gtt-wc: SKIP (0.000s)
[169.873329] [033/133] (852s left) kms_properties (crtc-properties-legacy)
[169.972411] Starting subtest: crtc-properties-legacy
[169.974648] Starting dynamic subtest: pipe-A-eDP-1
[170.416413] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.442s)
[170.428390] Starting dynamic subtest: pipe-B-eDP-1
[171.600762] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.183s)
[171.609414] Starting dynamic subtest: pipe-C-eDP-1
[172.720195] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.120s)
[172.733148] Starting dynamic subtest: pipe-D-eDP-1
[173.847670] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.126s)
[173.850003] Subtest crtc-properties-legacy: SUCCESS (3.877s)
[174.679266] [034/133] (847s left) kms_invalid_mode (zero-hdisplay)
[174.784472] Starting subtest: zero-hdisplay
[174.786685] Starting dynamic subtest: pipe-A-eDP-1
[175.072453] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[175.083871] Starting dynamic subtest: pipe-B-eDP-1
[175.085955] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[175.093958] Starting dynamic subtest: pipe-C-eDP-1
[175.096348] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[175.104376] Starting dynamic subtest: pipe-D-eDP-1
[175.106636] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[175.108991] Subtest zero-hdisplay: SUCCESS (0.295s)
[175.916130] [035/133] (846s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[176.015084] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[176.017325] Starting dynamic subtest: pipe-A
[177.062803] Dynamic subtest pipe-A: SUCCESS (1.050s)
[177.071915] Starting dynamic subtest: pipe-B
[179.212423] Dynamic subtest pipe-B: SUCCESS (2.149s)
[179.220213] Starting dynamic subtest: pipe-C
[180.394715] Dynamic subtest pipe-C: SUCCESS (1.180s)
[180.403931] Starting dynamic subtest: pipe-D
[181.555878] Dynamic subtest pipe-D: SUCCESS (1.160s)
[181.558249] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.544s)
[182.758175] [036/133] (839s left) kms_pm_rpm (legacy-planes-dpms)
[184.985989] Starting subtest: legacy-planes-dpms
[184.987950] Starting dynamic subtest: plane-63
[193.549788] Dynamic subtest plane-63: SUCCESS (8.569s)
[193.561527] Starting dynamic subtest: plane-93
[201.844022] Dynamic subtest plane-93: SUCCESS (8.292s)
[201.855025] Starting dynamic subtest: plane-123
[210.443696] Dynamic subtest plane-123: SUCCESS (8.596s)
[210.455460] Starting dynamic subtest: plane-133
[219.070785] Dynamic subtest plane-133: SUCCESS (8.623s)
[219.073884] Subtest legacy-planes-dpms: SUCCESS (34.093s)
[219.469825] [037/133] (802s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[219.583986] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[219.588511] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[219.715248] [038/133] (802s left) kms_dirtyfb (default-dirtyfb-ioctl)
[219.821376] Starting subtest: default-dirtyfb-ioctl
[219.823692] Starting dynamic subtest: A-eDP-1
[221.415451] Dynamic subtest A-eDP-1: SUCCESS (1.595s)
[221.417787] Subtest default-dirtyfb-ioctl: SUCCESS (1.597s)
[222.302050] [039/133] (799s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[222.420007] Starting subtest: cursorB-vs-flipA-legacy
[222.424625] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[222.589451] [040/133] (799s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[222.654460] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[222.656784] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[222.786721] [041/133] (799s left) kms_prime (basic-crc-vgem)
[222.910854] Starting subtest: basic-crc-vgem
[222.913094] Starting dynamic subtest: second-to-first
[223.800238] Dynamic subtest second-to-first: SUCCESS (0.891s)
[223.802153] Subtest basic-crc-vgem: SUCCESS (0.892s)
[223.924733] [FACT kms_prime (basic-crc-vgem)] new: kernel.kmod_is_loaded.vgem: true
[223.928092] [042/133] (798s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[224.040892] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[224.111021] [043/133] (798s left) i915_drm_fdinfo (busy)
[224.147933] Starting subtest: busy
[224.149858] Starting dynamic subtest: rcs0
[224.183379] Dynamic subtest rcs0: SKIP (0.036s)
[224.193737] Starting dynamic subtest: bcs0
[224.197311] Dynamic subtest bcs0: SKIP (0.000s)
[224.204797] Starting dynamic subtest: vcs0
[224.208181] Dynamic subtest vcs0: SKIP (0.000s)
[224.215750] Starting dynamic subtest: vcs1
[224.219354] Dynamic subtest vcs1: SKIP (0.000s)
[224.226716] Starting dynamic subtest: vecs0
[224.230375] Dynamic subtest vecs0: SKIP (0.000s)
[224.237749] Starting dynamic subtest: ccs0
[224.241289] Dynamic subtest ccs0: SKIP (0.000s)
[224.244908] Subtest busy: SKIP (0.041s)
[224.278242] [044/133] (798s left) gem_userptr_blits (nohangcheck)
[224.363122] Starting subtest: nohangcheck
[224.629972] Subtest nohangcheck: SUCCESS (0.266s)
[224.789383] [045/133] (797s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[224.901574] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[225.492124] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.592s)
[225.690504] [046/133] (796s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[225.784443] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[225.788848] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[226.927189] [047/133] (795s left) kms_scaling_modes (scaling-mode-full)
[227.031531] Starting subtest: scaling-mode-full
[227.033751] Starting dynamic subtest: pipe-A-eDP-1
[227.124941] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.095s)
[227.133865] Starting dynamic subtest: pipe-B-eDP-1
[228.330190] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.204s)
[228.338557] Starting dynamic subtest: pipe-C-eDP-1
[229.437178] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.105s)
[229.445418] Starting dynamic subtest: pipe-D-eDP-1
[230.570418] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.132s)
[230.572527] Subtest scaling-mode-full: SUCCESS (3.542s)
[231.858640] [048/133] (790s left) kms_psr (fbc-pr-basic)
[231.958409] Starting subtest: fbc-pr-basic
[231.962430] Subtest fbc-pr-basic: SKIP (0.000s)
[232.052671] [049/133] (790s left) gem_ringfill (basic-all)
[237.797288] Starting subtest: basic-all
[238.961555] Subtest basic-all: SUCCESS (1.165s)
[239.137580] [050/133] (783s left) gem_exec_whisper (basic-fds-forked-all)
[239.204545] Starting subtest: basic-fds-forked-all
[261.104778] Subtest basic-fds-forked-all: SUCCESS (21.901s)
[261.316479] [051/133] (761s left) api_intel_bb (full-batch)
[261.386933] Starting subtest: full-batch
[261.395047] Subtest full-batch: SUCCESS (0.010s)
[261.566749] [052/133] (761s left) kms_cursor_crc (cursor-sliding-256x85)
[261.817703] Starting subtest: cursor-sliding-256x85
[261.861360] Subtest cursor-sliding-256x85: SKIP (0.040s)
[262.067663] [053/133] (760s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[262.174281] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[262.176641] Starting dynamic subtest: pipe-A-eDP-1
[262.235331] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[262.248988] Starting dynamic subtest: pipe-B-eDP-1
[262.299824] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[262.310000] Starting dynamic subtest: pipe-C-eDP-1
[262.356537] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[262.365666] Starting dynamic subtest: pipe-D-eDP-1
[262.414605] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[262.418295] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.008s)
[264.531353] [054/133] (758s left) gen9_exec_parse (allowed-single)
[264.581761] Subtest allowed-single: SKIP (0.000s)
[264.649004] [055/133] (758s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[264.749076] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[271.660849] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.915s)
[271.810538] [056/133] (751s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[271.920352] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[271.924890] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[272.056504] [057/133] (750s left) gem_exec_fence (expired-history)
[272.570577] Starting subtest: expired-history
[279.547132] Subtest expired-history: SUCCESS (6.978s)
[280.189770] [058/133] (742s left) kms_psr (fbc-psr-sprite-plane-move)
[280.298107] Starting subtest: fbc-psr-sprite-plane-move
[280.300362] Starting dynamic subtest: eDP-1
[280.304377] Dynamic subtest eDP-1: SKIP (0.000s)
[280.308432] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[280.396832] [059/133] (742s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[280.502067] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[287.255708] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.756s)
[287.417499] [060/133] (735s left) gem_ctx_bad_destroy (double-destroy)
[287.486531] Starting subtest: double-destroy
[287.488950] Subtest double-destroy: SUCCESS (0.000s)
[287.598095] [061/133] (735s left) syncobj_timeline (invalid-signal-illegal-handle)
[287.656570] Starting subtest: invalid-signal-illegal-handle
[287.658972] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[287.787866] [062/133] (735s left) kms_chamelium_hpd (common-hpd-after-suspend)
[288.172412] Subtest common-hpd-after-suspend: SKIP (0.000s)
[288.993569] [063/133] (734s left) kms_frontbuffer_tracking (fbc-tiling-4)
[289.098089] Starting subtest: fbc-tiling-4
[293.294956] Subtest fbc-tiling-4: SUCCESS (4.201s)
[294.523616] [064/133] (728s left) gem_cs_tlb (engines)
[294.598100] Starting subtest: engines
[294.600090] Starting dynamic subtest: rcs0
[296.754081] Dynamic subtest rcs0: SUCCESS (2.153s)
[296.764343] Starting dynamic subtest: bcs0
[298.904987] Dynamic subtest bcs0: SUCCESS (2.151s)
[298.915167] Starting dynamic subtest: vcs0
[301.057287] Dynamic subtest vcs0: SUCCESS (2.152s)
[301.067483] Starting dynamic subtest: vcs1
[303.211806] Dynamic subtest vcs1: SUCCESS (2.152s)
[303.222405] Starting dynamic subtest: vecs0
[305.363524] Dynamic subtest vecs0: SUCCESS (2.151s)
[305.372912] Starting dynamic subtest: ccs0
[307.517038] Dynamic subtest ccs0: SUCCESS (2.153s)
[307.519328] Subtest engines: SUCCESS (12.918s)
[307.691990] [065/133] (715s left) gem_mmap_gtt (hang-busy)
[307.747342] Subtest hang-busy: SKIP (0.000s)
[307.817800] [066/133] (715s left) kms_psr (psr2-sprite-plane-onoff)
[307.916142] Starting subtest: psr2-sprite-plane-onoff
[307.918453] Starting dynamic subtest: eDP-1
[309.679515] Dynamic subtest eDP-1: SUCCESS (1.762s)
[309.681807] Subtest psr2-sprite-plane-onoff: SUCCESS (1.763s)
[310.570126] [067/133] (712s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[310.674393] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[311.287074] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.614s)
[311.452615] [068/133] (712s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[311.553210] Starting subtest: y-tiled-64bpp-rotate-270
[311.557764] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[311.679872] [069/133] (711s left) gem_bad_reloc (negative-reloc-lut)
[311.744093] Subtest negative-reloc-lut: SKIP (0.000s)
[311.824806] [070/133] (711s left) gem_ctx_persistence (engines-mixed)
[311.883393] Starting subtest: engines-mixed
[311.885718] Starting dynamic subtest: rcs0
[312.005387] Dynamic subtest rcs0: SUCCESS (0.121s)
[312.017879] Starting dynamic subtest: bcs0
[312.085308] Dynamic subtest bcs0: SUCCESS (0.078s)
[312.098107] Starting dynamic subtest: vcs0
[312.139925] Dynamic subtest vcs0: SUCCESS (0.053s)
[312.151027] Starting dynamic subtest: vcs1
[312.212714] Dynamic subtest vcs1: SUCCESS (0.071s)
[312.223307] Starting dynamic subtest: vecs0
[312.276832] Dynamic subtest vecs0: SUCCESS (0.062s)
[312.287244] Starting dynamic subtest: ccs0
[312.349577] Dynamic subtest ccs0: SUCCESS (0.071s)
[312.351707] Subtest engines-mixed: SUCCESS (0.468s)
[312.455188] [071/133] (711s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[312.548180] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[312.550022] Starting dynamic subtest: pipe-A
[312.616701] Dynamic subtest pipe-A: SUCCESS (0.068s)
[312.627149] Starting dynamic subtest: pipe-B
[313.769837] Dynamic subtest pipe-B: SUCCESS (1.151s)
[313.784089] Starting dynamic subtest: pipe-C
[314.872337] Dynamic subtest pipe-C: SUCCESS (1.100s)
[314.887077] Starting dynamic subtest: pipe-D
[316.007822] Dynamic subtest pipe-D: SUCCESS (1.133s)
[316.010474] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.461s)
[317.187919] [072/133] (706s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[317.294702] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[317.298777] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[317.438282] [073/133] (706s left) gem_exec_schedule (semaphore-noskip)
[317.506322] Starting subtest: semaphore-noskip
[317.910059] Subtest semaphore-noskip: SUCCESS (0.411s)
[318.275766] [074/133] (705s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[318.384974] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[318.389248] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[318.528189] [075/133] (705s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[318.629210] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[318.633071] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[318.768024] [076/133] (705s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[318.872607] Starting subtest: 4-tiled-16bpp-rotate-0
[320.185175] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.312s)
[320.338545] [077/133] (703s left) gem_exec_basic (basic)
[320.411838] Starting subtest: basic
[320.414034] Starting dynamic subtest: rcs0-smem
[320.416088] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[320.427436] Starting dynamic subtest: bcs0-smem
[320.429221] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[320.437323] Starting dynamic subtest: vcs0-smem
[320.439122] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[320.447327] Starting dynamic subtest: vcs1-smem
[320.449175] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[320.456990] Starting dynamic subtest: vecs0-smem
[320.458810] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[320.466694] Starting dynamic subtest: ccs0-smem
[320.468490] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[320.470297] Subtest basic: SUCCESS (0.013s)
[321.820475] [078/133] (702s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[321.927980] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[321.932181] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[322.080878] [079/133] (701s left) gem_mmap (short-mmap)
[322.142034] Subtest short-mmap: SKIP (0.000s)
[322.214355] [080/133] (701s left) gem_exec_reloc (basic-gtt-wc-active)
[322.285061] Subtest basic-gtt-wc-active: SKIP (0.000s)
[322.360764] [081/133] (701s left) gem_ctx_shared (create-shared-gtt)
[322.430218] Starting subtest: create-shared-gtt
[324.584178] Subtest create-shared-gtt: SUCCESS (2.152s)
[325.005367] [082/133] (699s left) gem_exec_reloc (basic-write-wc)
[325.071039] Subtest basic-write-wc: SKIP (0.000s)
[325.164558] [083/133] (698s left) gem_eio (wait-immediate)
[325.408247] Starting subtest: wait-immediate
[325.820590] Subtest wait-immediate: SUCCESS (0.416s)
[325.987770] [084/133] (698s left) gem_ctx_persistence (legacy-engines-mixed)
[326.051366] Starting subtest: legacy-engines-mixed
[326.053365] Starting dynamic subtest: render
[326.147293] Dynamic subtest render: SUCCESS (0.095s)
[326.161473] Starting dynamic subtest: bsd1
[326.208897] Dynamic subtest bsd1: SUCCESS (0.059s)
[326.222707] Starting dynamic subtest: bsd2
[326.270621] Dynamic subtest bsd2: SUCCESS (0.060s)
[326.282833] Starting dynamic subtest: blt
[326.337781] Dynamic subtest blt: SUCCESS (0.065s)
[326.351841] Starting dynamic subtest: vebox
[326.403725] Dynamic subtest vebox: SUCCESS (0.063s)
[326.405918] Subtest legacy-engines-mixed: SUCCESS (0.353s)
[326.508142] [085/133] (697s left) perf_pmu (semaphore-busy)
[326.548009] Starting subtest: semaphore-busy
[326.550133] Starting dynamic subtest: rcs0
[328.192753] Dynamic subtest rcs0: SUCCESS (1.639s)
[328.205250] Starting dynamic subtest: bcs0
[329.825128] Dynamic subtest bcs0: SUCCESS (1.629s)
[329.836599] Starting dynamic subtest: vcs0
[334.235874] Dynamic subtest vcs0: SUCCESS (4.407s)
[334.248862] Starting dynamic subtest: vcs1
[340.251891] Dynamic subtest vcs1: SUCCESS (6.011s)
[340.264895] Starting dynamic subtest: vecs0
[346.267733] Dynamic subtest vecs0: SUCCESS (6.011s)
[346.280489] Starting dynamic subtest: ccs0
[349.341494] Dynamic subtest ccs0: SUCCESS (3.070s)
[349.344077] Subtest semaphore-busy: SUCCESS (22.787s)
[349.485330] [086/133] (674s left) gem_exec_schedule (pi-common)
[349.687422] Starting subtest: pi-common
[349.689586] Starting dynamic subtest: rcs0
[349.727676] Dynamic subtest rcs0: SUCCESS (0.043s)
[349.737605] Starting dynamic subtest: bcs0
[349.769824] Dynamic subtest bcs0: SUCCESS (0.040s)
[349.779412] Starting dynamic subtest: vcs0
[349.806108] Dynamic subtest vcs0: SUCCESS (0.035s)
[349.815743] Starting dynamic subtest: vcs1
[349.838771] Dynamic subtest vcs1: SUCCESS (0.032s)
[349.848169] Starting dynamic subtest: vecs0
[349.872870] Dynamic subtest vecs0: SUCCESS (0.033s)
[349.882420] Starting dynamic subtest: ccs0
[349.908942] Dynamic subtest ccs0: SUCCESS (0.035s)
[349.911254] Subtest pi-common: SUCCESS (0.225s)
[350.164115] [087/133] (674s left) i915_hangman (engine-error-state-capture)
[350.238384] Starting subtest: engine-error-state-capture
[350.240670] Starting dynamic subtest: rcs0
[353.726208] Dynamic subtest rcs0: SUCCESS (3.487s)
[353.741557] Starting dynamic subtest: bcs0
[359.744357] Dynamic subtest bcs0: SUCCESS (6.015s)
[359.756863] Starting dynamic subtest: vcs0
[365.698170] Dynamic subtest vcs0: SUCCESS (5.950s)
[365.710587] Starting dynamic subtest: vcs1
[371.710609] Dynamic subtest vcs1: SUCCESS (6.009s)
[371.723627] Starting dynamic subtest: vecs0
[377.727556] Dynamic subtest vecs0: SUCCESS (6.014s)
[377.740374] Starting dynamic subtest: ccs0
[383.744033] Dynamic subtest ccs0: SUCCESS (6.012s)
[383.748131] Subtest engine-error-state-capture: SUCCESS (33.502s)
[383.914863] [088/133] (640s left) syncobj_timeline (wait-for-submit-snapshot)
[383.972276] Starting subtest: wait-for-submit-snapshot
[384.052700] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[384.159763] [089/133] (640s left) kms_color (ctm-blue-to-red)
[384.254384] Starting subtest: ctm-blue-to-red
[384.256317] Starting dynamic subtest: pipe-A-eDP-1
[384.931883] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.676s)
[384.942328] Starting dynamic subtest: pipe-B-eDP-1
[386.361234] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.431s)
[386.371439] Starting dynamic subtest: pipe-C-eDP-1
[387.705942] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.344s)
[387.716293] Starting dynamic subtest: pipe-D-eDP-1
[389.046851] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.339s)
[389.049149] Subtest ctm-blue-to-red: SUCCESS (4.793s)
[389.919731] [090/133] (634s left) prime_vgem (basic-gtt)
[390.017083] Starting subtest: basic-gtt
[390.021773] Subtest basic-gtt: SKIP (0.000s)
[390.154495] [091/133] (634s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[390.248318] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[397.672129] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.425s)
[397.842406] [092/133] (626s left) api_intel_allocator (default-alignment)
[397.908615] Starting subtest: default-alignment
[397.911081] Subtest default-alignment: SUCCESS (0.002s)
[398.061134] [093/133] (626s left) i915_pm_rps (fence-order)
[398.114794] Starting subtest: fence-order
[401.152229] Subtest fence-order: SUCCESS (3.034s)
[401.275194] [094/133] (623s left) kms_vblank (query-busy)
[401.376097] Starting subtest: query-busy
[401.378808] Starting dynamic subtest: pipe-A-eDP-1
[403.266830] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.890s)
[403.284461] Starting dynamic subtest: pipe-D-eDP-1
[405.823809] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.550s)
[405.826104] Subtest query-busy: SUCCESS (4.444s)
[406.648668] [095/133] (617s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[406.754585] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[406.758904] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[406.894978] [096/133] (617s left) kms_addfb_basic (invalid-get-prop-any)
[406.945501] Starting subtest: invalid-get-prop-any
[406.948026] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[407.122700] [097/133] (617s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[407.215720] Starting subtest: fbc-psr2-cursor-mmap-gtt
[407.217994] Starting dynamic subtest: eDP-1
[407.222010] Dynamic subtest eDP-1: SKIP (0.000s)
[407.226116] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[407.313451] [098/133] (617s left) kms_flip (2x-blocking-absolute-wf_vblank)
[407.423744] Starting subtest: 2x-blocking-absolute-wf_vblank
[407.435327] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.010s)
[407.578916] [099/133] (617s left) kms_cursor_crc (cursor-onscreen-256x85)
[407.838437] Starting subtest: cursor-onscreen-256x85
[407.888159] Subtest cursor-onscreen-256x85: SKIP (0.045s)
[408.084309] [100/133] (616s left) kms_flip (2x-modeset-vs-vblank-race)
[408.189977] Starting subtest: 2x-modeset-vs-vblank-race
[408.210100] Subtest 2x-modeset-vs-vblank-race: SKIP (0.019s)
[408.316159] [101/133] (616s left) kms_atomic_interruptible (atomic-setmode)
[408.415517] Starting subtest: atomic-setmode
[408.417403] Starting dynamic subtest: pipe-A-eDP-1
[415.322914] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.905s)
[415.325327] Subtest atomic-setmode: SUCCESS (6.906s)
[416.208523] [102/133] (608s left) kms_frontbuffer_tracking (psr-argb161616f-draw-render)
[416.322248] Starting subtest: psr-argb161616f-draw-render
[416.326334] Subtest psr-argb161616f-draw-render: SKIP (0.000s)
[416.460725] [103/133] (608s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[416.557816] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[416.562246] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[416.690935] [104/133] (608s left) kms_plane_scaling (invalid-num-scalers)
[416.788569] Starting subtest: invalid-num-scalers
[416.790902] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[416.807627] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.018s)
[416.817875] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[416.841453] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[416.851250] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[416.874628] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[416.884171] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[416.904528] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[416.906620] Subtest invalid-num-scalers: SUCCESS (0.116s)
[417.028011] [105/133] (608s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[417.134976] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[417.138175] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[417.250959] [106/133] (607s left) sw_sync (alloc_fence_invalid_timeline)
[417.285342] Starting subtest: alloc_fence_invalid_timeline
[417.287307] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[417.360531] [107/133] (607s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[417.418412] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[417.525005] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.106s)
[417.624066] [108/133] (607s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[417.724456] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[417.726987] Starting dynamic subtest: A-eDP1
[426.627885] Dynamic subtest A-eDP1: SUCCESS (8.903s)
[426.638773] Starting dynamic subtest: B-eDP1
[435.557459] Dynamic subtest B-eDP1: SUCCESS (8.928s)
[435.568584] Starting dynamic subtest: C-eDP1
[444.484652] Dynamic subtest C-eDP1: SUCCESS (8.925s)
[444.495698] Starting dynamic subtest: D-eDP1
[453.416654] Dynamic subtest D-eDP1: SUCCESS (8.930s)
[453.419371] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.694s)
[454.705632] [109/133] (570s left) kms_addfb_basic (size-max)
[454.803386] Starting subtest: size-max
[454.805513] Subtest size-max: SUCCESS (0.000s)
[454.940930] [110/133] (570s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[455.192707] Starting subtest: cursor-rapid-movement-256x256
[455.194887] Starting dynamic subtest: pipe-A-eDP-1
[455.736976] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.541s)
[455.764679] Starting dynamic subtest: pipe-D-eDP-1
[456.958493] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.203s)
[456.960884] Subtest cursor-rapid-movement-256x256: SUCCESS (1.769s)
[457.833777] [111/133] (567s left) gem_exec_whisper (basic-queues-all)
[457.905313] Starting subtest: basic-queues-all
[467.712322] Subtest basic-queues-all: SUCCESS (9.804s)
[467.930307] [112/133] (557s left) kms_dsc (dsc-fractional-bpp)
[468.029442] Starting subtest: dsc-fractional-bpp
[468.042972] Subtest dsc-fractional-bpp: SKIP (0.001s)
[468.133446] [113/133] (557s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[468.220443] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[468.222701] Starting dynamic subtest: pipe-A-default-mode
[468.510662] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[468.515321] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.289s)
[469.363546] [114/133] (556s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[469.468885] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[469.473303] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[469.605682] [115/133] (555s left) gem_softpin (evict-prime)
[469.668496] Starting subtest: evict-prime
[469.670719] Starting dynamic subtest: rcs0
[470.871332] Dynamic subtest rcs0: SUCCESS (1.202s)
[470.884298] Starting dynamic subtest: bcs0
[472.009977] Dynamic subtest bcs0: SUCCESS (1.137s)
[472.022807] Starting dynamic subtest: vcs0
[473.734662] Dynamic subtest vcs0: SUCCESS (1.721s)
[473.747354] Starting dynamic subtest: vcs1
[475.776138] Dynamic subtest vcs1: SUCCESS (2.039s)
[475.789342] Starting dynamic subtest: vecs0
[477.762954] Dynamic subtest vecs0: SUCCESS (1.984s)
[477.776976] Starting dynamic subtest: ccs0
[478.915595] Dynamic subtest ccs0: SUCCESS (1.151s)
[478.928969] Starting dynamic subtest: all
[480.761989] Dynamic subtest all: SUCCESS (1.843s)
[480.764792] Subtest evict-prime: SUCCESS (11.093s)
[480.863394] [116/133] (544s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[480.962546] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[480.966695] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[481.089619] [117/133] (544s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[481.180483] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[481.318306] [118/133] (544s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[481.372773] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[481.477601] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.104s)
[481.575035] [119/133] (544s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[481.673113] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[481.677563] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[481.785251] [120/133] (543s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[481.884719] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[485.940909] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.059s)
[487.186483] [121/133] (538s left) gem_mmap_wc (bad-size)
[487.254193] Subtest bad-size: SKIP (0.000s)
[487.320244] [122/133] (538s left) kms_hdr (static-toggle-suspend)
[487.422354] Starting subtest: static-toggle-suspend
[487.428426] Subtest static-toggle-suspend: SKIP (0.000s)
[487.518686] [123/133] (538s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[487.616965] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[487.621398] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[487.752525] [124/133] (538s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[492.736158] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[492.738493] Starting dynamic subtest: pipe-A-eDP-1
[493.525516] Dynamic subtest pipe-A-eDP-1: SKIP (0.785s)
[493.536493] Starting dynamic subtest: pipe-B-eDP-1
[494.664857] Dynamic subtest pipe-B-eDP-1: SKIP (1.137s)
[494.669593] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.928s)
[495.974077] [125/133] (529s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[496.073891] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[496.078365] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[496.189188] [126/133] (529s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[496.294574] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[496.296908] Starting dynamic subtest: pipe-A-eDP-1
[496.317615] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[496.337980] Starting dynamic subtest: pipe-B-eDP-1
[496.357837] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[496.376723] Starting dynamic subtest: pipe-C-eDP-1
[496.396973] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[496.416581] Starting dynamic subtest: pipe-D-eDP-1
[496.436229] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[496.438304] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[498.527801] [127/133] (527s left) syncobj_timeline (single-wait-all-available-submitted)
[498.591952] Starting subtest: single-wait-all-available-submitted
[498.594376] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[498.742913] [128/133] (527s left) gem_exec_parallel (userptr)
[498.812380] Starting subtest: userptr
[498.814778] Starting dynamic subtest: rcs0
[500.265492] Dynamic subtest rcs0: SUCCESS (1.453s)
[500.277763] Starting dynamic subtest: bcs0
[501.748444] Dynamic subtest bcs0: SUCCESS (1.481s)
[501.761041] Starting dynamic subtest: vcs0
[503.711652] Dynamic subtest vcs0: SUCCESS (1.961s)
[503.723448] Starting dynamic subtest: vcs1
[505.696327] Dynamic subtest vcs1: SUCCESS (1.982s)
[505.709105] Starting dynamic subtest: vecs0
[507.744703] Dynamic subtest vecs0: SUCCESS (2.046s)
[507.757843] Starting dynamic subtest: ccs0
[509.293758] Dynamic subtest ccs0: SUCCESS (1.548s)
[509.296147] Subtest userptr: SUCCESS (10.482s)
[509.506002] [129/133] (516s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[509.597981] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[509.602098] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[509.742020] [130/133] (516s left) i915_selftest (mock)
[513.344663] Starting subtest: mock
[513.347120] Starting dynamic subtest: sanitycheck
[514.120447] Dynamic subtest sanitycheck: SUCCESS (0.776s)
[514.130495] Starting dynamic subtest: shmem
[514.882917] Dynamic subtest shmem: SUCCESS (0.760s)
[514.891745] Starting dynamic subtest: fence
[522.987402] Dynamic subtest fence: SUCCESS (8.102s)
[522.996755] Starting dynamic subtest: scatterlist
[524.734532] Dynamic subtest scatterlist: SUCCESS (1.744s)
[524.744345] Starting dynamic subtest: syncmap
[528.310744] Dynamic subtest syncmap: SUCCESS (3.574s)
[528.319727] Starting dynamic subtest: uncore
[529.044713] Dynamic subtest uncore: SUCCESS (0.732s)
[529.053052] Starting dynamic subtest: ring
[529.792543] Dynamic subtest ring: SUCCESS (0.745s)
[529.802504] Starting dynamic subtest: engine
[530.488791] Dynamic subtest engine: SUCCESS (0.693s)
[530.498862] Starting dynamic subtest: timelines
[534.377663] Dynamic subtest timelines: SUCCESS (3.886s)
[534.388652] Starting dynamic subtest: requests
[537.583806] Dynamic subtest requests: SUCCESS (3.203s)
[537.593638] Starting dynamic subtest: objects
[538.399502] Dynamic subtest objects: SUCCESS (0.814s)
[538.409553] Starting dynamic subtest: phys
[539.251810] Dynamic subtest phys: SUCCESS (0.850s)
[539.261489] Starting dynamic subtest: dmabuf
[540.074938] Dynamic subtest dmabuf: SUCCESS (0.821s)
[540.085052] Starting dynamic subtest: vma
[545.477035] Dynamic subtest vma: SUCCESS (5.399s)
[545.486926] Starting dynamic subtest: evict
[546.932660] Dynamic subtest evict: SUCCESS (1.454s)
[546.942658] Starting dynamic subtest: gtt
[550.133614] Dynamic subtest gtt: SUCCESS (3.198s)
[550.143725] Starting dynamic subtest: hugepages
[551.118315] Dynamic subtest hugepages: SUCCESS (0.983s)
[551.128463] Starting dynamic subtest: memory_region
[553.799627] Dynamic subtest memory_region: SUCCESS (2.678s)
[553.802236] Subtest mock: SUCCESS (40.455s)
[553.833584] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[553.834281] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[553.837516] [131/133] (472s left) gem_mmap_gtt (basic-write-read)
[555.388867] Subtest basic-write-read: SKIP (0.000s)
[555.452799] [FACT gem_mmap_gtt (basic-write-read)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[555.454144] [FACT gem_mmap_gtt (basic-write-read)] new: kernel.kmod_is_loaded.i915: true
[555.458362] [132/133] (470s left) perf (gen12-group-exclusive-stream-sample-oa)
[555.604099] Starting subtest: gen12-group-exclusive-stream-sample-oa
[555.626752] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.021s)
[555.664484] [133/133] (470s left) perf_pmu (busy-double-start)
[555.701294] Starting subtest: busy-double-start
[555.703253] Starting dynamic subtest: rcs0
[559.352010] Dynamic subtest rcs0: FAIL (3.595s)
[559.362417] Starting dynamic subtest: bcs0
[562.906941] Dynamic subtest bcs0: SUCCESS (3.612s)
[562.918172] Starting dynamic subtest: vcs0
[567.302913] Dynamic subtest vcs0: SUCCESS (4.393s)
[567.314760] Starting dynamic subtest: vcs1
[571.333207] Dynamic subtest vcs1: SUCCESS (4.028s)
[571.344536] Starting dynamic subtest: vecs0
[575.306918] Dynamic subtest vecs0: SUCCESS (3.972s)
[575.318481] Starting dynamic subtest: ccs0
[578.943597] Dynamic subtest ccs0: FAIL (3.564s)
[578.945929] Subtest busy-double-start: FAIL (23.175s)
[579.026234] 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.