[46.581574] Initializing watchdogs
[46.581623]   /dev/watchdog0
[46.586195] [001/142] (960s left) gem_exec_fence (nb-await)
[46.763154] Starting subtest: nb-await
[46.763957] Starting dynamic subtest: rcs0
[46.821266] Dynamic subtest rcs0: SUCCESS (0.066s)
[46.828591] Starting dynamic subtest: bcs0
[46.880524] Dynamic subtest bcs0: SUCCESS (0.059s)
[46.887826] Starting dynamic subtest: vcs0
[46.940675] Dynamic subtest vcs0: SUCCESS (0.060s)
[46.947710] Starting dynamic subtest: vcs1
[47.001426] Dynamic subtest vcs1: SUCCESS (0.061s)
[47.008740] Starting dynamic subtest: vecs0
[47.060948] Dynamic subtest vecs0: SUCCESS (0.059s)
[47.062258] Subtest nb-await: SUCCESS (0.306s)
[47.507951] [002/142] (959s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[47.611855] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[47.613483] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[47.661980] [003/142] (959s left) kms_ccs (pipe-c-random-ccs-data-y_tiled_gen12_rc_ccs_cc)
[47.863981] Starting subtest: pipe-C-random-ccs-data-y_tiled_gen12_rc_ccs_cc
[47.957802] Subtest pipe-C-random-ccs-data-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.094s)
[48.126734] [004/142] (958s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[48.216961] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[48.218435] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[48.262898] [005/142] (958s left) gem_ctx_freq (sysfs)
[48.305564] Starting subtest: sysfs
[48.306405] Starting dynamic subtest: gt0
[53.201610] Dynamic subtest gt0: SUCCESS (4.895s)
[53.202884] Subtest sysfs: SUCCESS (4.895s)
[53.244630] [006/142] (953s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[53.337786] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[53.339161] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[53.392119] [007/142] (953s left) i915_pm_rpm (i2c)
[54.960645] Starting subtest: i2c
[58.018791] Subtest i2c: SUCCESS (3.058s)
[58.109241] [008/142] (949s left) kms_vblank (pipe-b-wait-idle)
[58.203946] Starting subtest: pipe-B-wait-idle
[59.444942] Subtest pipe-B-wait-idle: SUCCESS (1.241s)
[59.540533] [009/142] (947s left) gem_softpin (allocator-nopin)
[59.576718] Starting subtest: allocator-nopin
[59.653301] Subtest allocator-nopin: SUCCESS (0.076s)
[59.731770] [010/142] (947s left) gem_exec_params (invalid-ring)
[59.780945] Starting subtest: invalid-ring
[59.781786] Subtest invalid-ring: SUCCESS (0.000s)
[59.836132] [011/142] (947s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[59.923087] Starting subtest: psr-1p-primscrn-spr-indfb-move
[59.924610] Subtest psr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[59.967554] [012/142] (947s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[60.059605] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[60.061372] Subtest fbcpsr-1p-pri-indfb-multidraw: SKIP (0.000s)
[60.107880] [013/142] (947s left) perf (polling-parameterized)
[60.198343] Starting subtest: polling-parameterized
[80.246313] Subtest polling-parameterized: SUCCESS (20.014s)
[80.261895] [014/142] (926s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[80.388980] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[80.390456] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[80.437989] [015/142] (926s left) kms_plane_alpha_blend (alpha-7efc)
[80.529788] Starting subtest: alpha-7efc
[80.592031] Starting dynamic subtest: pipe-A-HDMI-A-1
[80.896346] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.304s)
[80.919983] Starting dynamic subtest: pipe-D-HDMI-A-1
[81.332996] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.417s)
[81.333848] Subtest alpha-7efc: SUCCESS (0.804s)
[81.432507] [016/142] (925s left) gem_exec_whisper (basic-fds-forked-all)
[81.475052] Starting subtest: basic-fds-forked-all
[105.303266] Subtest basic-fds-forked-all: SUCCESS (23.818s)
[105.453727] [017/142] (901s left) gem_eio (context-create)
[105.511903] Starting subtest: context-create
[105.533593] Subtest context-create: SUCCESS (0.021s)
[105.619310] [018/142] (901s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs)
[105.801500] Starting subtest: pipe-B-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs
[105.804176] Subtest pipe-B-crc-sprite-planes-basic-4_tiled_dg2_mc_ccs: SKIP (0.002s)
[105.924338] [019/142] (901s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[106.017826] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[106.019198] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[106.066786] [020/142] (901s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[106.113793] Starting subtest: cpuset-basic-small-copy-XY
[111.570578] Subtest cpuset-basic-small-copy-XY: SUCCESS (5.461s)
[111.603661] [021/142] (895s left) kms_rotation_crc (sprite-rotation-270)
[111.727757] Starting subtest: sprite-rotation-270
[115.483196] Subtest sprite-rotation-270: SUCCESS (3.755s)
[115.626155] [022/142] (891s left) syncobj_wait (signal)
[115.666178] Starting subtest: signal
[115.667021] Subtest signal: SUCCESS (0.000s)
[115.705855] [023/142] (891s left) kms_ccs (pipe-d-ccs-on-another-bo-y_tiled_gen12_rc_ccs)
[115.942050] Starting subtest: pipe-D-ccs-on-another-bo-y_tiled_gen12_rc_ccs
[115.942807] Subtest pipe-D-ccs-on-another-bo-y_tiled_gen12_rc_ccs: SUCCESS (0.000s)
[116.027457] [024/142] (891s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[116.109173] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[145.260442] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (29.152s)
[145.356568] [025/142] (862s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[145.443381] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[145.444908] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[145.504237] [026/142] (861s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[145.594803] Starting subtest: basic-flip-before-cursor-atomic
[146.116274] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.521s)
[146.201425] [027/142] (861s left) kms_ccs (pipe-b-random-ccs-data-y_tiled_gen12_rc_ccs_cc)
[146.391407] Starting subtest: pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs_cc
[146.484338] Subtest pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.093s)
[146.703402] [028/142] (860s left) gem_workarounds (suspend-resume-context)
[146.755704] Starting subtest: suspend-resume-context
[163.082550] Subtest suspend-resume-context: SUCCESS (1.280s)
[169.167506] [029/142] (859s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[169.258063] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[169.259535] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[169.315687] [030/142] (859s left) kms_addfb_basic (unused-offsets)
[169.361080] Starting subtest: unused-offsets
[169.361842] Subtest unused-offsets: SUCCESS (0.000s)
[169.462087] [031/142] (859s left) kms_vrr (flip-suspend)
[169.544005] Starting subtest: flip-suspend
[169.545404] Subtest flip-suspend: SKIP (0.000s)
[169.575832] [032/142] (858s left) kms_vblank (pipe-a-ts-continuation-idle-hang)
[169.659296] Starting subtest: pipe-A-ts-continuation-idle-hang
[183.991221] Subtest pipe-A-ts-continuation-idle-hang: SUCCESS (14.332s)
[184.100578] [033/142] (844s left) prime_mmap_coherency (ioctl-errors)
[184.135453] Starting subtest: ioctl-errors
[187.778222] Subtest ioctl-errors: SUCCESS (3.643s)
[187.868598] [034/142] (840s left) kms_psr2_sf (overlay-plane-move-continuous-sf)
[187.953054] Subtest overlay-plane-move-continuous-sf: SKIP (0.000s)
[187.969863] [035/142] (840s left) vc4/vc4_wait_bo (used-bo-1ns)
[188.020973] Subtest used-bo-1ns: SKIP (0.000s)
[188.050698] [036/142] (840s left) i915_module_load (reload)
[188.091148] Starting subtest: reload
[189.524578] Subtest reload: SUCCESS (1.433s)
[189.538896] [037/142] (839s left) kms_cursor_legacy (forked-bo)
[189.640607] Starting subtest: forked-bo
[189.641432] Starting dynamic subtest: pipe-A
[195.048739] Dynamic subtest pipe-A: SUCCESS (5.408s)
[195.054259] Starting dynamic subtest: pipe-B
[200.482385] Dynamic subtest pipe-B: SUCCESS (5.433s)
[200.487553] Starting dynamic subtest: pipe-C
[205.898394] Dynamic subtest pipe-C: SUCCESS (5.415s)
[205.904027] Starting dynamic subtest: pipe-D
[211.329487] Dynamic subtest pipe-D: SUCCESS (5.431s)
[211.336036] Starting dynamic subtest: all-pipes
[216.768677] Dynamic subtest all-pipes: SUCCESS (5.438s)
[216.769865] Subtest forked-bo: SUCCESS (27.128s)
[216.816153] [038/142] (811s left) kms_vblank (pipe-c-ts-continuation-modeset)
[216.904717] Starting subtest: pipe-C-ts-continuation-modeset
[217.247935] Subtest pipe-C-ts-continuation-modeset: SUCCESS (0.343s)
[217.344679] [039/142] (811s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[217.433160] Starting subtest: primary-yf-tiled-reflect-x-180
[217.483187] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.049s)
[217.545285] [040/142] (811s left) i915_pm_rpm (reg-read-ioctl)
[219.101822] Starting subtest: reg-read-ioctl
[219.611031] Subtest reg-read-ioctl: SUCCESS (0.509s)
[219.757970] [041/142] (808s left) gem_exec_parallel (basic)
[219.803255] Starting subtest: basic
[219.803996] Starting dynamic subtest: rcs0
[221.297614] Dynamic subtest rcs0: SUCCESS (1.494s)
[221.303098] Starting dynamic subtest: bcs0
[222.760675] Dynamic subtest bcs0: SUCCESS (1.463s)
[222.765862] Starting dynamic subtest: vcs0
[224.218414] Dynamic subtest vcs0: SUCCESS (1.457s)
[224.224110] Starting dynamic subtest: vcs1
[225.697584] Dynamic subtest vcs1: SUCCESS (1.479s)
[225.702584] Starting dynamic subtest: vecs0
[227.145191] Dynamic subtest vecs0: SUCCESS (1.447s)
[227.146133] Subtest basic: SUCCESS (7.342s)
[227.294954] [042/142] (801s left) v3d/v3d_create_bo (create-bo-zeroed)
[227.360271] Subtest create-bo-zeroed: SKIP (0.000s)
[227.389540] [043/142] (801s left) gem_softpin (evict-snoop)
[227.436594] Starting subtest: evict-snoop
[227.438179] Subtest evict-snoop: SKIP (0.000s)
[227.479640] [044/142] (801s left) kms_addfb_basic (unused-modifier)
[227.522372] Starting subtest: unused-modifier
[227.523079] Subtest unused-modifier: SUCCESS (0.000s)
[227.629116] [045/142] (801s left) kms_setmode (invalid-clone-exclusive-crtc)
[227.671634] Starting subtest: invalid-clone-exclusive-crtc
[227.673880] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[227.706687] [046/142] (801s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-factor-0-25)
[227.793772] Starting subtest: planes-downscale-factor-0-25-upscale-factor-0-25
[227.794519] Starting dynamic subtest: pipe-A-HDMI-A-1
[227.807130] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.012s)
[227.812218] Starting dynamic subtest: pipe-B-HDMI-A-1
[227.835995] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.027s)
[227.841190] Starting dynamic subtest: pipe-C-HDMI-A-1
[227.864343] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.027s)
[227.869522] Starting dynamic subtest: pipe-D-HDMI-A-1
[227.893032] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.027s)
[227.894632] Subtest planes-downscale-factor-0-25-upscale-factor-0-25: SKIP (0.099s)
[227.956222] [047/142] (800s left) gem_exec_balancer (hang)
[228.203883] Starting subtest: hang
[228.972894] Subtest hang: SUCCESS (0.774s)
[229.015770] [048/142] (799s left) drm_read (short-buffer-nonblock)
[229.156028] Starting subtest: short-buffer-nonblock
[229.169009] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[229.232235] [049/142] (799s left) kms_addfb_basic (bad-pitch-128)
[229.275319] Starting subtest: bad-pitch-128
[229.276054] Subtest bad-pitch-128: SUCCESS (0.000s)
[229.374049] [050/142] (799s left) kms_feature_discovery (chamelium)
[229.465339] Starting subtest: chamelium
[229.466891] Subtest chamelium: SKIP (0.000s)
[229.498474] [051/142] (799s left) gem_exec_fence (syncobj-channel)
[229.807390] Starting subtest: syncobj-channel
[230.826928] Subtest syncobj-channel: SUCCESS (1.018s)
[231.100348] [052/142] (797s left) perf_pmu (busy-idle)
[231.146251] Starting subtest: busy-idle
[231.147025] Starting dynamic subtest: rcs0
[231.777767] Dynamic subtest rcs0: SUCCESS (0.631s)
[231.786262] Starting dynamic subtest: bcs0
[232.411743] Dynamic subtest bcs0: SUCCESS (0.633s)
[232.420112] Starting dynamic subtest: vcs0
[233.046507] Dynamic subtest vcs0: SUCCESS (0.634s)
[233.055104] Starting dynamic subtest: vcs1
[233.693937] Dynamic subtest vcs1: SUCCESS (0.646s)
[233.702788] Starting dynamic subtest: vecs0
[234.330734] Dynamic subtest vecs0: SUCCESS (0.636s)
[234.331798] Subtest busy-idle: SUCCESS (3.185s)
[234.381704] [053/142] (794s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[234.473615] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[234.475019] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[234.529638] [054/142] (794s left) kms_prime (basic-modeset-hybrid)
[235.111582] Subtest basic-modeset-hybrid: SKIP (0.000s)
[235.159782] [055/142] (793s left) kms_big_fb (4-tiled-addfb)
[235.252651] Starting subtest: 4-tiled-addfb
[235.254237] Subtest 4-tiled-addfb: SKIP (0.000s)
[235.313429] [056/142] (793s left) gem_exec_flush (basic-wb-ro-default)
[235.361935] Starting subtest: basic-wb-ro-default
[240.776013] Subtest basic-wb-ro-default: SUCCESS (5.415s)
[240.940453] [057/142] (787s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_mtl_rc_ccs)
[241.106440] Starting subtest: pipe-A-crc-primary-basic-4_tiled_mtl_rc_ccs
[241.108058] Subtest pipe-A-crc-primary-basic-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[241.274313] [058/142] (787s left) kms_ccs (pipe-d-ccs-on-another-bo-4_tiled_mtl_rc_ccs)
[241.503584] Starting subtest: pipe-D-ccs-on-another-bo-4_tiled_mtl_rc_ccs
[241.505223] Subtest pipe-D-ccs-on-another-bo-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[241.582626] [059/142] (787s left) syncobj_timeline (wait-all-interrupted)
[241.616657] Starting subtest: wait-all-interrupted
[241.719726] Subtest wait-all-interrupted: SUCCESS (0.101s)
[241.770274] [060/142] (787s left) gem_eio (wait-wedge-immediate)
[241.813157] Starting subtest: wait-wedge-immediate
[242.051360] Subtest wait-wedge-immediate: SUCCESS (0.238s)
[242.142373] [061/142] (786s left) kms_psr (psr2_sprite_mmap_cpu)
[242.179232] Subtest psr2_sprite_mmap_cpu: SKIP (0.000s)
[242.203976] [062/142] (786s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[242.299088] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[242.300542] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[242.357380] [063/142] (786s left) kms_ccs (pipe-d-random-ccs-data-4_tiled_dg2_rc_ccs)
[242.578354] Starting subtest: pipe-D-random-ccs-data-4_tiled_dg2_rc_ccs
[242.580791] Subtest pipe-D-random-ccs-data-4_tiled_dg2_rc_ccs: SKIP (0.000s)
[242.664043] [064/142] (786s left) kms_flip (2x-flip-vs-dpms)
[242.732997] Starting subtest: 2x-flip-vs-dpms
[242.745233] Subtest 2x-flip-vs-dpms: SKIP (0.012s)
[242.789187] [065/142] (786s left) gem_exec_schedule (u-submit-golden-slice)
[242.841118] Starting subtest: u-submit-golden-slice
[242.841839] Starting dynamic subtest: rcs0
[242.870821] Dynamic subtest rcs0: SUCCESS (0.029s)
[242.877959] Starting dynamic subtest: bcs0
[242.898235] Dynamic subtest bcs0: SUCCESS (0.027s)
[242.904282] Starting dynamic subtest: vcs0
[242.925471] Dynamic subtest vcs0: SUCCESS (0.026s)
[242.931299] Starting dynamic subtest: vcs1
[242.946403] Dynamic subtest vcs1: SUCCESS (0.021s)
[242.956328] Starting dynamic subtest: vecs0
[242.971377] Dynamic subtest vecs0: SUCCESS (0.024s)
[242.972217] Subtest u-submit-golden-slice: SUCCESS (0.130s)
[243.248922] [066/142] (785s left) gem_exec_balancer (persistence)
[243.497837] Starting subtest: persistence
[244.342790] Subtest persistence: SUCCESS (0.844s)
[244.380669] [067/142] (784s left) syncobj_basic (bad-handle-to-fd)
[244.415583] Starting subtest: bad-handle-to-fd
[244.416394] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[244.456023] [068/142] (784s left) kms_ccs (pipe-c-crc-sprite-planes-basic-yf_tiled_ccs)
[244.668937] Starting subtest: pipe-C-crc-sprite-planes-basic-yf_tiled_ccs
[244.671703] Subtest pipe-C-crc-sprite-planes-basic-yf_tiled_ccs: SKIP (0.002s)
[244.770512] [069/142] (784s left) gem_exec_schedule (semaphore-resolve)
[244.814119] Starting subtest: semaphore-resolve
[244.828311] Subtest semaphore-resolve: SUCCESS (0.014s)
[245.106638] [070/142] (784s left) kms_cursor_crc (cursor-dpms)
[245.199482] Starting subtest: cursor-dpms
[245.201538] Starting dynamic subtest: pipe-A-HDMI-A-1
[245.796182] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.595s)
[245.802665] Starting dynamic subtest: pipe-D-HDMI-A-1
[246.342951] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.546s)
[246.343717] Subtest cursor-dpms: SUCCESS (1.144s)
[246.451682] [071/142] (782s left) kms_psr (primary_page_flip)
[246.486815] Subtest primary_page_flip: SKIP (0.000s)
[246.502465] [072/142] (782s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[246.586972] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[246.587808] Starting dynamic subtest: pipe-A-valid-mode
[246.637106] Dynamic subtest pipe-A-valid-mode: SKIP (0.048s)
[246.638680] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.049s)
[246.715800] [073/142] (782s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[246.800780] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[246.802284] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[246.865203] [074/142] (782s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[246.904923] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[247.011161] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s)
[247.061145] [075/142] (782s left) kms_addfb_basic (bad-pitch-63)
[247.103498] Starting subtest: bad-pitch-63
[247.104327] Subtest bad-pitch-63: SUCCESS (0.000s)
[247.211280] [076/142] (782s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[247.298142] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[247.299636] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[247.366860] [077/142] (781s left) gem_wait (write-wait)
[247.413128] Starting subtest: write-wait
[247.413957] Starting dynamic subtest: all-engines
[248.443817] Dynamic subtest all-engines: SUCCESS (1.030s)
[248.452167] Starting dynamic subtest: rcs0
[249.472650] Dynamic subtest rcs0: SUCCESS (1.027s)
[249.480958] Starting dynamic subtest: bcs0
[250.499766] Dynamic subtest bcs0: SUCCESS (1.026s)
[250.508417] Starting dynamic subtest: vcs0
[251.525561] Dynamic subtest vcs0: SUCCESS (1.025s)
[251.535081] Starting dynamic subtest: vcs1
[252.554501] Dynamic subtest vcs1: SUCCESS (1.028s)
[252.563304] Starting dynamic subtest: vecs0
[253.587883] Dynamic subtest vecs0: SUCCESS (1.032s)
[253.589071] Subtest write-wait: SUCCESS (6.175s)
[253.758117] [078/142] (775s left) gem_create (busy-create)
[253.800833] Starting subtest: busy-create
[253.801604] Starting dynamic subtest: smem0
[286.046636] Dynamic subtest smem0: SUCCESS (32.245s)
[286.047823] Subtest busy-create: SUCCESS (32.246s)
[286.205943] [079/142] (743s left) gem_wait (invalid-buf)
[286.248794] Starting subtest: invalid-buf
[286.249586] Subtest invalid-buf: SUCCESS (0.000s)
[286.441055] [080/142] (742s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[286.478722] Starting subtest: multi-wait-all-for-submit-signaled
[286.479537] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[286.514511] [081/142] (742s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc)
[286.694528] Starting subtest: pipe-B-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc
[287.563979] Subtest pipe-B-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.869s)
[287.756993] [082/142] (741s left) kms_properties (connector-properties-atomic)
[287.851278] Starting subtest: connector-properties-atomic
[287.992661] Subtest connector-properties-atomic: SUCCESS (0.140s)
[288.095055] [083/142] (741s left) gem_render_copy (yf-tiled)
[288.138335] Starting subtest: yf-tiled
[288.139085] Starting dynamic subtest: smem
[288.208397] Dynamic subtest smem: SUCCESS (0.070s)
[288.209245] Subtest yf-tiled: SUCCESS (0.070s)
[288.367440] [084/142] (740s left) kms_lease (master-vs-lease)
[288.462364] Starting subtest: master-vs-lease
[288.463147] Subtest master-vs-lease: SUCCESS (0.001s)
[288.501453] [085/142] (740s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[288.589610] Starting subtest: fbcpsr-slowdraw
[288.591220] Subtest fbcpsr-slowdraw: SKIP (0.000s)
[288.651524] [086/142] (740s left) kms_cursor_crc (cursor-random-32x32)
[288.742279] Starting subtest: cursor-random-32x32
[288.787852] Subtest cursor-random-32x32: SKIP (0.044s)
[288.843135] [087/142] (740s left) gem_render_copy (linear-to-vebox-y-tiled)
[288.884242] Starting subtest: linear-to-vebox-y-tiled
[288.885105] Starting dynamic subtest: smem
[288.980828] Dynamic subtest smem: SUCCESS (0.096s)
[288.981648] Subtest linear-to-vebox-y-tiled: SUCCESS (0.097s)
[289.147326] [088/142] (740s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[289.241240] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[289.242787] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[289.287034] [089/142] (740s left) kms_vblank (pipe-a-ts-continuation-idle)
[289.373432] Starting subtest: pipe-A-ts-continuation-idle
[289.531053] Subtest pipe-A-ts-continuation-idle: SUCCESS (0.157s)
[289.625990] [090/142] (739s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[289.750406] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[289.767863] [091/142] (739s left) syncobj_timeline (etime-multi-wait-all-submitted)
[289.802194] Starting subtest: etime-multi-wait-all-submitted
[289.911805] Subtest etime-multi-wait-all-submitted: SUCCESS (0.104s)
[289.962367] [092/142] (739s left) gem_ctx_param (invalid-size-set)
[290.004004] Starting subtest: invalid-size-set
[290.004821] Subtest invalid-size-set: SUCCESS (0.000s)
[290.041959] [093/142] (739s left) kms_universal_plane (universal-plane-pipe-c-functional)
[290.125337] Starting subtest: universal-plane-pipe-C-functional
[291.299113] Subtest universal-plane-pipe-C-functional: SUCCESS (1.173s)
[291.370902] [094/142] (738s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[291.457818] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[291.458626] Starting dynamic subtest: pipe-A-valid-mode
[292.219675] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.762s)
[292.220490] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SUCCESS (0.763s)
[292.354683] [095/142] (737s left) v3d/v3d_submit_cl (multiple-job-submission)
[292.406806] Subtest multiple-job-submission: SKIP (0.000s)
[292.440919] [096/142] (737s left) gem_exec_schedule (fairslice-all)
[292.484248] Starting subtest: fairslice-all
[294.515740] Subtest fairslice-all: SUCCESS (2.031s)
[294.798902] [097/142] (734s left) gem_pwrite (basic-random)
[294.841501] Starting subtest: basic-random
[300.523339] Subtest basic-random: SUCCESS (5.681s)
[300.595858] [098/142] (728s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[300.730200] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[300.731620] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[300.785367] [099/142] (728s left) gem_lmem_swapping (parallel-random-engines)
[300.832704] Subtest parallel-random-engines: SKIP (0.000s)
[300.856187] [100/142] (728s left) kms_hdr (bpc-switch-suspend)
[300.941227] Starting subtest: bpc-switch-suspend
[300.942664] Subtest bpc-switch-suspend: SKIP (0.000s)
[300.979572] [101/142] (728s left) kms_chamelium_color (ctm-red-to-blue)
[301.071161] Subtest ctm-red-to-blue: SKIP (0.000s)
[301.088948] [102/142] (728s left) core_setmaster (master-drop-set-user)
[301.143314] Starting subtest: master-drop-set-user
[301.161919] Subtest master-drop-set-user: SUCCESS (0.019s)
[301.174794] [103/142] (728s left) gem_ctx_persistence (file)
[301.216437] Starting subtest: file
[301.284958] Subtest file: SUCCESS (0.068s)
[301.357437] [104/142] (728s left) kms_ccs (pipe-b-ccs-on-another-bo-4_tiled_mtl_mc_ccs)
[301.537434] Starting subtest: pipe-B-ccs-on-another-bo-4_tiled_mtl_mc_ccs
[301.539055] Subtest pipe-B-ccs-on-another-bo-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[301.667579] [105/142] (728s left) vc4/vc4_create_bo (create-bo-4096)
[301.719669] Subtest create-bo-4096: SKIP (0.000s)
[301.750271] [106/142] (727s left) gem_exec_params (no-vebox)
[301.785509] Starting subtest: no-vebox
[301.786388] Subtest no-vebox: SUCCESS (0.001s)
[301.859477] [107/142] (727s left) drm_fdinfo (all-busy-check-all)
[301.902259] Starting subtest: all-busy-check-all
[302.416892] Subtest all-busy-check-all: SUCCESS (0.514s)
[302.463555] [108/142] (727s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[302.551547] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[302.553177] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[302.612015] [109/142] (727s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[302.696616] Starting subtest: psr-rgb565-draw-pwrite
[302.698129] Subtest psr-rgb565-draw-pwrite: SKIP (0.000s)
[302.756749] [110/142] (726s left) gem_exec_await (wide-contexts)
[302.820700] Starting subtest: wide-contexts
[324.484322] Subtest wide-contexts: SUCCESS (21.663s)
[324.656524] [111/142] (705s left) kms_vblank (pipe-c-ts-continuation-modeset-hang)
[324.768214] Starting subtest: pipe-C-ts-continuation-modeset-hang
[339.117078] Subtest pipe-C-ts-continuation-modeset-hang: SUCCESS (14.349s)
[339.223431] [112/142] (690s left) kms_ccs (pipe-a-bad-aux-stride-4_tiled_mtl_rc_ccs)
[339.377595] Starting subtest: pipe-A-bad-aux-stride-4_tiled_mtl_rc_ccs
[339.385846] Subtest pipe-A-bad-aux-stride-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[339.532392] [113/142] (690s left) kms_display_modes (mst-extended-mode-negative)
[339.613847] Starting subtest: mst-extended-mode-negative
[339.615248] Subtest mst-extended-mode-negative: SKIP (0.000s)
[339.634366] [114/142] (690s left) kms_color (ctm-0-75)
[339.721447] Starting subtest: ctm-0-75
[339.722168] Starting dynamic subtest: pipe-A
[340.677052] Dynamic subtest pipe-A: SUCCESS (0.955s)
[340.683301] Starting dynamic subtest: pipe-B
[341.605792] Dynamic subtest pipe-B: SUCCESS (0.929s)
[341.611784] Starting dynamic subtest: pipe-C
[342.524213] Dynamic subtest pipe-C: SUCCESS (0.917s)
[342.530097] Starting dynamic subtest: pipe-D
[343.440673] Dynamic subtest pipe-D: SUCCESS (0.916s)
[343.441416] Subtest ctm-0-75: SUCCESS (3.720s)
[343.522304] [115/142] (686s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[343.612485] Starting subtest: yf-tiled-16bpp-rotate-90
[343.614076] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[343.677710] [116/142] (686s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[343.770451] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[344.059012] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.288s)
[344.155224] [117/142] (685s left) kms_chamelium_frames (dp-crc-fast)
[344.299236] Subtest dp-crc-fast: SKIP (0.000s)
[344.356443] [118/142] (685s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[344.441959] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[345.581085] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (1.141s)
[345.681628] [119/142] (684s left) gem_softpin (invalid)
[345.724246] Starting subtest: invalid
[345.727821] Subtest invalid: SUCCESS (0.004s)
[345.814055] [120/142] (684s left) gem_userptr_blits (mmap-offset-banned)
[345.867717] Starting subtest: mmap-offset-banned
[345.868590] Starting dynamic subtest: gtt
[345.869348] Dynamic subtest gtt: SUCCESS (0.000s)
[345.875291] Starting dynamic subtest: wb
[345.876047] Dynamic subtest wb: SUCCESS (0.000s)
[345.881841] Starting dynamic subtest: wc
[345.882694] Dynamic subtest wc: SUCCESS (0.000s)
[345.888455] Starting dynamic subtest: uc
[345.889223] Dynamic subtest uc: SUCCESS (0.000s)
[345.889976] Subtest mmap-offset-banned: SUCCESS (0.003s)
[345.955947] [121/142] (683s left) perf (invalid-oa-exponent)
[346.044638] Starting subtest: invalid-oa-exponent
[346.055501] Subtest invalid-oa-exponent: SUCCESS (0.011s)
[346.076539] [122/142] (683s left) kms_async_flips (async-flip-with-page-flip-events)
[346.158321] Starting subtest: async-flip-with-page-flip-events
[346.259148] Starting dynamic subtest: pipe-A-HDMI-A-1-Y-RC_CCS
[346.397321] Dynamic subtest pipe-A-HDMI-A-1-Y-RC_CCS: SKIP (0.136s)
[346.403398] Starting dynamic subtest: pipe-A-HDMI-A-1-Y-RC_CCS-CC
[346.495731] Dynamic subtest pipe-A-HDMI-A-1-Y-RC_CCS-CC: SKIP (0.098s)
[346.501889] Starting dynamic subtest: pipe-A-HDMI-A-1-Y
[348.563800] Dynamic subtest pipe-A-HDMI-A-1-Y: SUCCESS (2.068s)
[348.569968] Starting dynamic subtest: pipe-A-HDMI-A-1-X
[350.605891] Dynamic subtest pipe-A-HDMI-A-1-X: SUCCESS (2.041s)
[350.612418] Starting dynamic subtest: pipe-A-HDMI-A-1-linear
[352.648342] Dynamic subtest pipe-A-HDMI-A-1-linear: SUCCESS (2.042s)
[352.756311] Starting dynamic subtest: pipe-B-HDMI-A-1-Y-RC_CCS
[352.892526] Dynamic subtest pipe-B-HDMI-A-1-Y-RC_CCS: SKIP (0.141s)
[352.899006] Starting dynamic subtest: pipe-B-HDMI-A-1-Y-RC_CCS-CC
[352.991966] Dynamic subtest pipe-B-HDMI-A-1-Y-RC_CCS-CC: SKIP (0.099s)
[352.999052] Starting dynamic subtest: pipe-B-HDMI-A-1-Y
[355.060753] Dynamic subtest pipe-B-HDMI-A-1-Y: SUCCESS (2.069s)
[355.067668] Starting dynamic subtest: pipe-B-HDMI-A-1-X
[357.094442] Dynamic subtest pipe-B-HDMI-A-1-X: SUCCESS (2.033s)
[357.100463] Starting dynamic subtest: pipe-B-HDMI-A-1-linear
[359.119718] Dynamic subtest pipe-B-HDMI-A-1-linear: SUCCESS (2.025s)
[359.224876] Starting dynamic subtest: pipe-C-HDMI-A-1-Y-RC_CCS
[359.353621] Dynamic subtest pipe-C-HDMI-A-1-Y-RC_CCS: SKIP (0.133s)
[359.359971] Starting dynamic subtest: pipe-C-HDMI-A-1-Y-RC_CCS-CC
[359.452597] Dynamic subtest pipe-C-HDMI-A-1-Y-RC_CCS-CC: SKIP (0.098s)
[359.460067] Starting dynamic subtest: pipe-C-HDMI-A-1-Y
[361.530410] Dynamic subtest pipe-C-HDMI-A-1-Y: SUCCESS (2.078s)
[361.543042] Starting dynamic subtest: pipe-C-HDMI-A-1-X
[363.563021] Dynamic subtest pipe-C-HDMI-A-1-X: SUCCESS (2.032s)
[363.568741] Starting dynamic subtest: pipe-C-HDMI-A-1-linear
[365.588385] Dynamic subtest pipe-C-HDMI-A-1-linear: SUCCESS (2.025s)
[365.689114] Starting dynamic subtest: pipe-D-HDMI-A-1-Y-RC_CCS
[365.845220] Dynamic subtest pipe-D-HDMI-A-1-Y-RC_CCS: SKIP (0.160s)
[365.852612] Starting dynamic subtest: pipe-D-HDMI-A-1-Y-RC_CCS-CC
[365.943784] Dynamic subtest pipe-D-HDMI-A-1-Y-RC_CCS-CC: SKIP (0.098s)
[365.951358] Starting dynamic subtest: pipe-D-HDMI-A-1-Y
[368.021405] Dynamic subtest pipe-D-HDMI-A-1-Y: SUCCESS (2.078s)
[368.028435] Starting dynamic subtest: pipe-D-HDMI-A-1-X
[370.054984] Dynamic subtest pipe-D-HDMI-A-1-X: SUCCESS (2.033s)
[370.061575] Starting dynamic subtest: pipe-D-HDMI-A-1-linear
[372.080437] Dynamic subtest pipe-D-HDMI-A-1-linear: SUCCESS (2.025s)
[372.081208] Subtest async-flip-with-page-flip-events: SUCCESS (25.922s)
[372.255246] [123/142] (657s left) vc4/vc4_purgeable_bo (access-purgeable-bo-mem)
[372.307734] Subtest access-purgeable-bo-mem: SKIP (0.000s)
[372.339320] [124/142] (657s left) kms_flip (2x-flip-vs-panning-vs-hang)
[372.407312] Starting subtest: 2x-flip-vs-panning-vs-hang
[372.418772] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.012s)
[372.464392] [125/142] (657s left) kms_pm_backlight (bad-brightness)
[372.550010] Subtest bad-brightness: SKIP (0.000s)
[372.574070] [126/142] (657s left) kms_ccs (pipe-a-bad-pixel-format-y_tiled_ccs)
[372.663218] Starting subtest: pipe-A-bad-pixel-format-y_tiled_ccs
[372.664601] Subtest pipe-A-bad-pixel-format-y_tiled_ccs: SKIP (0.000s)
[372.885482] [127/142] (657s left) syncobj_timeline (signal-point-0)
[372.923613] Starting subtest: signal-point-0
[372.924384] Subtest signal-point-0: SUCCESS (0.000s)
[372.966331] [128/142] (657s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[373.064156] Starting subtest: y-tiled-32bpp-rotate-0
[374.054331] Subtest y-tiled-32bpp-rotate-0: SUCCESS (0.990s)
[374.188168] [129/142] (655s left) kms_ccs (pipe-a-missing-ccs-buffer-y_tiled_ccs)
[374.349106] Starting subtest: pipe-A-missing-ccs-buffer-y_tiled_ccs
[374.350516] Subtest pipe-A-missing-ccs-buffer-y_tiled_ccs: SKIP (0.000s)
[374.511032] [130/142] (655s left) api_intel_bb (intel-bb-blit-none)
[374.545401] Starting subtest: intel-bb-blit-none
[377.671206] Subtest intel-bb-blit-none: SUCCESS (3.126s)
[377.743489] [131/142] (652s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[377.781278] Starting subtest: invalid-single-wait-all-unsubmitted
[377.782055] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[377.825734] [132/142] (652s left) i915_query (query-regions-unallocated)
[377.865038] Starting subtest: query-regions-unallocated
[377.865818] Subtest query-regions-unallocated: SUCCESS (0.000s)
[377.908865] [133/142] (652s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[378.003628] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[378.005105] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[378.071429] [134/142] (652s left) gem_busy (semaphore)
[378.244073] Starting subtest: semaphore
[378.245229] Starting dynamic subtest: rcs0
[378.272513] Dynamic subtest rcs0: SUCCESS (0.028s)
[378.284423] Starting dynamic subtest: bcs0
[378.287504] Dynamic subtest bcs0: SUCCESS (0.014s)
[378.296601] Starting dynamic subtest: vcs0
[378.303281] Dynamic subtest vcs0: SUCCESS (0.015s)
[378.311182] Starting dynamic subtest: vcs1
[378.317216] Dynamic subtest vcs1: SUCCESS (0.013s)
[378.324485] Starting dynamic subtest: vecs0
[378.332257] Dynamic subtest vecs0: SUCCESS (0.014s)
[378.333137] Subtest semaphore: SUCCESS (0.089s)
[378.519336] [135/142] (651s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_mtl_rc_ccs_cc)
[378.689692] Starting subtest: pipe-B-bad-pixel-format-4_tiled_mtl_rc_ccs_cc
[378.691817] Subtest pipe-B-bad-pixel-format-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[378.834882] [136/142] (651s left) gen9_exec_parse (bb-start-far)
[378.873791] Subtest bb-start-far: SKIP (0.000s)
[378.894956] [137/142] (651s left) kms_plane (plane-panning-bottom-right)
[378.980511] Starting subtest: plane-panning-bottom-right
[378.982314] Starting dynamic subtest: pipe-A-planes
[379.314657] Dynamic subtest pipe-A-planes: SUCCESS (0.333s)
[379.321628] Starting dynamic subtest: pipe-B-planes
[379.635893] Dynamic subtest pipe-B-planes: SUCCESS (0.319s)
[379.636675] Subtest plane-panning-bottom-right: SUCCESS (0.655s)
[379.726547] [138/142] (650s left) gem_exec_params (dr4-dirt)
[379.764134] Starting subtest: DR4-dirt
[379.764924] Subtest DR4-dirt: SUCCESS (0.000s)
[379.814159] [139/142] (650s left) gem_madvise (dontneed-after-mmap)
[379.852090] Starting subtest: dontneed-after-mmap
[379.855921] Subtest dontneed-after-mmap: SUCCESS (0.004s)
[379.928312] [140/142] (650s left) kms_color (ctm-green-to-red)
[380.015450] Starting subtest: ctm-green-to-red
[380.016162] Starting dynamic subtest: pipe-A
[380.324154] Dynamic subtest pipe-A: SUCCESS (0.308s)
[380.330744] Starting dynamic subtest: pipe-B
[380.587018] Dynamic subtest pipe-B: SUCCESS (0.263s)
[380.593431] Starting dynamic subtest: pipe-C
[380.845979] Dynamic subtest pipe-C: SUCCESS (0.258s)
[380.852312] Starting dynamic subtest: pipe-D
[381.113097] Dynamic subtest pipe-D: SUCCESS (0.266s)
[381.113835] Subtest ctm-green-to-red: SUCCESS (1.099s)
[381.216723] [141/142] (649s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[381.305473] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[381.308418] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[381.347491] [142/142] (648s left) kms_ccs (pipe-c-bad-rotation-90-y_tiled_gen12_rc_ccs_cc)
[381.534045] Starting subtest: pipe-C-bad-rotation-90-y_tiled_gen12_rc_ccs_cc
[381.599342] Subtest pipe-C-bad-rotation-90-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.065s)
[381.787888] Closing watchdogs
Done.