[57.523687] Initializing watchdogs
[57.523734]   /dev/watchdog0
[57.538821] [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.543276] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.545532] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.549030] [001/133] (960s left) gem_userptr_blits (nohangcheck)
[57.645757] Starting subtest: nohangcheck
[57.983330] Subtest nohangcheck: SUCCESS (0.336s)
[58.101005] [002/133] (959s left) gem_request_retire (retire-vma-not-inactive)
[58.162782] Starting subtest: retire-vma-not-inactive
[58.226968] Subtest retire-vma-not-inactive: SUCCESS (0.063s)
[58.329661] [003/133] (959s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[58.387883] Starting subtest: single-wait-for-submit-available-signaled
[58.390178] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.001s)
[58.489860] [004/133] (959s left) kms_prime (basic-modeset-hybrid)
[58.576593] Subtest basic-modeset-hybrid: SKIP (0.000s)
[58.698373] [FACT kms_prime (basic-modeset-hybrid)] new: kernel.kmod_is_loaded.vgem: true
[58.701805] [005/133] (959s left) gem_render_copy (linear-to-vebox-yf-tiled)
[58.760573] Starting subtest: linear-to-vebox-yf-tiled
[58.765238] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[58.944162] [006/133] (959s left) kms_cursor_crc (cursor-sliding-128x42)
[59.152595] Starting subtest: cursor-sliding-128x42
[59.209830] Subtest cursor-sliding-128x42: SKIP (0.053s)
[59.420909] [007/133] (958s left) kms_psr (psr2-cursor-plane-move)
[59.508810] Starting subtest: psr2-cursor-plane-move
[59.512292] Starting dynamic subtest: eDP-1
[61.200817] Dynamic subtest eDP-1: SUCCESS (1.692s)
[61.203286] Subtest psr2-cursor-plane-move: SUCCESS (1.692s)
[61.997818] [008/133] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[62.101394] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[62.105612] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[62.192824] [009/133] (956s left) perf_pmu (rc6-all-gts)
[62.239942] Starting subtest: rc6-all-gts
[68.597884] Subtest rc6-all-gts: SUCCESS (6.358s)
[69.480825] [010/133] (948s left) gem_mmap_offset (partial-mmap)
[69.541694] Starting subtest: partial-mmap
[69.543868] Starting dynamic subtest: smem0
[69.548338] Dynamic subtest smem0: SUCCESS (0.007s)
[69.550586] Subtest partial-mmap: SUCCESS (0.007s)
[69.670407] [011/133] (948s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[69.771168] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[78.535977] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.769s)
[78.635963] [012/133] (939s left) perf (non-system-wide-paranoid)
[78.771385] Starting subtest: non-system-wide-paranoid
[78.799459] Subtest non-system-wide-paranoid: SUCCESS (0.029s)
[78.851755] [013/133] (939s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[78.951921] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[78.956112] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[79.035350] [014/133] (939s left) i915_hangman (detector)
[79.100448] Starting subtest: detector
[79.102516] Starting dynamic subtest: rcs0
[90.868082] Dynamic subtest rcs0: SUCCESS (11.768s)
[90.878686] Starting dynamic subtest: bcs0
[102.835424] Dynamic subtest bcs0: SUCCESS (11.966s)
[102.846119] Starting dynamic subtest: vcs0
[112.884244] Dynamic subtest vcs0: SUCCESS (10.047s)
[112.895158] Starting dynamic subtest: vcs1
[124.850823] Dynamic subtest vcs1: SUCCESS (11.964s)
[124.860732] Starting dynamic subtest: vecs0
[136.819324] Dynamic subtest vecs0: SUCCESS (11.967s)
[136.831679] Starting dynamic subtest: ccs0
[146.867380] Dynamic subtest ccs0: SUCCESS (10.046s)
[146.870521] Subtest detector: SUCCESS (67.767s)
[146.986251] [015/133] (871s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[147.086722] Starting subtest: plane-lut1d-ctm3x4-lut1d
[147.232851] Starting dynamic subtest: pipe-A-plane-0
[147.596383] Dynamic subtest pipe-A-plane-0: FAIL (0.191s)
[147.606755] Starting dynamic subtest: pipe-A-plane-1
[147.826637] Dynamic subtest pipe-A-plane-1: FAIL (0.173s)
[147.836176] Starting dynamic subtest: pipe-A-plane-2
[148.056391] Dynamic subtest pipe-A-plane-2: FAIL (0.177s)
[148.987505] Starting dynamic subtest: pipe-B-plane-0
[149.466992] Dynamic subtest pipe-B-plane-0: FAIL (0.198s)
[149.475182] Starting dynamic subtest: pipe-B-plane-1
[149.795441] Dynamic subtest pipe-B-plane-1: FAIL (0.178s)
[149.805435] Starting dynamic subtest: pipe-B-plane-2
[150.100932] Dynamic subtest pipe-B-plane-2: FAIL (0.177s)
[151.199393] Starting dynamic subtest: pipe-C-plane-0
[151.717918] Dynamic subtest pipe-C-plane-0: FAIL (0.152s)
[151.726766] Starting dynamic subtest: pipe-C-plane-1
[152.133791] Dynamic subtest pipe-C-plane-1: FAIL (0.624s)
[152.143976] Starting dynamic subtest: pipe-C-plane-2
[152.507401] Dynamic subtest pipe-C-plane-2: FAIL (0.173s)
[153.338695] Starting dynamic subtest: pipe-D-plane-0
[153.958516] Dynamic subtest pipe-D-plane-0: FAIL (0.152s)
[153.967702] Starting dynamic subtest: pipe-D-plane-1
[154.429670] Dynamic subtest pipe-D-plane-1: FAIL (0.607s)
[154.439391] Starting dynamic subtest: pipe-D-plane-2
[154.894637] Dynamic subtest pipe-D-plane-2: FAIL (0.562s)
[154.956098] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (7.869s)
[155.779014] [016/133] (862s left) gem_exec_nop (basic-sequential)
[155.866785] Starting subtest: basic-sequential
[170.391241] Subtest basic-sequential: SUCCESS (14.532s)
[170.618133] [017/133] (848s left) prime_self_import (basic-llseek-size)
[170.656701] Starting subtest: basic-llseek-size
[170.673787] Subtest basic-llseek-size: SUCCESS (0.019s)
[170.764591] [018/133] (847s left) core_getclient (basic)
[170.813598] Starting subtest: basic
[170.815691] Subtest basic: SUCCESS (0.000s)
[170.909108] [019/133] (847s left) kms_flip (basic-flip-vs-dpms)
[171.012349] Starting subtest: basic-flip-vs-dpms
[171.014521] Starting dynamic subtest: A-eDP1
[173.581677] Dynamic subtest A-eDP1: SUCCESS (2.567s)
[173.591061] Starting dynamic subtest: B-eDP1
[175.766812] Dynamic subtest B-eDP1: SUCCESS (2.184s)
[175.776078] Starting dynamic subtest: C-eDP1
[177.850267] Dynamic subtest C-eDP1: SUCCESS (2.082s)
[177.860548] Starting dynamic subtest: D-eDP1
[180.011919] Dynamic subtest D-eDP1: SUCCESS (2.159s)
[180.014307] Subtest basic-flip-vs-dpms: SUCCESS (9.002s)
[180.827987] [020/133] (837s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[180.929634] Starting subtest: fbc-psr2-sprite-mmap-cpu
[180.931972] Starting dynamic subtest: eDP-1
[180.936463] Dynamic subtest eDP-1: SKIP (0.000s)
[180.940938] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[181.005154] [021/133] (837s left) syncobj_wait (invalid-signal-zero-handles)
[181.064296] Starting subtest: invalid-signal-zero-handles
[181.066237] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[181.173431] [022/133] (837s left) i915_suspend (basic-s2idle-without-i915)
[181.209853] Starting subtest: basic-s2idle-without-i915
[200.493364] Subtest basic-s2idle-without-i915: SUCCESS (4.419s)
[206.626998] [023/133] (818s left) kms_content_protection (type1)
[206.797128] Starting subtest: type1
[206.802159] Subtest type1: SKIP (0.000s)
[206.915551] [024/133] (818s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[207.006185] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[207.008514] Starting dynamic subtest: pipe-A-eDP-1
[207.032015] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[207.043889] Starting dynamic subtest: pipe-B-eDP-1
[207.065589] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[207.073249] Starting dynamic subtest: pipe-C-eDP-1
[207.094920] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[207.102911] Starting dynamic subtest: pipe-D-eDP-1
[207.124730] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[207.129154] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[209.250345] [025/133] (815s left) gem_basic (create-fd-close)
[209.302518] Starting subtest: create-fd-close
[209.307157] Subtest create-fd-close: SUCCESS (0.000s)
[209.406552] [026/133] (815s left) kms_plane (plane-position-hole)
[209.503893] Starting subtest: plane-position-hole
[210.027663] Starting dynamic subtest: pipe-A-plane-1
[211.344109] Dynamic subtest pipe-A-plane-1: SUCCESS (1.316s)
[211.352680] Starting dynamic subtest: pipe-A-plane-2
[212.698776] Dynamic subtest pipe-A-plane-2: SUCCESS (1.354s)
[212.709453] Starting dynamic subtest: pipe-A-plane-3
[213.982028] Dynamic subtest pipe-A-plane-3: SUCCESS (1.283s)
[213.990581] Starting dynamic subtest: pipe-A-plane-4
[215.329369] Dynamic subtest pipe-A-plane-4: SUCCESS (1.347s)
[215.339285] Starting dynamic subtest: pipe-A-plane-5
[215.354047] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[216.562059] Starting dynamic subtest: pipe-B-plane-1
[217.874859] Dynamic subtest pipe-B-plane-1: SUCCESS (1.319s)
[217.883188] Starting dynamic subtest: pipe-B-plane-2
[219.259639] Dynamic subtest pipe-B-plane-2: SUCCESS (1.384s)
[219.276582] Starting dynamic subtest: pipe-B-plane-3
[220.591155] Dynamic subtest pipe-B-plane-3: SUCCESS (1.333s)
[220.599643] Starting dynamic subtest: pipe-B-plane-4
[221.913598] Dynamic subtest pipe-B-plane-4: SUCCESS (1.321s)
[221.922509] Starting dynamic subtest: pipe-B-plane-5
[221.957462] Dynamic subtest pipe-B-plane-5: SUCCESS (0.041s)
[221.959802] Subtest plane-position-hole: SUCCESS (12.458s)
[222.761984] [027/133] (802s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[222.858785] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[222.861042] Starting dynamic subtest: pipe-A-eDP-1
[222.920701] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s)
[223.243317] Starting dynamic subtest: pipe-B-eDP-1
[224.067141] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.833s)
[224.366306] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.507s)
[225.233902] [028/133] (799s left) kms_plane_cursor (primary)
[225.327200] Starting subtest: primary
[225.331675] Starting dynamic subtest: pipe-A-eDP-1-size-64
[227.899143] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.573s)
[227.922123] Starting dynamic subtest: pipe-A-eDP-1-size-128
[230.488061] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.572s)
[230.511799] Starting dynamic subtest: pipe-A-eDP-1-size-256
[233.078080] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.572s)
[233.405004] Starting dynamic subtest: pipe-B-eDP-1-size-64
[236.730144] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.339s)
[236.752942] Starting dynamic subtest: pipe-B-eDP-1-size-128
[239.353119] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.605s)
[239.376274] Starting dynamic subtest: pipe-B-eDP-1-size-256
[241.942884] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.572s)
[242.258125] Starting dynamic subtest: pipe-C-eDP-1-size-64
[245.156352] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.910s)
[245.182804] Starting dynamic subtest: pipe-C-eDP-1-size-128
[247.367142] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.191s)
[247.393567] Starting dynamic subtest: pipe-C-eDP-1-size-256
[249.589339] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.203s)
[249.906160] Starting dynamic subtest: pipe-D-eDP-1-size-64
[252.804643] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.907s)
[252.829411] Starting dynamic subtest: pipe-D-eDP-1-size-128
[255.025154] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.203s)
[255.050969] Starting dynamic subtest: pipe-D-eDP-1-size-256
[257.258439] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.214s)
[257.566057] Subtest primary: SUCCESS (32.242s)
[258.427209] [029/133] (766s left) perf (invalid-oa-exponent)
[258.558473] Starting subtest: invalid-oa-exponent
[258.575408] Subtest invalid-oa-exponent: SUCCESS (0.016s)
[258.616687] [030/133] (766s left) gem_mmap_gtt (big-bo-tiledy)
[258.677675] Subtest big-bo-tiledY: SKIP (0.000s)
[258.737619] [031/133] (766s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[258.852004] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[258.856236] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[258.954137] [032/133] (766s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[259.054838] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[259.059716] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[259.140348] [033/133] (766s left) gem_exec_whisper (basic-contexts-forked)
[259.207947] Starting subtest: basic-contexts-forked
[284.221818] Subtest basic-contexts-forked: SUCCESS (25.019s)
[284.409344] [034/133] (740s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[284.506581] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[284.508667] Starting dynamic subtest: pipe-A
[284.573054] Dynamic subtest pipe-A: SUCCESS (0.068s)
[284.582366] Starting dynamic subtest: pipe-B
[285.742783] Dynamic subtest pipe-B: SUCCESS (1.168s)
[285.752735] Starting dynamic subtest: pipe-C
[286.853386] Dynamic subtest pipe-C: SUCCESS (1.109s)
[286.864304] Starting dynamic subtest: pipe-D
[287.999614] Dynamic subtest pipe-D: SUCCESS (1.146s)
[288.001940] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.496s)
[289.142806] [035/133] (736s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[289.197145] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[289.199421] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[289.289473] [036/133] (736s left) kms_psr (fbc-psr2-sprite-render)
[289.387019] Starting subtest: fbc-psr2-sprite-render
[289.389228] Starting dynamic subtest: eDP-1
[289.393234] Dynamic subtest eDP-1: SKIP (0.000s)
[289.397264] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[289.458515] [037/133] (736s left) gem_ctx_persistence (heartbeat-hang)
[289.520078] Starting subtest: heartbeat-hang
[289.524364] Subtest heartbeat-hang: SKIP (0.000s)
[289.625005] [038/133] (735s left) api_intel_bb (blit-noreloc-purge-cache)
[289.681800] Starting subtest: blit-noreloc-purge-cache
[289.690676] Subtest blit-noreloc-purge-cache: SUCCESS (0.010s)
[289.825572] [039/133] (735s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[289.925720] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[289.929660] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[290.033541] [040/133] (735s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[290.123928] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[297.492165] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.371s)
[297.627151] [041/133] (728s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[297.686359] Starting subtest: invalid-single-wait-all-unsubmitted
[297.688267] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[297.801737] [042/133] (727s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[297.866374] Starting subtest: yf-tiled-to-vebox-x-tiled
[297.870572] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[298.059515] [043/133] (727s left) gem_exec_reloc (basic-cpu-read-noreloc)
[298.117640] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[298.202002] [044/133] (727s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[298.296860] Starting subtest: fbcpsr-slowdraw
[323.522959] Subtest fbcpsr-slowdraw: SUCCESS (25.228s)
[323.665004] [045/133] (702s left) gem_mmap_gtt (cpuset-basic-small-copy)
[323.725138] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[323.785963] [046/133] (702s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[323.888496] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[323.899884] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.011s)
[323.978261] [047/133] (701s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[324.062817] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[324.065032] Starting dynamic subtest: pipe-A-eDP-1
[341.306106] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.637s)
[341.316044] Starting dynamic subtest: pipe-B-eDP-1
[359.283298] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.865s)
[359.292544] Starting dynamic subtest: pipe-C-eDP-1
[377.238882] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.826s)
[377.248072] Starting dynamic subtest: pipe-D-eDP-1
[395.242100] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.764s)
[395.244621] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (11.097s)
[400.477772] [048/133] (629s left) kms_prop_blob (invalid-get-prop)
[400.548697] Starting subtest: invalid-get-prop
[400.550976] Subtest invalid-get-prop: SUCCESS (0.000s)
[400.662672] [049/133] (629s left) gem_pipe_control_store_loop (reused-buffer)
[400.719097] Starting subtest: reused-buffer
[402.873463] Subtest reused-buffer: SUCCESS (2.155s)
[402.980336] [050/133] (627s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[403.066028] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[403.070474] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[403.140061] [051/133] (626s left) kms_pm_dc (dc9-dpms)
[404.246163] Starting subtest: dc9-dpms
[405.675165] Subtest dc9-dpms: SUCCESS (1.429s)
[405.751478] [052/133] (624s left) kms_psr (pr-sprite-render)
[405.841373] Starting subtest: pr-sprite-render
[405.845765] Subtest pr-sprite-render: SKIP (0.000s)
[405.913746] [053/133] (624s left) gem_exec_schedule (smoketest-all)
[405.985706] Starting subtest: smoketest-all
[438.340513] Subtest smoketest-all: SUCCESS (32.324s)
[439.957237] [054/133] (590s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[440.064523] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[440.066734] Starting dynamic subtest: pipe-A-eDP-1
[445.978351] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.918s)
[445.987638] Starting dynamic subtest: pipe-B-eDP-1
[452.649357] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.673s)
[452.651890] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.593s)
[453.528091] [055/133] (576s left) kms_cursor_crc (cursor-offscreen-256x85)
[453.800344] Starting subtest: cursor-offscreen-256x85
[453.851538] Subtest cursor-offscreen-256x85: SKIP (0.047s)
[454.033639] [056/133] (576s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[454.121617] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[458.108700] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (3.992s)
[459.234759] [057/133] (571s left) gen3_render_tiledx_blits
[459.350771] [058/133] (571s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[459.438397] Starting subtest: pr-plane-move-sf-dmg-area
[459.442512] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[459.507112] [059/133] (570s left) syncobj_eventfd (timeline-wait)
[459.568626] Starting subtest: timeline-wait
[459.576974] Subtest timeline-wait: SUCCESS (0.010s)
[459.665234] [060/133] (570s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[459.752817] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[459.757227] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[459.850867] [061/133] (570s left) kms_atomic (crtc-invalid-params)
[459.939121] Starting subtest: crtc-invalid-params
[459.941345] Starting dynamic subtest: pipe-A-eDP-1
[460.298450] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.357s)
[460.300701] Subtest crtc-invalid-params: SUCCESS (0.359s)
[461.152984] [062/133] (569s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[461.208037] Starting subtest: etime-single-wait-for-submit-unsubmitted
[461.317312] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[461.394563] [063/133] (569s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[461.503465] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[462.162199] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.659s)
[462.328178] [064/133] (568s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[462.423149] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[462.449925] Starting dynamic subtest: pipe-A-plane-0
[462.760649] Dynamic subtest pipe-A-plane-0: SUCCESS (0.311s)
[462.772489] Starting dynamic subtest: pipe-A-plane-3
[462.994044] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[463.003453] Starting dynamic subtest: pipe-A-plane-5
[463.007976] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[464.133375] Starting dynamic subtest: pipe-B-plane-0
[464.436447] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[464.454738] Starting dynamic subtest: pipe-B-plane-3
[464.691927] Dynamic subtest pipe-B-plane-3: SUCCESS (0.253s)
[464.701906] Starting dynamic subtest: pipe-B-plane-5
[464.706422] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[465.005691] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.583s)
[465.809183] [065/133] (564s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[465.903517] Starting subtest: primary-y-tiled-reflect-x-0
[465.964047] Subtest primary-y-tiled-reflect-x-0: SKIP (0.060s)
[466.075330] [066/133] (564s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[466.163837] Starting subtest: fbc-rgb565-draw-mmap-gtt
[466.168052] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[466.280175] [067/133] (564s left) gem_ppgtt (shrink-vs-evict-pinned)
[466.336072] Starting subtest: shrink-vs-evict-pinned
[471.852491] Subtest shrink-vs-evict-pinned: SUCCESS (5.516s)
[471.936153] [068/133] (558s left) gem_exec_capture (userptr)
[471.995859] Starting subtest: userptr
[472.826030] Subtest userptr: SUCCESS (0.828s)
[472.937485] [069/133] (557s left) kms_dp_linktrain_fallback (dp-fallback)
[473.033993] Starting subtest: dp-fallback
[473.040183] Subtest dp-fallback: SKIP (0.000s)
[473.107675] [070/133] (557s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[473.197982] Starting subtest: 4-tiled-8bpp-rotate-90
[473.219683] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.021s)
[473.339435] [071/133] (557s left) kms_pipe_crc_basic (suspend-read-crc)
[473.431896] Starting subtest: suspend-read-crc
[473.434102] Starting dynamic subtest: pipe-A-eDP-1
[491.980910] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.928s)
[491.991883] Starting dynamic subtest: pipe-B-eDP-1
[510.982673] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.613s)
[510.993809] Starting dynamic subtest: pipe-C-eDP-1
[529.938869] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.426s)
[529.951488] Starting dynamic subtest: pipe-D-eDP-1
[548.949475] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.470s)
[548.951736] Subtest suspend-read-crc: SUCCESS (13.443s)
[554.779255] [072/133] (481s left) perf (enable-disable)
[554.890102] Starting subtest: enable-disable
[554.893222] Starting dynamic subtest: 0-rcs0
[557.156697] Dynamic subtest 0-rcs0: SUCCESS (2.266s)
[557.166955] Starting dynamic subtest: 1-vcs0
[561.680669] Dynamic subtest 1-vcs0: SUCCESS (4.523s)
[561.683635] Subtest enable-disable: SUCCESS (6.791s)
[561.731389] [073/133] (474s left) perf_pmu (all-busy-idle-check-all)
[561.772075] Starting subtest: all-busy-idle-check-all
[562.469274] Subtest all-busy-idle-check-all: FAIL (0.626s)
[562.978701] [074/133] (473s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[563.094988] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[563.098931] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[563.198268] [075/133] (472s left) kms_invalid_mode (zero-clock)
[563.294299] Starting subtest: zero-clock
[563.296517] Starting dynamic subtest: pipe-A-eDP-1
[563.582834] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[563.592649] Starting dynamic subtest: pipe-B-eDP-1
[563.594766] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[563.603463] Starting dynamic subtest: pipe-C-eDP-1
[563.605643] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[563.615632] Starting dynamic subtest: pipe-D-eDP-1
[563.617754] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[563.619941] Subtest zero-clock: SUCCESS (0.296s)
[564.406252] [076/133] (471s left) gem_madvise (dontneed-before-pwrite)
[564.446354] Starting subtest: dontneed-before-pwrite
[564.463722] Subtest dontneed-before-pwrite: SKIP (0.015s)
[564.526200] [077/133] (471s left) gem_exec_whisper (basic-queues-all)
[564.584724] Starting subtest: basic-queues-all
[575.926900] Subtest basic-queues-all: SUCCESS (11.342s)
[576.116200] [078/133] (460s left) kms_psr (psr-primary-render)
[576.210304] Starting subtest: psr-primary-render
[576.212588] Starting dynamic subtest: eDP-1
[577.901976] Dynamic subtest eDP-1: SUCCESS (1.692s)
[577.904222] Subtest psr-primary-render: SUCCESS (1.693s)
[578.766793] [079/133] (457s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[579.165676] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[579.988876] [080/133] (456s left) gem_bad_reloc (negative-reloc-lut)
[580.057245] Subtest negative-reloc-lut: SKIP (0.000s)
[580.127754] [081/133] (456s left) syncobj_wait (wait-any-snapshot)
[580.184027] Starting subtest: wait-any-snapshot
[580.263873] Subtest wait-any-snapshot: SUCCESS (0.081s)
[580.344456] [082/133] (456s left) i915_drm_fdinfo (virtual-busy-hang)
[580.385381] Starting subtest: virtual-busy-hang
[580.389712] Subtest virtual-busy-hang: SKIP (0.000s)
[580.454189] [083/133] (456s left) kms_selftest (drm_dp_mst_helper)
[580.492709] Starting subtest: drm_dp_mst_helper
[580.540805] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[580.630697] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.089s)
[580.640886] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[580.721839] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.093s)
[580.731764] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[580.816945] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.094s)
[580.819124] Subtest drm_dp_mst_helper: SUCCESS (0.326s)
[580.978788] [084/133] (455s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[581.075269] Starting subtest: async-flip-with-page-flip-events-tiled
[581.453717] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[584.178510] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.725s)
[584.191391] Starting dynamic subtest: pipe-A-eDP-1-4
[586.353156] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[586.365561] Starting dynamic subtest: pipe-A-eDP-1-4
[588.362383] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.007s)
[588.374810] Starting dynamic subtest: pipe-A-eDP-1-x
[590.541854] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.177s)
[590.922159] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[593.710994] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.795s)
[593.720738] Starting dynamic subtest: pipe-B-eDP-1-4
[595.909399] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.197s)
[595.919138] Starting dynamic subtest: pipe-B-eDP-1-4
[597.918309] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.008s)
[597.928380] Starting dynamic subtest: pipe-B-eDP-1-x
[600.119980] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.200s)
[600.486513] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[603.244757] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.764s)
[603.254852] Starting dynamic subtest: pipe-C-eDP-1-4
[605.419718] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[605.429295] Starting dynamic subtest: pipe-C-eDP-1-4
[607.430267] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[607.439932] Starting dynamic subtest: pipe-C-eDP-1-x
[609.619693] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.188s)
[609.983494] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[612.776246] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.801s)
[612.789309] Starting dynamic subtest: pipe-D-eDP-1-4
[614.940114] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.163s)
[614.950220] Starting dynamic subtest: pipe-D-eDP-1-4
[616.949926] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[616.960201] Starting dynamic subtest: pipe-D-eDP-1-x
[619.128001] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.176s)
[619.130575] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.051s)
[620.368384] [085/133] (416s left) gem_ctx_param (invalid-get-engines)
[620.437172] Starting subtest: invalid-get-engines
[620.439353] Subtest invalid-get-engines: SUCCESS (0.002s)
[620.568129] [086/133] (416s left) core_setmaster (master-drop-set-shared-fd)
[620.653664] Starting subtest: master-drop-set-shared-fd
[620.664183] Subtest master-drop-set-shared-fd: SUCCESS (0.011s)
[620.703658] [087/133] (415s left) prime_mmap (test_refcounting)
[620.753746] Starting subtest: test_refcounting
[620.755646] Starting dynamic subtest: test_refcounting-smem
[620.785792] Dynamic subtest test_refcounting-smem: SUCCESS (0.034s)
[620.788242] Subtest test_refcounting: SUCCESS (0.034s)
[620.888864] [088/133] (415s left) gen7_exec_parse (cmd-crossing-page)
[620.948453] Subtest cmd-crossing-page: SKIP (0.000s)
[621.016066] [089/133] (415s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[621.113305] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[621.117344] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[621.211844] [090/133] (415s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[621.314240] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[628.008506] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.697s)
[628.150004] [091/133] (408s left) kms_rotation_crc (sprite-rotation-90)
[628.257470] Starting subtest: sprite-rotation-90
[628.261715] Subtest sprite-rotation-90: SKIP (0.001s)
[628.335664] [092/133] (408s left) gem_exec_reloc (basic-write-cpu)
[628.397676] Subtest basic-write-cpu: SKIP (0.000s)
[628.466339] [093/133] (408s left) kms_chamelium_hpd (hdmi-hpd-fast)
[628.856266] Subtest hdmi-hpd-fast: SKIP (0.000s)
[629.637333] [094/133] (407s left) gem_ctx_shared (q-independent)
[629.703248] Starting subtest: Q-independent
[629.705472] Starting dynamic subtest: rcs0
[629.771288] Dynamic subtest rcs0: SUCCESS (0.067s)
[629.784383] Starting dynamic subtest: vcs0
[629.811852] Dynamic subtest vcs0: SUCCESS (0.040s)
[629.822213] Starting dynamic subtest: vcs1
[629.859457] Dynamic subtest vcs1: SUCCESS (0.047s)
[629.870519] Starting dynamic subtest: vecs0
[629.899067] Dynamic subtest vecs0: SUCCESS (0.039s)
[629.909277] Starting dynamic subtest: ccs0
[629.944544] Dynamic subtest ccs0: SUCCESS (0.045s)
[629.947022] Subtest Q-independent: SUCCESS (0.241s)
[631.041405] [095/133] (405s left) gem_spin_batch (user-each)
[631.109486] Starting subtest: user-each
[634.377151] Subtest user-each: SUCCESS (3.261s)
[636.018737] [096/133] (401s left) syncobj_wait (invalid-signal-illegal-handle)
[636.089539] Starting subtest: invalid-signal-illegal-handle
[636.092111] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[636.203184] [097/133] (400s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[636.293858] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[639.890414] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.600s)
[641.051162] [098/133] (396s left) gem_exec_fence (syncobj-timeline-unused-fence)
[641.613699] Starting subtest: syncobj-timeline-unused-fence
[641.619703] Subtest syncobj-timeline-unused-fence: SUCCESS (0.007s)
[642.985386] [099/133] (394s left) gem_ctx_engines (independent)
[643.052271] Starting subtest: independent
[643.054517] Starting dynamic subtest: rcs0
[643.190666] Dynamic subtest rcs0: SUCCESS (0.137s)
[643.203015] Starting dynamic subtest: bcs0
[643.320159] Dynamic subtest bcs0: SUCCESS (0.128s)
[643.330584] Starting dynamic subtest: vcs0
[643.441350] Dynamic subtest vcs0: SUCCESS (0.121s)
[643.454834] Starting dynamic subtest: vcs1
[643.595573] Dynamic subtest vcs1: SUCCESS (0.154s)
[643.606959] Starting dynamic subtest: vecs0
[643.831931] Dynamic subtest vecs0: SUCCESS (0.234s)
[643.843308] Starting dynamic subtest: ccs0
[644.077530] Dynamic subtest ccs0: SUCCESS (0.245s)
[644.087189] Starting dynamic subtest: all-engines
[644.896658] Dynamic subtest all-engines: SUCCESS (0.818s)
[644.899355] Subtest independent: SUCCESS (1.844s)
[645.140702] [100/133] (392s left) gem_exec_schedule (preempt-queue-contexts-chain)
[645.206680] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[645.491181] [101/133] (391s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[645.590714] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[645.593000] Starting dynamic subtest: pipe-A-eDP-1
[645.906752] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[645.917954] Starting dynamic subtest: pipe-B-eDP-1
[647.230255] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.325s)
[647.242148] Starting dynamic subtest: pipe-C-eDP-1
[648.519230] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.288s)
[648.530722] Starting dynamic subtest: pipe-D-eDP-1
[649.795267] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.275s)
[649.797168] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.178s)
[650.989409] [102/133] (386s left) syncobj_wait (multi-wait-for-submit-signaled)
[651.036554] Starting subtest: multi-wait-for-submit-signaled
[651.038656] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[651.125599] [103/133] (386s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[651.218903] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[651.222985] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[651.312443] [104/133] (386s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[651.430097] Starting subtest: cursorB-vs-flipA-legacy
[651.434682] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[651.571860] [105/133] (385s left) perf (non-zero-reason)
[651.683718] Starting subtest: non-zero-reason
[651.686123] Starting dynamic subtest: 0-rcs0
[657.123850] Dynamic subtest 0-rcs0: SUCCESS (5.436s)
[657.136863] Starting dynamic subtest: 1-vecs0
[661.054072] Dynamic subtest 1-vecs0: SUCCESS (3.928s)
[661.056556] Subtest non-zero-reason: SUCCESS (9.366s)
[661.098768] [106/133] (376s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[661.207845] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[661.211984] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[661.308702] [107/133] (376s left) gem_exec_fence (syncobj-invalid-flags)
[661.765162] Starting subtest: syncobj-invalid-flags
[661.767158] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[663.016981] [108/133] (374s left) kms_addfb_basic (invalid-get-prop-any)
[663.071415] Starting subtest: invalid-get-prop-any
[663.073317] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[663.214168] [109/133] (374s left) gem_mmap_wc (write-gtt-read-wc)
[663.267012] Subtest write-gtt-read-wc: SKIP (0.000s)
[663.327651] [110/133] (374s left) gem_exec_schedule (preempt-queue)
[663.390342] Subtest preempt-queue: SKIP (0.000s)
[663.689840] [111/133] (373s left) kms_vblank (query-forked-busy)
[663.771399] Starting subtest: query-forked-busy
[663.773569] Starting dynamic subtest: pipe-A-eDP-1
[665.669655] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.895s)
[665.685011] Starting dynamic subtest: pipe-D-eDP-1
[668.260599] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.588s)
[668.263183] Subtest query-forked-busy: SUCCESS (4.488s)
[669.062397] [112/133] (368s left) prime_busy (after)
[669.119771] Starting subtest: after
[669.125803] Starting dynamic subtest: rcs0
[669.148763] Dynamic subtest rcs0: SUCCESS (0.026s)
[669.160484] Starting dynamic subtest: bcs0
[669.196401] Dynamic subtest bcs0: SUCCESS (0.047s)
[669.207220] Starting dynamic subtest: vcs0
[669.237242] Dynamic subtest vcs0: SUCCESS (0.039s)
[669.248198] Starting dynamic subtest: vcs1
[669.277515] Dynamic subtest vcs1: SUCCESS (0.040s)
[669.287267] Starting dynamic subtest: vecs0
[669.318213] Dynamic subtest vecs0: SUCCESS (0.040s)
[669.327746] Starting dynamic subtest: ccs0
[669.359426] Dynamic subtest ccs0: SUCCESS (0.040s)
[669.467988] Subtest after: SUCCESS (0.346s)
[669.545879] [113/133] (368s left) kms_lease (lease-again)
[669.631604] Starting subtest: lease-again
[669.633790] Starting dynamic subtest: pipe-A-eDP-1
[669.636078] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[669.647764] Starting dynamic subtest: pipe-B-eDP-1
[669.649644] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[669.658669] Starting dynamic subtest: pipe-C-eDP-1
[669.660537] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[669.669647] Starting dynamic subtest: pipe-D-eDP-1
[669.671568] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[669.673527] Subtest lease-again: SUCCESS (0.015s)
[669.786090] [114/133] (368s left) kms_cursor_edge_walk (64x64-top-edge)
[669.882541] Starting subtest: 64x64-top-edge
[669.884834] Starting dynamic subtest: pipe-A-eDP-1
[674.041735] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.156s)
[674.061786] Starting dynamic subtest: pipe-D-eDP-1
[676.743515] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.701s)
[676.745767] Subtest 64x64-top-edge: SUCCESS (6.861s)
[677.555750] [115/133] (360s left) i915_pm_rps (reset)
[677.622321] Starting subtest: reset
[686.088379] Subtest reset: SUCCESS (8.464s)
[686.212465] [116/133] (351s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[686.326133] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[686.330544] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[686.428474] [117/133] (351s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[686.485507] Starting subtest: multi-wait-for-submit-available-signaled
[686.487795] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[686.586853] [118/133] (351s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[686.675446] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[686.677687] Starting dynamic subtest: pipe-A-eDP-1
[687.094523] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.420s)
[687.109133] Starting dynamic subtest: pipe-B-eDP-1
[687.125581] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.003s)
[687.135447] Starting dynamic subtest: pipe-C-eDP-1
[687.149673] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.003s)
[687.158561] Starting dynamic subtest: pipe-D-eDP-1
[687.173300] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[687.174844] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.435s)
[689.423406] [119/133] (348s left) kms_big_fb (linear-8bpp-rotate-0)
[689.525920] Starting subtest: linear-8bpp-rotate-0
[690.772020] Subtest linear-8bpp-rotate-0: SUCCESS (1.246s)
[690.897062] [120/133] (347s left) kms_getfb (getfb2-handle-not-fb)
[690.987508] Starting subtest: getfb2-handle-not-fb
[690.989442] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[691.081996] [121/133] (347s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[691.181807] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[691.195895] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[691.289022] [122/133] (346s left) gem_exec_reloc (basic-write-gtt-active)
[691.343887] Subtest basic-write-gtt-active: SKIP (0.000s)
[691.411688] [123/133] (346s left) gem_exec_capture (capture-recoverable)
[691.465603] Starting subtest: capture-recoverable
[691.469679] Subtest capture-recoverable: SUCCESS (0.003s)
[691.573906] [124/133] (346s left) gem_ctx_param (non-root-set)
[691.617131] Starting subtest: non-root-set
[691.635163] Subtest non-root-set: SUCCESS (0.018s)
[691.739768] [125/133] (346s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[691.853448] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[691.857401] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[691.949902] [126/133] (346s left) kms_dsc (dsc-with-formats)
[692.041265] Starting subtest: dsc-with-formats
[692.078702] Subtest dsc-with-formats: SKIP (0.001s)
[692.125538] [127/133] (346s left) gem_eio (in-flight-contexts-immediate)
[692.351647] Starting subtest: in-flight-contexts-immediate
[705.959850] Subtest in-flight-contexts-immediate: SUCCESS (13.607s)
[706.084390] [128/133] (332s left) gem_exec_balancer (bonded-semaphore)
[706.138757] Starting subtest: bonded-semaphore
[706.143363] Subtest bonded-semaphore: SKIP (0.000s)
[706.439546] [129/133] (332s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[706.541653] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[706.545955] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[706.629144] [130/133] (331s left) syncobj_timeline (wait-delayed-signal)
[706.693345] Starting subtest: wait-delayed-signal
[706.798564] Subtest wait-delayed-signal: SUCCESS (0.103s)
[706.882322] [131/133] (331s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[706.978542] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[706.982958] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[707.083148] [132/133] (331s left) kms_chamelium_color (ctm-max)
[707.171971] Subtest ctm-max: SKIP (0.000s)
[707.223245] [133/133] (331s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[707.313358] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[707.317756] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[707.400620] 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.