[56.142331] Initializing watchdogs
[56.142380]   /dev/watchdog0
[56.149830] [001/130] (960s left) prime_self_import (basic-llseek-bad)
[56.192069] Starting subtest: basic-llseek-bad
[56.225751] Subtest basic-llseek-bad: SUCCESS (0.035s)
[56.328211] [002/130] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[56.435463] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[56.439760] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[56.532810] [003/130] (960s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[56.635868] Starting subtest: psr-rgb101010-draw-mmap-cpu
[61.451689] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (4.818s)
[61.519458] [004/130] (955s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[61.626988] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[61.631162] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[61.699687] [005/130] (955s left) perf (blocking)
[61.828604] Starting subtest: blocking
[61.830878] Starting dynamic subtest: 0-rcs0
[71.863017] Dynamic subtest 0-rcs0: SUCCESS (10.020s)
[71.871554] Starting dynamic subtest: 1-vcs1
[81.872421] Dynamic subtest 1-vcs1: SUCCESS (10.021s)
[81.875105] Subtest blocking: SUCCESS (20.042s)
[81.897201] [006/130] (934s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[81.990857] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[81.993240] Starting dynamic subtest: pipe-A-eDP-1
[82.016035] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[82.023803] Starting dynamic subtest: pipe-B-eDP-1
[82.044578] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[82.051279] Starting dynamic subtest: pipe-C-eDP-1
[82.073482] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[82.080770] Starting dynamic subtest: pipe-D-eDP-1
[82.102960] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[82.107108] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.002s)
[84.081161] [007/130] (932s left) gem_exec_whisper (basic-contexts-priority-all)
[84.157997] Starting subtest: basic-contexts-priority-all
[104.811387] Subtest basic-contexts-priority-all: SUCCESS (20.648s)
[104.978118] [008/130] (911s left) kms_psr (psr-sprite-plane-onoff)
[105.085958] Starting subtest: psr-sprite-plane-onoff
[105.088235] Starting dynamic subtest: eDP-1
[106.824723] Dynamic subtest eDP-1: SUCCESS (1.736s)
[106.827061] Subtest psr-sprite-plane-onoff: SUCCESS (1.736s)
[107.623118] [009/130] (909s left) kms_psr (psr-cursor-blt)
[107.724067] Starting subtest: psr-cursor-blt
[107.726497] Starting dynamic subtest: eDP-1
[109.440152] Dynamic subtest eDP-1: SUCCESS (1.712s)
[109.442212] Subtest psr-cursor-blt: SUCCESS (1.712s)
[110.284480] [010/130] (906s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[110.382698] Starting subtest: 2x-plain-flip-ts-check-interruptible
[110.395427] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s)
[110.449737] [011/130] (906s left) gem_softpin (noreloc-interruptible)
[110.517410] Starting subtest: noreloc-interruptible
[115.897854] Subtest noreloc-interruptible: SUCCESS (5.379s)
[116.000515] [012/130] (900s left) kms_rotation_crc (cursor-rotation-180)
[116.101513] Starting subtest: cursor-rotation-180
[117.548148] Subtest cursor-rotation-180: SUCCESS (1.446s)
[118.748209] [013/130] (898s left) kms_legacy_colorkey (invalid-plane)
[118.843110] Starting subtest: invalid-plane
[118.845311] Starting dynamic subtest: zero-id
[118.847286] Dynamic subtest zero-id: SUCCESS (0.000s)
[118.853887] Starting dynamic subtest: outrange-id
[118.855806] Dynamic subtest outrange-id: SUCCESS (0.000s)
[118.858090] Subtest invalid-plane: SUCCESS (0.000s)
[118.893804] [014/130] (897s left) gem_exec_params (no-blt)
[118.950759] Starting subtest: no-blt
[118.955434] Subtest no-blt: SUCCESS (0.004s)
[119.058145] [015/130] (897s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[119.122472] Starting subtest: yf-tiled-to-vebox-yf-tiled
[119.126814] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[119.284289] [016/130] (897s left) sw_sync (sync_random_merge)
[119.318165] Starting subtest: sync_random_merge
[119.356604] Subtest sync_random_merge: SUCCESS (0.040s)
[119.395265] [017/130] (897s left) kms_cursor_crc (cursor-sliding-max-size)
[119.667880] Starting subtest: cursor-sliding-max-size
[119.674702] Subtest cursor-sliding-max-size: SKIP (0.000s)
[119.789383] [018/130] (897s left) i915_pm_rpm (gem-evict-pwrite)
[122.047312] Starting subtest: gem-evict-pwrite
[122.052320] Subtest gem-evict-pwrite: SKIP (0.000s)
[122.377568] [019/130] (894s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[122.475058] Starting subtest: fbc-pr-sprite-mmap-gtt
[122.479668] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[122.526444] [020/130] (894s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[122.639079] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[122.643150] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[122.732404] [021/130] (894s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[122.839893] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[122.844236] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[122.912814] [022/130] (894s left) core_setmaster (master-drop-set-user)
[124.962623] Starting subtest: master-drop-set-user
[124.979715] Subtest master-drop-set-user: SUCCESS (0.018s)
[124.994872] [023/130] (892s left) syncobj_wait (invalid-signal-zero-handles)
[125.048867] Starting subtest: invalid-signal-zero-handles
[125.051282] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[125.118429] [024/130] (891s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[125.233894] Starting subtest: short-flip-after-cursor-atomic-transitions
[126.194236] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.959s)
[126.996965] [025/130] (890s left) gen7_exec_parse (bitmasks)
[127.062713] Subtest bitmasks: SKIP (0.000s)
[127.111503] [026/130] (889s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[127.212497] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[131.788498] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.578s)
[131.889931] [027/130] (885s left) gem_mmap (big-bo)
[131.945693] Subtest big-bo: SKIP (0.000s)
[131.978349] [028/130] (885s left) kms_cursor_crc (cursor-offscreen-512x512)
[132.222638] Starting subtest: cursor-offscreen-512x512
[132.227172] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[132.344956] [029/130] (884s left) gem_ctx_persistence (engines-cleanup)
[132.410971] Starting subtest: engines-cleanup
[132.413446] Starting dynamic subtest: rcs0
[132.494528] Dynamic subtest rcs0: SUCCESS (0.084s)
[132.505032] Starting dynamic subtest: bcs0
[132.537296] Dynamic subtest bcs0: SUCCESS (0.042s)
[132.545624] Starting dynamic subtest: vcs0
[132.606039] Dynamic subtest vcs0: SUCCESS (0.068s)
[132.615924] Starting dynamic subtest: vcs1
[132.660857] Dynamic subtest vcs1: SUCCESS (0.055s)
[132.670759] Starting dynamic subtest: vecs0
[132.719128] Dynamic subtest vecs0: SUCCESS (0.058s)
[132.728722] Starting dynamic subtest: ccs0
[132.770918] Dynamic subtest ccs0: SUCCESS (0.052s)
[132.773380] Subtest engines-cleanup: SUCCESS (0.360s)
[132.827264] [030/130] (884s left) syncobj_timeline (wait-delayed-signal)
[132.874363] Starting subtest: wait-delayed-signal
[132.977914] Subtest wait-delayed-signal: SUCCESS (0.102s)
[133.031257] [031/130] (884s left) kms_big_fb (y-tiled-addfb)
[133.139412] Starting subtest: y-tiled-addfb
[133.143795] Subtest y-tiled-addfb: SKIP (0.000s)
[133.216719] [032/130] (883s left) kms_writeback (writeback-fb-id-xrgb2101010)
[133.321212] Subtest writeback-fb-id-XRGB2101010: SKIP (0.000s)
[133.343614] [033/130] (883s left) kms_plane_scaling (planes-upscale-factor-0-25)
[133.438598] Starting subtest: planes-upscale-factor-0-25
[133.440935] Starting dynamic subtest: pipe-A
[133.503572] Dynamic subtest pipe-A: SUCCESS (0.064s)
[133.512633] Starting dynamic subtest: pipe-B
[134.588107] Dynamic subtest pipe-B: SUCCESS (1.084s)
[134.597914] Starting dynamic subtest: pipe-C
[135.695692] Dynamic subtest pipe-C: SUCCESS (1.107s)
[135.704536] Starting dynamic subtest: pipe-D
[136.818868] Dynamic subtest pipe-D: SUCCESS (1.122s)
[136.821393] Subtest planes-upscale-factor-0-25: SUCCESS (3.380s)
[137.942045] [034/130] (879s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[138.051540] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[138.064278] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s)
[138.118298] [035/130] (879s left) gem_exec_schedule (u-submit-golden-slice)
[138.202642] Starting subtest: u-submit-golden-slice
[138.205060] Starting dynamic subtest: rcs0
[138.228503] Dynamic subtest rcs0: SUCCESS (0.034s)
[138.238826] Starting dynamic subtest: bcs0
[138.251381] Dynamic subtest bcs0: SUCCESS (0.023s)
[138.259247] Starting dynamic subtest: vcs0
[138.282452] Dynamic subtest vcs0: SUCCESS (0.031s)
[138.290284] Starting dynamic subtest: vcs1
[138.316427] Dynamic subtest vcs1: SUCCESS (0.034s)
[138.324156] Starting dynamic subtest: vecs0
[138.345563] Dynamic subtest vecs0: SUCCESS (0.029s)
[138.355403] Starting dynamic subtest: ccs0
[138.375439] Dynamic subtest ccs0: SUCCESS (0.030s)
[138.377711] Subtest u-submit-golden-slice: SUCCESS (0.182s)
[140.044894] [036/130] (877s left) kms_feature_discovery (dp-mst)
[140.144756] Starting subtest: dp-mst
[140.149600] Subtest dp-mst: SKIP (0.000s)
[140.194208] [037/130] (877s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[140.241837] Starting subtest: etime-single-wait-for-submit-submitted
[140.343404] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.101s)
[140.396988] [038/130] (876s left) gem_basic (bad-close)
[140.454983] Starting subtest: bad-close
[140.459566] Subtest bad-close: SUCCESS (0.000s)
[140.530802] [039/130] (876s left) gem_exec_capture (capture)
[140.587327] Starting subtest: capture
[140.589515] Starting dynamic subtest: rcs0-smem
[141.430295] Dynamic subtest rcs0-smem: SUCCESS (0.842s)
[141.438964] Starting dynamic subtest: bcs0-smem
[142.754699] Dynamic subtest bcs0-smem: SUCCESS (1.322s)
[142.762736] Starting dynamic subtest: vcs0-smem
[143.585563] Dynamic subtest vcs0-smem: SUCCESS (0.830s)
[143.594068] Starting dynamic subtest: vcs1-smem
[144.911044] Dynamic subtest vcs1-smem: SUCCESS (1.327s)
[144.920245] Starting dynamic subtest: vecs0-smem
[145.812817] Dynamic subtest vecs0-smem: FAIL (0.842s)
[145.821184] Starting dynamic subtest: ccs0-smem
[147.074069] Dynamic subtest ccs0-smem: SUCCESS (1.319s)
[147.076495] Subtest capture: FAIL (6.484s)
[147.162445] [040/130] (870s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[147.263843] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[147.275086] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[147.332458] [041/130] (870s left) syncobj_eventfd (invalid-bad-pad)
[147.382930] Starting subtest: invalid-bad-pad
[147.384897] Subtest invalid-bad-pad: SUCCESS (0.000s)
[147.478989] [042/130] (869s left) gem_exec_schedule (smoketest-all)
[147.555100] Starting subtest: smoketest-all
[179.945168] Subtest smoketest-all: SUCCESS (32.343s)
[180.931037] [043/130] (836s left) gem_workarounds (suspend-resume)
[181.005293] Starting subtest: suspend-resume
[196.667411] Subtest suspend-resume: SUCCESS (1.209s)
[197.784462] [044/130] (835s left) drm_fdinfo (virtual-busy-all)
[197.829489] Starting subtest: virtual-busy-all
[197.833886] Subtest virtual-busy-all: SKIP (0.000s)
[197.875586] [045/130] (835s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[202.863135] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[202.867632] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s)
[203.697123] [046/130] (829s left) kms_async_flips (test-cursor-atomic)
[203.793184] Starting subtest: test-cursor-atomic
[203.797736] Subtest test-cursor-atomic: SKIP (0.000s)
[204.919749] [047/130] (828s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[205.030745] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[205.035116] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[205.119139] [048/130] (827s left) kms_pm_backlight (bad-brightness)
[205.224886] Starting subtest: bad-brightness
[205.271277] Starting dynamic subtest: eDP-1
[205.557292] Dynamic subtest eDP-1: SUCCESS (0.284s)
[205.559746] Subtest bad-brightness: SUCCESS (0.333s)
[206.346038] [049/130] (826s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-pwrite)
[206.459499] Starting subtest: psr-1p-offscren-pri-shrfb-draw-pwrite
[213.612989] Subtest psr-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (7.155s)
[213.706080] [050/130] (819s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[213.807683] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[219.274310] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.469s)
[219.355280] [051/130] (813s left) kms_force_connector_basic (force-connector-state)
[219.439323] Starting subtest: force-connector-state
[220.037419] Subtest force-connector-state: SUCCESS (0.598s)
[220.932851] [052/130] (812s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[221.035497] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[221.037831] Starting dynamic subtest: pipe-A-eDP-1
[221.063504] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[221.072193] Starting dynamic subtest: pipe-B-eDP-1
[221.096418] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[221.104252] Starting dynamic subtest: pipe-C-eDP-1
[221.128291] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[221.136151] Starting dynamic subtest: pipe-D-eDP-1
[221.160736] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[221.164881] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[223.216288] [053/130] (809s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[223.309104] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[223.311519] Starting dynamic subtest: pipe-A-eDP-1
[223.334592] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.023s)
[223.344809] Starting dynamic subtest: pipe-B-eDP-1
[223.364594] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.025s)
[223.372667] Starting dynamic subtest: pipe-C-eDP-1
[223.393112] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.023s)
[223.402705] Starting dynamic subtest: pipe-D-eDP-1
[223.423385] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.024s)
[223.425778] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.098s)
[225.614852] [054/130] (807s left) kms_hdr (bpc-switch)
[225.708077] Starting subtest: bpc-switch
[226.777108] Starting dynamic subtest: pipe-A-eDP-1
[230.181239] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.403s)
[230.183628] Subtest bpc-switch: SUCCESS (4.472s)
[230.273938] [055/130] (802s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[230.382372] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[231.369041] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (0.988s)
[231.495403] [056/130] (801s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[231.606099] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[232.208311] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.603s)
[232.361088] [057/130] (800s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[232.457800] Starting subtest: yf-tiled-32bpp-rotate-90
[232.462182] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[232.527903] [058/130] (800s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[232.634495] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[232.636951] Starting dynamic subtest: pipe-A-default-mode
[232.988257] Dynamic subtest pipe-A-default-mode: SKIP (0.350s)
[232.993115] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.352s)
[233.721842] [059/130] (799s left) gem_exec_schedule (preempt-user)
[233.788653] Starting subtest: preempt-user
[233.791122] Starting dynamic subtest: rcs0
[233.802291] Dynamic subtest rcs0: SUCCESS (0.021s)
[233.813160] Starting dynamic subtest: bcs0
[233.819217] Dynamic subtest bcs0: SUCCESS (0.017s)
[233.827501] Starting dynamic subtest: vcs0
[233.836831] Dynamic subtest vcs0: SUCCESS (0.017s)
[233.845034] Starting dynamic subtest: vcs1
[233.859902] Dynamic subtest vcs1: SUCCESS (0.023s)
[233.869085] Starting dynamic subtest: vecs0
[233.875976] Dynamic subtest vecs0: SUCCESS (0.016s)
[233.884274] Starting dynamic subtest: ccs0
[233.894763] Dynamic subtest ccs0: SUCCESS (0.018s)
[233.897152] Subtest preempt-user: SUCCESS (0.113s)
[235.444666] [060/130] (797s left) syncobj_wait (wait-for-submit-snapshot)
[235.503593] Starting subtest: wait-for-submit-snapshot
[235.583173] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[235.638136] [061/130] (797s left) api_intel_allocator (two-level-inception)
[235.683239] Starting subtest: two-level-inception
[241.092527] Subtest two-level-inception: SUCCESS (5.410s)
[241.195482] [062/130] (792s left) sw_sync (alloc_fence_invalid_timeline)
[241.234886] Starting subtest: alloc_fence_invalid_timeline
[241.237034] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[241.270445] [063/130] (791s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[246.308958] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[246.314133] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.003s)
[247.115443] [064/130] (786s left) gem_flink_basic (bad-flink)
[247.175521] Starting subtest: bad-flink
[247.177705] Subtest bad-flink: SUCCESS (0.000s)
[247.261999] [065/130] (786s left) gem_exec_balancer (invalid-balancer)
[247.321606] Starting subtest: invalid-balancer
[248.097380] Subtest invalid-balancer: SUCCESS (0.774s)
[248.374328] [066/130] (784s left) kms_plane (plane-position-hole)
[248.475149] Starting subtest: plane-position-hole
[248.962699] Starting dynamic subtest: pipe-A-plane-1
[250.271076] Dynamic subtest pipe-A-plane-1: SUCCESS (1.307s)
[250.280204] Starting dynamic subtest: pipe-A-plane-2
[251.548573] Dynamic subtest pipe-A-plane-2: SUCCESS (1.277s)
[251.558701] Starting dynamic subtest: pipe-A-plane-3
[252.747531] Dynamic subtest pipe-A-plane-3: SUCCESS (1.200s)
[252.757343] Starting dynamic subtest: pipe-A-plane-4
[253.947824] Dynamic subtest pipe-A-plane-4: SUCCESS (1.199s)
[253.957743] Starting dynamic subtest: pipe-A-plane-5
[253.969828] Dynamic subtest pipe-A-plane-5: SUCCESS (0.021s)
[255.079839] Starting dynamic subtest: pipe-B-plane-1
[256.363870] Dynamic subtest pipe-B-plane-1: SUCCESS (1.289s)
[256.372825] Starting dynamic subtest: pipe-B-plane-2
[257.662244] Dynamic subtest pipe-B-plane-2: SUCCESS (1.300s)
[257.671191] Starting dynamic subtest: pipe-B-plane-3
[258.960924] Dynamic subtest pipe-B-plane-3: SUCCESS (1.297s)
[258.972076] Starting dynamic subtest: pipe-B-plane-4
[260.250712] Dynamic subtest pipe-B-plane-4: SUCCESS (1.290s)
[260.258995] Starting dynamic subtest: pipe-B-plane-5
[260.274977] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[260.277186] Subtest plane-position-hole: SUCCESS (11.798s)
[261.017691] [067/130] (772s left) gem_mmap (pf-nonblock)
[261.079876] Subtest pf-nonblock: SKIP (0.000s)
[261.126668] [068/130] (772s left) gem_exec_fence (syncobj-unused-fence)
[261.611672] Starting subtest: syncobj-unused-fence
[261.618468] Subtest syncobj-unused-fence: SUCCESS (0.005s)
[263.472961] [069/130] (769s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[263.566242] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[263.568578] Starting dynamic subtest: pipe-A-eDP-1
[263.642908] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.076s)
[263.651523] Starting dynamic subtest: pipe-B-eDP-1
[263.720826] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.077s)
[263.729051] Starting dynamic subtest: pipe-C-eDP-1
[263.793732] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.072s)
[263.802351] Starting dynamic subtest: pipe-D-eDP-1
[263.868883] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.074s)
[263.871075] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.303s)
[266.115694] [070/130] (767s left) fbdev (read)
[266.152427] Starting subtest: read
[266.824191] Subtest read: SUCCESS (0.640s)
[266.855397] [071/130] (766s left) prime_mmap (test_forked)
[266.907579] Starting subtest: test_forked
[266.909849] Starting dynamic subtest: test_forked-smem
[266.952281] Dynamic subtest test_forked-smem: SUCCESS (0.047s)
[266.954829] Subtest test_forked: SUCCESS (0.047s)
[267.041683] [072/130] (766s left) gem_exec_schedule (fifo)
[267.106715] Starting subtest: fifo
[267.108743] Starting dynamic subtest: rcs0
[267.196993] Dynamic subtest rcs0: SUCCESS (0.099s)
[267.209116] Starting dynamic subtest: vcs0
[267.274085] Dynamic subtest vcs0: SUCCESS (0.077s)
[267.285286] Starting dynamic subtest: vcs1
[267.343690] Dynamic subtest vcs1: SUCCESS (0.069s)
[267.354619] Starting dynamic subtest: vecs0
[267.413669] Dynamic subtest vecs0: SUCCESS (0.070s)
[267.424776] Starting dynamic subtest: ccs0
[267.490127] Dynamic subtest ccs0: SUCCESS (0.075s)
[267.492512] Subtest fifo: SUCCESS (0.393s)
[268.487224] [073/130] (764s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[268.677729] Starting subtest: cursor-rapid-movement-128x128
[268.683247] Starting dynamic subtest: pipe-A-eDP-1
[269.221611] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.538s)
[269.245525] Starting dynamic subtest: pipe-D-eDP-1
[270.403248] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.163s)
[270.405635] Subtest cursor-rapid-movement-128x128: SUCCESS (1.725s)
[271.216558] [074/130] (762s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[271.319173] Starting subtest: coverage-vs-premult-vs-constant
[271.585486] Starting dynamic subtest: pipe-A-eDP-1
[272.107661] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.520s)
[272.116974] Starting dynamic subtest: pipe-D-eDP-1
[273.382329] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.272s)
[273.384968] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.060s)
[274.213582] [075/130] (759s left) gem_userptr_blits (coherency-unsync)
[274.295445] Subtest coherency-unsync: SKIP (0.000s)
[274.401804] [076/130] (759s left) kms_vblank (wait-busy)
[274.493181] Starting subtest: wait-busy
[274.495106] Starting dynamic subtest: pipe-A-eDP-1
[276.367803] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[276.382402] Starting dynamic subtest: pipe-D-eDP-1
[278.960029] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.590s)
[278.962087] Subtest wait-busy: SUCCESS (4.467s)
[279.812529] [077/130] (753s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-blt)
[279.919964] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-blt
[284.664790] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-blt: SUCCESS (4.747s)
[284.780640] [078/130] (748s left) sw_sync (sync_merge_invalid)
[284.820315] Starting subtest: sync_merge_invalid
[284.846093] Subtest sync_merge_invalid: SUCCESS (0.028s)
[284.907887] [079/130] (748s left) gem_fence_thrash (bo-write-verify-threaded-y)
[284.943549] Starting subtest: bo-write-verify-threaded-y
[284.954236] Subtest bo-write-verify-threaded-y: SKIP (0.010s)
[284.996033] [080/130] (748s left) syncobj_wait (wait-all-for-submit-complex)
[285.051433] Starting subtest: wait-all-for-submit-complex
[285.264535] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[285.319339] [081/130] (748s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[285.372858] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[285.375259] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[285.460648] [082/130] (748s left) syncobj_timeline (multi-wait-submitted-signaled)
[285.527600] Starting subtest: multi-wait-submitted-signaled
[285.530035] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[285.625559] [083/130] (748s left) gem_exec_fence (basic-busy-all)
[285.678669] Starting subtest: basic-busy-all
[285.779928] Subtest basic-busy-all: SUCCESS (0.101s)
[287.480273] [084/130] (746s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[287.576206] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[287.578410] Starting dynamic subtest: pipe-A-default-mode
[287.864130] Dynamic subtest pipe-A-default-mode: SKIP (0.282s)
[287.868876] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.283s)
[288.712157] [085/130] (744s left) gem_ctx_isolation (clean)
[288.769753] Starting subtest: clean
[288.772202] Starting dynamic subtest: rcs0
[288.818943] Dynamic subtest rcs0: SUCCESS (0.049s)
[288.829266] Starting dynamic subtest: bcs0
[288.868194] Dynamic subtest bcs0: SUCCESS (0.049s)
[288.876978] Starting dynamic subtest: vcs0
[288.942608] Dynamic subtest vcs0: SUCCESS (0.074s)
[288.952965] Starting dynamic subtest: vcs1
[290.456623] Dynamic subtest vcs1: SUCCESS (1.513s)
[290.465127] Starting dynamic subtest: vecs0
[292.422039] Dynamic subtest vecs0: SUCCESS (1.965s)
[292.432710] Starting dynamic subtest: ccs0
[294.361569] Dynamic subtest ccs0: SUCCESS (1.939s)
[294.364139] Subtest clean: SUCCESS (5.592s)
[294.564353] [086/130] (739s left) kms_pm_rpm (universal-planes-dpms)
[296.497293] Starting subtest: universal-planes-dpms
[296.500350] Starting dynamic subtest: plane-32
[304.779922] Dynamic subtest plane-32: SUCCESS (8.281s)
[304.791880] Starting dynamic subtest: plane-41
[313.048878] Dynamic subtest plane-41: SUCCESS (8.267s)
[313.060231] Starting dynamic subtest: plane-50
[321.651252] Dynamic subtest plane-50: SUCCESS (8.600s)
[321.662555] Starting dynamic subtest: plane-59
[330.346084] Dynamic subtest plane-59: SUCCESS (8.692s)
[330.357126] Starting dynamic subtest: plane-68
[338.796000] Dynamic subtest plane-68: SUCCESS (8.448s)
[338.808640] Starting dynamic subtest: plane-77
[347.495021] Dynamic subtest plane-77: SUCCESS (8.696s)
[347.497750] Subtest universal-planes-dpms: SUCCESS (50.998s)
[347.847175] [087/130] (685s left) gem_render_copy (yf-tiled)
[347.902142] Starting subtest: yf-tiled
[347.906695] Subtest yf-tiled: SKIP (0.000s)
[348.063968] [088/130] (685s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[348.155259] Starting subtest: fbc-psr2-sprite-mmap-gtt
[348.157579] Starting dynamic subtest: eDP-1
[348.161686] Dynamic subtest eDP-1: SKIP (0.000s)
[348.165782] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[348.207084] [089/130] (685s left) kms_content_protection (lic-type-1)
[348.349390] Starting subtest: lic-type-1
[351.680165] Subtest lic-type-1: SKIP (3.329s)
[352.807305] [090/130] (680s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[352.911791] Starting subtest: fbcpsr-rgb101010-draw-blt
[357.541314] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (4.632s)
[357.660526] [091/130] (676s left) kms_chamelium_color (ctm-0-25)
[357.758333] Subtest ctm-0-25: SKIP (0.000s)
[357.783737] [092/130] (676s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[357.887572] Starting subtest: invalid-modeset-force-ultra-joiner
[357.891773] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[357.936387] [093/130] (675s left) gem_mmap_wc (read-write)
[358.006009] Subtest read-write: SKIP (0.000s)
[358.051070] [094/130] (675s left) gem_exec_reloc (basic-cpu-gtt-active)
[358.106135] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[358.169935] [095/130] (675s left) gem_ctx_shared (disjoint-timelines)
[358.229049] Starting subtest: disjoint-timelines
[358.247744] Subtest disjoint-timelines: SUCCESS (0.019s)
[358.466125] [096/130] (675s left) dmabuf_sync_file (import-basic)
[358.506873] Starting subtest: import-basic
[358.509184] Subtest import-basic: SUCCESS (0.004s)
[358.544759] [097/130] (675s left) gem_pxp (create-regular-context-1)
[358.671477] Starting subtest: create-regular-context-1
[358.673859] Subtest create-regular-context-1: SUCCESS (0.002s)
[359.773951] [098/130] (674s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[364.790049] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[364.792256] Starting dynamic subtest: pipe-A-eDP-1
[371.279812] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.485s)
[371.289661] Starting dynamic subtest: pipe-B-eDP-1
[377.777917] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.499s)
[377.780332] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.988s)
[378.603241] [099/130] (655s left) kms_display_modes (extended-mode-basic)
[378.701424] Starting subtest: extended-mode-basic
[378.706022] Subtest extended-mode-basic: SKIP (0.000s)
[378.732362] [100/130] (655s left) kms_psr (pr-primary-mmap-cpu)
[378.839299] Starting subtest: pr-primary-mmap-cpu
[378.843574] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[378.893365] [101/130] (655s left) gem_mmap_gtt (flink-race)
[378.959959] Subtest flink-race: SKIP (0.000s)
[379.006165] [102/130] (655s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[379.113443] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[379.117701] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[379.202623] [103/130] (654s left) gem_mmap_gtt (basic-copy)
[379.265014] Subtest basic-copy: SKIP (0.000s)
[379.310689] [104/130] (654s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[379.407721] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[379.412127] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[379.507026] [105/130] (654s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[379.554808] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[379.556685] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[379.644042] [106/130] (654s left) kms_selftest (drm_plane_helper)
[379.681738] Starting subtest: drm_plane_helper
[379.696047] Starting dynamic subtest: drm_test_check_plane_state
[379.828273] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.132s)
[379.837351] Starting dynamic subtest: drm_test_check_invalid_plane_state
[379.952230] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.124s)
[379.954241] Subtest drm_plane_helper: SUCCESS (0.269s)
[380.116482] [107/130] (654s left) template (b)
[380.182242] Starting subtest: B
[380.184452] Subtest B: SUCCESS (0.000s)
[380.276948] [108/130] (653s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[380.374681] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[385.455403] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (5.084s)
[385.570580] [109/130] (648s left) kms_chamelium_frames (dp-crc-fast)
[385.948352] Subtest dp-crc-fast: SKIP (0.000s)
[386.688657] [110/130] (647s left) perf_pmu (gt-awake)
[386.737614] Starting subtest: gt-awake
[395.364415] Subtest gt-awake: SUCCESS (8.629s)
[395.452265] [111/130] (638s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[395.508927] Starting subtest: multi-wait-for-submit-submitted-signaled
[395.511340] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[395.587696] [112/130] (638s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[395.694899] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[395.698841] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[395.784548] [113/130] (638s left) i915_hangman (engine-engine-error)
[395.854272] Starting subtest: engine-engine-error
[395.856103] Starting dynamic subtest: rcs0
[397.374839] Dynamic subtest rcs0: SUCCESS (1.521s)
[397.387105] Starting dynamic subtest: bcs0
[399.360517] Dynamic subtest bcs0: SUCCESS (1.983s)
[399.375363] Starting dynamic subtest: vcs0
[401.343036] Dynamic subtest vcs0: SUCCESS (1.980s)
[401.357152] Starting dynamic subtest: vcs1
[403.327446] Dynamic subtest vcs1: SUCCESS (1.982s)
[403.338369] Starting dynamic subtest: vecs0
[405.375142] Dynamic subtest vecs0: SUCCESS (2.045s)
[405.387018] Starting dynamic subtest: ccs0
[407.359119] Dynamic subtest ccs0: SUCCESS (1.982s)
[407.362442] Subtest engine-engine-error: SUCCESS (11.506s)
[407.423635] [114/130] (626s left) perf (polling-small-buf)
[407.507529] Starting subtest: polling-small-buf
[407.597098] Subtest polling-small-buf: SUCCESS (0.087s)
[407.624828] [115/130] (626s left) gem_exec_alignment (forked)
[407.689784] Starting subtest: forked
[444.144083] Subtest forked: SUCCESS (36.450s)
[444.201793] [116/130] (590s left) gen9_exec_parse (unaligned-jump)
[444.312411] Subtest unaligned-jump: SKIP (0.000s)
[444.379916] [117/130] (589s left) gem_exec_create (basic)
[444.433479] Starting subtest: basic
[444.435904] Starting dynamic subtest: smem
[448.352380] Dynamic subtest smem: SUCCESS (3.917s)
[448.355091] Subtest basic: SUCCESS (3.918s)
[448.518570] [118/130] (585s left) gem_lmem_swapping (smem-oom)
[448.569068] Subtest smem-oom: SKIP (0.000s)
[448.590775] [119/130] (585s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[448.696137] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[448.698454] Starting dynamic subtest: pipe-A-eDP-1
[450.728191] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.030s)
[450.738919] Starting dynamic subtest: pipe-B-eDP-1
[452.817173] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.089s)
[452.826592] Starting dynamic subtest: pipe-C-eDP-1
[454.893647] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.075s)
[454.902860] Starting dynamic subtest: pipe-D-eDP-1
[456.893808] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.999s)
[456.896120] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.197s)
[458.102520] [120/130] (576s left) gem_mmap_gtt (basic-small-copy-odd)
[458.166962] Subtest basic-small-copy-odd: SKIP (0.000s)
[458.215924] [121/130] (576s left) prime_vgem (basic-read)
[458.322947] Starting subtest: basic-read
[458.344136] Subtest basic-read: SKIP (0.020s)
[458.451307] [122/130] (576s left) i915_selftest (live)
[463.305587] Starting subtest: live
[463.308296] Starting dynamic subtest: sanitycheck
[467.747276] Dynamic subtest sanitycheck: SUCCESS (4.442s)
[467.756231] Starting dynamic subtest: uncore
[472.128323] Dynamic subtest uncore: SUCCESS (4.379s)
[472.137214] Starting dynamic subtest: workarounds
[475.246147] Dynamic subtest workarounds: SUCCESS (3.116s)
[475.254151] Starting dynamic subtest: gt_engines
[479.883941] Dynamic subtest gt_engines: SUCCESS (4.636s)
[479.892732] Starting dynamic subtest: gt_timelines
[494.093120] Dynamic subtest gt_timelines: SUCCESS (14.206s)
[494.102675] Starting dynamic subtest: gt_contexts
[498.494642] Dynamic subtest gt_contexts: SUCCESS (4.400s)
[498.504331] Starting dynamic subtest: gt_lrc
[504.767379] Dynamic subtest gt_lrc: SUCCESS (6.270s)
[504.775928] Starting dynamic subtest: gt_mocs
[507.814161] Dynamic subtest gt_mocs: SUCCESS (3.045s)
[507.821490] Starting dynamic subtest: gt_pm
[513.651600] Dynamic subtest gt_pm: SUCCESS (5.835s)
[513.661011] Starting dynamic subtest: gt_heartbeat
[517.972902] Dynamic subtest gt_heartbeat: SUCCESS (4.319s)
[517.979675] Starting dynamic subtest: gt_tlb
[526.216309] Dynamic subtest gt_tlb: SUCCESS (8.242s)
[526.225522] Starting dynamic subtest: requests
[539.696461] Dynamic subtest requests: SUCCESS (13.477s)
[539.705762] Starting dynamic subtest: migrate
[545.680566] Dynamic subtest migrate: SUCCESS (5.982s)
[545.690109] Starting dynamic subtest: active
[549.987513] Dynamic subtest active: SUCCESS (4.305s)
[549.996861] Starting dynamic subtest: objects
[554.709382] Dynamic subtest objects: SUCCESS (4.720s)
[554.719314] Starting dynamic subtest: mman
[559.513379] Dynamic subtest mman: SUCCESS (4.802s)
[559.522874] Starting dynamic subtest: dmabuf
[563.955384] Dynamic subtest dmabuf: SUCCESS (4.440s)
[563.964888] Starting dynamic subtest: vma
[568.366423] Dynamic subtest vma: SUCCESS (4.409s)
[568.374847] Starting dynamic subtest: coherency
[573.286123] Dynamic subtest coherency: SUCCESS (4.918s)
[573.296020] Starting dynamic subtest: gtt
[584.979017] Dynamic subtest gtt: SUCCESS (11.691s)
[584.988313] Starting dynamic subtest: gem
[591.302896] Dynamic subtest gem: SUCCESS (6.323s)
[591.316219] Starting dynamic subtest: evict
[596.710427] Dynamic subtest evict: SUCCESS (5.405s)
[596.718270] Starting dynamic subtest: hugepages
[605.615797] Dynamic subtest hugepages: SUCCESS (8.904s)
[605.625603] Starting dynamic subtest: gem_contexts
[633.080521] Dynamic subtest gem_contexts: SUCCESS (27.462s)
[633.089537] Starting dynamic subtest: client
[637.438448] Dynamic subtest client: SUCCESS (4.358s)
[637.448121] Starting dynamic subtest: gem_migrate
[641.870566] Dynamic subtest gem_migrate: SUCCESS (4.421s)
[641.881299] Starting dynamic subtest: reset
[644.678262] Dynamic subtest reset: SUCCESS (2.815s)
[644.687873] Starting dynamic subtest: memory_region
[649.104304] Dynamic subtest memory_region: SUCCESS (4.424s)
[649.114171] Starting dynamic subtest: hangcheck
[662.186733] Dynamic subtest hangcheck: SUCCESS (13.080s)
[662.194949] Starting dynamic subtest: execlists
[666.525402] Dynamic subtest execlists: SUCCESS (4.337s)
[666.534770] Starting dynamic subtest: ring_submission
[670.930568] Dynamic subtest ring_submission: SUCCESS (4.402s)
[670.940769] Starting dynamic subtest: perf
[675.288378] Dynamic subtest perf: SUCCESS (4.356s)
[675.298051] Starting dynamic subtest: slpc
[687.432470] Dynamic subtest slpc: SUCCESS (12.142s)
[687.441329] Starting dynamic subtest: guc
[691.310723] Dynamic subtest guc: SUCCESS (3.876s)
[691.320678] Starting dynamic subtest: guc_multi_lrc
[695.744340] Dynamic subtest guc_multi_lrc: SUCCESS (4.432s)
[695.753383] Starting dynamic subtest: guc_hang
[700.681144] Dynamic subtest guc_hang: SUCCESS (4.935s)
[700.690796] Starting dynamic subtest: late_gt_pm
[703.433511] Dynamic subtest late_gt_pm: SUCCESS (2.750s)
[703.436605] Subtest live: SUCCESS (240.118s)
[703.728558] [123/130] (330s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[707.303152] Starting subtest: plane-primary-overlay-mutable-zpos
[710.740890] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.433s)
[711.914031] [124/130] (322s left) gem_spin_batch (engines)
[711.980619] Starting subtest: engines
[711.982924] Starting dynamic subtest: rcs0
[715.220547] Dynamic subtest rcs0: SUCCESS (3.234s)
[715.230788] Starting dynamic subtest: bcs0
[718.453780] Dynamic subtest bcs0: SUCCESS (3.232s)
[718.462358] Starting dynamic subtest: vcs0
[721.689842] Dynamic subtest vcs0: SUCCESS (3.233s)
[721.697975] Starting dynamic subtest: vcs1
[724.922043] Dynamic subtest vcs1: SUCCESS (3.230s)
[724.930327] Starting dynamic subtest: vecs0
[728.155140] Dynamic subtest vecs0: SUCCESS (3.230s)
[728.163568] Starting dynamic subtest: ccs0
[731.391872] Dynamic subtest ccs0: SUCCESS (3.235s)
[731.394470] Subtest engines: SUCCESS (19.407s)
[731.630613] [125/130] (302s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[731.691117] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[731.693378] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[731.793777] [126/130] (302s left) kms_color (degamma)
[731.894587] Starting subtest: degamma
[731.896965] Starting dynamic subtest: pipe-A-eDP-1
[732.590840] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.695s)
[732.600334] Starting dynamic subtest: pipe-B-eDP-1
[734.001487] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.410s)
[734.011203] Starting dynamic subtest: pipe-C-eDP-1
[735.370190] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.367s)
[735.378861] Starting dynamic subtest: pipe-D-eDP-1
[736.679005] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.309s)
[736.681477] Subtest degamma: SUCCESS (4.783s)
[737.491914] [127/130] (297s left) kms_flip (flip-vs-rmfb-interruptible)
[737.601851] Starting subtest: flip-vs-rmfb-interruptible
[737.606819] Starting dynamic subtest: A-eDP1
[746.199051] Dynamic subtest A-eDP1: SUCCESS (8.595s)
[746.208113] Starting dynamic subtest: B-eDP1
[754.827666] Dynamic subtest B-eDP1: SUCCESS (8.627s)
[754.837325] Starting dynamic subtest: C-eDP1
[763.441206] Dynamic subtest C-eDP1: SUCCESS (8.612s)
[763.450173] Starting dynamic subtest: D-eDP1
[772.063171] Dynamic subtest D-eDP1: SUCCESS (8.621s)
[772.065124] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.462s)
[773.217936] [128/130] (261s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[773.328143] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[774.062812] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.737s)
[774.224847] [129/130] (260s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[774.315205] Starting subtest: primary-y-tiled-reflect-x-90
[774.320560] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[774.369281] [130/130] (260s left) sw_sync (timeline_closed)
[774.411442] Starting subtest: timeline_closed
[774.413417] Subtest timeline_closed: SUCCESS (0.000s)
[774.446259] Closing watchdogs
Done.