[53.108784] Initializing watchdogs
[53.109148]   /dev/watchdog0
[53.126431] [001/141] (960s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k)
[53.558205] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s)
[53.846814] [002/141] (959s left) kms_ccs (pipe-d-bad-pixel-format-y_tiled_gen12_rc_ccs)
[54.567460] Subtest pipe-D-bad-pixel-format-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[54.870462] [003/141] (958s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[55.186130] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[55.188785] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[55.268342] [004/141] (958s left) gem_mmap (basic)
[55.469247] Starting subtest: basic
[55.475694] Subtest basic: SUCCESS (0.001s)
[55.567942] [005/141] (958s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[55.865476] Starting subtest: primary-x-tiled-reflect-x-0
[55.872773] Subtest primary-x-tiled-reflect-x-0: SKIP (0.003s)
[55.951403] [006/141] (957s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[56.248129] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[56.253382] Starting dynamic subtest: pipe-A-valid-mode
[56.336470] Dynamic subtest pipe-A-valid-mode: SKIP (0.083s)
[56.340183] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.086s)
[56.637523] [007/141] (957s left) kms_vblank (pipe-a-ts-continuation-suspend)
[56.935835] Starting subtest: pipe-A-ts-continuation-suspend
[73.819136] Subtest pipe-A-ts-continuation-suspend: SUCCESS (1.883s)
[78.145072] [008/141] (954s left) gem_ctx_param (invalid-ctx-set)
[78.348533] Starting subtest: invalid-ctx-set
[78.350302] Subtest invalid-ctx-set: SUCCESS (0.001s)
[78.421999] [009/141] (954s left) kms_ccs (pipe-c-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs)
[79.134401] Starting subtest: pipe-C-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs
[79.141420] Subtest pipe-C-crc-sprite-planes-basic-y_tiled_gen12_rc_ccs: SKIP (0.004s)
[79.438959] [010/141] (953s left) prime_mmap (test_dup)
[79.639980] Starting subtest: test_dup
[79.641281] Starting dynamic subtest: test_dup-smem
[79.646533] Dynamic subtest test_dup-smem: SUCCESS (0.007s)
[79.647984] Subtest test_dup: SUCCESS (0.007s)
[79.721872] [011/141] (953s left) kms_dsc (dsc-with-bpc-formats)
[80.024982] Subtest dsc-with-bpc-formats: SKIP (0.000s)
[80.071088] [012/141] (952s left) perf (blocking)
[80.428499] Starting subtest: blocking
[80.429860] Starting dynamic subtest: 0-rcs0
[90.503271] Dynamic subtest 0-rcs0: SUCCESS (10.072s)
[90.504643] Subtest blocking: SUCCESS (10.073s)
[90.554890] [013/141] (942s left) perf_pmu (semaphore-wait)
[90.768108] Starting subtest: semaphore-wait
[90.769830] Starting dynamic subtest: rcs0
[91.301421] Dynamic subtest rcs0: SUCCESS (0.534s)
[91.323066] Starting dynamic subtest: bcs0
[91.821196] Dynamic subtest bcs0: SUCCESS (0.519s)
[91.839596] Starting dynamic subtest: vcs0
[92.336704] Dynamic subtest vcs0: SUCCESS (0.515s)
[92.355638] Starting dynamic subtest: vecs0
[92.853720] Dynamic subtest vecs0: SUCCESS (0.515s)
[92.855144] Subtest semaphore-wait: SUCCESS (2.086s)
[92.956924] [014/141] (940s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[93.260707] Starting subtest: plane-primary-toggle-with-vblank-wait
[93.262147] Starting dynamic subtest: pipe-A-DP-1
[93.468804] Dynamic subtest pipe-A-DP-1: SUCCESS (0.209s)
[93.575171] Starting dynamic subtest: pipe-B-DP-1
[94.038363] Dynamic subtest pipe-B-DP-1: SUCCESS (0.483s)
[94.122754] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (0.864s)
[94.461950] [015/141] (938s left) kms_properties (get_properties-sanity-non-atomic)
[94.757671] Starting subtest: get_properties-sanity-non-atomic
[94.758914] Subtest get_properties-sanity-non-atomic: SUCCESS (0.003s)
[94.845165] [016/141] (938s left) gem_eio (wait-1us)
[95.076877] Starting subtest: wait-1us
[95.177413] Subtest wait-1us: SUCCESS (0.097s)
[95.345376] [017/141] (937s left) gem_softpin (overlap)
[95.556915] Starting subtest: overlap
[98.373209] Subtest overlap: SUCCESS (2.814s)
[98.479055] [018/141] (934s left) prime_mmap_coherency (read)
[98.688936] Starting subtest: read
[104.095527] Subtest read: SUCCESS (5.404s)
[104.193506] [019/141] (929s left) gem_exec_flush (basic-batch-kernel-default-uc)
[104.418160] Starting subtest: basic-batch-kernel-default-uc
[110.314364] Subtest basic-batch-kernel-default-uc: SUCCESS (5.896s)
[110.511306] [020/141] (922s left) syncobj_timeline (invalid-multi-wait-available-unsubmitted-submitted-signaled
[110.711587] Starting subtest: invalid-multi-wait-available-unsubmitted-submitted-signaled
[110.714954] Subtest invalid-multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.002s)
[110.796794] [021/141] (922s left) gem_caching (writes)
[111.004882] Starting subtest: writes
[125.320343] Subtest writes: SUCCESS (14.315s)
[125.430456] [022/141] (907s left) vc4/vc4_tiling (get-bad-handle)
[125.676475] Subtest get-bad-handle: SKIP (0.000s)
[125.747586] [023/141] (907s left) v3d/v3d_submit_cl (bad-multisync-pad)
[125.992574] Subtest bad-multisync-pad: SKIP (0.000s)
[126.063337] [024/141] (907s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[126.369364] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[126.371907] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[126.464107] [025/141] (906s left) sysfs_heartbeat_interval (mixed)
[126.673466] Starting subtest: mixed
[126.677031] Starting dynamic subtest: vecs0
[131.907594] Dynamic subtest vecs0: SUCCESS (5.231s)
[131.927340] Starting dynamic subtest: vcs0
[137.173144] Dynamic subtest vcs0: SUCCESS (5.265s)
[137.193221] Starting dynamic subtest: bcs0
[142.416142] Dynamic subtest bcs0: SUCCESS (5.242s)
[142.436068] Starting dynamic subtest: rcs0
[147.701487] Dynamic subtest rcs0: SUCCESS (5.285s)
[147.703192] Subtest mixed: SUCCESS (21.029s)
[147.780930] [026/141] (885s left) kms_frontbuffer_tracking (psr-suspend)
[148.105600] Starting subtest: psr-suspend
[148.108160] Subtest psr-suspend: SKIP (0.000s)
[148.197495] [027/141] (885s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[148.397399] Starting subtest: cpuset-basic-small-copy-XY
[155.565587] Subtest cpuset-basic-small-copy-XY: SUCCESS (7.168s)
[155.736138] [028/141] (877s left) kms_setmode (invalid-clone-single-crtc)
[156.052479] Starting subtest: invalid-clone-single-crtc
[156.056472] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[156.131896] [029/141] (877s left) gem_ctx_persistence (engines-hang)
[156.342956] Starting subtest: engines-hang
[156.344438] Starting dynamic subtest: rcs0
[156.383334] Dynamic subtest rcs0: SUCCESS (0.039s)
[156.404319] Starting dynamic subtest: bcs0
[156.407631] Dynamic subtest bcs0: SKIP (0.007s)
[156.428194] Starting dynamic subtest: vcs0
[156.429628] Dynamic subtest vcs0: SUCCESS (0.035s)
[156.452373] Starting dynamic subtest: vecs0
[156.460775] Dynamic subtest vecs0: SUCCESS (0.036s)
[156.462435] Subtest engines-hang: SUCCESS (0.118s)
[156.548371] [030/141] (877s left) kms_vblank (pipe-c-query-busy)
[156.857960] Starting subtest: pipe-C-query-busy
[159.842258] Subtest pipe-C-query-busy: SUCCESS (2.984s)
[160.174581] [031/141] (873s left) gem_exec_balancer (nop)
[160.406234] Starting subtest: nop
[200.488776] Subtest nop: SUCCESS (40.086s)
[204.390590] [032/141] (829s left) syncobj_timeline (multi-wait-all-available-signaled)
[204.612762] Starting subtest: multi-wait-all-available-signaled
[204.616087] Subtest multi-wait-all-available-signaled: SUCCESS (0.002s)
[204.705970] [033/141] (829s left) gem_exec_reloc (basic-wc-read-noreloc)
[204.916870] Starting subtest: basic-wc-read-noreloc
[204.926021] Subtest basic-wc-read-noreloc: SUCCESS (0.009s)
[205.109659] [034/141] (828s left) kms_ccs (pipe-b-crc-primary-rotation-180-y_tiled_gen12_mc_ccs)
[205.626428] Starting subtest: pipe-B-crc-primary-rotation-180-y_tiled_gen12_mc_ccs
[205.629181] Subtest pipe-B-crc-primary-rotation-180-y_tiled_gen12_mc_ccs: SKIP (0.001s)
[206.130558] [035/141] (827s left) gem_lmem_swapping (smem-oom)
[206.341750] Subtest smem-oom: SKIP (0.000s)
[206.398991] [036/141] (827s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[206.723498] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[206.757482] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.033s)
[206.863848] [037/141] (827s left) drm_fdinfo (idle)
[207.071209] Starting subtest: idle
[207.072858] Starting dynamic subtest: rcs0
[207.577900] Dynamic subtest rcs0: SUCCESS (0.505s)
[207.599170] Starting dynamic subtest: bcs0
[208.083127] Dynamic subtest bcs0: SUCCESS (0.505s)
[208.103370] Starting dynamic subtest: vcs0
[208.588651] Dynamic subtest vcs0: SUCCESS (0.505s)
[208.608856] Starting dynamic subtest: vecs0
[209.095196] Dynamic subtest vecs0: SUCCESS (0.506s)
[209.096577] Subtest idle: SUCCESS (2.022s)
[209.180784] [038/141] (824s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[209.483752] Starting subtest: basic-flip-after-cursor-atomic
[210.777511] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.293s)
[211.104027] [039/141] (822s left) gem_pread (exhaustion)
[211.303938] Starting subtest: exhaustion
[232.636884] Subtest exhaustion: SUCCESS (21.333s)
[232.741097] [040/141] (801s left) sw_sync (alloc_timeline)
[232.935163] Starting subtest: alloc_timeline
[232.936622] Subtest alloc_timeline: SUCCESS (0.000s)
[233.002541] [041/141] (801s left) kms_flip (wf_vblank-ts-check)
[233.277827] Starting subtest: wf_vblank-ts-check
[233.279228] Starting dynamic subtest: A-DP1
[244.094579] Dynamic subtest A-DP1: SUCCESS (10.815s)
[244.116433] Starting dynamic subtest: B-DP1
[254.836506] Dynamic subtest B-DP1: SUCCESS (10.742s)
[254.858379] Starting dynamic subtest: C-DP1
[265.570241] Dynamic subtest C-DP1: SUCCESS (10.733s)
[265.571611] Subtest wf_vblank-ts-check: SUCCESS (32.297s)
[265.982515] [042/141] (768s left) gem_softpin (evict-snoop)
[266.182989] Starting subtest: evict-snoop
[266.186185] Subtest evict-snoop: SKIP (0.000s)
[266.278464] [043/141] (767s left) syncobj_wait (multi-wait-for-submit-submitted)
[266.481241] Starting subtest: multi-wait-for-submit-submitted
[266.588563] Subtest multi-wait-for-submit-submitted: SUCCESS (0.107s)
[266.679775] [044/141] (767s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[266.979686] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[266.981456] Starting dynamic subtest: pipe-A-valid-mode
[267.649083] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.666s)
[267.650437] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SUCCESS (0.669s)
[267.984104] [045/141] (766s left) gem_ctx_freq (sysfs)
[268.188883] Starting subtest: sysfs
[273.118223] Subtest sysfs: SUCCESS (4.929s)
[273.184509] [046/141] (761s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[273.479317] Starting subtest: coverage-vs-premult-vs-constant
[273.788600] Starting dynamic subtest: pipe-A-DP-1
[274.222362] Dynamic subtest pipe-A-DP-1: SUCCESS (0.433s)
[274.255476] Starting dynamic subtest: pipe-C-DP-1
[274.898437] Dynamic subtest pipe-C-DP-1: SUCCESS (0.672s)
[274.900168] Subtest coverage-vs-premult-vs-constant: SUCCESS (1.422s)
[275.297246] [047/141] (759s left) kms_plane_scaling (planes-downscale-factor-0-5)
[275.591642] Starting subtest: planes-downscale-factor-0-5
[275.593022] Starting dynamic subtest: pipe-A-DP-1
[275.921301] Dynamic subtest pipe-A-DP-1: SUCCESS (0.329s)
[275.966923] Starting dynamic subtest: pipe-B-DP-1
[276.297562] Dynamic subtest pipe-B-DP-1: SUCCESS (0.372s)
[276.322770] Starting dynamic subtest: pipe-C-DP-1
[276.390496] Dynamic subtest pipe-C-DP-1: SKIP (0.088s)
[276.391963] Subtest planes-downscale-factor-0-5: SUCCESS (0.800s)
[276.774947] [048/141] (757s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[277.090395] Starting subtest: fbcpsr-suspend
[277.093435] Subtest fbcpsr-suspend: SKIP (0.000s)
[277.193315] [049/141] (757s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75)
[277.484924] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75
[277.488378] Starting dynamic subtest: pipe-A-DP-1
[277.566050] Dynamic subtest pipe-A-DP-1: SUCCESS (0.078s)
[277.591769] Starting dynamic subtest: pipe-B-DP-1
[277.936503] Dynamic subtest pipe-B-DP-1: SUCCESS (0.367s)
[277.968794] Starting dynamic subtest: pipe-C-DP-1
[278.025798] Dynamic subtest pipe-C-DP-1: SKIP (0.084s)
[278.027237] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SUCCESS (0.540s)
[278.411409] [050/141] (756s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[278.718212] Starting subtest: plane-all-transition-nonblocking-fencing
[278.719642] Starting dynamic subtest: pipe-A-DP-1
[282.751313] Dynamic subtest pipe-A-DP-1: SUCCESS (4.032s)
[282.897318] Starting dynamic subtest: pipe-B-DP-1
[287.184402] Dynamic subtest pipe-B-DP-1: SUCCESS (4.327s)
[287.288840] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (8.567s)
[287.629919] [051/141] (746s left) gem_create (create-ext-cpu-access-sanity-check)
[287.965097] Starting subtest: create-ext-cpu-access-sanity-check
[287.968346] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[288.061093] [052/141] (746s left) kms_flip (flip-vs-rmfb)
[288.341149] Starting subtest: flip-vs-rmfb
[288.342441] Starting dynamic subtest: A-DP1
[298.868347] Dynamic subtest A-DP1: SUCCESS (10.525s)
[298.890469] Starting dynamic subtest: B-DP1
[309.308775] Dynamic subtest B-DP1: SUCCESS (10.437s)
[309.331939] Starting dynamic subtest: C-DP1
[319.744784] Dynamic subtest C-DP1: SUCCESS (10.437s)
[319.746033] Subtest flip-vs-rmfb: SUCCESS (31.409s)
[320.161521] [053/141] (714s left) perf_pmu (most-busy-idle-check-all)
[320.368337] Starting subtest: most-busy-idle-check-all
[320.369889] Starting dynamic subtest: rcs0
[320.999580] Dynamic subtest rcs0: SUCCESS (0.629s)
[321.025616] Starting dynamic subtest: bcs0
[321.621842] Dynamic subtest bcs0: SUCCESS (0.622s)
[321.645600] Starting dynamic subtest: vcs0
[322.246840] Dynamic subtest vcs0: SUCCESS (0.624s)
[322.276065] Starting dynamic subtest: vecs0
[322.869921] Dynamic subtest vecs0: SUCCESS (0.622s)
[322.871651] Subtest most-busy-idle-check-all: SUCCESS (2.502s)
[322.959517] [054/141] (711s left) kms_cursor_crc (cursor-onscreen-256x85)
[323.273500] Starting subtest: cursor-onscreen-256x85
[323.284240] Starting dynamic subtest: pipe-A-DP-1
[325.631067] Dynamic subtest pipe-A-DP-1: SUCCESS (2.346s)
[325.729860] Starting dynamic subtest: pipe-C-DP-1
[328.344930] Dynamic subtest pipe-C-DP-1: SUCCESS (2.648s)
[328.347462] Subtest cursor-onscreen-256x85: SUCCESS (5.067s)
[328.684080] [055/141] (705s left) kms_ccs (pipe-a-ccs-on-another-bo-y_tiled_gen12_rc_ccs)
[329.149606] Starting subtest: pipe-A-ccs-on-another-bo-y_tiled_gen12_rc_ccs
[329.153352] Subtest pipe-A-ccs-on-another-bo-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[329.736256] [056/141] (704s left) fbdev (nullptr)
[329.943938] Starting subtest: nullptr
[329.945315] Subtest nullptr: SUCCESS (0.000s)
[330.021833] [057/141] (704s left) kms_chamelium_audio (dp-audio-edid)
[330.411399] Subtest dp-audio-edid: SKIP (0.000s)
[330.702429] [058/141] (704s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[330.996454] Starting subtest: flip-vs-cursor-busy-crc-legacy
[331.793981] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.800s)
[332.129172] [059/141] (702s left) kms_ccs (pipe-d-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs)
[332.840332] Subtest pipe-D-crc-sprite-planes-basic-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[333.154570] [060/141] (701s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[333.462380] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[333.465344] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[333.571360] [061/141] (701s left) gem_mmap_offset (bad-extensions)
[333.767669] Starting subtest: bad-extensions
[333.769304] Subtest bad-extensions: SUCCESS (0.000s)
[333.871941] [062/141] (701s left) kms_cursor_edge_walk (128x128-left-edge)
[334.170864] Starting subtest: 128x128-left-edge
[334.173718] Starting dynamic subtest: pipe-A-DP-1
[337.787826] Dynamic subtest pipe-A-DP-1: SUCCESS (3.617s)
[337.816155] Starting dynamic subtest: pipe-C-DP-1
[341.250584] Dynamic subtest pipe-C-DP-1: SUCCESS (3.454s)
[341.252758] Subtest 128x128-left-edge: SUCCESS (7.082s)
[341.564316] [063/141] (693s left) kms_flip (flip-vs-panning)
[341.854987] Starting subtest: flip-vs-panning
[341.856328] Starting dynamic subtest: A-DP1
[352.430208] Dynamic subtest A-DP1: SUCCESS (10.576s)
[352.452879] Starting dynamic subtest: B-DP1
[362.964588] Dynamic subtest B-DP1: SUCCESS (10.532s)
[362.988187] Starting dynamic subtest: C-DP1
[373.492370] Dynamic subtest C-DP1: SUCCESS (10.525s)
[373.493630] Subtest flip-vs-panning: SUCCESS (31.644s)
[373.941995] [064/141] (661s left) i915_suspend (fence-restore-tiled2untiled)
[374.141545] Starting subtest: fence-restore-tiled2untiled
[394.248536] Subtest fence-restore-tiled2untiled: SUCCESS (4.070s)
[395.373139] [065/141] (656s left) gem_mmap (short-mmap)
[395.571900] Starting subtest: short-mmap
[395.573526] Subtest short-mmap: SUCCESS (0.000s)
[395.686360] [066/141] (656s left) kms_vblank (pipe-d-ts-continuation-modeset-rpm)
[395.986854] Subtest pipe-D-ts-continuation-modeset-rpm: SKIP (0.000s)
[396.070042] [067/141] (656s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[396.375268] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[396.377950] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[396.486895] [068/141] (655s left) gem_softpin (safe-alignment)
[396.695374] Starting subtest: safe-alignment
[396.723843] Subtest safe-alignment: SUCCESS (0.028s)
[396.842901] [069/141] (655s left) kms_big_fb (linear-8bpp-rotate-270)
[397.161281] Starting subtest: linear-8bpp-rotate-270
[397.225714] Subtest linear-8bpp-rotate-270: SKIP (0.063s)
[397.336825] [070/141] (655s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[397.639323] Starting subtest: addfb25-y-tiled-small-legacy
[397.640909] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s)
[397.737004] [071/141] (654s left) syncobj_wait (invalid-reset-zero-handles)
[397.937261] Starting subtest: invalid-reset-zero-handles
[397.938929] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[398.038022] [072/141] (654s left) gen9_exec_parse (batch-invalid-length)
[398.258928] Starting subtest: batch-invalid-length
[398.268999] Subtest batch-invalid-length: SUCCESS (0.011s)
[398.487730] [073/141] (653s left) kms_universal_plane (universal-plane-pageflip-windowed-pipe-b)
[398.783906] Starting subtest: universal-plane-pageflip-windowed-pipe-B
[399.592938] Subtest universal-plane-pageflip-windowed-pipe-B: SUCCESS (0.812s)
[399.922719] [074/141] (652s left) kms_frontbuffer_tracking (fbcpsr-badstride)
[400.234964] Starting subtest: fbcpsr-badstride
[400.237783] Subtest fbcpsr-badstride: SKIP (0.000s)
[400.339271] [075/141] (652s left) syncobj_wait (wait-all-snapshot)
[400.542999] Starting subtest: wait-all-snapshot
[400.627214] Subtest wait-all-snapshot: SUCCESS (0.083s)
[400.723395] [076/141] (651s left) gem_exec_schedule (preempt-queue-contexts-chain)
[400.950607] Starting subtest: preempt-queue-contexts-chain
[400.954819] Starting dynamic subtest: rcs0
[402.024547] Dynamic subtest rcs0: SUCCESS (1.069s)
[402.061889] Starting dynamic subtest: bcs0
[403.072113] Dynamic subtest bcs0: SUCCESS (1.046s)
[403.100879] Starting dynamic subtest: vcs0
[404.152100] Dynamic subtest vcs0: SUCCESS (1.074s)
[404.181659] Starting dynamic subtest: vecs0
[405.222824] Dynamic subtest vecs0: SUCCESS (1.073s)
[405.224251] Subtest preempt-queue-contexts-chain: SUCCESS (4.270s)
[405.590098] [077/141] (647s left) kms_lease (multimaster-lease)
[405.893019] Starting subtest: multimaster-lease
[405.898240] Subtest multimaster-lease: SUCCESS (0.007s)
[405.989947] [078/141] (646s left) vc4/vc4_perfmon (create-two-perfmon)
[406.246378] Subtest create-two-perfmon: SKIP (0.000s)
[406.323299] [079/141] (646s left) kms_universal_plane (disable-primary-vs-flip-pipe-b)
[406.624067] Starting subtest: disable-primary-vs-flip-pipe-B
[407.692375] Subtest disable-primary-vs-flip-pipe-B: SUCCESS (1.071s)
[408.025526] [080/141] (644s left) i915_hangman (engine-engine-hang)
[408.245157] Starting subtest: engine-engine-hang
[408.246752] Starting dynamic subtest: rcs0
[408.834291] Dynamic subtest rcs0: SUCCESS (0.588s)
[408.858034] Starting dynamic subtest: bcs0
[409.432397] Dynamic subtest bcs0: SUCCESS (0.597s)
[409.457188] Starting dynamic subtest: vcs0
[410.017356] Dynamic subtest vcs0: SUCCESS (0.584s)
[410.047165] Starting dynamic subtest: vecs0
[410.599215] Dynamic subtest vecs0: SUCCESS (0.581s)
[410.600633] Subtest engine-engine-hang: SUCCESS (2.355s)
[410.725339] [081/141] (642s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[411.046870] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[411.082680] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.034s)
[411.192115] [082/141] (641s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[411.504129] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[411.507484] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[411.608827] [083/141] (641s left) kms_properties (plane-properties-legacy)
[411.907108] Starting subtest: plane-properties-legacy
[413.732463] Subtest plane-properties-legacy: SUCCESS (1.826s)
[414.073240] [084/141] (638s left) gem_exec_whisper (basic-queues-priority-all)
[414.303345] Starting subtest: basic-queues-priority-all
[436.935741] Subtest basic-queues-priority-all: SUCCESS (22.631s)
[437.138902] [085/141] (615s left) kms_invalid_mode (bad-hsync-end)
[437.438936] Starting subtest: bad-hsync-end
[437.440366] Starting dynamic subtest: DP-1-pipe-A
[437.538913] Dynamic subtest DP-1-pipe-A: SUCCESS (0.098s)
[437.565560] Starting dynamic subtest: DP-1-pipe-B
[437.567117] Dynamic subtest DP-1-pipe-B: SUCCESS (0.015s)
[437.590801] Starting dynamic subtest: DP-1-pipe-C
[437.592503] Dynamic subtest DP-1-pipe-C: SUCCESS (0.014s)
[437.594098] Subtest bad-hsync-end: SUCCESS (0.140s)
[437.889165] [086/141] (615s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[438.279627] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[438.557413] [087/141] (614s left) api_intel_bb (blit-noreloc-keep-cache)
[438.752920] Starting subtest: blit-noreloc-keep-cache
[438.769825] Subtest blit-noreloc-keep-cache: SUCCESS (0.017s)
[438.886059] [088/141] (614s left) kms_chamelium_hpd (hdmi-hpd-fast)
[439.276948] Subtest hdmi-hpd-fast: SKIP (0.000s)
[439.584060] [089/141] (613s left) v3d/v3d_wait_bo (map-bo-1ns)
[439.835087] Subtest map-bo-1ns: SKIP (0.000s)
[439.912774] [090/141] (613s left) gem_mmap_gtt (basic)
[440.110071] Starting subtest: basic
[440.111365] Subtest basic: SUCCESS (0.002s)
[440.211320] [091/141] (613s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[440.517988] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[440.520561] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[440.612284] [092/141] (612s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[440.916570] Starting subtest: cursor-vs-flip-legacy
[478.916657] Subtest cursor-vs-flip-legacy: SUCCESS (38.002s)
[479.249770] [093/141] (574s left) gem_mmap_gtt (basic-small-bo-tiledx)
[479.451194] Starting subtest: basic-small-bo-tiledX
[480.375925] Subtest basic-small-bo-tiledX: SUCCESS (0.925s)
[480.544649] [094/141] (572s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[480.987200] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[480.989779] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[481.098304] [095/141] (572s left) gem_ctx_shared (q-independent)
[481.322691] Starting subtest: Q-independent
[481.324137] Starting dynamic subtest: rcs0
[481.421693] Dynamic subtest rcs0: SUCCESS (0.097s)
[481.447193] Starting dynamic subtest: bcs0
[481.502757] Dynamic subtest bcs0: SUCCESS (0.080s)
[481.528316] Starting dynamic subtest: vcs0
[481.567235] Dynamic subtest vcs0: SUCCESS (0.063s)
[481.593293] Starting dynamic subtest: vecs0
[481.630227] Dynamic subtest vecs0: SUCCESS (0.062s)
[481.632279] Subtest Q-independent: SUCCESS (0.307s)
[481.865368] [096/141] (571s left) gem_exec_balancer (full)
[482.086084] Starting subtest: full
[486.054079] Subtest full: SUCCESS (3.968s)
[489.965135] [097/141] (563s left) kms_psr2_sf (overlay-plane-move-continuous-exceed-sf)
[490.167771] Subtest overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[490.232642] [098/141] (563s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[490.567649] Starting subtest: yf-tiled-16bpp-rotate-90
[490.656095] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.087s)
[490.781819] [099/141] (562s left) kms_ccs (pipe-d-ccs-on-another-bo-y_tiled_gen12_mc_ccs)
[491.497316] Subtest pipe-D-ccs-on-another-bo-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[491.813836] [100/141] (561s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_ccs)
[492.287014] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_ccs
[492.802872] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_ccs: SUCCESS (0.516s)
[493.472192] [101/141] (560s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[493.785371] Starting subtest: extended-modeset-hang-oldfb-with-reset
[493.790068] Starting dynamic subtest: pipe-A
[495.960278] Dynamic subtest pipe-A: SUCCESS (2.169s)
[495.990372] Starting dynamic subtest: pipe-C
[498.015174] Dynamic subtest pipe-C: SUCCESS (2.049s)
[498.016793] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (4.230s)
[498.363976] [102/141] (555s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[498.658592] Starting subtest: FB-8BPC-Vs-Panel-8BPC
[498.659918] Starting dynamic subtest: pipe-A-DP-1
[499.071335] Dynamic subtest pipe-A-DP-1: SUCCESS (0.412s)
[499.073093] Subtest FB-8BPC-Vs-Panel-8BPC: SUCCESS (0.414s)
[499.404942] [103/141] (554s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[499.714663] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[499.717742] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[499.821405] [104/141] (553s left) perf (non-zero-reason)
[500.153064] Starting subtest: non-zero-reason
[500.154624] Starting dynamic subtest: 0-rcs0
[535.197562] Dynamic subtest 0-rcs0: SUCCESS (35.041s)
[535.198955] Subtest non-zero-reason: SUCCESS (35.042s)
[535.259170] [105/141] (518s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[535.462658] Starting subtest: etime-single-wait-all-for-submit-submitted
[535.568014] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.106s)
[535.655030] [106/141] (518s left) kms_addfb_basic (invalid-get-prop)
[535.852571] Starting subtest: invalid-get-prop
[535.854129] Subtest invalid-get-prop: SUCCESS (0.000s)
[536.054799] [107/141] (517s left) gem_exec_capture (pi)
[536.266102] Starting subtest: pi
[536.267458] Starting dynamic subtest: rcs0
[565.694044] Dynamic subtest rcs0: SUCCESS (29.427s)
[565.717009] Starting dynamic subtest: bcs0
[595.340381] Dynamic subtest bcs0: SUCCESS (29.645s)
[595.363233] Starting dynamic subtest: vcs0
[624.887633] Dynamic subtest vcs0: SUCCESS (29.545s)
[624.910911] Starting dynamic subtest: vecs0
[654.612580] Dynamic subtest vecs0: SUCCESS (29.724s)
[654.613947] Subtest pi: SUCCESS (118.347s)
[654.709257] [108/141] (399s left) gem_spin_batch (engines)
[655.040219] Starting subtest: engines
[655.045001] Starting dynamic subtest: rcs0
[658.371237] Dynamic subtest rcs0: SUCCESS (3.325s)
[658.394878] Starting dynamic subtest: bcs0
[661.696307] Dynamic subtest bcs0: SUCCESS (3.324s)
[661.718450] Starting dynamic subtest: vcs0
[665.019238] Dynamic subtest vcs0: SUCCESS (3.322s)
[665.041126] Starting dynamic subtest: vecs0
[668.342367] Dynamic subtest vecs0: SUCCESS (3.321s)
[668.343930] Subtest engines: SUCCESS (13.298s)
[668.559994] [109/141] (385s left) kms_getfb (getfb-reject-ccs)
[668.760515] Starting subtest: getfb-reject-ccs
[668.762246] Subtest getfb-reject-ccs: SUCCESS (0.000s)
[668.870649] [110/141] (385s left) gem_exec_schedule (u-semaphore-user)
[669.123774] Starting subtest: u-semaphore-user
[669.145396] Subtest u-semaphore-user: SUCCESS (0.022s)
[669.505777] [111/141] (384s left) kms_ccs (pipe-c-bad-pixel-format-y_tiled_gen12_rc_ccs)
[670.118118] Starting subtest: pipe-C-bad-pixel-format-y_tiled_gen12_rc_ccs
[670.120822] Subtest pipe-C-bad-pixel-format-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[670.546715] [112/141] (383s left) kms_big_fb (4-tiled-addfb-size-overflow)
[670.870693] Starting subtest: 4-tiled-addfb-size-overflow
[670.874304] Subtest 4-tiled-addfb-size-overflow: SKIP (0.000s)
[670.979875] [113/141] (383s left) kms_content_protection (dp-mst-type-0)
[671.316612] Starting subtest: dp-mst-type-0
[671.320118] Subtest dp-mst-type-0: SKIP (0.001s)
[671.446074] [114/141] (382s left) syncobj_timeline (single-wait-available-submitted)
[671.648382] Starting subtest: single-wait-available-submitted
[671.650594] Subtest single-wait-available-submitted: SUCCESS (0.001s)
[671.745687] [115/141] (382s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[672.055295] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[672.057964] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[672.162100] [116/141] (382s left) gem_mmap_wc (read-write)
[672.361486] Starting subtest: read-write
[672.389709] Subtest read-write: SUCCESS (0.031s)
[672.511929] [117/141] (381s left) gem_exec_fence (syncobj-timeline-wait)
[673.310254] Starting subtest: syncobj-timeline-wait
[673.363626] Subtest syncobj-timeline-wait: SUCCESS (0.054s)
[673.596867] [118/141] (380s left) kms_lease (empty_lease)
[673.901633] Starting subtest: empty_lease
[673.903453] Starting dynamic subtest: pipe-A-DP-1
[673.905032] Dynamic subtest pipe-A-DP-1: SUCCESS (0.002s)
[673.932878] Starting dynamic subtest: pipe-B-DP-1
[673.934115] Dynamic subtest pipe-B-DP-1: SUCCESS (0.001s)
[673.958033] Starting dynamic subtest: pipe-C-DP-1
[673.959260] Dynamic subtest pipe-C-DP-1: SUCCESS (0.002s)
[673.960591] Subtest empty_lease: SUCCESS (0.017s)
[674.012790] [119/141] (380s left) kms_ccs (pipe-c-crc-primary-basic-4_tiled_dg2_rc_ccs)
[674.654378] Starting subtest: pipe-C-crc-primary-basic-4_tiled_dg2_rc_ccs
[674.657178] Subtest pipe-C-crc-primary-basic-4_tiled_dg2_rc_ccs: SKIP (0.001s)
[675.042616] [120/141] (379s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[675.349997] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[675.352667] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[675.459406] [121/141] (379s left) i915_pm_dc (dc5-dpms)
[676.777861] Starting subtest: dc5-dpms
[678.110919] Subtest dc5-dpms: SUCCESS (1.335s)
[678.238358] [122/141] (376s left) kms_ccs (pipe-c-bad-aux-stride-4_tiled_mtl_rc_ccs)
[678.930169] Starting subtest: pipe-C-bad-aux-stride-4_tiled_mtl_rc_ccs
[678.933027] Subtest pipe-C-bad-aux-stride-4_tiled_mtl_rc_ccs: SKIP (0.000s)
[679.272960] [123/141] (375s left) kms_psr2_su (page_flip-nv12)
[679.475046] Subtest page_flip-NV12: SKIP (0.000s)
[679.538627] [124/141] (375s left) gem_exec_reloc (basic-scanout)
[679.854856] Starting subtest: basic-scanout
[679.856084] Starting dynamic subtest: rcs0
[680.309299] Dynamic subtest rcs0: SUCCESS (0.457s)
[680.335285] Starting dynamic subtest: bcs0
[680.475676] Dynamic subtest bcs0: SUCCESS (0.165s)
[680.499687] Starting dynamic subtest: vcs0
[680.642380] Dynamic subtest vcs0: SUCCESS (0.165s)
[680.667102] Starting dynamic subtest: vecs0
[680.809168] Dynamic subtest vecs0: SUCCESS (0.165s)
[680.810755] Subtest basic-scanout: SUCCESS (0.959s)
[680.940934] [125/141] (373s left) kms_vblank (pipe-a-wait-forked-hang)
[681.238520] Starting subtest: pipe-A-wait-forked-hang
[688.040866] Subtest pipe-A-wait-forked-hang: SUCCESS (6.805s)
[688.386623] [126/141] (366s left) gem_sync (basic-each)
[688.615900] Starting subtest: basic-each
[690.935317] Subtest basic-each: SUCCESS (2.320s)
[691.152399] [127/141] (363s left) api_intel_allocator (alloc-simple)
[691.351738] Starting subtest: alloc-simple
[691.356018] Subtest alloc-simple: SUCCESS (0.003s)
[691.467715] [128/141] (363s left) kms_ccs (pipe-b-bad-aux-stride-yf_tiled_ccs)
[692.058999] Starting subtest: pipe-B-bad-aux-stride-yf_tiled_ccs
[692.064042] Subtest pipe-B-bad-aux-stride-yf_tiled_ccs: SUCCESS (0.002s)
[692.541532] [129/141] (362s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[692.863829] Starting subtest: 4-tiled-64bpp-rotate-270
[692.866570] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.000s)
[692.977033] [130/141] (361s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_mtl_mc_ccs)
[693.379361] Starting subtest: pipe-A-crc-primary-basic-4_tiled_mtl_mc_ccs
[693.383091] Subtest pipe-A-crc-primary-basic-4_tiled_mtl_mc_ccs: SKIP (0.001s)
[694.022501] [131/141] (360s left) kms_flip (dpms-vs-vblank-race-interruptible)
[694.317185] Starting subtest: dpms-vs-vblank-race-interruptible
[694.322018] Starting dynamic subtest: A-DP1
[698.542436] Dynamic subtest A-DP1: SUCCESS (4.219s)
[698.566839] Starting dynamic subtest: B-DP1
[702.589914] Dynamic subtest B-DP1: SUCCESS (4.044s)
[702.614561] Starting dynamic subtest: C-DP1
[706.910273] Dynamic subtest C-DP1: SUCCESS (4.315s)
[706.911605] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (12.589s)
[707.261315] [132/141] (347s left) i915_pm_rpm (gem-execbuf)
[709.058934] Starting subtest: gem-execbuf
[709.061709] Starting dynamic subtest: smem0
[710.730836] Dynamic subtest smem0: SUCCESS (1.671s)
[710.733254] Subtest gem-execbuf: SUCCESS (1.672s)
[713.919085] [133/141] (341s left) debugfs_test (read_all_entries)
[714.126923] Starting subtest: read_all_entries
[714.397613] Subtest read_all_entries: SUCCESS (0.270s)
[714.600682] [134/141] (340s left) kms_big_fb (x-tiled-addfb)
[714.929024] Starting subtest: x-tiled-addfb
[714.930461] Subtest x-tiled-addfb: SUCCESS (0.001s)
[715.033700] [135/141] (340s left) debugfs_test (read_all_entries_display_on)
[715.352800] Starting subtest: read_all_entries_display_on
[715.750259] Subtest read_all_entries_display_on: SUCCESS (0.400s)
[715.885274] [136/141] (339s left) v3d/v3d_perfmon (destroy-invalid-perfmon)
[716.138697] Subtest destroy-invalid-perfmon: SKIP (0.000s)
[716.217246] [137/141] (339s left) kms_ccs (pipe-b-crc-primary-basic-4_tiled_dg2_rc_ccs)
[716.737269] Starting subtest: pipe-B-crc-primary-basic-4_tiled_dg2_rc_ccs
[716.740828] Subtest pipe-B-crc-primary-basic-4_tiled_dg2_rc_ccs: SKIP (0.001s)
[717.285414] [138/141] (338s left) i915_pm_rpm (reg-read-ioctl)
[719.089510] Starting subtest: reg-read-ioctl
[719.733648] Subtest reg-read-ioctl: SUCCESS (0.644s)
[720.604094] [139/141] (334s left) kms_psr (basic)
[720.808454] Subtest basic: SKIP (0.000s)
[720.866692] [140/141] (334s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[721.164285] Starting subtest: 2x-cursor-vs-flip-legacy
[721.166873] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.005s)
[721.268222] [141/141] (334s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[721.488924] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[721.491514] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.001s)
[721.697973] Closing watchdogs
Done.