[42.486535] Initializing watchdogs
[42.486571]   /dev/watchdog0
[42.491840] [001/144] (960s left) kms_chamelium_color (ctm-0-25)
[42.567752] Subtest ctm-0-25: SKIP (0.000s)
[42.592350] [002/144] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[42.676189] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[42.678701] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[42.750294] [003/144] (960s left) kms_plane (plane-position-hole-dpms)
[42.812261] Starting subtest: plane-position-hole-dpms
[42.813500] Starting dynamic subtest: pipe-A
[53.629870] Dynamic subtest pipe-A: SUCCESS (10.818s)
[53.641773] Starting dynamic subtest: pipe-B
[65.123550] Dynamic subtest pipe-B: SUCCESS (11.493s)
[65.124865] Subtest plane-position-hole-dpms: SUCCESS (22.313s)
[65.969489] [004/144] (937s left) kms_psr2_sf (overlay-plane-update-continuous-sf)
[71.219149] Starting subtest: overlay-plane-update-continuous-sf
[71.220682] Starting dynamic subtest: pipe-A-eDP-1
[73.036693] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.816s)
[73.049558] Starting dynamic subtest: pipe-B-eDP-1
[74.864928] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.824s)
[74.866198] Subtest overlay-plane-update-continuous-sf: SUCCESS (3.647s)
[75.754133] [005/144] (927s left) gem_exec_flush (basic-uc-set-default)
[75.810868] Starting subtest: basic-uc-set-default
[106.836061] Subtest basic-uc-set-default: FAIL (30.938s)
[107.015627] [006/144] (896s left) kms_psr (fbc-psr-cursor-plane-onoff)
[107.071949] Starting subtest: fbc-psr-cursor-plane-onoff
[107.073097] Starting dynamic subtest: eDP-1
[107.075215] Dynamic subtest eDP-1: SKIP (0.000s)
[107.077591] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[107.171264] [007/144] (895s left) gem_partial_pwrite_pread (write-snoop)
[107.225681] Subtest write-snoop: SKIP (0.000s)
[107.265811] [008/144] (895s left) gem_exec_reloc (basic-gtt-read)
[107.334871] Subtest basic-gtt-read: SKIP (0.000s)
[107.394412] [009/144] (895s left) gem_exec_balancer (bonded-semaphore)
[107.446922] Starting subtest: bonded-semaphore
[107.448896] Subtest bonded-semaphore: SKIP (0.000s)
[107.694139] [010/144] (895s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[107.741960] Starting subtest: multi-wait-for-submit-available-signaled
[107.743537] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.001s)
[107.794995] [011/144] (895s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[107.866235] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[107.867475] Starting dynamic subtest: pipe-A-default-mode
[108.166997] Dynamic subtest pipe-A-default-mode: SKIP (0.299s)
[108.169405] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.300s)
[109.035938] [012/144] (894s left) gen9_exec_parse (allowed-single)
[109.089725] Subtest allowed-single: SKIP (0.000s)
[109.105606] [013/144] (894s left) gem_sync (basic-many-each)
[109.184933] Starting subtest: basic-many-each
[111.435826] Subtest basic-many-each: SUCCESS (2.251s)
[111.611804] [014/144] (891s left) gem_exec_fence (submit3)
[111.772415] Starting subtest: submit3
[111.775691] Subtest submit3: SKIP (0.000s)
[113.533482] [015/144] (889s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[113.604690] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[113.605994] Starting dynamic subtest: pipe-A-eDP-1
[113.675193] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.070s)
[113.691561] Starting dynamic subtest: pipe-B-eDP-1
[114.866217] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.189s)
[114.876775] Starting dynamic subtest: pipe-C-eDP-1
[116.071192] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.201s)
[116.087093] Starting dynamic subtest: pipe-D-eDP-1
[117.288045] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.214s)
[117.289434] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.684s)
[118.512536] [016/144] (884s left) kms_ccs (pipe-b-ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[118.909660] Starting subtest: pipe-B-ccs-on-another-bo-y-tiled-gen12-mc-ccs
[118.912336] Subtest pipe-B-ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[119.794193] [017/144] (883s left) kms_cursor_crc (cursor-sliding-64x21)
[119.952925] Starting subtest: cursor-sliding-64x21
[119.957543] Starting dynamic subtest: pipe-A-eDP-1
[123.863410] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.905s)
[123.903349] Starting dynamic subtest: pipe-D-eDP-1
[128.412434] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.520s)
[128.413634] Subtest cursor-sliding-64x21: SUCCESS (8.459s)
[129.285158] [018/144] (874s left) perf_pmu (frequency)
[129.339019] Starting subtest: frequency
[129.340027] Starting dynamic subtest: gt0
[131.449742] Dynamic subtest gt0: SUCCESS (2.107s)
[131.464067] Starting dynamic subtest: idle-gt0
[131.977924] Dynamic subtest idle-gt0: SUCCESS (0.525s)
[131.992492] Starting dynamic subtest: gt1
[136.417146] Dynamic subtest gt1: SUCCESS (4.438s)
[136.431480] Starting dynamic subtest: idle-gt1
[136.938848] Dynamic subtest idle-gt1: SUCCESS (0.522s)
[136.940277] Subtest frequency: SUCCESS (7.596s)
[137.011387] [019/144] (866s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[137.073560] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[137.074666] Starting dynamic subtest: pipe-A-eDP-1
[137.678451] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.605s)
[137.690977] Starting dynamic subtest: pipe-B-eDP-1
[139.419607] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.738s)
[139.431533] Starting dynamic subtest: pipe-C-eDP-1
[141.126311] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.704s)
[141.143728] Starting dynamic subtest: pipe-D-eDP-1
[142.877133] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.747s)
[142.878327] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (5.805s)
[144.117317] [020/144] (859s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[144.187163] Starting subtest: flip-vs-cursor-atomic
[150.031304] Subtest flip-vs-cursor-atomic: SUCCESS (5.841s)
[150.964190] [021/144] (852s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[151.037536] Starting subtest: fbc-pr-sprite-mmap-gtt
[151.039933] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[151.142505] [022/144] (852s left) kms_chamelium_hpd (hdmi-hpd-fast)
[151.530390] Subtest hdmi-hpd-fast: SKIP (0.000s)
[152.406832] [023/144] (851s left) vc4/vc4_wait_bo (used-bo-1ns)
[152.494245] Subtest used-bo-1ns: SKIP (0.000s)
[152.546472] [024/144] (850s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[152.607387] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[152.608592] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s)
[152.676705] [025/144] (850s left) kms_flip (2x-dpms-vs-vblank-race)
[152.740120] Starting subtest: 2x-dpms-vs-vblank-race
[152.752907] Subtest 2x-dpms-vs-vblank-race: SKIP (0.014s)
[152.815305] [026/144] (850s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[152.895577] Starting subtest: psr-rgb565-draw-render
[157.890791] Subtest psr-rgb565-draw-render: SUCCESS (4.995s)
[158.022858] [027/144] (845s left) syncobj_wait (wait-all-for-submit-snapshot)
[158.076098] Starting subtest: wait-all-for-submit-snapshot
[158.159753] Subtest wait-all-for-submit-snapshot: SUCCESS (0.083s)
[158.231269] [028/144] (845s left) gem_reg_read (bad-register)
[158.288412] Starting subtest: bad-register
[158.289623] Subtest bad-register: SUCCESS (0.000s)
[158.357619] [029/144] (845s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[158.413853] Starting subtest: etime-multi-wait-available-unsubmitted
[158.518753] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.103s)
[158.589831] [030/144] (845s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[158.658189] Starting subtest: disable-crc-after-crtc
[158.659764] Starting dynamic subtest: pipe-A-eDP-1
[160.484850] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.823s)
[160.500257] Starting dynamic subtest: pipe-B-eDP-1
[163.047206] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.559s)
[163.064391] Starting dynamic subtest: pipe-C-eDP-1
[165.545803] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.496s)
[165.565598] Starting dynamic subtest: pipe-D-eDP-1
[167.977577] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.429s)
[167.979025] Subtest disable-crc-after-crtc: SUCCESS (9.321s)
[168.886150] [031/144] (834s left) kms_frontbuffer_tracking (fbc-2p-rte)
[168.953209] Starting subtest: fbc-2p-rte
[168.955457] Subtest fbc-2p-rte: SKIP (0.000s)
[169.041423] [032/144] (834s left) prime_vgem (fence-read-hang)
[169.118447] Subtest fence-read-hang: SKIP (0.000s)
[169.194821] [033/144] (834s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[169.258448] Starting subtest: psr-2p-pri-indfb-multidraw
[169.260744] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[169.351837] [034/144] (834s left) kms_color (ctm-0-50)
[169.430620] Starting subtest: ctm-0-50
[169.431804] Starting dynamic subtest: pipe-A
[173.173583] Dynamic subtest pipe-A: SUCCESS (3.743s)
[173.185573] Starting dynamic subtest: pipe-B
[177.676181] Dynamic subtest pipe-B: SUCCESS (4.502s)
[177.688838] Starting dynamic subtest: pipe-C
[181.992328] Dynamic subtest pipe-C: SUCCESS (4.315s)
[182.006208] Starting dynamic subtest: pipe-D
[186.291020] Dynamic subtest pipe-D: SUCCESS (4.297s)
[186.292239] Subtest ctm-0-50: SUCCESS (16.861s)
[187.190310] [035/144] (816s left) kms_color (legacy-gamma-reset)
[187.252393] Starting subtest: legacy-gamma-reset
[187.253683] Starting dynamic subtest: pipe-A
[187.638643] Dynamic subtest pipe-A: SUCCESS (0.388s)
[187.652516] Starting dynamic subtest: pipe-B
[187.653778] Dynamic subtest pipe-B: SUCCESS (0.009s)
[187.668823] Starting dynamic subtest: pipe-C
[187.670094] Dynamic subtest pipe-C: SUCCESS (0.008s)
[187.680964] Starting dynamic subtest: pipe-D
[187.682098] Dynamic subtest pipe-D: SUCCESS (0.008s)
[187.683146] Subtest legacy-gamma-reset: SUCCESS (0.415s)
[188.533630] [036/144] (815s left) syncobj_wait (wait-all-delayed-signal)
[188.592606] Starting subtest: wait-all-delayed-signal
[188.695229] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[188.769539] [037/144] (815s left) kms_flip (2x-nonexisting-fb)
[188.846275] Starting subtest: 2x-nonexisting-fb
[188.860287] Subtest 2x-nonexisting-fb: SKIP (0.014s)
[188.926899] [038/144] (814s left) api_intel_bb (intel-bb-blit-x)
[188.978267] Starting subtest: intel-bb-blit-x
[193.261073] Subtest intel-bb-blit-x: SUCCESS (4.284s)
[193.366398] [039/144] (810s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[193.446514] Starting subtest: plane-primary-overlay-mutable-zpos
[197.124220] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.676s)
[198.391084] [040/144] (805s left) perf_pmu (multi-client)
[198.453744] Starting subtest: multi-client
[198.455203] Starting dynamic subtest: rcs0
[199.502930] Dynamic subtest rcs0: SUCCESS (1.047s)
[199.518459] Starting dynamic subtest: bcs0
[200.557614] Dynamic subtest bcs0: SUCCESS (1.053s)
[200.572942] Starting dynamic subtest: vcs0
[201.610907] Dynamic subtest vcs0: SUCCESS (1.051s)
[201.626818] Starting dynamic subtest: vcs1
[203.445599] Dynamic subtest vcs1: SUCCESS (1.832s)
[203.461208] Starting dynamic subtest: vecs0
[205.494253] Dynamic subtest vecs0: SUCCESS (2.047s)
[205.510073] Starting dynamic subtest: ccs0
[207.479130] Dynamic subtest ccs0: SUCCESS (1.983s)
[207.481038] Subtest multi-client: SUCCESS (9.024s)
[207.591513] [041/144] (796s left) syncobj_wait (multi-wait-for-submit-signaled)
[207.656748] Starting subtest: multi-wait-for-submit-signaled
[207.658136] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[207.727988] [042/144] (796s left) kms_ccs (pipe-a-bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[207.813963] Starting subtest: pipe-A-bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[207.816022] Subtest pipe-A-bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[209.013860] [043/144] (795s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[209.080190] Starting subtest: fbc-psr-cursor-mmap-cpu
[209.081420] Starting dynamic subtest: eDP-1
[209.083780] Dynamic subtest eDP-1: SKIP (0.000s)
[209.090417] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s)
[209.186536] [044/144] (794s left) i915_pm_rps (engine-order)
[209.249400] Starting subtest: engine-order
[214.219079] Subtest engine-order: SUCCESS (4.969s)
[214.279534] [045/144] (789s left) gem_tiled_partial_pwrite_pread (reads)
[214.338127] Subtest reads: SKIP (0.000s)
[214.366555] [046/144] (789s left) gem_exec_balancer (busy)
[214.426262] Starting subtest: busy
[216.429716] Subtest busy: SUCCESS (2.002s)
[216.697527] [047/144] (787s left) kms_flip (flip-vs-panning-vs-hang)
[216.756484] Starting subtest: flip-vs-panning-vs-hang
[216.757789] Starting dynamic subtest: A-eDP1
[255.100567] Dynamic subtest A-eDP1: SUCCESS (38.344s)
[255.117932] Starting dynamic subtest: D-eDP1
[305.082941] Dynamic subtest D-eDP1: SUCCESS (49.980s)
[305.088048] Subtest flip-vs-panning-vs-hang: SUCCESS (88.332s)
[306.356149] [048/144] (697s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[308.939966] Subtest verify-pxp-key-change-after-suspend-resume: SKIP (0.000s)
[309.005431] [049/144] (695s left) kms_ccs (pipe-c-random-ccs-data-4-tiled-mtl-mc-ccs)
[309.386431] Starting subtest: pipe-C-random-ccs-data-4-tiled-mtl-mc-ccs
[310.551560] Subtest pipe-C-random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (1.163s)
[311.731382] [050/144] (692s left) gem_exec_schedule (preempt)
[311.784083] Starting subtest: preempt
[311.785416] Starting dynamic subtest: rcs0
[311.817152] Dynamic subtest rcs0: SUCCESS (0.032s)
[311.832341] Starting dynamic subtest: bcs0
[311.843267] Dynamic subtest bcs0: SUCCESS (0.025s)
[311.850031] Starting dynamic subtest: vcs0
[311.861410] Dynamic subtest vcs0: SUCCESS (0.017s)
[311.871087] Starting dynamic subtest: vcs1
[311.890331] Dynamic subtest vcs1: SUCCESS (0.029s)
[311.900654] Starting dynamic subtest: vecs0
[311.914295] Dynamic subtest vecs0: SUCCESS (0.023s)
[311.926204] Starting dynamic subtest: ccs0
[311.933996] Dynamic subtest ccs0: SUCCESS (0.020s)
[311.935227] Subtest preempt: SUCCESS (0.150s)
[313.533593] [051/144] (690s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[313.597746] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[313.600022] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[313.682106] [052/144] (690s left) i915_suspend (sysfs-reader)
[313.739525] Starting subtest: sysfs-reader
[335.288954] Subtest sysfs-reader: SUCCESS (5.552s)
[342.347944] [053/144] (684s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[342.478836] Starting subtest: cursorB-vs-flipB-varying-size
[342.482251] Subtest cursorB-vs-flipB-varying-size: SKIP (0.002s)
[342.622586] [054/144] (684s left) gem_render_linear_blits (basic)
[342.675201] Starting subtest: basic
[342.693262] Subtest basic: SUCCESS (0.020s)
[342.774139] [055/144] (684s left) kms_getfb (getfb-handle-protection)
[342.844404] Starting subtest: getfb-handle-protection
[342.874087] Subtest getfb-handle-protection: SUCCESS (0.033s)
[342.972435] [056/144] (684s left) gem_exec_whisper (basic-queues-priority-all)
[343.043938] Starting subtest: basic-queues-priority-all
[368.006419] Subtest basic-queues-priority-all: SUCCESS (24.957s)
[368.187828] [057/144] (659s left) kms_selftest (drm_dp_mst_helper)
[368.236722] Starting subtest: drm_dp_mst_helper
[368.378866] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[368.390817] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.014s)
[368.414078] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[368.415390] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.007s)
[368.416581] Subtest drm_dp_mst_helper: SUCCESS (0.162s)
[368.619305] [058/144] (658s left) kms_psr (psr-primary-mmap-gtt)
[368.704243] Starting subtest: psr-primary-mmap-gtt
[368.705329] Starting dynamic subtest: eDP-1
[370.223272] Dynamic subtest eDP-1: SKIP (1.511s)
[370.226119] Subtest psr-primary-mmap-gtt: SKIP (1.513s)
[370.393618] [059/144] (657s left) kms_ccs (pipe-a-crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[370.758983] Starting subtest: pipe-A-crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[371.829397] Subtest pipe-A-crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (1.065s)
[373.042726] [060/144] (654s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[373.093201] Starting subtest: framebuffer-vs-set-tiling
[373.095546] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[373.205790] [061/144] (654s left) gem_mmap_wc (write-read)
[373.243192] Subtest write-read: SKIP (0.000s)
[373.276771] [062/144] (654s left) kms_ccs (pipe-b-missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[373.656421] Starting subtest: pipe-B-missing-ccs-buffer-y-tiled-gen12-rc-ccs
[373.658994] Subtest pipe-B-missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[374.518256] [063/144] (653s left) perf (global-sseu-config-invalid)
[374.684605] Subtest global-sseu-config-invalid: SKIP (0.000s)
[374.710852] [064/144] (652s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[374.791348] Starting subtest: y-tiled-8bpp-rotate-180
[374.793784] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[374.885500] [065/144] (652s left) kms_rotation_crc (primary-rotation-90)
[374.951666] Starting subtest: primary-rotation-90
[374.954434] Subtest primary-rotation-90: SKIP (0.001s)
[375.008759] [066/144] (652s left) gem_softpin (zero)
[375.042836] Starting subtest: zero
[375.049168] Subtest zero: SUCCESS (0.008s)
[375.163838] [067/144] (652s left) v3d/v3d_perfmon (get-values-valid-perfmon)
[375.263344] Subtest get-values-valid-perfmon: SKIP (0.000s)
[375.315914] [068/144] (652s left) kms_vrr (flipline)
[375.404035] Starting subtest: flipline
[375.406893] Subtest flipline: SKIP (0.000s)
[375.471592] [069/144] (652s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[375.520979] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[375.522498] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[375.589752] [070/144] (652s left) kms_flip (2x-flip-vs-fences-interruptible)
[375.639122] Starting subtest: 2x-flip-vs-fences-interruptible
[375.641509] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[375.710908] [071/144] (652s left) gem_exec_capture (capture-recoverable)
[375.763668] Starting subtest: capture-recoverable
[375.770068] Subtest capture-recoverable: SUCCESS (0.008s)
[375.877257] [072/144] (651s left) kms_cursor_edge_walk (128x128-top-edge)
[375.946860] Starting subtest: 128x128-top-edge
[375.948124] Starting dynamic subtest: pipe-A-eDP-1
[379.514832] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.564s)
[379.534812] Starting dynamic subtest: pipe-D-eDP-1
[382.732418] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.217s)
[382.733782] Subtest 128x128-top-edge: SUCCESS (6.787s)
[383.670916] [073/144] (644s left) syncobj_wait (invalid-signal-one-illegal-handle)
[383.725977] Starting subtest: invalid-signal-one-illegal-handle
[383.727793] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[383.794314] [074/144] (644s left) kms_ccs (pipe-c-ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[384.213071] Starting subtest: pipe-C-ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[384.214495] Subtest pipe-C-ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.000s)
[385.025958] [075/144] (642s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[385.109403] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[385.111637] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[385.183168] [076/144] (642s left) syncobj_eventfd (timeline-wait-signaled)
[385.239238] Starting subtest: timeline-wait-signaled
[385.240610] Subtest timeline-wait-signaled: SUCCESS (0.001s)
[385.310607] [077/144] (642s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[385.414897] Starting subtest: yf-tiled-addfb-size-overflow
[385.417157] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[385.505798] [078/144] (642s left) gem_ctx_param (root-set)
[385.558424] Starting subtest: root-set
[385.560323] Subtest root-set: SUCCESS (0.000s)
[385.633425] [079/144] (642s left) gem_ctx_isolation (preservation)
[385.704285] Starting subtest: preservation
[385.705871] Starting dynamic subtest: rcs0
[385.805687] Dynamic subtest rcs0: SUCCESS (0.101s)
[385.824732] Starting dynamic subtest: bcs0
[385.953478] Dynamic subtest bcs0: SUCCESS (0.146s)
[385.959406] Starting dynamic subtest: vcs0
[386.077072] Dynamic subtest vcs0: SUCCESS (0.124s)
[386.094944] Starting dynamic subtest: vcs1
[387.557097] Dynamic subtest vcs1: SUCCESS (1.479s)
[387.575545] Starting dynamic subtest: vecs0
[389.552916] Dynamic subtest vecs0: SUCCESS (1.995s)
[389.560070] Starting dynamic subtest: ccs0
[391.549089] Dynamic subtest ccs0: SUCCESS (1.995s)
[391.550461] Subtest preservation: SUCCESS (5.845s)
[391.783457] [080/144] (636s left) kms_ccs (pipe-d-bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[392.195515] Starting subtest: pipe-D-bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[393.025422] Subtest pipe-D-bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.828s)
[394.204425] [081/144] (633s left) gem_exec_params (rsvd2-dirt)
[394.262834] Starting subtest: rsvd2-dirt
[394.265754] Subtest rsvd2-dirt: SKIP (0.000s)
[394.352574] [082/144] (633s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[394.402673] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[394.403828] Starting dynamic subtest: pipe-A-default-mode
[395.643893] Dynamic subtest pipe-A-default-mode: SKIP (1.237s)
[395.646975] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.239s)
[395.785254] [083/144] (632s left) syncobj_basic (bad-fd-to-handle)
[395.845532] Starting subtest: bad-fd-to-handle
[395.847087] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[395.902194] [084/144] (632s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[395.969770] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[400.948351] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.979s)
[401.046985] [085/144] (627s left) gem_exec_schedule (reorder-wide)
[401.238883] Subtest reorder-wide: SKIP (0.000s)
[401.413464] [086/144] (626s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[401.485861] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[401.488559] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[401.584895] [087/144] (626s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[401.678231] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[406.578791] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (4.904s)
[406.711503] [088/144] (621s left) vc4/vc4_perfmon (create-single-perfmon)
[406.803354] Subtest create-single-perfmon: SKIP (0.000s)
[406.857839] [089/144] (621s left) drm_fdinfo (busy)
[406.902947] Starting subtest: busy
[406.904778] Starting dynamic subtest: rcs0
[406.907786] Dynamic subtest rcs0: SKIP (0.000s)
[406.927827] Starting dynamic subtest: bcs0
[406.931447] Dynamic subtest bcs0: SKIP (0.000s)
[406.949858] Starting dynamic subtest: vcs0
[406.953098] Dynamic subtest vcs0: SKIP (0.000s)
[406.965689] Starting dynamic subtest: vcs1
[406.968484] Dynamic subtest vcs1: SKIP (0.000s)
[406.976425] Starting dynamic subtest: vecs0
[406.978925] Dynamic subtest vecs0: SKIP (0.000s)
[406.984969] Starting dynamic subtest: ccs0
[406.987252] Dynamic subtest ccs0: SKIP (0.000s)
[406.989404] Subtest busy: SKIP (0.009s)
[407.000098] [090/144] (621s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[407.075272] Starting subtest: x-tiled-8bpp-rotate-0
[408.232190] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.157s)
[408.357932] [091/144] (619s left) kms_cursor_crc (cursor-onscreen-max-size)
[408.639630] Starting subtest: cursor-onscreen-max-size
[408.643055] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[408.739633] [092/144] (619s left) kms_ccs (pipe-a-crc-primary-basic-4-tiled-dg2-mc-ccs)
[409.081525] Starting subtest: pipe-A-crc-primary-basic-4-tiled-dg2-mc-ccs
[409.084502] Subtest pipe-A-crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[409.966718] [093/144] (618s left) kms_pm_rpm (modeset-lpsp-stress)
[411.595988] Starting subtest: modeset-lpsp-stress
[434.273210] Subtest modeset-lpsp-stress: SUCCESS (22.676s)
[434.357662] [094/144] (594s left) gem_exec_store (cachelines)
[434.422631] Starting subtest: cachelines
[434.423794] Starting dynamic subtest: rcs0
[434.486367] Dynamic subtest rcs0: SUCCESS (0.063s)
[434.504891] Starting dynamic subtest: bcs0
[434.545188] Dynamic subtest bcs0: SUCCESS (0.057s)
[434.563293] Starting dynamic subtest: vcs0
[436.473173] Dynamic subtest vcs0: SUCCESS (1.924s)
[436.492368] Starting dynamic subtest: vcs1
[438.456980] Dynamic subtest vcs1: SUCCESS (1.982s)
[438.476595] Starting dynamic subtest: vecs0
[440.441570] Dynamic subtest vecs0: SUCCESS (1.982s)
[440.460750] Starting dynamic subtest: ccs0
[440.512460] Dynamic subtest ccs0: SUCCESS (0.071s)
[440.514239] Subtest cachelines: SUCCESS (6.090s)
[440.696358] [095/144] (587s left) gem_ctx_persistence (legacy-engines-hang)
[440.748780] Starting subtest: legacy-engines-hang
[440.749772] Starting dynamic subtest: render
[440.820197] Dynamic subtest render: SUCCESS (0.071s)
[440.840518] Starting dynamic subtest: bsd1
[440.930329] Dynamic subtest bsd1: SUCCESS (0.107s)
[440.951463] Starting dynamic subtest: bsd2
[441.018104] Dynamic subtest bsd2: SUCCESS (0.086s)
[441.038629] Starting dynamic subtest: blt
[441.112047] Dynamic subtest blt: SUCCESS (0.092s)
[441.135947] Starting dynamic subtest: vebox
[441.212145] Dynamic subtest vebox: SUCCESS (0.098s)
[441.213810] Subtest legacy-engines-hang: SUCCESS (0.465s)
[441.296587] [096/144] (587s left) gem_flink_race (flink_close)
[441.347319] Starting subtest: flink_close
[446.402044] Subtest flink_close: SUCCESS (5.054s)
[446.464016] [097/144] (582s left) gem_workarounds (basic-read-fd)
[446.522358] Starting subtest: basic-read-fd
[446.542745] Subtest basic-read-fd: SUCCESS (0.020s)
[446.668322] [098/144] (581s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[446.754994] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[446.756928] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[446.848711] [099/144] (581s left) fbdev (read)
[446.898517] Starting subtest: read
[447.439656] Subtest read: SUCCESS (0.539s)
[447.498921] [100/144] (581s left) gem_partial_pwrite_pread (writes-after-reads-display)
[447.557909] Subtest writes-after-reads-display: SKIP (0.000s)
[447.612528] [101/144] (580s left) kms_ccs (pipe-d-bad-aux-stride-y-tiled-ccs)
[448.023458] Starting subtest: pipe-D-bad-aux-stride-y-tiled-ccs
[448.026193] Subtest pipe-D-bad-aux-stride-y-tiled-ccs: SKIP (0.000s)
[448.887374] [102/144] (579s left) gem_mmap_offset (bad-extensions)
[448.931642] Starting subtest: bad-extensions
[448.932827] Subtest bad-extensions: SUCCESS (0.000s)
[449.031145] [103/144] (579s left) gem_readwrite (write-bad-handle)
[449.096288] Subtest write-bad-handle: SKIP (0.000s)
[449.137310] [104/144] (579s left) syncobj_wait (single-wait-for-submit-submitted)
[449.169271] Starting subtest: single-wait-for-submit-submitted
[449.276994] Subtest single-wait-for-submit-submitted: SUCCESS (0.105s)
[449.350419] [105/144] (579s left) gem_close (many-handles-one-vma)
[449.418990] Starting subtest: many-handles-one-vma
[449.434718] Subtest many-handles-one-vma: SUCCESS (0.016s)
[449.525167] [106/144] (579s left) kms_ccs (pipe-b-crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[449.902200] Starting subtest: pipe-B-crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[449.905299] Subtest pipe-B-crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[450.803582] [107/144] (577s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[450.886842] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[452.052481] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.166s)
[452.183719] [108/144] (576s left) gem_lmem_swapping (parallel-random-verify-ccs)
[452.222923] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[452.233452] [109/144] (576s left) syncobj_basic (create-signaled)
[452.263000] Starting subtest: create-signaled
[452.264098] Subtest create-signaled: SUCCESS (0.000s)
[452.313577] [110/144] (576s left) kms_ccs (pipe-b-bad-aux-stride-y-tiled-gen12-rc-ccs)
[452.693305] Starting subtest: pipe-B-bad-aux-stride-y-tiled-gen12-rc-ccs
[452.696239] Subtest pipe-B-bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[453.558680] [111/144] (575s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[453.628111] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[453.630262] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[453.713457] [112/144] (575s left) sysfs_preempt_timeout (invalid)
[453.749880] Starting subtest: invalid
[453.751268] Starting dynamic subtest: vecs0
[453.752657] Dynamic subtest vecs0: SUCCESS (0.000s)
[453.771528] Starting dynamic subtest: ccs0
[453.772687] Dynamic subtest ccs0: SUCCESS (0.000s)
[453.783021] Starting dynamic subtest: vcs0
[453.784109] Dynamic subtest vcs0: SUCCESS (0.000s)
[453.797211] Starting dynamic subtest: bcs0
[453.798944] Dynamic subtest bcs0: SUCCESS (0.000s)
[453.812795] Starting dynamic subtest: rcs0
[453.813976] Dynamic subtest rcs0: SUCCESS (0.000s)
[453.823163] Starting dynamic subtest: vcs1
[453.824314] Dynamic subtest vcs1: SUCCESS (0.000s)
[453.825409] Subtest invalid: SUCCESS (0.011s)
[453.836752] [113/144] (575s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[453.915947] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[453.918293] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[454.018456] [114/144] (574s left) i915_pciid
[454.160311] [115/144] (574s left) gem_userptr_blits (vma-merge)
[454.259032] Starting subtest: vma-merge
[474.395508] Subtest vma-merge: FAIL (20.118s)
[474.460025] [116/144] (554s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[474.522867] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[474.525910] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[474.713131] [117/144] (554s left) kms_ccs (pipe-d-crc-primary-rotation-180-y-tiled-ccs)
[475.099132] Starting subtest: pipe-D-crc-primary-rotation-180-y-tiled-ccs
[475.101639] Subtest pipe-D-crc-primary-rotation-180-y-tiled-ccs: SKIP (0.000s)
[475.958357] [118/144] (553s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[476.033540] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[476.035575] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[476.110591] [119/144] (552s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-wc)
[476.183734] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-wc
[479.002181] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (2.819s)
[479.137945] [120/144] (549s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[479.247349] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[481.787683] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (2.542s)
[481.895765] [121/144] (547s left) api_intel_bb (blit-noreloc-keep-cache)
[481.951134] Starting subtest: blit-noreloc-keep-cache
[481.966247] Subtest blit-noreloc-keep-cache: SUCCESS (0.012s)
[482.050323] [122/144] (547s left) drm_fdinfo (virtual-busy-idle)
[482.097429] Starting subtest: virtual-busy-idle
[482.099557] Subtest virtual-busy-idle: SKIP (0.000s)
[482.159069] [123/144] (547s left) kms_psr (psr2-cursor-plane-onoff)
[482.209593] Starting subtest: psr2-cursor-plane-onoff
[482.210839] Starting dynamic subtest: eDP-1
[484.003840] Dynamic subtest eDP-1: SUCCESS (1.793s)
[484.005052] Subtest psr2-cursor-plane-onoff: SUCCESS (1.794s)
[484.916586] [124/144] (544s left) vgem_basic (bad-handle)
[484.993664] Starting subtest: bad-handle
[484.994925] Subtest bad-handle: SUCCESS (0.000s)
[485.052818] [125/144] (544s left) kms_sequence (get-forked-busy)
[485.113656] Starting subtest: get-forked-busy
[485.115010] Starting dynamic subtest: pipe-A-eDP-1
[487.059923] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.945s)
[487.081209] Starting dynamic subtest: pipe-B-eDP-1
[489.787773] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.725s)
[489.809856] Starting dynamic subtest: pipe-C-eDP-1
[492.440739] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.649s)
[492.457024] Starting dynamic subtest: pipe-D-eDP-1
[495.127404] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.684s)
[495.128653] Subtest get-forked-busy: SUCCESS (10.015s)
[496.042849] [126/144] (533s left) i915_suspend (basic-s3-without-i915)
[496.104150] Starting subtest: basic-s3-without-i915
[497.715421] Subtest basic-s3-without-i915: SKIP (1.607s)
[498.695677] [127/144] (530s left) gem_wait (invalid-flags)
[498.735440] Starting subtest: invalid-flags
[498.736642] Subtest invalid-flags: SUCCESS (0.000s)
[498.947603] [128/144] (530s left) v3d/v3d_submit_csd (bad-multisync-extension)
[499.026795] Subtest bad-multisync-extension: SKIP (0.000s)
[499.070245] [129/144] (530s left) kms_pipe_crc_basic (bad-source)
[499.153471] Starting subtest: bad-source
[499.154473] Subtest bad-source: SUCCESS (0.000s)
[499.215092] [130/144] (530s left) kms_dsc (dsc-with-bpc)
[499.282255] Subtest dsc-with-bpc: SKIP (0.000s)
[499.318948] [131/144] (530s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[499.417964] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[500.219374] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: FAIL (0.728s)
[500.289426] [132/144] (529s left) gem_mmap_offset (ptrace)
[500.339490] Starting subtest: ptrace
[500.345597] Starting dynamic subtest: smem0-wb
[500.387053] Dynamic subtest smem0-wb: SUCCESS (0.041s)
[500.394811] Starting dynamic subtest: smem0-wc
[500.418023] Dynamic subtest smem0-wc: SUCCESS (0.029s)
[500.430431] Starting dynamic subtest: smem0-uc
[500.464662] Dynamic subtest smem0-uc: SUCCESS (0.044s)
[500.465900] Subtest ptrace: SUCCESS (0.127s)
[500.567768] [133/144] (528s left) kms_ccs (pipe-d-random-ccs-data-4-tiled-mtl-rc-ccs)
[500.981271] Starting subtest: pipe-D-random-ccs-data-4-tiled-mtl-rc-ccs
[501.766308] Subtest pipe-D-random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (0.785s)
[502.957475] [134/144] (526s left) kms_ccs (pipe-a-missing-ccs-buffer-y-tiled-ccs)
[503.368318] Starting subtest: pipe-A-missing-ccs-buffer-y-tiled-ccs
[503.370865] Subtest pipe-A-missing-ccs-buffer-y-tiled-ccs: SKIP (0.000s)
[504.244073] [135/144] (525s left) gem_create (hog-create)
[504.319911] Starting subtest: hog-create
[504.321188] Starting dynamic subtest: smem0
[519.642708] Dynamic subtest smem0: FAIL (15.284s)
[519.643852] Subtest hog-create: FAIL (15.285s)
[521.538502] [136/144] (507s left) kms_prop_blob (blob-multiple)
[521.601301] Starting subtest: blob-multiple
[521.605609] Subtest blob-multiple: SUCCESS (0.002s)
[521.678303] [137/144] (507s left) gem_exec_parallel (userptr)
[521.758163] Starting subtest: userptr
[521.759696] Starting dynamic subtest: rcs0
[523.757061] Dynamic subtest rcs0: SUCCESS (1.999s)
[523.777369] Starting dynamic subtest: bcs0
[525.563831] Dynamic subtest bcs0: SUCCESS (1.804s)
[525.576072] Starting dynamic subtest: vcs0
[527.462426] Dynamic subtest vcs0: SUCCESS (1.895s)
[527.481481] Starting dynamic subtest: vcs1
[529.426202] Dynamic subtest vcs1: SUCCESS (1.963s)
[529.443830] Starting dynamic subtest: vecs0
[531.470499] Dynamic subtest vecs0: SUCCESS (2.042s)
[531.491334] Starting dynamic subtest: ccs0
[533.363042] Dynamic subtest ccs0: SUCCESS (1.893s)
[533.364533] Subtest userptr: SUCCESS (11.606s)
[533.555335] [138/144] (496s left) kms_ccs (pipe-c-ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[533.943441] Starting subtest: pipe-C-ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[533.946489] Subtest pipe-C-ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[534.838160] [139/144] (494s left) gem_exec_reloc (basic-gtt-cpu-active)
[534.892489] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[534.951947] [140/144] (494s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[535.064339] Starting subtest: fbcpsr-stridechange
[539.446787] Subtest fbcpsr-stridechange: SUCCESS (4.383s)
[539.579351] [141/144] (490s left) kms_lease (master-vs-lease)
[539.659171] Starting subtest: master-vs-lease
[539.660572] Subtest master-vs-lease: SUCCESS (0.001s)
[539.721229] [142/144] (489s left) prime_vgem (basic-fence-flip)
[539.797285] Starting subtest: basic-fence-flip
[540.126509] Subtest basic-fence-flip: SUCCESS (0.329s)
[540.213890] [143/144] (489s left) sysfs_heartbeat_interval (idempotent)
[540.276790] Starting subtest: idempotent
[540.278288] Starting dynamic subtest: vecs0
[540.279777] Dynamic subtest vecs0: SUCCESS (0.001s)
[540.290861] Starting dynamic subtest: ccs0
[540.291860] Dynamic subtest ccs0: SUCCESS (0.001s)
[540.296984] Starting dynamic subtest: vcs0
[540.298005] Dynamic subtest vcs0: SUCCESS (0.000s)
[540.302898] Starting dynamic subtest: bcs0
[540.303901] Dynamic subtest bcs0: SUCCESS (0.000s)
[540.308843] Starting dynamic subtest: rcs0
[540.309840] Dynamic subtest rcs0: SUCCESS (0.000s)
[540.314778] Starting dynamic subtest: vcs1
[540.315816] Dynamic subtest vcs1: SUCCESS (0.000s)
[540.316816] Subtest idempotent: SUCCESS (0.006s)
[540.327344] [144/144] (489s left) kms_flip (plain-flip-fb-recreate-interruptible)
[540.386540] Starting subtest: plain-flip-fb-recreate-interruptible
[540.390811] Starting dynamic subtest: A-eDP1
[549.347339] Dynamic subtest A-eDP1: SUCCESS (8.957s)
[549.369939] Starting dynamic subtest: B-eDP1
[558.307120] Dynamic subtest B-eDP1: SUCCESS (8.957s)
[558.324811] Starting dynamic subtest: C-eDP1
[567.256053] Dynamic subtest C-eDP1: SUCCESS (8.947s)
[567.273833] Starting dynamic subtest: D-eDP1
[576.151124] Dynamic subtest D-eDP1: SUCCESS (8.894s)
[576.159935] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.773s)
[577.457687] Closing watchdogs
Done.