[59.133903] Initializing watchdogs
[59.133951]   /dev/watchdog0
[59.148851] [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.153394] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.155563] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.158914] [001/131] (960s left) gem_ctx_persistence (heartbeat-hang)
[59.247909] Starting subtest: heartbeat-hang
[59.252340] Subtest heartbeat-hang: SKIP (0.000s)
[59.356610] [002/131] (960s left) syncobj_wait (wait-any-snapshot)
[59.415332] Starting subtest: wait-any-snapshot
[59.496993] Subtest wait-any-snapshot: SUCCESS (0.081s)
[59.568115] [003/131] (960s left) kms_cursor_crc (cursor-offscreen-128x42)
[59.788916] Starting subtest: cursor-offscreen-128x42
[59.849333] Subtest cursor-offscreen-128x42: SKIP (0.054s)
[60.050119] [004/131] (959s left) kms_joiner (basic-ultra-joiner)
[60.147682] Starting subtest: basic-ultra-joiner
[60.151239] Subtest basic-ultra-joiner: SKIP (0.000s)
[60.223010] [005/131] (959s left) i915_query (query-garbage)
[60.270147] Starting subtest: query-garbage
[60.272056] Subtest query-garbage: SUCCESS (0.000s)
[60.355220] [006/131] (959s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[60.439204] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[60.441185] Starting dynamic subtest: pipe-A
[60.459607] Dynamic subtest pipe-A: SKIP (0.018s)
[60.465954] Starting dynamic subtest: pipe-B
[60.495208] Dynamic subtest pipe-B: SKIP (0.035s)
[60.501995] Starting dynamic subtest: pipe-C
[60.529443] Dynamic subtest pipe-C: SKIP (0.032s)
[60.535998] Starting dynamic subtest: pipe-D
[60.561466] Dynamic subtest pipe-D: SKIP (0.032s)
[60.565199] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.119s)
[60.652333] [007/131] (959s left) vgem_basic (dmabuf-fence-before)
[60.717763] Starting subtest: dmabuf-fence-before
[60.719844] Subtest dmabuf-fence-before: SUCCESS (0.002s)
[60.770068] [FACT vgem_basic (dmabuf-fence-before)] new: kernel.kmod_is_loaded.vgem: true
[60.772659] [008/131] (959s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[60.874140] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[60.878183] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[60.995233] [009/131] (958s left) kms_pipe_stress (stress-xrgb8888-untiled)
[61.095499] Starting subtest: stress-xrgb8888-untiled
[67.034931] Subtest stress-xrgb8888-untiled: SUCCESS (5.923s)
[67.085053] [010/131] (952s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[67.342742] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[67.347526] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[67.546935] [011/131] (952s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[67.817393] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[67.821976] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[68.003984] [012/131] (952s left) kms_flip (wf_vblank-ts-check)
[68.149956] Starting subtest: wf_vblank-ts-check
[68.152417] Starting dynamic subtest: A-eDP1
[77.092202] Dynamic subtest A-eDP1: SUCCESS (8.933s)
[77.101812] Starting dynamic subtest: B-eDP1
[86.034434] Dynamic subtest B-eDP1: SUCCESS (8.935s)
[86.044590] Starting dynamic subtest: C-eDP1
[94.954241] Dynamic subtest C-eDP1: SUCCESS (8.915s)
[94.962252] Starting dynamic subtest: D-eDP1
[103.890551] Dynamic subtest D-eDP1: SUCCESS (8.932s)
[103.895439] Subtest wf_vblank-ts-check: SUCCESS (35.725s)
[105.116208] [013/131] (915s left) syncobj_wait (multi-wait-all-signaled)
[105.166662] Starting subtest: multi-wait-all-signaled
[105.168599] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[105.288955] [014/131] (914s left) gen9_exec_parse (bb-oversize)
[105.349230] Subtest bb-oversize: SKIP (0.000s)
[105.422818] [015/131] (914s left) gem_exec_create (basic)
[105.484514] Starting subtest: basic
[105.486936] Starting dynamic subtest: smem
[108.887901] Dynamic subtest smem: SUCCESS (3.400s)
[108.890598] Subtest basic: SUCCESS (3.401s)
[109.068683] [016/131] (911s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[109.180816] Starting subtest: pr-cursor-plane-move-continuous-sf
[109.185258] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[109.251218] [017/131] (911s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[109.339688] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[109.343740] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[109.455592] [018/131] (910s left) gem_gtt_cpu_tlb
[109.577168] [019/131] (910s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[109.684265] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[110.696634] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.012s)
[110.847964] [020/131] (909s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[110.943893] Starting subtest: primary-y-tiled-reflect-x-0
[111.003739] Subtest primary-y-tiled-reflect-x-0: SKIP (0.059s)
[111.104500] [021/131] (909s left) gem_ctx_persistence (engines-hostile-preempt)
[111.168461] Starting subtest: engines-hostile-preempt
[111.170884] Starting dynamic subtest: rcs0
[111.252602] Dynamic subtest rcs0: SUCCESS (0.084s)
[111.262567] Starting dynamic subtest: bcs0
[111.304658] Dynamic subtest bcs0: SUCCESS (0.051s)
[111.313755] Starting dynamic subtest: vcs0
[112.914457] Dynamic subtest vcs0: SUCCESS (1.607s)
[112.924938] Starting dynamic subtest: vcs1
[114.894911] Dynamic subtest vcs1: SUCCESS (1.979s)
[114.907670] Starting dynamic subtest: vecs0
[116.875859] Dynamic subtest vecs0: SUCCESS (1.979s)
[116.886279] Starting dynamic subtest: ccs0
[116.926834] Dynamic subtest ccs0: SUCCESS (0.052s)
[116.929534] Subtest engines-hostile-preempt: SUCCESS (5.758s)
[117.034603] [022/131] (903s left) gem_exec_params (invalid-fence-in)
[117.092499] Starting subtest: invalid-fence-in
[117.094783] Subtest invalid-fence-in: SUCCESS (0.000s)
[117.187287] [023/131] (903s left) i915_drm_fdinfo (memory-info-purgeable)
[117.224855] Starting subtest: memory-info-purgeable
[117.227344] Starting dynamic subtest: smem0
[119.819646] Dynamic subtest smem0: SUCCESS (2.594s)
[119.822275] Subtest memory-info-purgeable: SUCCESS (2.594s)
[119.891253] [024/131] (900s left) kms_properties (plane-properties-atomic)
[119.990186] Starting subtest: plane-properties-atomic
[119.991749] Starting dynamic subtest: pipe-A-eDP-1
[120.547439] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.555s)
[120.562102] Starting dynamic subtest: pipe-B-eDP-1
[121.799515] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.251s)
[121.807309] Starting dynamic subtest: pipe-C-eDP-1
[123.026584] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.225s)
[123.035459] Starting dynamic subtest: pipe-D-eDP-1
[124.264397] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.236s)
[124.266317] Subtest plane-properties-atomic: SUCCESS (4.272s)
[125.064084] [025/131] (895s left) gem_lmem_swapping (heavy-random)
[125.110510] Subtest heavy-random: SKIP (0.000s)
[125.148784] [026/131] (895s left) kms_psr (fbc-psr-cursor-render)
[125.238748] Starting subtest: fbc-psr-cursor-render
[125.240965] Starting dynamic subtest: eDP-1
[125.244953] Dynamic subtest eDP-1: SKIP (0.000s)
[125.248893] Subtest fbc-psr-cursor-render: SKIP (0.001s)
[125.306886] [027/131] (895s left) kms_content_protection (dp-mst-lic-type-0)
[125.444553] Starting subtest: dp-mst-lic-type-0
[125.448973] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[125.563319] [028/131] (895s left) core_setmaster (master-drop-set-user)
[125.657349] Starting subtest: master-drop-set-user
[125.671943] Subtest master-drop-set-user: SUCCESS (0.015s)
[125.709014] [029/131] (895s left) kms_hdr (bpc-switch-dpms)
[125.814565] Starting subtest: bpc-switch-dpms
[126.934274] Starting dynamic subtest: pipe-A-eDP-1
[131.440661] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.506s)
[131.443108] Subtest bpc-switch-dpms: SUCCESS (5.629s)
[131.551580] [030/131] (889s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[131.610980] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[131.711533] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.102s)
[131.787218] [031/131] (889s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[131.892413] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[132.660637] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.770s)
[132.844933] [032/131] (888s left) kms_lease (atomic-implicit-crtc)
[132.938016] Starting subtest: atomic-implicit-crtc
[132.940355] Starting dynamic subtest: pipe-A-eDP-1
[132.952025] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[132.960385] Starting dynamic subtest: pipe-B-eDP-1
[132.971936] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[132.980227] Starting dynamic subtest: pipe-C-eDP-1
[132.990687] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[132.998071] Starting dynamic subtest: pipe-D-eDP-1
[133.008541] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.009s)
[133.010409] Subtest atomic-implicit-crtc: SUCCESS (0.033s)
[133.062861] [033/131] (887s left) api_intel_bb (render-ccs)
[133.121456] Starting subtest: render-ccs
[133.467904] Subtest render-ccs: SUCCESS (0.348s)
[133.548297] [034/131] (887s left) perf_pmu (busy-check-all)
[133.593122] Starting subtest: busy-check-all
[133.595260] Starting dynamic subtest: rcs0
[134.155935] Dynamic subtest rcs0: SUCCESS (0.564s)
[134.165550] Starting dynamic subtest: bcs0
[134.707545] Dynamic subtest bcs0: SUCCESS (0.550s)
[134.722584] Starting dynamic subtest: vcs0
[135.893814] Dynamic subtest vcs0: SUCCESS (1.182s)
[135.905091] Starting dynamic subtest: vcs1
[137.877385] Dynamic subtest vcs1: SUCCESS (1.981s)
[137.888593] Starting dynamic subtest: vecs0
[139.925548] Dynamic subtest vecs0: SUCCESS (2.045s)
[139.936730] Starting dynamic subtest: ccs0
[140.480253] Dynamic subtest ccs0: SUCCESS (0.554s)
[140.482967] Subtest busy-check-all: SUCCESS (6.889s)
[140.610656] [035/131] (880s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[140.704381] Starting subtest: 4-tiled-64bpp-rotate-180
[142.216507] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.512s)
[142.359772] [036/131] (878s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[142.409871] Starting subtest: framebuffer-vs-set-tiling
[142.414147] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[142.544023] [037/131] (878s left) i915_query (query-regions-unallocated)
[142.596046] Starting subtest: query-regions-unallocated
[142.597873] Subtest query-regions-unallocated: SUCCESS (0.000s)
[142.696984] [038/131] (878s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[142.793479] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[142.797075] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[142.877181] [039/131] (878s left) kms_color (invalid-degamma-lut-sizes)
[142.983970] Starting subtest: invalid-degamma-lut-sizes
[142.985777] Starting dynamic subtest: pipe-A
[143.275483] Dynamic subtest pipe-A: SUCCESS (0.291s)
[143.286627] Starting dynamic subtest: pipe-B
[143.289091] Dynamic subtest pipe-B: SUCCESS (0.000s)
[143.297146] Starting dynamic subtest: pipe-C
[143.299447] Dynamic subtest pipe-C: SUCCESS (0.000s)
[143.307123] Starting dynamic subtest: pipe-D
[143.309293] Dynamic subtest pipe-D: SUCCESS (0.000s)
[143.311472] Subtest invalid-degamma-lut-sizes: SUCCESS (0.293s)
[144.132467] [040/131] (877s left) kms_psr (psr2-cursor-plane-onoff)
[144.241356] Starting subtest: psr2-cursor-plane-onoff
[144.243631] Starting dynamic subtest: eDP-1
[145.917072] Dynamic subtest eDP-1: SUCCESS (1.675s)
[145.919304] Subtest psr2-cursor-plane-onoff: SUCCESS (1.676s)
[146.729520] [041/131] (874s left) kms_psr (psr-sprite-blt)
[146.827779] Starting subtest: psr-sprite-blt
[146.830114] Starting dynamic subtest: eDP-1
[148.552406] Dynamic subtest eDP-1: SUCCESS (1.724s)
[148.554633] Subtest psr-sprite-blt: SUCCESS (1.725s)
[149.383167] [042/131] (871s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[149.486949] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[149.491414] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[149.597411] [043/131] (871s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[149.692178] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[149.694402] Starting dynamic subtest: pipe-A-eDP-1
[149.717072] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[149.726078] Starting dynamic subtest: pipe-B-eDP-1
[149.748137] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[149.755695] Starting dynamic subtest: pipe-C-eDP-1
[149.777070] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[149.784538] Starting dynamic subtest: pipe-D-eDP-1
[149.806095] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[149.810430] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[151.961250] [044/131] (869s left) drm_read (invalid-buffer)
[152.110806] Starting subtest: invalid-buffer
[152.113213] Subtest invalid-buffer: SUCCESS (0.000s)
[152.225858] [045/131] (869s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[152.272955] Starting subtest: wait-all-for-submit-delayed-submit
[152.377285] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.104s)
[152.467436] [046/131] (869s left) gem_exec_balancer (parallel-keep-submit-fence)
[152.736409] Starting subtest: parallel-keep-submit-fence
[153.867942] Subtest parallel-keep-submit-fence: SUCCESS (1.131s)
[153.951142] [047/131] (867s left) kms_cdclk (plane-scaling)
[154.044309] Starting subtest: plane-scaling
[154.046588] Starting dynamic subtest: pipe-A-eDP-1
[154.343713] Dynamic subtest pipe-A-eDP-1: SKIP (0.297s)
[154.352706] Starting dynamic subtest: pipe-B-eDP-1
[154.357282] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[154.365068] Starting dynamic subtest: pipe-C-eDP-1
[154.369660] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[154.377194] Starting dynamic subtest: pipe-D-eDP-1
[154.381191] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[154.385222] Subtest plane-scaling: SKIP (0.304s)
[155.184370] [048/131] (866s left) kms_cursor_crc (cursor-sliding-64x21)
[155.379074] Starting subtest: cursor-sliding-64x21
[155.420932] Subtest cursor-sliding-64x21: SKIP (0.039s)
[155.634981] [049/131] (866s left) gem_mmap_wc (coherency)
[155.690312] Subtest coherency: SKIP (0.000s)
[155.745124] [050/131] (865s left) kms_psr (fbc-pr-cursor-render)
[155.834917] Starting subtest: fbc-pr-cursor-render
[155.839289] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[155.910248] [051/131] (865s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[156.010936] Starting subtest: fbcpsr-modesetfrombusy
[162.261188] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.255s)
[162.389725] [052/131] (859s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[162.489605] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[162.491442] Starting dynamic subtest: pipe-A-eDP-1
[162.548496] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.060s)
[162.556510] Starting dynamic subtest: pipe-B-eDP-1
[162.608195] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.058s)
[162.616224] Starting dynamic subtest: pipe-C-eDP-1
[162.667954] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.059s)
[162.676079] Starting dynamic subtest: pipe-D-eDP-1
[162.727243] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.058s)
[162.729072] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.240s)
[165.013820] [053/131] (856s left) kms_addfb_basic (basic)
[165.073667] Starting subtest: basic
[165.076227] Subtest basic: SUCCESS (0.000s)
[165.194620] [054/131] (856s left) syncobj_wait (wait-for-submit-snapshot)
[165.250243] Starting subtest: wait-for-submit-snapshot
[165.330240] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[165.417776] [055/131] (856s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[165.509272] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[165.513497] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[165.591897] [056/131] (856s left) gem_exec_schedule (u-semaphore-resolve)
[165.673082] Starting subtest: u-semaphore-resolve
[165.707812] Subtest u-semaphore-resolve: SUCCESS (0.042s)
[166.031997] [057/131] (855s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt)
[166.124275] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt
[166.128329] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[166.218796] [058/131] (855s left) gem_eio (suspend)
[166.443064] Starting subtest: suspend
[178.721773] Subtest suspend: SUCCESS (12.277s)
[178.882961] [059/131] (843s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[178.993203] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[178.997756] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[179.078184] [060/131] (843s left) gem_spin_batch (spin-all-new)
[179.138419] Starting subtest: spin-all-new
[179.153537] Subtest spin-all-new: SUCCESS (0.015s)
[180.946821] [061/131] (841s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[181.052884] Starting subtest: psr-rgb101010-draw-mmap-gtt
[181.057221] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[181.143622] [062/131] (841s left) gem_watchdog (default-physical)
[181.220715] Starting subtest: default-physical
[182.978380] Subtest default-physical: SUCCESS (1.768s)
[183.072404] [063/131] (839s left) gem_render_copy (y-tiled-ccs-to-linear)
[183.146758] Starting subtest: y-tiled-ccs-to-linear
[183.151275] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[183.331006] [064/131] (838s left) kms_flip (absolute-wf_vblank-interruptible)
[183.431294] Starting subtest: absolute-wf_vblank-interruptible
[183.433473] Starting dynamic subtest: A-eDP1
[192.147119] Dynamic subtest A-eDP1: SUCCESS (8.714s)
[192.160172] Starting dynamic subtest: B-eDP1
[200.865737] Dynamic subtest B-eDP1: SUCCESS (8.715s)
[200.879322] Starting dynamic subtest: C-eDP1
[209.586779] Dynamic subtest C-eDP1: SUCCESS (8.719s)
[209.598817] Starting dynamic subtest: D-eDP1
[218.311960] Dynamic subtest D-eDP1: SUCCESS (8.722s)
[218.317634] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.884s)
[219.530753] [065/131] (802s left) gem_exec_schedule (preempt-hang)
[219.695200] Starting subtest: preempt-hang
[219.697852] Starting dynamic subtest: rcs0
[219.919786] Dynamic subtest rcs0: SUCCESS (0.224s)
[219.931374] Starting dynamic subtest: bcs0
[220.138200] Dynamic subtest bcs0: SUCCESS (0.218s)
[220.147930] Starting dynamic subtest: vcs0
[220.349358] Dynamic subtest vcs0: SUCCESS (0.210s)
[220.358516] Starting dynamic subtest: vcs1
[220.557980] Dynamic subtest vcs1: SUCCESS (0.208s)
[220.568523] Starting dynamic subtest: vecs0
[220.772078] Dynamic subtest vecs0: SUCCESS (0.213s)
[220.783201] Starting dynamic subtest: ccs0
[221.000446] Dynamic subtest ccs0: SUCCESS (0.227s)
[221.002453] Subtest preempt-hang: SUCCESS (1.305s)
[222.004245] [066/131] (800s left) kms_psr (pr-sprite-mmap-gtt)
[222.106204] Starting subtest: pr-sprite-mmap-gtt
[222.110597] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[222.178697] [067/131] (800s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[222.276617] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[222.280973] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[222.371578] [068/131] (800s left) gem_busy (extended)
[222.550922] Starting subtest: extended
[222.553810] Starting dynamic subtest: rcs0
[222.627090] Dynamic subtest rcs0: SUCCESS (0.076s)
[222.639029] Starting dynamic subtest: bcs0
[222.668749] Dynamic subtest bcs0: SUCCESS (0.040s)
[222.679109] Starting dynamic subtest: vcs0
[223.893327] Dynamic subtest vcs0: SUCCESS (1.221s)
[223.904997] Starting dynamic subtest: vcs1
[225.941189] Dynamic subtest vcs1: SUCCESS (2.044s)
[225.956713] Starting dynamic subtest: vecs0
[227.925454] Dynamic subtest vecs0: SUCCESS (1.981s)
[227.938149] Starting dynamic subtest: ccs0
[227.970219] Dynamic subtest ccs0: SUCCESS (0.043s)
[227.973035] Subtest extended: SUCCESS (5.421s)
[228.209351] [069/131] (794s left) api_intel_bb (blit-noreloc-purge-cache)
[228.257432] Starting subtest: blit-noreloc-purge-cache
[228.267979] Subtest blit-noreloc-purge-cache: SUCCESS (0.013s)
[228.406803] [070/131] (794s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[228.516314] Starting subtest: cursorB-vs-flipB-toggle
[228.520893] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[228.659937] [071/131] (793s left) prime_busy (hang-wait)
[228.728840] Starting subtest: hang-wait
[228.731233] Starting dynamic subtest: rcs0
[255.347354] Dynamic subtest rcs0: SUCCESS (26.616s)
[255.355953] Starting dynamic subtest: bcs0
[262.503955] Dynamic subtest bcs0: SUCCESS (7.151s)
[262.512693] Starting dynamic subtest: vcs0
[269.539685] Dynamic subtest vcs0: SUCCESS (7.032s)
[269.550700] Starting dynamic subtest: vcs1
[276.515818] Dynamic subtest vcs1: SUCCESS (6.973s)
[276.529632] Starting dynamic subtest: vecs0
[283.488268] Dynamic subtest vecs0: SUCCESS (6.970s)
[283.498190] Starting dynamic subtest: ccs0
[297.394978] Dynamic subtest ccs0: SUCCESS (13.904s)
[297.397722] Subtest hang-wait: SUCCESS (68.660s)
[297.518228] [072/131] (725s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[297.616050] Starting subtest: y-tiled-64bpp-rotate-180
[297.620581] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[297.710671] [073/131] (724s left) gem_mmap_offset (bad-object)
[297.772278] Starting subtest: bad-object
[297.774549] Subtest bad-object: SUCCESS (0.001s)
[297.858165] [074/131] (724s left) kms_atomic_interruptible (legacy-dpms)
[297.946836] Starting subtest: legacy-dpms
[297.949109] Starting dynamic subtest: pipe-A-eDP-1
[305.359395] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.411s)
[305.362058] Subtest legacy-dpms: SUCCESS (7.413s)
[306.183421] [075/131] (716s left) kms_cursor_crc (cursor-random-max-size)
[306.506088] Starting subtest: cursor-random-max-size
[306.512121] Subtest cursor-random-max-size: SKIP (0.000s)
[306.639072] [076/131] (716s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[306.740358] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[306.742619] Starting dynamic subtest: pipe-A-eDP-1
[306.764193] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[306.775437] Starting dynamic subtest: pipe-B-eDP-1
[306.796330] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[306.807039] Starting dynamic subtest: pipe-C-eDP-1
[306.828265] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[306.836371] Starting dynamic subtest: pipe-D-eDP-1
[306.858137] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[306.862398] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[309.024110] [077/131] (713s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[309.110412] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[309.114496] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[309.209268] [078/131] (713s left) kms_selftest (drm_format_helper)
[309.251832] Starting subtest: drm_format_helper
[309.306656] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[309.410904] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.105s)
[309.421465] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[309.504261] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.091s)
[309.514140] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[309.586533] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.082s)
[309.596536] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[309.689176] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.102s)
[309.699175] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[309.781899] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.092s)
[309.792406] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[309.873151] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.090s)
[309.883403] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[309.959084] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.085s)
[309.968918] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[310.046024] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.087s)
[310.055992] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[310.138616] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.092s)
[310.148950] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[310.233305] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.094s)
[310.241851] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[310.324097] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.090s)
[310.334596] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[310.412988] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.088s)
[310.421488] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[310.512260] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.096s)
[310.520522] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[310.610258] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.095s)
[310.619195] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[310.706203] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.095s)
[310.715643] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[310.791517] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.084s)
[310.800468] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[310.887408] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.096s)
[310.888989] Subtest drm_format_helper: SUCCESS (1.637s)
[311.032134] [079/131] (711s left) gem_exec_fence (syncobj-signal)
[311.453103] Starting subtest: syncobj-signal
[311.455648] Subtest syncobj-signal: SUCCESS (0.005s)
[312.991184] [080/131] (709s left) kms_flip (flip-vs-wf_vblank-interruptible)
[313.091116] Starting subtest: flip-vs-wf_vblank-interruptible
[313.093472] Starting dynamic subtest: A-eDP1
[314.972364] Dynamic subtest A-eDP1: SUCCESS (1.880s)
[314.983133] Starting dynamic subtest: B-eDP1
[316.899168] Dynamic subtest B-eDP1: SUCCESS (1.925s)
[316.909171] Starting dynamic subtest: C-eDP1
[318.824351] Dynamic subtest C-eDP1: SUCCESS (1.923s)
[318.834408] Starting dynamic subtest: D-eDP1
[320.669735] Dynamic subtest D-eDP1: SUCCESS (1.844s)
[320.674904] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.584s)
[321.896186] [081/131] (701s left) gem_exec_reloc (basic-gtt-noreloc)
[321.967296] Subtest basic-gtt-noreloc: SKIP (0.000s)
[322.028912] [082/131] (701s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[322.084407] Starting subtest: etime-multi-wait-for-submit-submitted
[322.193714] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.108s)
[322.269311] [083/131] (700s left) gem_pipe_control_store_loop (reused-buffer)
[322.316245] Starting subtest: reused-buffer
[324.470709] Subtest reused-buffer: SUCCESS (2.153s)
[324.582694] [084/131] (698s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[324.632342] Starting subtest: multi-wait-for-submit-available-submitted
[324.634758] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[324.722073] [085/131] (698s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[324.817406] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[324.821456] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[324.915089] [086/131] (698s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[325.013433] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[325.015739] Starting dynamic subtest: pipe-A-eDP-1
[325.036473] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[325.048066] Starting dynamic subtest: pipe-B-eDP-1
[325.067661] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[325.077117] Starting dynamic subtest: pipe-C-eDP-1
[325.096366] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[325.105633] Starting dynamic subtest: pipe-D-eDP-1
[325.125063] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[325.127197] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[327.250379] [087/131] (695s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[327.345511] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[327.349659] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[327.454195] [088/131] (695s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[327.560640] Starting subtest: 4-tiled-16bpp-rotate-180
[328.918772] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.357s)
[329.056064] [089/131] (694s left) kms_addfb_basic (too-wide)
[329.144375] Starting subtest: too-wide
[329.146132] Subtest too-wide: SUCCESS (0.000s)
[329.244783] [090/131] (694s left) i915_drm_fdinfo (virtual-idle)
[329.286372] Starting subtest: virtual-idle
[332.345387] Subtest virtual-idle: SUCCESS (3.058s)
[332.421588] [091/131] (690s left) gem_userptr_blits (stress-mm)
[332.513722] Starting subtest: stress-mm
[337.884571] Subtest stress-mm: SUCCESS (5.369s)
[338.005412] [092/131] (685s left) kms_properties (invalid-properties-atomic)
[338.098122] Starting subtest: invalid-properties-atomic
[338.407989] Subtest invalid-properties-atomic: SUCCESS (0.308s)
[338.479865] [093/131] (685s left) vgem_basic (bad-flag)
[338.524125] Starting subtest: bad-flag
[338.526306] Subtest bad-flag: SUCCESS (0.000s)
[338.579297] [094/131] (684s left) kms_pm_backlight (brightness-with-dpms)
[338.673075] Starting subtest: brightness-with-dpms
[338.721810] Starting dynamic subtest: eDP-1
[341.143070] Dynamic subtest eDP-1: SUCCESS (2.418s)
[341.145288] Subtest brightness-with-dpms: SUCCESS (2.470s)
[342.022067] [095/131] (681s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[342.125607] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[342.129832] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[342.235810] [096/131] (681s left) i915_pm_rpm (system-suspend-devices)
[344.063761] Starting subtest: system-suspend-devices
[351.739049] Subtest system-suspend-devices: SUCCESS (7.678s)
[352.130397] [097/131] (671s left) kms_cursor_legacy (single-bo)
[352.254325] Starting subtest: single-bo
[352.256201] Starting dynamic subtest: pipe-A
[357.637333] Dynamic subtest pipe-A: SUCCESS (5.380s)
[357.649512] Starting dynamic subtest: pipe-B
[363.020239] Dynamic subtest pipe-B: SUCCESS (5.380s)
[363.032230] Starting dynamic subtest: pipe-C
[368.403720] Dynamic subtest pipe-C: SUCCESS (5.379s)
[368.415347] Starting dynamic subtest: pipe-D
[373.784959] Dynamic subtest pipe-D: SUCCESS (5.379s)
[373.796398] Starting dynamic subtest: all-pipes
[379.175927] Dynamic subtest all-pipes: SUCCESS (5.388s)
[379.178443] Subtest single-bo: SUCCESS (26.919s)
[379.321022] [098/131] (644s left) syncobj_wait (multi-wait-submitted-signaled)
[379.385895] Starting subtest: multi-wait-submitted-signaled
[379.388232] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[379.485572] [099/131] (644s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[379.608134] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[379.612613] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[379.689370] [100/131] (644s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[379.766052] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[379.768435] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[379.880461] [101/131] (644s left) kms_flip (2x-flip-vs-panning-interruptible)
[379.985105] Starting subtest: 2x-flip-vs-panning-interruptible
[379.995824] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[380.074359] [102/131] (643s left) perf_pmu (init-busy)
[380.111683] Starting subtest: init-busy
[380.114070] Starting dynamic subtest: rcs0
[380.116486] Dynamic subtest rcs0: SUCCESS (0.001s)
[380.127298] Starting dynamic subtest: bcs0
[380.129110] Dynamic subtest bcs0: SUCCESS (0.000s)
[380.137199] Starting dynamic subtest: vcs0
[380.138996] Dynamic subtest vcs0: SUCCESS (0.001s)
[380.147035] Starting dynamic subtest: vcs1
[380.148880] Dynamic subtest vcs1: SUCCESS (0.001s)
[380.157477] Starting dynamic subtest: vecs0
[380.159634] Dynamic subtest vecs0: SUCCESS (0.001s)
[380.168282] Starting dynamic subtest: ccs0
[380.170132] Dynamic subtest ccs0: SUCCESS (0.001s)
[380.171934] Subtest init-busy: SUCCESS (0.007s)
[380.210104] [103/131] (643s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[380.257712] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[380.261365] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[380.445745] [104/131] (643s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[380.534130] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[380.538739] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[380.611278] [105/131] (643s left) syncobj_wait (invalid-reset-illegal-handle)
[380.654752] Starting subtest: invalid-reset-illegal-handle
[380.657070] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[380.760210] [106/131] (643s left) gem_exec_balancer (parallel-balancer)
[381.024946] Starting subtest: parallel-balancer
[381.894807] Subtest parallel-balancer: SUCCESS (0.872s)
[382.011861] [107/131] (642s left) kms_chamelium_frames (vga-frame-dump)
[382.407363] Subtest vga-frame-dump: SKIP (0.000s)
[383.225831] [108/131] (640s left) kms_dsc (dsc-with-output-formats)
[383.321102] Starting subtest: dsc-with-output-formats
[383.343041] Subtest dsc-with-output-formats: SKIP (0.001s)
[383.400414] [109/131] (640s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[383.491093] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[383.516631] Starting dynamic subtest: pipe-A-plane-0
[383.805212] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[383.815268] Starting dynamic subtest: pipe-A-plane-3
[384.038960] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[385.122810] Starting dynamic subtest: pipe-B-plane-0
[385.415061] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[385.425397] Starting dynamic subtest: pipe-B-plane-3
[385.648327] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[385.958298] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.469s)
[386.795836] [110/131] (637s left) kms_chamelium_color (degamma)
[386.895558] Subtest degamma: SKIP (0.000s)
[386.983475] [111/131] (637s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[387.084644] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[387.089183] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[387.184920] [112/131] (637s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[387.248269] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[387.306255] [113/131] (637s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[387.406704] Starting subtest: fbcpsr-tiling-linear
[393.968291] Subtest fbcpsr-tiling-linear: SUCCESS (6.566s)
[394.106473] [114/131] (630s left) kms_psr (fbc-pr-primary-render)
[394.200347] Starting subtest: fbc-pr-primary-render
[394.204791] Subtest fbc-pr-primary-render: SKIP (0.000s)
[394.302559] [115/131] (630s left) gem_eio (kms)
[394.552489] Starting subtest: kms
[414.490804] Subtest kms: SUCCESS (19.937s)
[414.592936] [116/131] (609s left) gem_exec_schedule (u-submit-late-slice)
[414.668455] Starting subtest: u-submit-late-slice
[414.670432] Starting dynamic subtest: rcs0
[414.703130] Dynamic subtest rcs0: SUCCESS (0.043s)
[414.712618] Starting dynamic subtest: bcs0
[414.740848] Dynamic subtest bcs0: SUCCESS (0.035s)
[414.756222] Starting dynamic subtest: vcs0
[414.783652] Dynamic subtest vcs0: SUCCESS (0.041s)
[414.793172] Starting dynamic subtest: vcs1
[414.813388] Dynamic subtest vcs1: SUCCESS (0.029s)
[414.825486] Starting dynamic subtest: vecs0
[414.850435] Dynamic subtest vecs0: SUCCESS (0.036s)
[414.859885] Starting dynamic subtest: ccs0
[414.893642] Dynamic subtest ccs0: SUCCESS (0.042s)
[414.896170] Subtest u-submit-late-slice: SUCCESS (0.234s)
[415.983740] [117/131] (608s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[416.087538] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[422.702290] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.617s)
[422.841506] [118/131] (601s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[422.891045] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[422.895712] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[423.074417] [119/131] (601s left) gem_exec_fence (basic-wait-all)
[423.144244] Starting subtest: basic-wait-all
[423.236296] Subtest basic-wait-all: SUCCESS (0.093s)
[424.975533] [120/131] (599s left) gem_exec_parallel (engines)
[425.053059] Starting subtest: engines
[425.055279] Starting dynamic subtest: basic
[426.922467] Dynamic subtest basic: SUCCESS (1.870s)
[426.931745] Starting dynamic subtest: contexts
[431.338577] Dynamic subtest contexts: SUCCESS (4.415s)
[431.347928] Starting dynamic subtest: fds
[435.240512] Dynamic subtest fds: SUCCESS (3.899s)
[435.253188] Starting dynamic subtest: userptr
[436.913018] Dynamic subtest userptr: SUCCESS (1.671s)
[436.915392] Subtest engines: SUCCESS (11.862s)
[437.108162] [121/131] (587s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[437.211432] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[438.334303] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.122s)
[438.480311] [122/131] (586s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[438.583397] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[438.587199] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[438.675248] [123/131] (586s left) gem_create (create-ext-placement-sanity-check)
[438.835881] Starting subtest: create-ext-placement-sanity-check
[438.838401] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[438.936434] [124/131] (585s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[439.031780] Starting subtest: fbc-1p-pri-indfb-multidraw
[451.866593] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (12.838s)
[453.282041] [125/131] (571s left) kms_async_flips (crc)
[453.380817] Starting subtest: crc
[453.769968] Starting dynamic subtest: pipe-A-eDP-1
[456.700562] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.929s)
[457.088682] Starting dynamic subtest: pipe-B-eDP-1
[460.031130] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.950s)
[460.405768] Starting dynamic subtest: pipe-C-eDP-1
[463.251713] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.854s)
[463.612459] Starting dynamic subtest: pipe-D-eDP-1
[466.465980] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.860s)
[466.468367] Subtest crc: SUCCESS (13.085s)
[467.648439] [126/131] (557s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[467.737272] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[467.741866] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[468.889063] [127/131] (556s left) gem_pxp (create-protected-buffer)
[469.015245] Starting subtest: create-protected-buffer
[469.017911] Subtest create-protected-buffer: SUCCESS (0.000s)
[469.133818] [128/131] (555s left) i915_query (query-topology-matches-eu-total)
[469.191531] Starting subtest: query-topology-matches-eu-total
[469.193801] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[469.307417] [129/131] (555s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[469.409559] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[476.100047] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.692s)
[476.224955] [130/131] (548s left) kms_vblank (wait-forked-busy-hang)
[476.318611] Starting subtest: wait-forked-busy-hang
[476.320553] Starting dynamic subtest: pipe-A-eDP-1
[502.674276] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.353s)
[502.688888] Starting dynamic subtest: pipe-D-eDP-1
[527.652640] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.974s)
[527.654935] Subtest wait-forked-busy-hang: SUCCESS (51.332s)
[528.461901] [131/131] (496s left) kms_rotation_crc (primary-rotation-270)
[528.566260] Starting subtest: primary-rotation-270
[528.570852] Subtest primary-rotation-270: SKIP (0.001s)
[528.658796] Closing watchdogs
results: parsing output: 0/ for test: gem_ctx_persistence
results: parsing output: 1/ for test: syncobj_wait
results: parsing output: 2/ for test: kms_cursor_crc
results: parsing output: 3/ for test: kms_joiner
results: parsing output: 4/ for test: i915_query
results: parsing output: 5/ for test: kms_plane_scaling
results: parsing output: 6/ for test: vgem_basic
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_pipe_stress
results: parsing output: 9/ for test: kms_plane
results: parsing output: 10/ for test: kms_flip_scaled_crc
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: gen9_exec_parse
results: parsing output: 14/ for test: gem_exec_create
results: parsing output: 15/ for test: kms_psr2_sf
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_gtt_cpu_tlb
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_rotation_crc
results: parsing output: 20/ for test: gem_ctx_persistence
results: parsing output: 21/ for test: gem_exec_params
results: parsing output: 22/ for test: i915_drm_fdinfo
results: parsing output: 23/ for test: kms_properties
results: parsing output: 24/ for test: gem_lmem_swapping
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: kms_content_protection
results: parsing output: 27/ for test: core_setmaster
results: parsing output: 28/ for test: kms_hdr
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_lease
results: parsing output: 32/ for test: api_intel_bb
results: parsing output: 33/ for test: perf_pmu
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_addfb_basic
results: parsing output: 36/ for test: i915_query
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_color
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: drm_read
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: gem_exec_balancer
results: parsing output: 46/ for test: kms_cdclk
results: parsing output: 47/ for test: kms_cursor_crc
results: parsing output: 48/ for test: gem_mmap_wc
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: kms_addfb_basic
results: parsing output: 53/ for test: syncobj_wait
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: gem_exec_schedule
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_eio
results: parsing output: 58/ for test: kms_flip_scaled_crc
results: parsing output: 59/ for test: gem_spin_batch
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_watchdog
results: parsing output: 62/ for test: gem_render_copy
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: gem_exec_schedule
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_busy
results: parsing output: 68/ for test: api_intel_bb
results: parsing output: 69/ for test: kms_cursor_legacy
results: parsing output: 70/ for test: prime_busy
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: gem_mmap_offset
results: parsing output: 73/ for test: kms_atomic_interruptible
results: parsing output: 74/ for test: kms_cursor_crc
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_selftest
results: parsing output: 78/ for test: gem_exec_fence
results: parsing output: 79/ for test: kms_flip
results: parsing output: 80/ for test: gem_exec_reloc
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: gem_pipe_control_store_loop
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: kms_addfb_basic
results: parsing output: 89/ for test: i915_drm_fdinfo
results: parsing output: 90/ for test: gem_userptr_blits
results: parsing output: 91/ for test: kms_properties
results: parsing output: 92/ for test: vgem_basic
results: parsing output: 93/ for test: kms_pm_backlight
results: parsing output: 94/ for test: kms_flip_scaled_crc
results: parsing output: 95/ for test: i915_pm_rpm
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: syncobj_wait
results: parsing output: 98/ for test: kms_psr2_sf
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: kms_flip
results: parsing output: 101/ for test: perf_pmu
results: parsing output: 102/ for test: gem_render_copy
results: parsing output: 103/ for test: kms_plane
results: parsing output: 104/ for test: syncobj_wait
results: parsing output: 105/ for test: gem_exec_balancer
results: parsing output: 106/ for test: kms_chamelium_frames
results: parsing output: 107/ for test: kms_dsc
results: parsing output: 108/ for test: kms_plane
results: parsing output: 109/ for test: kms_chamelium_color
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_mmap_gtt
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: gem_eio
results: parsing output: 115/ for test: gem_exec_schedule
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: gem_render_copy
results: parsing output: 118/ for test: gem_exec_fence
results: parsing output: 119/ for test: gem_exec_parallel
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_create
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_async_flips
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: gem_pxp
results: parsing output: 127/ for test: i915_query
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_vblank
results: parsing output: 130/ for test: kms_rotation_crc
Done.