[59.461241] Initializing watchdogs
[59.461292]   /dev/watchdog0
[59.476743] [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]
[59.481949] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.484544] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.487726] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[59.609206] Starting subtest: fbcpsr-rgb101010-draw-render
[66.390971] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.786s)
[66.515354] [002/133] (953s left) gem_exec_schedule (preempt-queue-contexts-chain)
[66.589702] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[66.875453] [003/133] (953s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[67.213027] Starting subtest: dp-mst-type-0-suspend-resume
[67.218134] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[67.633784] [004/133] (952s left) kms_joiner (basic-force-ultra-joiner)
[67.755226] Starting subtest: basic-force-ultra-joiner
[67.759972] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[67.835911] [005/133] (952s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[68.018274] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[68.022499] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[68.223622] [006/133] (952s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[68.286991] Starting subtest: multi-wait-available-submitted-signaled
[68.289357] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s)
[68.394141] [007/133] (951s left) gem_madvise (dontneed-before-pwrite)
[68.433289] Starting subtest: dontneed-before-pwrite
[68.451054] Subtest dontneed-before-pwrite: SKIP (0.014s)
[68.511921] [008/133] (951s left) kms_lease (lease-invalid-connector)
[68.607381] Starting subtest: lease-invalid-connector
[68.609913] Starting dynamic subtest: pipe-A-eDP-1
[68.612449] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[68.623916] Starting dynamic subtest: pipe-B-eDP-1
[68.626053] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[68.633077] Starting dynamic subtest: pipe-C-eDP-1
[68.634921] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[68.641624] Starting dynamic subtest: pipe-D-eDP-1
[68.643544] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[68.645432] Subtest lease-invalid-connector: SUCCESS (0.003s)
[68.678735] [009/133] (951s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[68.781473] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[68.785643] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[68.897696] [010/133] (951s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[68.994242] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[68.998392] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[69.084686] [011/133] (951s left) perf_pmu (busy)
[69.126832] Starting subtest: busy
[69.129439] Starting dynamic subtest: rcs0
[69.735651] Dynamic subtest rcs0: SUCCESS (0.609s)
[69.745843] Starting dynamic subtest: bcs0
[70.302718] Dynamic subtest bcs0: SUCCESS (0.566s)
[70.312603] Starting dynamic subtest: vcs0
[71.896090] Dynamic subtest vcs0: SUCCESS (1.590s)
[71.906195] Starting dynamic subtest: vcs1
[73.942686] Dynamic subtest vcs1: SUCCESS (2.046s)
[73.956216] Starting dynamic subtest: vecs0
[75.924848] Dynamic subtest vecs0: SUCCESS (1.980s)
[75.935460] Starting dynamic subtest: ccs0
[76.488376] Dynamic subtest ccs0: SUCCESS (0.563s)
[76.490864] Subtest busy: SUCCESS (7.362s)
[76.577728] [012/133] (943s left) gem_exec_reloc (basic-cpu-wc)
[76.642594] Subtest basic-cpu-wc: SKIP (0.000s)
[76.702807] [013/133] (943s left) syncobj_wait (multi-wait-all-submitted)
[76.758682] Starting subtest: multi-wait-all-submitted
[76.865094] Subtest multi-wait-all-submitted: SUCCESS (0.105s)
[76.937212] [014/133] (943s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[77.038872] Starting subtest: plane-upscale-factor-0-25-with-rotation
[77.041276] Starting dynamic subtest: pipe-A
[77.264436] Dynamic subtest pipe-A: SUCCESS (0.228s)
[77.273832] Starting dynamic subtest: pipe-B
[78.534406] Dynamic subtest pipe-B: SUCCESS (1.270s)
[78.543802] Starting dynamic subtest: pipe-C
[79.867169] Dynamic subtest pipe-C: SUCCESS (1.332s)
[79.876244] Starting dynamic subtest: pipe-D
[81.207099] Dynamic subtest pipe-D: SUCCESS (1.339s)
[81.209448] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.171s)
[82.382822] [015/133] (938s left) syncobj_timeline (single-wait-available-submitted)
[82.437822] Starting subtest: single-wait-available-submitted
[82.440146] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[82.543393] [016/133] (938s left) gem_exec_reloc (basic-gtt-wc-active)
[82.606148] Subtest basic-gtt-wc-active: SKIP (0.000s)
[82.679497] [017/133] (937s left) kms_chamelium_color (ctm-red-to-blue)
[82.772573] Subtest ctm-red-to-blue: SKIP (0.000s)
[82.814196] [018/133] (937s left) fbdev (nullptr)
[82.859595] Starting subtest: nullptr
[82.861898] Subtest nullptr: SUCCESS (0.000s)
[82.916665] [019/133] (937s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[83.009501] Starting subtest: 4-tiled-addfb-size-offset-overflow
[83.011450] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[83.093782] [020/133] (937s left) core_hotunplug (unbind-rebind)
[83.194503] Starting subtest: unbind-rebind
[87.540166] Subtest unbind-rebind: SUCCESS (4.345s)
[87.580874] [021/133] (933s left) kms_rotation_crc (cursor-rotation-180)
[88.927616] Starting subtest: cursor-rotation-180
[90.435284] Subtest cursor-rotation-180: SUCCESS (1.509s)
[91.630062] [022/133] (929s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[91.721848] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[91.724210] Starting dynamic subtest: pipe-A-eDP-1
[91.748221] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[91.761230] Starting dynamic subtest: pipe-B-eDP-1
[91.782315] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[91.789791] Starting dynamic subtest: pipe-C-eDP-1
[91.810458] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[91.818214] Starting dynamic subtest: pipe-D-eDP-1
[91.839671] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[91.844046] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[94.199736] [023/133] (926s left) gem_exec_fence (basic-await)
[94.379476] Starting subtest: basic-await
[94.381973] Starting dynamic subtest: rcs0
[94.456044] Dynamic subtest rcs0: SUCCESS (0.077s)
[94.468071] Starting dynamic subtest: bcs0
[94.528620] Dynamic subtest bcs0: SUCCESS (0.072s)
[94.542732] Starting dynamic subtest: vcs0
[94.602509] Dynamic subtest vcs0: SUCCESS (0.073s)
[94.615295] Starting dynamic subtest: vcs1
[94.676624] Dynamic subtest vcs1: SUCCESS (0.074s)
[94.687239] Starting dynamic subtest: vecs0
[94.751312] Dynamic subtest vecs0: SUCCESS (0.074s)
[94.761605] Starting dynamic subtest: ccs0
[94.824836] Dynamic subtest ccs0: SUCCESS (0.073s)
[94.827779] Subtest basic-await: SUCCESS (0.446s)
[97.003524] [FACT gem_exec_fence (basic-await)] new: kernel.kmod_is_loaded.vgem: true
[97.006992] [024/133] (923s left) gem_ctx_bad_destroy (invalid-ctx)
[97.060548] Starting subtest: invalid-ctx
[97.063044] Subtest invalid-ctx: SUCCESS (0.000s)
[97.153705] [025/133] (923s left) gem_create (busy-create)
[97.207579] Starting subtest: busy-create
[97.209890] Starting dynamic subtest: smem0
[130.904212] Dynamic subtest smem0: SUCCESS (33.694s)
[130.906646] Subtest busy-create: SUCCESS (33.695s)
[131.093501] [026/133] (889s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[131.185794] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[131.214418] Starting dynamic subtest: pipe-A-plane-0
[131.514313] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[131.524590] Starting dynamic subtest: pipe-A-plane-3
[131.748248] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[132.889743] Starting dynamic subtest: pipe-B-plane-0
[133.182195] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[133.192650] Starting dynamic subtest: pipe-B-plane-3
[133.415274] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[133.730225] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.544s)
[134.562838] [027/133] (886s left) gem_exec_whisper (basic-contexts-forked-all)
[134.621639] Starting subtest: basic-contexts-forked-all
[154.873379] Subtest basic-contexts-forked-all: SUCCESS (20.247s)
[155.059752] [028/133] (866s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[155.187179] Starting subtest: short-flip-after-cursor-toggle
[156.142498] Subtest short-flip-after-cursor-toggle: SUCCESS (0.956s)
[157.011062] [029/133] (864s left) gen9_exec_parse (unaligned-jump)
[157.058358] Subtest unaligned-jump: SKIP (0.000s)
[157.125460] [030/133] (864s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[157.222254] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[157.226670] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[157.321680] [031/133] (863s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[157.409370] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[164.729258] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.322s)
[164.841824] [032/133] (856s left) kms_cursor_crc (cursor-offscreen-256x85)
[165.089677] Starting subtest: cursor-offscreen-256x85
[165.134804] Subtest cursor-offscreen-256x85: SKIP (0.043s)
[165.299096] [033/133] (856s left) gem_workarounds (reset-context)
[165.362287] Starting subtest: reset-context
[165.542656] Subtest reset-context: SUCCESS (0.179s)
[165.705498] [034/133] (855s left) gem_exec_params (dr4-dirt)
[165.765484] Starting subtest: DR4-dirt
[165.767476] Subtest DR4-dirt: SUCCESS (0.000s)
[165.863849] [035/133] (855s left) gem_exec_balancer (invalid-bonds)
[165.917097] Starting subtest: invalid-bonds
[165.920917] Subtest invalid-bonds: SKIP (0.000s)
[166.241303] [036/133] (855s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[166.334734] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[166.338759] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[166.440184] [037/133] (855s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[166.492124] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[166.600990] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.108s)
[166.678465] [038/133] (854s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[166.765529] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[166.769618] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[166.863443] [039/133] (854s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[166.960378] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[166.964816] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[167.064596] [040/133] (854s left) gem_exec_params (larger-than-life-batch)
[167.126586] Starting subtest: larger-than-life-batch
[169.658762] Subtest larger-than-life-batch: SUCCESS (2.531s)
[170.953266] [041/133] (850s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[171.043080] Starting subtest: etime-multi-wait-for-submit-submitted
[171.152785] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.108s)
[171.230737] [042/133] (850s left) kms_setmode (invalid-clone-single-crtc)
[171.289144] Starting subtest: invalid-clone-single-crtc
[171.295804] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[171.392625] [043/133] (850s left) gen9_exec_parse (bb-start-far)
[171.450437] Subtest bb-start-far: SKIP (0.000s)
[171.521552] [044/133] (850s left) syncobj_timeline (wait-zero-handles)
[171.568638] Starting subtest: wait-zero-handles
[171.570552] Subtest wait-zero-handles: SUCCESS (0.000s)
[171.652967] [045/133] (850s left) gem_partial_pwrite_pread (reads-uncached)
[171.714755] Subtest reads-uncached: SKIP (0.000s)
[171.789943] [046/133] (850s left) gem_mmap_gtt (cpuset-big-copy)
[171.843297] Subtest cpuset-big-copy: SKIP (0.000s)
[171.904935] [047/133] (850s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[172.004993] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[172.009312] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[172.099098] [048/133] (849s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[172.201275] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[176.505619] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.307s)
[177.633048] [049/133] (844s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[177.726119] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[177.728479] Starting dynamic subtest: pipe-A-eDP-1
[177.752376] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[177.763441] Starting dynamic subtest: pipe-B-eDP-1
[177.785372] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[177.794825] Starting dynamic subtest: pipe-C-eDP-1
[177.816462] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[177.827617] Starting dynamic subtest: pipe-D-eDP-1
[177.849061] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[177.853316] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[179.909022] [050/133] (842s left) gem_pread (exhaustion)
[179.972153] Subtest exhaustion: SKIP (0.000s)
[180.035431] [051/133] (842s left) kms_addfb_basic (basic-x-tiled-legacy)
[180.091955] Starting subtest: basic-x-tiled-legacy
[180.096068] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[180.232593] [052/133] (841s left) kms_vblank (ts-continuation-suspend)
[180.320566] Starting subtest: ts-continuation-suspend
[180.322756] Starting dynamic subtest: pipe-A-eDP-1
[197.575374] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.838s)
[197.591403] Starting dynamic subtest: pipe-D-eDP-1
[215.556829] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.600s)
[215.558984] Subtest ts-continuation-suspend: SUCCESS (5.442s)
[226.392036] [053/133] (805s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[226.510936] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[226.515481] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[226.577149] [054/133] (805s left) gem_workarounds (reset)
[226.638688] Starting subtest: reset
[226.812342] Subtest reset: SUCCESS (0.172s)
[226.945299] [055/133] (805s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[227.045263] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[227.047537] Starting dynamic subtest: pipe-A-eDP-1
[238.035897] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.995s)
[238.046882] Starting dynamic subtest: pipe-B-eDP-1
[249.782869] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.743s)
[249.784870] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.740s)
[250.638439] [056/133] (781s left) kms_flip (dpms-off-confusion)
[250.728516] Starting subtest: dpms-off-confusion
[250.730813] Starting dynamic subtest: A-eDP1
[259.444259] Dynamic subtest A-eDP1: SUCCESS (8.713s)
[259.456592] Starting dynamic subtest: B-eDP1
[268.074353] Dynamic subtest B-eDP1: SUCCESS (8.628s)
[268.087259] Starting dynamic subtest: C-eDP1
[276.704783] Dynamic subtest C-eDP1: SUCCESS (8.629s)
[276.716775] Starting dynamic subtest: D-eDP1
[285.347730] Dynamic subtest D-eDP1: SUCCESS (8.640s)
[285.353189] Subtest dpms-off-confusion: SUCCESS (34.620s)
[286.541379] [057/133] (745s left) gem_ctx_persistence (smoketest)
[286.613300] Starting subtest: smoketest
[326.612504] Subtest smoketest: SUCCESS (39.995s)
[326.692440] [058/133] (705s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[326.786177] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[333.956912] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.174s)
[334.123153] [059/133] (698s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[334.182632] Starting subtest: multi-wait-all-for-submit-available-submitted
[334.184859] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[334.274282] [060/133] (698s left) kms_rotation_crc (sprite-rotation-90)
[334.373421] Starting subtest: sprite-rotation-90
[334.378099] Subtest sprite-rotation-90: SKIP (0.001s)
[334.463647] [061/133] (698s left) kms_async_flips (test-time-stamp)
[334.551972] Starting subtest: test-time-stamp
[334.935122] Starting dynamic subtest: pipe-A-eDP-1
[335.766156] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.829s)
[336.137763] Starting dynamic subtest: pipe-B-eDP-1
[336.893823] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.763s)
[337.269413] Starting dynamic subtest: pipe-C-eDP-1
[338.032233] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.769s)
[338.396889] Starting dynamic subtest: pipe-D-eDP-1
[339.158278] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.768s)
[339.160652] Subtest test-time-stamp: SUCCESS (4.607s)
[340.320030] [062/133] (692s left) i915_pm_rpm (debugfs-forcewake-user)
[341.850813] Starting subtest: debugfs-forcewake-user
[353.249614] Subtest debugfs-forcewake-user: SUCCESS (11.402s)
[353.632748] [063/133] (679s left) kms_psr (psr2-basic)
[353.737871] Starting subtest: psr2-basic
[353.740022] Starting dynamic subtest: eDP-1
[355.389046] Dynamic subtest eDP-1: SUCCESS (1.652s)
[355.391382] Subtest psr2-basic: SUCCESS (1.653s)
[356.197893] [064/133] (676s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[356.318710] Starting subtest: cursorA-vs-flipB-varying-size
[356.323323] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[356.466499] [065/133] (676s left) gen3_render_linear_blits
[356.583125] [066/133] (676s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[356.683655] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[356.687825] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[356.796599] [067/133] (676s left) sw_sync (sync_multi_timeline_wait)
[356.830585] Starting subtest: sync_multi_timeline_wait
[356.832512] Subtest sync_multi_timeline_wait: SUCCESS (0.001s)
[356.894424] [068/133] (676s left) kms_pm_rpm (modeset-non-lpsp-stress)
[358.837752] Starting subtest: modeset-non-lpsp-stress
[359.994245] Subtest modeset-non-lpsp-stress: SKIP (1.156s)
[360.382695] [069/133] (672s left) kms_psr (fbc-psr-primary-mmap-cpu)
[360.478171] Starting subtest: fbc-psr-primary-mmap-cpu
[360.480387] Starting dynamic subtest: eDP-1
[360.484398] Dynamic subtest eDP-1: SKIP (0.000s)
[360.488408] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[360.554757] [070/133] (672s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[360.647063] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[360.651462] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[360.751221] [071/133] (672s left) prime_vgem (fence-flip-hang)
[360.842279] Subtest fence-flip-hang: SKIP (0.000s)
[360.937940] [072/133] (672s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[361.058094] Starting subtest: flip-vs-cursor-varying-size
[369.755654] Subtest flip-vs-cursor-varying-size: SUCCESS (8.696s)
[370.588992] [073/133] (662s left) perf_pmu (pmu-read)
[370.634267] Starting subtest: pmu-read
[370.636513] Subtest pmu-read: SUCCESS (0.002s)
[370.740148] [074/133] (662s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[370.863948] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[371.843116] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.978s)
[371.954435] [075/133] (661s left) drm_read (fault-buffer)
[372.098975] Starting subtest: fault-buffer
[372.101323] Subtest fault-buffer: SUCCESS (0.001s)
[372.227578] [076/133] (661s left) gem_exec_reloc (basic-wc-read-active)
[372.282695] Subtest basic-wc-read-active: SKIP (0.000s)
[372.347973] [077/133] (660s left) kms_cursor_crc (cursor-random-256x85)
[372.594399] Starting subtest: cursor-random-256x85
[372.638672] Subtest cursor-random-256x85: SKIP (0.042s)
[372.809542] [078/133] (660s left) gem_gpgpu_fill (offset-16x16)
[372.861274] Starting subtest: offset-16x16
[372.866133] Subtest offset-16x16: SUCCESS (0.007s)
[373.047601] [079/133] (660s left) prime_vgem (busy)
[373.132525] Starting subtest: busy
[373.134566] Starting dynamic subtest: rcs0
[373.224570] Dynamic subtest rcs0: SUCCESS (0.091s)
[373.236782] Starting dynamic subtest: bcs0
[373.274150] Dynamic subtest bcs0: SUCCESS (0.049s)
[373.286494] Starting dynamic subtest: vcs0
[373.323019] Dynamic subtest vcs0: SUCCESS (0.046s)
[373.333432] Starting dynamic subtest: vcs1
[373.368471] Dynamic subtest vcs1: SUCCESS (0.045s)
[373.378832] Starting dynamic subtest: vecs0
[373.414569] Dynamic subtest vecs0: SUCCESS (0.045s)
[373.424634] Starting dynamic subtest: ccs0
[373.462613] Dynamic subtest ccs0: SUCCESS (0.043s)
[373.464946] Subtest busy: SUCCESS (0.327s)
[373.605524] [080/133] (659s left) gem_ctx_param (invalid-get-no-zeromap)
[373.652687] Starting subtest: invalid-get-no-zeromap
[373.654737] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[373.761771] [081/133] (659s left) gem_fence_thrash (bo-write-verify-threaded-y)
[373.801524] Starting subtest: bo-write-verify-threaded-y
[373.816494] Subtest bo-write-verify-threaded-y: SKIP (0.017s)
[373.876522] [082/133] (659s left) kms_color (ctm-max)
[373.983652] Starting subtest: ctm-max
[373.985255] Starting dynamic subtest: pipe-A-eDP-1
[374.689749] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.707s)
[374.701451] Starting dynamic subtest: pipe-B-eDP-1
[376.097784] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.404s)
[376.108507] Starting dynamic subtest: pipe-C-eDP-1
[377.472294] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.377s)
[377.483083] Starting dynamic subtest: pipe-D-eDP-1
[378.803627] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[378.805772] Subtest ctm-max: SUCCESS (4.819s)
[379.612909] [083/133] (653s left) kms_plane_multiple (tiling-x)
[379.712298] Starting subtest: tiling-x
[379.714675] Starting dynamic subtest: pipe-A-eDP-1
[383.457299] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.744s)
[383.469033] Starting dynamic subtest: pipe-B-eDP-1
[387.889416] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.432s)
[387.900852] Starting dynamic subtest: pipe-C-eDP-1
[392.231433] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.339s)
[392.242587] Starting dynamic subtest: pipe-D-eDP-1
[396.570776] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.338s)
[396.573206] Subtest tiling-x: SUCCESS (16.858s)
[397.383976] [084/133] (636s left) kms_draw_crc (draw-method-render)
[397.488105] Starting subtest: draw-method-render
[397.489999] Starting dynamic subtest: xrgb8888-untiled
[397.730794] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s)
[397.741695] Starting dynamic subtest: rgb565-untiled
[397.941882] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[397.952468] Starting dynamic subtest: xrgb2101010-untiled
[398.175249] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.232s)
[398.186350] Starting dynamic subtest: xbgr16161616f-untiled
[398.419042] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.244s)
[398.430097] Starting dynamic subtest: xrgb8888-xtiled
[398.542344] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[398.552526] Starting dynamic subtest: rgb565-xtiled
[398.675071] Dynamic subtest rgb565-xtiled: SUCCESS (0.130s)
[398.685882] Starting dynamic subtest: xrgb2101010-xtiled
[398.797102] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[398.807854] Starting dynamic subtest: xbgr16161616f-xtiled
[398.930300] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[398.942302] Starting dynamic subtest: xrgb8888-4tiled
[399.052692] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.122s)
[399.063464] Starting dynamic subtest: rgb565-4tiled
[399.163674] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s)
[399.174384] Starting dynamic subtest: xrgb2101010-4tiled
[399.286030] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.122s)
[399.296407] Starting dynamic subtest: xbgr16161616f-4tiled
[399.419330] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.132s)
[399.421304] Subtest draw-method-render: SUCCESS (1.934s)
[399.538692] [085/133] (634s left) gem_exec_suspend (basic)
[399.604289] Starting subtest: basic
[399.606163] Starting dynamic subtest: smem
[400.695231] Dynamic subtest smem: SUCCESS (1.088s)
[400.697959] Subtest basic: SUCCESS (1.090s)
[400.884398] [086/133] (632s left) i915_query (engine-info-invalid)
[400.939744] Starting subtest: engine-info-invalid
[400.941693] Subtest engine-info-invalid: SUCCESS (0.000s)
[401.032414] [087/133] (632s left) kms_psr (fbc-pr-primary-mmap-gtt)
[401.124073] Starting subtest: fbc-pr-primary-mmap-gtt
[401.128565] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[401.199140] [088/133] (632s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[401.295528] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[401.297771] Starting dynamic subtest: pipe-A-eDP-1
[402.555876] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.262s)
[402.574309] Starting dynamic subtest: pipe-B-eDP-1
[404.930444] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.374s)
[404.942188] Starting dynamic subtest: pipe-C-eDP-1
[407.258554] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.326s)
[407.272058] Starting dynamic subtest: pipe-D-eDP-1
[409.617462] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.341s)
[409.619695] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.308s)
[410.706650] [089/133] (623s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[410.809600] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[415.007715] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.201s)
[416.219437] [090/133] (617s left) kms_chamelium_hpd (dp-hpd-storm)
[416.615255] Subtest dp-hpd-storm: SKIP (0.000s)
[417.426052] [091/133] (616s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[417.538064] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[417.542462] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[417.624624] [092/133] (616s left) prime_self_import (basic-with_fd_dup)
[417.665951] Starting subtest: basic-with_fd_dup
[417.688702] Subtest basic-with_fd_dup: SUCCESS (0.023s)
[417.794241] [093/133] (616s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[417.876112] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[417.878284] Starting dynamic subtest: pipe-A-eDP-1
[417.899659] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[417.911898] Starting dynamic subtest: pipe-B-eDP-1
[417.932475] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[417.942706] Starting dynamic subtest: pipe-C-eDP-1
[417.963472] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[417.974069] Starting dynamic subtest: pipe-D-eDP-1
[417.995521] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[417.999592] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[420.114963] [094/133] (613s left) kms_flip (wf_vblank-ts-check)
[420.202373] Starting subtest: wf_vblank-ts-check
[420.204236] Starting dynamic subtest: A-eDP1
[429.164251] Dynamic subtest A-eDP1: SUCCESS (8.963s)
[429.175183] Starting dynamic subtest: B-eDP1
[438.095606] Dynamic subtest B-eDP1: SUCCESS (8.929s)
[438.110430] Starting dynamic subtest: C-eDP1
[447.008773] Dynamic subtest C-eDP1: SUCCESS (8.909s)
[447.019353] Starting dynamic subtest: D-eDP1
[455.937557] Dynamic subtest D-eDP1: SUCCESS (8.927s)
[455.942758] Subtest wf_vblank-ts-check: SUCCESS (35.742s)
[457.183888] [095/133] (576s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[457.289291] Starting subtest: x-tiled-8bpp-rotate-90
[457.310047] Subtest x-tiled-8bpp-rotate-90: SKIP (0.020s)
[457.434509] [096/133] (576s left) kms_psr (fbc-pr-cursor-plane-onoff)
[457.526199] Starting subtest: fbc-pr-cursor-plane-onoff
[457.530478] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[457.600488] [097/133] (576s left) kms_psr (psr-sprite-blt)
[457.690245] Starting subtest: psr-sprite-blt
[457.692493] Starting dynamic subtest: eDP-1
[459.470765] Dynamic subtest eDP-1: SUCCESS (1.780s)
[459.472673] Subtest psr-sprite-blt: SUCCESS (1.781s)
[460.310451] [098/133] (573s left) gem_exec_reloc (basic-range)
[460.367532] Subtest basic-range: SKIP (0.000s)
[460.441483] [099/133] (573s left) gem_softpin (allocator-evict)
[460.506960] Starting subtest: allocator-evict
[460.509282] Starting dynamic subtest: rcs0
[483.718237] Dynamic subtest rcs0: SUCCESS (23.210s)
[483.729010] Starting dynamic subtest: bcs0
[507.482017] Dynamic subtest bcs0: SUCCESS (23.761s)
[507.492794] Starting dynamic subtest: vcs0
[531.425476] Dynamic subtest vcs0: SUCCESS (23.941s)
[531.438805] Starting dynamic subtest: vcs1
[555.074564] Dynamic subtest vcs1: SUCCESS (23.645s)
[555.088452] Starting dynamic subtest: vecs0
[578.824419] Dynamic subtest vecs0: SUCCESS (23.747s)
[578.836473] Starting dynamic subtest: ccs0
[602.600994] Dynamic subtest ccs0: SUCCESS (23.774s)
[602.605002] Subtest allocator-evict: SUCCESS (142.088s)
[602.688141] [100/133] (431s left) kms_cursor_legacy (forked-move)
[602.855779] Starting subtest: forked-move
[602.857988] Starting dynamic subtest: pipe-A
[608.332130] Dynamic subtest pipe-A: SUCCESS (5.474s)
[608.346122] Starting dynamic subtest: pipe-B
[613.803497] Dynamic subtest pipe-B: SUCCESS (5.468s)
[613.816716] Starting dynamic subtest: pipe-C
[619.276888] Dynamic subtest pipe-C: SUCCESS (5.471s)
[619.290870] Starting dynamic subtest: pipe-D
[624.746163] Dynamic subtest pipe-D: SUCCESS (5.466s)
[624.759358] Starting dynamic subtest: all-pipes
[630.242829] Dynamic subtest all-pipes: SUCCESS (5.494s)
[630.245529] Subtest forked-move: SUCCESS (27.384s)
[630.407133] [101/133] (403s left) kms_frontbuffer_tracking (fbc-tiling-y)
[630.512278] Starting subtest: fbc-tiling-y
[630.516682] Subtest fbc-tiling-y: SKIP (0.000s)
[630.627005] [102/133] (403s left) kms_pipe_crc_basic (read-crc)
[630.729335] Starting subtest: read-crc
[630.731197] Starting dynamic subtest: pipe-A-eDP-1
[631.433433] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.705s)
[631.446045] Starting dynamic subtest: pipe-B-eDP-1
[632.780002] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.343s)
[632.791614] Starting dynamic subtest: pipe-C-eDP-1
[634.086561] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.305s)
[634.097972] Starting dynamic subtest: pipe-D-eDP-1
[635.404852] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.318s)
[635.407296] Subtest read-crc: SUCCESS (4.677s)
[636.244946] [103/133] (398s left) kms_cursor_edge_walk (64x64-top-bottom)
[636.338270] Starting subtest: 64x64-top-bottom
[636.340582] Starting dynamic subtest: pipe-A-eDP-1
[639.812839] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.473s)
[639.825450] Starting dynamic subtest: pipe-D-eDP-1
[642.936006] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.124s)
[642.938191] Subtest 64x64-top-bottom: SUCCESS (6.600s)
[643.745839] [104/133] (390s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[643.868812] Starting subtest: cursorB-vs-flipB-legacy
[643.873353] Subtest cursorB-vs-flipB-legacy: SKIP (0.002s)
[644.032342] [105/133] (390s left) gem_userptr_blits (usage-restrictions)
[644.099982] Starting subtest: usage-restrictions
[644.103065] Subtest usage-restrictions: SUCCESS (0.000s)
[644.219728] [106/133] (390s left) gem_caching (writes)
[644.281471] Subtest writes: SKIP (0.000s)
[644.357612] [107/133] (390s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[644.404222] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[644.505272] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.101s)
[644.586070] [108/133] (390s left) kms_psr (psr2-cursor-mmap-cpu)
[644.672957] Starting subtest: psr2-cursor-mmap-cpu
[644.675192] Starting dynamic subtest: eDP-1
[646.420954] Dynamic subtest eDP-1: SUCCESS (1.747s)
[646.423563] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.748s)
[647.315624] [109/133] (387s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[648.843267] Starting subtest: dpms-mode-unset-non-lpsp
[649.997223] Subtest dpms-mode-unset-non-lpsp: SKIP (1.154s)
[650.383539] [110/133] (384s left) api_intel_bb (add-remove-objects)
[650.440326] Starting subtest: add-remove-objects
[650.445792] Subtest add-remove-objects: SUCCESS (0.006s)
[650.565741] [111/133] (384s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[650.658685] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[650.663109] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[650.761724] [112/133] (384s left) kms_plane_scaling (invalid-parameters)
[650.860115] Starting subtest: invalid-parameters
[650.862331] Starting dynamic subtest: less-than-1-height-src
[650.872592] Dynamic subtest less-than-1-height-src: SUCCESS (0.013s)
[650.884097] Starting dynamic subtest: less-than-1-width-src
[650.886360] Dynamic subtest less-than-1-width-src: SUCCESS (0.013s)
[650.888585] Subtest invalid-parameters: SUCCESS (0.027s)
[650.976729] [113/133] (383s left) gem_exec_fence (keep-in-fence)
[651.151256] Starting subtest: keep-in-fence
[651.153885] Starting dynamic subtest: rcs0
[651.212910] Dynamic subtest rcs0: SUCCESS (0.061s)
[651.225872] Starting dynamic subtest: bcs0
[651.267322] Dynamic subtest bcs0: SUCCESS (0.053s)
[651.278947] Starting dynamic subtest: vcs0
[652.727141] Dynamic subtest vcs0: SUCCESS (1.456s)
[652.741021] Starting dynamic subtest: vcs1
[654.711804] Dynamic subtest vcs1: SUCCESS (1.982s)
[654.724956] Starting dynamic subtest: vecs0
[656.695513] Dynamic subtest vecs0: SUCCESS (1.982s)
[656.708628] Starting dynamic subtest: ccs0
[656.929397] Dynamic subtest ccs0: SUCCESS (0.232s)
[656.931693] Subtest keep-in-fence: SUCCESS (5.780s)
[658.757847] [114/133] (376s left) kms_big_fb (linear-32bpp-rotate-270)
[658.858791] Starting subtest: linear-32bpp-rotate-270
[658.880105] Subtest linear-32bpp-rotate-270: SKIP (0.021s)
[658.985268] [115/133] (376s left) gem_mmap_wc (write)
[659.039953] Subtest write: SKIP (0.000s)
[659.096553] [116/133] (375s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[659.153554] Starting subtest: x-tiled-to-vebox-y-tiled
[659.157673] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[659.339096] [117/133] (375s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[659.440473] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[659.444523] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[659.549478] [118/133] (375s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[659.642444] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[659.644627] Starting dynamic subtest: pipe-A-eDP-1
[659.702790] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[659.715509] Starting dynamic subtest: pipe-B-eDP-1
[659.772669] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[659.783829] Starting dynamic subtest: pipe-C-eDP-1
[659.838281] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[659.848838] Starting dynamic subtest: pipe-D-eDP-1
[659.902380] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[659.906635] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.009s)
[661.910888] [119/133] (373s left) gem_userptr_blits (nohangcheck)
[661.984987] Starting subtest: nohangcheck
[662.220286] Subtest nohangcheck: SUCCESS (0.232s)
[662.330038] [120/133] (372s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[662.448513] Starting subtest: basic-flip-before-cursor-atomic
[663.372814] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.925s)
[664.259555] [121/133] (371s left) kms_sequence (get-idle)
[664.353530] Starting subtest: get-idle
[664.355840] Starting dynamic subtest: pipe-A-eDP-1
[666.160075] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.808s)
[666.171068] Starting dynamic subtest: pipe-B-eDP-1
[668.626153] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.465s)
[668.637960] Starting dynamic subtest: pipe-C-eDP-1
[671.052543] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.422s)
[671.063779] Starting dynamic subtest: pipe-D-eDP-1
[673.493048] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.440s)
[673.495438] Subtest get-idle: SUCCESS (9.141s)
[674.301382] [122/133] (361s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[674.407844] Starting subtest: yf-tiled-8bpp-rotate-270
[674.412343] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[674.506183] [123/133] (360s left) api_intel_bb (intel-bb-blit-x)
[674.571781] Starting subtest: intel-bb-blit-x
[678.376822] Subtest intel-bb-blit-x: SUCCESS (3.805s)
[678.481669] [124/133] (356s left) kms_flip (flip-vs-suspend-interruptible)
[678.586352] Starting subtest: flip-vs-suspend-interruptible
[678.588528] Starting dynamic subtest: A-eDP1
[712.291018] Dynamic subtest A-eDP1: SUCCESS (4.287s)
[712.304553] Starting dynamic subtest: B-eDP1
[746.266662] Dynamic subtest B-eDP1: SUCCESS (4.170s)
[746.286382] Starting dynamic subtest: C-eDP1
[780.294511] Dynamic subtest C-eDP1: SUCCESS (4.177s)
[780.307481] Starting dynamic subtest: D-eDP1
[814.295267] Dynamic subtest D-eDP1: SUCCESS (4.167s)
[814.298761] Subtest flip-vs-suspend-interruptible: SUCCESS (16.811s)
[824.492177] [125/133] (220s left) kms_hdmi_inject (inject-4k)
[824.845751] Starting subtest: inject-4k
[825.162019] Subtest inject-4k: SUCCESS (0.314s)
[825.755057] [126/133] (218s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[825.848855] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[825.853674] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[825.948521] [127/133] (218s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[826.014009] Starting subtest: yf-tiled-ccs-to-y-tiled
[826.019423] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[826.201039] [128/133] (218s left) gem_mmap_gtt (pf-nonblock)
[826.260469] Subtest pf-nonblock: SKIP (0.000s)
[826.322476] [129/133] (218s left) kms_getfb (getfb2-into-addfb2)
[826.418029] Starting subtest: getfb2-into-addfb2
[826.420444] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[826.518559] [130/133] (218s left) gem_exec_schedule (lateslice)
[826.596576] Starting subtest: lateslice
[826.598750] Starting dynamic subtest: rcs0
[826.609747] Dynamic subtest rcs0: SUCCESS (0.024s)
[826.621522] Starting dynamic subtest: bcs0
[826.630298] Dynamic subtest bcs0: SUCCESS (0.020s)
[826.642949] Starting dynamic subtest: vcs0
[826.650931] Dynamic subtest vcs0: SUCCESS (0.020s)
[826.661530] Starting dynamic subtest: vcs1
[826.669051] Dynamic subtest vcs1: SUCCESS (0.017s)
[826.679395] Starting dynamic subtest: vecs0
[826.689434] Dynamic subtest vecs0: SUCCESS (0.019s)
[826.705941] Starting dynamic subtest: ccs0
[826.708846] Dynamic subtest ccs0: SUCCESS (0.017s)
[826.710935] Subtest lateslice: SUCCESS (0.121s)
[828.654589] [131/133] (216s left) i915_hangman (engine-engine-hang)
[828.714088] Starting subtest: engine-engine-hang
[828.716880] Starting dynamic subtest: rcs0
[830.603971] Dynamic subtest rcs0: SUCCESS (1.886s)
[830.615855] Starting dynamic subtest: bcs0
[832.587831] Dynamic subtest bcs0: SUCCESS (1.978s)
[832.601746] Starting dynamic subtest: vcs0
[834.572032] Dynamic subtest vcs0: SUCCESS (1.979s)
[834.586190] Starting dynamic subtest: vcs1
[836.554829] Dynamic subtest vcs1: SUCCESS (1.977s)
[836.568916] Starting dynamic subtest: vecs0
[838.603166] Dynamic subtest vecs0: SUCCESS (2.043s)
[838.617274] Starting dynamic subtest: ccs0
[840.587137] Dynamic subtest ccs0: SUCCESS (1.979s)
[840.590318] Subtest engine-engine-hang: SUCCESS (11.859s)
[840.685621] [132/133] (204s left) gem_exec_flush (basic-wb-prw-default)
[840.751347] Starting subtest: basic-wb-prw-default
[846.231769] Subtest basic-wb-prw-default: SUCCESS (5.475s)
[846.423965] [133/133] (198s left) gem_ctx_shared (q-in-order)
[846.488896] Starting subtest: Q-in-order
[846.491838] Starting dynamic subtest: rcs0
[846.662508] Dynamic subtest rcs0: SUCCESS (0.171s)
[846.684830] Starting dynamic subtest: vcs0
[846.778366] Dynamic subtest vcs0: SUCCESS (0.115s)
[846.794823] Starting dynamic subtest: vcs1
[846.899363] Dynamic subtest vcs1: SUCCESS (0.119s)
[846.911343] Starting dynamic subtest: vecs0
[847.011206] Dynamic subtest vecs0: SUCCESS (0.112s)
[847.027763] Starting dynamic subtest: ccs0
[847.136984] Dynamic subtest ccs0: SUCCESS (0.123s)
[847.140074] Subtest Q-in-order: SUCCESS (0.646s)
[848.728756] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_exec_schedule
results: parsing output: 2/ for test: kms_content_protection
results: parsing output: 3/ for test: kms_joiner
results: parsing output: 4/ for test: kms_flip_scaled_crc
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: gem_madvise
results: parsing output: 7/ for test: kms_lease
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: perf_pmu
results: parsing output: 11/ for test: gem_exec_reloc
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: kms_plane_scaling
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: gem_exec_reloc
results: parsing output: 16/ for test: kms_chamelium_color
results: parsing output: 17/ for test: fbdev
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: core_hotunplug
results: parsing output: 20/ for test: kms_rotation_crc
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: gem_exec_fence
results: parsing output: 23/ for test: gem_ctx_bad_destroy
results: parsing output: 24/ for test: gem_create
results: parsing output: 25/ for test: kms_plane
results: parsing output: 26/ for test: gem_exec_whisper
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: gen9_exec_parse
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_cursor_crc
results: parsing output: 32/ for test: gem_workarounds
results: parsing output: 33/ for test: gem_exec_params
results: parsing output: 34/ for test: gem_exec_balancer
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: syncobj_timeline
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_exec_params
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: kms_setmode
results: parsing output: 42/ for test: gen9_exec_parse
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: gem_partial_pwrite_pread
results: parsing output: 45/ for test: gem_mmap_gtt
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: gem_pread
results: parsing output: 50/ for test: kms_addfb_basic
results: parsing output: 51/ for test: kms_vblank
results: parsing output: 52/ for test: kms_psr2_sf
results: parsing output: 53/ for test: gem_workarounds
results: parsing output: 54/ for test: kms_psr2_sf
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: gem_ctx_persistence
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: syncobj_timeline
results: parsing output: 59/ for test: kms_rotation_crc
results: parsing output: 60/ for test: kms_async_flips
results: parsing output: 61/ for test: i915_pm_rpm
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: kms_cursor_legacy
results: parsing output: 64/ for test: gen3_render_linear_blits
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: sw_sync
results: parsing output: 67/ for test: kms_pm_rpm
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: prime_vgem
results: parsing output: 71/ for test: kms_cursor_legacy
results: parsing output: 72/ for test: perf_pmu
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: drm_read
results: parsing output: 75/ for test: gem_exec_reloc
results: parsing output: 76/ for test: kms_cursor_crc
results: parsing output: 77/ for test: gem_gpgpu_fill
results: parsing output: 78/ for test: prime_vgem
results: parsing output: 79/ for test: gem_ctx_param
results: parsing output: 80/ for test: gem_fence_thrash
results: parsing output: 81/ for test: kms_color
results: parsing output: 82/ for test: kms_plane_multiple
results: parsing output: 83/ for test: kms_draw_crc
results: parsing output: 84/ for test: gem_exec_suspend
results: parsing output: 85/ for test: i915_query
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_chamelium_hpd
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: prime_self_import
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: kms_flip
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: gem_exec_reloc
results: parsing output: 98/ for test: gem_softpin
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_pipe_crc_basic
results: parsing output: 102/ for test: kms_cursor_edge_walk
results: parsing output: 103/ for test: kms_cursor_legacy
results: parsing output: 104/ for test: gem_userptr_blits
results: parsing output: 105/ for test: gem_caching
results: parsing output: 106/ for test: syncobj_wait
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: kms_pm_rpm
results: parsing output: 109/ for test: api_intel_bb
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_plane_scaling
results: parsing output: 112/ for test: gem_exec_fence
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: gem_mmap_wc
results: parsing output: 115/ for test: gem_render_copy
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: gem_userptr_blits
results: parsing output: 119/ for test: kms_cursor_legacy
results: parsing output: 120/ for test: kms_sequence
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: api_intel_bb
results: parsing output: 123/ for test: kms_flip
results: parsing output: 124/ for test: kms_hdmi_inject
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_render_copy
results: parsing output: 127/ for test: gem_mmap_gtt
results: parsing output: 128/ for test: kms_getfb
results: parsing output: 129/ for test: gem_exec_schedule
results: parsing output: 130/ for test: i915_hangman
results: parsing output: 131/ for test: gem_exec_flush
results: parsing output: 132/ for test: gem_ctx_shared
Done.