[55.219917] Initializing watchdogs
[55.220295]   /dev/watchdog0
[55.235910] [001/141] (960s left) kms_ccs (pipe-a-crc-primary-rotation-180-yf_tiled_ccs)
[55.702814] Starting subtest: pipe-A-crc-primary-rotation-180-yf_tiled_ccs
[56.635154] Subtest pipe-A-crc-primary-rotation-180-yf_tiled_ccs: SUCCESS (0.925s)
[57.308979] [002/141] (958s left) vc4/vc4_dmabuf_poll (poll-read-waits-until-write-done)
[57.570915] Subtest poll-read-waits-until-write-done: SKIP (0.000s)
[57.637080] [003/141] (958s left) kms_plane (plane-position-covered)
[57.943704] Starting subtest: plane-position-covered
[57.945250] Starting dynamic subtest: pipe-A-planes
[59.454113] Dynamic subtest pipe-A-planes: SUCCESS (1.511s)
[59.469487] Starting dynamic subtest: pipe-B-planes
[61.238627] Dynamic subtest pipe-B-planes: SUCCESS (1.780s)
[61.239993] Subtest plane-position-covered: SUCCESS (3.299s)
[61.572976] [004/141] (954s left) perf (global-sseu-config-invalid)
[61.911901] Starting subtest: global-sseu-config-invalid
[61.913526] Starting dynamic subtest: 0-rcs0
[61.950256] Dynamic subtest 0-rcs0: SUCCESS (0.039s)
[61.951614] Subtest global-sseu-config-invalid: SUCCESS (0.039s)
[61.988779] [005/141] (953s left) i915_pm_freq_mult (media-freq)
[62.191511] Starting subtest: media-freq
[62.193405] Starting dynamic subtest: gt0
[62.195953] Dynamic subtest gt0: SKIP (0.000s)
[62.198511] Subtest media-freq: SKIP (0.001s)
[62.273228] [006/141] (953s left) vc4/vc4_purgeable_bo (mark-purgeable-twice)
[62.508734] Subtest mark-purgeable-twice: SKIP (0.000s)
[62.573359] [007/141] (953s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[62.881746] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[62.884402] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[62.973364] [008/141] (952s left) gem_lmem_swapping (heavy-random)
[63.218981] Subtest heavy-random: SKIP (0.000s)
[63.273484] [009/141] (952s left) gem_render_copy (linear-to-vebox-y-tiled)
[63.521099] Starting subtest: linear-to-vebox-y-tiled
[63.523927] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[63.725575] [010/141] (952s left) kms_addfb_basic (tile-pitch-mismatch)
[63.936926] Starting subtest: tile-pitch-mismatch
[63.938466] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[64.123661] [011/141] (951s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-pwrite)
[64.436233] Starting subtest: psr-1p-offscren-pri-indfb-draw-pwrite
[64.438821] Subtest psr-1p-offscren-pri-indfb-draw-pwrite: SKIP (0.000s)
[64.525066] [012/141] (951s left) gem_mmap_wc (invalid-flags)
[64.725962] Starting subtest: invalid-flags
[64.727409] Subtest invalid-flags: SUCCESS (0.000s)
[64.823316] [013/141] (951s left) kms_psr2_su (frontbuffer-xrgb8888)
[65.022108] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[65.072610] [014/141] (951s left) gem_mmap_gtt (big-copy)
[65.273756] Starting subtest: big-copy
[76.722917] Subtest big-copy: SUCCESS (11.449s)
[76.925733] [015/141] (939s left) gem_readwrite (new-obj)
[77.246273] Starting subtest: new-obj
[77.248911] Subtest new-obj: SUCCESS (0.000s)
[77.341337] [016/141] (938s left) kms_psr (primary_render)
[77.546044] Subtest primary_render: SKIP (0.000s)
[77.590884] [017/141] (938s left) kms_ccs (pipe-c-random-ccs-data-yf_tiled_ccs)
[78.243707] Starting subtest: pipe-C-random-ccs-data-yf_tiled_ccs
[78.247491] Subtest pipe-C-random-ccs-data-yf_tiled_ccs: SKIP (0.000s)
[78.610304] [018/141] (937s left) kms_cursor_crc (cursor-random-256x256)
[78.936439] Starting subtest: cursor-random-256x256
[78.949957] Starting dynamic subtest: pipe-A-DP-1
[82.958464] Dynamic subtest pipe-A-DP-1: SUCCESS (4.010s)
[83.044881] Starting dynamic subtest: pipe-C-DP-1
[87.171613] Dynamic subtest pipe-C-DP-1: SUCCESS (4.142s)
[87.172933] Subtest cursor-random-256x256: SUCCESS (8.234s)
[87.517330] [019/141] (928s left) gem_ctx_persistence (legacy-engines-hang)
[87.732510] Starting subtest: legacy-engines-hang
[87.736819] Starting dynamic subtest: render
[87.782490] Dynamic subtest render: SUCCESS (0.046s)
[87.802811] Starting dynamic subtest: bsd
[87.822585] Dynamic subtest bsd: SUCCESS (0.039s)
[87.840867] Starting dynamic subtest: blt
[87.844587] Dynamic subtest blt: SKIP (0.004s)
[87.860510] Starting dynamic subtest: vebox
[87.867503] Dynamic subtest vebox: SUCCESS (0.039s)
[87.870531] Subtest legacy-engines-hang: SUCCESS (0.135s)
[87.966540] [020/141] (928s left) gem_exec_reloc (basic-softpin)
[88.179328] Starting subtest: basic-softpin
[88.186323] Subtest basic-softpin: SUCCESS (0.006s)
[88.364949] [021/141] (928s left) kms_vblank (pipe-b-ts-continuation-dpms-rpm)
[88.659778] Starting subtest: pipe-B-ts-continuation-dpms-rpm
[90.843137] Subtest pipe-B-ts-continuation-dpms-rpm: SUCCESS (2.178s)
[91.346621] [022/141] (925s left) kms_big_fb (linear-16bpp-rotate-270)
[91.671813] Starting subtest: linear-16bpp-rotate-270
[91.743101] Subtest linear-16bpp-rotate-270: SKIP (0.070s)
[91.847354] [023/141] (924s left) v3d/v3d_submit_cl (multiple-job-submission)
[92.112621] Subtest multiple-job-submission: SKIP (0.000s)
[92.179658] [024/141] (924s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[92.483314] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[92.485984] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[92.579508] [025/141] (923s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[92.886466] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[92.889061] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[92.979279] [026/141] (923s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[93.298681] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[95.363237] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (2.066s)
[95.480109] [027/141] (921s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[95.803526] Starting subtest: y-tiled-addfb-size-offset-overflow
[95.806432] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[95.896710] [028/141] (920s left) gem_softpin (evict-snoop-interruptible)
[96.104672] Starting subtest: evict-snoop-interruptible
[96.107624] Subtest evict-snoop-interruptible: SKIP (0.000s)
[96.179388] [029/141] (920s left) gem_ctx_param (invalid-set-no-zeromap)
[96.381493] Starting subtest: invalid-set-no-zeromap
[96.383053] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[96.462835] [030/141] (920s left) gem_mmap_wc (write-read)
[96.660949] Starting subtest: write-read
[96.692163] Subtest write-read: SUCCESS (0.032s)
[96.796617] [031/141] (919s left) kms_pipe_crc_basic (suspend-read-crc)
[97.094634] Starting subtest: suspend-read-crc
[97.096174] Starting dynamic subtest: pipe-A-DP-1
[115.611247] Dynamic subtest pipe-A-DP-1: SUCCESS (2.516s)
[119.514222] [032/141] (916s left) gem_ctx_param (invalid-param-set)
[119.718682] Starting subtest: invalid-param-set
[119.720232] Subtest invalid-param-set: SUCCESS (0.000s)
[119.807500] [033/141] (915s left) kms_vblank (pipe-a-query-idle)
[120.109816] Starting subtest: pipe-A-query-idle
[122.368387] Subtest pipe-A-query-idle: SUCCESS (2.258s)
[122.694587] [034/141] (913s left) gem_exec_reloc (basic-gtt-active)
[122.904910] Starting subtest: basic-gtt-active
[123.051668] Subtest basic-gtt-active: SUCCESS (0.145s)
[123.243907] [035/141] (912s left) kms_rotation_crc (multiplane-rotation)
[123.545232] Starting subtest: multiplane-rotation
[137.607335] Subtest multiplane-rotation: SUCCESS (14.066s)
[137.728335] [036/141] (898s left) kms_busy (extended-modeset-hang-newfb)
[138.054336] Starting subtest: extended-modeset-hang-newfb
[138.058563] Starting dynamic subtest: pipe-A
[141.205049] Dynamic subtest pipe-A: SUCCESS (3.146s)
[141.231770] Starting dynamic subtest: pipe-C
[144.491145] Dynamic subtest pipe-C: SUCCESS (3.273s)
[144.492372] Subtest extended-modeset-hang-newfb: SUCCESS (6.436s)
[144.817708] [037/141] (891s left) api_intel_allocator (reloc-allocator)
[145.018743] Starting subtest: reloc-allocator
[145.020120] Starting dynamic subtest: basic
[145.024195] Dynamic subtest basic: SUCCESS (0.005s)
[145.043745] Starting dynamic subtest: parallel-one
[145.045396] Dynamic subtest parallel-one: SUCCESS (0.019s)
[145.064715] Starting dynamic subtest: print
[145.066378] Dynamic subtest print: SUCCESS (0.000s)
[145.085465] Starting dynamic subtest: reuse
[145.086816] Dynamic subtest reuse: SUCCESS (0.000s)
[145.105495] Starting dynamic subtest: fork-reopen-allocator
[145.106769] Dynamic subtest fork-reopen-allocator: SUCCESS (0.041s)
[145.108063] Subtest reloc-allocator: SUCCESS (0.069s)
[145.181522] [038/141] (890s left) syncobj_timeline (invalid-signal-illegal-handle)
[145.384091] Starting subtest: invalid-signal-illegal-handle
[145.385672] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[145.463703] [039/141] (890s left) gem_workarounds (suspend-resume-fd)
[145.699228] Starting subtest: suspend-resume-fd
[163.135395] Subtest suspend-resume-fd: SUCCESS (1.220s)
[167.361409] [040/141] (888s left) gem_exec_params (secure-non-root)
[167.573721] Starting subtest: secure-non-root
[167.576701] Subtest secure-non-root: SKIP (0.000s)
[167.669904] [041/141] (888s left) gem_mmap_wc (write-wc-read-gtt)
[167.868991] Starting subtest: write-wc-read-gtt
[168.410474] Subtest write-wc-read-gtt: SUCCESS (0.540s)
[168.520032] [042/141] (887s left) gem_exec_schedule (in-order)
[168.754235] Starting subtest: in-order
[168.756123] Starting dynamic subtest: rcs0
[168.900085] Dynamic subtest rcs0: SUCCESS (0.143s)
[168.923098] Starting dynamic subtest: bcs0
[169.053728] Dynamic subtest bcs0: SUCCESS (0.153s)
[169.075264] Starting dynamic subtest: vcs0
[169.184360] Dynamic subtest vcs0: SUCCESS (0.130s)
[169.205795] Starting dynamic subtest: vecs0
[169.316267] Dynamic subtest vecs0: SUCCESS (0.131s)
[169.318405] Subtest in-order: SUCCESS (0.561s)
[169.671633] [043/141] (886s left) i915_query (engine-info-invalid)
[169.876028] Starting subtest: engine-info-invalid
[169.877440] Subtest engine-info-invalid: SUCCESS (0.000s)
[169.953924] [044/141] (886s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[170.269062] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[170.271585] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[170.371537] [045/141] (886s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[170.687508] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[170.690018] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[170.787384] [046/141] (885s left) gem_exec_reloc (basic-cpu-active)
[170.999946] Starting subtest: basic-cpu-active
[171.144108] Subtest basic-cpu-active: SUCCESS (0.142s)
[171.338270] [047/141] (885s left) gem_exec_schedule (smoketest-all)
[171.573100] Starting subtest: smoketest-all
[203.895111] Subtest smoketest-all: SUCCESS (32.315s)
[204.238175] [048/141] (852s left) kms_plane_scaling (planes-downscale-factor-0-25-unity-scaling)
[204.540296] Starting subtest: planes-downscale-factor-0-25-unity-scaling
[204.541694] Starting dynamic subtest: pipe-A-DP-1
[204.571949] Dynamic subtest pipe-A-DP-1: SKIP (0.030s)
[204.600485] Starting dynamic subtest: pipe-B-DP-1
[204.657566] Dynamic subtest pipe-B-DP-1: SKIP (0.080s)
[204.684456] Starting dynamic subtest: pipe-C-DP-1
[204.742313] Dynamic subtest pipe-C-DP-1: SKIP (0.081s)
[204.745714] Subtest planes-downscale-factor-0-25-unity-scaling: SKIP (0.204s)
[204.837862] [049/141] (851s left) kms_ccs (pipe-c-crc-primary-basic-4_tiled_dg2_rc_ccs_cc)
[205.471498] Starting subtest: pipe-C-crc-primary-basic-4_tiled_dg2_rc_ccs_cc
[205.474346] Subtest pipe-C-crc-primary-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.001s)
[205.872708] [050/141] (850s left) gem_exec_balancer (parallel-ordering)
[209.865376] Subtest parallel-ordering: SKIP (0.000s)
[209.955890] [051/141] (846s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_dg2_mc_ccs)
[210.668806] Subtest pipe-D-bad-rotation-90-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[210.969884] [052/141] (845s left) syncobj_timeline (wait-for-submit-complex)
[211.173915] Starting subtest: wait-for-submit-complex
[211.238364] Subtest wait-for-submit-complex: SUCCESS (0.063s)
[211.320271] [053/141] (845s left) gem_busy (semaphore)
[211.685006] Starting subtest: semaphore
[211.686398] Starting dynamic subtest: rcs0
[211.720347] Dynamic subtest rcs0: SUCCESS (0.035s)
[211.744573] Starting dynamic subtest: bcs0
[211.754592] Dynamic subtest bcs0: SUCCESS (0.033s)
[211.778237] Starting dynamic subtest: vcs0
[211.793340] Dynamic subtest vcs0: SUCCESS (0.038s)
[211.815399] Starting dynamic subtest: vecs0
[211.821562] Dynamic subtest vecs0: SUCCESS (0.028s)
[211.822831] Subtest semaphore: SUCCESS (0.138s)
[212.054565] [054/141] (844s left) kms_psr (psr2_sprite_mmap_gtt)
[212.257380] Subtest psr2_sprite_mmap_gtt: SKIP (0.000s)
[212.321694] [055/141] (844s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_dg2_rc_ccs_cc)
[213.078096] Subtest pipe-D-crc-primary-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[213.392552] [056/141] (843s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[213.706777] Starting subtest: psr-rgb101010-draw-mmap-gtt
[213.710234] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[213.809004] [057/141] (843s left) i915_module_load (resize-bar)
[214.009021] Starting subtest: resize-bar
[214.021507] Subtest resize-bar: SKIP (0.013s)
[214.074554] [058/141] (842s left) kms_dp_tiled_display (basic-test-pattern)
[214.366861] Starting subtest: basic-test-pattern
[214.369464] Subtest basic-test-pattern: SKIP (0.000s)
[214.458837] [059/141] (842s left) gem_softpin (allocator-fork)
[214.667414] Starting subtest: allocator-fork
[217.021550] Subtest allocator-fork: SUCCESS (2.352s)
[217.127115] [060/141] (839s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[217.426268] Starting subtest: 2x-flip-vs-modeset-vs-hang
[217.429021] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.003s)
[217.543821] [061/141] (839s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[217.842553] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[217.848248] Starting dynamic subtest: A-DP1
[228.622555] Dynamic subtest A-DP1: SUCCESS (10.775s)
[228.643759] Starting dynamic subtest: B-DP1
[239.366162] Dynamic subtest B-DP1: SUCCESS (10.742s)
[239.385699] Starting dynamic subtest: C-DP1
[250.077504] Dynamic subtest C-DP1: SUCCESS (10.710s)
[250.080439] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (32.238s)
[250.486477] [062/141] (806s left) kms_atomic_transition (modeset-transition)
[250.783653] Starting subtest: modeset-transition
[250.784915] Starting dynamic subtest: 1x-outputs
[255.583016] Dynamic subtest 1x-outputs: SUCCESS (4.800s)
[255.670816] Subtest modeset-transition: SUCCESS (4.890s)
[256.004439] [063/141] (801s left) kms_setmode (basic)
[256.210952] Starting subtest: basic
[256.427601] Starting dynamic subtest: pipe-A-DP-1
[258.742413] Dynamic subtest pipe-A-DP-1: SUCCESS (2.311s)
[258.902485] Starting dynamic subtest: pipe-B-DP-1
[261.185926] Dynamic subtest pipe-B-DP-1: SUCCESS (2.298s)
[261.282455] Subtest basic: SUCCESS (5.070s)
[261.617546] [064/141] (795s left) kms_vblank (pipe-d-wait-forked-busy-hang)
[261.928359] Subtest pipe-D-wait-forked-busy-hang: SKIP (0.000s)
[262.016619] [065/141] (795s left) kms_lease (lease_revoke)
[262.317177] Starting subtest: lease_revoke
[262.318535] Starting dynamic subtest: pipe-A-DP-1
[262.419916] Dynamic subtest pipe-A-DP-1: SUCCESS (0.103s)
[262.450086] Starting dynamic subtest: pipe-B-DP-1
[262.533183] Dynamic subtest pipe-B-DP-1: SUCCESS (0.102s)
[262.557892] Starting dynamic subtest: pipe-C-DP-1
[262.645782] Dynamic subtest pipe-C-DP-1: SUCCESS (0.108s)
[262.647344] Subtest lease_revoke: SUCCESS (0.330s)
[262.749940] [066/141] (794s left) kms_ccs (pipe-a-ccs-on-another-bo-y_tiled_ccs)
[263.204641] Starting subtest: pipe-A-ccs-on-another-bo-y_tiled_ccs
[263.206650] Subtest pipe-A-ccs-on-another-bo-y_tiled_ccs: SUCCESS (0.001s)
[263.782731] [067/141] (793s left) fbdev (pan)
[263.981091] Starting subtest: pan
[264.023499] Subtest pan: SUCCESS (0.043s)
[264.116229] [068/141] (793s left) kms_cursor_edge_walk (64x64-top-edge)
[264.418844] Starting subtest: 64x64-top-edge
[264.423218] Starting dynamic subtest: pipe-A-DP-1
[268.053451] Dynamic subtest pipe-A-DP-1: SUCCESS (3.630s)
[268.076756] Starting dynamic subtest: pipe-C-DP-1
[271.537357] Dynamic subtest pipe-C-DP-1: SUCCESS (3.479s)
[271.539009] Subtest 64x64-top-edge: SUCCESS (7.119s)
[271.852108] [069/141] (785s left) drm_fdinfo (virtual-busy-hang)
[272.061519] Starting subtest: virtual-busy-hang
[276.275258] Subtest virtual-busy-hang: SUCCESS (4.214s)
[276.367005] [070/141] (781s left) gem_exec_schedule (preempt-hang)
[276.715396] Starting subtest: preempt-hang
[276.717488] Starting dynamic subtest: rcs0
[276.999822] Dynamic subtest rcs0: SUCCESS (0.279s)
[277.024067] Starting dynamic subtest: bcs0
[277.291252] Dynamic subtest bcs0: SUCCESS (0.292s)
[277.315550] Starting dynamic subtest: vcs0
[277.560089] Dynamic subtest vcs0: SUCCESS (0.269s)
[277.580753] Starting dynamic subtest: vecs0
[277.833264] Dynamic subtest vecs0: SUCCESS (0.271s)
[277.834721] Subtest preempt-hang: SUCCESS (1.118s)
[278.100861] [071/141] (779s left) kms_frontbuffer_tracking (psr-1p-rte)
[278.415709] Starting subtest: psr-1p-rte
[278.418307] Subtest psr-1p-rte: SKIP (0.000s)
[278.517883] [072/141] (779s left) perf_pmu (idle-no-semaphores)
[278.728005] Starting subtest: idle-no-semaphores
[278.729282] Starting dynamic subtest: rcs0
[279.242613] Dynamic subtest rcs0: SUCCESS (0.514s)
[279.262425] Starting dynamic subtest: bcs0
[279.760919] Dynamic subtest bcs0: SUCCESS (0.517s)
[279.782460] Starting dynamic subtest: vcs0
[280.281410] Dynamic subtest vcs0: SUCCESS (0.519s)
[280.302825] Starting dynamic subtest: vecs0
[280.802843] Dynamic subtest vecs0: SUCCESS (0.519s)
[280.804719] Subtest idle-no-semaphores: SUCCESS (2.075s)
[280.901450] [073/141] (776s left) kms_ccs (pipe-b-bad-aux-stride-4_tiled_mtl_rc_ccs_cc)
[281.488912] Starting subtest: pipe-B-bad-aux-stride-4_tiled_mtl_rc_ccs_cc
[281.491524] Subtest pipe-B-bad-aux-stride-4_tiled_mtl_rc_ccs_cc: SKIP (0.000s)
[281.944452] [074/141] (775s left) v3d/v3d_submit_csd (bad-multisync-out-sync)
[282.185454] Subtest bad-multisync-out-sync: SKIP (0.000s)
[282.259713] [075/141] (775s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[282.566920] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[282.569671] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[282.676727] [076/141] (775s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[282.989384] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[282.992512] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[283.093468] [077/141] (774s left) kms_chamelium_edid (vga-edid-read)
[283.505947] Subtest vga-edid-read: SKIP (0.000s)
[283.794283] [078/141] (773s left) gem_spin_batch (resubmit-all)
[284.019997] Starting subtest: resubmit-all
[284.021511] Starting dynamic subtest: rcs0
[284.032022] Dynamic subtest rcs0: SUCCESS (0.012s)
[284.063259] Starting dynamic subtest: bcs0
[284.064584] Dynamic subtest bcs0: SUCCESS (0.008s)
[284.084439] Starting dynamic subtest: vcs0
[284.085703] Dynamic subtest vcs0: SUCCESS (0.006s)
[284.105669] Starting dynamic subtest: vecs0
[284.106986] Dynamic subtest vecs0: SUCCESS (0.007s)
[284.108250] Subtest resubmit-all: SUCCESS (0.039s)
[284.289706] [079/141] (773s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[284.586112] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[284.587537] Starting dynamic subtest: pipe-A-valid-mode
[285.299856] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.713s)
[285.301150] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SUCCESS (0.716s)
[285.648913] [080/141] (772s left) gen9_exec_parse (bb-start-out)
[285.876144] Starting subtest: bb-start-out
[285.882004] Subtest bb-start-out: SUCCESS (0.005s)
[286.116022] [081/141] (771s left) prime_mmap (test_userptr)
[286.317279] Starting subtest: test_userptr
[286.321747] Starting dynamic subtest: test_userptr-smem
[286.323285] Dynamic subtest test_userptr-smem: SUCCESS (0.001s)
[286.324738] Subtest test_userptr: SUCCESS (0.005s)
[286.432200] [082/141] (771s left) kms_content_protection (lic)
[286.766614] Starting subtest: LIC
[286.808425] Starting dynamic subtest: pipe-A-DP-1
[407.455293] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[408.168837] Closing watchdogs
[408.174799] Initializing watchdogs
[408.174970]   /dev/watchdog0
[408.200226] [083/141] (649s left) gem_render_copy_redux (interruptible)
[408.433242] Starting subtest: interruptible
[410.737715] Subtest interruptible: SUCCESS (2.303s)
[410.833680] [084/141] (647s left) gem_exec_balancer (hog)
[411.056714] Starting subtest: hog
[414.717518] Subtest hog: SUCCESS (3.658s)
[418.600642] [085/141] (639s left) kms_getfb (getfb2-handle-zero)
[418.803199] Starting subtest: getfb2-handle-zero
[418.804730] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[418.899010] [086/141] (639s left) syncobj_wait (multi-wait-all-submitted)
[419.101500] Starting subtest: multi-wait-all-submitted
[419.210996] Subtest multi-wait-all-submitted: SUCCESS (0.107s)
[419.298930] [087/141] (638s left) syncobj_timeline (single-wait-for-submit-signaled)
[419.506641] Starting subtest: single-wait-for-submit-signaled
[419.508112] Subtest single-wait-for-submit-signaled: SUCCESS (0.001s)
[419.598739] [088/141] (638s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[419.900550] Starting subtest: cursor-rapid-movement-64x64
[419.931994] Starting dynamic subtest: pipe-A-DP-1
[420.423296] Dynamic subtest pipe-A-DP-1: SUCCESS (0.490s)
[420.504976] Starting dynamic subtest: pipe-C-DP-1
[421.292882] Dynamic subtest pipe-C-DP-1: SUCCESS (0.808s)
[421.294242] Subtest cursor-rapid-movement-64x64: SUCCESS (1.394s)
[421.659871] [089/141] (636s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[421.985342] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[423.096674] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.110s)
[423.425263] [090/141] (634s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[423.751964] Starting subtest: x-tiled-16bpp-rotate-0
[427.332252] Subtest x-tiled-16bpp-rotate-0: SUCCESS (3.577s)
[427.640388] [091/141] (630s left) gem_exec_schedule (u-submit-late-slice)
[427.867934] Starting subtest: u-submit-late-slice
[427.869792] Starting dynamic subtest: rcs0
[427.938359] Dynamic subtest rcs0: SUCCESS (0.067s)
[427.962177] Starting dynamic subtest: bcs0
[427.991652] Dynamic subtest bcs0: SUCCESS (0.053s)
[428.019490] Starting dynamic subtest: vcs0
[428.048858] Dynamic subtest vcs0: SUCCESS (0.054s)
[428.074326] Starting dynamic subtest: vecs0
[428.097239] Dynamic subtest vecs0: SUCCESS (0.050s)
[428.098525] Subtest u-submit-late-slice: SUCCESS (0.229s)
[428.457017] [092/141] (629s left) gem_pread (self)
[428.659331] Starting subtest: self
[428.717711] Subtest self: SUCCESS (0.061s)
[428.822914] [093/141] (629s left) gem_exec_params (cliprects-invalid)
[429.029158] Starting subtest: cliprects-invalid
[429.030934] Subtest cliprects-invalid: SUCCESS (0.001s)
[429.139254] [094/141] (629s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[429.451470] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[429.454176] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[429.556930] [095/141] (628s left) gem_exec_fence (submit67)
[429.911975] Starting subtest: submit67
[429.913506] Starting dynamic subtest: rcs0
[432.255859] Dynamic subtest rcs0: SUCCESS (2.339s)
[432.284601] Starting dynamic subtest: bcs0
[433.374107] Dynamic subtest bcs0: SUCCESS (1.119s)
[433.400818] Starting dynamic subtest: vcs0
[434.567475] Dynamic subtest vcs0: SUCCESS (1.191s)
[434.593928] Starting dynamic subtest: vecs0
[435.717802] Dynamic subtest vecs0: SUCCESS (1.151s)
[435.719512] Subtest submit67: SUCCESS (5.805s)
[436.440984] [096/141] (622s left) syncobj_timeline (invalid-transfer-non-existent-point)
[436.643819] Starting subtest: invalid-transfer-non-existent-point
[436.645179] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[436.742357] [097/141] (621s left) gem_exec_flush (basic-wb-pro-default)
[436.967954] Starting subtest: basic-wb-pro-default
[442.452164] Subtest basic-wb-pro-default: SUCCESS (5.484s)
[442.656834] [098/141] (615s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[442.859505] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[442.860997] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[442.958423] [099/141] (615s left) kms_chamelium_audio (dp-audio)
[443.363548] Subtest dp-audio: SKIP (0.000s)
[443.636444] [100/141] (615s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_dg2_rc_ccs_cc)
[444.182800] Starting subtest: pipe-B-random-ccs-data-4_tiled_dg2_rc_ccs_cc
[444.188174] Subtest pipe-B-random-ccs-data-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s)
[444.680499] [101/141] (614s left) v3d/v3d_job_submission (threaded-job-submission)
[444.939310] Subtest threaded-job-submission: SKIP (0.000s)
[445.013828] [102/141] (613s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[445.403492] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[445.694425] [103/141] (613s left) kms_ccs (pipe-a-missing-ccs-buffer-y_tiled_gen12_rc_ccs)
[446.125486] Starting subtest: pipe-A-missing-ccs-buffer-y_tiled_gen12_rc_ccs
[446.128015] Subtest pipe-A-missing-ccs-buffer-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[446.709929] [104/141] (612s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[447.026835] Starting subtest: yf-tiled-8bpp-rotate-90
[447.029500] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[447.127260] [105/141] (611s left) kms_rotation_crc (primary-rotation-180)
[447.431246] Starting subtest: primary-rotation-180
[451.794707] Subtest primary-rotation-180: SUCCESS (4.366s)
[452.204757] [106/141] (606s left) gem_vm_create (invalid-create)
[452.415405] Starting subtest: invalid-create
[452.417072] Subtest invalid-create: SUCCESS (0.001s)
[452.521699] [107/141] (606s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[452.832295] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[452.834899] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[452.937618] [108/141] (606s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[453.236081] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[453.241294] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.003s)
[453.338942] [109/141] (605s left) gem_exec_whisper (basic-queues-forked)
[453.562721] Starting subtest: basic-queues-forked
[465.151737] Subtest basic-queues-forked: SUCCESS (11.586s)
[465.356019] [110/141] (593s left) kms_ccs (pipe-c-bad-rotation-90-4_tiled_dg2_mc_ccs)
[465.981726] Starting subtest: pipe-C-bad-rotation-90-4_tiled_dg2_mc_ccs
[465.984319] Subtest pipe-C-bad-rotation-90-4_tiled_dg2_mc_ccs: SKIP (0.000s)
[466.388893] [111/141] (592s left) kms_addfb_basic (master-rmfb)
[466.591245] Starting subtest: master-rmfb
[466.592732] Subtest master-rmfb: SUCCESS (0.001s)
[466.805304] [112/141] (592s left) kms_ccs (pipe-b-crc-primary-basic-y_tiled_ccs)
[467.316741] Starting subtest: pipe-B-crc-primary-basic-y_tiled_ccs
[467.955811] Subtest pipe-B-crc-primary-basic-y_tiled_ccs: SUCCESS (0.639s)
[468.559203] [113/141] (590s left) api_intel_bb (object-noreloc-keep-cache-simple)
[468.760153] Starting subtest: object-noreloc-keep-cache-simple
[468.767901] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.008s)
[468.891215] [114/141] (590s left) prime_self_import (basic-llseek-size)
[469.086857] Starting subtest: basic-llseek-size
[469.093335] Subtest basic-llseek-size: SUCCESS (0.006s)
[469.191495] [115/141] (590s left) kms_vblank (pipe-b-ts-continuation-idle-hang)
[469.489257] Starting subtest: pipe-B-ts-continuation-idle-hang
[477.182524] Subtest pipe-B-ts-continuation-idle-hang: SUCCESS (7.695s)
[477.524973] [116/141] (581s left) api_intel_bb (reset-bb)
[477.726999] Starting subtest: reset-bb
[477.731714] Subtest reset-bb: SUCCESS (0.006s)
[477.840470] [117/141] (581s left) kms_hdmi_inject (inject-4k)
[478.042962] Subtest inject-4k: SKIP (0.000s)
[478.106467] [118/141] (581s left) i915_pm_rpm (modeset-pc8-residency-stress)
[479.913528] Starting subtest: modeset-pc8-residency-stress
[479.918073] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[480.425399] [119/141] (579s left) gem_exec_reloc (basic-cpu-read-noreloc)
[480.637120] Starting subtest: basic-cpu-read-noreloc
[480.646861] Subtest basic-cpu-read-noreloc: SUCCESS (0.009s)
[480.841388] [120/141] (578s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[481.139622] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[481.140909] Starting dynamic subtest: pipe-A-valid-mode
[481.257377] Dynamic subtest pipe-A-valid-mode: SKIP (0.117s)
[481.260893] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.121s)
[481.596013] [121/141] (578s left) gem_exec_reloc (basic-cpu-wc)
[481.809391] Starting subtest: basic-cpu-wc
[481.830624] Subtest basic-cpu-wc: SUCCESS (0.021s)
[482.017355] [122/141] (577s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[482.333124] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[482.335665] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[482.446630] [123/141] (577s left) gem_exec_fair (basic-pace)
[482.682647] Starting subtest: basic-pace
[482.684137] Starting dynamic subtest: rcs0
[487.502346] Dynamic subtest rcs0: SUCCESS (4.819s)
[487.528246] Starting dynamic subtest: bcs0
[487.530706] Dynamic subtest bcs0: SKIP (0.008s)
[487.554378] Starting dynamic subtest: vcs0
[492.295291] Dynamic subtest vcs0: SUCCESS (4.781s)
[492.318117] Starting dynamic subtest: vecs0
[497.080459] Dynamic subtest vecs0: SUCCESS (4.784s)
[497.081797] Subtest basic-pace: SUCCESS (14.399s)
[497.280159] [124/141] (562s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[497.587033] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[497.589680] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[497.696372] [125/141] (562s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[498.004103] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[498.006936] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[498.095806] [126/141] (561s left) prime_busy (before-wait)
[498.305557] Starting subtest: before-wait
[498.323417] Starting dynamic subtest: rcs0
[498.334223] Dynamic subtest rcs0: SUCCESS (0.011s)
[498.362073] Starting dynamic subtest: bcs0
[498.363293] Dynamic subtest bcs0: SUCCESS (0.022s)
[498.388674] Starting dynamic subtest: vcs0
[498.389950] Dynamic subtest vcs0: SUCCESS (0.019s)
[498.413364] Starting dynamic subtest: vecs0
[498.414589] Dynamic subtest vecs0: SUCCESS (0.016s)
[498.509425] Subtest before-wait: SUCCESS (0.202s)
[498.595939] [127/141] (561s left) kms_ccs (pipe-b-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc)
[499.118145] Starting subtest: pipe-B-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc
[499.120778] Subtest pipe-B-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc: SKIP (0.002s)
[499.631835] [128/141] (560s left) kms_ccs (pipe-d-crc-primary-rotation-180-y_tiled_gen12_mc_ccs)
[500.343647] Subtest pipe-D-crc-primary-rotation-180-y_tiled_gen12_mc_ccs: SKIP (0.000s)
[500.661639] [129/141] (559s left) syncobj_timeline (etime-multi-wait-all-submitted)
[500.864941] Starting subtest: etime-multi-wait-all-submitted
[500.969868] Subtest etime-multi-wait-all-submitted: SUCCESS (0.103s)
[501.061472] [130/141] (558s left) kms_prime (basic-crc-hybrid)
[503.034195] Subtest basic-crc-hybrid: SKIP (0.000s)
[503.179928] [131/141] (556s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[503.566646] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[503.858211] [132/141] (556s left) gem_ctx_create (basic-files)
[504.082431] Starting subtest: basic-files
[506.117640] Subtest basic-files: SUCCESS (2.035s)
[506.354516] [133/141] (553s left) gem_softpin (evict-active)
[506.562980] Starting subtest: evict-active
[506.585768] Subtest evict-active: SUCCESS (0.022s)
[506.702927] [134/141] (553s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[507.023511] Starting subtest: y-tiled-16bpp-rotate-270
[507.097439] Subtest y-tiled-16bpp-rotate-270: SKIP (0.075s)
[507.203438] [135/141] (553s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[507.514994] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[507.517712] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[507.620326] [136/141] (552s left) gem_mmap_gtt (hang-busy)
[507.821537] Starting subtest: hang-busy
[522.433293] Subtest hang-busy: SUCCESS (14.610s)
[522.551634] [137/141] (537s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[522.870707] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[522.873609] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[522.987331] [138/141] (537s left) gem_ctx_sseu (engines)
[523.200215] Subtest engines: SKIP (0.000s)
[523.253444] [139/141] (537s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[523.565702] Starting subtest: fbc-shrfb-scaledprimary
[526.776022] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.211s)
[526.923117] [140/141] (533s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[527.128087] Starting subtest: invalid-single-wait-all-unsubmitted
[527.129617] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[527.220017] [141/141] (533s left) kms_pipe_crc_basic (bad-source)
[527.518896] Starting subtest: bad-source
[527.520238] Subtest bad-source: SUCCESS (0.001s)
[527.601184] Closing watchdogs
Done.