[56.233436] Initializing watchdogs
[56.233479]   /dev/watchdog0
[56.247469] [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.252249] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.254400] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.257671] [001/133] (960s left) gem_partial_pwrite_pread (write-snoop)
[56.351096] Subtest write-snoop: SKIP (0.000s)
[56.435531] [002/133] (960s left) kms_content_protection (content-type-change)
[56.587194] Starting subtest: content-type-change
[56.591716] Subtest content-type-change: SKIP (0.000s)
[56.755508] [003/133] (960s left) kms_rotation_crc (multiplane-rotation)
[56.842674] Starting subtest: multiplane-rotation
[74.288505] Subtest multiplane-rotation: SUCCESS (17.425s)
[74.444987] [004/133] (942s left) kms_chamelium_color (ctm-red-to-blue)
[74.561040] Subtest ctm-red-to-blue: SKIP (0.000s)
[74.602409] [005/133] (942s left) syncobj_wait (invalid-reset-one-illegal-handle)
[74.662096] Starting subtest: invalid-reset-one-illegal-handle
[74.663737] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[74.799461] [006/133] (942s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[74.903072] Starting subtest: disable-crc-after-crtc
[74.904704] Starting dynamic subtest: pipe-A-eDP-1
[76.547257] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.643s)
[76.556091] Starting dynamic subtest: pipe-B-eDP-1
[78.809783] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.261s)
[78.816961] Starting dynamic subtest: pipe-C-eDP-1
[81.059253] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.247s)
[81.067399] Starting dynamic subtest: pipe-D-eDP-1
[83.335249] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.278s)
[83.337624] Subtest disable-crc-after-crtc: SUCCESS (8.434s)
[84.165718] [007/133] (932s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[84.245481] Subtest tiled-to-tiled: SKIP (0.000s)
[84.324267] [008/133] (932s left) syncobj_wait (wait-all-interrupted)
[84.383099] Starting subtest: wait-all-interrupted
[84.484900] Subtest wait-all-interrupted: SUCCESS (0.103s)
[84.583110] [009/133] (932s left) syncobj_wait (wait-all-complex)
[84.649461] Starting subtest: wait-all-complex
[84.862044] Subtest wait-all-complex: SUCCESS (0.212s)
[84.955788] [010/133] (932s left) gem_pxp (reject-modify-context-protection-on)
[85.083760] Starting subtest: reject-modify-context-protection-on
[85.086207] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[85.238933] [011/133] (931s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[85.351968] Starting subtest: cursorA-vs-flipB-varying-size
[85.356340] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[85.556420] [012/133] (931s left) kms_rotation_crc (primary-rotation-90)
[85.662591] Starting subtest: primary-rotation-90
[85.666742] Subtest primary-rotation-90: SKIP (0.001s)
[85.757438] [013/133] (931s left) syncobj_wait (reset-multiple-signaled)
[85.813287] Starting subtest: reset-multiple-signaled
[85.815288] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[85.941285] [014/133] (931s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[86.034165] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[86.037916] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[87.199394] [015/133] (930s left) gem_softpin (noreloc-s3)
[87.262408] Starting subtest: noreloc-S3
[107.792780] Subtest noreloc-S3: SUCCESS (5.382s)
[107.966044] [016/133] (909s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[108.095284] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[112.585118] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.456s)
[113.788291] [017/133] (903s left) gem_ctx_param (invalid-ctx-set)
[113.858456] Starting subtest: invalid-ctx-set
[113.860902] Subtest invalid-ctx-set: SUCCESS (0.003s)
[114.004583] [018/133] (903s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[114.073226] Starting subtest: single-wait-all-for-submit-unsubmitted
[114.176857] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[114.272842] [019/133] (903s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[114.382656] Starting subtest: x-tiled-64bpp-rotate-90
[114.402079] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[114.549828] [020/133] (902s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[114.611491] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[114.679877] [021/133] (902s left) kms_psr (fbc-psr-cursor-plane-move)
[114.775193] Starting subtest: fbc-psr-cursor-plane-move
[114.777389] Starting dynamic subtest: eDP-1
[114.781800] Dynamic subtest eDP-1: SKIP (0.000s)
[114.786352] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[114.870259] [022/133] (902s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[114.984277] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[115.955435] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.966s)
[116.119361] [023/133] (901s left) kms_flip (2x-flip-vs-rmfb)
[116.228025] Starting subtest: 2x-flip-vs-rmfb
[116.236570] Subtest 2x-flip-vs-rmfb: SKIP (0.010s)
[116.387929] [024/133] (901s left) kms_plane_cursor (viewport)
[116.492435] Starting subtest: viewport
[116.495933] Starting dynamic subtest: pipe-A-eDP-1-size-64
[119.001353] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.500s)
[119.060661] Starting dynamic subtest: pipe-A-eDP-1-size-128
[121.531101] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.471s)
[121.590475] Starting dynamic subtest: pipe-A-eDP-1-size-256
[124.070921] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.482s)
[124.425676] Starting dynamic subtest: pipe-B-eDP-1-size-64
[127.654939] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.235s)
[127.714093] Starting dynamic subtest: pipe-B-eDP-1-size-128
[130.212830] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.504s)
[130.273643] Starting dynamic subtest: pipe-B-eDP-1-size-256
[132.750677] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.481s)
[133.115000] Starting dynamic subtest: pipe-C-eDP-1-size-64
[135.997221] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.892s)
[136.039858] Starting dynamic subtest: pipe-C-eDP-1-size-128
[138.231411] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.202s)
[138.267004] Starting dynamic subtest: pipe-C-eDP-1-size-256
[140.452914] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.192s)
[140.779333] Starting dynamic subtest: pipe-D-eDP-1-size-64
[143.606217] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.836s)
[143.643962] Starting dynamic subtest: pipe-D-eDP-1-size-128
[145.750538] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.113s)
[145.787143] Starting dynamic subtest: pipe-D-eDP-1-size-256
[147.950597] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.169s)
[148.273098] Subtest viewport: SUCCESS (31.749s)
[149.144437] [025/133] (868s left) kms_cdclk (mode-transition)
[149.246900] Starting subtest: mode-transition
[149.249146] Starting dynamic subtest: pipe-A-eDP-1
[149.545452] Dynamic subtest pipe-A-eDP-1: SKIP (0.296s)
[149.557505] Starting dynamic subtest: pipe-B-eDP-1
[149.562001] Dynamic subtest pipe-B-eDP-1: SKIP (0.002s)
[149.572994] Starting dynamic subtest: pipe-C-eDP-1
[149.577386] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[149.585880] Starting dynamic subtest: pipe-D-eDP-1
[149.589849] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[149.593805] Subtest mode-transition: SKIP (0.304s)
[150.370692] [026/133] (867s left) gem_exec_balancer (fairslice)
[150.454105] Starting subtest: fairslice
[153.313769] Subtest fairslice: SUCCESS (2.860s)
[154.076336] [027/133] (863s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[154.213388] Starting subtest: basic-flip-before-cursor-varying-size
[155.142222] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.928s)
[156.001113] [028/133] (861s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[156.090283] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[156.092600] Starting dynamic subtest: pipe-A-default-mode
[156.380824] Dynamic subtest pipe-A-default-mode: SKIP (0.289s)
[156.385498] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.290s)
[157.229857] [029/133] (860s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[157.338843] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[157.340984] Starting dynamic subtest: pipe-A-default-mode
[160.059834] Dynamic subtest pipe-A-default-mode: SUCCESS (2.718s)
[160.061874] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.719s)
[160.906322] [030/133] (856s left) core_getstats (basic)
[160.978268] Starting subtest: basic
[160.980323] Subtest basic: SUCCESS (0.000s)
[161.105253] [031/133] (856s left) kms_rmfb (close-fd)
[161.199978] Starting subtest: close-fd
[161.202090] Starting dynamic subtest: pipe-A-eDP-1
[161.306802] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.107s)
[161.320123] Starting dynamic subtest: pipe-B-eDP-1
[162.453321] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.145s)
[162.463668] Starting dynamic subtest: pipe-C-eDP-1
[163.580465] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.124s)
[163.589694] Starting dynamic subtest: pipe-D-eDP-1
[164.712390] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.132s)
[164.714714] Subtest close-fd: SUCCESS (3.515s)
[165.943007] [032/133] (852s left) gem_exec_reloc (basic-gtt-wc)
[166.039903] Subtest basic-gtt-wc: SKIP (0.000s)
[166.099232] [033/133] (851s left) kms_properties (crtc-properties-legacy)
[166.201633] Starting subtest: crtc-properties-legacy
[166.203896] Starting dynamic subtest: pipe-A-eDP-1
[166.643768] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.438s)
[166.653878] Starting dynamic subtest: pipe-B-eDP-1
[167.791737] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.148s)
[167.804633] Starting dynamic subtest: pipe-C-eDP-1
[168.909777] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.114s)
[168.918387] Starting dynamic subtest: pipe-D-eDP-1
[170.035903] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.124s)
[170.038095] Subtest crtc-properties-legacy: SUCCESS (3.831s)
[170.878370] [034/133] (847s left) kms_invalid_mode (zero-hdisplay)
[170.997325] Starting subtest: zero-hdisplay
[170.999475] Starting dynamic subtest: pipe-A-eDP-1
[171.282556] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[171.291216] Starting dynamic subtest: pipe-B-eDP-1
[171.293372] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[171.300889] Starting dynamic subtest: pipe-C-eDP-1
[171.303073] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[171.310626] Starting dynamic subtest: pipe-D-eDP-1
[171.312510] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[171.314373] Subtest zero-hdisplay: SUCCESS (0.289s)
[172.114985] [035/133] (845s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[172.220004] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[172.222369] Starting dynamic subtest: pipe-A
[173.267722] Dynamic subtest pipe-A: SUCCESS (1.050s)
[173.277815] Starting dynamic subtest: pipe-B
[175.406543] Dynamic subtest pipe-B: SUCCESS (2.136s)
[175.416411] Starting dynamic subtest: pipe-C
[176.609586] Dynamic subtest pipe-C: SUCCESS (1.200s)
[176.617694] Starting dynamic subtest: pipe-D
[177.756105] Dynamic subtest pipe-D: SUCCESS (1.144s)
[177.758461] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.537s)
[178.962235] [036/133] (839s left) kms_pm_rpm (legacy-planes-dpms)
[181.194845] Starting subtest: legacy-planes-dpms
[181.198332] Starting dynamic subtest: plane-63
[189.494427] Dynamic subtest plane-63: SUCCESS (8.296s)
[189.506345] Starting dynamic subtest: plane-93
[197.803111] Dynamic subtest plane-93: SUCCESS (8.302s)
[197.814692] Starting dynamic subtest: plane-123
[206.099132] Dynamic subtest plane-123: SUCCESS (8.296s)
[206.110002] Starting dynamic subtest: plane-133
[214.825098] Dynamic subtest plane-133: SUCCESS (8.725s)
[214.827930] Subtest legacy-planes-dpms: SUCCESS (33.631s)
[215.208140] [037/133] (802s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[215.305793] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[215.310239] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[215.444944] [038/133] (802s left) kms_dirtyfb (default-dirtyfb-ioctl)
[215.531124] Starting subtest: default-dirtyfb-ioctl
[215.533458] Starting dynamic subtest: A-eDP-1
[217.134979] Dynamic subtest A-eDP-1: SUCCESS (1.605s)
[217.137263] Subtest default-dirtyfb-ioctl: SUCCESS (1.606s)
[217.950571] [039/133] (800s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[218.083478] Starting subtest: cursorB-vs-flipA-legacy
[218.088389] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[218.253081] [040/133] (800s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[218.308469] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[218.310866] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[218.425702] [041/133] (799s left) kms_prime (basic-crc-vgem)
[218.552535] Starting subtest: basic-crc-vgem
[218.554694] Starting dynamic subtest: second-to-first
[219.498360] Dynamic subtest second-to-first: SUCCESS (0.948s)
[219.500188] Subtest basic-crc-vgem: SUCCESS (0.949s)
[219.604293] [FACT kms_prime (basic-crc-vgem)] new: kernel.kmod_is_loaded.vgem: true
[219.607367] [042/133] (798s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[219.712597] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[219.781930] [043/133] (798s left) i915_drm_fdinfo (busy)
[219.815321] Starting subtest: busy
[219.817096] Starting dynamic subtest: rcs0
[219.828984] Dynamic subtest rcs0: SKIP (0.012s)
[219.838201] Starting dynamic subtest: bcs0
[219.843974] Dynamic subtest bcs0: SKIP (0.014s)
[219.851981] Starting dynamic subtest: vcs0
[219.855250] Dynamic subtest vcs0: SKIP (0.000s)
[219.863321] Starting dynamic subtest: vcs1
[219.866744] Dynamic subtest vcs1: SKIP (0.000s)
[219.874166] Starting dynamic subtest: vecs0
[219.877420] Dynamic subtest vecs0: SKIP (0.000s)
[219.884672] Starting dynamic subtest: ccs0
[219.887986] Dynamic subtest ccs0: SKIP (0.000s)
[219.891265] Subtest busy: SKIP (0.031s)
[219.938808] [044/133] (798s left) gem_userptr_blits (nohangcheck)
[220.009364] Starting subtest: nohangcheck
[220.230870] Subtest nohangcheck: SUCCESS (0.218s)
[220.389247] [045/133] (798s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[220.490442] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[221.114762] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.626s)
[221.338417] [046/133] (797s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[221.444104] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[221.448422] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[222.588125] [047/133] (795s left) kms_scaling_modes (scaling-mode-full)
[222.687984] Starting subtest: scaling-mode-full
[222.690398] Starting dynamic subtest: pipe-A-eDP-1
[222.780398] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[222.790118] Starting dynamic subtest: pipe-B-eDP-1
[223.989593] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.208s)
[223.999551] Starting dynamic subtest: pipe-C-eDP-1
[225.202735] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.212s)
[225.213244] Starting dynamic subtest: pipe-D-eDP-1
[226.326802] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.123s)
[226.329194] Subtest scaling-mode-full: SUCCESS (3.642s)
[227.507394] [048/133] (791s left) kms_psr (fbc-pr-basic)
[227.618443] Starting subtest: fbc-pr-basic
[227.622486] Subtest fbc-pr-basic: SKIP (0.000s)
[227.713492] [049/133] (790s left) gem_ringfill (basic-all)
[233.041080] Starting subtest: basic-all
[234.197947] Subtest basic-all: SUCCESS (1.157s)
[234.380391] [050/133] (784s left) gem_exec_whisper (basic-fds-forked-all)
[234.461139] Starting subtest: basic-fds-forked-all
[256.174105] Subtest basic-fds-forked-all: SUCCESS (21.706s)
[256.382824] [051/133] (762s left) api_intel_bb (full-batch)
[256.444533] Starting subtest: full-batch
[256.453747] Subtest full-batch: SUCCESS (0.012s)
[256.569758] [052/133] (762s left) kms_cursor_crc (cursor-sliding-256x85)
[256.809650] Starting subtest: cursor-sliding-256x85
[256.854363] Subtest cursor-sliding-256x85: SKIP (0.040s)
[257.037061] [053/133] (761s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[257.139173] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[257.141478] Starting dynamic subtest: pipe-A-eDP-1
[257.196233] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[257.205174] Starting dynamic subtest: pipe-B-eDP-1
[257.261926] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[257.273038] Starting dynamic subtest: pipe-C-eDP-1
[257.324749] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[257.334545] Starting dynamic subtest: pipe-D-eDP-1
[257.381941] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[257.385530] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.008s)
[259.478639] [054/133] (759s left) gen9_exec_parse (allowed-single)
[259.541036] Subtest allowed-single: SKIP (0.000s)
[259.630488] [055/133] (759s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[259.732856] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[266.810475] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.078s)
[266.969111] [056/133] (751s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[267.075712] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[267.080007] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[267.215824] [057/133] (751s left) gem_exec_fence (expired-history)
[267.701747] Starting subtest: expired-history
[274.783714] Subtest expired-history: SUCCESS (7.081s)
[276.091279] [058/133] (742s left) kms_psr (fbc-psr-sprite-plane-move)
[276.203128] Starting subtest: fbc-psr-sprite-plane-move
[276.205392] Starting dynamic subtest: eDP-1
[276.209522] Dynamic subtest eDP-1: SKIP (0.000s)
[276.213663] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[276.303351] [059/133] (742s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[276.406408] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[283.124767] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.719s)
[283.275023] [060/133] (735s left) gem_ctx_bad_destroy (double-destroy)
[283.342539] Starting subtest: double-destroy
[283.344806] Subtest double-destroy: SUCCESS (0.000s)
[283.443005] [061/133] (735s left) syncobj_timeline (invalid-signal-illegal-handle)
[283.492454] Starting subtest: invalid-signal-illegal-handle
[283.494707] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[283.622923] [062/133] (735s left) kms_chamelium_hpd (common-hpd-after-suspend)
[284.007785] Subtest common-hpd-after-suspend: SKIP (0.000s)
[284.846142] [063/133] (734s left) kms_frontbuffer_tracking (fbc-tiling-4)
[284.939843] Starting subtest: fbc-tiling-4
[289.210649] Subtest fbc-tiling-4: SUCCESS (4.273s)
[290.386150] [064/133] (728s left) gem_cs_tlb (engines)
[290.447444] Starting subtest: engines
[290.449649] Starting dynamic subtest: rcs0
[292.602010] Dynamic subtest rcs0: SUCCESS (2.151s)
[292.612086] Starting dynamic subtest: bcs0
[294.756943] Dynamic subtest bcs0: SUCCESS (2.151s)
[294.769097] Starting dynamic subtest: vcs0
[296.908263] Dynamic subtest vcs0: SUCCESS (2.151s)
[296.919866] Starting dynamic subtest: vcs1
[299.063844] Dynamic subtest vcs1: SUCCESS (2.152s)
[299.075852] Starting dynamic subtest: vecs0
[301.215936] Dynamic subtest vecs0: SUCCESS (2.152s)
[301.225438] Starting dynamic subtest: ccs0
[303.369823] Dynamic subtest ccs0: SUCCESS (2.153s)
[303.372137] Subtest engines: SUCCESS (12.916s)
[303.531208] [065/133] (715s left) gem_mmap_gtt (hang-busy)
[303.588707] Subtest hang-busy: SKIP (0.000s)
[303.656386] [066/133] (715s left) kms_psr (psr2-sprite-plane-onoff)
[303.777196] Starting subtest: psr2-sprite-plane-onoff
[303.779391] Starting dynamic subtest: eDP-1
[305.483278] Dynamic subtest eDP-1: SUCCESS (1.704s)
[305.485646] Subtest psr2-sprite-plane-onoff: SUCCESS (1.705s)
[306.353400] [067/133] (713s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[306.461363] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[307.063146] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.603s)
[307.301100] [068/133] (712s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[307.395623] Starting subtest: y-tiled-64bpp-rotate-270
[307.400018] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[307.521072] [069/133] (711s left) gem_bad_reloc (negative-reloc-lut)
[307.593355] Subtest negative-reloc-lut: SKIP (0.000s)
[307.674146] [070/133] (711s left) gem_ctx_persistence (engines-mixed)
[307.731975] Starting subtest: engines-mixed
[307.734307] Starting dynamic subtest: rcs0
[307.829008] Dynamic subtest rcs0: SUCCESS (0.096s)
[307.841768] Starting dynamic subtest: bcs0
[307.913813] Dynamic subtest bcs0: SUCCESS (0.082s)
[307.926869] Starting dynamic subtest: vcs0
[307.984676] Dynamic subtest vcs0: SUCCESS (0.069s)
[307.996097] Starting dynamic subtest: vcs1
[308.067619] Dynamic subtest vcs1: SUCCESS (0.081s)
[308.079106] Starting dynamic subtest: vecs0
[308.141663] Dynamic subtest vecs0: SUCCESS (0.072s)
[308.153278] Starting dynamic subtest: ccs0
[308.219649] Dynamic subtest ccs0: SUCCESS (0.076s)
[308.221877] Subtest engines-mixed: SUCCESS (0.489s)
[308.322547] [071/133] (711s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[308.412036] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[308.413917] Starting dynamic subtest: pipe-A
[308.475118] Dynamic subtest pipe-A: SUCCESS (0.064s)
[308.485130] Starting dynamic subtest: pipe-B
[309.658609] Dynamic subtest pipe-B: SUCCESS (1.181s)
[309.675364] Starting dynamic subtest: pipe-C
[310.765402] Dynamic subtest pipe-C: SUCCESS (1.105s)
[310.774613] Starting dynamic subtest: pipe-D
[311.891643] Dynamic subtest pipe-D: SUCCESS (1.124s)
[311.894117] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.481s)
[313.076153] [072/133] (706s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[313.189904] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[313.194143] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[313.310484] [073/133] (706s left) gem_exec_schedule (semaphore-noskip)
[313.370317] Starting subtest: semaphore-noskip
[313.778849] Subtest semaphore-noskip: SUCCESS (0.413s)
[314.157675] [074/133] (705s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[314.260304] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[314.264326] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[314.388134] [075/133] (705s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[314.478117] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[314.482298] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[314.606115] [076/133] (705s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[314.715809] Starting subtest: 4-tiled-16bpp-rotate-0
[316.015920] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.301s)
[316.192149] [077/133] (703s left) gem_exec_basic (basic)
[316.252389] Starting subtest: basic
[316.254291] Starting dynamic subtest: rcs0-smem
[316.256108] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[316.265332] Starting dynamic subtest: bcs0-smem
[316.267145] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[316.275477] Starting dynamic subtest: vcs0-smem
[316.277120] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[316.285292] Starting dynamic subtest: vcs1-smem
[316.286855] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[316.294935] Starting dynamic subtest: vecs0-smem
[316.296543] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[316.304940] Starting dynamic subtest: ccs0-smem
[316.306569] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[316.308148] Subtest basic: SUCCESS (0.014s)
[318.127000] [078/133] (701s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[318.225115] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[318.229585] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[318.362254] [079/133] (701s left) gem_mmap (short-mmap)
[318.425385] Subtest short-mmap: SKIP (0.000s)
[318.490315] [080/133] (701s left) gem_exec_reloc (basic-gtt-wc-active)
[318.554496] Subtest basic-gtt-wc-active: SKIP (0.000s)
[318.636286] [081/133] (701s left) gem_ctx_shared (create-shared-gtt)
[318.692899] Starting subtest: create-shared-gtt
[320.847099] Subtest create-shared-gtt: SUCCESS (2.152s)
[321.272014] [082/133] (698s left) gem_exec_reloc (basic-write-wc)
[321.336773] Subtest basic-write-wc: SKIP (0.000s)
[321.411951] [083/133] (698s left) gem_eio (wait-immediate)
[321.665237] Starting subtest: wait-immediate
[322.067661] Subtest wait-immediate: SUCCESS (0.403s)
[322.215360] [084/133] (697s left) gem_ctx_persistence (legacy-engines-mixed)
[322.273757] Starting subtest: legacy-engines-mixed
[322.275531] Starting dynamic subtest: render
[322.378472] Dynamic subtest render: SUCCESS (0.107s)
[322.392862] Starting dynamic subtest: bsd1
[322.460539] Dynamic subtest bsd1: SUCCESS (0.079s)
[322.474790] Starting dynamic subtest: bsd2
[322.541745] Dynamic subtest bsd2: SUCCESS (0.078s)
[322.554332] Starting dynamic subtest: blt
[322.628989] Dynamic subtest blt: SUCCESS (0.084s)
[322.641574] Starting dynamic subtest: vebox
[322.712899] Dynamic subtest vebox: SUCCESS (0.081s)
[322.715499] Subtest legacy-engines-mixed: SUCCESS (0.443s)
[322.813372] [085/133] (697s left) perf_pmu (semaphore-busy)
[322.854162] Starting subtest: semaphore-busy
[322.855888] Starting dynamic subtest: rcs0
[324.516005] Dynamic subtest rcs0: SUCCESS (1.658s)
[324.527939] Starting dynamic subtest: bcs0
[326.149734] Dynamic subtest bcs0: SUCCESS (1.629s)
[326.161406] Starting dynamic subtest: vcs0
[330.504672] Dynamic subtest vcs0: SUCCESS (4.351s)
[330.516849] Starting dynamic subtest: vcs1
[336.519824] Dynamic subtest vcs1: SUCCESS (6.013s)
[336.529978] Starting dynamic subtest: vecs0
[342.472369] Dynamic subtest vecs0: SUCCESS (5.951s)
[342.485109] Starting dynamic subtest: ccs0
[345.605674] Dynamic subtest ccs0: SUCCESS (3.131s)
[345.608863] Subtest semaphore-busy: SUCCESS (22.753s)
[345.746391] [086/133] (674s left) gem_exec_schedule (pi-common)
[345.939666] Starting subtest: pi-common
[345.942126] Starting dynamic subtest: rcs0
[345.977280] Dynamic subtest rcs0: SUCCESS (0.040s)
[345.988270] Starting dynamic subtest: bcs0
[346.017015] Dynamic subtest bcs0: SUCCESS (0.039s)
[346.026747] Starting dynamic subtest: vcs0
[346.059608] Dynamic subtest vcs0: SUCCESS (0.042s)
[346.069247] Starting dynamic subtest: vcs1
[346.097752] Dynamic subtest vcs1: SUCCESS (0.037s)
[346.107114] Starting dynamic subtest: vecs0
[346.131875] Dynamic subtest vecs0: SUCCESS (0.033s)
[346.141340] Starting dynamic subtest: ccs0
[346.164436] Dynamic subtest ccs0: SUCCESS (0.032s)
[346.166668] Subtest pi-common: SUCCESS (0.228s)
[346.427137] [087/133] (673s left) i915_hangman (engine-error-state-capture)
[346.494500] Starting subtest: engine-error-state-capture
[346.496668] Starting dynamic subtest: rcs0
[349.995865] Dynamic subtest rcs0: SUCCESS (3.501s)
[350.008765] Starting dynamic subtest: bcs0
[355.946800] Dynamic subtest bcs0: SUCCESS (5.948s)
[355.958695] Starting dynamic subtest: vcs0
[361.963147] Dynamic subtest vcs0: SUCCESS (6.015s)
[361.975425] Starting dynamic subtest: vcs1
[367.915740] Dynamic subtest vcs1: SUCCESS (5.950s)
[367.926707] Starting dynamic subtest: vecs0
[372.906987] Dynamic subtest vecs0: SUCCESS (4.988s)
[372.919556] Starting dynamic subtest: ccs0
[377.964087] Dynamic subtest ccs0: SUCCESS (5.054s)
[377.966858] Subtest engine-error-state-capture: SUCCESS (31.473s)
[378.069879] [088/133] (642s left) syncobj_timeline (wait-for-submit-snapshot)
[378.136266] Starting subtest: wait-for-submit-snapshot
[378.216487] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[378.322206] [089/133] (642s left) kms_color (ctm-blue-to-red)
[378.429708] Starting subtest: ctm-blue-to-red
[378.431563] Starting dynamic subtest: pipe-A-eDP-1
[379.123099] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.694s)
[379.133187] Starting dynamic subtest: pipe-B-eDP-1
[380.501851] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.376s)
[380.512533] Starting dynamic subtest: pipe-C-eDP-1
[381.776382] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.276s)
[381.787344] Starting dynamic subtest: pipe-D-eDP-1
[383.104856] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[383.107371] Subtest ctm-blue-to-red: SUCCESS (4.677s)
[383.978455] [090/133] (636s left) prime_vgem (basic-gtt)
[384.076197] Starting subtest: basic-gtt
[384.081093] Subtest basic-gtt: SKIP (0.000s)
[384.202483] [091/133] (636s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[384.296135] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[391.718398] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.424s)
[391.903356] [092/133] (628s left) api_intel_allocator (default-alignment)
[391.969727] Starting subtest: default-alignment
[391.975107] Subtest default-alignment: SUCCESS (0.006s)
[392.126890] [093/133] (628s left) i915_pm_rps (fence-order)
[392.182177] Starting subtest: fence-order
[395.127784] Subtest fence-order: SUCCESS (2.946s)
[395.299547] [094/133] (625s left) kms_vblank (query-busy)
[395.400820] Starting subtest: query-busy
[395.402647] Starting dynamic subtest: pipe-A-eDP-1
[397.280126] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.879s)
[397.295789] Starting dynamic subtest: pipe-D-eDP-1
[399.856498] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.574s)
[399.858714] Subtest query-busy: SUCCESS (4.457s)
[400.677565] [095/133] (619s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[400.783162] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[400.787713] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[400.920200] [096/133] (619s left) kms_addfb_basic (invalid-get-prop-any)
[400.981700] Starting subtest: invalid-get-prop-any
[400.983926] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[401.163250] [097/133] (619s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[401.259011] Starting subtest: fbc-psr2-cursor-mmap-gtt
[401.261418] Starting dynamic subtest: eDP-1
[401.265663] Dynamic subtest eDP-1: SKIP (0.000s)
[401.269914] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[401.358789] [098/133] (619s left) kms_flip (2x-blocking-absolute-wf_vblank)
[401.457529] Starting subtest: 2x-blocking-absolute-wf_vblank
[401.468206] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.010s)
[401.571374] [099/133] (619s left) kms_cursor_crc (cursor-onscreen-256x85)
[401.821193] Starting subtest: cursor-onscreen-256x85
[401.869193] Subtest cursor-onscreen-256x85: SKIP (0.042s)
[402.074465] [100/133] (618s left) kms_flip (2x-modeset-vs-vblank-race)
[402.166808] Starting subtest: 2x-modeset-vs-vblank-race
[402.178169] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[402.282234] [101/133] (618s left) kms_atomic_interruptible (atomic-setmode)
[402.382170] Starting subtest: atomic-setmode
[402.384027] Starting dynamic subtest: pipe-A-eDP-1
[409.303267] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.920s)
[409.305782] Subtest atomic-setmode: SUCCESS (6.921s)
[410.194146] [102/133] (610s left) kms_frontbuffer_tracking (psr-argb161616f-draw-render)
[410.300605] Starting subtest: psr-argb161616f-draw-render
[410.304990] Subtest psr-argb161616f-draw-render: SKIP (0.000s)
[410.427768] [103/133] (610s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[410.530013] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[410.534124] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[410.649352] [104/133] (610s left) kms_plane_scaling (invalid-num-scalers)
[410.738202] Starting subtest: invalid-num-scalers
[410.740458] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[410.757944] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.018s)
[410.767783] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[410.790790] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[410.800816] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[410.820978] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[410.830740] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[410.853374] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[410.855583] Subtest invalid-num-scalers: SUCCESS (0.116s)
[410.987520] [105/133] (610s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[411.090501] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[411.094794] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[411.201444] [106/133] (609s left) sw_sync (alloc_fence_invalid_timeline)
[411.238436] Starting subtest: alloc_fence_invalid_timeline
[411.240500] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[411.328191] [107/133] (609s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[411.387497] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[411.487691] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.101s)
[411.587369] [108/133] (609s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[411.684684] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[411.688678] Starting dynamic subtest: A-eDP1
[420.614918] Dynamic subtest A-eDP1: SUCCESS (8.927s)
[420.625396] Starting dynamic subtest: B-eDP1
[429.541809] Dynamic subtest B-eDP1: SUCCESS (8.924s)
[429.553805] Starting dynamic subtest: C-eDP1
[438.453356] Dynamic subtest C-eDP1: SUCCESS (8.908s)
[438.466710] Starting dynamic subtest: D-eDP1
[447.373505] Dynamic subtest D-eDP1: SUCCESS (8.916s)
[447.378649] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.687s)
[448.613317] [109/133] (572s left) kms_addfb_basic (size-max)
[448.727063] Starting subtest: size-max
[448.729231] Subtest size-max: SUCCESS (0.000s)
[448.881093] [110/133] (572s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[449.116750] Starting subtest: cursor-rapid-movement-256x256
[449.121477] Starting dynamic subtest: pipe-A-eDP-1
[449.658319] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.537s)
[449.688617] Starting dynamic subtest: pipe-D-eDP-1
[450.880782] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.201s)
[450.883196] Subtest cursor-rapid-movement-256x256: SUCCESS (1.763s)
[451.767013] [111/133] (569s left) gem_exec_whisper (basic-queues-all)
[451.839403] Starting subtest: basic-queues-all
[460.368957] Subtest basic-queues-all: SUCCESS (8.528s)
[460.580555] [112/133] (560s left) kms_dsc (dsc-fractional-bpp)
[460.675673] Starting subtest: dsc-fractional-bpp
[460.689140] Subtest dsc-fractional-bpp: SKIP (0.001s)
[460.777481] [113/133] (560s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[460.875102] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[460.877316] Starting dynamic subtest: pipe-A-default-mode
[461.181077] Dynamic subtest pipe-A-default-mode: SKIP (0.303s)
[461.185699] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.306s)
[462.008005] [114/133] (559s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[462.112699] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[462.117140] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[462.251432] [115/133] (559s left) gem_softpin (evict-prime)
[462.307505] Starting subtest: evict-prime
[462.309725] Starting dynamic subtest: rcs0
[463.479847] Dynamic subtest rcs0: SUCCESS (1.172s)
[463.492671] Starting dynamic subtest: bcs0
[464.624753] Dynamic subtest bcs0: SUCCESS (1.142s)
[464.637398] Starting dynamic subtest: vcs0
[465.955463] Dynamic subtest vcs0: SUCCESS (1.327s)
[465.968335] Starting dynamic subtest: vcs1
[468.013556] Dynamic subtest vcs1: SUCCESS (2.056s)
[468.026494] Starting dynamic subtest: vecs0
[469.963434] Dynamic subtest vecs0: SUCCESS (1.947s)
[469.976205] Starting dynamic subtest: ccs0
[471.124102] Dynamic subtest ccs0: SUCCESS (1.159s)
[471.137127] Starting dynamic subtest: all
[472.937677] Dynamic subtest all: SUCCESS (1.809s)
[472.940329] Subtest evict-prime: SUCCESS (10.628s)
[473.046837] [116/133] (548s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[473.154157] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[473.158235] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[473.284821] [117/133] (548s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[473.379083] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[473.501763] [118/133] (548s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[473.563533] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[473.673077] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.108s)
[473.778440] [119/133] (547s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[473.887490] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[473.891869] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[474.013392] [120/133] (547s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[474.113570] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[478.200512] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.090s)
[479.417585] [121/133] (542s left) gem_mmap_wc (bad-size)
[479.486036] Subtest bad-size: SKIP (0.000s)
[479.556057] [122/133] (542s left) kms_hdr (static-toggle-suspend)
[479.643572] Starting subtest: static-toggle-suspend
[479.650007] Subtest static-toggle-suspend: SKIP (0.000s)
[479.739800] [123/133] (542s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[479.830332] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[479.834762] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[479.971431] [124/133] (541s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[484.966121] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[484.968422] Starting dynamic subtest: pipe-A-eDP-1
[485.754437] Dynamic subtest pipe-A-eDP-1: SKIP (0.784s)
[485.765184] Starting dynamic subtest: pipe-B-eDP-1
[486.891878] Dynamic subtest pipe-B-eDP-1: SKIP (1.135s)
[486.896378] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.924s)
[488.103685] [125/133] (533s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[488.203236] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[488.207139] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[488.338324] [126/133] (533s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[488.423367] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[488.425472] Starting dynamic subtest: pipe-A-eDP-1
[488.445108] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[488.457302] Starting dynamic subtest: pipe-B-eDP-1
[488.475185] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[488.484681] Starting dynamic subtest: pipe-C-eDP-1
[488.503150] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[488.512428] Starting dynamic subtest: pipe-D-eDP-1
[488.531609] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[488.533515] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.006s)
[490.769987] [127/133] (531s left) syncobj_timeline (single-wait-all-available-submitted)
[490.822448] Starting subtest: single-wait-all-available-submitted
[490.824412] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[490.957275] [128/133] (531s left) gem_exec_parallel (userptr)
[491.013396] Starting subtest: userptr
[491.015682] Starting dynamic subtest: rcs0
[492.454891] Dynamic subtest rcs0: SUCCESS (1.441s)
[492.467643] Starting dynamic subtest: bcs0
[493.933550] Dynamic subtest bcs0: SUCCESS (1.476s)
[493.950779] Starting dynamic subtest: vcs0
[496.011819] Dynamic subtest vcs0: SUCCESS (2.075s)
[496.023798] Starting dynamic subtest: vcs1
[497.997376] Dynamic subtest vcs1: SUCCESS (1.982s)
[498.010116] Starting dynamic subtest: vecs0
[499.979075] Dynamic subtest vecs0: SUCCESS (1.979s)
[499.988753] Starting dynamic subtest: ccs0
[501.477021] Dynamic subtest ccs0: SUCCESS (1.496s)
[501.479969] Subtest userptr: SUCCESS (10.462s)
[501.692258] [129/133] (520s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[501.790161] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[501.794140] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[501.924470] [130/133] (520s left) i915_selftest (mock)
[505.498678] Starting subtest: mock
[505.500799] Starting dynamic subtest: sanitycheck
[506.227398] Dynamic subtest sanitycheck: SUCCESS (0.728s)
[506.237295] Starting dynamic subtest: shmem
[506.967003] Dynamic subtest shmem: SUCCESS (0.738s)
[506.977131] Starting dynamic subtest: fence
[515.213255] Dynamic subtest fence: SUCCESS (8.241s)
[515.223280] Starting dynamic subtest: scatterlist
[516.952447] Dynamic subtest scatterlist: SUCCESS (1.737s)
[516.962470] Starting dynamic subtest: syncmap
[520.290488] Dynamic subtest syncmap: SUCCESS (3.335s)
[520.300831] Starting dynamic subtest: uncore
[521.012283] Dynamic subtest uncore: SUCCESS (0.720s)
[521.021991] Starting dynamic subtest: ring
[521.732208] Dynamic subtest ring: SUCCESS (0.718s)
[521.742226] Starting dynamic subtest: engine
[522.446348] Dynamic subtest engine: SUCCESS (0.712s)
[522.454847] Starting dynamic subtest: timelines
[526.337127] Dynamic subtest timelines: SUCCESS (3.887s)
[526.346757] Starting dynamic subtest: requests
[529.850230] Dynamic subtest requests: SUCCESS (3.510s)
[529.860031] Starting dynamic subtest: objects
[530.721691] Dynamic subtest objects: SUCCESS (0.869s)
[530.731767] Starting dynamic subtest: phys
[531.564711] Dynamic subtest phys: SUCCESS (0.841s)
[531.574195] Starting dynamic subtest: dmabuf
[532.363396] Dynamic subtest dmabuf: SUCCESS (0.797s)
[532.373062] Starting dynamic subtest: vma
[537.626642] Dynamic subtest vma: SUCCESS (5.259s)
[537.636378] Starting dynamic subtest: evict
[539.039040] Dynamic subtest evict: SUCCESS (1.410s)
[539.048974] Starting dynamic subtest: gtt
[542.762815] Dynamic subtest gtt: SUCCESS (3.721s)
[542.772401] Starting dynamic subtest: hugepages
[543.750455] Dynamic subtest hugepages: SUCCESS (0.985s)
[543.760562] Starting dynamic subtest: memory_region
[546.324396] Dynamic subtest memory_region: SUCCESS (2.571s)
[546.327415] Subtest mock: SUCCESS (40.817s)
[546.357330] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[546.358074] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[546.361164] [131/133] (475s left) gem_mmap_gtt (basic-write-read)
[547.861663] Subtest basic-write-read: SKIP (0.000s)
[547.914143] [FACT gem_mmap_gtt (basic-write-read)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[547.915551] [FACT gem_mmap_gtt (basic-write-read)] new: kernel.kmod_is_loaded.i915: true
[547.919230] [132/133] (474s left) perf (gen12-group-exclusive-stream-sample-oa)
[548.068260] Starting subtest: gen12-group-exclusive-stream-sample-oa
[548.088601] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.020s)
[548.130252] [133/133] (474s left) perf_pmu (busy-double-start)
[548.170569] Starting subtest: busy-double-start
[548.172655] Starting dynamic subtest: rcs0
[551.813700] Dynamic subtest rcs0: FAIL (3.593s)
[551.822784] Starting dynamic subtest: bcs0
[555.332948] Dynamic subtest bcs0: SUCCESS (3.569s)
[555.342399] Starting dynamic subtest: vcs0
[559.508622] Dynamic subtest vcs0: SUCCESS (4.173s)
[559.519430] Starting dynamic subtest: vcs1
[563.572066] Dynamic subtest vcs1: SUCCESS (4.060s)
[563.583535] Starting dynamic subtest: vecs0
[567.506747] Dynamic subtest vecs0: SUCCESS (3.932s)
[567.517835] Starting dynamic subtest: ccs0
[571.142730] Dynamic subtest ccs0: FAIL (3.564s)
[571.145217] Subtest busy-double-start: FAIL (22.901s)
[571.217928] 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.