[57.462135] Initializing watchdogs
[57.462183]   /dev/watchdog0
[57.469854] [001/130] (960s left) prime_self_import (basic-llseek-bad)
[57.507336] Starting subtest: basic-llseek-bad
[57.529753] Subtest basic-llseek-bad: SUCCESS (0.022s)
[57.620278] [002/130] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[57.726531] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[57.730965] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[57.814551] [003/130] (960s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[57.923378] Starting subtest: psr-rgb101010-draw-mmap-cpu
[62.749192] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (4.829s)
[62.839931] [004/130] (955s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[62.960992] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[62.965271] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[63.058905] [005/130] (954s left) perf (blocking)
[63.184610] Starting subtest: blocking
[63.186560] Starting dynamic subtest: 0-rcs0
[73.197357] Dynamic subtest 0-rcs0: SUCCESS (10.011s)
[73.204308] Starting dynamic subtest: 1-vecs0
[83.217365] Dynamic subtest 1-vecs0: SUCCESS (10.020s)
[83.220091] Subtest blocking: SUCCESS (20.031s)
[83.243858] [006/130] (934s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[83.334120] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[83.336893] Starting dynamic subtest: pipe-A-eDP-1
[83.361234] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[83.371102] Starting dynamic subtest: pipe-B-eDP-1
[83.392928] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[83.399467] Starting dynamic subtest: pipe-C-eDP-1
[83.421305] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[83.427300] Starting dynamic subtest: pipe-D-eDP-1
[83.449245] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[83.453532] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.002s)
[85.486359] [007/130] (932s left) gem_exec_whisper (basic-contexts-priority-all)
[85.558045] Starting subtest: basic-contexts-priority-all
[107.672179] Subtest basic-contexts-priority-all: SUCCESS (22.108s)
[107.837799] [008/130] (910s left) kms_psr (psr-sprite-plane-onoff)
[107.940975] Starting subtest: psr-sprite-plane-onoff
[107.943377] Starting dynamic subtest: eDP-1
[109.634874] Dynamic subtest eDP-1: SUCCESS (1.691s)
[109.637674] Subtest psr-sprite-plane-onoff: SUCCESS (1.692s)
[110.431551] [009/130] (907s left) kms_psr (psr-cursor-blt)
[110.531991] Starting subtest: psr-cursor-blt
[110.534385] Starting dynamic subtest: eDP-1
[112.240083] Dynamic subtest eDP-1: SUCCESS (1.705s)
[112.242480] Subtest psr-cursor-blt: SUCCESS (1.706s)
[113.079467] [010/130] (905s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[113.177990] Starting subtest: 2x-plain-flip-ts-check-interruptible
[113.190993] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s)
[113.244690] [011/130] (904s left) gem_softpin (noreloc-interruptible)
[113.317725] Starting subtest: noreloc-interruptible
[118.745085] Subtest noreloc-interruptible: SUCCESS (5.425s)
[118.863724] [012/130] (899s left) kms_rotation_crc (cursor-rotation-180)
[118.970960] Starting subtest: cursor-rotation-180
[120.438534] Subtest cursor-rotation-180: SUCCESS (1.466s)
[121.624530] [013/130] (896s left) kms_legacy_colorkey (invalid-plane)
[121.730890] Starting subtest: invalid-plane
[121.733212] Starting dynamic subtest: zero-id
[121.735104] Dynamic subtest zero-id: SUCCESS (0.000s)
[121.742089] Starting dynamic subtest: outrange-id
[121.744605] Dynamic subtest outrange-id: SUCCESS (0.000s)
[121.746967] Subtest invalid-plane: SUCCESS (0.000s)
[121.783290] [014/130] (896s left) gem_exec_params (no-blt)
[121.850062] Starting subtest: no-blt
[121.852315] Subtest no-blt: SUCCESS (0.002s)
[121.933176] [015/130] (896s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[121.990426] Starting subtest: yf-tiled-to-vebox-yf-tiled
[121.995034] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[122.147548] [016/130] (896s left) sw_sync (sync_random_merge)
[122.180893] Starting subtest: sync_random_merge
[122.219991] Subtest sync_random_merge: SUCCESS (0.041s)
[122.258168] [017/130] (896s left) kms_cursor_crc (cursor-sliding-max-size)
[122.532069] Starting subtest: cursor-sliding-max-size
[122.538923] Subtest cursor-sliding-max-size: SKIP (0.000s)
[122.637238] [018/130] (895s left) i915_pm_rpm (gem-evict-pwrite)
[124.193048] Starting subtest: gem-evict-pwrite
[124.198100] Subtest gem-evict-pwrite: SKIP (0.000s)
[124.861769] [019/130] (893s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[124.963014] Starting subtest: fbc-pr-sprite-mmap-gtt
[124.967655] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[125.014171] [020/130] (893s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[125.123460] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[125.127600] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[125.202634] [021/130] (893s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[125.307388] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[125.311717] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[125.383209] [022/130] (892s left) core_setmaster (master-drop-set-user)
[127.449384] Starting subtest: master-drop-set-user
[127.465264] Subtest master-drop-set-user: SUCCESS (0.017s)
[127.479318] [023/130] (890s left) syncobj_wait (invalid-signal-zero-handles)
[127.531055] Starting subtest: invalid-signal-zero-handles
[127.533448] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[127.592134] [024/130] (890s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[127.719309] Starting subtest: short-flip-after-cursor-atomic-transitions
[128.678479] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.958s)
[129.473994] [025/130] (888s left) gen7_exec_parse (bitmasks)
[129.542605] Subtest bitmasks: SKIP (0.000s)
[129.596793] [026/130] (888s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[129.701268] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[134.256359] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.559s)
[134.360272] [027/130] (884s left) gem_mmap (big-bo)
[134.451648] Subtest big-bo: SKIP (0.000s)
[134.488535] [028/130] (883s left) kms_cursor_crc (cursor-offscreen-512x512)
[134.731405] Starting subtest: cursor-offscreen-512x512
[134.736159] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[134.856804] [029/130] (883s left) gem_ctx_persistence (engines-cleanup)
[134.916455] Starting subtest: engines-cleanup
[134.918908] Starting dynamic subtest: rcs0
[135.022235] Dynamic subtest rcs0: SUCCESS (0.105s)
[135.033528] Starting dynamic subtest: bcs0
[135.081748] Dynamic subtest bcs0: SUCCESS (0.060s)
[135.092577] Starting dynamic subtest: vcs0
[135.110410] Dynamic subtest vcs0: SUCCESS (0.028s)
[135.117789] Starting dynamic subtest: vcs1
[135.182629] Dynamic subtest vcs1: SUCCESS (0.072s)
[135.191648] Starting dynamic subtest: vecs0
[135.236476] Dynamic subtest vecs0: SUCCESS (0.053s)
[135.245346] Starting dynamic subtest: ccs0
[135.309487] Dynamic subtest ccs0: SUCCESS (0.073s)
[135.311749] Subtest engines-cleanup: SUCCESS (0.393s)
[135.367367] [030/130] (883s left) syncobj_timeline (wait-delayed-signal)
[135.429247] Starting subtest: wait-delayed-signal
[135.535057] Subtest wait-delayed-signal: SUCCESS (0.103s)
[135.587181] [031/130] (882s left) kms_big_fb (y-tiled-addfb)
[135.703567] Starting subtest: y-tiled-addfb
[135.707688] Subtest y-tiled-addfb: SKIP (0.000s)
[135.785050] [032/130] (882s left) kms_writeback (writeback-fb-id-xrgb2101010)
[135.887061] Subtest writeback-fb-id-XRGB2101010: SKIP (0.000s)
[135.911359] [033/130] (882s left) kms_plane_scaling (planes-upscale-factor-0-25)
[136.010066] Starting subtest: planes-upscale-factor-0-25
[136.012340] Starting dynamic subtest: pipe-A
[136.073608] Dynamic subtest pipe-A: SUCCESS (0.063s)
[136.082741] Starting dynamic subtest: pipe-B
[137.163955] Dynamic subtest pipe-B: SUCCESS (1.090s)
[137.174644] Starting dynamic subtest: pipe-C
[138.263734] Dynamic subtest pipe-C: SUCCESS (1.099s)
[138.272112] Starting dynamic subtest: pipe-D
[139.391369] Dynamic subtest pipe-D: SUCCESS (1.127s)
[139.393887] Subtest planes-upscale-factor-0-25: SUCCESS (3.381s)
[140.521831] [034/130] (878s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[140.625564] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[140.639165] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s)
[140.694024] [035/130] (877s left) gem_exec_schedule (u-submit-golden-slice)
[140.772931] Starting subtest: u-submit-golden-slice
[140.775274] Starting dynamic subtest: rcs0
[140.798589] Dynamic subtest rcs0: SUCCESS (0.033s)
[140.808524] Starting dynamic subtest: bcs0
[140.824456] Dynamic subtest bcs0: SUCCESS (0.026s)
[140.834559] Starting dynamic subtest: vcs0
[140.858098] Dynamic subtest vcs0: SUCCESS (0.033s)
[140.866409] Starting dynamic subtest: vcs1
[140.885986] Dynamic subtest vcs1: SUCCESS (0.028s)
[140.896754] Starting dynamic subtest: vecs0
[140.916346] Dynamic subtest vecs0: SUCCESS (0.030s)
[140.924415] Starting dynamic subtest: ccs0
[140.947641] Dynamic subtest ccs0: SUCCESS (0.031s)
[140.949983] Subtest u-submit-golden-slice: SUCCESS (0.182s)
[142.013714] [036/130] (876s left) kms_feature_discovery (dp-mst)
[142.127093] Starting subtest: dp-mst
[142.131329] Subtest dp-mst: SKIP (0.000s)
[142.176708] [037/130] (876s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[142.240279] Starting subtest: etime-single-wait-for-submit-submitted
[142.340931] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.102s)
[142.396748] [038/130] (876s left) gem_basic (bad-close)
[142.448043] Starting subtest: bad-close
[142.452465] Subtest bad-close: SUCCESS (0.000s)
[142.520736] [039/130] (876s left) gem_exec_capture (capture)
[142.583142] Starting subtest: capture
[142.585569] Starting dynamic subtest: rcs0-smem
[143.417078] Dynamic subtest rcs0-smem: SUCCESS (0.834s)
[143.426776] Starting dynamic subtest: bcs0-smem
[144.746179] Dynamic subtest bcs0-smem: SUCCESS (1.329s)
[144.752886] Starting dynamic subtest: vcs0-smem
[145.571072] Dynamic subtest vcs0-smem: SUCCESS (0.825s)
[145.577581] Starting dynamic subtest: vcs1-smem
[146.892230] Dynamic subtest vcs1-smem: SUCCESS (1.320s)
[146.901162] Starting dynamic subtest: vecs0-smem
[147.784165] Dynamic subtest vecs0-smem: FAIL (0.836s)
[147.793207] Starting dynamic subtest: ccs0-smem
[149.047213] Dynamic subtest ccs0-smem: SUCCESS (1.320s)
[149.049290] Subtest capture: FAIL (6.464s)
[149.153030] [040/130] (869s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[149.261059] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[149.272914] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[149.332261] [041/130] (869s left) syncobj_eventfd (invalid-bad-pad)
[149.391871] Starting subtest: invalid-bad-pad
[149.394278] Subtest invalid-bad-pad: SUCCESS (0.000s)
[149.467241] [042/130] (869s left) gem_exec_schedule (smoketest-all)
[149.545959] Starting subtest: smoketest-all
[181.929344] Subtest smoketest-all: SUCCESS (32.332s)
[182.979502] [043/130] (835s left) gem_workarounds (suspend-resume)
[183.056487] Starting subtest: suspend-resume
[198.912152] Subtest suspend-resume: SUCCESS (1.230s)
[199.032218] [044/130] (834s left) drm_fdinfo (virtual-busy-all)
[199.072487] Starting subtest: virtual-busy-all
[199.076609] Subtest virtual-busy-all: SKIP (0.000s)
[199.118031] [045/130] (834s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[204.105938] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[204.111044] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.003s)
[204.938210] [046/130] (828s left) kms_async_flips (test-cursor-atomic)
[205.033030] Starting subtest: test-cursor-atomic
[205.037675] Subtest test-cursor-atomic: SKIP (0.000s)
[206.160459] [047/130] (827s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[206.266650] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[206.270901] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[206.357349] [048/130] (827s left) kms_pm_backlight (bad-brightness)
[206.457324] Starting subtest: bad-brightness
[206.502965] Starting dynamic subtest: eDP-1
[206.823913] Dynamic subtest eDP-1: SUCCESS (0.319s)
[206.826187] Subtest bad-brightness: SUCCESS (0.368s)
[207.592961] [049/130] (825s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-pwrite)
[207.698946] Starting subtest: psr-1p-offscren-pri-shrfb-draw-pwrite
[214.732568] Subtest psr-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (7.031s)
[214.846710] [050/130] (818s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[214.954619] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[220.416379] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.462s)
[220.505600] [051/130] (813s left) kms_force_connector_basic (force-connector-state)
[220.589358] Starting subtest: force-connector-state
[221.199584] Subtest force-connector-state: SUCCESS (0.610s)
[222.138148] [052/130] (811s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[222.228908] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[222.231289] Starting dynamic subtest: pipe-A-eDP-1
[222.255607] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[222.264961] Starting dynamic subtest: pipe-B-eDP-1
[222.288293] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[222.296298] Starting dynamic subtest: pipe-C-eDP-1
[222.319883] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[222.328180] Starting dynamic subtest: pipe-D-eDP-1
[222.354224] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[222.358541] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[224.425163] [053/130] (809s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[224.516935] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[224.519140] Starting dynamic subtest: pipe-A-eDP-1
[224.544809] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.025s)
[224.553869] Starting dynamic subtest: pipe-B-eDP-1
[224.573112] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.023s)
[224.581260] Starting dynamic subtest: pipe-C-eDP-1
[224.601084] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.023s)
[224.609069] Starting dynamic subtest: pipe-D-eDP-1
[224.629794] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.023s)
[224.632228] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.097s)
[226.831147] [054/130] (806s left) kms_hdr (bpc-switch)
[226.925912] Starting subtest: bpc-switch
[227.991741] Starting dynamic subtest: pipe-A-eDP-1
[231.390005] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.398s)
[231.392563] Subtest bpc-switch: SUCCESS (4.463s)
[231.505474] [055/130] (802s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[231.615961] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[232.614269] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.000s)
[232.706788] [056/130] (800s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[232.821254] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[233.422815] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.603s)
[233.584616] [057/130] (800s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[233.693760] Starting subtest: yf-tiled-32bpp-rotate-90
[233.697885] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[233.777348] [058/130] (799s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[233.882710] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[233.885236] Starting dynamic subtest: pipe-A-default-mode
[234.237498] Dynamic subtest pipe-A-default-mode: SKIP (0.351s)
[234.241919] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.352s)
[234.933179] [059/130] (798s left) gem_exec_schedule (preempt-user)
[235.013106] Starting subtest: preempt-user
[235.015561] Starting dynamic subtest: rcs0
[235.026225] Dynamic subtest rcs0: SUCCESS (0.022s)
[235.037208] Starting dynamic subtest: bcs0
[235.043288] Dynamic subtest bcs0: SUCCESS (0.017s)
[235.051544] Starting dynamic subtest: vcs0
[235.064073] Dynamic subtest vcs0: SUCCESS (0.020s)
[235.073397] Starting dynamic subtest: vcs1
[235.084223] Dynamic subtest vcs1: SUCCESS (0.020s)
[235.092500] Starting dynamic subtest: vecs0
[235.102594] Dynamic subtest vecs0: SUCCESS (0.018s)
[235.111097] Starting dynamic subtest: ccs0
[235.124279] Dynamic subtest ccs0: SUCCESS (0.021s)
[235.126538] Subtest preempt-user: SUCCESS (0.121s)
[236.638015] [060/130] (797s left) syncobj_wait (wait-for-submit-snapshot)
[236.701486] Starting subtest: wait-for-submit-snapshot
[236.782863] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[236.837634] [061/130] (796s left) api_intel_allocator (two-level-inception)
[236.901980] Starting subtest: two-level-inception
[242.316644] Subtest two-level-inception: SUCCESS (5.414s)
[242.420622] [062/130] (791s left) sw_sync (alloc_fence_invalid_timeline)
[242.458916] Starting subtest: alloc_fence_invalid_timeline
[242.461276] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[242.493694] [063/130] (791s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[247.526752] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[247.531238] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.003s)
[248.327142] [064/130] (785s left) gem_flink_basic (bad-flink)
[248.380448] Starting subtest: bad-flink
[248.382901] Subtest bad-flink: SUCCESS (0.000s)
[248.476723] [065/130] (785s left) gem_exec_balancer (invalid-balancer)
[248.552324] Starting subtest: invalid-balancer
[249.328744] Subtest invalid-balancer: SUCCESS (0.774s)
[249.589929] [066/130] (784s left) kms_plane (plane-position-hole)
[249.683774] Starting subtest: plane-position-hole
[250.176041] Starting dynamic subtest: pipe-A-plane-1
[251.472972] Dynamic subtest pipe-A-plane-1: SUCCESS (1.298s)
[251.481499] Starting dynamic subtest: pipe-A-plane-2
[252.773258] Dynamic subtest pipe-A-plane-2: SUCCESS (1.300s)
[252.782895] Starting dynamic subtest: pipe-A-plane-3
[254.078212] Dynamic subtest pipe-A-plane-3: SUCCESS (1.301s)
[254.090373] Starting dynamic subtest: pipe-A-plane-4
[255.409670] Dynamic subtest pipe-A-plane-4: SUCCESS (1.332s)
[255.419725] Starting dynamic subtest: pipe-A-plane-5
[255.433068] Dynamic subtest pipe-A-plane-5: SUCCESS (0.021s)
[256.597385] Starting dynamic subtest: pipe-B-plane-1
[257.910098] Dynamic subtest pipe-B-plane-1: SUCCESS (1.323s)
[257.919616] Starting dynamic subtest: pipe-B-plane-2
[259.171468] Dynamic subtest pipe-B-plane-2: SUCCESS (1.261s)
[259.182204] Starting dynamic subtest: pipe-B-plane-3
[260.460371] Dynamic subtest pipe-B-plane-3: SUCCESS (1.287s)
[260.469710] Starting dynamic subtest: pipe-B-plane-4
[261.660435] Dynamic subtest pipe-B-plane-4: SUCCESS (1.200s)
[261.669619] Starting dynamic subtest: pipe-B-plane-5
[261.684896] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[261.687216] Subtest plane-position-hole: SUCCESS (11.997s)
[262.430875] [067/130] (771s left) gem_mmap (pf-nonblock)
[262.487276] Subtest pf-nonblock: SKIP (0.000s)
[262.527023] [068/130] (771s left) gem_exec_fence (syncobj-unused-fence)
[263.016640] Starting subtest: syncobj-unused-fence
[263.021867] Subtest syncobj-unused-fence: SUCCESS (0.004s)
[264.591224] [069/130] (769s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[264.686962] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[264.689325] Starting dynamic subtest: pipe-A-eDP-1
[264.764691] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.077s)
[264.773900] Starting dynamic subtest: pipe-B-eDP-1
[264.837330] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.071s)
[264.845894] Starting dynamic subtest: pipe-C-eDP-1
[264.912295] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.073s)
[264.921730] Starting dynamic subtest: pipe-D-eDP-1
[264.985658] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.072s)
[264.987981] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.299s)
[267.230021] [070/130] (766s left) fbdev (read)
[267.280242] Starting subtest: read
[267.988220] Subtest read: SUCCESS (0.705s)
[268.032662] [071/130] (765s left) prime_mmap (test_forked)
[268.093427] Starting subtest: test_forked
[268.095480] Starting dynamic subtest: test_forked-smem
[268.138595] Dynamic subtest test_forked-smem: SUCCESS (0.047s)
[268.141160] Subtest test_forked: SUCCESS (0.048s)
[268.231706] [072/130] (765s left) gem_exec_schedule (fifo)
[268.305277] Starting subtest: fifo
[268.307321] Starting dynamic subtest: rcs0
[268.406526] Dynamic subtest rcs0: SUCCESS (0.109s)
[268.415555] Starting dynamic subtest: vcs0
[268.488206] Dynamic subtest vcs0: SUCCESS (0.080s)
[268.499163] Starting dynamic subtest: vcs1
[268.559333] Dynamic subtest vcs1: SUCCESS (0.071s)
[268.570651] Starting dynamic subtest: vecs0
[268.631728] Dynamic subtest vecs0: SUCCESS (0.072s)
[268.642936] Starting dynamic subtest: ccs0
[268.710538] Dynamic subtest ccs0: SUCCESS (0.078s)
[268.713522] Subtest fifo: SUCCESS (0.413s)
[269.651146] [073/130] (764s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[269.843454] Starting subtest: cursor-rapid-movement-128x128
[269.848384] Starting dynamic subtest: pipe-A-eDP-1
[270.375990] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.528s)
[270.398911] Starting dynamic subtest: pipe-D-eDP-1
[271.619785] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.224s)
[271.621901] Subtest cursor-rapid-movement-128x128: SUCCESS (1.774s)
[272.430982] [074/130] (761s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[272.527133] Starting subtest: coverage-vs-premult-vs-constant
[272.794313] Starting dynamic subtest: pipe-A-eDP-1
[273.347537] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.551s)
[273.357044] Starting dynamic subtest: pipe-D-eDP-1
[274.633346] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.284s)
[274.635896] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.105s)
[275.428057] [075/130] (758s left) gem_userptr_blits (coherency-unsync)
[275.499738] Subtest coherency-unsync: SKIP (0.000s)
[275.624798] [076/130] (758s left) kms_vblank (wait-busy)
[275.713957] Starting subtest: wait-busy
[275.716180] Starting dynamic subtest: pipe-A-eDP-1
[277.591098] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[277.605687] Starting dynamic subtest: pipe-D-eDP-1
[280.174144] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.581s)
[280.176475] Subtest wait-busy: SUCCESS (4.459s)
[281.029245] [077/130] (753s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-blt)
[281.130789] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-blt
[285.873125] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-blt: SUCCESS (4.745s)
[285.966508] [078/130] (748s left) sw_sync (sync_merge_invalid)
[286.004799] Starting subtest: sync_merge_invalid
[286.017939] Subtest sync_merge_invalid: SUCCESS (0.014s)
[286.064730] [079/130] (748s left) gem_fence_thrash (bo-write-verify-threaded-y)
[286.099945] Starting subtest: bo-write-verify-threaded-y
[286.129168] Subtest bo-write-verify-threaded-y: SKIP (0.032s)
[286.179179] [080/130] (747s left) syncobj_wait (wait-all-for-submit-complex)
[286.241264] Starting subtest: wait-all-for-submit-complex
[286.455012] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[286.508404] [081/130] (747s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[286.564371] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[286.566561] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[286.632965] [082/130] (747s left) syncobj_timeline (multi-wait-submitted-signaled)
[286.682647] Starting subtest: multi-wait-submitted-signaled
[286.684900] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[286.764317] [083/130] (747s left) gem_exec_fence (basic-busy-all)
[286.821535] Starting subtest: basic-busy-all
[286.921180] Subtest basic-busy-all: SUCCESS (0.100s)
[288.639234] [084/130] (745s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[288.735205] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[288.737548] Starting dynamic subtest: pipe-A-default-mode
[289.022125] Dynamic subtest pipe-A-default-mode: SKIP (0.283s)
[289.026810] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.284s)
[289.828519] [085/130] (744s left) gem_ctx_isolation (clean)
[289.886403] Starting subtest: clean
[289.888877] Starting dynamic subtest: rcs0
[289.951082] Dynamic subtest rcs0: SUCCESS (0.064s)
[289.962131] Starting dynamic subtest: bcs0
[290.038047] Dynamic subtest bcs0: SUCCESS (0.086s)
[290.048644] Starting dynamic subtest: vcs0
[290.103327] Dynamic subtest vcs0: SUCCESS (0.064s)
[290.114237] Starting dynamic subtest: vcs1
[291.529958] Dynamic subtest vcs1: SUCCESS (1.426s)
[291.538576] Starting dynamic subtest: vecs0
[293.620735] Dynamic subtest vecs0: SUCCESS (2.090s)
[293.629130] Starting dynamic subtest: ccs0
[295.562265] Dynamic subtest ccs0: SUCCESS (1.941s)
[295.564521] Subtest clean: SUCCESS (5.676s)
[295.768811] [086/130] (738s left) kms_pm_rpm (universal-planes-dpms)
[297.698976] Starting subtest: universal-planes-dpms
[297.701795] Starting dynamic subtest: plane-32
[305.986863] Dynamic subtest plane-32: SUCCESS (8.289s)
[305.998110] Starting dynamic subtest: plane-41
[314.262218] Dynamic subtest plane-41: SUCCESS (8.274s)
[314.273259] Starting dynamic subtest: plane-50
[322.959551] Dynamic subtest plane-50: SUCCESS (8.696s)
[322.971345] Starting dynamic subtest: plane-59
[331.228334] Dynamic subtest plane-59: SUCCESS (8.267s)
[331.239743] Starting dynamic subtest: plane-68
[339.501495] Dynamic subtest plane-68: SUCCESS (8.267s)
[339.512441] Starting dynamic subtest: plane-77
[348.089271] Dynamic subtest plane-77: SUCCESS (8.590s)
[348.091888] Subtest universal-planes-dpms: SUCCESS (50.396s)
[348.432354] [087/130] (685s left) gem_render_copy (yf-tiled)
[348.488888] Starting subtest: yf-tiled
[348.493578] Subtest yf-tiled: SKIP (0.000s)
[348.653331] [088/130] (685s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[348.754074] Starting subtest: fbc-psr2-sprite-mmap-gtt
[348.756418] Starting dynamic subtest: eDP-1
[348.760806] Dynamic subtest eDP-1: SKIP (0.000s)
[348.765243] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[348.814487] [089/130] (685s left) kms_content_protection (lic-type-1)
[348.951591] Starting subtest: lic-type-1
[352.287757] Subtest lic-type-1: SKIP (3.334s)
[353.517607] [090/130] (680s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[353.625882] Starting subtest: fbcpsr-rgb101010-draw-blt
[358.286885] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (4.664s)
[358.389970] [091/130] (675s left) kms_chamelium_color (ctm-0-25)
[358.491168] Subtest ctm-0-25: SKIP (0.000s)
[358.517025] [092/130] (675s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[358.632369] Starting subtest: invalid-modeset-force-ultra-joiner
[358.636674] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[358.676072] [093/130] (675s left) gem_mmap_wc (read-write)
[358.745763] Subtest read-write: SKIP (0.000s)
[358.788286] [094/130] (675s left) gem_exec_reloc (basic-cpu-gtt-active)
[358.840614] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[358.904150] [095/130] (675s left) gem_ctx_shared (disjoint-timelines)
[358.962310] Starting subtest: disjoint-timelines
[358.979020] Subtest disjoint-timelines: SUCCESS (0.017s)
[359.210981] [096/130] (675s left) dmabuf_sync_file (import-basic)
[359.251250] Starting subtest: import-basic
[359.253536] Subtest import-basic: SUCCESS (0.002s)
[359.286164] [097/130] (675s left) gem_pxp (create-regular-context-1)
[359.410684] Starting subtest: create-regular-context-1
[359.412982] Subtest create-regular-context-1: SUCCESS (0.001s)
[360.511494] [098/130] (673s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[365.501492] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[365.504095] Starting dynamic subtest: pipe-A-eDP-1
[371.984579] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.481s)
[371.993877] Starting dynamic subtest: pipe-B-eDP-1
[378.485777] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.497s)
[378.488286] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.982s)
[379.314452] [099/130] (655s left) kms_display_modes (extended-mode-basic)
[379.422020] Starting subtest: extended-mode-basic
[379.426624] Subtest extended-mode-basic: SKIP (0.000s)
[379.452353] [100/130] (655s left) kms_psr (pr-primary-mmap-cpu)
[379.546980] Starting subtest: pr-primary-mmap-cpu
[379.551505] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[379.600346] [101/130] (654s left) gem_mmap_gtt (flink-race)
[379.663380] Subtest flink-race: SKIP (0.000s)
[379.708712] [102/130] (654s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[379.813090] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[379.817180] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[379.898811] [103/130] (654s left) gem_mmap_gtt (basic-copy)
[379.953731] Subtest basic-copy: SKIP (0.000s)
[380.009174] [104/130] (654s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[380.118597] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[380.122649] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[380.195436] [105/130] (654s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[380.253038] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[380.255356] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[380.348654] [106/130] (654s left) kms_selftest (drm_plane_helper)
[380.382172] Starting subtest: drm_plane_helper
[380.395723] Starting dynamic subtest: drm_test_check_plane_state
[380.535814] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.140s)
[380.545529] Starting dynamic subtest: drm_test_check_invalid_plane_state
[380.653635] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.114s)
[380.655920] Subtest drm_plane_helper: SUCCESS (0.269s)
[380.817754] [107/130] (653s left) template (b)
[380.876692] Starting subtest: B
[380.878758] Subtest B: SUCCESS (0.000s)
[380.958004] [108/130] (653s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[381.050003] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[386.175888] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (5.129s)
[386.280924] [109/130] (648s left) kms_chamelium_frames (dp-crc-fast)
[386.681597] Subtest dp-crc-fast: SKIP (0.000s)
[387.493868] [110/130] (647s left) perf_pmu (gt-awake)
[387.535963] Starting subtest: gt-awake
[396.554054] Subtest gt-awake: SUCCESS (9.016s)
[396.650806] [111/130] (638s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[396.703346] Starting subtest: multi-wait-for-submit-submitted-signaled
[396.705694] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[396.786913] [112/130] (637s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[396.887009] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[396.891039] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[396.965540] [113/130] (637s left) i915_hangman (engine-engine-error)
[397.025224] Starting subtest: engine-engine-error
[397.027111] Starting dynamic subtest: rcs0
[398.505075] Dynamic subtest rcs0: SUCCESS (1.479s)
[398.517715] Starting dynamic subtest: bcs0
[400.549740] Dynamic subtest bcs0: SUCCESS (2.044s)
[400.564774] Starting dynamic subtest: vcs0
[402.534776] Dynamic subtest vcs0: SUCCESS (1.982s)
[402.545028] Starting dynamic subtest: vcs1
[404.518050] Dynamic subtest vcs1: SUCCESS (1.981s)
[404.530353] Starting dynamic subtest: vecs0
[406.502192] Dynamic subtest vecs0: SUCCESS (1.982s)
[406.513995] Starting dynamic subtest: ccs0
[408.550890] Dynamic subtest ccs0: SUCCESS (2.046s)
[408.553768] Subtest engine-engine-error: SUCCESS (11.526s)
[408.665172] [114/130] (626s left) perf (polling-small-buf)
[408.758960] Starting subtest: polling-small-buf
[408.848905] Subtest polling-small-buf: SUCCESS (0.087s)
[408.878061] [115/130] (625s left) gem_exec_alignment (forked)
[408.948642] Starting subtest: forked
[445.323615] Subtest forked: SUCCESS (36.372s)
[445.378853] [116/130] (589s left) gen9_exec_parse (unaligned-jump)
[445.470547] Subtest unaligned-jump: SKIP (0.000s)
[445.527709] [117/130] (589s left) gem_exec_create (basic)
[445.587435] Starting subtest: basic
[445.589896] Starting dynamic subtest: smem
[449.544536] Dynamic subtest smem: SUCCESS (3.955s)
[449.547198] Subtest basic: SUCCESS (3.956s)
[449.713417] [118/130] (585s left) gem_lmem_swapping (smem-oom)
[449.762133] Subtest smem-oom: SKIP (0.000s)
[449.785954] [119/130] (585s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[449.889690] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[449.892065] Starting dynamic subtest: pipe-A-eDP-1
[451.945433] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.053s)
[451.954753] Starting dynamic subtest: pipe-B-eDP-1
[454.026707] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.080s)
[454.035945] Starting dynamic subtest: pipe-C-eDP-1
[456.005422] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.978s)
[456.015123] Starting dynamic subtest: pipe-D-eDP-1
[458.005820] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.998s)
[458.008127] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.114s)
[459.211740] [120/130] (575s left) gem_mmap_gtt (basic-small-copy-odd)
[459.274241] Subtest basic-small-copy-odd: SKIP (0.000s)
[459.311049] [121/130] (575s left) prime_vgem (basic-read)
[459.388982] Starting subtest: basic-read
[459.409303] Subtest basic-read: SKIP (0.018s)
[459.520010] [122/130] (575s left) i915_selftest (live)
[464.582867] Starting subtest: live
[464.585558] Starting dynamic subtest: sanitycheck
[469.146413] Dynamic subtest sanitycheck: SUCCESS (4.563s)
[469.155441] Starting dynamic subtest: uncore
[473.614948] Dynamic subtest uncore: SUCCESS (4.466s)
[473.624272] Starting dynamic subtest: workarounds
[476.863069] Dynamic subtest workarounds: SUCCESS (3.247s)
[476.872267] Starting dynamic subtest: gt_engines
[481.568493] Dynamic subtest gt_engines: SUCCESS (4.703s)
[481.578028] Starting dynamic subtest: gt_timelines
[495.926224] Dynamic subtest gt_timelines: SUCCESS (14.331s)
[495.937081] Starting dynamic subtest: gt_contexts
[500.332069] Dynamic subtest gt_contexts: SUCCESS (4.428s)
[500.341856] Starting dynamic subtest: gt_lrc
[506.670515] Dynamic subtest gt_lrc: SUCCESS (6.336s)
[506.680436] Starting dynamic subtest: gt_mocs
[511.352909] Dynamic subtest gt_mocs: SUCCESS (4.680s)
[511.360924] Starting dynamic subtest: gt_pm
[517.406007] Dynamic subtest gt_pm: SUCCESS (6.051s)
[517.415270] Starting dynamic subtest: gt_heartbeat
[521.800321] Dynamic subtest gt_heartbeat: SUCCESS (4.392s)
[521.809904] Starting dynamic subtest: gt_tlb
[530.059293] Dynamic subtest gt_tlb: SUCCESS (8.257s)
[530.068803] Starting dynamic subtest: requests
[543.622347] Dynamic subtest requests: SUCCESS (13.560s)
[543.636209] Starting dynamic subtest: migrate
[551.715036] Dynamic subtest migrate: SUCCESS (8.091s)
[551.724907] Starting dynamic subtest: active
[556.194280] Dynamic subtest active: SUCCESS (4.477s)
[556.203985] Starting dynamic subtest: objects
[560.939919] Dynamic subtest objects: SUCCESS (4.744s)
[560.949230] Starting dynamic subtest: mman
[564.427088] Dynamic subtest mman: SUCCESS (3.486s)
[564.436628] Starting dynamic subtest: dmabuf
[568.925771] Dynamic subtest dmabuf: SUCCESS (4.496s)
[568.935567] Starting dynamic subtest: vma
[573.365271] Dynamic subtest vma: SUCCESS (4.437s)
[573.375047] Starting dynamic subtest: coherency
[578.296336] Dynamic subtest coherency: SUCCESS (4.929s)
[578.310180] Starting dynamic subtest: gtt
[588.156663] Dynamic subtest gtt: SUCCESS (9.858s)
[588.171449] Starting dynamic subtest: gem
[596.490669] Dynamic subtest gem: SUCCESS (8.332s)
[596.500038] Starting dynamic subtest: evict
[601.996477] Dynamic subtest evict: SUCCESS (5.504s)
[602.010164] Starting dynamic subtest: hugepages
[611.069248] Dynamic subtest hugepages: SUCCESS (9.070s)
[611.078496] Starting dynamic subtest: gem_contexts
[638.538677] Dynamic subtest gem_contexts: SUCCESS (27.466s)
[638.548340] Starting dynamic subtest: client
[642.994888] Dynamic subtest client: SUCCESS (4.455s)
[643.004675] Starting dynamic subtest: gem_migrate
[647.528189] Dynamic subtest gem_migrate: SUCCESS (4.531s)
[647.538527] Starting dynamic subtest: reset
[650.424435] Dynamic subtest reset: SUCCESS (2.894s)
[650.434520] Starting dynamic subtest: memory_region
[654.962478] Dynamic subtest memory_region: SUCCESS (4.536s)
[654.972304] Starting dynamic subtest: hangcheck
[668.603403] Dynamic subtest hangcheck: SUCCESS (13.639s)
[668.612934] Starting dynamic subtest: execlists
[673.023822] Dynamic subtest execlists: SUCCESS (4.419s)
[673.038654] Starting dynamic subtest: ring_submission
[677.568447] Dynamic subtest ring_submission: SUCCESS (4.542s)
[677.578159] Starting dynamic subtest: perf
[682.067832] Dynamic subtest perf: SUCCESS (4.498s)
[682.076778] Starting dynamic subtest: slpc
[696.269296] Dynamic subtest slpc: SUCCESS (14.199s)
[696.278754] Starting dynamic subtest: guc
[700.153764] Dynamic subtest guc: SUCCESS (3.883s)
[700.162190] Starting dynamic subtest: guc_multi_lrc
[704.648143] Dynamic subtest guc_multi_lrc: SUCCESS (4.492s)
[704.657546] Starting dynamic subtest: guc_hang
[710.009152] Dynamic subtest guc_hang: SUCCESS (5.359s)
[710.019317] Starting dynamic subtest: late_gt_pm
[714.521189] Dynamic subtest late_gt_pm: SUCCESS (4.510s)
[714.524075] Subtest live: SUCCESS (249.925s)
[714.822920] [123/130] (320s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[718.320121] Starting subtest: plane-primary-overlay-mutable-zpos
[721.780304] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.456s)
[722.951502] [124/130] (312s left) gem_spin_batch (engines)
[723.025083] Starting subtest: engines
[723.027464] Starting dynamic subtest: rcs0
[726.266493] Dynamic subtest rcs0: SUCCESS (3.236s)
[726.277366] Starting dynamic subtest: bcs0
[729.500919] Dynamic subtest bcs0: SUCCESS (3.232s)
[729.512986] Starting dynamic subtest: vcs0
[732.737331] Dynamic subtest vcs0: SUCCESS (3.234s)
[732.748202] Starting dynamic subtest: vcs1
[735.968769] Dynamic subtest vcs1: SUCCESS (3.229s)
[735.977359] Starting dynamic subtest: vecs0
[739.202440] Dynamic subtest vecs0: SUCCESS (3.232s)
[739.211762] Starting dynamic subtest: ccs0
[742.437906] Dynamic subtest ccs0: SUCCESS (3.233s)
[742.439956] Subtest engines: SUCCESS (19.408s)
[742.601866] [125/130] (292s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[742.666548] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[742.668897] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s)
[742.763723] [126/130] (292s left) kms_color (degamma)
[742.874947] Starting subtest: degamma
[742.877206] Starting dynamic subtest: pipe-A-eDP-1
[743.558165] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.681s)
[743.566672] Starting dynamic subtest: pipe-B-eDP-1
[744.956382] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.398s)
[744.965739] Starting dynamic subtest: pipe-C-eDP-1
[746.303722] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.347s)
[746.313417] Starting dynamic subtest: pipe-D-eDP-1
[747.626906] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.322s)
[747.629346] Subtest degamma: SUCCESS (4.751s)
[748.447368] [127/130] (286s left) kms_flip (flip-vs-rmfb-interruptible)
[748.558048] Starting subtest: flip-vs-rmfb-interruptible
[748.560428] Starting dynamic subtest: A-eDP1
[757.160130] Dynamic subtest A-eDP1: SUCCESS (8.600s)
[757.170401] Starting dynamic subtest: B-eDP1
[765.788866] Dynamic subtest B-eDP1: SUCCESS (8.627s)
[765.802390] Starting dynamic subtest: C-eDP1
[774.409458] Dynamic subtest C-eDP1: SUCCESS (8.618s)
[774.421389] Starting dynamic subtest: D-eDP1
[783.036905] Dynamic subtest D-eDP1: SUCCESS (8.624s)
[783.041176] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.482s)
[784.186411] [128/130] (250s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[784.302199] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[785.037672] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.737s)
[785.171943] [129/130] (249s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[785.275664] Starting subtest: primary-y-tiled-reflect-x-90
[785.280297] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[785.333866] [130/130] (249s left) sw_sync (timeline_closed)
[785.367329] Starting subtest: timeline_closed
[785.369645] Subtest timeline_closed: SUCCESS (0.000s)
[785.403361] Closing watchdogs
Done.