[58.684333] Initializing watchdogs
[58.684384]   /dev/watchdog0
[58.698671] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.703193] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.706012] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.709596] [001/133] (960s left) gem_userptr_blits (nohangcheck)
[58.796268] Starting subtest: nohangcheck
[59.147480] Subtest nohangcheck: SUCCESS (0.352s)
[59.272809] [002/133] (959s left) gem_request_retire (retire-vma-not-inactive)
[59.340683] Starting subtest: retire-vma-not-inactive
[59.407624] Subtest retire-vma-not-inactive: SUCCESS (0.064s)
[59.515678] [003/133] (959s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[59.586785] Starting subtest: single-wait-for-submit-available-signaled
[59.589318] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.001s)
[59.696883] [004/133] (959s left) kms_prime (basic-modeset-hybrid)
[59.795884] Subtest basic-modeset-hybrid: SKIP (0.000s)
[59.918121] [FACT kms_prime (basic-modeset-hybrid)] new: kernel.kmod_is_loaded.vgem: true
[59.921321] [005/133] (959s left) gem_render_copy (linear-to-vebox-yf-tiled)
[59.990812] Starting subtest: linear-to-vebox-yf-tiled
[59.996243] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[60.173723] [006/133] (959s left) kms_cursor_crc (cursor-sliding-128x42)
[60.398872] Starting subtest: cursor-sliding-128x42
[60.452093] Subtest cursor-sliding-128x42: SKIP (0.050s)
[60.642816] [007/133] (958s left) kms_psr (psr2-cursor-plane-move)
[60.741044] Starting subtest: psr2-cursor-plane-move
[60.743402] Starting dynamic subtest: eDP-1
[62.417757] Dynamic subtest eDP-1: SUCCESS (1.678s)
[62.420106] Subtest psr2-cursor-plane-move: SUCCESS (1.679s)
[63.299176] [008/133] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[63.400645] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[63.404672] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[63.496816] [009/133] (956s left) perf_pmu (rc6-all-gts)
[63.541390] Starting subtest: rc6-all-gts
[69.903728] Subtest rc6-all-gts: SUCCESS (6.365s)
[70.785200] [010/133] (948s left) gem_mmap_offset (partial-mmap)
[70.847134] Starting subtest: partial-mmap
[70.849217] Starting dynamic subtest: smem0
[70.852722] Dynamic subtest smem0: SUCCESS (0.006s)
[70.855175] Subtest partial-mmap: SUCCESS (0.006s)
[70.959875] [011/133] (948s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[71.071449] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[79.736815] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.671s)
[79.837375] [012/133] (939s left) perf (non-system-wide-paranoid)
[79.971495] Starting subtest: non-system-wide-paranoid
[79.996777] Subtest non-system-wide-paranoid: SUCCESS (0.027s)
[80.047722] [013/133] (939s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[80.151583] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[80.156064] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[80.260926] [014/133] (939s left) i915_hangman (detector)
[80.324253] Starting subtest: detector
[80.326498] Starting dynamic subtest: rcs0
[91.893404] Dynamic subtest rcs0: SUCCESS (11.568s)
[91.904219] Starting dynamic subtest: bcs0
[103.860040] Dynamic subtest bcs0: SUCCESS (11.965s)
[103.871233] Starting dynamic subtest: vcs0
[115.892035] Dynamic subtest vcs0: SUCCESS (12.031s)
[115.905894] Starting dynamic subtest: vcs1
[127.797367] Dynamic subtest vcs1: SUCCESS (11.904s)
[127.807808] Starting dynamic subtest: vecs0
[137.843535] Dynamic subtest vecs0: SUCCESS (10.045s)
[137.853998] Starting dynamic subtest: ccs0
[149.875614] Dynamic subtest ccs0: SUCCESS (12.030s)
[149.878428] Subtest detector: SUCCESS (69.550s)
[149.962085] [015/133] (869s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[150.062704] Starting subtest: plane-lut1d-ctm3x4-lut1d
[150.209069] Starting dynamic subtest: pipe-A-plane-0
[150.574783] Dynamic subtest pipe-A-plane-0: FAIL (0.191s)
[150.585266] Starting dynamic subtest: pipe-A-plane-1
[150.808230] Dynamic subtest pipe-A-plane-1: FAIL (0.173s)
[150.816585] Starting dynamic subtest: pipe-A-plane-2
[151.041406] Dynamic subtest pipe-A-plane-2: FAIL (0.176s)
[151.981477] Starting dynamic subtest: pipe-B-plane-0
[152.439675] Dynamic subtest pipe-B-plane-0: FAIL (0.175s)
[152.449479] Starting dynamic subtest: pipe-B-plane-1
[152.775765] Dynamic subtest pipe-B-plane-1: FAIL (0.177s)
[152.785907] Starting dynamic subtest: pipe-B-plane-2
[153.093049] Dynamic subtest pipe-B-plane-2: FAIL (0.633s)
[154.199131] Starting dynamic subtest: pipe-C-plane-0
[154.734786] Dynamic subtest pipe-C-plane-0: FAIL (0.152s)
[154.745059] Starting dynamic subtest: pipe-C-plane-1
[155.167013] Dynamic subtest pipe-C-plane-1: FAIL (0.641s)
[155.176766] Starting dynamic subtest: pipe-C-plane-2
[155.566060] Dynamic subtest pipe-C-plane-2: FAIL (0.172s)
[156.353458] Starting dynamic subtest: pipe-D-plane-0
[156.975358] Dynamic subtest pipe-D-plane-0: FAIL (0.152s)
[156.984429] Starting dynamic subtest: pipe-D-plane-1
[157.449260] Dynamic subtest pipe-D-plane-1: FAIL (0.602s)
[157.459120] Starting dynamic subtest: pipe-D-plane-2
[157.915773] Dynamic subtest pipe-D-plane-2: FAIL (0.564s)
[157.972292] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (7.909s)
[158.807609] [016/133] (861s left) gem_exec_nop (basic-sequential)
[158.885432] Starting subtest: basic-sequential
[174.994530] Subtest basic-sequential: SUCCESS (16.118s)
[175.227344] [017/133] (844s left) prime_self_import (basic-llseek-size)
[175.261926] Starting subtest: basic-llseek-size
[175.276747] Subtest basic-llseek-size: SUCCESS (0.014s)
[175.391870] [018/133] (844s left) core_getclient (basic)
[175.443812] Starting subtest: basic
[175.446159] Subtest basic: SUCCESS (0.000s)
[175.562702] [019/133] (844s left) kms_flip (basic-flip-vs-dpms)
[175.670941] Starting subtest: basic-flip-vs-dpms
[175.673246] Starting dynamic subtest: A-eDP1
[178.298595] Dynamic subtest A-eDP1: SUCCESS (2.626s)
[178.307533] Starting dynamic subtest: B-eDP1
[180.453950] Dynamic subtest B-eDP1: SUCCESS (2.152s)
[180.464141] Starting dynamic subtest: C-eDP1
[182.624088] Dynamic subtest C-eDP1: SUCCESS (2.170s)
[182.632341] Starting dynamic subtest: D-eDP1
[184.793434] Dynamic subtest D-eDP1: SUCCESS (2.168s)
[184.795752] Subtest basic-flip-vs-dpms: SUCCESS (9.127s)
[185.596822] [020/133] (834s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[185.689582] Starting subtest: fbc-psr2-sprite-mmap-cpu
[185.691693] Starting dynamic subtest: eDP-1
[185.695664] Dynamic subtest eDP-1: SKIP (0.000s)
[185.699692] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[185.761105] [021/133] (834s left) syncobj_wait (invalid-signal-zero-handles)
[185.810828] Starting subtest: invalid-signal-zero-handles
[185.813192] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[185.912535] [022/133] (834s left) i915_suspend (basic-s2idle-without-i915)
[185.940934] Starting subtest: basic-s2idle-without-i915
[205.438729] Subtest basic-s2idle-without-i915: SUCCESS (4.157s)
[205.541692] [023/133] (814s left) kms_content_protection (type1)
[205.705377] Starting subtest: type1
[205.709844] Subtest type1: SKIP (0.000s)
[205.825700] [024/133] (814s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[205.911724] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[205.914023] Starting dynamic subtest: pipe-A-eDP-1
[205.937013] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[205.946445] Starting dynamic subtest: pipe-B-eDP-1
[205.968257] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[205.976611] Starting dynamic subtest: pipe-C-eDP-1
[205.997978] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[206.005865] Starting dynamic subtest: pipe-D-eDP-1
[206.027930] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[206.031980] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[208.194476] [025/133] (811s left) gem_basic (create-fd-close)
[208.247869] Starting subtest: create-fd-close
[208.252693] Subtest create-fd-close: SUCCESS (0.000s)
[208.362721] [026/133] (811s left) kms_plane (plane-position-hole)
[208.473635] Starting subtest: plane-position-hole
[208.994343] Starting dynamic subtest: pipe-A-plane-1
[210.306424] Dynamic subtest pipe-A-plane-1: SUCCESS (1.320s)
[210.318284] Starting dynamic subtest: pipe-A-plane-2
[211.606910] Dynamic subtest pipe-A-plane-2: SUCCESS (1.306s)
[211.616648] Starting dynamic subtest: pipe-A-plane-3
[212.933226] Dynamic subtest pipe-A-plane-3: SUCCESS (1.332s)
[212.943067] Starting dynamic subtest: pipe-A-plane-4
[214.260428] Dynamic subtest pipe-A-plane-4: SUCCESS (1.331s)
[214.269963] Starting dynamic subtest: pipe-A-plane-5
[214.288488] Dynamic subtest pipe-A-plane-5: SUCCESS (0.028s)
[215.508471] Starting dynamic subtest: pipe-B-plane-1
[216.821194] Dynamic subtest pipe-B-plane-1: SUCCESS (1.322s)
[216.830580] Starting dynamic subtest: pipe-B-plane-2
[218.145145] Dynamic subtest pipe-B-plane-2: SUCCESS (1.327s)
[218.154249] Starting dynamic subtest: pipe-B-plane-3
[219.491331] Dynamic subtest pipe-B-plane-3: SUCCESS (1.350s)
[219.500846] Starting dynamic subtest: pipe-B-plane-4
[220.814206] Dynamic subtest pipe-B-plane-4: SUCCESS (1.326s)
[220.822861] Starting dynamic subtest: pipe-B-plane-5
[220.839436] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[220.841725] Subtest plane-position-hole: SUCCESS (12.413s)
[221.688858] [027/133] (798s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[221.782445] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[221.784721] Starting dynamic subtest: pipe-A-eDP-1
[221.844453] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s)
[222.167432] Starting dynamic subtest: pipe-B-eDP-1
[222.986006] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.831s)
[223.292165] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.510s)
[224.139870] [028/133] (796s left) kms_plane_cursor (primary)
[224.243408] Starting subtest: primary
[224.247745] Starting dynamic subtest: pipe-A-eDP-1-size-64
[226.864506] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.625s)
[226.887394] Starting dynamic subtest: pipe-A-eDP-1-size-128
[229.518262] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.639s)
[229.541782] Starting dynamic subtest: pipe-A-eDP-1-size-256
[232.118624] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.583s)
[232.445645] Starting dynamic subtest: pipe-B-eDP-1-size-64
[235.701324] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.269s)
[235.724598] Starting dynamic subtest: pipe-B-eDP-1-size-128
[238.314488] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.594s)
[238.337677] Starting dynamic subtest: pipe-B-eDP-1-size-256
[240.916495] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.583s)
[241.236718] Starting dynamic subtest: pipe-C-eDP-1-size-64
[244.160906] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.943s)
[244.186676] Starting dynamic subtest: pipe-C-eDP-1-size-128
[246.383465] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.202s)
[246.409095] Starting dynamic subtest: pipe-C-eDP-1-size-256
[248.582776] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.180s)
[248.900840] Starting dynamic subtest: pipe-D-eDP-1-size-64
[251.788619] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.898s)
[251.814722] Starting dynamic subtest: pipe-D-eDP-1-size-128
[254.000041] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.191s)
[254.025355] Starting dynamic subtest: pipe-D-eDP-1-size-256
[256.198770] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.180s)
[256.505999] Subtest primary: SUCCESS (32.273s)
[257.353059] [029/133] (762s left) perf (invalid-oa-exponent)
[257.485775] Starting subtest: invalid-oa-exponent
[257.507643] Subtest invalid-oa-exponent: SUCCESS (0.021s)
[257.554233] [030/133] (762s left) gem_mmap_gtt (big-bo-tiledy)
[257.606880] Subtest big-bo-tiledY: SKIP (0.000s)
[257.672679] [031/133] (762s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[257.768554] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[257.773282] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[257.875039] [032/133] (762s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[257.970007] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[257.974140] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[258.066426] [033/133] (762s left) gem_exec_whisper (basic-contexts-forked)
[258.135290] Starting subtest: basic-contexts-forked
[281.808978] Subtest basic-contexts-forked: SUCCESS (23.677s)
[281.996809] [034/133] (738s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[282.097364] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[282.099638] Starting dynamic subtest: pipe-A
[282.162961] Dynamic subtest pipe-A: SUCCESS (0.068s)
[282.171628] Starting dynamic subtest: pipe-B
[283.269361] Dynamic subtest pipe-B: SUCCESS (1.106s)
[283.279965] Starting dynamic subtest: pipe-C
[284.379176] Dynamic subtest pipe-C: SUCCESS (1.108s)
[284.393850] Starting dynamic subtest: pipe-D
[285.505818] Dynamic subtest pipe-D: SUCCESS (1.126s)
[285.507995] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.412s)
[286.663807] [035/133] (733s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[286.725270] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[286.727225] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[286.825765] [036/133] (733s left) kms_psr (fbc-psr2-sprite-render)
[286.932137] Starting subtest: fbc-psr2-sprite-render
[286.934350] Starting dynamic subtest: eDP-1
[286.938220] Dynamic subtest eDP-1: SKIP (0.000s)
[286.942226] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[287.004644] [037/133] (733s left) gem_ctx_persistence (heartbeat-hang)
[287.059921] Starting subtest: heartbeat-hang
[287.064307] Subtest heartbeat-hang: SKIP (0.000s)
[287.157523] [038/133] (733s left) api_intel_bb (blit-noreloc-purge-cache)
[287.216083] Starting subtest: blit-noreloc-purge-cache
[287.225026] Subtest blit-noreloc-purge-cache: SUCCESS (0.012s)
[287.347376] [039/133] (733s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[287.440947] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[287.445044] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[287.528714] [040/133] (733s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[287.618728] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[295.020077] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.406s)
[295.147095] [041/133] (725s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[295.203918] Starting subtest: invalid-single-wait-all-unsubmitted
[295.206103] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[295.297902] [042/133] (725s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[295.352789] Starting subtest: yf-tiled-to-vebox-x-tiled
[295.357203] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[295.536041] [043/133] (725s left) gem_exec_reloc (basic-cpu-read-noreloc)
[295.586024] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[295.641610] [044/133] (725s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[295.739636] Starting subtest: fbcpsr-slowdraw
[320.900943] Subtest fbcpsr-slowdraw: SUCCESS (25.154s)
[321.047079] [045/133] (699s left) gem_mmap_gtt (cpuset-basic-small-copy)
[321.106989] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[321.165364] [046/133] (699s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[321.257155] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[321.268784] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.011s)
[321.388142] [047/133] (699s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[321.481543] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[321.483710] Starting dynamic subtest: pipe-A-eDP-1
[338.208319] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.428s)
[338.218014] Starting dynamic subtest: pipe-B-eDP-1
[355.174262] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.437s)
[355.183836] Starting dynamic subtest: pipe-C-eDP-1
[372.157014] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.413s)
[372.166491] Starting dynamic subtest: pipe-D-eDP-1
[389.155094] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.341s)
[389.157742] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.625s)
[390.353428] [048/133] (630s left) kms_prop_blob (invalid-get-prop)
[390.421098] Starting subtest: invalid-get-prop
[390.423355] Subtest invalid-get-prop: SUCCESS (0.000s)
[390.539709] [049/133] (630s left) gem_pipe_control_store_loop (reused-buffer)
[390.593230] Starting subtest: reused-buffer
[392.731664] Subtest reused-buffer: SUCCESS (2.152s)
[392.844492] [050/133] (628s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[392.946710] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[392.951040] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[393.020114] [051/133] (628s left) kms_pm_dc (dc9-dpms)
[394.110878] Starting subtest: dc9-dpms
[395.537756] Subtest dc9-dpms: SUCCESS (1.435s)
[395.628449] [052/133] (625s left) kms_psr (pr-sprite-render)
[395.729528] Starting subtest: pr-sprite-render
[395.734718] Subtest pr-sprite-render: SKIP (0.000s)
[395.805476] [053/133] (625s left) gem_exec_schedule (smoketest-all)
[395.879614] Starting subtest: smoketest-all
[428.262584] Subtest smoketest-all: SUCCESS (32.364s)
[429.453618] [054/133] (591s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[429.565933] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[429.568501] Starting dynamic subtest: pipe-A-eDP-1
[435.506643] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.943s)
[435.516646] Starting dynamic subtest: pipe-B-eDP-1
[442.161180] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.654s)
[442.164012] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.600s)
[443.017961] [055/133] (578s left) kms_cursor_crc (cursor-offscreen-256x85)
[443.266955] Starting subtest: cursor-offscreen-256x85
[443.313571] Subtest cursor-offscreen-256x85: SKIP (0.041s)
[443.507514] [056/133] (577s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[443.611078] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[447.613340] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (4.009s)
[448.739710] [057/133] (572s left) gen3_render_tiledx_blits
[448.856009] [058/133] (572s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[448.954828] Starting subtest: pr-plane-move-sf-dmg-area
[448.959842] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[449.022969] [059/133] (572s left) syncobj_eventfd (timeline-wait)
[449.086136] Starting subtest: timeline-wait
[449.094740] Subtest timeline-wait: SUCCESS (0.010s)
[449.184963] [060/133] (572s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[449.308859] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[449.314497] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[449.406175] [061/133] (572s left) kms_atomic (crtc-invalid-params)
[449.508887] Starting subtest: crtc-invalid-params
[449.511778] Starting dynamic subtest: pipe-A-eDP-1
[449.870382] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.362s)
[449.872993] Subtest crtc-invalid-params: SUCCESS (0.364s)
[450.750073] [062/133] (570s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[450.813805] Starting subtest: etime-single-wait-for-submit-unsubmitted
[450.919675] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[451.012175] [063/133] (570s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[451.106734] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[451.796960] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.692s)
[451.963133] [064/133] (569s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[452.051740] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[452.081366] Starting dynamic subtest: pipe-A-plane-0
[452.369618] Dynamic subtest pipe-A-plane-0: SUCCESS (0.288s)
[452.378682] Starting dynamic subtest: pipe-A-plane-3
[452.602112] Dynamic subtest pipe-A-plane-3: SUCCESS (0.231s)
[452.611963] Starting dynamic subtest: pipe-A-plane-5
[452.617123] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[453.737245] Starting dynamic subtest: pipe-B-plane-0
[454.029633] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[454.039246] Starting dynamic subtest: pipe-B-plane-3
[454.264625] Dynamic subtest pipe-B-plane-3: SUCCESS (0.231s)
[454.273793] Starting dynamic subtest: pipe-B-plane-5
[454.278711] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[454.577017] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.523s)
[455.410467] [065/133] (566s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[455.498857] Starting subtest: primary-y-tiled-reflect-x-0
[455.570919] Subtest primary-y-tiled-reflect-x-0: SKIP (0.071s)
[455.676999] [066/133] (566s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[455.792132] Starting subtest: fbc-rgb565-draw-mmap-gtt
[455.797550] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[455.894473] [067/133] (566s left) gem_ppgtt (shrink-vs-evict-pinned)
[455.950881] Starting subtest: shrink-vs-evict-pinned
[461.305922] Subtest shrink-vs-evict-pinned: SUCCESS (5.356s)
[461.388193] [068/133] (560s left) gem_exec_capture (userptr)
[461.454231] Starting subtest: userptr
[462.281452] Subtest userptr: SUCCESS (0.824s)
[462.419719] [069/133] (559s left) kms_dp_linktrain_fallback (dp-fallback)
[462.515315] Starting subtest: dp-fallback
[462.522937] Subtest dp-fallback: SKIP (0.000s)
[462.589571] [070/133] (559s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[462.691504] Starting subtest: 4-tiled-8bpp-rotate-90
[462.713945] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.022s)
[462.860610] [071/133] (559s left) kms_pipe_crc_basic (suspend-read-crc)
[462.955360] Starting subtest: suspend-read-crc
[462.957794] Starting dynamic subtest: pipe-A-eDP-1
[480.905687] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.559s)
[480.916505] Starting dynamic subtest: pipe-B-eDP-1
[498.897410] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.143s)
[498.908256] Starting dynamic subtest: pipe-C-eDP-1
[516.838511] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.097s)
[516.849510] Starting dynamic subtest: pipe-D-eDP-1
[534.846766] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.073s)
[534.849689] Subtest suspend-read-crc: SUCCESS (11.878s)
[535.661013] [072/133] (486s left) perf (enable-disable)
[535.763701] Starting subtest: enable-disable
[535.766504] Starting dynamic subtest: 0-rcs0
[538.025470] Dynamic subtest 0-rcs0: SUCCESS (2.279s)
[538.035840] Starting dynamic subtest: 1-vcs0
[542.512137] Dynamic subtest 1-vcs0: SUCCESS (4.506s)
[542.514787] Subtest enable-disable: SUCCESS (6.788s)
[542.563392] [073/133] (479s left) perf_pmu (all-busy-idle-check-all)
[542.604291] Starting subtest: all-busy-idle-check-all
[543.318519] Subtest all-busy-idle-check-all: FAIL (0.628s)
[543.530621] [074/133] (478s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[543.633554] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[543.638442] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[543.726709] [075/133] (478s left) kms_invalid_mode (zero-clock)
[543.820545] Starting subtest: zero-clock
[543.823297] Starting dynamic subtest: pipe-A-eDP-1
[544.103655] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[544.115596] Starting dynamic subtest: pipe-B-eDP-1
[544.118531] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[544.128139] Starting dynamic subtest: pipe-C-eDP-1
[544.130948] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[544.140966] Starting dynamic subtest: pipe-D-eDP-1
[544.143828] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[544.146808] Subtest zero-clock: SUCCESS (0.296s)
[544.951273] [076/133] (477s left) gem_madvise (dontneed-before-pwrite)
[544.992828] Starting subtest: dontneed-before-pwrite
[545.011768] Subtest dontneed-before-pwrite: SKIP (0.016s)
[545.074765] [077/133] (477s left) gem_exec_whisper (basic-queues-all)
[545.130186] Starting subtest: basic-queues-all
[554.980418] Subtest basic-queues-all: SUCCESS (9.864s)
[555.170482] [078/133] (467s left) kms_psr (psr-primary-render)
[555.274761] Starting subtest: psr-primary-render
[555.277552] Starting dynamic subtest: eDP-1
[557.029822] Dynamic subtest eDP-1: SUCCESS (1.757s)
[557.032774] Subtest psr-primary-render: SUCCESS (1.758s)
[557.885694] [079/133] (464s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[558.273600] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[559.090404] [080/133] (463s left) gem_bad_reloc (negative-reloc-lut)
[559.152375] Subtest negative-reloc-lut: SKIP (0.000s)
[559.259808] [081/133] (463s left) syncobj_wait (wait-any-snapshot)
[559.311155] Starting subtest: wait-any-snapshot
[559.391789] Subtest wait-any-snapshot: SUCCESS (0.083s)
[559.486635] [082/133] (463s left) i915_drm_fdinfo (virtual-busy-hang)
[559.530751] Starting subtest: virtual-busy-hang
[559.535941] Subtest virtual-busy-hang: SKIP (0.000s)
[559.607069] [083/133] (463s left) kms_selftest (drm_dp_mst_helper)
[559.650722] Starting subtest: drm_dp_mst_helper
[559.701043] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[559.799746] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.101s)
[559.811434] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[559.897692] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.094s)
[559.908549] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[559.991506] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.094s)
[559.993576] Subtest drm_dp_mst_helper: SUCCESS (0.341s)
[560.136929] [084/133] (462s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[560.229275] Starting subtest: async-flip-with-page-flip-events-tiled
[560.606462] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[563.373519] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.770s)
[563.384156] Starting dynamic subtest: pipe-A-eDP-1-4
[565.557656] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.182s)
[565.570933] Starting dynamic subtest: pipe-A-eDP-1-4
[567.567523] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.007s)
[567.577959] Starting dynamic subtest: pipe-A-eDP-1-x
[569.758263] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.188s)
[570.134250] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[572.897415] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.773s)
[572.910791] Starting dynamic subtest: pipe-B-eDP-1-4
[575.083557] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[575.096497] Starting dynamic subtest: pipe-B-eDP-1-4
[577.093716] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[577.104402] Starting dynamic subtest: pipe-B-eDP-1-x
[579.295237] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.200s)
[579.663617] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[582.422304] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.768s)
[582.433597] Starting dynamic subtest: pipe-C-eDP-1-4
[584.597423] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.175s)
[584.608052] Starting dynamic subtest: pipe-C-eDP-1-4
[586.606792] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.008s)
[586.618049] Starting dynamic subtest: pipe-C-eDP-1-x
[588.797029] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.189s)
[589.170806] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[591.957847] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.797s)
[591.968547] Starting dynamic subtest: pipe-D-eDP-1-4
[594.131789] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s)
[594.142565] Starting dynamic subtest: pipe-D-eDP-1-4
[596.141482] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[596.152218] Starting dynamic subtest: pipe-D-eDP-1-x
[598.331113] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.189s)
[598.333933] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.106s)
[599.544072] [085/133] (423s left) gem_ctx_param (invalid-get-engines)
[599.612305] Starting subtest: invalid-get-engines
[599.615058] Subtest invalid-get-engines: SUCCESS (0.001s)
[599.727346] [086/133] (423s left) core_setmaster (master-drop-set-shared-fd)
[599.805952] Starting subtest: master-drop-set-shared-fd
[599.828119] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[599.869164] [087/133] (423s left) prime_mmap (test_refcounting)
[599.921428] Starting subtest: test_refcounting
[599.924218] Starting dynamic subtest: test_refcounting-smem
[599.951501] Dynamic subtest test_refcounting-smem: SUCCESS (0.033s)
[599.954614] Subtest test_refcounting: SUCCESS (0.033s)
[600.076039] [088/133] (422s left) gen7_exec_parse (cmd-crossing-page)
[600.137612] Subtest cmd-crossing-page: SKIP (0.000s)
[600.207500] [089/133] (422s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[600.307400] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[600.312596] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[600.408403] [090/133] (422s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[600.507246] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[607.241747] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.737s)
[607.358170] [091/133] (415s left) kms_rotation_crc (sprite-rotation-90)
[607.452639] Starting subtest: sprite-rotation-90
[607.458234] Subtest sprite-rotation-90: SKIP (0.001s)
[607.537108] [092/133] (415s left) gem_exec_reloc (basic-write-cpu)
[607.593368] Subtest basic-write-cpu: SKIP (0.000s)
[607.649249] [093/133] (415s left) kms_chamelium_hpd (hdmi-hpd-fast)
[608.042790] Subtest hdmi-hpd-fast: SKIP (0.000s)
[608.888864] [094/133] (414s left) gem_ctx_shared (q-independent)
[608.958278] Starting subtest: Q-independent
[608.960812] Starting dynamic subtest: rcs0
[609.036762] Dynamic subtest rcs0: SUCCESS (0.078s)
[609.048353] Starting dynamic subtest: vcs0
[609.079092] Dynamic subtest vcs0: SUCCESS (0.042s)
[609.096246] Starting dynamic subtest: vcs1
[609.124376] Dynamic subtest vcs1: SUCCESS (0.044s)
[609.136486] Starting dynamic subtest: vecs0
[609.171529] Dynamic subtest vecs0: SUCCESS (0.047s)
[609.185868] Starting dynamic subtest: ccs0
[609.220205] Dynamic subtest ccs0: SUCCESS (0.048s)
[609.222833] Subtest Q-independent: SUCCESS (0.263s)
[610.546453] [095/133] (412s left) gem_spin_batch (user-each)
[610.617322] Starting subtest: user-each
[613.891595] Subtest user-each: SUCCESS (3.267s)
[614.448608] [096/133] (408s left) syncobj_wait (invalid-signal-illegal-handle)
[614.511279] Starting subtest: invalid-signal-illegal-handle
[614.514053] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[614.595158] [097/133] (408s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[614.700644] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[618.334302] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.639s)
[619.526272] [098/133] (403s left) gem_exec_fence (syncobj-timeline-unused-fence)
[620.084719] Starting subtest: syncobj-timeline-unused-fence
[620.090817] Subtest syncobj-timeline-unused-fence: SUCCESS (0.007s)
[621.564626] [099/133] (401s left) gem_ctx_engines (independent)
[621.629385] Starting subtest: independent
[621.632124] Starting dynamic subtest: rcs0
[621.775045] Dynamic subtest rcs0: SUCCESS (0.144s)
[621.785285] Starting dynamic subtest: bcs0
[621.878229] Dynamic subtest bcs0: SUCCESS (0.103s)
[621.892074] Starting dynamic subtest: vcs0
[622.067842] Dynamic subtest vcs0: SUCCESS (0.188s)
[622.077654] Starting dynamic subtest: vcs1
[622.280970] Dynamic subtest vcs1: SUCCESS (0.213s)
[622.294581] Starting dynamic subtest: vecs0
[622.502764] Dynamic subtest vecs0: SUCCESS (0.220s)
[622.515637] Starting dynamic subtest: ccs0
[622.723572] Dynamic subtest ccs0: SUCCESS (0.219s)
[622.737059] Starting dynamic subtest: all-engines
[623.922157] Dynamic subtest all-engines: SUCCESS (1.198s)
[623.924826] Subtest independent: SUCCESS (2.292s)
[625.497199] [100/133] (398s left) gem_exec_schedule (preempt-queue-contexts-chain)
[625.572687] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[625.879127] [101/133] (397s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[625.986825] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[625.989326] Starting dynamic subtest: pipe-A-eDP-1
[626.310211] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s)
[626.323249] Starting dynamic subtest: pipe-B-eDP-1
[627.595403] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.278s)
[627.607789] Starting dynamic subtest: pipe-C-eDP-1
[628.894080] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.297s)
[628.904773] Starting dynamic subtest: pipe-D-eDP-1
[630.111677] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.216s)
[630.114329] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.090s)
[631.238204] [102/133] (392s left) syncobj_wait (multi-wait-for-submit-signaled)
[631.296577] Starting subtest: multi-wait-for-submit-signaled
[631.298765] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[631.393174] [103/133] (392s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[631.487123] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[631.492642] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[631.587220] [104/133] (392s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[631.698530] Starting subtest: cursorB-vs-flipA-legacy
[631.703794] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[631.856431] [105/133] (391s left) perf (non-zero-reason)
[631.949321] Starting subtest: non-zero-reason
[631.952023] Starting dynamic subtest: 0-rcs0
[637.429445] Dynamic subtest 0-rcs0: SUCCESS (5.476s)
[637.442290] Starting dynamic subtest: 1-vcs1
[641.378914] Dynamic subtest 1-vcs1: SUCCESS (3.947s)
[641.381757] Subtest non-zero-reason: SUCCESS (9.425s)
[641.431699] [106/133] (382s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[641.549693] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[641.555168] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[641.655806] [107/133] (382s left) gem_exec_fence (syncobj-invalid-flags)
[642.111811] Starting subtest: syncobj-invalid-flags
[642.115150] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[643.498434] [108/133] (380s left) kms_addfb_basic (invalid-get-prop-any)
[643.545325] Starting subtest: invalid-get-prop-any
[643.547471] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[643.673464] [109/133] (380s left) gem_mmap_wc (write-gtt-read-wc)
[643.753580] Subtest write-gtt-read-wc: SKIP (0.000s)
[643.814896] [110/133] (380s left) gem_exec_schedule (preempt-queue)
[643.884645] Subtest preempt-queue: SKIP (0.000s)
[644.179533] [111/133] (379s left) kms_vblank (query-forked-busy)
[644.282079] Starting subtest: query-forked-busy
[644.287672] Starting dynamic subtest: pipe-A-eDP-1
[646.159725] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.877s)
[646.176642] Starting dynamic subtest: pipe-D-eDP-1
[648.689103] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.526s)
[648.691778] Subtest query-forked-busy: SUCCESS (4.407s)
[649.488757] [112/133] (374s left) prime_busy (after)
[649.545480] Starting subtest: after
[649.551443] Starting dynamic subtest: rcs0
[649.584537] Dynamic subtest rcs0: SUCCESS (0.035s)
[649.595560] Starting dynamic subtest: bcs0
[649.636677] Dynamic subtest bcs0: SUCCESS (0.051s)
[649.647864] Starting dynamic subtest: vcs0
[649.678419] Dynamic subtest vcs0: SUCCESS (0.041s)
[649.688822] Starting dynamic subtest: vcs1
[649.719542] Dynamic subtest vcs1: SUCCESS (0.041s)
[649.729777] Starting dynamic subtest: vecs0
[649.761887] Dynamic subtest vecs0: SUCCESS (0.041s)
[649.772612] Starting dynamic subtest: ccs0
[649.803528] Dynamic subtest ccs0: SUCCESS (0.041s)
[649.911646] Subtest after: SUCCESS (0.364s)
[650.002292] [113/133] (374s left) kms_lease (lease-again)
[650.108053] Starting subtest: lease-again
[650.110664] Starting dynamic subtest: pipe-A-eDP-1
[650.113472] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s)
[650.127109] Starting dynamic subtest: pipe-B-eDP-1
[650.129564] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[650.139918] Starting dynamic subtest: pipe-C-eDP-1
[650.142618] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[650.152714] Starting dynamic subtest: pipe-D-eDP-1
[650.155484] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[650.158342] Subtest lease-again: SUCCESS (0.013s)
[650.235471] [114/133] (373s left) kms_cursor_edge_walk (64x64-top-edge)
[650.338548] Starting subtest: 64x64-top-edge
[650.341281] Starting dynamic subtest: pipe-A-eDP-1
[653.757599] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.419s)
[653.770770] Starting dynamic subtest: pipe-D-eDP-1
[656.875033] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.113s)
[656.877563] Subtest 64x64-top-edge: SUCCESS (6.535s)
[657.672405] [115/133] (366s left) i915_pm_rps (reset)
[657.726683] Starting subtest: reset
[666.191680] Subtest reset: SUCCESS (8.460s)
[666.309427] [116/133] (357s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[666.411397] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[666.416276] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[666.510555] [117/133] (357s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[666.561553] Starting subtest: multi-wait-for-submit-available-signaled
[666.564357] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[666.663918] [118/133] (357s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[666.758410] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[666.760539] Starting dynamic subtest: pipe-A-eDP-1
[667.184147] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.427s)
[667.198612] Starting dynamic subtest: pipe-B-eDP-1
[667.217798] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.003s)
[667.230493] Starting dynamic subtest: pipe-C-eDP-1
[667.249208] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[667.259389] Starting dynamic subtest: pipe-D-eDP-1
[667.278428] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[667.280470] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.442s)
[669.447656] [119/133] (354s left) kms_big_fb (linear-8bpp-rotate-0)
[669.549914] Starting subtest: linear-8bpp-rotate-0
[670.897543] Subtest linear-8bpp-rotate-0: SUCCESS (1.348s)
[671.009472] [120/133] (353s left) kms_getfb (getfb2-handle-not-fb)
[671.101718] Starting subtest: getfb2-handle-not-fb
[671.104492] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[671.194614] [121/133] (353s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[671.282388] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[671.293499] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.010s)
[671.369994] [122/133] (353s left) gem_exec_reloc (basic-write-gtt-active)
[671.426476] Subtest basic-write-gtt-active: SKIP (0.000s)
[671.495948] [123/133] (353s left) gem_exec_capture (capture-recoverable)
[671.554740] Starting subtest: capture-recoverable
[671.556740] Subtest capture-recoverable: SUCCESS (0.004s)
[671.666685] [124/133] (352s left) gem_ctx_param (non-root-set)
[671.721479] Starting subtest: non-root-set
[671.743795] Subtest non-root-set: SUCCESS (0.024s)
[671.837708] [125/133] (352s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[671.933914] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[671.938514] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[672.029028] [126/133] (352s left) kms_dsc (dsc-with-formats)
[672.124992] Starting subtest: dsc-with-formats
[672.170696] Subtest dsc-with-formats: SKIP (0.002s)
[672.211758] [127/133] (352s left) gem_eio (in-flight-contexts-immediate)
[672.501477] Starting subtest: in-flight-contexts-immediate
[686.458578] Subtest in-flight-contexts-immediate: SUCCESS (13.958s)
[686.633446] [128/133] (338s left) gem_exec_balancer (bonded-semaphore)
[686.697034] Starting subtest: bonded-semaphore
[686.702379] Subtest bonded-semaphore: SKIP (0.000s)
[686.997820] [129/133] (337s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[687.107512] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[687.112510] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[687.204639] [130/133] (337s left) syncobj_timeline (wait-delayed-signal)
[687.267843] Starting subtest: wait-delayed-signal
[687.367968] Subtest wait-delayed-signal: SUCCESS (0.103s)
[687.454068] [131/133] (337s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[687.578471] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[687.583523] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[687.695120] [132/133] (337s left) kms_chamelium_color (ctm-max)
[687.787719] Subtest ctm-max: SKIP (0.000s)
[687.834991] [133/133] (337s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[687.929778] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[687.934714] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[688.022035] Closing watchdogs
results: parsing output: 0/ for test: gem_userptr_blits
results: parsing output: 1/ for test: gem_request_retire
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: kms_prime
results: parsing output: 4/ for test: gem_render_copy
results: parsing output: 5/ for test: kms_cursor_crc
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: perf_pmu
results: parsing output: 9/ for test: gem_mmap_offset
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: perf
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: i915_hangman
results: parsing output: 14/ for test: kms_color_pipeline
results: parsing output: 15/ for test: gem_exec_nop
results: parsing output: 16/ for test: prime_self_import
results: parsing output: 17/ for test: core_getclient
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: syncobj_wait
results: parsing output: 21/ for test: i915_suspend
results: parsing output: 22/ for test: kms_content_protection
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: gem_basic
results: parsing output: 25/ for test: kms_plane
results: parsing output: 26/ for test: kms_atomic_transition
results: parsing output: 27/ for test: kms_plane_cursor
results: parsing output: 28/ for test: perf
results: parsing output: 29/ for test: gem_mmap_gtt
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: gem_exec_whisper
results: parsing output: 33/ for test: kms_plane_scaling
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: kms_psr
results: parsing output: 36/ for test: gem_ctx_persistence
results: parsing output: 37/ for test: api_intel_bb
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: syncobj_wait
results: parsing output: 41/ for test: gem_render_copy
results: parsing output: 42/ for test: gem_exec_reloc
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_mmap_gtt
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: kms_prop_blob
results: parsing output: 48/ for test: gem_pipe_control_store_loop
results: parsing output: 49/ for test: kms_flip_scaled_crc
results: parsing output: 50/ for test: kms_pm_dc
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: gem_exec_schedule
results: parsing output: 53/ for test: kms_psr2_sf
results: parsing output: 54/ for test: kms_cursor_crc
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gen3_render_tiledx_blits
results: parsing output: 57/ for test: kms_psr2_sf
results: parsing output: 58/ for test: syncobj_eventfd
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_atomic
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: kms_plane
results: parsing output: 64/ for test: kms_rotation_crc
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_ppgtt
results: parsing output: 67/ for test: gem_exec_capture
results: parsing output: 68/ for test: kms_dp_linktrain_fallback
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: kms_pipe_crc_basic
results: parsing output: 71/ for test: perf
results: parsing output: 72/ for test: perf_pmu
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_invalid_mode
results: parsing output: 75/ for test: gem_madvise
results: parsing output: 76/ for test: gem_exec_whisper
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: kms_chamelium_edid
results: parsing output: 79/ for test: gem_bad_reloc
results: parsing output: 80/ for test: syncobj_wait
results: parsing output: 81/ for test: i915_drm_fdinfo
results: parsing output: 82/ for test: kms_selftest
results: parsing output: 83/ for test: kms_async_flips
results: parsing output: 84/ for test: gem_ctx_param
results: parsing output: 85/ for test: core_setmaster
results: parsing output: 86/ for test: prime_mmap
results: parsing output: 87/ for test: gen7_exec_parse
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_rotation_crc
results: parsing output: 91/ for test: gem_exec_reloc
results: parsing output: 92/ for test: kms_chamelium_hpd
results: parsing output: 93/ for test: gem_ctx_shared
results: parsing output: 94/ for test: gem_spin_batch
results: parsing output: 95/ for test: syncobj_wait
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_exec_fence
results: parsing output: 98/ for test: gem_ctx_engines
results: parsing output: 99/ for test: gem_exec_schedule
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: syncobj_wait
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: kms_cursor_legacy
results: parsing output: 104/ for test: perf
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: gem_exec_fence
results: parsing output: 107/ for test: kms_addfb_basic
results: parsing output: 108/ for test: gem_mmap_wc
results: parsing output: 109/ for test: gem_exec_schedule
results: parsing output: 110/ for test: kms_vblank
results: parsing output: 111/ for test: prime_busy
results: parsing output: 112/ for test: kms_lease
results: parsing output: 113/ for test: kms_cursor_edge_walk
results: parsing output: 114/ for test: i915_pm_rps
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: kms_getfb
results: parsing output: 120/ for test: kms_flip
results: parsing output: 121/ for test: gem_exec_reloc
results: parsing output: 122/ for test: gem_exec_capture
results: parsing output: 123/ for test: gem_ctx_param
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_dsc
results: parsing output: 126/ for test: gem_eio
results: parsing output: 127/ for test: gem_exec_balancer
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_chamelium_color
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.