[55.448508] Initializing watchdogs
[55.448551]   /dev/watchdog0
[55.455708] [001/130] (960s left) kms_chamelium_color (gamma)
[55.608917] Subtest gamma: SKIP (0.000s)
[55.629845] [002/130] (960s left) kms_cursor_crc (cursor-random-64x21)
[55.796606] Starting subtest: cursor-random-64x21
[55.836796] Subtest cursor-random-64x21: SKIP (0.035s)
[56.022360] [003/130] (959s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[56.122572] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[56.125821] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[56.202233] [004/130] (959s left) syncobj_basic (bad-fd-to-handle)
[56.255213] Starting subtest: bad-fd-to-handle
[56.256862] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[56.331493] [005/130] (959s left) gem_userptr_blits (set-cache-level)
[56.387475] Starting subtest: set-cache-level
[56.390946] Subtest set-cache-level: SKIP (0.000s)
[56.495790] [006/130] (959s left) gem_exec_balancer (waits)
[56.554526] Starting subtest: waits
[62.810202] Subtest waits: SUCCESS (6.319s)
[63.071833] [007/130] (952s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[63.183227] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[63.187627] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[63.264595] [008/130] (952s left) api_intel_bb (blit-noreloc-purge-cache)
[63.326820] Starting subtest: blit-noreloc-purge-cache
[63.334884] Subtest blit-noreloc-purge-cache: SUCCESS (0.009s)
[63.404200] [009/130] (952s left) gem_exec_schedule (preempt-self)
[63.475158] Starting subtest: preempt-self
[63.477232] Starting dynamic subtest: rcs0
[63.490666] Dynamic subtest rcs0: SUCCESS (0.022s)
[63.497290] Starting dynamic subtest: bcs0
[63.506678] Dynamic subtest bcs0: SUCCESS (0.016s)
[63.513850] Starting dynamic subtest: vcs0
[63.521491] Dynamic subtest vcs0: SUCCESS (0.015s)
[63.527488] Starting dynamic subtest: vcs1
[63.540637] Dynamic subtest vcs1: SUCCESS (0.019s)
[63.547180] Starting dynamic subtest: vecs0
[63.555261] Dynamic subtest vecs0: SUCCESS (0.015s)
[63.561729] Starting dynamic subtest: ccs0
[63.569740] Dynamic subtest ccs0: SUCCESS (0.014s)
[63.571991] Subtest preempt-self: SUCCESS (0.102s)
[65.015616] [010/130] (950s left) kms_addfb_basic (invalid-set-prop)
[65.072031] Starting subtest: invalid-set-prop
[65.074343] Subtest invalid-set-prop: SUCCESS (0.000s)
[65.207057] [011/130] (950s left) kms_psr (psr-cursor-plane-move)
[65.306889] Starting subtest: psr-cursor-plane-move
[65.309196] Starting dynamic subtest: eDP-1
[66.995691] Dynamic subtest eDP-1: SUCCESS (1.694s)
[66.997987] Subtest psr-cursor-plane-move: SUCCESS (1.695s)
[67.840085] [012/130] (948s left) perf_pmu (module-unload)
[67.938450] Starting subtest: module-unload
[113.981909] Subtest module-unload: SUCCESS (46.060s)
[113.997112] [013/130] (902s left) kms_draw_crc (draw-method-mmap-gtt)
[115.523766] Starting subtest: draw-method-mmap-gtt
[115.528256] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[115.606142] [014/130] (900s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[115.732485] Starting subtest: short-flip-after-cursor-atomic-transitions
[116.717352] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.986s)
[117.543605] [015/130] (898s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[117.637563] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[121.041218] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (3.408s)
[121.159253] [016/130] (894s left) gem_exec_reloc (basic-write-read-active)
[121.227090] Subtest basic-write-read-active: SKIP (0.000s)
[121.297260] [017/130] (894s left) gem_exec_reloc (basic-wc-gtt)
[121.366216] Subtest basic-wc-gtt: SKIP (0.000s)
[121.417729] [018/130] (894s left) kms_lease (lease-invalid-connector)
[121.505493] Starting subtest: lease-invalid-connector
[121.507575] Starting dynamic subtest: pipe-A-eDP-1
[121.509655] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[121.517756] Starting dynamic subtest: pipe-B-eDP-1
[121.519660] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[121.525997] Starting dynamic subtest: pipe-C-eDP-1
[121.527658] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[121.534141] Starting dynamic subtest: pipe-D-eDP-1
[121.535921] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[121.537899] Subtest lease-invalid-connector: SUCCESS (0.002s)
[121.556965] [019/130] (894s left) kms_setmode (basic-clone-single-crtc)
[121.603976] Starting subtest: basic-clone-single-crtc
[121.609037] Subtest basic-clone-single-crtc: SKIP (0.000s)
[121.687149] [020/130] (894s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[121.787946] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[121.791749] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[121.864361] [021/130] (894s left) gem_tiled_partial_pwrite_pread (writes)
[121.926799] Subtest writes: SKIP (0.000s)
[121.976089] [022/130] (894s left) i915_pm_rpm (debugfs-forcewake-user)
[124.104322] Starting subtest: debugfs-forcewake-user
[135.487779] Subtest debugfs-forcewake-user: SUCCESS (11.383s)
[135.820234] [023/130] (880s left) kms_psr (pr-primary-mmap-cpu)
[135.920091] Starting subtest: pr-primary-mmap-cpu
[135.924788] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[135.970829] [024/130] (880s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[136.058876] Starting subtest: bad-aux-stride-yf-tiled-ccs
[136.061272] Starting dynamic subtest: pipe-A-eDP-1
[136.085459] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[136.094732] Starting dynamic subtest: pipe-B-eDP-1
[136.116594] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[136.124072] Starting dynamic subtest: pipe-C-eDP-1
[136.145834] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[136.153067] Starting dynamic subtest: pipe-D-eDP-1
[136.175724] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[136.180301] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.002s)
[138.157970] [025/130] (878s left) prime_self_import (basic-with_two_bos)
[138.191452] Starting subtest: basic-with_two_bos
[138.220768] Subtest basic-with_two_bos: SUCCESS (0.031s)
[138.321031] [026/130] (877s left) kms_atomic_interruptible (atomic-setmode)
[138.423836] Starting subtest: atomic-setmode
[138.426255] Starting dynamic subtest: pipe-A-eDP-1
[145.277519] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.854s)
[145.280099] Subtest atomic-setmode: SUCCESS (6.855s)
[146.048927] [027/130] (870s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[146.154795] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[146.744156] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.592s)
[146.872261] [028/130] (869s left) kms_pm_dc (dc3co-vpb-simulation)
[147.968950] Starting subtest: dc3co-vpb-simulation
[156.768618] Subtest dc3co-vpb-simulation: SKIP (8.796s)
[156.895239] [029/130] (859s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[156.996263] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[156.998473] Starting dynamic subtest: pipe-A-default-mode
[157.286562] Dynamic subtest pipe-A-default-mode: SKIP (0.284s)
[157.291289] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.285s)
[158.074954] [030/130] (858s left) gem_flink_race (flink_name)
[158.116678] Starting subtest: flink_name
[163.526832] Subtest flink_name: SUCCESS (5.404s)
[163.619729] [031/130] (852s left) kms_psr (psr2-cursor-mmap-gtt)
[163.718033] Starting subtest: psr2-cursor-mmap-gtt
[163.720282] Starting dynamic subtest: eDP-1
[165.372251] Dynamic subtest eDP-1: SUCCESS (1.651s)
[165.374211] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.651s)
[166.138705] [032/130] (850s left) gem_partial_pwrite_pread (reads)
[166.200714] Subtest reads: SKIP (0.000s)
[166.234130] [033/130] (850s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[166.300730] Starting subtest: multi-wait-all-for-submit-submitted
[166.406933] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.106s)
[166.460321] [034/130] (849s left) gem_pipe_control_store_loop (reused-buffer)
[166.511793] Starting subtest: reused-buffer
[168.663483] Subtest reused-buffer: SUCCESS (2.152s)
[168.758848] [035/130] (847s left) perf (invalid-oa-format-id)
[168.857826] Starting subtest: invalid-oa-format-id
[168.868577] Subtest invalid-oa-format-id: SUCCESS (0.009s)
[168.887808] [036/130] (847s left) kms_panel_fitting (atomic-fastset)
[169.001816] Starting subtest: atomic-fastset
[169.004088] Starting dynamic subtest: pipe-A-eDP-1
[169.142078] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.140s)
[169.152078] Starting dynamic subtest: pipe-B-eDP-1
[170.279680] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.136s)
[170.290152] Starting dynamic subtest: pipe-C-eDP-1
[171.499029] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.219s)
[171.507800] Starting dynamic subtest: pipe-D-eDP-1
[172.613245] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.115s)
[172.615655] Subtest atomic-fastset: SUCCESS (3.611s)
[173.843406] [037/130] (842s left) kms_prop_blob (blob-prop-core)
[173.911241] Starting subtest: blob-prop-core
[173.913685] Subtest blob-prop-core: SUCCESS (0.000s)
[174.006358] [038/130] (842s left) gem_spin_batch (spin-each)
[174.074460] Starting subtest: spin-each
[177.346846] Subtest spin-each: SUCCESS (3.266s)
[177.975266] [039/130] (838s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[178.089783] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[178.094038] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[178.167867] [040/130] (838s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[178.274747] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[178.286053] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.010s)
[178.339887] [041/130] (838s left) kms_pm_rpm (system-suspend-modeset)
[180.158099] Starting subtest: system-suspend-modeset
[200.521028] Subtest system-suspend-modeset: SUCCESS (4.663s)
[200.844733] [042/130] (831s left) gem_ctx_persistence (legacy-engines-hang)
[200.905415] Starting subtest: legacy-engines-hang
[200.907697] Starting dynamic subtest: render
[201.060030] Dynamic subtest render: SUCCESS (0.157s)
[201.071201] Starting dynamic subtest: bsd1
[201.166146] Dynamic subtest bsd1: SUCCESS (0.107s)
[201.175566] Starting dynamic subtest: bsd2
[201.288941] Dynamic subtest bsd2: SUCCESS (0.124s)
[201.299337] Starting dynamic subtest: blt
[201.412732] Dynamic subtest blt: SUCCESS (0.126s)
[201.423274] Starting dynamic subtest: vebox
[201.538046] Dynamic subtest vebox: SUCCESS (0.126s)
[201.540682] Subtest legacy-engines-hang: SUCCESS (0.648s)
[201.592135] [043/130] (830s left) gem_exec_fence (basic-wait-all)
[201.652091] Starting subtest: basic-wait-all
[201.760920] Subtest basic-wait-all: SUCCESS (0.113s)
[203.812889] [044/130] (828s left) i915_query (query-regions-garbage-items)
[203.864292] Starting subtest: query-regions-garbage-items
[203.866134] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[203.950412] [045/130] (828s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[204.051075] Starting subtest: sprite-rotation-90-pos-100-0
[204.055620] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[204.102158] [046/130] (828s left) gem_render_copy (y-tiled)
[204.162706] Starting subtest: y-tiled
[204.166920] Subtest y-tiled: SKIP (0.000s)
[204.324232] [047/130] (827s left) perf_pmu (interrupts-sync)
[204.362585] Starting subtest: interrupts-sync
[205.470072] Subtest interrupts-sync: SUCCESS (1.122s)
[205.557740] [048/130] (826s left) syncobj_timeline (invalid-transfer-bad-pad)
[205.619332] Starting subtest: invalid-transfer-bad-pad
[205.621688] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[205.706944] [049/130] (826s left) kms_psr (fbc-psr2-sprite-plane-move)
[205.795299] Starting subtest: fbc-psr2-sprite-plane-move
[205.797525] Starting dynamic subtest: eDP-1
[205.801348] Dynamic subtest eDP-1: SKIP (0.000s)
[205.805323] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[205.847667] [050/130] (826s left) gem_render_copy (linear)
[205.907000] Starting subtest: linear
[205.909165] Starting dynamic subtest: smem
[205.947920] Dynamic subtest smem: SUCCESS (0.041s)
[205.950233] Subtest linear: SUCCESS (0.041s)
[206.158444] [051/130] (826s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[206.227418] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[206.269957] [052/130] (826s left) kms_cursor_crc (cursor-onscreen-max-size)
[206.544030] Starting subtest: cursor-onscreen-max-size
[206.550736] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[206.659168] [053/130] (825s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[206.765700] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[210.962750] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (4.238s)
[211.080896] [054/130] (821s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[211.200379] Starting subtest: cursorB-vs-flipB-legacy
[211.206095] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[211.289172] [055/130] (821s left) kms_sequence (get-idle)
[211.393296] Starting subtest: get-idle
[211.395560] Starting dynamic subtest: pipe-A-eDP-1
[213.194506] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.810s)
[213.204452] Starting dynamic subtest: pipe-B-eDP-1
[215.690856] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.507s)
[215.699377] Starting dynamic subtest: pipe-C-eDP-1
[218.085206] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.401s)
[218.094351] Starting dynamic subtest: pipe-D-eDP-1
[220.517643] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.436s)
[220.519980] Subtest get-idle: SUCCESS (9.157s)
[221.285299] [056/130] (811s left) gem_exec_balancer (hang)
[221.537195] Starting subtest: hang
[223.023882] Subtest hang: SUCCESS (1.491s)
[223.155947] [057/130] (809s left) kms_flip (flip-vs-expired-vblank-interruptible)
[223.272571] Starting subtest: flip-vs-expired-vblank-interruptible
[223.274827] Starting dynamic subtest: A-eDP1
[231.910421] Dynamic subtest A-eDP1: SUCCESS (8.642s)
[231.921317] Starting dynamic subtest: B-eDP1
[240.521807] Dynamic subtest B-eDP1: SUCCESS (8.606s)
[240.532565] Starting dynamic subtest: C-eDP1
[249.136183] Dynamic subtest C-eDP1: SUCCESS (8.612s)
[249.146223] Starting dynamic subtest: D-eDP1
[257.768284] Dynamic subtest D-eDP1: SUCCESS (8.631s)
[257.773541] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.500s)
[258.901290] [058/130] (773s left) syncobj_wait (single-wait-signaled)
[258.965556] Starting subtest: single-wait-signaled
[258.968009] Subtest single-wait-signaled: SUCCESS (0.000s)
[259.054051] [059/130] (773s left) debugfs_test (read_all_entries)
[259.114341] Starting subtest: read_all_entries
[259.403041] Subtest read_all_entries: SUCCESS (0.289s)
[259.491327] [060/130] (772s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[259.600308] Starting subtest: 4-tiled-32bpp-rotate-0
[260.818468] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.223s)
[260.956004] [061/130] (771s left) prime_vgem (shrink)
[261.051453] Starting subtest: shrink
[261.067472] Subtest shrink: SUCCESS (0.014s)
[261.176973] [062/130] (771s left) drm_fdinfo (busy-hang)
[261.219001] Starting subtest: busy-hang
[261.220823] Starting dynamic subtest: rcs0
[261.246287] Dynamic subtest rcs0: SKIP (0.025s)
[261.255424] Starting dynamic subtest: bcs0
[261.258632] Dynamic subtest bcs0: SKIP (0.001s)
[261.266280] Starting dynamic subtest: vcs0
[261.269691] Dynamic subtest vcs0: SKIP (0.000s)
[261.277049] Starting dynamic subtest: vcs1
[261.280357] Dynamic subtest vcs1: SKIP (0.000s)
[261.287361] Starting dynamic subtest: vecs0
[261.290680] Dynamic subtest vecs0: SKIP (0.000s)
[261.297679] Starting dynamic subtest: ccs0
[261.300956] Dynamic subtest ccs0: SKIP (0.000s)
[261.304141] Subtest busy-hang: SKIP (0.030s)
[261.317533] [063/130] (771s left) kms_cursor_edge_walk (256x256-right-edge)
[261.421649] Starting subtest: 256x256-right-edge
[261.423691] Starting dynamic subtest: pipe-A-eDP-1
[264.854493] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.431s)
[264.864198] Starting dynamic subtest: pipe-D-eDP-1
[267.962641] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.108s)
[267.965044] Subtest 256x256-right-edge: SUCCESS (6.541s)
[268.767616] [064/130] (763s left) gem_unref_active_buffers
[268.971819] [065/130] (763s left) kms_big_fb (linear-8bpp-rotate-270)
[269.083033] Starting subtest: linear-8bpp-rotate-270
[269.104179] Subtest linear-8bpp-rotate-270: SKIP (0.021s)
[269.198341] [066/130] (763s left) kms_big_fb (y-tiled-addfb-size-overflow)
[269.305992] Starting subtest: y-tiled-addfb-size-overflow
[269.310204] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[269.392212] [067/130] (763s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[269.492229] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[269.494644] Starting dynamic subtest: pipe-A-eDP-1
[269.517310] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[269.527730] Starting dynamic subtest: pipe-B-eDP-1
[269.549340] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[269.557123] Starting dynamic subtest: pipe-C-eDP-1
[269.578753] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[269.586340] Starting dynamic subtest: pipe-D-eDP-1
[269.609545] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[269.613954] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[271.624464] [068/130] (760s left) kms_async_flips (test-cursor)
[271.720310] Starting subtest: test-cursor
[271.724777] Subtest test-cursor: SKIP (0.000s)
[272.846397] [069/130] (759s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc)
[272.958623] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc
[277.390292] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (4.436s)
[277.503157] [070/130] (755s left) kms_addfb_basic (no-handle)
[277.568318] Starting subtest: no-handle
[277.570190] Subtest no-handle: SUCCESS (0.000s)
[277.710256] [071/130] (754s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[277.815544] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[277.819693] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[277.898664] [072/130] (754s left) kms_writeback (writeback-invalid-parameters)
[277.998525] Subtest writeback-invalid-parameters: SKIP (0.000s)
[278.021732] [073/130] (754s left) kms_pipe_crc_basic (nonblocking-crc)
[278.121031] Starting subtest: nonblocking-crc
[278.123362] Starting dynamic subtest: pipe-A-eDP-1
[278.832221] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.708s)
[278.846644] Starting dynamic subtest: pipe-B-eDP-1
[280.183292] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.351s)
[280.192530] Starting dynamic subtest: pipe-C-eDP-1
[281.474974] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.291s)
[281.484998] Starting dynamic subtest: pipe-D-eDP-1
[282.797793] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.322s)
[282.800277] Subtest nonblocking-crc: SUCCESS (4.677s)
[283.603337] [074/130] (749s left) gem_userptr_blits (input-checking)
[283.669001] Starting subtest: input-checking
[283.670910] Subtest input-checking: SUCCESS (0.000s)
[283.773037] [075/130] (748s left) gem_mmap_gtt (basic-small-copy-odd)
[283.835126] Subtest basic-small-copy-odd: SKIP (0.000s)
[283.874007] [076/130] (748s left) syncobj_wait (wait-zero-handles)
[283.933752] Starting subtest: wait-zero-handles
[283.936094] Subtest wait-zero-handles: SUCCESS (0.000s)
[284.011000] [077/130] (748s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[284.106771] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[288.373767] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (4.271s)
[288.499402] [078/130] (744s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[288.605687] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[288.609821] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[288.691133] [079/130] (744s left) gem_eio (create-ext)
[288.915442] Starting subtest: create-ext
[289.213338] Subtest create-ext: SUCCESS (0.298s)
[289.344006] [080/130] (743s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted)
[289.401527] Starting subtest: multi-wait-all-for-submit-available-submitted
[289.403648] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[289.493236] [081/130] (743s left) kms_getfb (getfb2-into-addfb2)
[289.552337] Starting subtest: getfb2-into-addfb2
[289.554468] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[289.641324] [082/130] (743s left) kms_addfb_basic (invalid-set-prop-any)
[289.694411] Starting subtest: invalid-set-prop-any
[289.696099] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[289.811757] [083/130] (743s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[289.902923] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[289.904757] Starting dynamic subtest: pipe-A-eDP-1
[289.912526] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[289.922917] Starting dynamic subtest: pipe-B-eDP-1
[289.930035] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[289.938262] Starting dynamic subtest: pipe-C-eDP-1
[289.945501] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[289.953452] Starting dynamic subtest: pipe-D-eDP-1
[289.960738] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[289.964219] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[291.992562] [084/130] (740s left) kms_chamelium_frames (dp-crc-fast)
[292.377973] Subtest dp-crc-fast: SKIP (0.000s)
[293.191894] [085/130] (739s left) kms_color (ctm-negative)
[293.288419] Starting subtest: ctm-negative
[293.290648] Starting dynamic subtest: pipe-A-eDP-1
[293.930303] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.641s)
[293.938627] Starting dynamic subtest: pipe-B-eDP-1
[295.251048] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.318s)
[295.260795] Starting dynamic subtest: pipe-C-eDP-1
[296.529126] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.278s)
[296.537852] Starting dynamic subtest: pipe-D-eDP-1
[297.875130] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.344s)
[297.877541] Subtest ctm-negative: SUCCESS (4.583s)
[298.709813] [086/130] (734s left) kms_pipe_crc_basic (suspend-read-crc)
[298.805657] Starting subtest: suspend-read-crc
[298.808077] Starting dynamic subtest: pipe-A-eDP-1
[316.884269] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.492s)
[316.892915] Starting dynamic subtest: pipe-B-eDP-1
[334.560370] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.738s)
[334.571310] Starting dynamic subtest: pipe-C-eDP-1
[352.530923] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.643s)
[352.541065] Starting dynamic subtest: pipe-D-eDP-1
[370.521088] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.678s)
[370.523421] Subtest suspend-read-crc: SUCCESS (10.556s)
[371.337923] [087/130] (722s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[371.438488] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[371.443394] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[371.509634] [088/130] (722s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[371.622766] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[371.631835] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[371.724044] [089/130] (722s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[371.825177] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[371.836474] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.010s)
[371.892070] [090/130] (722s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[371.998069] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[372.606503] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.625s)
[372.755715] [091/130] (721s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[372.847093] Starting subtest: fbc-pr-cursor-mmap-gtt
[372.852207] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[372.900702] [092/130] (721s left) gen7_exec_parse (oacontrol-tracking)
[372.962197] Subtest oacontrol-tracking: SKIP (0.000s)
[373.000917] [093/130] (721s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[373.111143] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[377.306533] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (4.272s)
[377.408802] [094/130] (716s left) kms_plane_scaling (2x-scaler-multi-pipe)
[377.509481] Starting subtest: 2x-scaler-multi-pipe
[377.514220] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[377.599829] [095/130] (716s left) gem_pread (exhaustion)
[377.657299] Subtest exhaustion: SKIP (0.000s)
[377.700221] [096/130] (716s left) prime_mmap (test_refcounting)
[377.759050] Starting subtest: test_refcounting
[377.761158] Starting dynamic subtest: test_refcounting-smem
[377.790163] Dynamic subtest test_refcounting-smem: SUCCESS (0.033s)
[377.792729] Subtest test_refcounting: SUCCESS (0.034s)
[377.860525] [097/130] (716s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[377.924921] Starting subtest: y-tiled-to-vebox-y-tiled
[377.930221] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[378.093144] [098/130] (716s left) kms_plane_scaling (plane-downscale-factor-0-25-with-rotation)
[378.181924] Starting subtest: plane-downscale-factor-0-25-with-rotation
[378.184478] Starting dynamic subtest: pipe-A
[378.198423] Dynamic subtest pipe-A: SKIP (0.010s)
[378.208029] Starting dynamic subtest: pipe-B
[378.218914] Dynamic subtest pipe-B: SKIP (0.019s)
[378.227861] Starting dynamic subtest: pipe-C
[378.238663] Dynamic subtest pipe-C: SKIP (0.019s)
[378.247460] Starting dynamic subtest: pipe-D
[378.258125] Dynamic subtest pipe-D: SKIP (0.019s)
[378.263180] Subtest plane-downscale-factor-0-25-with-rotation: SKIP (0.069s)
[378.337980] [099/130] (715s left) fbdev (nullptr)
[378.386154] Starting subtest: nullptr
[378.388870] Subtest nullptr: SUCCESS (0.000s)
[378.424539] [100/130] (715s left) syncobj_timeline (signal-point-0)
[378.484714] Starting subtest: signal-point-0
[378.487407] Subtest signal-point-0: SUCCESS (0.000s)
[378.580547] [101/130] (715s left) kms_feature_discovery (psr1)
[378.678230] Starting subtest: psr1
[378.680273] Subtest psr1: SUCCESS (0.000s)
[378.728928] [102/130] (715s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[378.840178] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[382.053244] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (3.245s)
[382.157831] [103/130] (712s left) gem_mmap_offset (mmap-unmap)
[382.214271] Starting subtest: mmap-unmap
[382.216790] Starting dynamic subtest: smem0
[403.497964] Dynamic subtest smem0: SUCCESS (21.333s)
[403.500832] Subtest mmap-unmap: SUCCESS (21.334s)
[403.569904] [104/130] (690s left) gem_exec_schedule (fairslice-all)
[403.640400] Starting subtest: fairslice-all
[405.729782] Subtest fairslice-all: SUCCESS (2.088s)
[407.127114] [105/130] (687s left) gem_pxp (verify-pxp-stale-ctx-execution)
[408.249732] Starting subtest: verify-pxp-stale-ctx-execution
[408.308781] Subtest verify-pxp-stale-ctx-execution: SUCCESS (0.060s)
[408.453981] [106/130] (685s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-25)
[408.570279] Starting subtest: planes-upscale-20x20-downscale-factor-0-25
[408.573033] Starting dynamic subtest: pipe-A
[408.586494] Dynamic subtest pipe-A: SKIP (0.011s)
[408.596846] Starting dynamic subtest: pipe-B
[408.605608] Dynamic subtest pipe-B: SKIP (0.022s)
[408.615574] Starting dynamic subtest: pipe-C
[408.629951] Dynamic subtest pipe-C: SKIP (0.022s)
[408.640182] Starting dynamic subtest: pipe-D
[408.653717] Dynamic subtest pipe-D: SKIP (0.022s)
[408.658178] Subtest planes-upscale-20x20-downscale-factor-0-25: SKIP (0.081s)
[408.740722] [107/130] (685s left) gem_ccs (suspend-resume)
[408.793508] Starting subtest: suspend-resume
[408.799066] Subtest suspend-resume: SKIP (0.000s)
[408.881780] [108/130] (685s left) kms_content_protection (atomic)
[409.032218] Starting subtest: atomic
[412.264348] Subtest atomic: SKIP (3.228s)
[413.414966] [109/130] (680s left) gem_userptr_blits (sync-unmap-cycles)
[413.490287] Starting subtest: sync-unmap-cycles
[418.861244] Subtest sync-unmap-cycles: SUCCESS (5.371s)
[418.999690] [110/130] (675s left) gem_create (create-ext-placement-each)
[419.180069] Starting subtest: create-ext-placement-each
[419.183057] Subtest create-ext-placement-each: SUCCESS (0.000s)
[419.282955] [111/130] (675s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[419.393515] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[419.396397] Starting dynamic subtest: pipe-A-default-mode
[419.677292] Dynamic subtest pipe-A-default-mode: SKIP (0.283s)
[419.682334] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.284s)
[420.446505] [112/130] (673s left) gem_lmem_swapping (parallel-random-engines)
[420.489403] Subtest parallel-random-engines: SKIP (0.000s)
[420.508772] [113/130] (673s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[425.514249] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[425.517256] Starting dynamic subtest: pipe-A-eDP-1
[426.313806] Dynamic subtest pipe-A-eDP-1: SKIP (0.796s)
[426.323499] Starting dynamic subtest: pipe-B-eDP-1
[427.437291] Dynamic subtest pipe-B-eDP-1: SKIP (1.122s)
[427.443883] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.921s)
[428.590651] [114/130] (665s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[428.695244] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[428.697898] Starting dynamic subtest: pipe-A-eDP-1
[428.726016] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[428.736521] Starting dynamic subtest: pipe-B-eDP-1
[428.764378] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[428.773470] Starting dynamic subtest: pipe-C-eDP-1
[428.800397] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[428.809234] Starting dynamic subtest: pipe-D-eDP-1
[428.836241] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[428.841135] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s)
[430.835555] [115/130] (663s left) gem_exec_fence (syncobj-timeline-unused-fence)
[431.372053] Starting subtest: syncobj-timeline-unused-fence
[431.378503] Subtest syncobj-timeline-unused-fence: SUCCESS (0.007s)
[433.151081] [116/130] (661s left) i915_pm_rc6_residency (rc6-fence)
[433.207511] Starting subtest: rc6-fence
[433.225924] Starting dynamic subtest: gt0
[445.551455] Dynamic subtest gt0: SUCCESS (12.328s)
[445.562505] Starting dynamic subtest: gt1
[460.995692] Dynamic subtest gt1: SUCCESS (15.445s)
[460.999021] Subtest rc6-fence: SUCCESS (27.798s)
[461.054827] [117/130] (633s left) syncobj_timeline (etime-multi-wait-submitted)
[461.114448] Starting subtest: etime-multi-wait-submitted
[461.215781] Subtest etime-multi-wait-submitted: SUCCESS (0.103s)
[461.275090] [118/130] (633s left) kms_vblank (query-forked-busy-hang)
[461.374924] Starting subtest: query-forked-busy-hang
[461.377470] Starting dynamic subtest: pipe-A-eDP-1
[487.804503] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.421s)
[487.819936] Starting dynamic subtest: pipe-D-eDP-1
[502.843391] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.033s)
[502.846259] Subtest query-forked-busy-hang: SUCCESS (41.459s)
[503.675773] [119/130] (590s left) gem_exec_fence (basic-busy-all)
[503.734418] Starting subtest: basic-busy-all
[503.822663] Subtest basic-busy-all: SUCCESS (0.089s)
[506.139705] [120/130] (588s left) api_intel_bb (simple-bb)
[506.206966] Starting subtest: simple-bb
[506.214849] Subtest simple-bb: SUCCESS (0.012s)
[506.341729] [121/130] (588s left) gem_ctx_persistence (engines-cleanup)
[506.408199] Starting subtest: engines-cleanup
[506.411104] Starting dynamic subtest: rcs0
[506.533174] Dynamic subtest rcs0: SUCCESS (0.124s)
[506.545314] Starting dynamic subtest: bcs0
[506.605854] Dynamic subtest bcs0: SUCCESS (0.071s)
[506.618257] Starting dynamic subtest: vcs0
[506.684757] Dynamic subtest vcs0: SUCCESS (0.077s)
[506.695446] Starting dynamic subtest: vcs1
[506.743799] Dynamic subtest vcs1: SUCCESS (0.057s)
[506.754086] Starting dynamic subtest: vecs0
[506.813756] Dynamic subtest vecs0: SUCCESS (0.068s)
[506.825499] Starting dynamic subtest: ccs0
[506.838462] Dynamic subtest ccs0: SUCCESS (0.023s)
[506.841255] Subtest engines-cleanup: SUCCESS (0.431s)
[506.956246] [122/130] (587s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[507.052171] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[507.054788] Starting dynamic subtest: pipe-A-eDP-1
[507.081329] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[507.090350] Starting dynamic subtest: pipe-B-eDP-1
[507.115863] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[507.124266] Starting dynamic subtest: pipe-C-eDP-1
[507.146081] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[507.154304] Starting dynamic subtest: pipe-D-eDP-1
[507.178963] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[507.183312] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[509.233760] [123/130] (585s left) gem_exec_schedule (semaphore-resolve)
[509.307295] Starting subtest: semaphore-resolve
[509.344502] Subtest semaphore-resolve: SUCCESS (0.047s)
[509.677265] [124/130] (584s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[509.784316] Starting subtest: fbc-rgb565-draw-pwrite
[513.276519] Subtest fbc-rgb565-draw-pwrite: SUCCESS (3.496s)
[513.428371] [125/130] (581s left) kms_psr (fbc-psr2-dpms)
[513.546655] Starting subtest: fbc-psr2-dpms
[513.549209] Starting dynamic subtest: eDP-1
[513.554358] Dynamic subtest eDP-1: SKIP (0.000s)
[513.559645] Subtest fbc-psr2-dpms: SKIP (0.001s)
[513.599892] [126/130] (581s left) gem_exec_whisper (basic-contexts)
[513.678359] Starting subtest: basic-contexts
[519.144490] Subtest basic-contexts: SUCCESS (5.463s)
[519.311418] [127/130] (575s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[519.423514] Starting subtest: y-tiled-64bpp-rotate-270
[519.428881] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[519.502890] [128/130] (575s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[519.610342] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[519.614411] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[519.673013] [129/130] (575s left) perf_pmu (pmu-read)
[519.714463] Starting subtest: pmu-read
[519.717099] Subtest pmu-read: SUCCESS (0.005s)
[519.808534] [130/130] (574s left) perf (disabled-read-error)
[519.902101] Starting subtest: disabled-read-error
[519.919724] Subtest disabled-read-error: SUCCESS (0.018s)
[519.937327] Closing watchdogs
Done.