[93.722181] Initializing watchdogs
[93.722241]   /dev/watchdog0
[93.726790] [001/141] (960s left) kms_ccs (pipe-a-crc-primary-rotation-180-yf_tiled_ccs)
[93.949585] Starting subtest: pipe-A-crc-primary-rotation-180-yf_tiled_ccs
[93.951105] Subtest pipe-A-crc-primary-rotation-180-yf_tiled_ccs: SKIP (0.000s)
[94.302821] [002/141] (959s left) vc4/vc4_dmabuf_poll (poll-read-waits-until-write-done)
[94.374504] Subtest poll-read-waits-until-write-done: SKIP (0.000s)
[94.401835] [003/141] (959s left) kms_plane (plane-position-covered)
[94.498068] Starting subtest: plane-position-covered
[94.498817] Starting dynamic subtest: pipe-A-planes
[95.916209] Dynamic subtest pipe-A-planes: SUCCESS (1.417s)
[95.920035] Starting dynamic subtest: pipe-B-planes
[97.319827] Dynamic subtest pipe-B-planes: SUCCESS (1.402s)
[97.320704] Subtest plane-position-covered: SUCCESS (2.822s)
[97.418613] [004/141] (956s left) perf (global-sseu-config-invalid)
[97.500931] Starting subtest: global-sseu-config-invalid
[97.501661] Starting dynamic subtest: 0-rcs0
[97.510566] Dynamic subtest 0-rcs0: SUCCESS (0.010s)
[97.511287] Subtest global-sseu-config-invalid: SUCCESS (0.010s)
[97.524476] [005/141] (956s left) i915_pm_freq_mult (media-freq)
[97.570912] Starting subtest: media-freq
[97.571610] Starting dynamic subtest: gt0
[97.572983] Dynamic subtest gt0: SKIP (0.000s)
[97.574341] Subtest media-freq: SKIP (0.000s)
[97.601569] [006/141] (956s left) vc4/vc4_purgeable_bo (mark-purgeable-twice)
[97.666037] Subtest mark-purgeable-twice: SKIP (0.000s)
[97.693654] [007/141] (956s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[97.794728] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[97.796148] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[97.835209] [008/141] (956s left) gem_lmem_swapping (heavy-random)
[97.886053] Subtest heavy-random: SKIP (0.000s)
[97.902992] [009/141] (956s left) gem_render_copy (linear-to-vebox-y-tiled)
[97.953299] Starting subtest: linear-to-vebox-y-tiled
[97.954036] Starting dynamic subtest: smem
[98.050587] Dynamic subtest smem: SUCCESS (0.097s)
[98.051402] Subtest linear-to-vebox-y-tiled: SUCCESS (0.097s)
[98.185876] [010/141] (956s left) kms_addfb_basic (tile-pitch-mismatch)
[98.232133] Starting subtest: tile-pitch-mismatch
[98.232891] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[98.327273] [011/141] (955s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-pwrite)
[98.426842] Starting subtest: psr-1p-offscren-pri-indfb-draw-pwrite
[98.428314] Subtest psr-1p-offscren-pri-indfb-draw-pwrite: SKIP (0.000s)
[98.476884] [012/141] (955s left) gem_mmap_wc (invalid-flags)
[98.523968] Starting subtest: invalid-flags
[98.524724] Subtest invalid-flags: SUCCESS (0.000s)
[98.568597] [013/141] (955s left) kms_psr2_su (frontbuffer-xrgb8888)
[98.614855] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[98.628477] [014/141] (955s left) gem_mmap_gtt (big-copy)
[98.673844] Starting subtest: big-copy
[105.102307] Subtest big-copy: SUCCESS (6.428s)
[105.140396] [015/141] (949s left) gem_readwrite (new-obj)
[105.230900] Starting subtest: new-obj
[105.232321] Subtest new-obj: SUCCESS (0.000s)
[105.293052] [016/141] (949s left) kms_psr (primary_render)
[105.353853] Subtest primary_render: SKIP (0.000s)
[105.371345] [017/141] (949s left) kms_ccs (pipe-c-random-ccs-data-yf_tiled_ccs)
[105.696525] Starting subtest: pipe-C-random-ccs-data-yf_tiled_ccs
[105.698839] Subtest pipe-C-random-ccs-data-yf_tiled_ccs: SKIP (0.000s)
[105.886308] [018/141] (948s left) kms_cursor_crc (cursor-random-256x256)
[105.987493] Starting subtest: cursor-random-256x256
[105.992707] Starting dynamic subtest: pipe-A-HDMI-A-1
[107.932765] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.941s)
[107.956700] Starting dynamic subtest: pipe-D-HDMI-A-1
[110.642409] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.689s)
[110.643131] Subtest cursor-random-256x256: SUCCESS (4.655s)
[110.755409] [019/141] (943s left) gem_ctx_persistence (legacy-engines-hang)
[110.809270] Starting subtest: legacy-engines-hang
[110.810045] Starting dynamic subtest: render
[110.845998] Dynamic subtest render: SUCCESS (0.036s)
[110.851201] Starting dynamic subtest: bsd1
[110.877919] Dynamic subtest bsd1: SUCCESS (0.032s)
[110.882572] Starting dynamic subtest: bsd2
[110.913229] Dynamic subtest bsd2: SUCCESS (0.035s)
[110.917663] Starting dynamic subtest: blt
[110.945782] Dynamic subtest blt: SUCCESS (0.032s)
[110.955271] Starting dynamic subtest: vebox
[110.984914] Dynamic subtest vebox: SUCCESS (0.038s)
[110.986569] Subtest legacy-engines-hang: SUCCESS (0.175s)
[111.033233] [020/141] (943s left) gem_exec_reloc (basic-softpin)
[111.088709] Starting subtest: basic-softpin
[111.090362] Subtest basic-softpin: SUCCESS (0.002s)
[111.171428] [021/141] (943s left) kms_vblank (pipe-b-ts-continuation-dpms-rpm)
[111.275470] Starting subtest: pipe-B-ts-continuation-dpms-rpm
[123.046106] Subtest pipe-B-ts-continuation-dpms-rpm: SUCCESS (11.771s)
[123.193258] [022/141] (931s left) kms_big_fb (linear-16bpp-rotate-270)
[123.301660] Starting subtest: linear-16bpp-rotate-270
[123.349646] Subtest linear-16bpp-rotate-270: SKIP (0.047s)
[123.417411] [023/141] (931s left) v3d/v3d_submit_cl (multiple-job-submission)
[123.488181] Subtest multiple-job-submission: SKIP (0.000s)
[123.517447] [024/141] (930s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[123.621012] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[123.622422] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[123.675833] [025/141] (930s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[123.778878] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[123.780319] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[123.817484] [026/141] (930s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[123.932119] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[124.996904] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (1.066s)
[125.075365] [027/141] (929s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[125.182993] Starting subtest: y-tiled-addfb-size-offset-overflow
[125.183752] Subtest y-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[125.241762] [028/141] (929s left) gem_softpin (evict-snoop-interruptible)
[125.290674] Starting subtest: evict-snoop-interruptible
[125.292144] Subtest evict-snoop-interruptible: SKIP (0.000s)
[125.333449] [029/141] (929s left) gem_ctx_param (invalid-set-no-zeromap)
[125.381791] Starting subtest: invalid-set-no-zeromap
[125.382524] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[125.417074] [030/141] (929s left) gem_mmap_wc (write-read)
[125.465245] Starting subtest: write-read
[125.469029] Subtest write-read: SUCCESS (0.004s)
[125.519972] [031/141] (929s left) kms_pipe_crc_basic (suspend-read-crc)
[125.626637] Starting subtest: suspend-read-crc
[125.628455] Starting dynamic subtest: pipe-A-HDMI-A-1
[142.692342] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.066s)
[142.698782] Starting dynamic subtest: pipe-B-HDMI-A-1
[159.867684] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.349s)
[159.873843] Starting dynamic subtest: pipe-C-HDMI-A-1
[178.064788] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.801s)
[178.073208] Starting dynamic subtest: pipe-D-HDMI-A-1
[196.356495] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (3.359s)
[196.357288] Subtest suspend-read-crc: SUCCESS (10.589s)
[201.509996] [032/141] (918s left) gem_ctx_param (invalid-param-set)
[201.562790] Starting subtest: invalid-param-set
[201.563582] Subtest invalid-param-set: SUCCESS (0.000s)
[201.596581] [033/141] (918s left) kms_vblank (pipe-a-query-idle)
[201.691242] Starting subtest: pipe-A-query-idle
[202.838851] Subtest pipe-A-query-idle: SUCCESS (1.148s)
[202.933494] [034/141] (916s left) gem_exec_reloc (basic-gtt-active)
[202.982586] Starting subtest: basic-gtt-active
[203.095842] Subtest basic-gtt-active: SUCCESS (0.113s)
[203.192182] [035/141] (916s left) kms_rotation_crc (multiplane-rotation)
[203.288441] Starting subtest: multiplane-rotation
[212.681569] Subtest multiplane-rotation: SUCCESS (9.394s)
[212.758576] [036/141] (907s left) kms_busy (extended-modeset-hang-newfb)
[212.865619] Starting subtest: extended-modeset-hang-newfb
[212.867337] Starting dynamic subtest: pipe-A
[215.647578] Dynamic subtest pipe-A: SUCCESS (2.779s)
[215.658168] Starting dynamic subtest: pipe-D
[218.439329] Dynamic subtest pipe-D: SUCCESS (2.784s)
[218.440100] Subtest extended-modeset-hang-newfb: SUCCESS (5.574s)
[218.545202] [037/141] (901s left) api_intel_allocator (reloc-allocator)
[218.593662] Starting subtest: reloc-allocator
[218.594459] Starting dynamic subtest: basic
[218.596298] Dynamic subtest basic: SUCCESS (0.002s)
[218.601135] Starting dynamic subtest: parallel-one
[218.601946] Dynamic subtest parallel-one: SUCCESS (0.005s)
[218.607198] Starting dynamic subtest: print
[218.608032] Dynamic subtest print: SUCCESS (0.000s)
[218.613478] Starting dynamic subtest: reuse
[218.614219] Dynamic subtest reuse: SUCCESS (0.000s)
[218.619444] Starting dynamic subtest: fork-reopen-allocator
[218.620185] Dynamic subtest fork-reopen-allocator: SUCCESS (0.014s)
[218.620969] Subtest reloc-allocator: SUCCESS (0.023s)
[218.679300] [038/141] (901s left) syncobj_timeline (invalid-signal-illegal-handle)
[218.730166] Starting subtest: invalid-signal-illegal-handle
[218.731003] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[218.770282] [039/141] (901s left) gem_workarounds (suspend-resume-fd)
[218.827362] Starting subtest: suspend-resume-fd
[235.343296] Subtest suspend-resume-fd: SUCCESS (1.314s)
[241.413856] [040/141] (899s left) gem_exec_params (secure-non-root)
[241.474013] Starting subtest: secure-non-root
[241.475542] Subtest secure-non-root: SKIP (0.000s)
[241.525602] [041/141] (899s left) gem_mmap_wc (write-wc-read-gtt)
[241.577548] Starting subtest: write-wc-read-gtt
[241.881230] Subtest write-wc-read-gtt: SUCCESS (0.304s)
[241.942986] [042/141] (899s left) gem_exec_schedule (in-order)
[242.008395] Starting subtest: in-order
[242.009220] Starting dynamic subtest: rcs0
[242.061325] Dynamic subtest rcs0: SUCCESS (0.052s)
[242.069622] Starting dynamic subtest: bcs0
[242.117062] Dynamic subtest bcs0: SUCCESS (0.055s)
[242.125957] Starting dynamic subtest: vcs0
[242.173221] Dynamic subtest vcs0: SUCCESS (0.055s)
[242.182071] Starting dynamic subtest: vcs1
[242.233970] Dynamic subtest vcs1: SUCCESS (0.060s)
[242.242407] Starting dynamic subtest: vecs0
[242.293128] Dynamic subtest vecs0: SUCCESS (0.058s)
[242.294156] Subtest in-order: SUCCESS (0.284s)
[242.564397] [043/141] (898s left) i915_query (engine-info-invalid)
[242.621191] Starting subtest: engine-info-invalid
[242.621954] Subtest engine-info-invalid: SUCCESS (0.000s)
[242.654747] [044/141] (898s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[242.761536] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[242.763181] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[242.813504] [045/141] (898s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[242.913198] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[242.914683] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[242.971565] [046/141] (898s left) gem_exec_reloc (basic-cpu-active)
[243.020400] Starting subtest: basic-cpu-active
[243.147439] Subtest basic-cpu-active: SUCCESS (0.119s)
[243.238323] [047/141] (897s left) gem_exec_schedule (smoketest-all)
[243.296372] Starting subtest: smoketest-all
[275.555833] Subtest smoketest-all: SUCCESS (32.254s)
[275.860316] [048/141] (865s left) kms_plane_scaling (planes-downscale-factor-0-25-unity-scaling)
[275.960493] Starting subtest: planes-downscale-factor-0-25-unity-scaling
[275.962376] Starting dynamic subtest: pipe-A-HDMI-A-1
[275.974334] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.011s)
[275.978792] Starting dynamic subtest: pipe-B-HDMI-A-1
[276.000250] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.024s)
[276.004668] Starting dynamic subtest: pipe-C-HDMI-A-1
[276.025683] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.024s)
[276.030098] Starting dynamic subtest: pipe-D-HDMI-A-1
[276.052159] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.025s)
[276.053589] Subtest planes-downscale-factor-0-25-unity-scaling: SKIP (0.091s)
[276.106132] [049/141] (865s left) kms_ccs (pipe-c-crc-primary-basic-4_tiled_dg2_rc_ccs_cc)
[276.419648] Starting subtest: pipe-C-crc-primary-basic-4_tiled_dg2_rc_ccs_cc
[276.421225] Subtest pipe-C-crc-primary-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[276.630760] [050/141] (864s left) gem_exec_balancer (parallel-ordering)
[276.870025] Starting subtest: parallel-ordering
[277.026503] Subtest parallel-ordering: FAIL (0.145s)
[277.081527] [051/141] (864s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_dg2_mc_ccs)
[277.459094] Starting subtest: pipe-D-bad-rotation-90-4_tiled_dg2_mc_ccs
[277.460605] Subtest pipe-D-bad-rotation-90-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[277.598335] [052/141] (863s left) syncobj_timeline (wait-for-submit-complex)
[277.645939] Starting subtest: wait-for-submit-complex
[277.707136] Subtest wait-for-submit-complex: SUCCESS (0.061s)
[277.739964] [053/141] (863s left) gem_busy (semaphore)
[277.919461] Starting subtest: semaphore
[277.920552] Starting dynamic subtest: rcs0
[277.944430] Dynamic subtest rcs0: SUCCESS (0.025s)
[277.953083] Starting dynamic subtest: bcs0
[277.966258] Dynamic subtest bcs0: SUCCESS (0.021s)
[277.975434] Starting dynamic subtest: vcs0
[277.989382] Dynamic subtest vcs0: SUCCESS (0.022s)
[277.999024] Starting dynamic subtest: vcs1
[278.009016] Dynamic subtest vcs1: SUCCESS (0.019s)
[278.017639] Starting dynamic subtest: vecs0
[278.036571] Dynamic subtest vecs0: SUCCESS (0.027s)
[278.037807] Subtest semaphore: SUCCESS (0.118s)
[278.213599] [054/141] (863s left) kms_psr (psr2_sprite_mmap_gtt)
[278.261381] Subtest psr2_sprite_mmap_gtt: SKIP (0.000s)
[278.283578] [055/141] (862s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_dg2_rc_ccs_cc)
[278.674522] Starting subtest: pipe-D-crc-primary-basic-4_tiled_dg2_rc_ccs_cc
[278.676089] Subtest pipe-D-crc-primary-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[278.804417] [056/141] (862s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[278.906107] Starting subtest: psr-rgb101010-draw-mmap-gtt
[278.907535] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[278.963198] [057/141] (862s left) i915_module_load (resize-bar)
[279.010148] Starting subtest: resize-bar
[279.014379] Subtest resize-bar: SKIP (0.004s)
[279.031194] [058/141] (862s left) kms_dp_tiled_display (basic-test-pattern)
[279.128293] Starting subtest: basic-test-pattern
[279.129802] Subtest basic-test-pattern: SKIP (0.000s)
[279.162880] [059/141] (862s left) gem_softpin (allocator-fork)
[279.213339] Starting subtest: allocator-fork
[281.428261] Subtest allocator-fork: SUCCESS (2.214s)
[281.508689] [060/141] (859s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[281.600051] Starting subtest: 2x-flip-vs-modeset-vs-hang
[281.613083] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.013s)
[281.654976] [061/141] (859s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[281.737462] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[281.740954] Starting dynamic subtest: A-HDMI-A1
[289.544704] Dynamic subtest A-HDMI-A1: SUCCESS (7.803s)
[289.550601] Starting dynamic subtest: B-HDMI-A1
[297.312996] Dynamic subtest B-HDMI-A1: SUCCESS (7.767s)
[297.320303] Starting dynamic subtest: C-HDMI-A1
[305.081259] Dynamic subtest C-HDMI-A1: SUCCESS (7.764s)
[305.085668] Starting dynamic subtest: D-HDMI-A1
[312.841995] Dynamic subtest D-HDMI-A1: SUCCESS (7.762s)
[312.844268] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (31.107s)
[312.980333] [062/141] (828s left) kms_atomic_transition (modeset-transition)
[313.081014] Starting subtest: modeset-transition
[313.081854] Starting dynamic subtest: 1x-outputs
[316.206397] Dynamic subtest 1x-outputs: SUCCESS (3.125s)
[316.246305] Subtest modeset-transition: SUCCESS (3.165s)
[316.336606] [063/141] (824s left) kms_setmode (basic)
[316.388689] Starting subtest: basic
[316.466361] Starting dynamic subtest: pipe-A-HDMI-A-1
[317.528993] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.061s)
[317.612887] Starting dynamic subtest: pipe-B-HDMI-A-1
[318.671052] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.060s)
[318.721394] Subtest basic: SUCCESS (2.332s)
[318.811519] [064/141] (822s left) kms_vblank (pipe-d-wait-forked-busy-hang)
[318.910712] Starting subtest: pipe-D-wait-forked-busy-hang
[333.362379] Subtest pipe-D-wait-forked-busy-hang: SUCCESS (14.456s)
[333.465551] [065/141] (807s left) kms_lease (lease_revoke)
[333.563417] Starting subtest: lease_revoke
[333.565583] Starting dynamic subtest: pipe-A-HDMI-A-1
[333.599971] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.035s)
[333.610898] Starting dynamic subtest: pipe-B-HDMI-A-1
[333.637373] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.036s)
[333.652867] Starting dynamic subtest: pipe-C-HDMI-A-1
[333.674520] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.036s)
[333.690256] Starting dynamic subtest: pipe-D-HDMI-A-1
[333.711623] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.036s)
[333.712359] Subtest lease_revoke: SUCCESS (0.149s)
[333.765629] [066/141] (807s left) kms_ccs (pipe-a-ccs-on-another-bo-y_tiled_ccs)
[333.956151] Starting subtest: pipe-A-ccs-on-another-bo-y_tiled_ccs
[333.957540] Subtest pipe-A-ccs-on-another-bo-y_tiled_ccs: SKIP (0.000s)
[334.291322] [067/141] (807s left) fbdev (pan)
[334.338670] Starting subtest: pan
[334.360946] Subtest pan: SUCCESS (0.022s)
[334.398870] [068/141] (806s left) kms_cursor_edge_walk (64x64-top-edge)
[334.496446] Starting subtest: 64x64-top-edge
[334.498215] Starting dynamic subtest: pipe-A-HDMI-A-1
[336.230048] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.732s)
[336.236997] Starting dynamic subtest: pipe-D-HDMI-A-1
[337.901632] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.667s)
[337.902395] Subtest 64x64-top-edge: SUCCESS (3.404s)
[337.973100] [069/141] (803s left) drm_fdinfo (virtual-busy-hang)
[338.021099] Starting subtest: virtual-busy-hang
[343.187861] Subtest virtual-busy-hang: SUCCESS (5.166s)
[343.226700] [070/141] (798s left) gem_exec_schedule (preempt-hang)
[343.397246] Starting subtest: preempt-hang
[343.398785] Starting dynamic subtest: rcs0
[343.594357] Dynamic subtest rcs0: SUCCESS (0.197s)
[343.599648] Starting dynamic subtest: bcs0
[343.780998] Dynamic subtest bcs0: SUCCESS (0.186s)
[343.785859] Starting dynamic subtest: vcs0
[343.962558] Dynamic subtest vcs0: SUCCESS (0.181s)
[343.967460] Starting dynamic subtest: vcs1
[344.155157] Dynamic subtest vcs1: SUCCESS (0.192s)
[344.160165] Starting dynamic subtest: vecs0
[344.338873] Dynamic subtest vecs0: SUCCESS (0.183s)
[344.339638] Subtest preempt-hang: SUCCESS (0.943s)
[344.500708] [071/141] (796s left) kms_frontbuffer_tracking (psr-1p-rte)
[344.608585] Starting subtest: psr-1p-rte
[344.609965] Subtest psr-1p-rte: SKIP (0.000s)
[344.657408] [072/141] (796s left) perf_pmu (idle-no-semaphores)
[344.705905] Starting subtest: idle-no-semaphores
[344.706705] Starting dynamic subtest: rcs0
[345.235731] Dynamic subtest rcs0: SUCCESS (0.528s)
[345.243725] Starting dynamic subtest: bcs0
[345.752109] Dynamic subtest bcs0: SUCCESS (0.515s)
[345.760456] Starting dynamic subtest: vcs0
[346.263733] Dynamic subtest vcs0: SUCCESS (0.511s)
[346.272169] Starting dynamic subtest: vcs1
[346.784317] Dynamic subtest vcs1: SUCCESS (0.520s)
[346.792653] Starting dynamic subtest: vecs0
[347.295607] Dynamic subtest vecs0: SUCCESS (0.510s)
[347.297014] Subtest idle-no-semaphores: SUCCESS (2.589s)
[347.339742] [073/141] (794s left) kms_ccs (pipe-b-bad-aux-stride-4_tiled_mtl_rc_ccs_cc)
[347.621749] Starting subtest: pipe-B-bad-aux-stride-4_tiled_mtl_rc_ccs_cc
[347.623341] Subtest pipe-B-bad-aux-stride-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[347.870355] [074/141] (793s left) v3d/v3d_submit_csd (bad-multisync-out-sync)
[347.931765] Subtest bad-multisync-out-sync: SKIP (0.000s)
[347.964479] [075/141] (793s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[348.063938] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[348.065333] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[348.119884] [076/141] (793s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[348.220158] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[348.221666] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[348.270037] [077/141] (793s left) kms_chamelium_edid (vga-edid-read)
[348.414310] Subtest vga-edid-read: SKIP (0.000s)
[348.472200] [078/141] (793s left) gem_spin_batch (resubmit-all)
[348.536415] Starting subtest: resubmit-all
[348.537192] Starting dynamic subtest: rcs0
[348.539255] Dynamic subtest rcs0: SUCCESS (0.003s)
[348.544547] Starting dynamic subtest: bcs0
[348.545305] Dynamic subtest bcs0: SUCCESS (0.001s)
[348.550081] Starting dynamic subtest: vcs0
[348.550786] Dynamic subtest vcs0: SUCCESS (0.001s)
[348.555360] Starting dynamic subtest: vcs1
[348.556046] Dynamic subtest vcs1: SUCCESS (0.001s)
[348.560510] Starting dynamic subtest: vecs0
[348.561218] Dynamic subtest vecs0: SUCCESS (0.001s)
[348.561916] Subtest resubmit-all: SUCCESS (0.009s)
[348.684340] [079/141] (792s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[348.779959] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[348.780757] Starting dynamic subtest: pipe-A-valid-mode
[349.680715] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.899s)
[349.681523] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SUCCESS (0.901s)
[349.773541] [080/141] (791s left) gen9_exec_parse (bb-start-out)
[349.824955] Subtest bb-start-out: SKIP (0.000s)
[349.842982] [081/141] (791s left) prime_mmap (test_userptr)
[349.895679] Starting subtest: test_userptr
[349.896531] Starting dynamic subtest: test_userptr-smem
[349.897344] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[349.898146] Subtest test_userptr: SUCCESS (0.001s)
[349.942049] [082/141] (791s left) kms_content_protection (lic)
[350.053904] Starting subtest: LIC
[350.331515] Subtest LIC: SKIP (0.275s)
[350.446668] [083/141] (791s left) gem_render_copy_redux (interruptible)
[350.500516] Starting subtest: interruptible
[350.937868] Subtest interruptible: SUCCESS (0.429s)
[350.996645] [084/141] (790s left) gem_exec_balancer (hog)
[351.049646] Starting subtest: hog
[351.920690] Subtest hog: SUCCESS (0.870s)
[352.147033] [085/141] (789s left) kms_getfb (getfb2-handle-zero)
[352.194034] Starting subtest: getfb2-handle-zero
[352.194813] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[352.241737] [086/141] (789s left) syncobj_wait (multi-wait-all-submitted)
[352.292539] Starting subtest: multi-wait-all-submitted
[352.401721] Subtest multi-wait-all-submitted: SUCCESS (0.108s)
[352.450205] [087/141] (789s left) syncobj_timeline (single-wait-for-submit-signaled)
[352.508055] Starting subtest: single-wait-for-submit-signaled
[352.508855] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[352.547738] [088/141] (789s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[352.652690] Starting subtest: cursor-rapid-movement-64x64
[352.658767] Starting dynamic subtest: pipe-A-HDMI-A-1
[352.891755] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.233s)
[352.918641] Starting dynamic subtest: pipe-D-HDMI-A-1
[353.923539] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.011s)
[353.924234] Subtest cursor-rapid-movement-64x64: SUCCESS (1.270s)
[354.024027] [089/141] (787s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[354.127851] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[354.417708] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.290s)
[354.507430] [090/141] (787s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[354.610979] Starting subtest: x-tiled-16bpp-rotate-0
[355.593855] Subtest x-tiled-16bpp-rotate-0: SUCCESS (0.983s)
[355.710383] [091/141] (785s left) gem_exec_schedule (u-submit-late-slice)
[355.772286] Starting subtest: u-submit-late-slice
[355.773007] Starting dynamic subtest: rcs0
[355.796998] Dynamic subtest rcs0: SUCCESS (0.024s)
[355.802851] Starting dynamic subtest: bcs0
[355.821967] Dynamic subtest bcs0: SUCCESS (0.025s)
[355.827420] Starting dynamic subtest: vcs0
[355.844941] Dynamic subtest vcs0: SUCCESS (0.022s)
[355.850346] Starting dynamic subtest: vcs1
[355.866237] Dynamic subtest vcs1: SUCCESS (0.021s)
[355.871420] Starting dynamic subtest: vecs0
[355.890133] Dynamic subtest vecs0: SUCCESS (0.023s)
[355.891014] Subtest u-submit-late-slice: SUCCESS (0.117s)
[356.165419] [092/141] (785s left) gem_pread (self)
[356.222910] Starting subtest: self
[356.229561] Subtest self: SUCCESS (0.007s)
[356.286851] [093/141] (785s left) gem_exec_params (cliprects-invalid)
[356.345609] Starting subtest: cliprects-invalid
[356.346447] Subtest cliprects-invalid: SUCCESS (0.000s)
[356.404713] [094/141] (785s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[356.515770] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[356.517207] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[356.575543] [095/141] (785s left) gem_exec_fence (submit67)
[356.745256] Starting subtest: submit67
[356.746744] Starting dynamic subtest: rcs0
[357.652061] Dynamic subtest rcs0: SUCCESS (0.906s)
[357.658587] Starting dynamic subtest: bcs0
[358.115597] Dynamic subtest bcs0: SUCCESS (0.463s)
[358.121701] Starting dynamic subtest: vcs0
[358.617085] Dynamic subtest vcs0: SUCCESS (0.501s)
[358.623342] Starting dynamic subtest: vcs1
[359.097904] Dynamic subtest vcs1: SUCCESS (0.480s)
[359.104300] Starting dynamic subtest: vecs0
[359.609411] Dynamic subtest vecs0: SUCCESS (0.511s)
[359.610212] Subtest submit67: SUCCESS (2.865s)
[360.049208] [096/141] (781s left) syncobj_timeline (invalid-transfer-non-existent-point)
[360.103963] Starting subtest: invalid-transfer-non-existent-point
[360.104789] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[360.141375] [097/141] (781s left) gem_exec_flush (basic-wb-pro-default)
[360.201338] Starting subtest: basic-wb-pro-default
[365.616405] Subtest basic-wb-pro-default: SUCCESS (5.415s)
[365.786175] [098/141] (776s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[365.852337] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[365.853157] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[365.896580] [099/141] (775s left) kms_chamelium_audio (dp-audio)
[366.053417] Subtest dp-audio: SKIP (0.000s)
[366.109543] [100/141] (775s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_dg2_rc_ccs_cc)
[366.364601] Starting subtest: pipe-B-random-ccs-data-4_tiled_dg2_rc_ccs_cc
[366.366790] Subtest pipe-B-random-ccs-data-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[366.636046] [101/141] (775s left) v3d/v3d_job_submission (threaded-job-submission)
[366.706047] Subtest threaded-job-submission: SKIP (0.000s)
[366.735729] [102/141] (775s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[366.880456] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[366.936653] [103/141] (774s left) kms_ccs (pipe-a-missing-ccs-buffer-y_tiled_gen12_rc_ccs)
[367.122761] Starting subtest: pipe-A-missing-ccs-buffer-y_tiled_gen12_rc_ccs
[367.123484] Subtest pipe-A-missing-ccs-buffer-y_tiled_gen12_rc_ccs: SUCCESS (0.000s)
[367.465841] [104/141] (774s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[367.570292] Starting subtest: yf-tiled-8bpp-rotate-90
[367.571963] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[367.640596] [105/141] (774s left) kms_rotation_crc (primary-rotation-180)
[367.739724] Starting subtest: primary-rotation-180
[371.261882] Subtest primary-rotation-180: SUCCESS (3.523s)
[371.395327] [106/141] (770s left) gem_vm_create (invalid-create)
[371.446649] Starting subtest: invalid-create
[371.447410] Subtest invalid-create: SUCCESS (0.000s)
[371.503982] [107/141] (770s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[371.602505] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[371.603933] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[371.646279] [108/141] (770s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[371.729949] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[371.743145] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.012s)
[371.780941] [109/141] (770s left) gem_exec_whisper (basic-queues-forked)
[371.844966] Starting subtest: basic-queues-forked
[375.313241] Subtest basic-queues-forked: SUCCESS (3.468s)
[375.644321] [110/141] (766s left) kms_ccs (pipe-c-bad-rotation-90-4_tiled_dg2_mc_ccs)
[375.955608] Starting subtest: pipe-C-bad-rotation-90-4_tiled_dg2_mc_ccs
[375.957287] Subtest pipe-C-bad-rotation-90-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[376.172238] [111/141] (765s left) kms_addfb_basic (master-rmfb)
[376.219666] Starting subtest: master-rmfb
[376.220471] Subtest master-rmfb: SUCCESS (0.000s)
[376.313636] [112/141] (765s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_ccs)
[376.546209] Starting subtest: pipe-B-crc-primary-basic-y_tiled_ccs
[376.547691] Subtest pipe-B-crc-primary-basic-y_tiled_ccs: SKIP (0.000s)
[376.837448] [113/141] (765s left) api_intel_bb (object-noreloc-keep-cache-simple)
[376.885197] Starting subtest: object-noreloc-keep-cache-simple
[376.886487] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.002s)
[376.953555] [114/141] (765s left) prime_self_import (basic-llseek-size)
[376.997836] Starting subtest: basic-llseek-size
[377.000938] Subtest basic-llseek-size: SUCCESS (0.002s)
[377.045305] [115/141] (764s left) kms_vblank (pipe-b-ts-continuation-idle-hang)
[377.141693] Starting subtest: pipe-B-ts-continuation-idle-hang
[391.215971] Subtest pipe-B-ts-continuation-idle-hang: SUCCESS (14.074s)
[391.317683] [116/141] (750s left) api_intel_bb (reset-bb)
[391.367498] Starting subtest: reset-bb
[391.368517] Subtest reset-bb: SUCCESS (0.002s)
[391.442546] [117/141] (750s left) kms_hdmi_inject (inject-4k)
[391.549045] Starting subtest: inject-4k
[391.733163] Subtest inject-4k: SUCCESS (0.181s)
[391.847603] [118/141] (750s left) i915_pm_rpm (modeset-pc8-residency-stress)
[403.399532] Starting subtest: modeset-pc8-residency-stress
[403.401979] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[403.540727] [119/141] (738s left) gem_exec_reloc (basic-cpu-read-noreloc)
[403.590675] Starting subtest: basic-cpu-read-noreloc
[403.593209] Subtest basic-cpu-read-noreloc: SUCCESS (0.003s)
[403.681909] [120/141] (738s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[403.778474] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[403.779222] Starting dynamic subtest: pipe-A-valid-mode
[403.826291] Dynamic subtest pipe-A-valid-mode: SKIP (0.046s)
[403.827823] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.048s)
[403.897592] [121/141] (738s left) gem_exec_reloc (basic-cpu-wc)
[403.946863] Starting subtest: basic-cpu-wc
[403.951530] Subtest basic-cpu-wc: SUCCESS (0.005s)
[404.039497] [122/141] (738s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[404.139466] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[404.140844] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[404.190539] [123/141] (737s left) gem_exec_fair (basic-pace)
[404.246598] Starting subtest: basic-pace
[404.247335] Starting dynamic subtest: rcs0
[408.665096] Dynamic subtest rcs0: FAIL (4.401s)
[408.670479] Starting dynamic subtest: bcs0
[413.081022] Dynamic subtest bcs0: FAIL (4.412s)
[413.086178] Starting dynamic subtest: vcs0
[417.465280] Dynamic subtest vcs0: FAIL (4.386s)
[417.470318] Starting dynamic subtest: vcs1
[423.053207] Dynamic subtest vcs1: FAIL (5.587s)
[423.058203] Starting dynamic subtest: vecs0
[428.637390] Dynamic subtest vecs0: FAIL (5.584s)
[428.638121] Subtest basic-pace: FAIL (24.372s)
[428.776074] [124/141] (713s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[428.886685] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[428.888337] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[428.934733] [125/141] (713s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[429.034343] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[429.035750] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[429.093359] [126/141] (713s left) prime_busy (before-wait)
[429.141665] Starting subtest: before-wait
[429.145685] Starting dynamic subtest: rcs0
[429.168364] Dynamic subtest rcs0: SUCCESS (0.022s)
[429.175777] Starting dynamic subtest: bcs0
[429.189059] Dynamic subtest bcs0: SUCCESS (0.020s)
[429.200237] Starting dynamic subtest: vcs0
[429.201206] Dynamic subtest vcs0: SUCCESS (0.011s)
[429.208120] Starting dynamic subtest: vcs1
[429.226196] Dynamic subtest vcs1: SUCCESS (0.024s)
[429.236697] Starting dynamic subtest: vecs0
[429.248588] Dynamic subtest vecs0: SUCCESS (0.022s)
[429.357535] Subtest before-wait: SUCCESS (0.215s)
[429.399844] [127/141] (712s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc)
[429.646631] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc
[429.648174] Subtest pipe-B-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[429.935422] [128/141] (712s left) kms_ccs (pipe-d-crc-primary-rotation-180-y_tiled_gen12_mc_ccs)
[430.337616] Starting subtest: pipe-D-crc-primary-rotation-180-y_tiled_gen12_mc_ccs
[430.339130] Subtest pipe-D-crc-primary-rotation-180-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[430.463244] [129/141] (711s left) syncobj_timeline (etime-multi-wait-all-submitted)
[430.510794] Starting subtest: etime-multi-wait-all-submitted
[430.615946] Subtest etime-multi-wait-all-submitted: SUCCESS (0.105s)
[430.662844] [130/141] (711s left) kms_prime (basic-crc-hybrid)
[431.267117] Subtest basic-crc-hybrid: SKIP (0.000s)
[431.336138] [131/141] (710s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[431.491813] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[431.548051] [132/141] (710s left) gem_ctx_create (basic-files)
[431.602393] Starting subtest: basic-files
[433.611879] Subtest basic-files: SUCCESS (2.010s)
[433.776529] [133/141] (708s left) gem_softpin (evict-active)
[433.836496] Starting subtest: evict-active
[433.841008] Subtest evict-active: SUCCESS (0.005s)
[433.920804] [134/141] (708s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[434.032456] Starting subtest: y-tiled-16bpp-rotate-270
[434.940625] Subtest y-tiled-16bpp-rotate-270: SUCCESS (0.908s)
[435.048069] [135/141] (707s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[435.181817] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[435.183514] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[435.203858] [136/141] (707s left) gem_mmap_gtt (hang-busy)
[435.251354] Starting subtest: hang-busy
[463.879456] Subtest hang-busy: SUCCESS (28.628s)
[463.950053] [137/141] (678s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[464.048826] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[464.050377] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[464.108545] [138/141] (678s left) gem_ctx_sseu (engines)
[464.158220] Subtest engines: SKIP (0.000s)
[464.176269] [139/141] (678s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[464.276275] Starting subtest: fbc-shrfb-scaledprimary
[466.987230] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.712s)
[467.074897] [140/141] (675s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[467.127854] Starting subtest: invalid-single-wait-all-unsubmitted
[467.128703] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[467.168909] [141/141] (675s left) kms_pipe_crc_basic (bad-source)
[467.275119] Starting subtest: bad-source
[467.275932] Subtest bad-source: SUCCESS (0.000s)
[467.307347] Closing watchdogs
Done.