[41.500599] Initializing watchdogs
[41.500915]   /dev/watchdog0
[41.517852] [001/142] (960s left) kms_plane_scaling (plane-upscale-with-pixel-format-factor-0-25)
[41.784924] Starting subtest: plane-upscale-with-pixel-format-factor-0-25
[41.786633] Starting dynamic subtest: pipe-A-DP-1
[42.470036] Dynamic subtest pipe-A-DP-1: SUCCESS (0.685s)
[42.486806] Starting dynamic subtest: pipe-B-DP-1
[43.433035] Dynamic subtest pipe-B-DP-1: SUCCESS (0.960s)
[43.447692] Starting dynamic subtest: pipe-C-DP-1
[43.798423] Dynamic subtest pipe-C-DP-1: SUCCESS (0.362s)
[43.799708] Subtest plane-upscale-with-pixel-format-factor-0-25: SUCCESS (2.016s)
[44.200487] [002/142] (957s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[44.460897] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[44.463500] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[44.562129] [003/142] (957s left) kms_atomic_interruptible (universal-setplane-primary)
[44.805204] Starting subtest: universal-setplane-primary
[44.808136] Starting dynamic subtest: DP-1-pipe-A
[51.333916] Dynamic subtest DP-1-pipe-A: SUCCESS (6.527s)
[51.335158] Subtest universal-setplane-primary: SUCCESS (6.530s)
[51.667868] [004/142] (950s left) kms_ccs (pipe-c-bad-pixel-format-4_tiled_mtl_rc_ccs_cc)
[52.092161] Starting subtest: pipe-C-bad-pixel-format-4_tiled_mtl_rc_ccs_cc
[52.094662] Subtest pipe-C-bad-pixel-format-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[52.450826] [005/142] (949s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[52.691033] Starting subtest: 2x-flip-vs-rmfb-interruptible
[52.695684] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.003s)
[52.784280] [006/142] (949s left) kms_chamelium_audio (hdmi-audio-edid)
[53.118040] Subtest hdmi-audio-edid: SKIP (0.000s)
[53.410888] [007/142] (948s left) kms_vblank (pipe-b-query-forked-busy)
[53.658275] Starting subtest: pipe-B-query-forked-busy
[56.449940] Subtest pipe-B-query-forked-busy: SUCCESS (2.792s)
[56.768329] [008/142] (945s left) kms_ccs (pipe-b-ccs-on-another-bo-y_tiled_ccs)
[57.175273] Starting subtest: pipe-B-ccs-on-another-bo-y_tiled_ccs
[57.176859] Subtest pipe-B-ccs-on-another-bo-y_tiled_ccs: SUCCESS (0.001s)
[57.547200] [009/142] (944s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[57.802955] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[57.805634] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[57.897736] [010/142] (944s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[58.161071] Starting subtest: y-tiled-16bpp-rotate-90
[58.271166] Subtest y-tiled-16bpp-rotate-90: SKIP (0.108s)
[58.365226] [011/142] (943s left) prime_mmap (test_aperture_limit)
[58.506065] Starting subtest: test_aperture_limit
[58.507485] Starting dynamic subtest: test_aperture_limit-smem
[58.532870] Dynamic subtest test_aperture_limit-smem: SUCCESS (0.026s)
[58.534827] Subtest test_aperture_limit: SUCCESS (0.027s)
[58.635733] [012/142] (943s left) i915_pm_rpm (universal-planes-dpms)
[60.738194] Starting subtest: universal-planes-dpms
[60.741230] Starting dynamic subtest: plane-31
[63.156088] Dynamic subtest plane-31: SUCCESS (2.416s)
[63.179738] Starting dynamic subtest: plane-39
[65.199818] Dynamic subtest plane-39: SUCCESS (2.044s)
[65.219358] Starting dynamic subtest: plane-47
[67.149483] Dynamic subtest plane-47: SUCCESS (1.949s)
[67.168546] Starting dynamic subtest: plane-55
[69.251312] Dynamic subtest plane-55: SUCCESS (2.101s)
[69.254051] Subtest universal-planes-dpms: SUCCESS (8.514s)
[69.701043] [013/142] (932s left) gem_exec_reloc (basic-write-gtt-noreloc)
[69.878742] Starting subtest: basic-write-gtt-noreloc
[69.891026] Subtest basic-write-gtt-noreloc: SUCCESS (0.011s)
[70.065730] [014/142] (932s left) api_intel_bb (object-noreloc-keep-cache-simple)
[70.212056] Starting subtest: object-noreloc-keep-cache-simple
[70.225312] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.012s)
[70.331298] [015/142] (932s left) gem_exec_parallel (fds)
[70.495779] Starting subtest: fds
[70.497339] Starting dynamic subtest: rcs0
[79.495197] Dynamic subtest rcs0: SUCCESS (8.998s)
[79.510426] Starting dynamic subtest: bcs0
[88.540523] Dynamic subtest bcs0: SUCCESS (9.046s)
[88.557385] Starting dynamic subtest: vcs0
[98.416800] Dynamic subtest vcs0: SUCCESS (9.876s)
[98.432596] Starting dynamic subtest: vecs0
[108.414826] Dynamic subtest vecs0: SUCCESS (9.996s)
[108.416257] Subtest fds: SUCCESS (37.919s)
[108.640693] [016/142] (893s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[108.791115] Subtest invalidate-primary-flip-overlay: SKIP (0.000s)
[108.855174] [017/142] (893s left) kms_cursor_crc (cursor-onscreen-32x32)
[109.114713] Starting subtest: cursor-onscreen-32x32
[109.248282] Subtest cursor-onscreen-32x32: SKIP (0.129s)
[109.351778] [018/142] (893s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[109.599643] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[109.601056] Starting dynamic subtest: pipe-A-DP-1
[109.919953] Dynamic subtest pipe-A-DP-1: SUCCESS (0.320s)
[109.943943] Starting dynamic subtest: pipe-B-DP-1
[110.307680] Dynamic subtest pipe-B-DP-1: SUCCESS (0.384s)
[110.325342] Starting dynamic subtest: pipe-C-DP-1
[110.405556] Dynamic subtest pipe-C-DP-1: SKIP (0.092s)
[110.406927] Subtest planes-downscale-factor-0-5-upscale-20x20: SUCCESS (0.808s)
[110.783605] [019/142] (891s left) gem_softpin (allocator-fork)
[110.938279] Starting subtest: allocator-fork
[113.317307] Subtest allocator-fork: SUCCESS (2.378s)
[113.435282] [020/142] (889s left) gem_flink_basic (bad-open)
[113.575803] Starting subtest: bad-open
[113.577204] Subtest bad-open: SUCCESS (0.000s)
[113.664133] [021/142] (889s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[113.897875] Starting subtest: 2x-long-cursor-vs-flip-atomic
[113.903266] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.004s)
[113.980562] [022/142] (888s left) gem_exec_store (basic)
[114.150752] Starting subtest: basic
[114.223305] Subtest basic: SUCCESS (0.071s)
[114.414117] [023/142] (888s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[114.648620] Starting subtest: cursorA-vs-flipA-varying-size
[125.709997] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.062s)
[126.072357] [024/142] (876s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[126.336870] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[126.339596] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[126.433249] [025/142] (876s left) perf (whitelisted-registers-userspace-config)
[126.728901] Starting subtest: whitelisted-registers-userspace-config
[126.733820] Subtest whitelisted-registers-userspace-config: SUCCESS (0.003s)
[126.783957] [026/142] (876s left) kms_ccs (pipe-c-missing-ccs-buffer-y_tiled_ccs)
[127.239397] Starting subtest: pipe-C-missing-ccs-buffer-y_tiled_ccs
[127.242080] Subtest pipe-C-missing-ccs-buffer-y_tiled_ccs: SKIP (0.000s)
[127.577475] [027/142] (875s left) vc4/vc4_wait_bo (unused-bo-0ns)
[127.762157] Subtest unused-bo-0ns: SKIP (0.000s)
[127.830181] [028/142] (875s left) gem_mmap_offset (oob-read)
[127.969627] Starting subtest: oob-read
[127.974097] Subtest oob-read: SUCCESS (0.002s)
[128.078670] [029/142] (874s left) kms_ccs (pipe-d-missing-ccs-buffer-4_tiled_mtl_mc_ccs)
[128.563775] Subtest pipe-D-missing-ccs-buffer-4_tiled_mtl_mc_ccs: SKIP (0.000s)
[128.882953] [030/142] (874s left) fbdev (info)
[129.024165] Starting subtest: info
[129.025835] Subtest info: SUCCESS (0.000s)
[129.114541] [031/142] (873s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[129.350219] Starting subtest: nonblocking-crc-frame-sequence
[129.356784] Starting dynamic subtest: pipe-A-DP-1
[129.940394] Dynamic subtest pipe-A-DP-1: SUCCESS (0.587s)
[129.958450] Starting dynamic subtest: pipe-B-DP-1
[130.708589] Dynamic subtest pipe-B-DP-1: SUCCESS (0.765s)
[130.728904] Starting dynamic subtest: pipe-C-DP-1
[131.481281] Dynamic subtest pipe-C-DP-1: SUCCESS (0.768s)
[131.482574] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.133s)
[131.799912] [032/142] (871s left) gem_exec_schedule (implicit-boths)
[131.972637] Starting subtest: implicit-boths
[131.974101] Starting dynamic subtest: rcs0
[132.126467] Dynamic subtest rcs0: SUCCESS (0.152s)
[132.148258] Starting dynamic subtest: bcs0
[132.270259] Dynamic subtest bcs0: SUCCESS (0.140s)
[132.289364] Starting dynamic subtest: vcs0
[132.397382] Dynamic subtest vcs0: SUCCESS (0.124s)
[132.414789] Starting dynamic subtest: vecs0
[132.527417] Dynamic subtest vecs0: SUCCESS (0.128s)
[132.528984] Subtest implicit-boths: SUCCESS (0.556s)
[132.901369] [033/142] (870s left) kms_fbcon_fbt (fbc)
[133.051627] Starting subtest: fbc
[136.950615] Subtest fbc: SUCCESS (3.898s)
[137.003444] [034/142] (866s left) kms_chamelium_frames (dp-crc-multiple)
[137.335603] Subtest dp-crc-multiple: SKIP (0.000s)
[137.631814] [035/142] (865s left) gem_ctx_isolation (nonpriv)
[137.798299] Starting subtest: nonpriv
[137.799831] Starting dynamic subtest: rcs0
[140.181228] Dynamic subtest rcs0: SUCCESS (2.381s)
[140.198308] Starting dynamic subtest: bcs0
[143.248330] Dynamic subtest bcs0: SUCCESS (3.066s)
[143.265282] Starting dynamic subtest: vcs0
[145.565917] Dynamic subtest vcs0: SUCCESS (2.317s)
[145.582394] Starting dynamic subtest: vecs0
[147.855478] Dynamic subtest vecs0: SUCCESS (2.287s)
[147.856963] Subtest nonpriv: SUCCESS (10.059s)
[148.060799] [036/142] (855s left) gem_eio (reset-stress)
[148.229746] Starting subtest: reset-stress
[181.565607] Subtest reset-stress: SUCCESS (33.335s)
[181.743972] [037/142] (821s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[181.990735] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[181.993479] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[182.092925] [038/142] (821s left) drm_fdinfo (virtual-busy)
[182.244420] Starting subtest: virtual-busy
[184.416358] Subtest virtual-busy: SUCCESS (2.171s)
[184.492433] [039/142] (818s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[184.735786] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[184.739199] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[184.843355] [040/142] (818s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[185.096731] Starting subtest: fbc-rgb565-draw-blt
[187.320468] Subtest fbc-rgb565-draw-blt: SUCCESS (2.227s)
[187.464998] [041/142] (816s left) gem_ctx_persistence (heartbeat-close)
[187.619824] Starting subtest: heartbeat-close
[187.788977] Subtest heartbeat-close: SUCCESS (0.168s)
[187.875932] [042/142] (815s left) kms_busy (extended-modeset-hang-oldfb)
[188.129387] Starting subtest: extended-modeset-hang-oldfb
[188.132395] Starting dynamic subtest: pipe-A
[195.388221] Dynamic subtest pipe-A: SUCCESS (7.251s)
[195.408374] Starting dynamic subtest: pipe-C
[203.392603] Dynamic subtest pipe-C: SUCCESS (8.001s)
[203.394375] Subtest extended-modeset-hang-oldfb: SUCCESS (15.265s)
[203.736228] [043/142] (799s left) gem_exec_alignment (pi-isolated)