[57.409395] Initializing watchdogs
[57.409440]   /dev/watchdog0
[57.423882] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.428608] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.430821] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.432842] [001/133] (960s left) gem_partial_pwrite_pread (write-snoop)
[57.507299] Subtest write-snoop: SKIP (0.000s)
[57.576439] [002/133] (960s left) kms_content_protection (content-type-change)
[57.727610] Starting subtest: content-type-change
[57.729713] Subtest content-type-change: SKIP (0.000s)
[57.882223] [003/133] (960s left) kms_rotation_crc (multiplane-rotation)
[57.977140] Starting subtest: multiplane-rotation
[75.311551] Subtest multiplane-rotation: SUCCESS (17.335s)
[75.462973] [004/133] (942s left) kms_chamelium_color (ctm-red-to-blue)
[75.543935] Subtest ctm-red-to-blue: SKIP (0.000s)
[75.580354] [005/133] (942s left) syncobj_wait (invalid-reset-one-illegal-handle)
[75.629086] Starting subtest: invalid-reset-one-illegal-handle
[75.629989] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[75.715775] [006/133] (942s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[75.801338] Starting subtest: disable-crc-after-crtc
[75.802224] Starting dynamic subtest: pipe-A-eDP-1
[77.480278] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.678s)
[77.486812] Starting dynamic subtest: pipe-B-eDP-1
[79.756776] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.275s)
[79.763227] Starting dynamic subtest: pipe-C-eDP-1
[82.008680] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.250s)
[82.015060] Starting dynamic subtest: pipe-D-eDP-1
[84.268877] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.259s)
[84.269936] Subtest disable-crc-after-crtc: SUCCESS (8.468s)
[85.123859] [007/133] (932s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[85.183249] Subtest tiled-to-tiled: SKIP (0.000s)
[85.242800] [008/133] (932s left) syncobj_wait (wait-all-interrupted)
[85.296474] Starting subtest: wait-all-interrupted
[85.401057] Subtest wait-all-interrupted: SUCCESS (0.102s)
[85.491198] [009/133] (932s left) syncobj_wait (wait-all-complex)
[85.546043] Starting subtest: wait-all-complex
[85.763064] Subtest wait-all-complex: SUCCESS (0.214s)
[85.861351] [010/133] (932s left) gem_pxp (reject-modify-context-protection-on)
[85.976949] Starting subtest: reject-modify-context-protection-on
[85.978249] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[86.116673] [011/133] (932s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[86.244562] Starting subtest: cursorA-vs-flipB-varying-size
[86.246396] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[86.403969] [012/133] (931s left) kms_rotation_crc (primary-rotation-90)
[86.509328] Starting subtest: primary-rotation-90
[86.511202] Subtest primary-rotation-90: SKIP (0.001s)
[86.603339] [013/133] (931s left) syncobj_wait (reset-multiple-signaled)
[86.656738] Starting subtest: reset-multiple-signaled
[86.658199] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[86.796844] [014/133] (931s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[86.896033] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[86.898063] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[88.058238] [015/133] (930s left) gem_softpin (noreloc-s3)
[88.129111] Starting subtest: noreloc-S3
[108.740999] Subtest noreloc-S3: SUCCESS (5.425s)
[111.908121] [016/133] (909s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[112.032660] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[116.559240] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.524s)
[117.770284] [017/133] (903s left) gem_ctx_param (invalid-ctx-set)
[117.827322] Starting subtest: invalid-ctx-set
[117.828981] Subtest invalid-ctx-set: SUCCESS (0.001s)
[117.950780] [018/133] (903s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[118.015779] Starting subtest: single-wait-all-for-submit-unsubmitted
[118.122302] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[118.211744] [019/133] (903s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[118.318928] Starting subtest: x-tiled-64bpp-rotate-90
[118.338872] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[118.490770] [020/133] (903s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[118.546943] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[118.608061] [021/133] (902s left) kms_psr (fbc-psr-cursor-plane-move)
[118.711490] Starting subtest: fbc-psr-cursor-plane-move
[118.712890] Starting dynamic subtest: eDP-1
[118.715268] Dynamic subtest eDP-1: SKIP (0.000s)
[118.717664] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[118.804952] [022/133] (902s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[118.908593] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[119.898922] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.989s)
[120.035732] [023/133] (901s left) kms_flip (2x-flip-vs-rmfb)
[120.133122] Starting subtest: 2x-flip-vs-rmfb
[120.143813] Subtest 2x-flip-vs-rmfb: SKIP (0.010s)
[120.239909] [024/133] (901s left) kms_plane_cursor (viewport)
[120.323649] Starting subtest: viewport
[120.326268] Starting dynamic subtest: pipe-A-eDP-1-size-64
[122.780299] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.455s)
[122.840075] Starting dynamic subtest: pipe-A-eDP-1-size-128
[125.326361] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.493s)
[125.390310] Starting dynamic subtest: pipe-A-eDP-1-size-256
[127.872751] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.493s)
[128.217203] Starting dynamic subtest: pipe-B-eDP-1-size-64
[131.398238] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.185s)
[131.458090] Starting dynamic subtest: pipe-B-eDP-1-size-128
[133.842113] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.393s)
[133.901961] Starting dynamic subtest: pipe-B-eDP-1-size-256
[136.343236] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.449s)
[136.692491] Starting dynamic subtest: pipe-C-eDP-1-size-64
[139.459494] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.773s)
[139.496735] Starting dynamic subtest: pipe-C-eDP-1-size-128
[141.559519] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.069s)
[141.597206] Starting dynamic subtest: pipe-C-eDP-1-size-256
[143.659515] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.069s)
[143.983931] Starting dynamic subtest: pipe-D-eDP-1-size-64
[146.780487] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.804s)
[146.818516] Starting dynamic subtest: pipe-D-eDP-1-size-128
[148.825302] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.013s)
[148.865245] Starting dynamic subtest: pipe-D-eDP-1-size-256
[150.892246] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.034s)
[151.210518] Subtest viewport: SUCCESS (30.881s)
[152.096364] [025/133] (869s left) kms_cdclk (mode-transition)
[152.195957] Starting subtest: mode-transition
[152.197060] Starting dynamic subtest: pipe-A-eDP-1
[152.494967] Dynamic subtest pipe-A-eDP-1: SKIP (0.298s)
[152.501407] Starting dynamic subtest: pipe-B-eDP-1
[152.503396] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[152.509685] Starting dynamic subtest: pipe-C-eDP-1
[152.511454] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[152.517641] Starting dynamic subtest: pipe-D-eDP-1
[152.519303] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[152.521272] Subtest mode-transition: SKIP (0.306s)
[153.318052] [026/133] (868s left) gem_exec_balancer (fairslice)
[153.391614] Starting subtest: fairslice
[156.269351] Subtest fairslice: SUCCESS (2.875s)
[157.123493] [027/133] (864s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[157.231570] Starting subtest: basic-flip-before-cursor-varying-size
[158.161201] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.930s)
[159.055532] [028/133] (862s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[159.133890] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[159.134928] Starting dynamic subtest: pipe-A-default-mode
[159.419881] Dynamic subtest pipe-A-default-mode: SKIP (0.284s)
[159.421723] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.286s)
[160.286243] [029/133] (861s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[160.384128] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[160.385033] Starting dynamic subtest: pipe-A-default-mode
[163.128044] Dynamic subtest pipe-A-default-mode: SUCCESS (2.743s)
[163.128908] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.745s)
[163.987034] [030/133] (857s left) core_getstats (basic)
[164.040163] Starting subtest: basic
[164.041364] Subtest basic: SUCCESS (0.000s)
[164.149466] [031/133] (857s left) kms_rmfb (close-fd)
[164.246477] Starting subtest: close-fd
[164.247761] Starting dynamic subtest: pipe-A-eDP-1
[164.355954] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.109s)
[164.366482] Starting dynamic subtest: pipe-B-eDP-1
[165.528638] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.171s)
[165.536497] Starting dynamic subtest: pipe-C-eDP-1
[166.666292] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.135s)
[166.673423] Starting dynamic subtest: pipe-D-eDP-1
[167.800962] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s)
[167.802061] Subtest close-fd: SUCCESS (3.555s)
[169.022904] [032/133] (852s left) gem_exec_reloc (basic-gtt-wc)
[169.085923] Subtest basic-gtt-wc: SKIP (0.000s)
[169.163133] [033/133] (852s left) kms_properties (crtc-properties-legacy)
[169.258143] Starting subtest: crtc-properties-legacy
[169.259288] Starting dynamic subtest: pipe-A-eDP-1
[169.716046] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.458s)
[169.723645] Starting dynamic subtest: pipe-B-eDP-1
[170.875234] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.157s)
[170.882372] Starting dynamic subtest: pipe-C-eDP-1
[171.998306] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.120s)
[172.005035] Starting dynamic subtest: pipe-D-eDP-1
[173.129374] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.132s)
[173.130952] Subtest crtc-properties-legacy: SUCCESS (3.872s)
[173.965948] [034/133] (848s left) kms_invalid_mode (zero-hdisplay)
[174.060861] Starting subtest: zero-hdisplay
[174.061975] Starting dynamic subtest: pipe-A-eDP-1
[174.342745] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[174.350374] Starting dynamic subtest: pipe-B-eDP-1
[174.351766] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[174.358701] Starting dynamic subtest: pipe-C-eDP-1
[174.359851] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[174.367369] Starting dynamic subtest: pipe-D-eDP-1
[174.368741] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[174.369872] Subtest zero-hdisplay: SUCCESS (0.289s)
[175.189458] [035/133] (846s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[175.273786] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[175.274909] Starting dynamic subtest: pipe-A
[176.335086] Dynamic subtest pipe-A: SUCCESS (1.061s)
[176.344082] Starting dynamic subtest: pipe-B
[178.483103] Dynamic subtest pipe-B: SUCCESS (2.146s)
[178.491673] Starting dynamic subtest: pipe-C
[179.681820] Dynamic subtest pipe-C: SUCCESS (1.198s)
[179.690651] Starting dynamic subtest: pipe-D
[180.825933] Dynamic subtest pipe-D: SUCCESS (1.143s)
[180.827183] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.552s)
[182.035167] [036/133] (839s left) kms_pm_rpm (legacy-planes-dpms)
[184.265501] Starting subtest: legacy-planes-dpms
[184.267296] Starting dynamic subtest: plane-63
[192.835283] Dynamic subtest plane-63: SUCCESS (8.570s)
[192.849328] Starting dynamic subtest: plane-93
[201.423474] Dynamic subtest plane-93: SUCCESS (8.584s)
[201.435714] Starting dynamic subtest: plane-123
[209.745791] Dynamic subtest plane-123: SUCCESS (8.322s)
[209.757211] Starting dynamic subtest: plane-133
[218.073152] Dynamic subtest plane-133: SUCCESS (8.327s)
[218.074397] Subtest legacy-planes-dpms: SUCCESS (33.815s)
[218.446227] [037/133] (803s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[218.546417] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[218.548421] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[218.678577] [038/133] (803s left) kms_dirtyfb (default-dirtyfb-ioctl)
[218.768032] Starting subtest: default-dirtyfb-ioctl
[218.769043] Starting dynamic subtest: A-eDP-1
[220.332810] Dynamic subtest A-eDP-1: SUCCESS (1.564s)
[220.333838] Subtest default-dirtyfb-ioctl: SUCCESS (1.566s)
[221.182423] [039/133] (800s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[221.301111] Starting subtest: cursorB-vs-flipA-legacy
[221.303123] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[221.461178] [040/133] (800s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[221.513482] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[221.514346] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[221.640361] [041/133] (800s left) kms_prime (basic-crc-vgem)
[221.768035] Starting subtest: basic-crc-vgem
[221.769487] Starting dynamic subtest: second-to-first
[222.703370] Dynamic subtest second-to-first: SUCCESS (0.936s)
[222.704837] Subtest basic-crc-vgem: SUCCESS (0.937s)
[222.808221] [FACT kms_prime (basic-crc-vgem)] new: kernel.kmod_is_loaded.vgem: true
[222.810987] [042/133] (799s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[222.901719] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[222.962307] [043/133] (799s left) i915_drm_fdinfo (busy)
[222.996969] Starting subtest: busy
[222.998089] Starting dynamic subtest: rcs0
[223.022430] Dynamic subtest rcs0: SKIP (0.024s)
[223.029503] Starting dynamic subtest: bcs0
[223.047991] Dynamic subtest bcs0: SKIP (0.025s)
[223.056523] Starting dynamic subtest: vcs0
[223.059119] Dynamic subtest vcs0: SKIP (0.000s)
[223.066096] Starting dynamic subtest: vcs1
[223.068425] Dynamic subtest vcs1: SKIP (0.000s)
[223.075486] Starting dynamic subtest: vecs0
[223.078066] Dynamic subtest vecs0: SKIP (0.000s)
[223.085113] Starting dynamic subtest: ccs0
[223.086983] Dynamic subtest ccs0: SKIP (0.000s)
[223.088774] Subtest busy: SKIP (0.054s)
[223.139408] [044/133] (799s left) gem_userptr_blits (nohangcheck)
[223.214889] Starting subtest: nohangcheck
[223.504916] Subtest nohangcheck: SUCCESS (0.287s)
[223.654876] [045/133] (798s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[223.765463] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[224.413159] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.648s)
[224.597878] [046/133] (797s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[224.697960] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[224.699859] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[225.801983] [047/133] (796s left) kms_scaling_modes (scaling-mode-full)
[225.891874] Starting subtest: scaling-mode-full
[225.892903] Starting dynamic subtest: pipe-A-eDP-1
[225.987197] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.096s)
[225.997536] Starting dynamic subtest: pipe-B-eDP-1
[227.217416] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.230s)
[227.227128] Starting dynamic subtest: pipe-C-eDP-1
[228.327989] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.107s)
[228.339839] Starting dynamic subtest: pipe-D-eDP-1
[229.463123] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s)
[229.464161] Subtest scaling-mode-full: SUCCESS (3.575s)
[230.638507] [048/133] (791s left) kms_psr (fbc-pr-basic)
[230.715915] Starting subtest: fbc-pr-basic
[230.718020] Subtest fbc-pr-basic: SKIP (0.000s)
[230.804621] [049/133] (791s left) gem_ringfill (basic-all)
[236.072342] Starting subtest: basic-all
[237.251904] Subtest basic-all: SUCCESS (1.178s)
[237.420269] [050/133] (785s left) gem_exec_whisper (basic-fds-forked-all)
[237.491240] Starting subtest: basic-fds-forked-all
[262.315510] Subtest basic-fds-forked-all: SUCCESS (24.824s)
[262.517843] [051/133] (759s left) api_intel_bb (full-batch)
[262.569019] Starting subtest: full-batch
[262.579879] Subtest full-batch: SUCCESS (0.011s)
[262.735085] [052/133] (759s left) kms_cursor_crc (cursor-sliding-256x85)
[262.999503] Starting subtest: cursor-sliding-256x85
[263.038932] Subtest cursor-sliding-256x85: SKIP (0.037s)
[263.250803] [053/133] (759s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[263.335967] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[263.337017] Starting dynamic subtest: pipe-A-eDP-1
[263.360102] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[263.368085] Starting dynamic subtest: pipe-B-eDP-1
[263.391133] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[263.399101] Starting dynamic subtest: pipe-C-eDP-1
[263.423576] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[263.431484] Starting dynamic subtest: pipe-D-eDP-1
[263.456086] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[263.457942] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.009s)
[265.512594] [054/133] (757s left) gen9_exec_parse (allowed-single)
[265.573130] Subtest allowed-single: SKIP (0.000s)
[265.627721] [055/133] (757s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[265.735873] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[272.711080] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.977s)
[272.831531] [056/133] (749s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[272.936600] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[272.938670] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[273.062447] [057/133] (749s left) gem_exec_fence (expired-history)
[273.569951] Starting subtest: expired-history
[280.804167] Subtest expired-history: SUCCESS (7.233s)
[281.409755] [058/133] (741s left) kms_psr (fbc-psr-sprite-plane-move)
[281.507052] Starting subtest: fbc-psr-sprite-plane-move
[281.508055] Starting dynamic subtest: eDP-1
[281.510197] Dynamic subtest eDP-1: SKIP (0.000s)
[281.512667] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[281.604084] [059/133] (741s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[281.699482] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[288.423379] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.725s)
[288.564310] [060/133] (734s left) gem_ctx_bad_destroy (double-destroy)
[288.612769] Starting subtest: double-destroy
[288.614261] Subtest double-destroy: SUCCESS (0.000s)
[288.718939] [061/133] (734s left) syncobj_timeline (invalid-signal-illegal-handle)
[288.773232] Starting subtest: invalid-signal-illegal-handle
[288.774405] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[288.900732] [062/133] (733s left) kms_chamelium_hpd (common-hpd-after-suspend)
[289.276585] Subtest common-hpd-after-suspend: SKIP (0.000s)
[290.036420] [063/133] (732s left) kms_frontbuffer_tracking (fbc-tiling-4)
[290.121345] Starting subtest: fbc-tiling-4
[294.348153] Subtest fbc-tiling-4: SUCCESS (4.228s)
[295.511219] [064/133] (727s left) gem_cs_tlb (engines)
[295.575134] Starting subtest: engines
[295.576304] Starting dynamic subtest: rcs0
[297.731386] Dynamic subtest rcs0: SUCCESS (2.153s)
[297.741384] Starting dynamic subtest: bcs0
[299.885247] Dynamic subtest bcs0: SUCCESS (2.153s)
[299.900513] Starting dynamic subtest: vcs0
[302.041751] Dynamic subtest vcs0: SUCCESS (2.154s)
[302.052186] Starting dynamic subtest: vcs1
[304.194271] Dynamic subtest vcs1: SUCCESS (2.153s)
[304.203028] Starting dynamic subtest: vecs0
[306.350257] Dynamic subtest vecs0: SUCCESS (2.153s)
[306.358892] Starting dynamic subtest: ccs0
[308.504782] Dynamic subtest ccs0: SUCCESS (2.154s)
[308.506049] Subtest engines: SUCCESS (12.927s)
[308.664428] [065/133] (714s left) gem_mmap_gtt (hang-busy)
[308.720340] Subtest hang-busy: SKIP (0.000s)
[308.779175] [066/133] (714s left) kms_psr (psr2-sprite-plane-onoff)
[308.873433] Starting subtest: psr2-sprite-plane-onoff
[308.874810] Starting dynamic subtest: eDP-1
[310.620689] Dynamic subtest eDP-1: SUCCESS (1.747s)
[310.621544] Subtest psr2-sprite-plane-onoff: SUCCESS (1.748s)
[311.473531] [067/133] (711s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[311.574018] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[312.232345] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.659s)
[312.444598] [068/133] (710s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[312.543661] Starting subtest: y-tiled-64bpp-rotate-270
[312.546121] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[312.659278] [069/133] (710s left) gem_bad_reloc (negative-reloc-lut)
[312.719240] Subtest negative-reloc-lut: SKIP (0.000s)
[312.784523] [070/133] (710s left) gem_ctx_persistence (engines-mixed)
[312.837334] Starting subtest: engines-mixed
[312.838722] Starting dynamic subtest: rcs0
[312.942430] Dynamic subtest rcs0: SUCCESS (0.105s)
[312.954502] Starting dynamic subtest: bcs0
[313.007134] Dynamic subtest bcs0: SUCCESS (0.063s)
[313.017779] Starting dynamic subtest: vcs0
[313.055906] Dynamic subtest vcs0: SUCCESS (0.047s)
[313.065350] Starting dynamic subtest: vcs1
[313.135142] Dynamic subtest vcs1: SUCCESS (0.077s)
[313.146202] Starting dynamic subtest: vecs0
[313.210104] Dynamic subtest vecs0: SUCCESS (0.073s)
[313.221722] Starting dynamic subtest: ccs0
[313.289066] Dynamic subtest ccs0: SUCCESS (0.077s)
[313.290419] Subtest engines-mixed: SUCCESS (0.453s)
[313.385687] [071/133] (709s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[313.479904] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[313.481221] Starting dynamic subtest: pipe-A
[313.545898] Dynamic subtest pipe-A: SUCCESS (0.065s)
[313.555058] Starting dynamic subtest: pipe-B
[314.680368] Dynamic subtest pipe-B: SUCCESS (1.133s)
[314.692236] Starting dynamic subtest: pipe-C
[315.786608] Dynamic subtest pipe-C: SUCCESS (1.104s)
[315.794343] Starting dynamic subtest: pipe-D
[316.911082] Dynamic subtest pipe-D: SUCCESS (1.124s)
[316.913020] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.433s)
[318.092368] [072/133] (705s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[318.190248] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[318.192038] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[318.321290] [073/133] (704s left) gem_exec_schedule (semaphore-noskip)
[318.382312] Starting subtest: semaphore-noskip
[318.844978] Subtest semaphore-noskip: SUCCESS (0.461s)
[319.224425] [074/133] (704s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[319.329125] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[319.331160] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[319.461165] [075/133] (703s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[319.553420] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[319.555805] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[319.683861] [076/133] (703s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[319.787253] Starting subtest: 4-tiled-16bpp-rotate-0
[321.121236] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.335s)
[321.284757] [077/133] (702s left) gem_exec_basic (basic)
[321.345038] Starting subtest: basic
[321.346261] Starting dynamic subtest: rcs0-smem
[321.348747] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[321.356526] Starting dynamic subtest: bcs0-smem
[321.357352] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[321.365362] Starting dynamic subtest: vcs0-smem
[321.366505] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[321.374175] Starting dynamic subtest: vcs1-smem
[321.375194] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[321.383181] Starting dynamic subtest: vecs0-smem
[321.384372] Dynamic subtest vecs0-smem: SUCCESS (0.003s)
[321.392397] Starting dynamic subtest: ccs0-smem
[321.393664] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[321.394772] Subtest basic: SUCCESS (0.017s)
[323.169293] [078/133] (700s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[323.259883] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[323.261756] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[323.365498] [079/133] (700s left) gem_mmap (short-mmap)
[323.423974] Subtest short-mmap: SKIP (0.000s)
[323.475358] [080/133] (700s left) gem_exec_reloc (basic-gtt-wc-active)
[323.532276] Subtest basic-gtt-wc-active: SKIP (0.000s)
[323.606253] [081/133] (699s left) gem_ctx_shared (create-shared-gtt)
[323.667130] Starting subtest: create-shared-gtt
[325.819519] Subtest create-shared-gtt: SUCCESS (2.153s)
[326.249794] [082/133] (697s left) gem_exec_reloc (basic-write-wc)
[326.306304] Subtest basic-write-wc: SKIP (0.000s)
[326.382976] [083/133] (697s left) gem_eio (wait-immediate)
[326.664514] Starting subtest: wait-immediate
[327.102432] Subtest wait-immediate: SUCCESS (0.438s)
[327.292334] [084/133] (696s left) gem_ctx_persistence (legacy-engines-mixed)
[327.339365] Starting subtest: legacy-engines-mixed
[327.340809] Starting dynamic subtest: render
[327.432289] Dynamic subtest render: SUCCESS (0.092s)
[327.445901] Starting dynamic subtest: bsd1
[327.505375] Dynamic subtest bsd1: SUCCESS (0.070s)
[327.518798] Starting dynamic subtest: bsd2
[327.590480] Dynamic subtest bsd2: SUCCESS (0.082s)
[327.603547] Starting dynamic subtest: blt
[327.665255] Dynamic subtest blt: SUCCESS (0.072s)
[327.677478] Starting dynamic subtest: vebox
[327.743409] Dynamic subtest vebox: SUCCESS (0.075s)
[327.745158] Subtest legacy-engines-mixed: SUCCESS (0.405s)
[327.841705] [085/133] (695s left) perf_pmu (semaphore-busy)
[327.879530] Starting subtest: semaphore-busy
[327.880971] Starting dynamic subtest: rcs0
[329.521270] Dynamic subtest rcs0: SUCCESS (1.639s)
[329.532741] Starting dynamic subtest: bcs0
[331.156428] Dynamic subtest bcs0: SUCCESS (1.633s)
[331.167515] Starting dynamic subtest: vcs0
[335.581248] Dynamic subtest vcs0: SUCCESS (4.424s)
[335.593212] Starting dynamic subtest: vcs1
[341.600990] Dynamic subtest vcs1: SUCCESS (6.014s)
[341.612085] Starting dynamic subtest: vecs0
[347.616360] Dynamic subtest vecs0: SUCCESS (6.012s)
[347.627901] Starting dynamic subtest: ccs0
[350.693021] Dynamic subtest ccs0: SUCCESS (3.073s)
[350.694482] Subtest semaphore-busy: SUCCESS (22.811s)
[350.849879] [086/133] (672s left) gem_exec_schedule (pi-common)
[351.045498] Starting subtest: pi-common
[351.047144] Starting dynamic subtest: rcs0
[351.086673] Dynamic subtest rcs0: SUCCESS (0.044s)
[351.096409] Starting dynamic subtest: bcs0
[351.123320] Dynamic subtest bcs0: SUCCESS (0.036s)
[351.132019] Starting dynamic subtest: vcs0
[351.171393] Dynamic subtest vcs0: SUCCESS (0.047s)
[351.180255] Starting dynamic subtest: vcs1
[351.205146] Dynamic subtest vcs1: SUCCESS (0.033s)
[351.213622] Starting dynamic subtest: vecs0
[351.240517] Dynamic subtest vecs0: SUCCESS (0.034s)
[351.249224] Starting dynamic subtest: ccs0
[351.276497] Dynamic subtest ccs0: SUCCESS (0.035s)
[351.278057] Subtest pi-common: SUCCESS (0.234s)
[351.547035] [087/133] (672s left) i915_hangman (engine-error-state-capture)
[351.611365] Starting subtest: engine-error-state-capture
[351.612713] Starting dynamic subtest: rcs0
[357.060318] Dynamic subtest rcs0: SUCCESS (5.446s)
[357.072243] Starting dynamic subtest: bcs0
[363.076504] Dynamic subtest bcs0: SUCCESS (6.013s)
[363.088877] Starting dynamic subtest: vcs0
[369.029495] Dynamic subtest vcs0: SUCCESS (5.950s)
[369.039142] Starting dynamic subtest: vcs1
[375.044098] Dynamic subtest vcs1: SUCCESS (6.013s)
[375.057579] Starting dynamic subtest: vecs0
[380.034972] Dynamic subtest vecs0: SUCCESS (4.988s)
[380.046715] Starting dynamic subtest: ccs0
[385.028006] Dynamic subtest ccs0: SUCCESS (4.987s)
[385.029826] Subtest engine-error-state-capture: SUCCESS (33.414s)
[385.128845] [088/133] (638s left) syncobj_timeline (wait-for-submit-snapshot)
[385.176703] Starting subtest: wait-for-submit-snapshot
[385.261603] Subtest wait-for-submit-snapshot: SUCCESS (0.084s)
[385.358421] [089/133] (638s left) kms_color (ctm-blue-to-red)
[385.462514] Starting subtest: ctm-blue-to-red
[385.463865] Starting dynamic subtest: pipe-A-eDP-1
[386.169504] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.708s)
[386.178397] Starting dynamic subtest: pipe-B-eDP-1
[387.536485] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.365s)
[387.545478] Starting dynamic subtest: pipe-C-eDP-1
[388.815165] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.277s)
[388.824279] Starting dynamic subtest: pipe-D-eDP-1
[390.148106] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.333s)
[390.149115] Subtest ctm-blue-to-red: SUCCESS (4.686s)
[391.018762] [090/133] (632s left) prime_vgem (basic-gtt)
[391.112916] Starting subtest: basic-gtt
[391.115402] Subtest basic-gtt: SKIP (0.000s)
[391.261305] [091/133] (632s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[391.360183] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[398.651701] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.292s)
[398.827821] [092/133] (625s left) api_intel_allocator (default-alignment)
[398.887341] Starting subtest: default-alignment
[398.892803] Subtest default-alignment: SUCCESS (0.006s)
[399.053119] [093/133] (624s left) i915_pm_rps (fence-order)
[399.104788] Starting subtest: fence-order
[402.529749] Subtest fence-order: SUCCESS (3.425s)
[402.686580] [094/133] (621s left) kms_vblank (query-busy)
[402.779295] Starting subtest: query-busy
[402.780273] Starting dynamic subtest: pipe-A-eDP-1
[404.668167] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.887s)
[404.678798] Starting dynamic subtest: pipe-D-eDP-1
[407.231904] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.560s)
[407.233331] Subtest query-busy: SUCCESS (4.452s)
[408.051794] [095/133] (615s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[408.164241] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[408.166800] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[408.290619] [096/133] (615s left) kms_addfb_basic (invalid-get-prop-any)
[408.331541] Starting subtest: invalid-get-prop-any
[408.332395] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[408.480798] [097/133] (615s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[408.564154] Starting subtest: fbc-psr2-cursor-mmap-gtt
[408.565038] Starting dynamic subtest: eDP-1
[408.566803] Dynamic subtest eDP-1: SKIP (0.000s)
[408.568618] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[408.653791] [098/133] (615s left) kms_flip (2x-blocking-absolute-wf_vblank)
[408.756870] Starting subtest: 2x-blocking-absolute-wf_vblank
[408.772676] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.015s)
[408.902377] [099/133] (615s left) kms_cursor_crc (cursor-onscreen-256x85)
[409.163764] Starting subtest: cursor-onscreen-256x85
[409.204544] Subtest cursor-onscreen-256x85: SKIP (0.039s)
[409.429440] [100/133] (614s left) kms_flip (2x-modeset-vs-vblank-race)
[409.517509] Starting subtest: 2x-modeset-vs-vblank-race
[409.528628] Subtest 2x-modeset-vs-vblank-race: SKIP (0.010s)
[409.663685] [101/133] (614s left) kms_atomic_interruptible (atomic-setmode)
[409.771262] Starting subtest: atomic-setmode
[409.772517] Starting dynamic subtest: pipe-A-eDP-1
[416.668850] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.895s)
[416.669952] Subtest atomic-setmode: SUCCESS (6.897s)
[417.486992] [102/133] (606s left) kms_frontbuffer_tracking (psr-argb161616f-draw-render)
[417.583854] Starting subtest: psr-argb161616f-draw-render
[417.585803] Subtest psr-argb161616f-draw-render: SKIP (0.000s)
[417.692856] [103/133] (606s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[417.783884] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[417.786093] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[417.912929] [104/133] (606s left) kms_plane_scaling (invalid-num-scalers)
[418.012537] Starting subtest: invalid-num-scalers
[418.014003] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[418.028801] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.016s)
[418.037493] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[418.058057] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.028s)
[418.067268] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[418.101796] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.042s)
[418.111514] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[418.131730] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.028s)
[418.133775] Subtest invalid-num-scalers: SUCCESS (0.122s)
[418.286338] [105/133] (606s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[418.385095] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[418.386984] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[418.512750] [106/133] (605s left) sw_sync (alloc_fence_invalid_timeline)
[418.548219] Starting subtest: alloc_fence_invalid_timeline
[418.549305] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[418.622847] [107/133] (605s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[418.683491] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[418.784007] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.101s)
[418.881054] [108/133] (605s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[418.977536] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[418.980095] Starting dynamic subtest: A-eDP1
[427.923307] Dynamic subtest A-eDP1: SUCCESS (8.943s)
[427.933664] Starting dynamic subtest: B-eDP1
[436.857134] Dynamic subtest B-eDP1: SUCCESS (8.931s)
[436.867940] Starting dynamic subtest: C-eDP1
[445.778083] Dynamic subtest C-eDP1: SUCCESS (8.918s)
[445.788182] Starting dynamic subtest: D-eDP1
[454.713064] Dynamic subtest D-eDP1: SUCCESS (8.932s)
[454.717096] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.737s)
[455.974164] [109/133] (568s left) kms_addfb_basic (size-max)
[456.068196] Starting subtest: size-max
[456.069311] Subtest size-max: SUCCESS (0.000s)
[456.184158] [110/133] (568s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[456.415192] Starting subtest: cursor-rapid-movement-256x256
[456.417725] Starting dynamic subtest: pipe-A-eDP-1
[456.946350] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.528s)
[456.974130] Starting dynamic subtest: pipe-D-eDP-1
[458.139159] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.173s)
[458.140271] Subtest cursor-rapid-movement-256x256: SUCCESS (1.723s)
[459.020759] [111/133] (565s left) gem_exec_whisper (basic-queues-all)
[459.089460] Starting subtest: basic-queues-all
[467.140626] Subtest basic-queues-all: SUCCESS (8.047s)
[467.344683] [112/133] (557s left) kms_dsc (dsc-fractional-bpp)
[467.439489] Starting subtest: dsc-fractional-bpp
[467.446124] Subtest dsc-fractional-bpp: SKIP (0.000s)
[467.530050] [113/133] (557s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[467.616010] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[467.617198] Starting dynamic subtest: pipe-A-default-mode
[467.901926] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[467.904110] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.286s)
[468.751999] [114/133] (555s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[468.850250] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[468.852397] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[468.975432] [115/133] (555s left) gem_softpin (evict-prime)
[469.023191] Starting subtest: evict-prime
[469.024327] Starting dynamic subtest: rcs0
[470.220781] Dynamic subtest rcs0: SUCCESS (1.197s)
[470.238008] Starting dynamic subtest: bcs0
[471.383538] Dynamic subtest bcs0: SUCCESS (1.161s)
[471.394910] Starting dynamic subtest: vcs0
[473.152938] Dynamic subtest vcs0: SUCCESS (1.764s)
[473.164387] Starting dynamic subtest: vcs1
[475.078063] Dynamic subtest vcs1: SUCCESS (1.922s)
[475.089950] Starting dynamic subtest: vecs0
[477.125236] Dynamic subtest vecs0: SUCCESS (2.044s)
[477.137066] Starting dynamic subtest: ccs0
[478.269669] Dynamic subtest ccs0: SUCCESS (1.144s)
[478.281855] Starting dynamic subtest: all
[480.076379] Dynamic subtest all: SUCCESS (1.802s)
[480.077970] Subtest evict-prime: SUCCESS (11.052s)
[480.234592] [116/133] (544s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[480.330391] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[480.332384] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[480.467941] [117/133] (544s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[480.557346] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[480.672254] [118/133] (544s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[480.727537] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[480.833854] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.105s)
[480.928682] [119/133] (543s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[481.034651] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[481.036478] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[481.176939] [120/133] (543s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[481.275356] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[485.378173] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.102s)
[486.566087] [121/133] (538s left) gem_mmap_wc (bad-size)
[486.628872] Subtest bad-size: SKIP (0.000s)
[486.686303] [122/133] (538s left) kms_hdr (static-toggle-suspend)
[486.780392] Starting subtest: static-toggle-suspend
[486.783718] Subtest static-toggle-suspend: SKIP (0.000s)
[486.878085] [123/133] (538s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[486.963743] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[486.965645] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[487.099130] [124/133] (537s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[492.114191] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[492.115167] Starting dynamic subtest: pipe-A-eDP-1
[492.915079] Dynamic subtest pipe-A-eDP-1: SKIP (0.798s)
[492.926800] Starting dynamic subtest: pipe-B-eDP-1
[494.044725] Dynamic subtest pipe-B-eDP-1: SKIP (1.128s)
[494.046428] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.931s)
[495.257762] [125/133] (529s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[495.352711] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[495.354803] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[495.484606] [126/133] (529s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[495.575246] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[495.576241] Starting dynamic subtest: pipe-A-eDP-1
[495.584248] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[495.592991] Starting dynamic subtest: pipe-B-eDP-1
[495.602134] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[495.611421] Starting dynamic subtest: pipe-C-eDP-1
[495.618864] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[495.626865] Starting dynamic subtest: pipe-D-eDP-1
[495.633916] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[495.634694] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[497.741067] [127/133] (527s left) syncobj_timeline (single-wait-all-available-submitted)
[497.790023] Starting subtest: single-wait-all-available-submitted
[497.791173] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[497.922617] [128/133] (527s left) gem_exec_parallel (userptr)
[497.984061] Starting subtest: userptr
[497.985268] Starting dynamic subtest: rcs0
[499.683853] Dynamic subtest rcs0: SUCCESS (1.699s)
[499.694367] Starting dynamic subtest: bcs0
[501.410756] Dynamic subtest bcs0: SUCCESS (1.726s)
[501.422356] Starting dynamic subtest: vcs0
[503.110390] Dynamic subtest vcs0: SUCCESS (1.697s)
[503.120972] Starting dynamic subtest: vcs1
[505.136471] Dynamic subtest vcs1: SUCCESS (2.024s)
[505.147328] Starting dynamic subtest: vecs0
[507.062525] Dynamic subtest vecs0: SUCCESS (1.922s)
[507.071810] Starting dynamic subtest: ccs0
[508.870900] Dynamic subtest ccs0: SUCCESS (1.810s)
[508.871804] Subtest userptr: SUCCESS (10.887s)
[509.074638] [129/133] (516s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[509.164848] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[509.166411] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[509.277030] [130/133] (515s left) i915_selftest (mock)
[511.215623] Starting subtest: mock
[511.217191] Starting dynamic subtest: sanitycheck
[513.255499] Dynamic subtest sanitycheck: SUCCESS (2.041s)
[513.265374] Starting dynamic subtest: shmem
[515.247684] Dynamic subtest shmem: SUCCESS (1.989s)
[515.256529] Starting dynamic subtest: fence
[524.247799] Dynamic subtest fence: SUCCESS (9.000s)
[524.259354] Starting dynamic subtest: scatterlist
[527.288069] Dynamic subtest scatterlist: SUCCESS (3.036s)
[527.300015] Starting dynamic subtest: syncmap
[531.936460] Dynamic subtest syncmap: SUCCESS (4.645s)
[531.945489] Starting dynamic subtest: uncore
[533.943196] Dynamic subtest uncore: SUCCESS (2.005s)
[533.951938] Starting dynamic subtest: ring
[535.981109] Dynamic subtest ring: SUCCESS (2.036s)
[535.990166] Starting dynamic subtest: engine
[537.962484] Dynamic subtest engine: SUCCESS (1.980s)
[537.973004] Starting dynamic subtest: timelines
[543.158644] Dynamic subtest timelines: SUCCESS (5.193s)
[543.167989] Starting dynamic subtest: requests
[548.036924] Dynamic subtest requests: SUCCESS (4.876s)
[548.045416] Starting dynamic subtest: objects
[550.137393] Dynamic subtest objects: SUCCESS (2.098s)
[550.146472] Starting dynamic subtest: phys
[552.292839] Dynamic subtest phys: SUCCESS (2.152s)
[552.301585] Starting dynamic subtest: dmabuf
[554.397415] Dynamic subtest dmabuf: SUCCESS (2.103s)
[554.406889] Starting dynamic subtest: vma
[561.125349] Dynamic subtest vma: SUCCESS (6.726s)
[561.133736] Starting dynamic subtest: evict
[563.884552] Dynamic subtest evict: SUCCESS (2.759s)
[563.893541] Starting dynamic subtest: gtt
[568.444476] Dynamic subtest gtt: SUCCESS (4.556s)
[568.453337] Starting dynamic subtest: hugepages
[570.719391] Dynamic subtest hugepages: SUCCESS (2.273s)
[570.727393] Starting dynamic subtest: memory_region
[574.647719] Dynamic subtest memory_region: SUCCESS (3.928s)
[574.649461] Subtest mock: SUCCESS (63.433s)
[574.672708] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[574.673368] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[574.675476] [131/133] (450s left) gem_mmap_gtt (basic-write-read)
[577.509005] Subtest basic-write-read: SKIP (0.000s)
[577.572554] [FACT gem_mmap_gtt (basic-write-read)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[577.573976] [FACT gem_mmap_gtt (basic-write-read)] new: kernel.kmod_is_loaded.i915: true
[577.576610] [132/133] (447s left) perf (gen12-group-exclusive-stream-sample-oa)
[577.733675] Starting subtest: gen12-group-exclusive-stream-sample-oa
[577.758854] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.025s)
[577.803891] [133/133] (447s left) perf_pmu (busy-double-start)
[577.848299] Starting subtest: busy-double-start
[577.850243] Starting dynamic subtest: rcs0
[581.482726] Dynamic subtest rcs0: FAIL (3.600s)
[581.490833] Starting dynamic subtest: bcs0
[585.028703] Dynamic subtest bcs0: SUCCESS (3.578s)
[585.040514] Starting dynamic subtest: vcs0
[589.645388] Dynamic subtest vcs0: SUCCESS (4.615s)
[589.658223] Starting dynamic subtest: vcs1
[593.681492] Dynamic subtest vcs1: SUCCESS (4.034s)
[593.693519] Starting dynamic subtest: vecs0
[597.635484] Dynamic subtest vecs0: SUCCESS (3.952s)
[597.647606] Starting dynamic subtest: ccs0
[601.235639] Dynamic subtest ccs0: FAIL (3.566s)
[601.236625] Subtest busy-double-start: FAIL (23.355s)
[601.349873] 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.