[26.168927] Initializing watchdogs
[26.168993]   /dev/watchdog0
[26.173402] [001/141] (960s left) kms_selftest (all-tests)
[26.279722] Starting subtest: all-tests
[26.281334] Subtest all-tests: SKIP (0.000s)
[26.304922] [002/141] (960s left) drm_fdinfo (busy)
[26.357981] Starting subtest: busy
[26.358980] Starting dynamic subtest: rcs0
[26.882141] Dynamic subtest rcs0: SUCCESS (0.524s)
[26.886279] Starting dynamic subtest: bcs0
[27.399248] Dynamic subtest bcs0: SUCCESS (0.517s)
[27.405218] Starting dynamic subtest: vcs0
[27.918491] Dynamic subtest vcs0: SUCCESS (0.518s)
[27.923609] Starting dynamic subtest: vcs1
[28.441485] Dynamic subtest vcs1: SUCCESS (0.524s)
[28.447293] Starting dynamic subtest: vecs0
[28.964522] Dynamic subtest vecs0: SUCCESS (0.523s)
[28.965658] Subtest busy: SUCCESS (2.606s)
[29.011323] [003/141] (957s left) gem_ctx_isolation (dirty-create)
[29.067181] Starting subtest: dirty-create
[29.067982] Starting dynamic subtest: rcs0
[29.266174] Dynamic subtest rcs0: SUCCESS (0.190s)
[29.269194] Starting dynamic subtest: bcs0
[29.476813] Dynamic subtest bcs0: SUCCESS (0.210s)
[29.479783] Starting dynamic subtest: vcs0
[29.697820] Dynamic subtest vcs0: SUCCESS (0.221s)
[29.700795] Starting dynamic subtest: vcs1
[29.926137] Dynamic subtest vcs1: SUCCESS (0.228s)
[29.929230] Starting dynamic subtest: vecs0
[30.140423] Dynamic subtest vecs0: SUCCESS (0.214s)
[30.141178] Subtest dirty-create: SUCCESS (1.065s)
[30.279178] [004/141] (956s left) kms_ccs (pipe-d-missing-ccs-buffer-y_tiled_gen12_rc_ccs)
[30.706030] Starting subtest: pipe-D-missing-ccs-buffer-y_tiled_gen12_rc_ccs
[30.706841] Subtest pipe-D-missing-ccs-buffer-y_tiled_gen12_rc_ccs: SUCCESS (0.000s)
[30.808214] [005/141] (955s left) kms_plane_scaling (plane-downscale-with-pixel-format-factor-0-75)
[30.904405] Starting subtest: plane-downscale-with-pixel-format-factor-0-75
[30.905193] Starting dynamic subtest: pipe-A-HDMI-A-1
[38.405715] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.500s)
[38.409539] Starting dynamic subtest: pipe-B-HDMI-A-1
[45.939815] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (7.533s)
[45.943686] Starting dynamic subtest: pipe-C-HDMI-A-1
[46.123054] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.182s)
[46.126728] Starting dynamic subtest: pipe-D-HDMI-A-1
[46.305506] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.181s)
[46.306243] Subtest plane-downscale-with-pixel-format-factor-0-75: SUCCESS (15.402s)
[46.426254] [006/141] (940s left) perf (invalid-oa-metric-set-id)
[46.515300] Starting subtest: invalid-oa-metric-set-id
[46.523971] Subtest invalid-oa-metric-set-id: SUCCESS (0.009s)
[46.538724] [007/141] (940s left) gem_exec_reloc (basic-write-read-active)
[46.587012] Starting subtest: basic-write-read-active
[46.704332] Subtest basic-write-read-active: SUCCESS (0.109s)
[46.783631] [008/141] (939s left) gem_exec_whisper (basic-forked-all)
[46.837134] Starting subtest: basic-forked-all
[61.546133] Subtest basic-forked-all: SUCCESS (14.708s)
[61.707625] [009/141] (925s left) kms_universal_plane (universal-plane-pipe-a-sanity)
[61.826013] Starting subtest: universal-plane-pipe-A-sanity
[62.080808] Subtest universal-plane-pipe-A-sanity: SUCCESS (0.255s)
[62.150651] [010/141] (924s left) syncobj_wait (invalid-single-wait-unsubmitted)
[62.199868] Starting subtest: invalid-single-wait-unsubmitted
[62.200591] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[62.234025] [011/141] (924s left) kms_prop_blob (invalid-get-prop-any)
[62.280165] Starting subtest: invalid-get-prop-any
[62.280960] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[62.316496] [012/141] (924s left) gem_mmap_wc (pf-nonblock)
[62.364718] Starting subtest: pf-nonblock
[62.366509] Subtest pf-nonblock: SUCCESS (0.001s)
[62.430805] [013/141] (924s left) kms_ccs (pipe-a-random-ccs-data-y_tiled_ccs)
[62.615113] Starting subtest: pipe-A-random-ccs-data-y_tiled_ccs
[62.617475] Subtest pipe-A-random-ccs-data-y_tiled_ccs: SKIP (0.000s)
[62.954480] [014/141] (923s left) kms_cursor_legacy (forked-bo)
[63.048522] Starting subtest: forked-bo
[63.049272] Starting dynamic subtest: pipe-A
[84.570328] Dynamic subtest pipe-A: SUCCESS (21.513s)
[84.574131] Starting dynamic subtest: pipe-B
[106.119029] Dynamic subtest pipe-B: SUCCESS (21.524s)
[106.124009] Starting dynamic subtest: pipe-C
[127.643573] Dynamic subtest pipe-C: SUCCESS (21.524s)
[127.647898] Starting dynamic subtest: pipe-D
[149.179462] Dynamic subtest pipe-D: SUCCESS (21.536s)
[149.184081] Starting dynamic subtest: all-pipes
[170.702928] Dynamic subtest all-pipes: SUCCESS (21.548s)
[170.703936] Subtest forked-bo: SUCCESS (107.645s)
[170.733491] [015/141] (816s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[170.836617] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[170.838269] Starting dynamic subtest: pipe-A-valid-mode
[170.885156] Dynamic subtest pipe-A-valid-mode: SKIP (0.046s)
[170.886536] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.048s)
[170.953165] [016/141] (815s left) kms_psr (dpms)
[170.999536] Subtest dpms: SKIP (0.000s)
[171.021116] [017/141] (815s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-pwrite)
[171.122911] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-pwrite
[171.124493] Subtest fbcpsr-1p-offscren-pri-indfb-draw-pwrite: SKIP (0.000s)
[171.170184] [018/141] (815s left) gem_spin_batch (resubmit-new)
[171.221305] Starting subtest: resubmit-new
[171.222086] Starting dynamic subtest: rcs0
[171.224287] Dynamic subtest rcs0: SUCCESS (0.003s)
[171.228724] Starting dynamic subtest: bcs0
[171.229498] Dynamic subtest bcs0: SUCCESS (0.002s)
[171.234403] Starting dynamic subtest: vcs0
[171.235127] Dynamic subtest vcs0: SUCCESS (0.002s)
[171.238918] Starting dynamic subtest: vcs1
[171.239609] Dynamic subtest vcs1: SUCCESS (0.003s)
[171.243200] Starting dynamic subtest: vecs0
[171.243917] Dynamic subtest vecs0: SUCCESS (0.003s)
[171.244615] Subtest resubmit-new: SUCCESS (0.013s)
[171.386691] [019/141] (815s left) kms_ccs (pipe-b-bad-pixel-format-y_tiled_gen12_rc_ccs_cc)
[171.610128] Starting subtest: pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs_cc
[171.610948] Subtest pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.000s)
[171.907688] [020/141] (814s left) gem_softpin (noreloc-interruptible)
[171.957803] Starting subtest: noreloc-interruptible
[177.396274] Subtest noreloc-interruptible: SUCCESS (5.403s)
[177.429742] [021/141] (809s left) kms_lease (lease_unleased_crtc)
[177.540771] Starting subtest: lease_unleased_crtc
[177.542417] Starting dynamic subtest: pipe-A-HDMI-A-1
[177.620810] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.077s)
[177.633584] Starting dynamic subtest: pipe-B-HDMI-A-1
[177.660230] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.038s)
[177.674817] Starting dynamic subtest: pipe-C-HDMI-A-1
[177.699114] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.037s)
[177.704569] Starting dynamic subtest: pipe-D-HDMI-A-1
[177.738036] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.036s)
[177.738802] Subtest lease_unleased_crtc: SUCCESS (0.197s)
[177.828524] [022/141] (809s left) syncobj_wait (single-wait-all-for-submit-signaled)
[177.875913] Starting subtest: single-wait-all-for-submit-signaled
[177.876636] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[177.911698] [023/141] (809s left) vgem_basic (bad-fence)
[177.975277] Starting subtest: bad-fence
[177.976020] Subtest bad-fence: SUCCESS (0.000s)
[178.003246] [024/141] (808s left) kms_big_joiner (2x-modeset)
[178.097953] Subtest 2x-modeset: SKIP (0.000s)
[178.113283] [025/141] (808s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[178.214191] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[178.215741] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[178.262405] [026/141] (808s left) gen9_exec_parse (valid-registers)
[178.310834] Subtest valid-registers: SKIP (0.000s)
[178.329659] [027/141] (808s left) gem_mmap_gtt (close-race)
[178.375578] Starting subtest: close-race
[198.466355] Subtest close-race: SUCCESS (20.057s)
[198.504042] [028/141] (788s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[198.622542] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[198.623932] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[198.673152] [029/141] (788s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[198.768601] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[199.364361] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.596s)
[199.450386] [030/141] (787s left) gem_mmap_gtt (basic-small-copy-odd)
[199.495058] Starting subtest: basic-small-copy-odd
[201.563138] Subtest basic-small-copy-odd: SUCCESS (2.068s)
[201.605306] [031/141] (785s left) kms_vblank (pipe-b-query-forked-hang)
[201.739763] Starting subtest: pipe-B-query-forked-hang
[216.039107] Subtest pipe-B-query-forked-hang: SUCCESS (14.300s)
[216.137710] [032/141] (770s left) perf (invalid-create-userspace-config)
[216.232989] Starting subtest: invalid-create-userspace-config
[216.234610] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[216.249890] [033/141] (770s left) perf (mi-rpc)
[216.329361] Starting subtest: mi-rpc
[216.330864] Subtest mi-rpc: SKIP (0.000s)
[216.341815] [034/141] (770s left) kms_ccs (pipe-a-bad-aux-stride-4_tiled_mtl_rc_ccs_cc)
[216.543484] Starting subtest: pipe-A-bad-aux-stride-4_tiled_mtl_rc_ccs_cc
[216.545133] Subtest pipe-A-bad-aux-stride-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[216.857029] [035/141] (770s left) gem_ccs (block-multicopy-compressed)
[216.906877] Starting subtest: block-multicopy-compressed
[216.908334] Subtest block-multicopy-compressed: SKIP (0.000s)
[216.940588] [036/141] (770s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[217.042488] Starting subtest: y-tiled-8bpp-rotate-0
[218.012871] Subtest y-tiled-8bpp-rotate-0: SUCCESS (0.970s)
[218.092456] [037/141] (768s left) feature_discovery (display-4x)
[218.189571] Starting subtest: display-4x
[218.191093] Subtest display-4x: SKIP (0.000s)
[218.224499] [038/141] (768s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[218.323771] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[219.454748] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (1.132s)
[219.555909] [039/141] (767s left) api_intel_bb (reset-flags)
[219.610365] Starting subtest: reset-flags
[219.615351] Subtest reset-flags: SUCCESS (0.005s)
[219.692465] [040/141] (767s left) v3d/v3d_submit_cl (single-in-sync)
[219.771572] Subtest single-in-sync: SKIP (0.000s)
[219.800742] [041/141] (767s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[219.910529] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[219.911933] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[219.966636] [042/141] (767s left) kms_properties (invalid-properties-legacy)
[220.060450] Starting subtest: invalid-properties-legacy
[220.362136] Subtest invalid-properties-legacy: SUCCESS (0.293s)
[220.393239] [043/141] (766s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[220.494956] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[220.496421] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[220.558294] [044/141] (766s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[220.656928] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[220.658333] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[220.708143] [045/141] (766s left) gem_exec_schedule (u-fairslice-all)
[220.763762] Starting subtest: u-fairslice-all
[222.795470] Subtest u-fairslice-all: SUCCESS (2.031s)
[223.068489] [046/141] (764s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[223.180775] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[223.182141] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[223.233691] [047/141] (763s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[223.329275] Starting subtest: primary-y-tiled-reflect-x-0
[228.142418] Subtest primary-y-tiled-reflect-x-0: SUCCESS (4.813s)
[228.294341] [048/141] (758s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[228.440418] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[228.495357] [049/141] (758s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[228.594440] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[229.713529] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (1.120s)
[229.801674] [050/141] (757s left) gem_exec_big (single)
[229.857131] Starting subtest: single
[233.049633] Subtest single: SUCCESS (3.183s)
[233.531820] [051/141] (753s left) kms_flip (2x-flip-vs-panning)
[233.652849] Starting subtest: 2x-flip-vs-panning
[233.665589] Subtest 2x-flip-vs-panning: SKIP (0.012s)
[233.709688] [052/141] (753s left) kms_cursor_crc (cursor-random-128x42)
[233.812976] Starting subtest: cursor-random-128x42
[233.818884] Starting dynamic subtest: pipe-A-HDMI-A-1
[235.753656] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.936s)
[235.776940] Starting dynamic subtest: pipe-D-HDMI-A-1
[238.438182] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.664s)
[238.438951] Subtest cursor-random-128x42: SUCCESS (4.624s)
[238.530266] [053/141] (748s left) gem_exec_fence (invalid-timeline-fence-array)
[238.973715] Starting subtest: invalid-timeline-fence-array
[238.980829] Subtest invalid-timeline-fence-array: SUCCESS (0.006s)
[239.124513] [054/141] (748s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[239.228876] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[239.230278] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[239.279448] [055/141] (748s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[239.425868] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[239.481503] [056/141] (747s left) gem_ctx_shared (q-promotion)
[239.534729] Starting subtest: Q-promotion
[239.535451] Starting dynamic subtest: rcs0
[239.576898] Dynamic subtest rcs0: SUCCESS (0.042s)
[239.581982] Starting dynamic subtest: bcs0
[239.617599] Dynamic subtest bcs0: SUCCESS (0.040s)
[239.622268] Starting dynamic subtest: vcs0
[239.658857] Dynamic subtest vcs0: SUCCESS (0.041s)
[239.663528] Starting dynamic subtest: vcs1
[239.699191] Dynamic subtest vcs1: SUCCESS (0.040s)
[239.703962] Starting dynamic subtest: vecs0
[239.751435] Dynamic subtest vecs0: SUCCESS (0.042s)
[239.752465] Subtest Q-promotion: SUCCESS (0.206s)
[239.895750] [057/141] (747s left) i915_module_load (reload-no-display)
[239.951818] Starting subtest: reload-no-display
[245.700247] Subtest reload-no-display: SUCCESS (5.740s)
[245.713456] [058/141] (741s left) kms_draw_crc (draw-method-mmap-gtt)
[246.246351] Starting subtest: draw-method-mmap-gtt
[246.247129] Starting dynamic subtest: xrgb8888-untiled
[246.403484] Dynamic subtest xrgb8888-untiled: SUCCESS (0.157s)
[246.408553] Starting dynamic subtest: rgb565-untiled
[246.553459] Dynamic subtest rgb565-untiled: SUCCESS (0.150s)
[246.558471] Starting dynamic subtest: xrgb2101010-untiled
[246.686744] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.133s)
[246.691859] Starting dynamic subtest: xrgb8888-xtiled
[246.761829] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.075s)
[246.766798] Starting dynamic subtest: rgb565-xtiled
[246.836868] Dynamic subtest rgb565-xtiled: SUCCESS (0.075s)
[246.841801] Starting dynamic subtest: xrgb2101010-xtiled
[246.903532] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.066s)
[246.908772] Starting dynamic subtest: xrgb8888-ytiled
[246.978895] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.075s)
[246.983189] Starting dynamic subtest: rgb565-ytiled
[247.062260] Dynamic subtest rgb565-ytiled: SUCCESS (0.083s)
[247.068340] Starting dynamic subtest: xrgb2101010-ytiled
[247.129475] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.066s)
[247.130873] Subtest draw-method-mmap-gtt: SUCCESS (0.883s)
[247.213401] [059/141] (740s left) i915_pm_rpm (universal-planes)
[258.770994] Starting subtest: universal-planes
[258.772468] Starting dynamic subtest: plane-31
[260.930106] Dynamic subtest plane-31: SUCCESS (2.158s)
[260.935286] Starting dynamic subtest: plane-40
[263.332523] Dynamic subtest plane-40: SUCCESS (2.402s)
[263.342429] Starting dynamic subtest: plane-49
[265.508623] Dynamic subtest plane-49: SUCCESS (2.175s)
[265.513804] Starting dynamic subtest: plane-58
[267.638394] Dynamic subtest plane-58: SUCCESS (2.129s)
[267.642355] Starting dynamic subtest: plane-67
[270.016032] Dynamic subtest plane-67: SUCCESS (2.376s)
[270.025896] Starting dynamic subtest: plane-76
[272.263938] Dynamic subtest plane-76: SUCCESS (2.247s)
[272.273877] Starting dynamic subtest: plane-85
[274.659433] Dynamic subtest plane-85: SUCCESS (2.395s)
[274.663503] Starting dynamic subtest: plane-94
[276.742246] Dynamic subtest plane-94: SUCCESS (2.082s)
[276.743110] Subtest universal-planes: SUCCESS (17.972s)
[276.875840] [060/141] (710s left) sw_sync (timeline_closed)
[276.929541] Starting subtest: timeline_closed
[276.930310] Subtest timeline_closed: SUCCESS (0.000s)
[276.955809] [061/141] (710s left) gem_exec_suspend (basic-s3-devices)
[277.009798] Starting subtest: basic-S3-devices
[277.010620] Starting dynamic subtest: smem
[283.557952] Dynamic subtest smem: SUCCESS (6.548s)
[283.558679] Subtest basic-S3-devices: SUCCESS (6.548s)
[290.081796] [062/141] (703s left) gem_wait (busy)
[290.148388] Starting subtest: busy
[290.149208] Starting dynamic subtest: all-engines
[290.662643] Dynamic subtest all-engines: SUCCESS (0.513s)
[290.667687] Starting dynamic subtest: rcs0
[291.182926] Dynamic subtest rcs0: SUCCESS (0.521s)
[291.188296] Starting dynamic subtest: bcs0
[291.695256] Dynamic subtest bcs0: SUCCESS (0.509s)
[291.699891] Starting dynamic subtest: vcs0
[292.203590] Dynamic subtest vcs0: SUCCESS (0.511s)
[292.208319] Starting dynamic subtest: vcs1
[292.720226] Dynamic subtest vcs1: SUCCESS (0.517s)
[292.725042] Starting dynamic subtest: vecs0
[293.231746] Dynamic subtest vecs0: SUCCESS (0.509s)
[293.232586] Subtest busy: SUCCESS (3.081s)
[293.396617] [063/141] (700s left) kms_writeback (writeback-fb-id)
[293.546129] Subtest writeback-fb-id: SKIP (0.000s)
[293.570834] [064/141] (700s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[293.624153] Starting subtest: legacy-engines-hostile-preempt
[293.624922] Starting dynamic subtest: render
[293.707175] Dynamic subtest render: SUCCESS (0.082s)
[293.712459] Starting dynamic subtest: bsd1
[293.793759] Dynamic subtest bsd1: SUCCESS (0.085s)
[293.806745] Starting dynamic subtest: bsd2
[293.886778] Dynamic subtest bsd2: SUCCESS (0.092s)
[293.899468] Starting dynamic subtest: blt
[293.981837] Dynamic subtest blt: SUCCESS (0.094s)
[293.994506] Starting dynamic subtest: vebox
[294.070082] Dynamic subtest vebox: SUCCESS (0.087s)
[294.071448] Subtest legacy-engines-hostile-preempt: SUCCESS (0.445s)
[294.119535] [065/141] (699s left) kms_rotation_crc (sprite-rotation-180)
[294.224120] Starting subtest: sprite-rotation-180
[296.883254] Subtest sprite-rotation-180: SUCCESS (2.659s)
[297.009967] [066/141] (696s left) kms_ccs (pipe-c-ccs-on-another-bo-yf_tiled_ccs)
[297.362354] Starting subtest: pipe-C-ccs-on-another-bo-yf_tiled_ccs
[297.363959] Subtest pipe-C-ccs-on-another-bo-yf_tiled_ccs: SKIP (0.000s)
[297.537863] [067/141] (696s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[297.658446] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[297.659868] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[297.715448] [068/141] (696s left) gem_pwrite (basic-exhaustion)
[297.762701] Starting subtest: basic-exhaustion
[301.469924] Subtest basic-exhaustion: SUCCESS (3.699s)
[301.514206] [069/141] (692s left) kms_ccs (pipe-d-bad-pixel-format-y_tiled_ccs)
[301.892535] Starting subtest: pipe-D-bad-pixel-format-y_tiled_ccs
[301.893934] Subtest pipe-D-bad-pixel-format-y_tiled_ccs: SKIP (0.000s)
[302.042073] [070/141] (691s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[302.151792] Starting subtest: x-tiled-32bpp-rotate-0
[303.387770] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.236s)
[303.527757] [071/141] (690s left) gem_workarounds (reset-context)
[303.591621] Starting subtest: reset-context
[303.600547] Subtest reset-context: SUCCESS (0.008s)
[303.678725] [072/141] (690s left) kms_setmode (basic-clone-single-crtc)
[303.731577] Starting subtest: basic-clone-single-crtc
[303.734080] Subtest basic-clone-single-crtc: SKIP (0.000s)
[303.767571] [073/141] (690s left) gem_exec_schedule (pi-common)
[303.958497] Starting subtest: pi-common
[303.959407] Starting dynamic subtest: rcs0
[304.026875] Dynamic subtest rcs0: SUCCESS (0.076s)
[304.038483] Starting dynamic subtest: bcs0
[304.102472] Dynamic subtest bcs0: SUCCESS (0.075s)
[304.114582] Starting dynamic subtest: vcs0
[304.179169] Dynamic subtest vcs0: SUCCESS (0.076s)
[304.190726] Starting dynamic subtest: vcs1
[304.254950] Dynamic subtest vcs1: SUCCESS (0.075s)
[304.266378] Starting dynamic subtest: vecs0
[304.331882] Dynamic subtest vecs0: SUCCESS (0.076s)
[304.333182] Subtest pi-common: SUCCESS (0.381s)
[304.486727] [074/141] (689s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[304.584791] Starting subtest: cursorB-vs-flipB-legacy
[304.587121] Subtest cursorB-vs-flipB-legacy: SKIP (0.002s)
[304.625811] [075/141] (689s left) kms_vblank (pipe-d-wait-forked)
[304.722470] Starting subtest: pipe-D-wait-forked
[306.771793] Subtest pipe-D-wait-forked: SUCCESS (2.049s)
[306.865531] [076/141] (687s left) sysfs_heartbeat_interval (precise)
[306.916084] Starting subtest: precise
[306.916864] Starting dynamic subtest: vecs0
[308.409470] Dynamic subtest vecs0: SUCCESS (1.492s)
[308.416637] Starting dynamic subtest: vcs0
[309.882153] Dynamic subtest vcs0: SUCCESS (1.472s)
[309.889896] Starting dynamic subtest: bcs0
[311.357937] Dynamic subtest bcs0: SUCCESS (1.475s)
[311.365009] Starting dynamic subtest: rcs0
[312.827184] Dynamic subtest rcs0: SUCCESS (1.468s)
[312.833289] Starting dynamic subtest: vcs1
[314.308366] Dynamic subtest vcs1: SUCCESS (1.481s)
[314.309395] Subtest precise: SUCCESS (7.392s)
[314.346933] [077/141] (679s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[314.452071] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[314.453472] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[314.499726] [078/141] (679s left) vc4/vc4_perfmon (create-single-perfmon)
[314.570247] Subtest create-single-perfmon: SKIP (0.000s)
[314.601390] [079/141] (679s left) kms_content_protection (type1)
[314.710574] Starting subtest: type1
[314.991481] Subtest type1: SKIP (0.279s)
[315.117673] [080/141] (678s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[315.219905] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[315.221410] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[315.275696] [081/141] (678s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[315.329071] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[315.329870] Starting dynamic subtest: smem
[315.450194] Dynamic subtest smem: SUCCESS (0.111s)
[315.451760] Subtest yf-tiled-ccs-to-y-tiled-ccs: SUCCESS (0.112s)
[315.584921] [082/141] (678s left) kms_vblank (pipe-a-ts-continuation-dpms-suspend)
[315.681452] Starting subtest: pipe-A-ts-continuation-dpms-suspend
[331.812240] Subtest pipe-A-ts-continuation-dpms-suspend: SUCCESS (1.514s)
[335.899760] [083/141] (676s left) kms_atomic_interruptible (legacy-dpms)
[336.005554] Starting subtest: legacy-dpms
[336.007647] Starting dynamic subtest: HDMI-A-1-pipe-A
[342.198894] Dynamic subtest HDMI-A-1-pipe-A: SUCCESS (6.192s)
[342.199701] Subtest legacy-dpms: SUCCESS (6.194s)
[342.282940] [084/141] (670s left) kms_chamelium_color (gamma)
[342.381901] Subtest gamma: SKIP (0.000s)
[342.398652] [085/141] (670s left) syncobj_timeline (reset-multiple-signaled)
[342.448628] Starting subtest: reset-multiple-signaled
[342.449468] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[342.488741] [086/141] (670s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[342.536186] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[342.536896] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[342.572869] [087/141] (670s left) perf_pmu (busy-hang)
[342.622349] Starting subtest: busy-hang
[342.623091] Starting dynamic subtest: rcs0
[343.648683] Dynamic subtest rcs0: SUCCESS (1.026s)
[343.657425] Starting dynamic subtest: bcs0
[344.683631] Dynamic subtest bcs0: SUCCESS (1.034s)
[344.692239] Starting dynamic subtest: vcs0
[345.718703] Dynamic subtest vcs0: SUCCESS (1.034s)
[345.727169] Starting dynamic subtest: vcs1
[346.755882] Dynamic subtest vcs1: SUCCESS (1.036s)
[346.765165] Starting dynamic subtest: vecs0
[347.795669] Dynamic subtest vecs0: SUCCESS (1.039s)
[347.796867] Subtest busy-hang: SUCCESS (5.173s)
[347.847354] [088/141] (664s left) prime_vgem (wait)
[347.904666] Starting subtest: wait
[347.905383] Starting dynamic subtest: rcs0
[347.919694] Dynamic subtest rcs0: SUCCESS (0.015s)
[347.924963] Starting dynamic subtest: bcs0
[347.931291] Dynamic subtest bcs0: SUCCESS (0.011s)
[347.936949] Starting dynamic subtest: vcs0
[347.944569] Dynamic subtest vcs0: SUCCESS (0.013s)
[347.951671] Starting dynamic subtest: vcs1
[347.960866] Dynamic subtest vcs1: SUCCESS (0.015s)
[347.968464] Starting dynamic subtest: vecs0
[347.977857] Dynamic subtest vecs0: SUCCESS (0.016s)
[347.978756] Subtest wait: SUCCESS (0.073s)
[348.068617] [089/141] (664s left) kms_addfb_basic (basic)
[348.124577] Starting subtest: basic
[348.125260] Subtest basic: SUCCESS (0.000s)
[348.231693] [090/141] (664s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[348.279901] Starting subtest: single-wait-for-submit-unsubmitted
[348.384948] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[348.435418] [091/141] (664s left) gem_wait (invalid-buf)
[348.492969] Starting subtest: invalid-buf
[348.493745] Subtest invalid-buf: SUCCESS (0.000s)
[348.680853] [092/141] (664s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[348.789641] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[348.791208] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[348.848649] [093/141] (663s left) perf (disabled-read-error)
[348.940479] Starting subtest: disabled-read-error
[348.956097] Subtest disabled-read-error: SUCCESS (0.016s)
[348.970639] [094/141] (663s left) gem_linear_blits (basic)
[349.211431] Starting subtest: basic
[349.216673] Subtest basic: SUCCESS (0.004s)
[349.311833] [095/141] (663s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc)
[349.722522] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc
[349.725450] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc: SKIP (0.002s)
[349.887771] [096/141] (662s left) kms_ccs (pipe-b-random-ccs-data-y_tiled_gen12_rc_ccs_cc)
[350.137691] Starting subtest: pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs_cc
[350.232635] Subtest pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs_cc: SUCCESS (0.095s)
[350.557285] [097/141] (662s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[350.662396] Starting subtest: x-tiled-64bpp-rotate-270
[350.694418] Subtest x-tiled-64bpp-rotate-270: SKIP (0.031s)
[350.763082] [098/141] (662s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_gen12_rc_ccs)
[350.997505] Starting subtest: pipe-B-crc-primary-basic-y_tiled_gen12_rc_ccs
[351.245014] Subtest pipe-B-crc-primary-basic-y_tiled_gen12_rc_ccs: SUCCESS (0.248s)
[351.587117] [099/141] (661s left) kms_addfb_basic (basic-x-tiled-legacy)
[351.638608] Starting subtest: basic-x-tiled-legacy
[351.639372] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[351.736968] [100/141] (661s left) kms_ccs (pipe-a-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc)
[351.900562] Starting subtest: pipe-A-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc
[351.901928] Subtest pipe-A-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[352.261280] [101/141] (660s left) kms_ccs (pipe-a-bad-rotation-90-y_tiled_ccs)
[352.418117] Starting subtest: pipe-A-bad-rotation-90-y_tiled_ccs
[352.419590] Subtest pipe-A-bad-rotation-90-y_tiled_ccs: SKIP (0.000s)
[352.805175] [102/141] (660s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[352.907000] Starting subtest: psr-farfromfence-mmap-gtt
[352.908472] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[352.954702] [103/141] (659s left) i915_pm_freq_api (freq-basic-api)
[353.005872] Subtest freq-basic-api: SKIP (0.000s)
[353.023539] [104/141] (659s left) kms_plane_scaling (plane-upscale-with-rotation-factor-0-25)
[353.118522] Starting subtest: plane-upscale-with-rotation-factor-0-25
[353.120550] Starting dynamic subtest: pipe-A-HDMI-A-1
[353.154513] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.033s)
[353.159920] Starting dynamic subtest: pipe-B-HDMI-A-1
[353.238191] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.082s)
[353.243471] Starting dynamic subtest: pipe-C-HDMI-A-1
[353.321966] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.082s)
[353.327274] Starting dynamic subtest: pipe-D-HDMI-A-1
[353.405336] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.081s)
[353.406983] Subtest plane-upscale-with-rotation-factor-0-25: SKIP (0.285s)
[353.537495] [105/141] (659s left) gem_exec_balancer (full-late)
[353.592412] Starting subtest: full-late
[354.672609] Subtest full-late: SUCCESS (1.059s)
[354.896276] [106/141] (658s left) gem_tiling_max_stride
[355.049436] [107/141] (657s left) kms_addfb_basic (size-max)
[355.155633] Starting subtest: size-max
[355.156342] Subtest size-max: SUCCESS (0.000s)
[355.212732] [108/141] (657s left) perf (rc6-disable)
[355.299799] Starting subtest: rc6-disable
[355.478077] Subtest rc6-disable: SUCCESS (0.178s)
[355.509112] [109/141] (657s left) kms_atomic (plane-primary-legacy)
[355.654969] Starting subtest: plane-primary-legacy
[355.759244] Subtest plane-primary-legacy: SUCCESS (0.104s)
[355.927502] [110/141] (657s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[355.977385] Starting subtest: multi-wait-for-submit-available-signaled
[355.978164] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.001s)
[356.018512] [111/141] (657s left) v3d/v3d_perfmon (create-two-perfmon)
[356.088674] Subtest create-two-perfmon: SKIP (0.000s)
[356.118630] [112/141] (656s left) kms_ccs (pipe-c-crc-primary-rotation-180-y_tiled_gen12_rc_ccs)
[356.440363] Starting subtest: pipe-C-crc-primary-rotation-180-y_tiled_gen12_rc_ccs
[356.631695] Subtest pipe-C-crc-primary-rotation-180-y_tiled_gen12_rc_ccs: SUCCESS (0.191s)
[356.886032] [113/141] (656s left) gem_softpin (allocator-nopin)
[356.937641] Starting subtest: allocator-nopin
[357.000234] Subtest allocator-nopin: SUCCESS (0.062s)
[357.068937] [114/141] (656s left) v3d/v3d_wait_bo (bad-pad)
[357.138972] Subtest bad-pad: SKIP (0.000s)
[357.169311] [115/141] (655s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[357.269688] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[357.271062] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[357.318945] [116/141] (655s left) kms_vblank (pipe-b-wait-forked-busy-hang)
[357.413963] Starting subtest: pipe-B-wait-forked-busy-hang
[371.445946] Subtest pipe-B-wait-forked-busy-hang: SUCCESS (14.032s)
[371.547108] [117/141] (641s left) i915_pm_rps (min-max-config-idle)
[371.599275] Starting subtest: min-max-config-idle
[371.749793] Subtest min-max-config-idle: SUCCESS (0.151s)
[371.823368] [118/141] (641s left) syncobj_basic (test-valid-cycle)
[371.873029] Starting subtest: test-valid-cycle
[371.873753] Subtest test-valid-cycle: SUCCESS (0.000s)
[371.921715] [119/141] (641s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[372.022822] Starting subtest: cursor-rapid-movement-128x128
[372.028543] Starting dynamic subtest: pipe-A-HDMI-A-1
[372.255381] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.228s)
[372.280235] Starting dynamic subtest: pipe-D-HDMI-A-1
[373.283595] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.007s)
[373.284334] Subtest cursor-rapid-movement-128x128: SUCCESS (1.260s)
[373.377708] [120/141] (639s left) api_intel_bb (bb-with-allocator)
[373.426566] Starting subtest: bb-with-allocator
[373.427876] Subtest bb-with-allocator: SUCCESS (0.002s)
[373.501334] [121/141] (639s left) syncobj_timeline (etime-single-wait-submitted)
[373.548903] Starting subtest: etime-single-wait-submitted
[373.655220] Subtest etime-single-wait-submitted: SUCCESS (0.106s)
[373.692935] [122/141] (639s left) gem_exec_schedule (independent)
[373.747075] Starting subtest: independent
[373.747841] Starting dynamic subtest: rcs0
[373.826977] Dynamic subtest rcs0: SUCCESS (0.079s)
[373.832675] Starting dynamic subtest: bcs0
[373.900962] Dynamic subtest bcs0: SUCCESS (0.074s)
[373.906889] Starting dynamic subtest: vcs0
[373.977033] Dynamic subtest vcs0: SUCCESS (0.076s)
[373.982762] Starting dynamic subtest: vcs1
[374.065899] Dynamic subtest vcs1: SUCCESS (0.089s)
[374.071594] Starting dynamic subtest: vecs0
[374.140959] Dynamic subtest vecs0: SUCCESS (0.075s)
[374.141710] Subtest independent: SUCCESS (0.394s)
[374.413510] [123/141] (638s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[374.515939] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[374.517328] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[374.568387] [124/141] (638s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_dg2_rc_ccs_cc)
[374.951797] Starting subtest: pipe-D-bad-rotation-90-4_tiled_dg2_rc_ccs_cc
[374.953311] Subtest pipe-D-bad-rotation-90-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[375.094590] [125/141] (638s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[375.532666] Starting subtest: syncobj-timeline-invalid-flags
[375.534040] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.001s)
[375.689250] [126/141] (637s left) kms_psr (psr2_cursor_blt)
[375.746381] Subtest psr2_cursor_blt: SKIP (0.000s)
[375.762117] [127/141] (637s left) kms_ccs (pipe-b-missing-ccs-buffer-yf_tiled_ccs)
[376.022244] Starting subtest: pipe-B-missing-ccs-buffer-yf_tiled_ccs
[376.023704] Subtest pipe-B-missing-ccs-buffer-yf_tiled_ccs: SKIP (0.000s)
[376.287546] [128/141] (636s left) gem_exec_flush (basic-wb-ro-default)
[376.340585] Starting subtest: basic-wb-ro-default
[381.760240] Subtest basic-wb-ro-default: SUCCESS (5.420s)
[381.921246] [129/141] (631s left) gem_partial_pwrite_pread (reads-uncached)
[381.992023] Starting subtest: reads-uncached
[383.485884] Subtest reads-uncached: SUCCESS (1.493s)
[383.562841] [130/141] (629s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[383.667653] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[383.669064] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[383.730466] [131/141] (629s left) kms_ccs (pipe-d-crc-primary-rotation-180-4_tiled_mtl_mc_ccs)
[384.148665] Starting subtest: pipe-D-crc-primary-rotation-180-4_tiled_mtl_mc_ccs
[384.150372] Subtest pipe-D-crc-primary-rotation-180-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[384.272989] [132/141] (629s left) kms_frontbuffer_tracking (psr-slowdraw)
[384.371310] Starting subtest: psr-slowdraw
[384.372733] Subtest psr-slowdraw: SKIP (0.000s)
[384.423472] [133/141] (628s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-gtt)
[384.522763] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-gtt
[384.524149] Subtest psr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[384.581455] [134/141] (628s left) gem_lmem_swapping (heavy-verify-random)
[384.630676] Subtest heavy-verify-random: SKIP (0.000s)
[384.650155] [135/141] (628s left) gem_userptr_blits (readonly-unsync)
[384.707705] Subtest readonly-unsync: SKIP (0.000s)
[384.790550] [136/141] (628s left) syncobj_wait (invalid-wait-bad-flags)
[384.847294] Starting subtest: invalid-wait-bad-flags
[384.848025] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[384.881570] [137/141] (628s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[384.986663] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[384.988077] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[385.048471] [138/141] (628s left) kms_plane_alpha_blend (alpha-transparent-fb)
[385.141568] Starting subtest: alpha-transparent-fb
[385.209921] Starting dynamic subtest: pipe-A-HDMI-A-1
[385.492420] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.283s)
[385.500246] Starting dynamic subtest: pipe-D-HDMI-A-1
[385.784656] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.289s)
[385.785377] Subtest alpha-transparent-fb: SUCCESS (0.643s)
[385.893099] [139/141] (627s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[385.975988] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[385.989342] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.013s)
[386.026579] [140/141] (627s left) kms_plane (plane-position-hole-dpms)
[386.120898] Starting subtest: plane-position-hole-dpms
[386.122592] Starting dynamic subtest: pipe-A-planes
[388.041128] Dynamic subtest pipe-A-planes: SUCCESS (1.919s)
[388.047687] Starting dynamic subtest: pipe-B-planes
[389.855892] Dynamic subtest pipe-B-planes: SUCCESS (1.813s)
[389.856665] Subtest plane-position-hole-dpms: SUCCESS (3.735s)
[389.955061] [141/141] (623s left) kms_force_connector_basic (force-connector-state)
[390.112763] Starting subtest: force-connector-state
[391.501433] Subtest force-connector-state: SUCCESS (1.390s)
[391.747640] Closing watchdogs
Done.